"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestChunkerChunk50bBox:" 2025/06/29 03:34:40 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo" 2025/06/29 03:34:40 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/29 03:34:40 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo" 2025/06/29 03:34:40 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/06/29 03:34:41 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/06/29 03:34:41 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/06/29 03:34:44 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/06/29 03:34:45 INFO : dir/subdir: Making directory 2025/06/29 03:34:48 INFO : dir/subdir: Removing directory 2025/06/29 03:34:50 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/06/29 03:34:52 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/06/29 03:34:57 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_lrkrw8: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/06/29 03:34:58 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_lrkrw8: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/06/29 03:35:12 INFO : ．/．.rclone_chunk.001_lrl6jc: Moved (server-side) to: ．/．.rclone_chunk.001 2025/06/29 03:35:13 INFO : ．/．.rclone_chunk.002_lrl6jc: Moved (server-side) to: ．/．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/06/29 03:35:27 INFO : ．．/．．.rclone_chunk.001_lrll7y: Moved (server-side) to: ．．/．．.rclone_chunk.001 2025/06/29 03:35:27 INFO : ．．/．．.rclone_chunk.002_lrll7y: Moved (server-side) to: ．．/．．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/06/29 03:35:41 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_lrlz0w: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/06/29 03:35:41 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_lrlz0w: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/06/29 03:35:56 INFO : leading space/ leading space.rclone_chunk.001_lrmeqj: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/06/29 03:35:56 INFO : leading space/ leading space.rclone_chunk.002_lrmeqj: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/06/29 03:36:10 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_lrmsqm: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/06/29 03:36:11 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_lrmsqm: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/06/29 03:36:24 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_lrn66i: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/06/29 03:36:25 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_lrn66i: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/06/29 03:36:39 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_lrnkiq: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/06/29 03:36:39 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_lrnkiq: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/06/29 03:36:53 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_lrnzto: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/06/29 03:36:53 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_lrnzto: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/06/29 03:37:07 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_lrodss: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/06/29 03:37:08 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_lrodss: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/06/29 03:37:22 INFO : .leading dot/.leading dot.rclone_chunk.001_lroso4: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/06/29 03:37:22 INFO : .leading dot/.leading dot.rclone_chunk.002_lroso4: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/06/29 03:37:36 INFO : trailing space /trailing space .rclone_chunk.001_lrp66h: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/06/29 03:37:37 INFO : trailing space /trailing space .rclone_chunk.002_lrp66h: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/06/29 03:37:51 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_lrplfl: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/06/29 03:37:51 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_lrplfl: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/06/29 03:38:05 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_lrpz6j: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/06/29 03:38:05 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_lrpz6j: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/06/29 03:38:19 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_lrqdjo: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/06/29 03:38:19 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_lrqdjo: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/06/29 03:38:33 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_lrqr7x: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/06/29 03:38:34 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_lrqr7x: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/06/29 03:38:48 INFO : trailing dot./trailing dot..rclone_chunk.001_lrr6pk: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/06/29 03:38:48 INFO : trailing dot./trailing dot..rclone_chunk.002_lrr6pk: 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/06/29 03:39:02 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_lrrklm: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/06/29 03:39:02 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_lrrklm: 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/06/29 03:39:16 INFO : test%46.txt/test%46.txt.rclone_chunk.001_lrryxb: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/06/29 03:39:17 INFO : test%46.txt/test%46.txt.rclone_chunk.002_lrryxb: 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 2025/06/29 03:40:22 DEBUG : Config file has changed externally - reloading 2025/06/29 03:40:22 DEBUG : TestBox: Loaded invalid token from config file - ignoring 2025/06/29 03:40:23 DEBUG : Saving config "token" in section "TestBox" of the config file 2025/06/29 03:40:23 DEBUG : TestBox: Saved new token in config file === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/06/29 03:40:29 INFO : zero-length-file.rclone_chunk.001_lru0mb: 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/06/29 03:40:32 INFO : dir: Making directory 2025/06/29 03:40:33 INFO : dir/subdir1: Making directory 2025/06/29 03:40:34 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653179985") 2025/06/29 03:40:34 INFO : dir/subdir3: Making directory 2025/06/29 03:40:34 DEBUG : box root 'rclone-test-gitehak8xojo': ["zero-length-file.rclone_chunk.001_lru0mb"(0)|file|ITEM_UPLOAD|1908381956608|8c21fa81e2a0e386b74631d2f7a302be2cc35588] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:34 DEBUG : box root 'rclone-test-gitehak8xojo': ["file1.txt"(1)|file|ITEM_UPLOAD|1908381455091|5816fd3c42331a3e194617176a6a9ecaaf3d2d07] new parent not found 2025/06/29 03:40:34 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:34 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653181207") 2025/06/29 03:40:35 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653181440") 2025/06/29 03:40:35 INFO : dir/subdir2: Making directory 2025/06/29 03:40:36 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653182204") 2025/06/29 03:40:36 DEBUG : box root 'rclone-test-gitehak8xojo': ["zero-length-file"(1)|file|ITEM_RENAME|1908381956608|c2f7e07c72eac4c2bb01e035571af414972ef818] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:36 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:36 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653183205") 2025/06/29 03:40:36 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001_lru2ue"(0)|file|ITEM_UPLOAD|1908380324742|2ed955064b2505c4cb12759405166c4be31dc59c] new parent not found 2025/06/29 03:40:36 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:36 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653183430") 2025/06/29 03:40:37 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653183657") 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653184207") 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["zero-length-file"(2)|file|ITEM_TRASH|1908381956608|ad4f1dc5216c032faee990e6ac53038fa0814588] added old path ("zero-length-file") for notify 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.002_lru2ue"(0)|file|ITEM_UPLOAD|1908386850750|c6cbbb9cba8d936c90cd0e5bc8b0fe5f3e742336] new parent not found 2025/06/29 03:40:38 DEBUG : doChangeNotify("zero-length-file", 1) 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 1 paths and 1 notifications 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653185206") 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001"(1)|file|ITEM_RENAME|1908380324742|9fddb1855ba91c0c23604c645d66e605c4fbf743] new parent not found 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:38 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653185439") 2025/06/29 03:40:39 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653185664") 2025/06/29 03:40:39 DEBUG : box root 'rclone-test-gitehak8xojo': ["dir"(0)|folder|ITEM_CREATE|328430797382|2060ed79072e37e20bc73919a78b1037a17dd233] added new path ("dir") for notify 2025/06/29 03:40:39 DEBUG : doChangeNotify("dir", 0) 2025/06/29 03:40:39 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 1 paths and 1 notifications 2025/06/29 03:40:39 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653186211") 2025/06/29 03:40:40 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653186481") 2025/06/29 03:40:40 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.txt"(1)|file|ITEM_UPLOAD|1908385686959|e02c144d5e9c2ee01f966ba53a134f4afae3b4c7] new parent not found 2025/06/29 03:40:40 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.002"(1)|file|ITEM_RENAME|1908386850750|86128f5234eb8623e47ba18cd794ccde46ab9f9e] new parent not found 2025/06/29 03:40:40 DEBUG : box root 'rclone-test-gitehak8xojo': ["subdir1"(0)|folder|ITEM_CREATE|328429778393|5e45325a0cda5afd3e0ac1f9fc4e0114f35978e9] added new path ("dir/subdir1") for notify 2025/06/29 03:40:40 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/06/29 03:40:40 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 1 paths and 1 notifications 2025/06/29 03:40:40 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653187202") 2025/06/29 03:40:40 INFO : dir/file2.rclone_chunk.001_lrua8b: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/06/29 03:40:41 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653187434") 2025/06/29 03:40:41 INFO : dir/file2.rclone_chunk.002_lrua8b: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/06/29 03:40:41 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum"(0)|file|ITEM_UPLOAD|1908383641451|77592f9b628b25cd918aa1277302066ed1dc8526] new parent not found 2025/06/29 03:40:41 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:41 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653188204") 2025/06/29 03:40:41 DEBUG : box root 'rclone-test-gitehak8xojo': ["subdir3"(0)|folder|ITEM_CREATE|328429434241|59c36a76df06713b4f98a45ed738da3967519c24] added new path ("dir/subdir3") for notify 2025/06/29 03:40:41 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/06/29 03:40:41 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 1 paths and 1 notifications 2025/06/29 03:40:41 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653188427") 2025/06/29 03:40:42 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653188648") 2025/06/29 03:40:42 DEBUG : box root 'rclone-test-gitehak8xojo': ["subdir2"(0)|folder|ITEM_CREATE|328429797102|4fc010fd48f830efe090719de6d5dc633d90be9e] added new path ("dir/subdir2") for notify 2025/06/29 03:40:42 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/06/29 03:40:42 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 1 paths and 1 notifications 2025/06/29 03:40:42 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653189215") 2025/06/29 03:40:43 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653189455") 2025/06/29 03:40:43 DEBUG : box root 'rclone-test-gitehak8xojo': ["file20.txt"(0)|file|ITEM_RENAME|1908381589711|78b6ddffbba7105bdcad3f7172f9c3f2ad9264f7] new parent not found 2025/06/29 03:40:43 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:43 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653190207") 2025/06/29 03:40:44 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653190437") 2025/06/29 03:40:45 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653191205") 2025/06/29 03:40:45 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.rclone_chunk.001_lrua8b"(0)|file|ITEM_UPLOAD|1908387025358|972837bdcd162b34d592baec5d1156df056c01d9] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:45 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:45 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653192210") 2025/06/29 03:40:46 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653192431") 2025/06/29 03:40:46 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.rclone_chunk.002_lrua8b"(0)|file|ITEM_UPLOAD|1908380855853|ecdb993d93fc0ed34959bbabd3bff4792ff97193] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:46 DEBUG : box root 'rclone-test-gitehak8xojo': ["file21.txt"(0)|file|ITEM_RENAME|1908387052701|11ad74b04bda253717549754a25267caa58a38f1] new parent not found 2025/06/29 03:40:46 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:46 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653193211") 2025/06/29 03:40:47 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653193442") 2025/06/29 03:40:47 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1908387025358|cbdf09b6e8a6e8eabd9e486b960483e164909d83] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:47 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1908380855853|c1996c42512e1bede904665c0a0c7d41212df4a1] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:47 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001_lrudsc"(0)|file|ITEM_UPLOAD|1908384315601|e3c5f0f9007212217c7ce4c811af01c97bcd39b3] new parent not found 2025/06/29 03:40:47 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:47 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653194202") 2025/06/29 03:40:47 INFO : dir/file4.rclone_chunk.001_lruh6c: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/06/29 03:40:48 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653194437") 2025/06/29 03:40:48 INFO : dir/file4.rclone_chunk.002_lruh6c: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/06/29 03:40:49 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653195204") 2025/06/29 03:40:49 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2"(0)|file|ITEM_UPLOAD|1908387855797|66b5c37d6aa917ab9c9945bdcea824db5442832c] ignored due to old SequenceID ('\x00') 2025/06/29 03:40:49 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:49 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653196207") 2025/06/29 03:40:49 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.002_lrudsc"(0)|file|ITEM_UPLOAD|1908380552479|a2e5f7d14aa87066265d4f158e63c4cc0942c446] new parent not found 2025/06/29 03:40:49 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:49 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653196434") 2025/06/29 03:40:50 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653196662") 2025/06/29 03:40:51 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653197209") 2025/06/29 03:40:51 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4.rclone_chunk.001_lruh6c"(0)|file|ITEM_UPLOAD|1908386046317|98dad72f0252b9a81a899f52b9e1086bc249c7dc] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:51 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:51 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653198215") 2025/06/29 03:40:52 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653198444") 2025/06/29 03:40:53 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653199212") 2025/06/29 03:40:53 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4.rclone_chunk.002_lruh6c"(0)|file|ITEM_UPLOAD|1908381090398|30de3e9b0ee39060f8c00770e581f2e4e216dc57] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:53 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001"(1)|file|ITEM_RENAME|1908384315601|167df819620353ae41c808c781337659f35c1633] new parent not found 2025/06/29 03:40:53 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:53 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653200209") 2025/06/29 03:40:54 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653200444") 2025/06/29 03:40:54 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.002"(1)|file|ITEM_RENAME|1908380552479|4566d06f76edd8c292817eb2c580dc405a9a0c04] new parent not found 2025/06/29 03:40:54 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1908386046317|682628f38b2f1ba18bfe2f5a2ec462b9d8d800c1] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:54 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1908381090398|f7db80a80e8e694d237a81e8fa3f09101b74a3f4] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:54 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:54 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653201213") 2025/06/29 03:40:55 INFO : dir/file3.rclone_chunk.001_lrupok: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/06/29 03:40:55 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653201445") 2025/06/29 03:40:55 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum"(1)|file|ITEM_UPLOAD|1908383641451|fe3d747e71513d70ce4cf24dbb95686e4052c4b9] new parent not found 2025/06/29 03:40:55 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:55 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653202217") 2025/06/29 03:40:55 INFO : dir/file3.rclone_chunk.002_lrupok: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/06/29 03:40:56 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653202451") 2025/06/29 03:40:56 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4"(0)|file|ITEM_UPLOAD|1908385057321|5a05e844f6934cdad5add88496bb73d27826b12d] ignored due to old SequenceID ('\x00') 2025/06/29 03:40:56 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:56 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653203204") 2025/06/29 03:40:57 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653203432") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/06/29 03:40:58 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653204218") 2025/06/29 03:40:59 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653205207") 2025/06/29 03:40:59 DEBUG : box root 'rclone-test-gitehak8xojo': ["file3.rclone_chunk.001_lrupok"(0)|file|ITEM_UPLOAD|1908381491302|c60e7c4898a376abde7f13f2d7074e7055f82000] ignored due to old SequenceID ('\x01') 2025/06/29 03:40:59 DEBUG : box root 'rclone-test-gitehak8xojo': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1908385374564|71f9a898e67cc3a3a8c72bdd8a8d682a14ff2269] new parent not found 2025/06/29 03:40:59 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:40:59 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653206208") 2025/06/29 03:41:00 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653206439") 2025/06/29 03:41:00 DEBUG : box root 'rclone-test-gitehak8xojo': ["file3.rclone_chunk.002_lrupok"(0)|file|ITEM_UPLOAD|1908385299827|7d88c20a6146e90cf527f91c32f7c3a6f5c1f03c] ignored due to old SequenceID ('\x01') 2025/06/29 03:41:00 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:00 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653207203") 2025/06/29 03:41:00 DEBUG : box root 'rclone-test-gitehak8xojo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1908381491302|b2719f7b736eaedea3f93061e7eb7a2bcafb4fff] ignored due to old SequenceID ('\x01') 2025/06/29 03:41:00 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:00 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653207435") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/06/29 03:41:01 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653207657") 2025/06/29 03:41:02 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653208204") 2025/06/29 03:41:02 DEBUG : box root 'rclone-test-gitehak8xojo': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1908381770154|dd27b1ab5af8924a59ec5a9d7c5bd14e1a062cc5] new parent not found 2025/06/29 03:41:02 DEBUG : box root 'rclone-test-gitehak8xojo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1908385299827|6a15843b2787635328f504ab014e914e734104c7] ignored due to old SequenceID ('\x01') 2025/06/29 03:41:02 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:02 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653209204") 2025/06/29 03:41:03 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653209452") 2025/06/29 03:41:03 DEBUG : box root 'rclone-test-gitehak8xojo': ["file3"(0)|file|ITEM_UPLOAD|1908383442152|7db2acf5ced07c5ec526141087644acba3d8d094] ignored due to old SequenceID ('\x00') 2025/06/29 03:41:03 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:03 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653210207") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/06/29 03:41:04 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653210435") 2025/06/29 03:41:05 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653211207") 2025/06/29 03:41:06 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653212210") 2025/06/29 03:41:06 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.txt-rclone-copy-qadotog4"(0)|file|ITEM_COPY|1908386454304|99ad609e455f0328c900f9b89def10d931a83548] new parent not found 2025/06/29 03:41:06 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:06 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653213203") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/06/29 03:41:07 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653213435") 2025/06/29 03:41:07 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.txt"(1)|file|ITEM_RENAME|1908386454304|0f1b6f82a241fc75e780f26d846bed0e07e3dca8] new parent not found 2025/06/29 03:41:07 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:07 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653214209") 2025/06/29 03:41:08 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653214434") 2025/06/29 03:41:09 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653215207") 2025/06/29 03:41:09 DEBUG : box root 'rclone-test-gitehak8xojo': ["file1.txt-rclone-copy-zakoxuj6"(0)|file|ITEM_COPY|1908387126777|888dd03d13820ff6fd335c2ff4a98719512e1212] new parent not found 2025/06/29 03:41:09 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:09 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653216205") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/06/29 03:41:10 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653216434") 2025/06/29 03:41:10 DEBUG : box root 'rclone-test-gitehak8xojo': ["data"(0)|folder|ITEM_CREATE|328430203005|168d3f1be98d8de466bf84ae074759a63548eaa4] new parent not found 2025/06/29 03:41:10 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:10 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653217203") 2025/06/29 03:41:11 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653217425") 2025/06/29 03:41:11 DEBUG : box root 'rclone-test-gitehak8xojo': ["banana.rclone_chunk.001_lrv06z"(0)|file|ITEM_UPLOAD|1908383440002|0ab9d6e0f17679dedd80b9043d030bc5e924b764] new parent not found 2025/06/29 03:41:11 DEBUG : box root 'rclone-test-gitehak8xojo': ["file1.txt"(1)|file|ITEM_RENAME|1908387126777|bae3032ddad8fd936df6cebee13b1a64ecc6eddb] new parent not found 2025/06/29 03:41:11 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:11 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653218204") 2025/06/29 03:41:12 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653218434") 2025/06/29 03:41:12 DEBUG : box root 'rclone-test-gitehak8xojo': ["banana"(1)|file|ITEM_RENAME|1908383440002|ed329560b08df52010ab201bc33ede76a7683b6b] new parent not found 2025/06/29 03:41:12 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:12 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653219205") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/06/29 03:41:13 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653219434") 2025/06/29 03:41:14 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653220204") 2025/06/29 03:41:14 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001_lrv4cq"(0)|file|ITEM_UPLOAD|1908385098081|8fd60841fe55c9fe75d5e447c242d4f0a3ecaaca] new parent not found 2025/06/29 03:41:14 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:14 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653221208") 2025/06/29 03:41:15 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653221428") 2025/06/29 03:41:15 DEBUG : box root 'rclone-test-gitehak8xojo': ["file1.txt"(1)|file|ITEM_RENAME|1908381455091|da7dc67f5243b27f46c3bf6789ad14b1451c8eb9] new parent not found 2025/06/29 03:41:15 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum"(1)|file|ITEM_RENAME|1908385098081|c2dcaf84d6bbb755a78768dbf77c20bb35535e18] new parent not found 2025/06/29 03:41:15 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:15 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653222214") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/06/29 03:41:16 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653222446") 2025/06/29 03:41:17 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653223204") 2025/06/29 03:41:17 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.txt"(1)|file|ITEM_RENAME|1908385686959|9ed020d193ed288e3562e89c2c349fa59170dcd6] new parent not found 2025/06/29 03:41:17 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:17 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653224206") 2025/06/29 03:41:18 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653224434") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/06/29 03:41:19 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653225202") 2025/06/29 03:41:20 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653226203") 2025/06/29 03:41:21 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653227201") 2025/06/29 03:41:21 DEBUG : box root 'rclone-test-gitehak8xojo': ["file20.txt"(0)|file|ITEM_RENAME|1908381589711|41f960c69fea9b7bdb29d47e5a1857f72091d258] new parent not found 2025/06/29 03:41:21 DEBUG : box root 'rclone-test-gitehak8xojo': ["potato.rclone_chunk.001_lrvb9e"(0)|file|ITEM_UPLOAD|1908387198213|4d3245e7219164eb1029bb28f10380d199ffaee4] new parent not found 2025/06/29 03:41:21 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:21 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653228205") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/06/29 03:41:22 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653228430") 2025/06/29 03:41:22 DEBUG : box root 'rclone-test-gitehak8xojo': ["potato"(1)|file|ITEM_RENAME|1908387198213|3d6b9c71cc52fa574ebbac374e187adec48530c2] new parent not found 2025/06/29 03:41:22 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:22 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653229211") 2025/06/29 03:41:23 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653229428") 2025/06/29 03:41:24 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653230204") 2025/06/29 03:41:24 DEBUG : box root 'rclone-test-gitehak8xojo': ["file1.txt"(2)|file|ITEM_UPLOAD|1908387126777|772e57eb080c467dba4cd22791dce9745b7b5211] new parent not found 2025/06/29 03:41:24 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:24 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653231210") fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/06/29 03:41:25 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653231430") 2025/06/29 03:41:26 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653232203") 2025/06/29 03:41:26 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001_lrvfk5"(0)|file|ITEM_UPLOAD|1908387234163|94fb91a2522b4257cae36e936eee36a4fcf85f81] new parent not found 2025/06/29 03:41:26 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:26 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653233210") 2025/06/29 03:41:27 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653233432") 2025/06/29 03:41:28 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653234206") 2025/06/29 03:41:29 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653235205") 2025/06/29 03:41:29 DEBUG : box root 'rclone-test-gitehak8xojo': ["file21.txt"(0)|file|ITEM_RENAME|1908387052701|63473e09cb27f019f466538e2d49b4d9448d861f] new parent not found 2025/06/29 03:41:29 DEBUG : box root 'rclone-test-gitehak8xojo': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1908385309750|59a1e41fc0786ffda9c351adad655a96b57fcb12] new parent not found 2025/06/29 03:41:29 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum"(1)|file|ITEM_RENAME|1908387234163|443e3e980806b799bbf66a81d01a87404df5b9ad] new parent not found 2025/06/29 03:41:29 DEBUG : box root 'rclone-test-gitehak8xojo': Received 4 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:29 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653236201") 2025/06/29 03:41:30 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653236443") 2025/06/29 03:41:31 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653237206") 2025/06/29 03:41:32 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653238202") 2025/06/29 03:41:32 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:32 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653239213") 2025/06/29 03:41:32 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2"(1)|file|ITEM_TRASH|1908387855797|1bf7ac31eb35469845bf7f7918d2fdb64a47e652] added old path ("dir/file2") for notify 2025/06/29 03:41:32 DEBUG : doChangeNotify("dir/file2", 1) 2025/06/29 03:41:32 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 1 paths and 1 notifications 2025/06/29 03:41:32 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653239438") 2025/06/29 03:41:33 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653239667") 2025/06/29 03:41:33 DEBUG : box root 'rclone-test-gitehak8xojo': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1908380764496|441b045517891cd86009d23c6dff016493239cc6] new parent not found 2025/06/29 03:41:33 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:33 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653240204") 2025/06/29 03:41:33 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:33 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653240432") 2025/06/29 03:41:34 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653240654") 2025/06/29 03:41:34 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1908387025358|1e8fc9544946adc76d25383d5d7c4da32a516ee5] added old path ("dir/file2.rclone_chunk.001") for notify 2025/06/29 03:41:34 DEBUG : doChangeNotify("dir/file2", 1) 2025/06/29 03:41:34 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 1 paths and 1 notifications 2025/06/29 03:41:34 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653241214") 2025/06/29 03:41:35 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653241438") 2025/06/29 03:41:35 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001_lrvpzy"(0)|file|ITEM_UPLOAD|1908385444097|9aa0f77c2844e0a5b83ef15e6e9534472ada9904] new parent not found 2025/06/29 03:41:35 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:35 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653242216") 2025/06/29 03:41:36 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653242434") 2025/06/29 03:41:36 DEBUG : box root 'rclone-test-gitehak8xojo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1908380855853|0d1b141693c2c34337a075cd3fe5832e501e6303] added old path ("dir/file2.rclone_chunk.002") for notify 2025/06/29 03:41:36 DEBUG : box root 'rclone-test-gitehak8xojo': ["file1.txt-rclone-copy-dudulaz4"(0)|file|ITEM_COPY|1908383253137|2ece77bd6bfe98d0f74c96aafb32c7c4998bb7f7] new parent not found 2025/06/29 03:41:36 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.002_lrvpzy"(0)|file|ITEM_UPLOAD|1908380877163|2f3032a05d3ed583d06301ecb4aa165f41a92235] new parent not found 2025/06/29 03:41:36 DEBUG : doChangeNotify("dir/file2", 1) 2025/06/29 03:41:36 DEBUG : box root 'rclone-test-gitehak8xojo': Received 3 events, resulting in 1 paths and 1 notifications 2025/06/29 03:41:36 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653243211") 2025/06/29 03:41:37 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653243453") 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653244203") 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4"(1)|file|ITEM_TRASH|1908385057321|65263492a1c3640472f1880b1cf0489b43254098] added old path ("dir/file4") for notify 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.001"(1)|file|ITEM_RENAME|1908385444097|4a506e785ca776c981eeaaf1e67c936b14b8b552] new parent not found 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1908386046317|229e789db396eb5886471040ba944cab6493ccdf] added old path ("dir/file4.rclone_chunk.001") for notify 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["file1.txt"(1)|file|ITEM_RENAME|1908383253137|9bd39977c4a23e520391450e1b0dd8a8e19baed8] new parent not found 2025/06/29 03:41:38 DEBUG : doChangeNotify("dir/file4", 1) 2025/06/29 03:41:38 DEBUG : doChangeNotify("dir/file4", 1) 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': Received 5 events, resulting in 2 paths and 2 notifications 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653245204") 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1908386809860|de036c2cdcf495380fb557dbdd023eb2993b8d21] new parent not found 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum.rclone_chunk.002"(1)|file|ITEM_RENAME|1908380877163|e1713f535da67b29a4f0d4a68789641fd893ebc9] new parent not found 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:38 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653245444") 2025/06/29 03:41:39 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653245672") 2025/06/29 03:41:39 DEBUG : box root 'rclone-test-gitehak8xojo': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1908381090398|b4cd63d03608be399565b5da8fa3934e48000686] added old path ("dir/file4.rclone_chunk.002") for notify 2025/06/29 03:41:39 DEBUG : doChangeNotify("dir/file4", 1) 2025/06/29 03:41:39 DEBUG : box root 'rclone-test-gitehak8xojo': Received 1 events, resulting in 1 paths and 1 notifications 2025/06/29 03:41:39 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653246204") 2025/06/29 03:41:40 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653246424") 2025/06/29 03:41:40 DEBUG : box root 'rclone-test-gitehak8xojo': ["test.sum"(2)|file|ITEM_UPLOAD|1908387234163|368dc0a55588167e61620735be4ac3ed22645a8b] new parent not found 2025/06/29 03:41:40 DEBUG : box root 'rclone-test-gitehak8xojo': Received 2 events, resulting in 0 paths and 0 notifications 2025/06/29 03:41:40 DEBUG : box root 'rclone-test-gitehak8xojo': Checking for changes on remote (next_stream_position: "30401048653247202") === RUN TestIntegration/FsMkdir/FsPutFiles 2025/06/29 03:41:45 INFO : file name.txt.rclone_chunk.001_lrw3kw: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/06/29 03:41:45 INFO : file name.txt.rclone_chunk.002_lrw3kw: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/06/29 03:41:52 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_lrwaax: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/06/29 03:41:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_lrwaax: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/06/29 03:42:04 INFO : file name.txt.rclone_chunk.001_lrwj6y: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/06/29 03:42:04 INFO : file name.txt.rclone_chunk.002_lrwj6y: 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/06/29 03:42:11 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/06/29 03:42:11 DEBUG : Config file has changed externally - reloading 2025/06/29 03:42:11 DEBUG : Creating backend with remote "TestBox:" 2025/06/29 03:42:12 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/06/29 03:42:26 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_lrx7am: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/06/29 03:42:26 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_lrx7am: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/06/29 03:42:39 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_lrxkm1: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/06/29 03:42:39 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_lrxkm1: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/06/29 03:42:43 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo/dirToPurgeFromRoot" 2025/06/29 03:42:43 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/dirToPurgeFromRoot" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/06/29 03:42:48 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo/hello? sausage/êé" 2025/06/29 03:42:48 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/hello? sausage/êé" 2025/06/29 03:42:58 INFO : a/b/c/d/e.txt.rclone_chunk.001_lrxzcp: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/06/29 03:42:58 INFO : a/b/c/d/e.txt.rclone_chunk.002_lrxzcp: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/06/29 03:43:06 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/06/29 03:43:20 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/06/29 03:43:21 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/06/29 03:43:22 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/06/29 03:43:23 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/06/29 03:43:28 DEBUG : file name.txt: move 2 data chunks... 2025/06/29 03:43:30 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/06/29 03:43:31 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/06/29 03:43:32 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/06/29 03:43:37 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/06/29 03:43:38 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/06/29 03:43:39 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/06/29 03:43:41 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/06/29 03:43:45 DEBUG : other.txt: move 2 data chunks... 2025/06/29 03:43:47 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/06/29 03:43:48 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/06/29 03:43:49 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/06/29 03:43:53 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vexakic1rujo" 2025/06/29 03:43:53 DEBUG : Creating backend with remote "TestBox:rclone-test-vexakic1rujo" 2025/06/29 03:43:54 DEBUG : box root 'rclone-test-vexakic1rujo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/06/29 03:43:55 DEBUG : box root 'rclone-test-vexakic1rujo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/06/29 03:44:01 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/06/29 03:44:04 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/06/29 03:44:10 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-vexakic1rujo': 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/06/29 03:44:45 INFO : file name.txt.rclone_chunk.001_ls0yc3: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/06/29 03:44:46 INFO : file name.txt.rclone_chunk.002_ls0yc3: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/06/29 03:44:46 INFO : file name.txt.rclone_chunk.003_ls0yc3: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/06/29 03:44:47 INFO : file name.txt.rclone_chunk.004_ls0yc3: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/06/29 03:44:53 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/06/29 03:44:53 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/06/29 03:44:58 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-gitehak8xojo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-gitehak8xojo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/06/29 03:44:59 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo/not found.txt" 2025/06/29 03:44:59 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/not found.txt" 2025/06/29 03:45:01 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-gitehak8xojo" from "TestChunkerChunk50bBox:rclone-test-gitehak8xojo" 2025/06/29 03:45:01 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" === 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/06/29 03:45:08 INFO : rclone-test-gitehak8xojo/created from root.txt.rclone_chunk.001_ls1qfq: Moved (server-side) to: rclone-test-gitehak8xojo/created from root.txt.rclone_chunk.001 2025/06/29 03:45:08 INFO : rclone-test-gitehak8xojo/created from root.txt.rclone_chunk.002_ls1qfq: Moved (server-side) to: rclone-test-gitehak8xojo/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/06/29 03:45:32 INFO : piped data.txt.rclone_chunk.001_ls2fhs: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/06/29 03:45:40 INFO : piped data.txt.rclone_chunk.001_ls2k9w: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/06/29 03:45:40 INFO : piped data.txt.rclone_chunk.002_ls2k9w: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/06/29 03:45:41 INFO : piped data.txt.rclone_chunk.003_ls2k9w: 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/06/29 03:45:48 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-gitehak8xojo': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/06/29 03:45:52 INFO : small/emptyfile.rclone_chunk.001_ls2z9x: Moved (server-side) to: small/emptyfile 2025/06/29 03:45:59 INFO : small/smallfile.rclone_chunk.001_ls36ty: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/06/29 03:46:14 INFO : corrupted/billy.rclone_chunk.001_ls3ewn: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/06/29 03:46:14 INFO : corrupted/billy.rclone_chunk.002_ls3ewn: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/06/29 03:46:15 INFO : corrupted/billy.rclone_chunk.003_ls3ewn: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/06/29 03:46:15 INFO : corrupted/billy.rclone_chunk.004_ls3ewn: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/06/29 03:46:16 INFO : corrupted/billy.rclone_chunk.005_ls3ewn: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/06/29 03:46:27 INFO : corrupted/silly1.rclone_chunk.001_ls3tch: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/06/29 03:46:28 INFO : corrupted/silly1.rclone_chunk.002_ls3tch: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/06/29 03:46:28 INFO : corrupted/silly1.rclone_chunk.003_ls3tch: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/06/29 03:46:29 INFO : corrupted/silly1.rclone_chunk.004_ls3tch: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/06/29 03:46:29 INFO : corrupted/silly1.rclone_chunk.005_ls3tch: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/06/29 03:46:42 INFO : corrupted/silly2.rclone_chunk.001_ls4782: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/06/29 03:46:42 INFO : corrupted/silly2.rclone_chunk.002_ls4782: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/06/29 03:46:43 INFO : corrupted/silly2.rclone_chunk.003_ls4782: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/06/29 03:46:43 INFO : corrupted/silly2.rclone_chunk.004_ls4782: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/06/29 03:46:44 INFO : corrupted/silly2.rclone_chunk.005_ls4782: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/06/29 03:46:58 INFO : corrupted/silly3.rclone_chunk.001_ls4nh9: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/06/29 03:46:59 INFO : corrupted/silly3.rclone_chunk.002_ls4nh9: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/06/29 03:46:59 INFO : corrupted/silly3.rclone_chunk.003_ls4nh9: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/06/29 03:47:00 INFO : corrupted/silly3.rclone_chunk.004_ls4nh9: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/06/29 03:47:00 INFO : corrupted/silly3.rclone_chunk.005_ls4nh9: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/06/29 03:47:12 INFO : corrupted/willy.rclone_chunk.001_ls517m: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/06/29 03:47:13 INFO : corrupted/willy.rclone_chunk.002_ls517m: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/06/29 03:47:13 INFO : corrupted/willy.rclone_chunk.003_ls517m: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/06/29 03:47:14 INFO : corrupted/willy.rclone_chunk.004_ls517m: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/06/29 03:47:14 INFO : corrupted/willy.rclone_chunk.005_ls517m: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/06/29 03:47:26 INFO : corrupted/silly4.rclone_chunk.001_ls5gve: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/06/29 03:47:27 INFO : corrupted/silly4.rclone_chunk.002_ls5gve: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/06/29 03:47:27 INFO : corrupted/silly4.rclone_chunk.003_ls5gve: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/06/29 03:47:28 INFO : corrupted/silly4.rclone_chunk.004_ls5gve: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/06/29 03:47:28 INFO : corrupted/silly4.rclone_chunk.005_ls5gve: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/06/29 03:47:32 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/06/29 03:47:40 INFO : corrupted/silly5.rclone_chunk.001_ls5uo6: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/06/29 03:47:41 INFO : corrupted/silly5.rclone_chunk.002_ls5uo6: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/06/29 03:47:41 INFO : corrupted/silly5.rclone_chunk.003_ls5uo6: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/06/29 03:47:42 INFO : corrupted/silly5.rclone_chunk.004_ls5uo6: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/06/29 03:47:42 INFO : corrupted/silly5.rclone_chunk.005_ls5uo6: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/06/29 03:47:45 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2025/06/29 03:48:04 INFO : wreaked/wreaker.rclone_chunk.001_ls6ln0: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/06/29 03:48:05 INFO : wreaked/wreaker.rclone_chunk.002_ls6ln0: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/06/29 03:48:09 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-gitehak8xojo': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/06/29 03:48:24 ERROR : usermeta/today.rclone_chunk.001_ls77nt: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1908385771057","file_version":{"type":"file_version","id":"2105105992657","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_ls77nt"}}) 2025/06/29 03:48:25 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/06/29 03:48:26 INFO : usermeta/today.rclone_chunk.001_ls77nt: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/06/29 03:48:37 ERROR : usermeta/past.rclone_chunk.001_ls7lde: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1908389119151","file_version":{"type":"file_version","id":"2105109443951","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_ls7lde"}}) 2025/06/29 03:48:39 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/06/29 03:48:40 INFO : usermeta/past.rclone_chunk.001_ls7lde: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/06/29 03:48:50 ERROR : usermeta/future.rclone_chunk.001_ls7yul: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1908388054968","file_version":{"type":"file_version","id":"2105108166168","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_ls7yul"}}) 2025/06/29 03:48:52 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/06/29 03:48:53 INFO : usermeta/future.rclone_chunk.001_ls7yul: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/06/29 03:49:12 DEBUG : future/test: Can't move - required hash not found 2025/06/29 03:49:12 DEBUG : future/test: Can't move, switching to copy 2025/06/29 03:49:13 DEBUG : future/test: Can't copy - required hash not found 2025/06/29 03:49:13 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/06/29 03:49:13 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/06/29 03:49:15 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-gitehak8xojo': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/06/29 03:49:56 INFO : backcomp/renamefile.rclone_chunk.001_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/06/29 03:49:56 INFO : backcomp/renamefile.rclone_chunk.002_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/06/29 03:49:57 INFO : backcomp/renamefile.rclone_chunk.003_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/06/29 03:49:58 INFO : backcomp/renamefile.rclone_chunk.004_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/06/29 03:49:58 INFO : backcomp/renamefile.rclone_chunk.005_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/06/29 03:49:59 INFO : backcomp/renamefile.rclone_chunk.006_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/06/29 03:49:59 INFO : backcomp/renamefile.rclone_chunk.007_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/06/29 03:50:00 INFO : backcomp/renamefile.rclone_chunk.008_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/06/29 03:50:00 INFO : backcomp/renamefile.rclone_chunk.009_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/06/29 03:50:00 INFO : backcomp/renamefile.rclone_chunk.010_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/06/29 03:50:01 INFO : backcomp/renamefile.rclone_chunk.011_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/06/29 03:50:02 INFO : backcomp/renamefile.rclone_chunk.012_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/06/29 03:50:02 INFO : backcomp/renamefile.rclone_chunk.013_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/06/29 03:50:03 INFO : backcomp/renamefile.rclone_chunk.014_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/06/29 03:50:03 INFO : backcomp/renamefile.rclone_chunk.015_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/06/29 03:50:04 INFO : backcomp/renamefile.rclone_chunk.016_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/06/29 03:50:04 INFO : backcomp/renamefile.rclone_chunk.017_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/06/29 03:50:05 INFO : backcomp/renamefile.rclone_chunk.018_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/06/29 03:50:05 INFO : backcomp/renamefile.rclone_chunk.019_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/06/29 03:50:06 INFO : backcomp/renamefile.rclone_chunk.020_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/06/29 03:50:06 INFO : backcomp/renamefile.rclone_chunk.021_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/06/29 03:50:07 INFO : backcomp/renamefile.rclone_chunk.022_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/06/29 03:50:07 INFO : backcomp/renamefile.rclone_chunk.023_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/06/29 03:50:08 INFO : backcomp/renamefile.rclone_chunk.024_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/06/29 03:50:08 INFO : backcomp/renamefile.rclone_chunk.025_ls8th0: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/06/29 03:50:47 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo/servermovetest/subdir1" 2025/06/29 03:50:47 DEBUG : Config file has changed externally - reloading 2025/06/29 03:50:47 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/servermovetest/subdir1" 2025/06/29 03:50:49 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo/servermovetest/subdir2" 2025/06/29 03:50:49 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/servermovetest/subdir2" 2025/06/29 03:50:58 INFO : movefile.rclone_chunk.001_lsbdk1: Moved (server-side) to: movefile.rclone_chunk.001 2025/06/29 03:50:58 INFO : movefile.rclone_chunk.002_lsbdk1: Moved (server-side) to: movefile.rclone_chunk.002 2025/06/29 03:51:02 DEBUG : movefile: move 2 data chunks... 2025/06/29 03:51:04 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/06/29 03:51:06 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/06/29 03:51:07 INFO : movefile: Moved (server-side) 2025/06/29 03:51:08 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/06/29 03:51:13 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-gitehak8xojo/md5all" 2025/06/29 03:51:13 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/06/29 03:51:13 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/md5all" 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/06/29 03:51:21 INFO : unknown-size-put.txt.rclone_chunk.001_lsc1rj: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/06/29 03:51:22 INFO : unknown-size-put.txt.rclone_chunk.002_lsc1rj: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/06/29 03:51:22 INFO : unknown-size-put.txt.rclone_chunk.003_lsc1rj: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/06/29 03:51:34 INFO : unknown-size-update.txt.rclone_chunk.001_lscg23: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/06/29 03:51:34 INFO : unknown-size-update.txt.rclone_chunk.002_lscg23: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/06/29 03:51:50 INFO : unknown-size-update.txt.rclone_chunk.001_lscosu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/06/29 03:51:51 INFO : unknown-size-update.txt.rclone_chunk.002_lscosu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/06/29 03:51:52 INFO : unknown-size-update.txt.rclone_chunk.003_lscosu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/06/29 03:51:52 INFO : unknown-size-update.txt.rclone_chunk.004_lscosu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/06/29 03:51:53 INFO : unknown-size-update.txt.rclone_chunk.005_lscosu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/06/29 03:52:02 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gitehak8xojo/deeper/nonexisting/directory" 2025/06/29 03:52:02 DEBUG : Config file has changed externally - reloading 2025/06/29 03:52:02 DEBUG : Creating backend with remote "TestBox:rclone-test-gitehak8xojo/deeper/nonexisting/directory" === 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/06/29 03:52:10 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/06/29 03:52:10 ERROR : error listing: directory not found 2025/06/29 03:52:10 DEBUG : box root 'rclone-test-gitehak8xojo': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1050.85s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.46s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.99s) --- FAIL: TestIntegration/FsMkdir (1047.10s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.02s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.31s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.30s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.31s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (273.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (14.67s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (14.57s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (14.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (14.69s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (14.75s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (13.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (14.14s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (14.64s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (14.25s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (14.37s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (14.56s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (14.46s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (13.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (14.61s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (13.69s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (14.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (14.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (14.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (14.35s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.61s) --- PASS: TestIntegration/FsMkdir/FsPutError (59.67s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.26s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (69.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (574.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.63s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.50s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.65s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.64s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (13.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (14.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (17.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (13.26s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (35.35s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (17.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.89s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.90s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.87s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (18.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (17.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (2.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.36s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (14.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.93s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.89s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (8.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (20.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (14.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (326.67s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (15.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (114.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (18.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (42.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (18.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (89.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (25.50s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (2.12s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (46.99s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (14.30s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (32.68s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.90s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.34s) --- 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 1050.927s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished OK in 17m34.341576319s (try 1/5)