"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/12 07:12:36 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose" 2025/03/12 07:12:36 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 07:12:36 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose" 2025/03/12 07:12:36 DEBUG : box root 'rclone-test-sacubol4tose': Token expired but no uploads in progress - doing nothing 2025/03/12 07:12:36 DEBUG : TestBox: Loaded invalid token from config file - ignoring 2025/03/12 07:12:37 DEBUG : Saving config "token" in section "TestBox" of the config file 2025/03/12 07:12:37 DEBUG : TestBox: Saved new token in config file 2025/03/12 07:12:37 DEBUG : box root 'rclone-test-sacubol4tose': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/12 07:12:38 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/03/12 07:12:38 DEBUG : box root 'rclone-test-sacubol4tose': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/12 07:12:39 DEBUG : box root 'rclone-test-sacubol4tose': 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/12 07:12:41 DEBUG : box root 'rclone-test-sacubol4tose': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/03/12 07:12:42 INFO : dir/subdir: Making directory 2025/03/12 07:12:45 INFO : dir/subdir: Removing directory 2025/03/12 07:12:48 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/12 07:12:50 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/12 07:12:57 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_06z3qr: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/03/12 07:12:58 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_06z3qr: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/03/12 07:13:13 INFO : ．/．.rclone_chunk.001_06zk2l: Moved (server-side) to: ．/．.rclone_chunk.001 2025/03/12 07:13:14 INFO : ．/．.rclone_chunk.002_06zk2l: Moved (server-side) to: ．/．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/03/12 07:13:27 INFO : ．．/．．.rclone_chunk.001_06zypj: Moved (server-side) to: ．．/．．.rclone_chunk.001 2025/03/12 07:13:27 INFO : ．．/．．.rclone_chunk.002_06zypj: Moved (server-side) to: ．．/．．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/03/12 07:13:40 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_070b9d: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/03/12 07:13:40 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_070b9d: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/03/12 07:13:56 INFO : leading space/ leading space.rclone_chunk.001_070qd0: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/03/12 07:13:57 INFO : leading space/ leading space.rclone_chunk.002_070qd0: 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/12 07:14:11 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_07162n: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/03/12 07:14:12 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_07162n: 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/12 07:14:25 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_071klh: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/03/12 07:14:25 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_071klh: 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/12 07:14:38 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_071x7s: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/03/12 07:14:38 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_071x7s: 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/12 07:14:55 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_072c16: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/03/12 07:14:55 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_072c16: 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/12 07:15:10 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_072tje: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/03/12 07:15:11 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_072tje: 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/12 07:15:25 INFO : .leading dot/.leading dot.rclone_chunk.001_0738sb: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/03/12 07:15:26 INFO : .leading dot/.leading dot.rclone_chunk.002_0738sb: 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/12 07:15:38 INFO : trailing space /trailing space .rclone_chunk.001_073mfw: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/03/12 07:15:39 INFO : trailing space /trailing space .rclone_chunk.002_073mfw: 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/12 07:15:55 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_07415o: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/03/12 07:15:55 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_07415o: 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/12 07:16:10 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_074gxr: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/03/12 07:16:10 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_074gxr: 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/12 07:16:24 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_074vn8: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/03/12 07:16:25 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_074vn8: 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/12 07:16:37 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_07591q: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/03/12 07:16:38 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_07591q: 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/12 07:16:53 INFO : trailing dot./trailing dot..rclone_chunk.001_075nf5: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/03/12 07:16:53 INFO : trailing dot./trailing dot..rclone_chunk.002_075nf5: 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/12 07:17:08 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_0763tw: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/03/12 07:17:09 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_0763tw: 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/12 07:17:23 INFO : test%46.txt/test%46.txt.rclone_chunk.001_076iat: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/03/12 07:17:24 INFO : test%46.txt/test%46.txt.rclone_chunk.002_076iat: 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/12 07:18:35 INFO : zero-length-file.rclone_chunk.001_078joy: 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/12 07:18:38 INFO : dir: Making directory 2025/03/12 07:18:39 INFO : dir/subdir1: Making directory 2025/03/12 07:18:40 INFO : dir/subdir3: Making directory 2025/03/12 07:18:40 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248666132") 2025/03/12 07:18:41 INFO : dir/subdir2: Making directory 2025/03/12 07:18:41 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248667361") 2025/03/12 07:18:42 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248668358") 2025/03/12 07:18:43 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248669359") 2025/03/12 07:18:44 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248670355") 2025/03/12 07:18:45 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248671365") 2025/03/12 07:18:46 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248672385") 2025/03/12 07:18:47 INFO : dir/file2.rclone_chunk.001_078tp4: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/03/12 07:18:47 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248673398") 2025/03/12 07:18:47 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.013_076wol"(0)|file|ITEM_UPLOAD|1800791831513|ed2dd7646e6d3e10c79841efdcec90ce83c11aa0] added new path ("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt.rclone_chunk.013_076wol") for notify 2025/03/12 07:18:47 DEBUG : doChangeNotify("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt.rclone_chunk.013_076wol", 1) 2025/03/12 07:18:47 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt.rclone_chunk.013_076wol", 1 2025/03/12 07:18:47 DEBUG : box root 'rclone-test-sacubol4tose': Received 4 events, resulting in 1 paths and 1 notifications 2025/03/12 07:18:47 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248674428") 2025/03/12 07:18:47 INFO : dir/file2.rclone_chunk.002_078tp4: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248674746") 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.004_076wol"(1)|file|ITEM_TRASH|1800799430175|2c839d2a903ef777e4745dd960678e343078b742] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.003_076wol"(1)|file|ITEM_TRASH|1800790225532|81dd3f2ff085524240d0ba09245f66e3b29f99f4] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.013_076wol"(0)|file|ITEM_UPLOAD|1800791831513|ed2dd7646e6d3e10c79841efdcec90ce83c11aa0] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.007_076wol"(1)|file|ITEM_TRASH|1800797386950|1e005b36b4480863d673e0ac8736cc6630d9e807] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248675383") 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.004_076wol"(1)|file|ITEM_TRASH|1800799430175|2c839d2a903ef777e4745dd960678e343078b742] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.003_076wol"(1)|file|ITEM_TRASH|1800790225532|81dd3f2ff085524240d0ba09245f66e3b29f99f4] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.013_076wol"(0)|file|ITEM_UPLOAD|1800791831513|ed2dd7646e6d3e10c79841efdcec90ce83c11aa0] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.007_076wol"(1)|file|ITEM_TRASH|1800797386950|1e005b36b4480863d673e0ac8736cc6630d9e807] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.006_076wol"(1)|file|ITEM_TRASH|1800801193884|be6ac894fcd6bd40ab6520d8040a8556445139a7] ignored due to duplicate EventID 2025/03/12 07:18:48 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.005_076wol"(1)|file|ITEM_TRASH|1800800130432|a6310831034fa45a90dd7581d2959893313bd1c6] ignored due to duplicate EventID 2025/03/12 07:18:49 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248675703") 2025/03/12 07:18:49 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.004_076wol"(1)|file|ITEM_TRASH|1800799430175|2c839d2a903ef777e4745dd960678e343078b742] ignored due to duplicate EventID 2025/03/12 07:18:49 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.003_076wol"(1)|file|ITEM_TRASH|1800790225532|81dd3f2ff085524240d0ba09245f66e3b29f99f4] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248676366") 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.013_076wol"(0)|file|ITEM_UPLOAD|1800791831513|ed2dd7646e6d3e10c79841efdcec90ce83c11aa0] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.007_076wol"(1)|file|ITEM_TRASH|1800797386950|1e005b36b4480863d673e0ac8736cc6630d9e807] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.006_076wol"(1)|file|ITEM_TRASH|1800801193884|be6ac894fcd6bd40ab6520d8040a8556445139a7] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.005_076wol"(1)|file|ITEM_TRASH|1800800130432|a6310831034fa45a90dd7581d2959893313bd1c6] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': Received 7 events, resulting in 0 paths and 0 notifications 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248677402") 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.007_076wol"(1)|file|ITEM_TRASH|1800797386950|1e005b36b4480863d673e0ac8736cc6630d9e807] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.006_076wol"(1)|file|ITEM_TRASH|1800801193884|be6ac894fcd6bd40ab6520d8040a8556445139a7] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.005_076wol"(1)|file|ITEM_TRASH|1800800130432|a6310831034fa45a90dd7581d2959893313bd1c6] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.002_076wol"(1)|file|ITEM_TRASH|1800789693194|d87f11cc0f2650cb898a18f283da183697bb492b] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.016_076wol"(1)|file|ITEM_TRASH|1800797766351|e009488e44048acbb2d0eef7c404ec57ec34da06] ignored due to duplicate EventID 2025/03/12 07:18:50 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.010_076wol"(1)|file|ITEM_TRASH|1800790235251|9efa26c6eea5399322a01b59cadf49fac6e75647] ignored due to duplicate EventID 2025/03/12 07:18:51 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248677703") 2025/03/12 07:18:51 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.007_076wol"(1)|file|ITEM_TRASH|1800797386950|1e005b36b4480863d673e0ac8736cc6630d9e807] ignored due to duplicate EventID 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248678397") 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.006_076wol"(1)|file|ITEM_TRASH|1800801193884|be6ac894fcd6bd40ab6520d8040a8556445139a7] ignored due to duplicate EventID 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.005_076wol"(1)|file|ITEM_TRASH|1800800130432|a6310831034fa45a90dd7581d2959893313bd1c6] ignored due to duplicate EventID 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.002_076wol"(1)|file|ITEM_TRASH|1800789693194|d87f11cc0f2650cb898a18f283da183697bb492b] ignored due to duplicate EventID 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.016_076wol"(1)|file|ITEM_TRASH|1800797766351|e009488e44048acbb2d0eef7c404ec57ec34da06] ignored due to duplicate EventID 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.010_076wol"(1)|file|ITEM_TRASH|1800790235251|9efa26c6eea5399322a01b59cadf49fac6e75647] ignored due to duplicate EventID 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/12 07:18:52 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248679377") 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248679658") 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.002_076wol"(1)|file|ITEM_TRASH|1800789693194|d87f11cc0f2650cb898a18f283da183697bb492b] ignored due to duplicate EventID 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.016_076wol"(1)|file|ITEM_TRASH|1800797766351|e009488e44048acbb2d0eef7c404ec57ec34da06] ignored due to duplicate EventID 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.010_076wol"(1)|file|ITEM_TRASH|1800790235251|9efa26c6eea5399322a01b59cadf49fac6e75647] ignored due to duplicate EventID 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.009_076wol"(1)|file|ITEM_TRASH|1800797819230|4512bea340c87496fd8048b5b9bfe140a08eb47e] ignored due to duplicate EventID 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file.rclone_chunk.001_078joy"(0)|file|ITEM_UPLOAD|1800789822967|2e91a4472adee18b6d3e37e47f49816ce37569e2] ignored due to old SequenceID ('\x01') 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': Received 7 events, resulting in 0 paths and 0 notifications 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248680381") 2025/03/12 07:18:53 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.016_076wol"(1)|file|ITEM_TRASH|1800797766351|e009488e44048acbb2d0eef7c404ec57ec34da06] ignored due to duplicate EventID 2025/03/12 07:18:54 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248680699") 2025/03/12 07:18:55 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248681392") 2025/03/12 07:18:55 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.010_076wol"(1)|file|ITEM_TRASH|1800790235251|9efa26c6eea5399322a01b59cadf49fac6e75647] ignored due to duplicate EventID 2025/03/12 07:18:55 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.009_076wol"(1)|file|ITEM_TRASH|1800797819230|4512bea340c87496fd8048b5b9bfe140a08eb47e] ignored due to duplicate EventID 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248682385") 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file.rclone_chunk.001_078joy"(0)|file|ITEM_UPLOAD|1800789822967|2e91a4472adee18b6d3e37e47f49816ce37569e2] ignored due to duplicate EventID 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.020_076wol"(1)|file|ITEM_TRASH|1800789316181|c97582f90da0db57f5dbf52dad796f625b68e2d5] ignored due to duplicate EventID 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.018_076wol"(1)|file|ITEM_TRASH|1800790506515|6492cee188ec8e64e28e36ce523265be98d0cd88] ignored due to duplicate EventID 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': ["subdir2"(0)|folder|ITEM_CREATE|311303149917|802743df988117f4b1f637a5d596aad1a82c17f5] ignored due to old SequenceID ('\x00') 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': Received 10 events, resulting in 0 paths and 0 notifications 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248683394") 2025/03/12 07:18:56 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file.rclone_chunk.001_078joy"(0)|file|ITEM_UPLOAD|1800789822967|2e91a4472adee18b6d3e37e47f49816ce37569e2] ignored due to duplicate EventID 2025/03/12 07:18:57 INFO : dir/file4.rclone_chunk.001_0792x1: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248683705") 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.020_076wol"(1)|file|ITEM_TRASH|1800789316181|c97582f90da0db57f5dbf52dad796f625b68e2d5] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.018_076wol"(1)|file|ITEM_TRASH|1800790506515|6492cee188ec8e64e28e36ce523265be98d0cd88] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.015_076wol"(1)|file|ITEM_TRASH|1800792116892|f63a5f6584dea9f7724b0cea9441a42a7d4374e1] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.008_076wol"(1)|file|ITEM_TRASH|1800797427750|1463f25bd065a51b601cc91973638e7d3d9b68cc] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["subdir2"(0)|folder|ITEM_CREATE|311303149917|802743df988117f4b1f637a5d596aad1a82c17f5] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.013_076wol"(1)|file|ITEM_TRASH|1800791831513|dfb5ce51587846f8f65d48a9039fb5e545c5bc3b] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.011_076wol"(1)|file|ITEM_TRASH|1800790787701|bfcd35492982cf5dbe957acf4b137ef014bea2b7] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.014_076wol"(1)|file|ITEM_TRASH|1800790314451|df3535a7ddc060f8eafd9bedfd4eb8326eb49593] ignored due to duplicate EventID 2025/03/12 07:18:57 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.017_076wol"(1)|file|ITEM_TRASH|1800792467709|87b3501505bd9f72f6238686f48e8d992a33fddc] ignored due to duplicate EventID 2025/03/12 07:18:57 INFO : dir/file4.rclone_chunk.002_0792x1: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/03/12 07:18:58 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248684372") 2025/03/12 07:18:58 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.015_076wol"(1)|file|ITEM_TRASH|1800792116892|f63a5f6584dea9f7724b0cea9441a42a7d4374e1] ignored due to duplicate EventID 2025/03/12 07:18:58 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.008_076wol"(1)|file|ITEM_TRASH|1800797427750|1463f25bd065a51b601cc91973638e7d3d9b68cc] ignored due to duplicate EventID 2025/03/12 07:18:58 DEBUG : box root 'rclone-test-sacubol4tose': ["subdir2"(0)|folder|ITEM_CREATE|311303149917|802743df988117f4b1f637a5d596aad1a82c17f5] ignored due to duplicate EventID 2025/03/12 07:18:58 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.013_076wol"(1)|file|ITEM_TRASH|1800791831513|dfb5ce51587846f8f65d48a9039fb5e545c5bc3b] ignored due to duplicate EventID 2025/03/12 07:18:59 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248685442") 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248686364") 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.011_076wol"(1)|file|ITEM_TRASH|1800790787701|bfcd35492982cf5dbe957acf4b137ef014bea2b7] ignored due to duplicate EventID 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.014_076wol"(1)|file|ITEM_TRASH|1800790314451|df3535a7ddc060f8eafd9bedfd4eb8326eb49593] ignored due to duplicate EventID 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.017_076wol"(1)|file|ITEM_TRASH|1800792467709|87b3501505bd9f72f6238686f48e8d992a33fddc] ignored due to duplicate EventID 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.001_0792x1"(0)|file|ITEM_UPLOAD|1800799310012|12ad7fd8e2ff6d46ce9e3f2d872bd0114439c4dd] added new path ("dir/file4.rclone_chunk.001_0792x1") for notify 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.002_078tp4"(0)|file|ITEM_UPLOAD|1800798038161|14f972ba29bdbcfc617eae4e7415a7e3d9205c0c] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:00 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_0792x1", 1) 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': Received 5 events, resulting in 1 paths and 1 notifications 2025/03/12 07:19:00 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248687362") 2025/03/12 07:19:01 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248687615") 2025/03/12 07:19:02 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248688369") 2025/03/12 07:19:02 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.001_0792x1"(0)|file|ITEM_UPLOAD|1800799310012|12ad7fd8e2ff6d46ce9e3f2d872bd0114439c4dd] ignored due to duplicate EventID 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248689402") 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.002_078tp4"(0)|file|ITEM_UPLOAD|1800798038161|14f972ba29bdbcfc617eae4e7415a7e3d9205c0c] ignored due to duplicate EventID 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': ["subdir1"(0)|folder|ITEM_CREATE|311306447162|85fbe4c908a9537d56083924b099e81b9b119214] ignored due to old SequenceID ('\x00') 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': ["file2"(0)|file|ITEM_UPLOAD|1800800267566|7930b820ef8ed9a7187d64b4cdbff746f16da677] ignored due to old SequenceID ('\x00') 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1800798038161|35661d5c7b761a882d16bb00fbac36e5e2889129] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file"(2)|file|ITEM_TRASH|1800789822967|9a093ce74e3dd00909e13e0f8715a0d2f1d0ebe2] added old path ("zero-length-file") for notify 2025/03/12 07:19:03 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': Received 5 events, resulting in 1 paths and 1 notifications 2025/03/12 07:19:03 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248690376") 2025/03/12 07:19:04 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248690661") 2025/03/12 07:19:05 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248691470") 2025/03/12 07:19:05 DEBUG : box root 'rclone-test-sacubol4tose': ["subdir1"(0)|folder|ITEM_CREATE|311306447162|85fbe4c908a9537d56083924b099e81b9b119214] ignored due to duplicate EventID 2025/03/12 07:19:05 INFO : dir/file3.rclone_chunk.001_079bti: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/03/12 07:19:06 INFO : dir/file3.rclone_chunk.002_079bti: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/03/12 07:19:06 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248692402") 2025/03/12 07:19:06 DEBUG : box root 'rclone-test-sacubol4tose': ["file2"(0)|file|ITEM_UPLOAD|1800800267566|7930b820ef8ed9a7187d64b4cdbff746f16da677] ignored due to duplicate EventID 2025/03/12 07:19:07 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248693367") 2025/03/12 07:19:07 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1800798038161|35661d5c7b761a882d16bb00fbac36e5e2889129] ignored due to duplicate EventID 2025/03/12 07:19:07 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file"(2)|file|ITEM_TRASH|1800789822967|9a093ce74e3dd00909e13e0f8715a0d2f1d0ebe2] ignored due to duplicate EventID 2025/03/12 07:19:08 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248694377") 2025/03/12 07:19:08 DEBUG : box root 'rclone-test-sacubol4tose': ["subdir3"(0)|folder|ITEM_CREATE|311306603680|4829a7468d194b93d0e3abcd59d96fb5e96fe3cc] ignored due to old SequenceID ('\x00') 2025/03/12 07:19:08 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1800800373375|7990dd05ea46814afbb173c98a931a54225c84d8] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:08 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file"(1)|file|ITEM_RENAME|1800789822967|c9d1ac4e9a8320d6d0e0cba1e550d8695ba9242f] added new path ("zero-length-file") for notify 2025/03/12 07:19:08 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.002_0792x1"(0)|file|ITEM_UPLOAD|1800800373375|7ae5bb4cb3951697d2474e20dea07e9981d76fea] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:08 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/12 07:19:08 DEBUG : box root 'rclone-test-sacubol4tose': Received 5 events, resulting in 1 paths and 1 notifications 2025/03/12 07:19:08 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248695372") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/12 07:19:09 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248695642") 2025/03/12 07:19:09 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1800800373375|7990dd05ea46814afbb173c98a931a54225c84d8] ignored due to duplicate EventID 2025/03/12 07:19:09 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file"(1)|file|ITEM_RENAME|1800789822967|c9d1ac4e9a8320d6d0e0cba1e550d8695ba9242f] ignored due to duplicate EventID 2025/03/12 07:19:09 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.002_0792x1"(0)|file|ITEM_UPLOAD|1800800373375|7ae5bb4cb3951697d2474e20dea07e9981d76fea] ignored due to duplicate EventID 2025/03/12 07:19:09 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.001_079bti"(0)|file|ITEM_UPLOAD|1800787960691|bdfbd97e347a4463a8a1c9435d635cf006f4bd08] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:09 DEBUG : box root 'rclone-test-sacubol4tose': Received 5 events, resulting in 0 paths and 0 notifications 2025/03/12 07:19:09 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248696383") 2025/03/12 07:19:10 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248696680") 2025/03/12 07:19:10 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1800800373375|7990dd05ea46814afbb173c98a931a54225c84d8] ignored due to duplicate EventID 2025/03/12 07:19:11 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248697389") 2025/03/12 07:19:11 DEBUG : box root 'rclone-test-sacubol4tose': ["zero-length-file"(1)|file|ITEM_RENAME|1800789822967|c9d1ac4e9a8320d6d0e0cba1e550d8695ba9242f] ignored due to duplicate EventID fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248698368") 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.002_0792x1"(0)|file|ITEM_UPLOAD|1800800373375|7ae5bb4cb3951697d2474e20dea07e9981d76fea] ignored due to duplicate EventID 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.012_076wol"(1)|file|ITEM_TRASH|1800785437230|cb38527b6bc6782417aa24f30229d4783d82bbca] ignored due to duplicate EventID 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.001_079bti"(0)|file|ITEM_UPLOAD|1800787960691|bdfbd97e347a4463a8a1c9435d635cf006f4bd08] ignored due to duplicate EventID 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.001_078tp4"(0)|file|ITEM_UPLOAD|1800801256007|0d2657bdaeb77188d68e8d1a7050ca1963545411] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1800801256007|a7b2f0dc08ea47a31cc9598d63446188d39dd3b6] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1800799310012|298e62170cac8e5e77fd319ed8d37b479d56f9b7] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1800788697248|89fb2c78eed46ae7851c80bae8117f0129744db3] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': Received 7 events, resulting in 0 paths and 0 notifications 2025/03/12 07:19:12 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248699405") 2025/03/12 07:19:13 DEBUG : box root 'rclone-test-sacubol4tose': ["z.txt.rclone_chunk.012_076wol"(1)|file|ITEM_TRASH|1800785437230|cb38527b6bc6782417aa24f30229d4783d82bbca] ignored due to duplicate EventID 2025/03/12 07:19:13 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248699802") 2025/03/12 07:19:13 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.001_079bti"(0)|file|ITEM_UPLOAD|1800787960691|bdfbd97e347a4463a8a1c9435d635cf006f4bd08] ignored due to duplicate EventID 2025/03/12 07:19:14 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248700373") 2025/03/12 07:19:14 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.001_078tp4"(0)|file|ITEM_UPLOAD|1800801256007|0d2657bdaeb77188d68e8d1a7050ca1963545411] ignored due to duplicate EventID 2025/03/12 07:19:14 DEBUG : box root 'rclone-test-sacubol4tose': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1800801256007|a7b2f0dc08ea47a31cc9598d63446188d39dd3b6] ignored due to duplicate EventID 2025/03/12 07:19:14 DEBUG : box root 'rclone-test-sacubol4tose': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1800799310012|298e62170cac8e5e77fd319ed8d37b479d56f9b7] ignored due to duplicate EventID fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/12 07:19:15 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248701366") 2025/03/12 07:19:16 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248702388") 2025/03/12 07:19:16 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1800788697248|89fb2c78eed46ae7851c80bae8117f0129744db3] ignored due to duplicate EventID 2025/03/12 07:19:17 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248703368") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248704400") 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': ["dir"(0)|folder|ITEM_CREATE|311304260604|bbef13552101cf03ca6058fad79c65822e2242f8] added new path ("dir") for notify 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': ["file4"(0)|file|ITEM_UPLOAD|1800796299619|a533a7ba4cb985218c0107f125272ff38e3b27de] ignored due to old SequenceID ('\x00') 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': ["file3"(0)|file|ITEM_UPLOAD|1800787883741|c52fa11b5c0baa5286a90750d9e19e86c200a8b7] ignored due to old SequenceID ('\x00') 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.002_079bti"(0)|file|ITEM_UPLOAD|1800788697248|912181f9270d0a2a211a79d312db89707c941487] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:18 DEBUG : doChangeNotify("dir", 0) 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': Received 4 events, resulting in 1 paths and 1 notifications 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248705379") 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': ["file3"(0)|file|ITEM_UPLOAD|1800787883741|c52fa11b5c0baa5286a90750d9e19e86c200a8b7] ignored due to duplicate EventID 2025/03/12 07:19:18 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.002_079bti"(0)|file|ITEM_UPLOAD|1800788697248|912181f9270d0a2a211a79d312db89707c941487] ignored due to duplicate EventID 2025/03/12 07:19:19 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248705645") 2025/03/12 07:19:19 DEBUG : box root 'rclone-test-sacubol4tose': ["file3"(0)|file|ITEM_UPLOAD|1800787883741|c52fa11b5c0baa5286a90750d9e19e86c200a8b7] ignored due to duplicate EventID 2025/03/12 07:19:20 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248706378") 2025/03/12 07:19:20 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.002_079bti"(0)|file|ITEM_UPLOAD|1800788697248|912181f9270d0a2a211a79d312db89707c941487] ignored due to duplicate EventID fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/12 07:19:21 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248707379") 2025/03/12 07:19:22 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248708360") 2025/03/12 07:19:23 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248709366") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/12 07:19:24 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248710357") 2025/03/12 07:19:25 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248711361") 2025/03/12 07:19:26 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248712357") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/03/12 07:19:27 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248713358") 2025/03/12 07:19:28 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248714357") 2025/03/12 07:19:29 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248715356") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/03/12 07:19:30 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248716358") 2025/03/12 07:19:31 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248717357") 2025/03/12 07:19:32 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248718357") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/03/12 07:19:33 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248719353") 2025/03/12 07:19:34 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248720367") 2025/03/12 07:19:35 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248721354") fstests.go:935: map[dir:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[dir/file4.rclone_chunk.001_0792x1:{} zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/03/12 07:19:36 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248722357") 2025/03/12 07:19:37 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248723377") 2025/03/12 07:19:38 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248724384") 2025/03/12 07:19:39 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248725359") 2025/03/12 07:19:40 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248726353") 2025/03/12 07:19:41 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248727355") 2025/03/12 07:19:42 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248728355") 2025/03/12 07:19:43 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248729370") 2025/03/12 07:19:44 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248730376") 2025/03/12 07:19:45 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248731390") 2025/03/12 07:19:46 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248732391") 2025/03/12 07:19:47 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248733403") 2025/03/12 07:19:48 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248734387") 2025/03/12 07:19:49 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248735383") 2025/03/12 07:19:50 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248736376") 2025/03/12 07:19:50 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1800787960691|4a3147e67cd7944039d64da4fee5c15a696dcafa] ignored due to old SequenceID ('\x01') 2025/03/12 07:19:50 DEBUG : box root 'rclone-test-sacubol4tose': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/12 07:19:50 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248737371") 2025/03/12 07:19:51 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248737610") 2025/03/12 07:19:52 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248738405") 2025/03/12 07:19:52 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1800787960691|4a3147e67cd7944039d64da4fee5c15a696dcafa] ignored due to duplicate EventID 2025/03/12 07:19:53 DEBUG : box root 'rclone-test-sacubol4tose': Checking for changes on remote (next_stream_position: "30401039248739387") 2025/03/12 07:19:53 DEBUG : box root 'rclone-test-sacubol4tose': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1800787960691|4a3147e67cd7944039d64da4fee5c15a696dcafa] ignored due to duplicate EventID === RUN TestIntegration/FsMkdir/FsPutFiles 2025/03/12 07:19:58 INFO : file name.txt.rclone_chunk.001_07atx8: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/12 07:19:59 INFO : file name.txt.rclone_chunk.002_07atx8: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/12 07:20:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_07b1je: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/12 07:20:08 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_07b1je: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/12 07:20:19 INFO : file name.txt.rclone_chunk.001_07bbr6: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/12 07:20:20 INFO : file name.txt.rclone_chunk.002_07bbr6: 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/12 07:20:28 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/12 07:20:28 DEBUG : Creating backend with remote "TestBox:" 2025/03/12 07:20:28 DEBUG : Reset feature "ListR" 2025/03/12 07:20:28 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/12 07:20:44 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_07c1z1: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/03/12 07:20:44 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_07c1z1: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/03/12 07:21:02 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_07chc7: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/03/12 07:21:02 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_07chc7: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/03/12 07:21:07 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose/dirToPurgeFromRoot" 2025/03/12 07:21:07 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/dirToPurgeFromRoot" 2025/03/12 07:21:08 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/12 07:21:12 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose/hello? sausage/êé" 2025/03/12 07:21:12 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/hello? sausage/êé" 2025/03/12 07:21:14 DEBUG : Reset feature "ListR" 2025/03/12 07:21:23 INFO : a/b/c/d/e.txt.rclone_chunk.001_07d2k7: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/03/12 07:21:24 INFO : a/b/c/d/e.txt.rclone_chunk.002_07d2k7: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/03/12 07:21:32 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/12 07:21:44 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/03/12 07:21:45 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/03/12 07:21:46 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/03/12 07:21:47 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/03/12 07:21:53 DEBUG : file name.txt: move 2 data chunks... 2025/03/12 07:21:55 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/03/12 07:21:57 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/03/12 07:21:58 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/03/12 07:22:03 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/03/12 07:22:04 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/12 07:22:06 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/12 07:22:07 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/03/12 07:22:12 DEBUG : other.txt: move 2 data chunks... 2025/03/12 07:22:13 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/12 07:22:14 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/12 07:22:15 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/12 07:22:20 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-xifotem8juqe" 2025/03/12 07:22:20 DEBUG : Creating backend with remote "TestBox:rclone-test-xifotem8juqe" 2025/03/12 07:22:21 DEBUG : box root 'rclone-test-xifotem8juqe': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/12 07:22:21 DEBUG : Reset feature "ListR" 2025/03/12 07:22:22 DEBUG : box root 'rclone-test-xifotem8juqe': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/12 07:22:28 DEBUG : box root 'rclone-test-sacubol4tose': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/12 07:22:31 DEBUG : box root 'rclone-test-sacubol4tose': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/12 07:22:37 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-xifotem8juqe': 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/12 07:23:20 INFO : file name.txt.rclone_chunk.001_07g8gc: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/12 07:23:20 INFO : file name.txt.rclone_chunk.002_07g8gc: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/12 07:23:21 INFO : file name.txt.rclone_chunk.003_07g8gc: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/03/12 07:23:21 INFO : file name.txt.rclone_chunk.004_07g8gc: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/03/12 07:23:30 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/12 07:23:30 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/12 07:23:35 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-sacubol4tose/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-sacubol4tose/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2025/03/12 07:23:35 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/12 07:23:35 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose/not found.txt" 2025/03/12 07:23:35 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/not found.txt" 2025/03/12 07:23:37 DEBUG : Reset feature "ListR" 2025/03/12 07:23:37 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-sacubol4tose" from "TestChunkerChunk50bBox:rclone-test-sacubol4tose" 2025/03/12 07:23:37 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/12 07:23:37 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/12 07:23:44 INFO : rclone-test-sacubol4tose/created from root.txt.rclone_chunk.001_07h3ct: Moved (server-side) to: rclone-test-sacubol4tose/created from root.txt.rclone_chunk.001 2025/03/12 07:23:45 INFO : rclone-test-sacubol4tose/created from root.txt.rclone_chunk.002_07h3ct: Moved (server-side) to: rclone-test-sacubol4tose/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/12 07:24:10 INFO : piped data.txt.rclone_chunk.001_07huxe: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/03/12 07:24:20 INFO : piped data.txt.rclone_chunk.001_07i0hs: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/03/12 07:24:20 INFO : piped data.txt.rclone_chunk.002_07i0hs: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/03/12 07:24:21 INFO : piped data.txt.rclone_chunk.003_07i0hs: 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/12 07:24:28 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-sacubol4tose': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/03/12 07:24:32 INFO : small/emptyfile.rclone_chunk.001_07ifks: Moved (server-side) to: small/emptyfile 2025/03/12 07:24:39 INFO : small/smallfile.rclone_chunk.001_07in4x: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/03/12 07:24:57 INFO : corrupted/billy.rclone_chunk.001_07iwtm: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/03/12 07:24:58 INFO : corrupted/billy.rclone_chunk.002_07iwtm: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/03/12 07:24:59 INFO : corrupted/billy.rclone_chunk.003_07iwtm: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/03/12 07:24:59 INFO : corrupted/billy.rclone_chunk.004_07iwtm: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/03/12 07:25:01 INFO : corrupted/billy.rclone_chunk.005_07iwtm: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/03/12 07:25:14 INFO : corrupted/silly1.rclone_chunk.001_07jfze: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/03/12 07:25:15 INFO : corrupted/silly1.rclone_chunk.002_07jfze: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/03/12 07:25:16 INFO : corrupted/silly1.rclone_chunk.003_07jfze: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/03/12 07:25:16 INFO : corrupted/silly1.rclone_chunk.004_07jfze: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/03/12 07:25:17 INFO : corrupted/silly1.rclone_chunk.005_07jfze: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/03/12 07:25:30 INFO : corrupted/silly2.rclone_chunk.001_07jwaa: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/03/12 07:25:30 INFO : corrupted/silly2.rclone_chunk.002_07jwaa: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/03/12 07:25:31 INFO : corrupted/silly2.rclone_chunk.003_07jwaa: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/03/12 07:25:31 INFO : corrupted/silly2.rclone_chunk.004_07jwaa: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/03/12 07:25:32 INFO : corrupted/silly2.rclone_chunk.005_07jwaa: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/03/12 07:25:48 INFO : corrupted/silly3.rclone_chunk.001_07kd3t: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/03/12 07:25:49 INFO : corrupted/silly3.rclone_chunk.002_07kd3t: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/03/12 07:25:49 INFO : corrupted/silly3.rclone_chunk.003_07kd3t: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/03/12 07:25:50 INFO : corrupted/silly3.rclone_chunk.004_07kd3t: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/03/12 07:25:51 INFO : corrupted/silly3.rclone_chunk.005_07kd3t: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/03/12 07:26:05 INFO : corrupted/willy.rclone_chunk.001_07kt3w: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/03/12 07:26:06 INFO : corrupted/willy.rclone_chunk.002_07kt3w: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/03/12 07:26:06 INFO : corrupted/willy.rclone_chunk.003_07kt3w: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/03/12 07:26:07 INFO : corrupted/willy.rclone_chunk.004_07kt3w: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/03/12 07:26:07 INFO : corrupted/willy.rclone_chunk.005_07kt3w: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/03/12 07:26:22 INFO : corrupted/silly4.rclone_chunk.001_07lb00: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/03/12 07:26:22 INFO : corrupted/silly4.rclone_chunk.002_07lb00: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/03/12 07:26:23 INFO : corrupted/silly4.rclone_chunk.003_07lb00: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/03/12 07:26:23 INFO : corrupted/silly4.rclone_chunk.004_07lb00: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/03/12 07:26:24 INFO : corrupted/silly4.rclone_chunk.005_07lb00: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/03/12 07:26:27 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/03/12 07:26:36 INFO : corrupted/silly5.rclone_chunk.001_07lqy6: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/03/12 07:26:36 INFO : corrupted/silly5.rclone_chunk.002_07lqy6: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/03/12 07:26:37 INFO : corrupted/silly5.rclone_chunk.003_07lqy6: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/03/12 07:26:37 INFO : corrupted/silly5.rclone_chunk.004_07lqy6: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/03/12 07:26:38 INFO : corrupted/silly5.rclone_chunk.005_07lqy6: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/03/12 07:26:41 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/12 07:27:01 INFO : wreaked/wreaker.rclone_chunk.001_07mi5l: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/03/12 07:27:01 INFO : wreaked/wreaker.rclone_chunk.002_07mi5l: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/03/12 07:27:07 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-sacubol4tose': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/03/12 07:27:22 ERROR : usermeta/today.rclone_chunk.001_07n6au: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1800807213205","file_version":{"type":"file_version","id":"1984781342005","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_07n6au"}}) 2025/03/12 07:27:24 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/03/12 07:27:24 INFO : usermeta/today.rclone_chunk.001_07n6au: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/03/12 07:27:35 ERROR : usermeta/past.rclone_chunk.001_07nkgd: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1800805034283","file_version":{"type":"file_version","id":"1984779035883","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_07nkgd"}}) 2025/03/12 07:27:36 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/03/12 07:27:37 INFO : usermeta/past.rclone_chunk.001_07nkgd: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/03/12 07:27:51 ERROR : usermeta/future.rclone_chunk.001_07nzlx: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1800803295886","file_version":{"type":"file_version","id":"1984777458286","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_07nzlx"}}) 2025/03/12 07:27:53 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/03/12 07:27:53 INFO : usermeta/future.rclone_chunk.001_07nzlx: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/03/12 07:28:16 DEBUG : future/test: Can't move - required hash not found 2025/03/12 07:28:16 DEBUG : future/test: Can't move, switching to copy 2025/03/12 07:28:17 DEBUG : future/test: Can't copy - required hash not found 2025/03/12 07:28:18 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/12 07:28:18 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/12 07:28:20 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-sacubol4tose': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/03/12 07:29:07 INFO : backcomp/renamefile.rclone_chunk.001_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/03/12 07:29:08 INFO : backcomp/renamefile.rclone_chunk.002_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/03/12 07:29:08 INFO : backcomp/renamefile.rclone_chunk.003_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/03/12 07:29:09 INFO : backcomp/renamefile.rclone_chunk.004_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/03/12 07:29:10 INFO : backcomp/renamefile.rclone_chunk.005_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/03/12 07:29:10 INFO : backcomp/renamefile.rclone_chunk.006_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/03/12 07:29:11 INFO : backcomp/renamefile.rclone_chunk.007_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/03/12 07:29:11 INFO : backcomp/renamefile.rclone_chunk.008_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/03/12 07:29:12 INFO : backcomp/renamefile.rclone_chunk.009_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/03/12 07:29:13 INFO : backcomp/renamefile.rclone_chunk.010_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/03/12 07:29:13 INFO : backcomp/renamefile.rclone_chunk.011_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/03/12 07:29:14 INFO : backcomp/renamefile.rclone_chunk.012_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/03/12 07:29:15 INFO : backcomp/renamefile.rclone_chunk.013_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/03/12 07:29:15 INFO : backcomp/renamefile.rclone_chunk.014_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/03/12 07:29:16 INFO : backcomp/renamefile.rclone_chunk.015_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/03/12 07:29:16 INFO : backcomp/renamefile.rclone_chunk.016_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/03/12 07:29:17 INFO : backcomp/renamefile.rclone_chunk.017_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/03/12 07:29:17 INFO : backcomp/renamefile.rclone_chunk.018_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/03/12 07:29:18 INFO : backcomp/renamefile.rclone_chunk.019_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/03/12 07:29:18 INFO : backcomp/renamefile.rclone_chunk.020_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/03/12 07:29:19 INFO : backcomp/renamefile.rclone_chunk.021_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/03/12 07:29:20 INFO : backcomp/renamefile.rclone_chunk.022_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/03/12 07:29:20 INFO : backcomp/renamefile.rclone_chunk.023_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/03/12 07:29:21 INFO : backcomp/renamefile.rclone_chunk.024_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/03/12 07:29:21 INFO : backcomp/renamefile.rclone_chunk.025_07ozty: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/03/12 07:29:54 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose/servermovetest/subdir1" 2025/03/12 07:29:54 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/servermovetest/subdir1" 2025/03/12 07:29:57 DEBUG : Reset feature "ListR" 2025/03/12 07:29:57 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose/servermovetest/subdir2" 2025/03/12 07:29:57 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/servermovetest/subdir2" 2025/03/12 07:29:59 DEBUG : Reset feature "ListR" 2025/03/12 07:30:06 INFO : movefile.rclone_chunk.001_07rmww: Moved (server-side) to: movefile.rclone_chunk.001 2025/03/12 07:30:07 INFO : movefile.rclone_chunk.002_07rmww: Moved (server-side) to: movefile.rclone_chunk.002 2025/03/12 07:30:12 DEBUG : movefile: move 2 data chunks... 2025/03/12 07:30:14 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/03/12 07:30:15 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/03/12 07:30:16 INFO : movefile: Moved (server-side) 2025/03/12 07:30:18 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/03/12 07:30:23 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-sacubol4tose/md5all" 2025/03/12 07:30:23 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/03/12 07:30:23 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/md5all" 2025/03/12 07:30:24 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/12 07:30:30 INFO : unknown-size-put.txt.rclone_chunk.001_07sb5y: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/03/12 07:30:31 INFO : unknown-size-put.txt.rclone_chunk.002_07sb5y: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/03/12 07:30:31 INFO : unknown-size-put.txt.rclone_chunk.003_07sb5y: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/03/12 07:30:41 INFO : unknown-size-update.txt.rclone_chunk.001_07sota: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/12 07:30:42 INFO : unknown-size-update.txt.rclone_chunk.002_07sota: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/12 07:31:02 INFO : unknown-size-update.txt.rclone_chunk.001_07szik: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/12 07:31:02 INFO : unknown-size-update.txt.rclone_chunk.002_07szik: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/12 07:31:03 INFO : unknown-size-update.txt.rclone_chunk.003_07szik: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/03/12 07:31:04 INFO : unknown-size-update.txt.rclone_chunk.004_07szik: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/03/12 07:31:04 INFO : unknown-size-update.txt.rclone_chunk.005_07szik: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/03/12 07:31:13 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sacubol4tose/deeper/nonexisting/directory" 2025/03/12 07:31:13 DEBUG : Creating backend with remote "TestBox:rclone-test-sacubol4tose/deeper/nonexisting/directory" 2025/03/12 07:31:15 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/12 07:31:21 DEBUG : box root 'rclone-test-sacubol4tose': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/12 07:31:21 ERROR : : error listing: directory not found 2025/03/12 07:31:21 DEBUG : box root 'rclone-test-sacubol4tose': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1124.86s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.48s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.87s) --- FAIL: TestIntegration/FsMkdir (1120.65s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (7.32s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.36s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.34s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.37s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (281.30s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (16.84s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (13.85s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (13.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (14.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (16.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (14.68s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (12.78s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (15.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (16.63s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (15.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (13.81s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (14.52s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (16.06s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (14.68s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (13.57s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (14.42s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (15.68s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (15.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (14.04s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.62s) --- PASS: TestIntegration/FsMkdir/FsPutError (59.35s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.08s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (75.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (630.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.77s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.49s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.74s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.72s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (15.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (18.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (17.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (11.82s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (38.73s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (17.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (1.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (1.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (1.44s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (1.33s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (1.57s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (1.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (4.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (1.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (5.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (21.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (19.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.39s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (17.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.94s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (1.14s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (8.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (20.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (15.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (356.45s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (16.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (130.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (21.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (46.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (21.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (90.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (28.38s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (1.61s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (48.90s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (12.53s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (36.37s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.39s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.26s) --- 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 1124.889s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 18m46.820143425s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]