"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestChunkerChunk50bBox:" 2025/03/27 02:10:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo" 2025/03/27 02:10:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/27 02:10:46 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo" 2025/03/27 02:10:46 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/27 02:10:47 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/03/27 02:10:48 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/27 02:10:49 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/03/27 02:10:52 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/03/27 02:10:53 INFO : dir/subdir: Making directory 2025/03/27 02:10:58 INFO : dir/subdir: Removing directory 2025/03/27 02:11:00 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/03/27 02:11:03 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/03/27 02:11:10 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_rl04e5: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/03/27 02:11:10 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_rl04e5: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/03/27 02:11:26 INFO : ./..rclone_chunk.001_rl0kiy: Moved (server-side) to: ./..rclone_chunk.001 2025/03/27 02:11:27 INFO : ./..rclone_chunk.002_rl0kiy: Moved (server-side) to: ./..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/03/27 02:11:42 INFO : ../...rclone_chunk.001_rl101m: Moved (server-side) to: ../...rclone_chunk.001 2025/03/27 02:11:43 INFO : ../...rclone_chunk.002_rl101m: Moved (server-side) to: ../...rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/03/27 02:11:59 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001_rl1hh2: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/03/27 02:11:59 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002_rl1hh2: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/03/27 02:12:15 INFO : leading space/ leading space.rclone_chunk.001_rl1x0t: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/03/27 02:12:15 INFO : leading space/ leading space.rclone_chunk.002_rl1x0t: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/03/27 02:12:31 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_rl2dr3: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/03/27 02:12:31 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_rl2dr3: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/03/27 02:12:46 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_rl2s87: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/03/27 02:12:46 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_rl2s87: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/03/27 02:13:02 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_rl38hi: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/03/27 02:13:03 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_rl38hi: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/03/27 02:13:18 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_rl3oi1: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/03/27 02:13:18 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_rl3oi1: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/03/27 02:13:34 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_rl44ib: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/03/27 02:13:34 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_rl44ib: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/03/27 02:13:49 INFO : .leading dot/.leading dot.rclone_chunk.001_rl4jza: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/03/27 02:13:50 INFO : .leading dot/.leading dot.rclone_chunk.002_rl4jza: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/03/27 02:14:05 INFO : trailing space /trailing space .rclone_chunk.001_rl4zux: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/03/27 02:14:05 INFO : trailing space /trailing space .rclone_chunk.002_rl4zux: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/03/27 02:14:20 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_rl5fsj: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/03/27 02:14:21 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_rl5fsj: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/03/27 02:14:36 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_rl5vxg: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/03/27 02:14:37 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_rl5vxg: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/03/27 02:14:52 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_rl6a60: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/03/27 02:14:52 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_rl6a60: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/03/27 02:15:07 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_rl6pmh: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/03/27 02:15:07 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_rl6pmh: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/03/27 02:15:22 INFO : trailing dot./trailing dot..rclone_chunk.001_rl7500: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/03/27 02:15:23 INFO : trailing dot./trailing dot..rclone_chunk.002_rl7500: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/03/27 02:15:38 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_rl7kln: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/03/27 02:15:38 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_rl7kln: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/03/27 02:15:53 INFO : test%46.txt/test%46.txt.rclone_chunk.001_rl8034: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/03/27 02:15:54 INFO : test%46.txt/test%46.txt.rclone_chunk.002_rl8034: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError fstests.go:747: Reduce file size due to limit 1024 === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/03/27 02:17:10 INFO : zero-length-file.rclone_chunk.001_rla6co: Moved (server-side) to: zero-length-file === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/03/27 02:17:14 INFO : dir: Making directory 2025/03/27 02:17:15 INFO : dir/subdir1: Making directory 2025/03/27 02:17:16 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526582082") 2025/03/27 02:17:16 INFO : dir/subdir3: Making directory 2025/03/27 02:17:16 DEBUG : box root 'rclone-test-vocalex5qubo': ["zero-length-file"(1)|file|ITEM_RENAME|1815142782713|20a4623c79c9c339ad0bba8e4f7cd2b15defd689] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:16 DEBUG : box root 'rclone-test-vocalex5qubo': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:16 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526583329") 2025/03/27 02:17:16 DEBUG : box root 'rclone-test-vocalex5qubo': ["zero-length-file.rclone_chunk.001_rla6co"(0)|file|ITEM_UPLOAD|1815142782713|059e0f36e5be917bbbbed1781e91ef3808379f91] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:16 DEBUG : box root 'rclone-test-vocalex5qubo': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:16 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526583617") 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["only8"(0)|file|ITEM_UPLOAD|1815150570375|4dd1beaed508e00af7333a35d8d0065d2645308b] new parent not found 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["both9"(0)|file|ITEM_UPLOAD|1815160864134|15a376b0c92ca9f94564d7e98581ac68c916d7bc] new parent not found 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["zero-length-file"(2)|file|ITEM_TRASH|1815142782713|93597929d1fee09761f0e8fb73a24fbba1c09393] added old path ("zero-length-file") for notify 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["dir"(0)|folder|ITEM_CREATE|313659918425|7fb9e5bde70df9f7932cf583224e14e951a6fe53] added new path ("dir") for notify 2025/03/27 02:17:17 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/27 02:17:17 DEBUG : doChangeNotify("dir", 0) 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': Received 4 events, resulting in 2 paths and 2 notifications 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526583857") 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526584125") 2025/03/27 02:17:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["only8"(0)|file|ITEM_UPLOAD|1815150570375|4dd1beaed508e00af7333a35d8d0065d2645308b] ignored due to duplicate EventID 2025/03/27 02:17:17 INFO : dir/subdir2: Making directory 2025/03/27 02:17:18 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526584373") 2025/03/27 02:17:18 DEBUG : box root 'rclone-test-vocalex5qubo': ["both9"(0)|file|ITEM_UPLOAD|1815160864134|15a376b0c92ca9f94564d7e98581ac68c916d7bc] ignored due to duplicate EventID 2025/03/27 02:17:19 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526585345") 2025/03/27 02:17:20 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526586351") 2025/03/27 02:17:20 DEBUG : box root 'rclone-test-vocalex5qubo': ["zero-length-file"(2)|file|ITEM_TRASH|1815142782713|93597929d1fee09761f0e8fb73a24fbba1c09393] ignored due to duplicate EventID 2025/03/27 02:17:21 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526587327") 2025/03/27 02:17:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["dir"(0)|folder|ITEM_CREATE|313659918425|7fb9e5bde70df9f7932cf583224e14e951a6fe53] ignored due to duplicate EventID 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526588320") 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': ["only10"(0)|file|ITEM_UPLOAD|1815160910051|75138e50a3e5b19a371cdafa7a3cda7b2103f146] new parent not found 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': ["subdir1"(0)|folder|ITEM_CREATE|313659860616|147a35f94a65c5fa998da9b063ce95e332f7f10f] added new path ("dir/subdir1") for notify 2025/03/27 02:17:22 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': Received 2 events, resulting in 1 paths and 1 notifications 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526589388") 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': ["both10"(0)|file|ITEM_UPLOAD|1815148415587|d8cb2ac4ab01408f5e74e1df0644229e2d765f02] new parent not found 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:22 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526589666") 2025/03/27 02:17:23 DEBUG : box root 'rclone-test-vocalex5qubo': ["subdir3"(0)|folder|ITEM_CREATE|313660930855|c5ede74fe7725a5d2b79620f84145852107924f1] added new path ("dir/subdir3") for notify 2025/03/27 02:17:23 DEBUG : box root 'rclone-test-vocalex5qubo': ["only11"(0)|file|ITEM_UPLOAD|1815145475685|4843fffccf42dc0880672a8d50184462f99c2581] new parent not found 2025/03/27 02:17:23 DEBUG : box root 'rclone-test-vocalex5qubo': ["only9"(0)|file|ITEM_UPLOAD|1815141992928|18ad1f27c6a27c7690c04fcbf78d4b7b65ccc05a] new parent not found 2025/03/27 02:17:23 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/03/27 02:17:23 DEBUG : box root 'rclone-test-vocalex5qubo': Received 3 events, resulting in 1 paths and 1 notifications 2025/03/27 02:17:23 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526589926") 2025/03/27 02:17:23 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526590177") 2025/03/27 02:17:23 INFO : dir/file2.rclone_chunk.001_rlaiuz: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/03/27 02:17:24 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526590424") 2025/03/27 02:17:24 INFO : dir/file2.rclone_chunk.002_rlaiuz: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/03/27 02:17:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["subdir3"(0)|folder|ITEM_CREATE|313660930855|c5ede74fe7725a5d2b79620f84145852107924f1] ignored due to duplicate EventID 2025/03/27 02:17:25 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526591324") 2025/03/27 02:17:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["only11"(0)|file|ITEM_UPLOAD|1815145475685|4843fffccf42dc0880672a8d50184462f99c2581] ignored due to duplicate EventID 2025/03/27 02:17:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["only9"(0)|file|ITEM_UPLOAD|1815141992928|18ad1f27c6a27c7690c04fcbf78d4b7b65ccc05a] ignored due to duplicate EventID 2025/03/27 02:17:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["both11"(0)|file|ITEM_UPLOAD|1815154912454|74b8c2d01bb9fed950316f217e6ba922450c1ada] new parent not found 2025/03/27 02:17:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["both12"(0)|file|ITEM_UPLOAD|1815145725041|e158dee735d907a80f1d693be781c96979356bed] new parent not found 2025/03/27 02:17:25 DEBUG : box root 'rclone-test-vocalex5qubo': Received 4 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:25 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526592325") 2025/03/27 02:17:26 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526592580") 2025/03/27 02:17:26 DEBUG : box root 'rclone-test-vocalex5qubo': ["only11"(0)|file|ITEM_UPLOAD|1815145475685|4843fffccf42dc0880672a8d50184462f99c2581] ignored due to duplicate EventID 2025/03/27 02:17:26 DEBUG : box root 'rclone-test-vocalex5qubo': ["only9"(0)|file|ITEM_UPLOAD|1815141992928|18ad1f27c6a27c7690c04fcbf78d4b7b65ccc05a] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526593343") 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["both11"(0)|file|ITEM_UPLOAD|1815154912454|74b8c2d01bb9fed950316f217e6ba922450c1ada] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["both12"(0)|file|ITEM_UPLOAD|1815145725041|e158dee735d907a80f1d693be781c96979356bed] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002_rlaiuz"(0)|file|ITEM_UPLOAD|1815150712215|c0acbdce69888abf84e964582c452c2ff7a4866a] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001_rlaiuz"(0)|file|ITEM_UPLOAD|1815157912060|e1cbc2ae10f560a77bc09a407d868c70648d473a] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1815157912060|c466a18fb3df3670ac2f70c181f9d1c4e5ff0da3] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["both13"(0)|file|ITEM_UPLOAD|1815144167327|6233a7cec4f54aeb5a137a1f17094508e4717e4d] new parent not found 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["only12"(0)|file|ITEM_UPLOAD|1815146617403|41e717b06b5bf8193897e8dac593686bdc9c76ca] new parent not found 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1815150712215|eea9e82eaa0aad86f5a8494c2b4ad8ef59e7b303] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': Received 8 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526594331") 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["both12"(0)|file|ITEM_UPLOAD|1815145725041|e158dee735d907a80f1d693be781c96979356bed] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002_rlaiuz"(0)|file|ITEM_UPLOAD|1815150712215|c0acbdce69888abf84e964582c452c2ff7a4866a] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001_rlaiuz"(0)|file|ITEM_UPLOAD|1815157912060|e1cbc2ae10f560a77bc09a407d868c70648d473a] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1815157912060|c466a18fb3df3670ac2f70c181f9d1c4e5ff0da3] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["both13"(0)|file|ITEM_UPLOAD|1815144167327|6233a7cec4f54aeb5a137a1f17094508e4717e4d] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["only12"(0)|file|ITEM_UPLOAD|1815146617403|41e717b06b5bf8193897e8dac593686bdc9c76ca] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1815150712215|eea9e82eaa0aad86f5a8494c2b4ad8ef59e7b303] ignored due to duplicate EventID 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(0)|file|ITEM_UPLOAD|1815141642833|a93ce40450603219c6df157b03a89d67bb24f2d3] ignored due to old SequenceID ('\x00') 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': Received 8 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:27 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526594621") 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["both12"(0)|file|ITEM_UPLOAD|1815145725041|e158dee735d907a80f1d693be781c96979356bed] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002_rlaiuz"(0)|file|ITEM_UPLOAD|1815150712215|c0acbdce69888abf84e964582c452c2ff7a4866a] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001_rlaiuz"(0)|file|ITEM_UPLOAD|1815157912060|e1cbc2ae10f560a77bc09a407d868c70648d473a] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1815157912060|c466a18fb3df3670ac2f70c181f9d1c4e5ff0da3] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["both13"(0)|file|ITEM_UPLOAD|1815144167327|6233a7cec4f54aeb5a137a1f17094508e4717e4d] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["only12"(0)|file|ITEM_UPLOAD|1815146617403|41e717b06b5bf8193897e8dac593686bdc9c76ca] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1815150712215|eea9e82eaa0aad86f5a8494c2b4ad8ef59e7b303] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(0)|file|ITEM_UPLOAD|1815141642833|a93ce40450603219c6df157b03a89d67bb24f2d3] ignored due to duplicate EventID 2025/03/27 02:17:28 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526594916") 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526595341") 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["both12"(0)|file|ITEM_UPLOAD|1815145725041|e158dee735d907a80f1d693be781c96979356bed] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002_rlaiuz"(0)|file|ITEM_UPLOAD|1815150712215|c0acbdce69888abf84e964582c452c2ff7a4866a] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001_rlaiuz"(0)|file|ITEM_UPLOAD|1815157912060|e1cbc2ae10f560a77bc09a407d868c70648d473a] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1815157912060|c466a18fb3df3670ac2f70c181f9d1c4e5ff0da3] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["both13"(0)|file|ITEM_UPLOAD|1815144167327|6233a7cec4f54aeb5a137a1f17094508e4717e4d] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["only12"(0)|file|ITEM_UPLOAD|1815146617403|41e717b06b5bf8193897e8dac593686bdc9c76ca] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1815150712215|eea9e82eaa0aad86f5a8494c2b4ad8ef59e7b303] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(0)|file|ITEM_UPLOAD|1815141642833|a93ce40450603219c6df157b03a89d67bb24f2d3] ignored due to duplicate EventID 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["only13"(0)|file|ITEM_UPLOAD|1815144558818|64ac2cdd71fa80f3812ff90afd600cb597cae28f] new parent not found 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': Received 9 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526596335") 2025/03/27 02:17:29 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002_rlaiuz"(0)|file|ITEM_UPLOAD|1815150712215|c0acbdce69888abf84e964582c452c2ff7a4866a] ignored due to duplicate EventID 2025/03/27 02:17:30 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526596635") 2025/03/27 02:17:30 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001_rlaiuz"(0)|file|ITEM_UPLOAD|1815157912060|e1cbc2ae10f560a77bc09a407d868c70648d473a] ignored due to duplicate EventID 2025/03/27 02:17:31 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526597359") 2025/03/27 02:17:31 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1815157912060|c466a18fb3df3670ac2f70c181f9d1c4e5ff0da3] ignored due to duplicate EventID 2025/03/27 02:17:31 DEBUG : box root 'rclone-test-vocalex5qubo': ["both13"(0)|file|ITEM_UPLOAD|1815144167327|6233a7cec4f54aeb5a137a1f17094508e4717e4d] ignored due to duplicate EventID 2025/03/27 02:17:31 DEBUG : box root 'rclone-test-vocalex5qubo': ["only12"(0)|file|ITEM_UPLOAD|1815146617403|41e717b06b5bf8193897e8dac593686bdc9c76ca] ignored due to duplicate EventID 2025/03/27 02:17:31 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1815150712215|eea9e82eaa0aad86f5a8494c2b4ad8ef59e7b303] ignored due to duplicate EventID 2025/03/27 02:17:32 INFO : dir/file4.rclone_chunk.001_rlaqvw: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/03/27 02:17:32 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526598334") 2025/03/27 02:17:32 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(0)|file|ITEM_UPLOAD|1815141642833|a93ce40450603219c6df157b03a89d67bb24f2d3] ignored due to duplicate EventID 2025/03/27 02:17:33 INFO : dir/file4.rclone_chunk.002_rlaqvw: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/03/27 02:17:33 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526599391") 2025/03/27 02:17:33 DEBUG : box root 'rclone-test-vocalex5qubo': ["only13"(0)|file|ITEM_UPLOAD|1815144558818|64ac2cdd71fa80f3812ff90afd600cb597cae28f] ignored due to duplicate EventID 2025/03/27 02:17:34 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526600339") 2025/03/27 02:17:34 DEBUG : box root 'rclone-test-vocalex5qubo': ["both14"(0)|file|ITEM_UPLOAD|1815159556704|e137e49d0af1e6e34f3358e41e880fac6b1a8f34] new parent not found 2025/03/27 02:17:34 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.002_rlaqvw"(0)|file|ITEM_UPLOAD|1815147409794|40901f93e21b9e26866bf49fa6a23d94d78b842a] added new path ("dir/file4.rclone_chunk.002_rlaqvw") for notify 2025/03/27 02:17:34 DEBUG : box root 'rclone-test-vocalex5qubo': ["only14"(0)|file|ITEM_UPLOAD|1815151254556|fb5030233422f9f7baaf68e5b82428f80c52f0a4] new parent not found 2025/03/27 02:17:34 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1815148057207|eb6e206c9af38cafde0b242679ee0f9d1e54bbd8] added new path ("dir/file4.rclone_chunk.001") for notify 2025/03/27 02:17:34 DEBUG : doChangeNotify("dir/file4.rclone_chunk.002_rlaqvw", 1) 2025/03/27 02:17:34 DEBUG : doChangeNotify("dir/file4", 1) 2025/03/27 02:17:34 DEBUG : box root 'rclone-test-vocalex5qubo': Received 4 events, resulting in 2 paths and 2 notifications 2025/03/27 02:17:34 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526601334") 2025/03/27 02:17:35 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526601591") 2025/03/27 02:17:36 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526602336") 2025/03/27 02:17:36 DEBUG : box root 'rclone-test-vocalex5qubo': ["both14"(0)|file|ITEM_UPLOAD|1815159556704|e137e49d0af1e6e34f3358e41e880fac6b1a8f34] ignored due to duplicate EventID 2025/03/27 02:17:37 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526603322") 2025/03/27 02:17:37 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.002_rlaqvw"(0)|file|ITEM_UPLOAD|1815147409794|40901f93e21b9e26866bf49fa6a23d94d78b842a] ignored due to duplicate EventID 2025/03/27 02:17:37 DEBUG : box root 'rclone-test-vocalex5qubo': ["only14"(0)|file|ITEM_UPLOAD|1815151254556|fb5030233422f9f7baaf68e5b82428f80c52f0a4] ignored due to duplicate EventID 2025/03/27 02:17:38 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526604328") 2025/03/27 02:17:38 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1815148057207|eb6e206c9af38cafde0b242679ee0f9d1e54bbd8] ignored due to duplicate EventID 2025/03/27 02:17:39 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526605346") 2025/03/27 02:17:39 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1815147409794|adbd6590773a8ad0045d43e1aa7a106a13ae0cdd] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:39 DEBUG : box root 'rclone-test-vocalex5qubo': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:39 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526606323") 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526606572") 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': ["both15"(0)|file|ITEM_UPLOAD|1815152943880|2550efa504e4f2361b6a9841e063ad5b1d8453e8] new parent not found 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4"(0)|file|ITEM_UPLOAD|1815148242538|5902efeb1de7c5f5aa7477dfc325d2062a6aefad] ignored due to old SequenceID ('\x00') 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': ["only15"(0)|file|ITEM_UPLOAD|1815141818105|2e681047959a78646a51c79478944a9a0a16e9c3] new parent not found 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': ["subdir2"(0)|folder|ITEM_CREATE|313660444649|1731381f6f6bc5b4e26766e894c5bb0e759ca0f3] ignored due to old SequenceID ('\x00') 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(0)|file|ITEM_UPLOAD|1815150995877|f13e995a355f82e5de071c5f6dbe8ee21bb7c0e3] new parent not found 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': Received 5 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526607328") 2025/03/27 02:17:40 DEBUG : box root 'rclone-test-vocalex5qubo': ["both15"(0)|file|ITEM_UPLOAD|1815152943880|2550efa504e4f2361b6a9841e063ad5b1d8453e8] ignored due to duplicate EventID 2025/03/27 02:17:40 INFO : dir/file3.rclone_chunk.001_rlaz84: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526607592") 2025/03/27 02:17:41 INFO : dir/file3.rclone_chunk.002_rlaz84: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4"(0)|file|ITEM_UPLOAD|1815148242538|5902efeb1de7c5f5aa7477dfc325d2062a6aefad] ignored due to duplicate EventID 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': ["only15"(0)|file|ITEM_UPLOAD|1815141818105|2e681047959a78646a51c79478944a9a0a16e9c3] ignored due to duplicate EventID 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': ["subdir2"(0)|folder|ITEM_CREATE|313660444649|1731381f6f6bc5b4e26766e894c5bb0e759ca0f3] ignored due to duplicate EventID 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(0)|file|ITEM_UPLOAD|1815150995877|f13e995a355f82e5de071c5f6dbe8ee21bb7c0e3] ignored due to duplicate EventID 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': ["both16"(0)|file|ITEM_UPLOAD|1815146502569|9cea98a7ffeb712a8723a832d1bd50557752ef15] new parent not found 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001_rlaz84"(0)|file|ITEM_UPLOAD|1815141111901|fc8e949ac605ec113e9284dae2a110b9bf8c0772] added new path ("dir/file3.rclone_chunk.001_rlaz84") for notify 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': ["both17"(0)|file|ITEM_UPLOAD|1815153215736|6b3fb90850153f728dcd1d44cf45115b7c8c0057] new parent not found 2025/03/27 02:17:41 DEBUG : doChangeNotify("dir/file3.rclone_chunk.001_rlaz84", 1) 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 1 paths and 1 notifications 2025/03/27 02:17:41 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526608326") 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526608624") 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["subdir2"(0)|folder|ITEM_CREATE|313660444649|1731381f6f6bc5b4e26766e894c5bb0e759ca0f3] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(0)|file|ITEM_UPLOAD|1815150995877|f13e995a355f82e5de071c5f6dbe8ee21bb7c0e3] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["both16"(0)|file|ITEM_UPLOAD|1815146502569|9cea98a7ffeb712a8723a832d1bd50557752ef15] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001_rlaz84"(0)|file|ITEM_UPLOAD|1815141111901|fc8e949ac605ec113e9284dae2a110b9bf8c0772] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["both17"(0)|file|ITEM_UPLOAD|1815153215736|6b3fb90850153f728dcd1d44cf45115b7c8c0057] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.001_rlaqvw"(0)|file|ITEM_UPLOAD|1815148057207|c26f0d3a923cc9a19769dfcc92ecb503711975f3] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526609323") 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["subdir2"(0)|folder|ITEM_CREATE|313660444649|1731381f6f6bc5b4e26766e894c5bb0e759ca0f3] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(0)|file|ITEM_UPLOAD|1815150995877|f13e995a355f82e5de071c5f6dbe8ee21bb7c0e3] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["both16"(0)|file|ITEM_UPLOAD|1815146502569|9cea98a7ffeb712a8723a832d1bd50557752ef15] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001_rlaz84"(0)|file|ITEM_UPLOAD|1815141111901|fc8e949ac605ec113e9284dae2a110b9bf8c0772] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["both17"(0)|file|ITEM_UPLOAD|1815153215736|6b3fb90850153f728dcd1d44cf45115b7c8c0057] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.001_rlaqvw"(0)|file|ITEM_UPLOAD|1815148057207|c26f0d3a923cc9a19769dfcc92ecb503711975f3] ignored due to duplicate EventID 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.002_rlaz84"(0)|file|ITEM_UPLOAD|1815147731130|1b449a24fa1b93f9bc9ec6e0e062c286ab1d29cd] added new path ("dir/file3.rclone_chunk.002_rlaz84") for notify 2025/03/27 02:17:42 DEBUG : doChangeNotify("dir/file3.rclone_chunk.002_rlaz84", 1) 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 1 paths and 1 notifications 2025/03/27 02:17:42 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526609597") 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526609886") 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(0)|file|ITEM_UPLOAD|1815150995877|f13e995a355f82e5de071c5f6dbe8ee21bb7c0e3] ignored due to duplicate EventID 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': ["both16"(0)|file|ITEM_UPLOAD|1815146502569|9cea98a7ffeb712a8723a832d1bd50557752ef15] ignored due to duplicate EventID 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001_rlaz84"(0)|file|ITEM_UPLOAD|1815141111901|fc8e949ac605ec113e9284dae2a110b9bf8c0772] ignored due to duplicate EventID 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': ["both17"(0)|file|ITEM_UPLOAD|1815153215736|6b3fb90850153f728dcd1d44cf45115b7c8c0057] ignored due to duplicate EventID 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.001_rlaqvw"(0)|file|ITEM_UPLOAD|1815148057207|c26f0d3a923cc9a19769dfcc92ecb503711975f3] ignored due to duplicate EventID 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.002_rlaz84"(0)|file|ITEM_UPLOAD|1815147731130|1b449a24fa1b93f9bc9ec6e0e062c286ab1d29cd] ignored due to duplicate EventID 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1815147731130|53bd1c7bba9fe26f7b066e2980d7649500053d1c] added new path ("dir/file3.rclone_chunk.002") for notify 2025/03/27 02:17:43 DEBUG : doChangeNotify("dir/file3", 1) 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 1 paths and 1 notifications 2025/03/27 02:17:43 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526610322") 2025/03/27 02:17:44 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526610612") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/27 02:17:44 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(0)|file|ITEM_UPLOAD|1815150995877|f13e995a355f82e5de071c5f6dbe8ee21bb7c0e3] ignored due to duplicate EventID 2025/03/27 02:17:45 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526611324") 2025/03/27 02:17:45 DEBUG : box root 'rclone-test-vocalex5qubo': ["both16"(0)|file|ITEM_UPLOAD|1815146502569|9cea98a7ffeb712a8723a832d1bd50557752ef15] ignored due to duplicate EventID 2025/03/27 02:17:45 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001_rlaz84"(0)|file|ITEM_UPLOAD|1815141111901|fc8e949ac605ec113e9284dae2a110b9bf8c0772] ignored due to duplicate EventID 2025/03/27 02:17:45 DEBUG : box root 'rclone-test-vocalex5qubo': ["both17"(0)|file|ITEM_UPLOAD|1815153215736|6b3fb90850153f728dcd1d44cf45115b7c8c0057] ignored due to duplicate EventID 2025/03/27 02:17:46 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526612344") 2025/03/27 02:17:46 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.001_rlaqvw"(0)|file|ITEM_UPLOAD|1815148057207|c26f0d3a923cc9a19769dfcc92ecb503711975f3] ignored due to duplicate EventID 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526613330") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.002_rlaz84"(0)|file|ITEM_UPLOAD|1815147731130|1b449a24fa1b93f9bc9ec6e0e062c286ab1d29cd] ignored due to duplicate EventID 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1815147731130|53bd1c7bba9fe26f7b066e2980d7649500053d1c] ignored due to duplicate EventID 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["only17"(0)|file|ITEM_UPLOAD|1815143013436|5286b1a062f4bb06949cb326b321d79929ba162c] new parent not found 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1815141111901|0feb03488ecc49a6606aeb9c4ea343877db7bb6b] ignored due to old SequenceID ('\x01') 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["only18"(0)|file|ITEM_UPLOAD|1815161102038|b62d8d7023d9f6ca76cde50bf7bb1198d57088f1] new parent not found 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["both19"(0)|file|ITEM_UPLOAD|1815150635428|9a97cda1a95c72069c034d65a3f468f7cbdaa1cd] new parent not found 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3"(0)|file|ITEM_UPLOAD|1815148446120|c6de5816f9356d34560e658e9bff93262de11830] ignored due to old SequenceID ('\x00') 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526614338") 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["only17"(0)|file|ITEM_UPLOAD|1815143013436|5286b1a062f4bb06949cb326b321d79929ba162c] ignored due to duplicate EventID 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1815141111901|0feb03488ecc49a6606aeb9c4ea343877db7bb6b] ignored due to duplicate EventID 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["only18"(0)|file|ITEM_UPLOAD|1815161102038|b62d8d7023d9f6ca76cde50bf7bb1198d57088f1] ignored due to duplicate EventID 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["both19"(0)|file|ITEM_UPLOAD|1815150635428|9a97cda1a95c72069c034d65a3f468f7cbdaa1cd] ignored due to duplicate EventID 2025/03/27 02:17:47 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3"(0)|file|ITEM_UPLOAD|1815148446120|c6de5816f9356d34560e658e9bff93262de11830] ignored due to duplicate EventID 2025/03/27 02:17:48 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526614672") 2025/03/27 02:17:49 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526615330") 2025/03/27 02:17:50 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526616336") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/27 02:17:50 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1815141111901|0feb03488ecc49a6606aeb9c4ea343877db7bb6b] ignored due to duplicate EventID 2025/03/27 02:17:50 DEBUG : box root 'rclone-test-vocalex5qubo': ["only18"(0)|file|ITEM_UPLOAD|1815161102038|b62d8d7023d9f6ca76cde50bf7bb1198d57088f1] ignored due to duplicate EventID 2025/03/27 02:17:51 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526617330") 2025/03/27 02:17:51 DEBUG : box root 'rclone-test-vocalex5qubo': ["both19"(0)|file|ITEM_UPLOAD|1815150635428|9a97cda1a95c72069c034d65a3f468f7cbdaa1cd] ignored due to duplicate EventID 2025/03/27 02:17:51 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3"(0)|file|ITEM_UPLOAD|1815148446120|c6de5816f9356d34560e658e9bff93262de11830] ignored due to duplicate EventID 2025/03/27 02:17:52 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526618332") 2025/03/27 02:17:52 DEBUG : box root 'rclone-test-vocalex5qubo': ["both18"(0)|file|ITEM_UPLOAD|1815156868711|53ae61deec0f970750396261a3cdf80fa0a7c2a7] new parent not found 2025/03/27 02:17:52 DEBUG : box root 'rclone-test-vocalex5qubo': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:52 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526619332") 2025/03/27 02:17:52 DEBUG : box root 'rclone-test-vocalex5qubo': ["only19"(0)|file|ITEM_UPLOAD|1815146035183|60fa3ae1bf72f035729915d3b60e7a75cddad7f5] new parent not found 2025/03/27 02:17:52 DEBUG : box root 'rclone-test-vocalex5qubo': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:52 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526619586") 2025/03/27 02:17:53 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526619851") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/27 02:17:54 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526620341") 2025/03/27 02:17:54 DEBUG : box root 'rclone-test-vocalex5qubo': ["only19"(0)|file|ITEM_UPLOAD|1815146035183|60fa3ae1bf72f035729915d3b60e7a75cddad7f5] ignored due to duplicate EventID 2025/03/27 02:17:54 DEBUG : box root 'rclone-test-vocalex5qubo': ["only19"(1)|file|ITEM_TRASH|1815146035183|b24c6ba316de6d775828ba91cccc7fec38973327] ignored due to duplicate EventID 2025/03/27 02:17:54 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:54 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526621325") 2025/03/27 02:17:55 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526621612") 2025/03/27 02:17:56 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526622334") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/27 02:17:56 DEBUG : box root 'rclone-test-vocalex5qubo': ["only19"(1)|file|ITEM_TRASH|1815146035183|b24c6ba316de6d775828ba91cccc7fec38973327] ignored due to duplicate EventID 2025/03/27 02:17:57 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526623322") 2025/03/27 02:17:57 DEBUG : box root 'rclone-test-vocalex5qubo': ["only9"(1)|file|ITEM_TRASH|1815141992928|228aec68df5d0336473cbb5d8add691327e02a57] ignored due to duplicate EventID 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526624336") 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': ["only17"(1)|file|ITEM_TRASH|1815143013436|9c07d482b18b77fcec368525f528875d34a8bb70] ignored due to duplicate EventID 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': ["only0"(1)|file|ITEM_TRASH|1815144258947|62a3340618839b2d4f9ec3a5b891ed8a58056db4] ignored due to duplicate EventID 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': ["only11"(1)|file|ITEM_TRASH|1815145475685|22dd498117e414cd1ec6ab1313b20b73e3e847a0] ignored due to duplicate EventID 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': ["only13"(1)|file|ITEM_TRASH|1815144558818|d42162eb3466621252a6afa0ee7735685453c4ac] ignored due to duplicate EventID 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': Received 16 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526625363") 2025/03/27 02:17:58 DEBUG : box root 'rclone-test-vocalex5qubo': ["only7"(1)|file|ITEM_TRASH|1815146034432|923d6290f74f28b9ebec584301864b915e36f1cc] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526625714") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only5"(1)|file|ITEM_TRASH|1815141126025|bf50ea2a937d99d7639bfc982775a49ccb72e45f] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only1"(1)|file|ITEM_TRASH|1815141302118|adfde7fe9b778efa7c0eabadf8b61e04a306e62b] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only10"(1)|file|ITEM_TRASH|1815160910051|77fde85906da122899270c3474dc332ef85f36fb] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only4"(1)|file|ITEM_TRASH|1815157053231|c61a5eaf82179037e2e6f37655abc45f0c2a08ca] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only12"(1)|file|ITEM_TRASH|1815146617403|fe645f81eef11076b1dbc80b1eecd0f5125b533d] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only18"(1)|file|ITEM_TRASH|1815161102038|d650c8ee0df5dee2cdd7783319718dd656e7b3fc] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only14"(1)|file|ITEM_TRASH|1815151254556|216f9c04ddae2144bf3fe9fd705ceb2030c38291] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(1)|file|ITEM_TRASH|1815150995877|a3298188469d7bfa57d7ce1e67e425c989977eaa] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only6"(1)|file|ITEM_TRASH|1815146082673|eda2eb61c3bf8419ac87eec7b048052517d500e8] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only15"(1)|file|ITEM_TRASH|1815141818105|36f3a4ec00df81465a590e5e582eb0397cf271c6] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only2"(1)|file|ITEM_TRASH|1815140269928|5ae8f97422d01bc81fd147cdd5189345ba3e997a] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': Received 13 events, resulting in 0 paths and 0 notifications 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526626336") 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only4"(1)|file|ITEM_TRASH|1815157053231|c61a5eaf82179037e2e6f37655abc45f0c2a08ca] ignored due to duplicate EventID 2025/03/27 02:17:59 DEBUG : box root 'rclone-test-vocalex5qubo': ["only12"(1)|file|ITEM_TRASH|1815146617403|fe645f81eef11076b1dbc80b1eecd0f5125b533d] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526626675") 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["only18"(1)|file|ITEM_TRASH|1815161102038|d650c8ee0df5dee2cdd7783319718dd656e7b3fc] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["only14"(1)|file|ITEM_TRASH|1815151254556|216f9c04ddae2144bf3fe9fd705ceb2030c38291] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["only16"(1)|file|ITEM_TRASH|1815150995877|a3298188469d7bfa57d7ce1e67e425c989977eaa] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["only6"(1)|file|ITEM_TRASH|1815146082673|eda2eb61c3bf8419ac87eec7b048052517d500e8] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["only15"(1)|file|ITEM_TRASH|1815141818105|36f3a4ec00df81465a590e5e582eb0397cf271c6] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["only2"(1)|file|ITEM_TRASH|1815140269928|5ae8f97422d01bc81fd147cdd5189345ba3e997a] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["only8"(1)|file|ITEM_TRASH|1815150570375|52f2fc0401ed0190cebb6fc5d7976c21d20b5fb7] ignored due to duplicate EventID 2025/03/27 02:18:00 DEBUG : box root 'rclone-test-vocalex5qubo': ["both0"(1)|file|ITEM_TRASH|1815158937290|68fd461defd2a112f44afe13bf0ade073e8bd7a4] ignored due to duplicate EventID 2025/03/27 02:18:01 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526627385") 2025/03/27 02:18:01 DEBUG : box root 'rclone-test-vocalex5qubo': ["only15"(1)|file|ITEM_TRASH|1815141818105|36f3a4ec00df81465a590e5e582eb0397cf271c6] ignored due to duplicate EventID 2025/03/27 02:18:02 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526628330") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/03/27 02:18:02 DEBUG : box root 'rclone-test-vocalex5qubo': ["only2"(1)|file|ITEM_TRASH|1815140269928|5ae8f97422d01bc81fd147cdd5189345ba3e997a] ignored due to duplicate EventID 2025/03/27 02:18:02 DEBUG : box root 'rclone-test-vocalex5qubo': ["only8"(1)|file|ITEM_TRASH|1815150570375|52f2fc0401ed0190cebb6fc5d7976c21d20b5fb7] ignored due to duplicate EventID 2025/03/27 02:18:02 DEBUG : box root 'rclone-test-vocalex5qubo': ["both0"(1)|file|ITEM_TRASH|1815158937290|68fd461defd2a112f44afe13bf0ade073e8bd7a4] ignored due to duplicate EventID 2025/03/27 02:18:02 DEBUG : box root 'rclone-test-vocalex5qubo': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/27 02:18:02 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526629339") 2025/03/27 02:18:02 DEBUG : box root 'rclone-test-vocalex5qubo': ["only8"(1)|file|ITEM_TRASH|1815150570375|52f2fc0401ed0190cebb6fc5d7976c21d20b5fb7] ignored due to duplicate EventID 2025/03/27 02:18:03 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526629616") 2025/03/27 02:18:03 DEBUG : box root 'rclone-test-vocalex5qubo': ["both0"(1)|file|ITEM_TRASH|1815158937290|68fd461defd2a112f44afe13bf0ade073e8bd7a4] ignored due to duplicate EventID 2025/03/27 02:18:04 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526630327") 2025/03/27 02:18:05 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526631328") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/03/27 02:18:05 DEBUG : box root 'rclone-test-vocalex5qubo': ["both1"(1)|file|ITEM_TRASH|1815141959743|5e8cb755cdab12a43871ea1e782db2f70d4b409f] ignored due to duplicate EventID 2025/03/27 02:18:05 DEBUG : box root 'rclone-test-vocalex5qubo': ["only3"(1)|file|ITEM_TRASH|1815158251175|e8c8458b80099a6a5a4bf446cf86028a7123ffec] ignored due to duplicate EventID 2025/03/27 02:18:06 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526632342") 2025/03/27 02:18:06 DEBUG : box root 'rclone-test-vocalex5qubo': ["both10"(1)|file|ITEM_TRASH|1815148415587|1b871c7fce4b6c29109d4441d5581e78a235583d] ignored due to duplicate EventID 2025/03/27 02:18:07 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526633331") 2025/03/27 02:18:07 DEBUG : box root 'rclone-test-vocalex5qubo': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/27 02:18:07 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526634338") 2025/03/27 02:18:08 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526634602") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/03/27 02:18:08 DEBUG : box root 'rclone-test-vocalex5qubo': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/27 02:18:08 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526635322") 2025/03/27 02:18:08 DEBUG : box root 'rclone-test-vocalex5qubo': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/27 02:18:08 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526635564") 2025/03/27 02:18:09 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526635819") 2025/03/27 02:18:09 DEBUG : box root 'rclone-test-vocalex5qubo': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/27 02:18:09 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526636330") 2025/03/27 02:18:10 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526636586") 2025/03/27 02:18:11 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526637338") fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[dir/file3:{} dir/file3.rclone_chunk.001_rlaz84:{} dir/file3.rclone_chunk.002_rlaz84:{} dir/file4:{} dir/file4.rclone_chunk.002_rlaqvw:{} zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/03/27 02:18:12 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526638334") 2025/03/27 02:18:13 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526639336") 2025/03/27 02:18:13 DEBUG : box root 'rclone-test-vocalex5qubo': ["both16"(1)|file|ITEM_TRASH|1815146502569|243a4275c81d1e70d6453a65d2dceab0d3033c69] ignored due to duplicate EventID 2025/03/27 02:18:13 DEBUG : box root 'rclone-test-vocalex5qubo': ["both17"(1)|file|ITEM_TRASH|1815153215736|1a2b996438e05012da0fbf4855b86834c3922ff7] ignored due to duplicate EventID 2025/03/27 02:18:13 DEBUG : box root 'rclone-test-vocalex5qubo': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/27 02:18:13 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526640335") 2025/03/27 02:18:14 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526640633") 2025/03/27 02:18:15 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526641333") 2025/03/27 02:18:16 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526642337") 2025/03/27 02:18:16 DEBUG : box root 'rclone-test-vocalex5qubo': ["both19"(1)|file|ITEM_TRASH|1815150635428|43b1e81d8695b88059353aa91d695c0083eed54f] ignored due to duplicate EventID 2025/03/27 02:18:17 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526643332") 2025/03/27 02:18:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["both15"(1)|file|ITEM_TRASH|1815152943880|791cbce7e709601d9fa473ca66ca930fea229253] ignored due to duplicate EventID 2025/03/27 02:18:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["both2"(1)|file|ITEM_TRASH|1815157156497|9a1903e6757a21bf06939ead875a2dfc2dcc2c1b] ignored due to duplicate EventID 2025/03/27 02:18:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["both3"(1)|file|ITEM_TRASH|1815143686870|339f14b0c097176d0162b500cde3dc67fb53286c] ignored due to duplicate EventID 2025/03/27 02:18:17 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1815157912060|d87fb425573d6032140c9a75c6009a8e07fe398c] added old path ("dir/file2.rclone_chunk.001") for notify 2025/03/27 02:18:17 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/27 02:18:17 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 1 paths and 1 notifications 2025/03/27 02:18:17 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526644357") 2025/03/27 02:18:18 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526644635") 2025/03/27 02:18:18 DEBUG : box root 'rclone-test-vocalex5qubo': ["both4"(1)|file|ITEM_TRASH|1815143615323|c1a9bba8f60e8dd6180d485f8ce4375b43f2a74b] ignored due to duplicate EventID 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526645344") 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': ["both5"(1)|file|ITEM_TRASH|1815142408413|f1358c216818b82b6c611fe2ecc69082124b5091] ignored due to duplicate EventID 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': ["both18"(1)|file|ITEM_TRASH|1815156868711|ce33dd1d952e1717acd82fc7face99e9087346bf] ignored due to duplicate EventID 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1815157912060|d87fb425573d6032140c9a75c6009a8e07fe398c] ignored due to duplicate EventID 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1815150712215|e154132be1708930af1af7a5b3601a2a554e1631] added old path ("dir/file2.rclone_chunk.002") for notify 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4"(1)|file|ITEM_TRASH|1815148242538|e2d49ad83d6d724f02292848aea6694aa8f517e1] added old path ("dir/file4") for notify 2025/03/27 02:18:19 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/27 02:18:19 DEBUG : doChangeNotify("dir/file4", 1) 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 2 paths and 2 notifications 2025/03/27 02:18:19 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526646338") 2025/03/27 02:18:20 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526646630") 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526647319") 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1815157912060|d87fb425573d6032140c9a75c6009a8e07fe398c] ignored due to duplicate EventID 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["both6"(1)|file|ITEM_TRASH|1815142314898|e8fe629ff129c49b82f66eb68e57438365886f71] ignored due to duplicate EventID 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1815150712215|e154132be1708930af1af7a5b3601a2a554e1631] ignored due to duplicate EventID 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["both7"(1)|file|ITEM_TRASH|1815148040881|d1c3a622522d886587236d3c8704fc10dc0f80ce] ignored due to duplicate EventID 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4"(1)|file|ITEM_TRASH|1815148242538|e2d49ad83d6d724f02292848aea6694aa8f517e1] ignored due to duplicate EventID 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(1)|file|ITEM_TRASH|1815141642833|f04388346bec689fb1d72d9feaedb75d5d0f9e0c] added old path ("dir/file2") for notify 2025/03/27 02:18:21 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': Received 8 events, resulting in 1 paths and 1 notifications 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526648332") 2025/03/27 02:18:21 DEBUG : box root 'rclone-test-vocalex5qubo': ["both6"(1)|file|ITEM_TRASH|1815142314898|e8fe629ff129c49b82f66eb68e57438365886f71] ignored due to duplicate EventID 2025/03/27 02:18:22 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526648624") 2025/03/27 02:18:23 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526649335") 2025/03/27 02:18:23 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1815150712215|e154132be1708930af1af7a5b3601a2a554e1631] ignored due to duplicate EventID 2025/03/27 02:18:23 DEBUG : box root 'rclone-test-vocalex5qubo': ["both7"(1)|file|ITEM_TRASH|1815148040881|d1c3a622522d886587236d3c8704fc10dc0f80ce] ignored due to duplicate EventID 2025/03/27 02:18:23 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4"(1)|file|ITEM_TRASH|1815148242538|e2d49ad83d6d724f02292848aea6694aa8f517e1] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526650325") 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["both8"(1)|file|ITEM_TRASH|1815150470024|81b6293a269ebb12865a216f181e5ca816e50753] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["both9"(1)|file|ITEM_TRASH|1815160864134|debbd8fb0eb00146ccf0898652851f9c6d14ffa1] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(1)|file|ITEM_TRASH|1815141642833|f04388346bec689fb1d72d9feaedb75d5d0f9e0c] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["both0"(0)|file|ITEM_UPLOAD|1815144973657|ac556ec3c60fdfdd8f1cb4acea8728deb9776930] new parent not found 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["only0"(0)|file|ITEM_UPLOAD|1815144904428|e10fb836bea37c5902f5a3e675e199f1d5ae9ab3] new parent not found 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1815147409794|5c7c1a0c886db19ad48eabb1c28b65301970d87e] added old path ("dir/file4.rclone_chunk.002") for notify 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3"(1)|file|ITEM_TRASH|1815148446120|e0a6efc263066ca8325ee212f8703a85e029d18c] added old path ("dir/file3") for notify 2025/03/27 02:18:24 DEBUG : doChangeNotify("dir/file4", 1) 2025/03/27 02:18:24 DEBUG : doChangeNotify("dir/file3", 1) 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': Received 7 events, resulting in 2 paths and 2 notifications 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526651335") 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(1)|file|ITEM_TRASH|1815141642833|f04388346bec689fb1d72d9feaedb75d5d0f9e0c] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["both0"(0)|file|ITEM_UPLOAD|1815144973657|ac556ec3c60fdfdd8f1cb4acea8728deb9776930] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["only0"(0)|file|ITEM_UPLOAD|1815144904428|e10fb836bea37c5902f5a3e675e199f1d5ae9ab3] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1815147409794|5c7c1a0c886db19ad48eabb1c28b65301970d87e] ignored due to duplicate EventID 2025/03/27 02:18:24 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3"(1)|file|ITEM_TRASH|1815148446120|e0a6efc263066ca8325ee212f8703a85e029d18c] ignored due to duplicate EventID 2025/03/27 02:18:25 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526651610") 2025/03/27 02:18:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["file2"(1)|file|ITEM_TRASH|1815141642833|f04388346bec689fb1d72d9feaedb75d5d0f9e0c] ignored due to duplicate EventID 2025/03/27 02:18:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["both0"(0)|file|ITEM_UPLOAD|1815144973657|ac556ec3c60fdfdd8f1cb4acea8728deb9776930] ignored due to duplicate EventID 2025/03/27 02:18:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["only0"(0)|file|ITEM_UPLOAD|1815144904428|e10fb836bea37c5902f5a3e675e199f1d5ae9ab3] ignored due to duplicate EventID 2025/03/27 02:18:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1815147409794|5c7c1a0c886db19ad48eabb1c28b65301970d87e] ignored due to duplicate EventID 2025/03/27 02:18:25 DEBUG : box root 'rclone-test-vocalex5qubo': ["file3"(1)|file|ITEM_TRASH|1815148446120|e0a6efc263066ca8325ee212f8703a85e029d18c] ignored due to duplicate EventID 2025/03/27 02:18:26 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526652327") 2025/03/27 02:18:27 DEBUG : box root 'rclone-test-vocalex5qubo': Checking for changes on remote (next_stream_position: "30401040526653336") 2025/03/27 02:18:27 DEBUG : box root 'rclone-test-vocalex5qubo': ["both0"(0)|file|ITEM_UPLOAD|1815144973657|ac556ec3c60fdfdd8f1cb4acea8728deb9776930] ignored due to duplicate EventID === RUN TestIntegration/FsMkdir/FsPutFiles 2025/03/27 02:18:33 INFO : file name.txt.rclone_chunk.001_rlcfsq: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/27 02:18:33 INFO : file name.txt.rclone_chunk.002_rlcfsq: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/27 02:18:42 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_rlcnvh: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/27 02:18:42 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_rlcnvh: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/27 02:18:54 INFO : file name.txt.rclone_chunk.001_rlcye0: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/27 02:18:55 INFO : file name.txt.rclone_chunk.002_rlcye0: Moved (server-side) to: file name.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/03/27 02:19:03 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/27 02:19:03 DEBUG : Creating backend with remote "TestBox:" 2025/03/27 02:19:03 DEBUG : Reset feature "ListR" 2025/03/27 02:19:04 DEBUG : box root '': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2025/03/27 02:19:22 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_rldrka: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/03/27 02:19:22 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_rldrka: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/03/27 02:19:37 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_rle7wa: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/03/27 02:19:38 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_rle7wa: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/03/27 02:19:42 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo/dirToPurgeFromRoot" 2025/03/27 02:19:42 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/dirToPurgeFromRoot" 2025/03/27 02:19:43 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/27 02:19:48 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo/hello? sausage/êé" 2025/03/27 02:19:48 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/hello? sausage/êé" 2025/03/27 02:19:50 DEBUG : Reset feature "ListR" 2025/03/27 02:20:00 INFO : a/b/c/d/e.txt.rclone_chunk.001_rlep0z: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/03/27 02:20:01 INFO : a/b/c/d/e.txt.rclone_chunk.002_rlep0z: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/03/27 02:20:10 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy 2 data chunks... === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1289: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/03/27 02:20:24 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/03/27 02:20:25 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/03/27 02:20:26 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/03/27 02:20:27 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/03/27 02:20:33 DEBUG : file name.txt: move 2 data chunks... 2025/03/27 02:20:35 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/03/27 02:20:36 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/03/27 02:20:37 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/03/27 02:20:42 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/03/27 02:20:43 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/27 02:20:44 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/27 02:20:45 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/03/27 02:20:51 DEBUG : other.txt: move 2 data chunks... 2025/03/27 02:20:52 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/27 02:20:53 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/27 02:20:54 INFO : other.txt: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/03/27 02:20:58 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-xotodos3yuga" 2025/03/27 02:20:58 DEBUG : Creating backend with remote "TestBox:rclone-test-xotodos3yuga" 2025/03/27 02:20:59 DEBUG : box root 'rclone-test-xotodos3yuga': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/27 02:20:59 DEBUG : Reset feature "ListR" 2025/03/27 02:21:00 DEBUG : box root 'rclone-test-xotodos3yuga': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/27 02:21:06 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/27 02:21:10 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/27 02:21:17 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-xotodos3yuga': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/03/27 02:21:59 INFO : file name.txt.rclone_chunk.001_rlhzyj: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/27 02:22:00 INFO : file name.txt.rclone_chunk.002_rlhzyj: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/27 02:22:00 INFO : file name.txt.rclone_chunk.003_rlhzyj: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/03/27 02:22:01 INFO : file name.txt.rclone_chunk.004_rlhzyj: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/03/27 02:22:09 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/27 02:22:09 DEBUG : Config file has changed externally - reloading 2025/03/27 02:22:09 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/27 02:22:15 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-vocalex5qubo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-vocalex5qubo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2025/03/27 02:22:15 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/27 02:22:15 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo/not found.txt" 2025/03/27 02:22:15 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/not found.txt" 2025/03/27 02:22:18 DEBUG : Reset feature "ListR" 2025/03/27 02:22:19 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-vocalex5qubo" from "TestChunkerChunk50bBox:rclone-test-vocalex5qubo" 2025/03/27 02:22:19 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/27 02:22:19 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/03/27 02:22:27 INFO : rclone-test-vocalex5qubo/created from root.txt.rclone_chunk.001_rlixij: Moved (server-side) to: rclone-test-vocalex5qubo/created from root.txt.rclone_chunk.001 2025/03/27 02:22:27 INFO : rclone-test-vocalex5qubo/created from root.txt.rclone_chunk.002_rlixij: Moved (server-side) to: rclone-test-vocalex5qubo/created from root.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/03/27 02:22:55 INFO : piped data.txt.rclone_chunk.001_rljq4b: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/03/27 02:23:03 INFO : piped data.txt.rclone_chunk.001_rljwt2: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/03/27 02:23:04 INFO : piped data.txt.rclone_chunk.002_rljwt2: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/03/27 02:23:05 INFO : piped data.txt.rclone_chunk.003_rljwt2: Moved (server-side) to: piped data.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge chunker_internal_test.go:906: -upload-kilobytes is not set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat 2025/03/27 02:23:12 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-vocalex5qubo': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/03/27 02:23:17 INFO : small/emptyfile.rclone_chunk.001_rlkc42: Moved (server-side) to: small/emptyfile 2025/03/27 02:23:26 INFO : small/smallfile.rclone_chunk.001_rlklfz: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/03/27 02:23:41 INFO : corrupted/billy.rclone_chunk.001_rlkuu1: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/03/27 02:23:42 INFO : corrupted/billy.rclone_chunk.002_rlkuu1: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/03/27 02:23:43 INFO : corrupted/billy.rclone_chunk.003_rlkuu1: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/03/27 02:23:43 INFO : corrupted/billy.rclone_chunk.004_rlkuu1: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/03/27 02:23:44 INFO : corrupted/billy.rclone_chunk.005_rlkuu1: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/03/27 02:23:57 INFO : corrupted/silly1.rclone_chunk.001_rllajs: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/03/27 02:23:58 INFO : corrupted/silly1.rclone_chunk.002_rllajs: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/03/27 02:23:58 INFO : corrupted/silly1.rclone_chunk.003_rllajs: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/03/27 02:23:59 INFO : corrupted/silly1.rclone_chunk.004_rllajs: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/03/27 02:24:00 INFO : corrupted/silly1.rclone_chunk.005_rllajs: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/03/27 02:24:13 INFO : corrupted/silly2.rclone_chunk.001_rllr0i: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/03/27 02:24:14 INFO : corrupted/silly2.rclone_chunk.002_rllr0i: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/03/27 02:24:15 INFO : corrupted/silly2.rclone_chunk.003_rllr0i: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/03/27 02:24:15 INFO : corrupted/silly2.rclone_chunk.004_rllr0i: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/03/27 02:24:16 INFO : corrupted/silly2.rclone_chunk.005_rllr0i: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/03/27 02:24:32 INFO : corrupted/silly3.rclone_chunk.001_rlm9dr: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/03/27 02:24:33 INFO : corrupted/silly3.rclone_chunk.002_rlm9dr: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/03/27 02:24:33 INFO : corrupted/silly3.rclone_chunk.003_rlm9dr: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/03/27 02:24:34 INFO : corrupted/silly3.rclone_chunk.004_rlm9dr: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/03/27 02:24:35 INFO : corrupted/silly3.rclone_chunk.005_rlm9dr: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/03/27 02:24:48 INFO : corrupted/willy.rclone_chunk.001_rlmpry: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/03/27 02:24:49 INFO : corrupted/willy.rclone_chunk.002_rlmpry: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/03/27 02:24:49 INFO : corrupted/willy.rclone_chunk.003_rlmpry: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/03/27 02:24:50 INFO : corrupted/willy.rclone_chunk.004_rlmpry: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/03/27 02:24:51 INFO : corrupted/willy.rclone_chunk.005_rlmpry: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/03/27 02:25:05 INFO : corrupted/silly4.rclone_chunk.001_rln65d: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/03/27 02:25:06 INFO : corrupted/silly4.rclone_chunk.002_rln65d: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/03/27 02:25:06 INFO : corrupted/silly4.rclone_chunk.003_rln65d: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/03/27 02:25:07 INFO : corrupted/silly4.rclone_chunk.004_rln65d: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/03/27 02:25:07 INFO : corrupted/silly4.rclone_chunk.005_rln65d: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/03/27 02:25:11 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/03/27 02:25:22 INFO : corrupted/silly5.rclone_chunk.001_rlnnym: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/03/27 02:25:22 INFO : corrupted/silly5.rclone_chunk.002_rlnnym: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/03/27 02:25:23 INFO : corrupted/silly5.rclone_chunk.003_rlnnym: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/03/27 02:25:24 INFO : corrupted/silly5.rclone_chunk.004_rlnnym: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/03/27 02:25:24 INFO : corrupted/silly5.rclone_chunk.005_rlnnym: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/03/27 02:25:27 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2025/03/27 02:25:49 INFO : wreaked/wreaker.rclone_chunk.001_rloiqc: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/03/27 02:25:50 INFO : wreaked/wreaker.rclone_chunk.002_rloiqc: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/03/27 02:25:55 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-vocalex5qubo': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/03/27 02:26:11 ERROR : usermeta/today.rclone_chunk.001_rlp71r: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1815149886938","file_version":{"type":"file_version","id":"2000892729338","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_rlp71r"}}) 2025/03/27 02:26:13 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/03/27 02:26:13 INFO : usermeta/today.rclone_chunk.001_rlp71r: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/03/27 02:26:26 ERROR : usermeta/past.rclone_chunk.001_rlpm5a: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1815165416671","file_version":{"type":"file_version","id":"2000908873471","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_rlpm5a"}}) 2025/03/27 02:26:27 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/03/27 02:26:28 INFO : usermeta/past.rclone_chunk.001_rlpm5a: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/03/27 02:26:41 ERROR : usermeta/future.rclone_chunk.001_rlq1e5: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1815169969561","file_version":{"type":"file_version","id":"2000913575161","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_rlq1e5"}}) 2025/03/27 02:26:42 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/03/27 02:26:43 INFO : usermeta/future.rclone_chunk.001_rlq1e5: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/03/27 02:27:05 DEBUG : future/test: Can't move - required hash not found 2025/03/27 02:27:05 DEBUG : future/test: Can't move, switching to copy 2025/03/27 02:27:06 DEBUG : future/test: Can't copy - required hash not found 2025/03/27 02:27:07 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/27 02:27:07 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/27 02:27:09 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-vocalex5qubo': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/03/27 02:27:57 INFO : backcomp/renamefile.rclone_chunk.001_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/03/27 02:27:58 INFO : backcomp/renamefile.rclone_chunk.002_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/03/27 02:27:59 INFO : backcomp/renamefile.rclone_chunk.003_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/03/27 02:27:59 INFO : backcomp/renamefile.rclone_chunk.004_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/03/27 02:28:00 INFO : backcomp/renamefile.rclone_chunk.005_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/03/27 02:28:01 INFO : backcomp/renamefile.rclone_chunk.006_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/03/27 02:28:01 INFO : backcomp/renamefile.rclone_chunk.007_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/03/27 02:28:02 INFO : backcomp/renamefile.rclone_chunk.008_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/03/27 02:28:02 INFO : backcomp/renamefile.rclone_chunk.009_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/03/27 02:28:03 INFO : backcomp/renamefile.rclone_chunk.010_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/03/27 02:28:04 INFO : backcomp/renamefile.rclone_chunk.011_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/03/27 02:28:04 INFO : backcomp/renamefile.rclone_chunk.012_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/03/27 02:28:05 INFO : backcomp/renamefile.rclone_chunk.013_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/03/27 02:28:05 INFO : backcomp/renamefile.rclone_chunk.014_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/03/27 02:28:06 INFO : backcomp/renamefile.rclone_chunk.015_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/03/27 02:28:07 INFO : backcomp/renamefile.rclone_chunk.016_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/03/27 02:28:07 INFO : backcomp/renamefile.rclone_chunk.017_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/03/27 02:28:08 INFO : backcomp/renamefile.rclone_chunk.018_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/03/27 02:28:08 INFO : backcomp/renamefile.rclone_chunk.019_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/03/27 02:28:09 INFO : backcomp/renamefile.rclone_chunk.020_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/03/27 02:28:10 INFO : backcomp/renamefile.rclone_chunk.021_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/03/27 02:28:10 INFO : backcomp/renamefile.rclone_chunk.022_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/03/27 02:28:11 INFO : backcomp/renamefile.rclone_chunk.023_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/03/27 02:28:11 INFO : backcomp/renamefile.rclone_chunk.024_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/03/27 02:28:12 INFO : backcomp/renamefile.rclone_chunk.025_rlr0ke: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/03/27 02:28:49 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo/servermovetest/subdir1" 2025/03/27 02:28:49 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/servermovetest/subdir1" 2025/03/27 02:28:53 DEBUG : Reset feature "ListR" 2025/03/27 02:28:53 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo/servermovetest/subdir2" 2025/03/27 02:28:53 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/servermovetest/subdir2" 2025/03/27 02:28:57 DEBUG : Reset feature "ListR" 2025/03/27 02:29:06 INFO : movefile.rclone_chunk.001_rltwaa: Moved (server-side) to: movefile.rclone_chunk.001 2025/03/27 02:29:07 INFO : movefile.rclone_chunk.002_rltwaa: Moved (server-side) to: movefile.rclone_chunk.002 2025/03/27 02:29:13 DEBUG : movefile: move 2 data chunks... 2025/03/27 02:29:15 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/03/27 02:29:16 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/03/27 02:29:18 INFO : movefile: Moved (server-side) 2025/03/27 02:29:19 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/03/27 02:29:25 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-vocalex5qubo/md5all" 2025/03/27 02:29:25 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/03/27 02:29:25 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/md5all" 2025/03/27 02:29:27 DEBUG : Reset feature "ListR" chunker_internal_test.go:878: this test needs a base fs with slow hash, e.g. local === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *chunker.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2485: *chunker.Fs does not implement SetCopyCutoff === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/03/27 02:29:33 INFO : unknown-size-put.txt.rclone_chunk.001_rluqo2: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/03/27 02:29:34 INFO : unknown-size-put.txt.rclone_chunk.002_rluqo2: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/03/27 02:29:34 INFO : unknown-size-put.txt.rclone_chunk.003_rluqo2: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/03/27 02:29:46 INFO : unknown-size-update.txt.rclone_chunk.001_rlv4pu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/27 02:29:47 INFO : unknown-size-update.txt.rclone_chunk.002_rlv4pu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/27 02:30:03 INFO : unknown-size-update.txt.rclone_chunk.001_rlve9x: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/27 02:30:04 INFO : unknown-size-update.txt.rclone_chunk.002_rlve9x: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/27 02:30:05 INFO : unknown-size-update.txt.rclone_chunk.003_rlve9x: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/03/27 02:30:05 INFO : unknown-size-update.txt.rclone_chunk.004_rlve9x: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/03/27 02:30:06 INFO : unknown-size-update.txt.rclone_chunk.005_rlve9x: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/03/27 02:30:15 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vocalex5qubo/deeper/nonexisting/directory" 2025/03/27 02:30:15 DEBUG : Creating backend with remote "TestBox:rclone-test-vocalex5qubo/deeper/nonexisting/directory" 2025/03/27 02:30:19 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory === RUN TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata fstests.go:2742: Directories don't support ReadDirMetadata === RUN TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata fstests.go:2754: Directories don't support WriteDirMetadata === RUN TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime fstests.go:2768: Directories don't support WriteDirSetModTime === RUN TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap 2025/03/27 02:30:25 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/27 02:30:25 ERROR : : error listing: directory not found 2025/03/27 02:30:26 DEBUG : box root 'rclone-test-vocalex5qubo': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1180.22s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.52s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.49s) --- FAIL: TestIntegration/FsMkdir (1174.81s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (8.79s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.36s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.37s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.37s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (300.40s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (16.62s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (16.08s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (16.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (16.74s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (15.58s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (15.63s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (15.89s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (15.73s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (16.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (15.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (15.62s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (15.72s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (16.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (15.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (15.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (15.49s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (15.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (15.43s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (16.15s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.75s) --- PASS: TestIntegration/FsMkdir/FsPutError (62.63s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (7.05s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (73.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (659.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.98s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (2.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.57s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.84s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.79s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (4.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (2.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (15.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (16.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (20.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (13.97s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (36.11s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (19.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (1.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (1.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (1.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (1.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (1.26s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (1.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (1.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (1.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (1.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (5.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (21.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (3.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (21.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (2.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.40s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (18.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (7.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (1.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (9.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (21.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (6.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (15.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (374.44s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (18.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (132.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (21.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (46.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (21.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (96.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (35.74s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (1.91s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (48.36s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (14.20s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (34.16s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (4.41s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.61s) --- SKIP: TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/chunker 1180.263s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 19m43.001864653s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]