"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestChunkerChunk50bBox:" 2025/07/03 01:26:55 NOTICE: TestChunkerChunk50bBox: Starting server 2025/07/03 01:26:55 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu" 2025/07/03 01:26:55 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/03 01:26:55 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu" 2025/07/03 01:26:56 DEBUG : box root 'rclone-test-vetereb4podu': 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/07/03 01:26:57 DEBUG : box root 'rclone-test-vetereb4podu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/03 01:26:58 DEBUG : box root 'rclone-test-vetereb4podu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/07/03 01:27:01 DEBUG : box root 'rclone-test-vetereb4podu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/07/03 01:27:02 INFO : dir/subdir: Making directory 2025/07/03 01:27:06 INFO : dir/subdir: Removing directory 2025/07/03 01:27:08 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/07/03 01:27:11 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/07/03 01:27:17 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_t0bzvu: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/07/03 01:27:18 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_t0bzvu: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/07/03 01:27:34 INFO : ./..rclone_chunk.001_t0cg0f: Moved (server-side) to: ./..rclone_chunk.001 2025/07/03 01:27:35 INFO : ./..rclone_chunk.002_t0cg0f: Moved (server-side) to: ./..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/07/03 01:27:51 INFO : ../...rclone_chunk.001_t0cxze: Moved (server-side) to: ../...rclone_chunk.001 2025/07/03 01:27:52 INFO : ../...rclone_chunk.002_t0cxze: Moved (server-side) to: ../...rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/07/03 01:28:08 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001_t0ddeq: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/07/03 01:28:08 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002_t0ddeq: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/07/03 01:28:24 INFO : leading space/ leading space.rclone_chunk.001_t0dt2d: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/07/03 01:28:25 INFO : leading space/ leading space.rclone_chunk.002_t0dt2d: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/07/03 01:28:40 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_t0eaux: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/07/03 01:28:41 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_t0eaux: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/07/03 01:28:57 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_t0erg1: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/07/03 01:28:58 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_t0erg1: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/07/03 01:29:15 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_t0f80b: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/07/03 01:29:15 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_t0f80b: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 2025/07/03 01:29:17 DEBUG : TestBox: Loaded invalid token from config file - ignoring 2025/07/03 01:29:18 DEBUG : TestBox: got fatal oauth error: oauth2: "invalid_grant" "Refresh token has expired" fstest.go:537: Sleeping for 1s for findObject eventual consistency: 1/3 (pre-upload check: Options "https://api.box.com/2.0/files/content/": couldn't fetch token: invalid_grant: maybe token expired? - try refreshing with "rclone config reconnect TestBox:") 2025/07/03 01:29:19 DEBUG : Config file has changed externally - reloading 2025/07/03 01:29:19 DEBUG : TestBox: Loaded fresh token from config file 2025/07/03 01:29:19 DEBUG : TestBox: Loaded new refresh token from config file === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/07/03 01:29:33 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_t0frvc: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/07/03 01:29:34 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_t0frvc: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/07/03 01:29:50 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_t0g8bu: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/07/03 01:29:51 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_t0g8bu: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/07/03 01:30:07 INFO : .leading dot/.leading dot.rclone_chunk.001_t0gont: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/07/03 01:30:07 INFO : .leading dot/.leading dot.rclone_chunk.002_t0gont: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/07/03 01:30:24 INFO : trailing space /trailing space .rclone_chunk.001_t0h4o0: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/07/03 01:30:24 INFO : trailing space /trailing space .rclone_chunk.002_t0h4o0: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/07/03 01:30:40 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_t0hlb1: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/07/03 01:30:40 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_t0hlb1: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/07/03 01:30:56 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_t0i27q: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/07/03 01:30:57 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_t0i27q: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/07/03 01:31:13 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_t0iil6: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/07/03 01:31:13 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_t0iil6: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/07/03 01:31:29 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_t0iy3i: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/07/03 01:31:29 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_t0iy3i: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/07/03 01:31:46 INFO : trailing dot./trailing dot..rclone_chunk.001_t0jfj1: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/07/03 01:31:46 INFO : trailing dot./trailing dot..rclone_chunk.002_t0jfj1: 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/07/03 01:32:01 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_t0jv1v: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/07/03 01:32:02 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_t0jv1v: 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/07/03 01:32:18 INFO : test%46.txt/test%46.txt.rclone_chunk.001_t0kbdm: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/07/03 01:32:19 INFO : test%46.txt/test%46.txt.rclone_chunk.002_t0kbdm: 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/07/03 01:33:40 INFO : zero-length-file.rclone_chunk.001_t0mmit: 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/07/03 01:33:43 INFO : dir: Making directory 2025/07/03 01:33:44 INFO : dir/subdir1: Making directory 2025/07/03 01:33:45 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991171511") 2025/07/03 01:33:45 INFO : dir/subdir3: Making directory 2025/07/03 01:33:45 DEBUG : box root 'rclone-test-vetereb4podu': ["zero-length-file.rclone_chunk.001_t0mmit"(0)|file|ITEM_UPLOAD|1912629042486|d46afbd0ae7706eef01431eae7325d4cc7bb5780] ignored due to old SequenceID ('\x01') 2025/07/03 01:33:45 DEBUG : box root 'rclone-test-vetereb4podu': ["both0"(1)|file|ITEM_RENAME|1912633007023|d11c4d71f3cf3f127f35dde5a9e7adf3b639635a] new parent not found 2025/07/03 01:33:45 DEBUG : box root 'rclone-test-vetereb4podu': ["both0.rclone_chunk.001_t0mmi2"(0)|file|ITEM_UPLOAD|1912633007023|8515c9c2907a6af479ed5d3e3fbcb0773388c419] new parent not found 2025/07/03 01:33:45 DEBUG : box root 'rclone-test-vetereb4podu': Received 3 events, resulting in 0 paths and 0 notifications 2025/07/03 01:33:45 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991172738") 2025/07/03 01:33:46 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991172983") 2025/07/03 01:33:46 DEBUG : box root 'rclone-test-vetereb4podu': ["zero-length-file"(1)|file|ITEM_RENAME|1912629042486|6fe24fa6d5378bdba2cf01ce2a4959de895fc9fe] ignored due to old SequenceID ('\x01') 2025/07/03 01:33:46 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:33:46 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991173754") 2025/07/03 01:33:47 INFO : dir/subdir2: Making directory 2025/07/03 01:33:47 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991173984") 2025/07/03 01:33:48 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991174737") 2025/07/03 01:33:48 DEBUG : box root 'rclone-test-vetereb4podu': ["only0.rclone_chunk.001_t0mpdd"(0)|file|ITEM_UPLOAD|1912618559685|c9340c9dc2e4eadba33a122b41d7420a82888bd1] new parent not found 2025/07/03 01:33:48 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:33:48 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991175747") 2025/07/03 01:33:49 DEBUG : box root 'rclone-test-vetereb4podu': ["only0"(1)|file|ITEM_RENAME|1912618559685|1c3bb2489eb4e385b7e0720dc153b9698cdda0f5] new parent not found 2025/07/03 01:33:49 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:33:49 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991175980") 2025/07/03 01:33:49 DEBUG : box root 'rclone-test-vetereb4podu': ["zero-length-file"(2)|file|ITEM_TRASH|1912629042486|39333475836f51451146b38379f45bebaa189b1b] added old path ("zero-length-file") for notify 2025/07/03 01:33:49 DEBUG : doChangeNotify("zero-length-file", 1) 2025/07/03 01:33:49 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:33:49 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991176213") 2025/07/03 01:33:49 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991176446") 2025/07/03 01:33:50 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991176752") 2025/07/03 01:33:50 DEBUG : box root 'rclone-test-vetereb4podu': ["dir"(0)|folder|ITEM_CREATE|329109573540|c1318a003fc7adbd6c152d45606f39cb6b8179e6] added new path ("dir") for notify 2025/07/03 01:33:50 DEBUG : doChangeNotify("dir", 0) 2025/07/03 01:33:50 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:33:50 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991177757") 2025/07/03 01:33:51 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991178001") 2025/07/03 01:33:51 DEBUG : box root 'rclone-test-vetereb4podu': ["subdir1"(0)|folder|ITEM_CREATE|329108838990|c92a1a8db3faa7956a9ca7ece1e5a250df8eeb62] added new path ("dir/subdir1") for notify 2025/07/03 01:33:51 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/07/03 01:33:51 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:33:51 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991178737") 2025/07/03 01:33:52 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991178972") 2025/07/03 01:33:52 DEBUG : box root 'rclone-test-vetereb4podu': ["both1.rclone_chunk.001_t0mtoc"(0)|file|ITEM_UPLOAD|1912629774365|d634838cc40ae871399e0e4c5dc2d48b9a0b2a2a] new parent not found 2025/07/03 01:33:52 DEBUG : box root 'rclone-test-vetereb4podu': ["both1"(1)|file|ITEM_RENAME|1912629774365|b7316e0576c7dda5a0f578691e131f3ac04fd29f] new parent not found 2025/07/03 01:33:52 DEBUG : box root 'rclone-test-vetereb4podu': ["subdir3"(0)|folder|ITEM_CREATE|329108667756|ce81e4fe633e052168b100d5371965396480a53b] added new path ("dir/subdir3") for notify 2025/07/03 01:33:52 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/07/03 01:33:52 DEBUG : box root 'rclone-test-vetereb4podu': Received 3 events, resulting in 1 paths and 1 notifications 2025/07/03 01:33:52 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991179734") 2025/07/03 01:33:53 INFO : dir/file2.rclone_chunk.001_t0my97: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/07/03 01:33:53 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991179972") 2025/07/03 01:33:53 INFO : dir/file2.rclone_chunk.002_t0my97: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/07/03 01:33:54 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991180739") 2025/07/03 01:33:54 DEBUG : box root 'rclone-test-vetereb4podu': ["subdir2"(0)|folder|ITEM_CREATE|329107519031|fbb79cc886fb2ca4607cfb59c1d1a97ef7e0950c] added new path ("dir/subdir2") for notify 2025/07/03 01:33:54 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/07/03 01:33:54 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:33:54 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991181741") 2025/07/03 01:33:55 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991181979") 2025/07/03 01:33:55 DEBUG : box root 'rclone-test-vetereb4podu': ["only1.rclone_chunk.001_t0mxsy"(0)|file|ITEM_UPLOAD|1912632908531|2bbf716efe0e91d9f0564cab61a5007ca7834a40] new parent not found 2025/07/03 01:33:55 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:33:55 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991182739") 2025/07/03 01:33:56 DEBUG : box root 'rclone-test-vetereb4podu': ["file2.rclone_chunk.001_t0my97"(0)|file|ITEM_UPLOAD|1912629143112|21df7d1e69dd96b084497c3649d0f2323c2cf647] added new path ("dir/file2.rclone_chunk.001_t0my97") for notify 2025/07/03 01:33:56 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_t0my97", 1) 2025/07/03 01:33:56 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:33:56 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991182977") 2025/07/03 01:33:56 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991183215") 2025/07/03 01:33:57 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991183746") 2025/07/03 01:33:57 DEBUG : box root 'rclone-test-vetereb4podu': ["only1"(1)|file|ITEM_RENAME|1912632908531|e8aa437da539960464a4fba48afa57e1929fff51] new parent not found 2025/07/03 01:33:57 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:33:57 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991184751") 2025/07/03 01:33:58 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991184993") 2025/07/03 01:33:59 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991185740") 2025/07/03 01:33:59 DEBUG : box root 'rclone-test-vetereb4podu': ["file2.rclone_chunk.002_t0my97"(0)|file|ITEM_UPLOAD|1912634656097|3fc18b99f8271113b4ac619ce6aad7e9f5fcff1b] ignored due to old SequenceID ('\x01') 2025/07/03 01:33:59 DEBUG : box root 'rclone-test-vetereb4podu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1912634656097|56f8081bdf7034d190cc669cf037d0aa127cd695] ignored due to old SequenceID ('\x01') 2025/07/03 01:33:59 DEBUG : box root 'rclone-test-vetereb4podu': ["both2.rclone_chunk.001_t0n1re"(0)|file|ITEM_UPLOAD|1912615273993|01f518bac7392e5c741ad37bd15600b0e14c9d5f] new parent not found 2025/07/03 01:33:59 DEBUG : box root 'rclone-test-vetereb4podu': Received 3 events, resulting in 0 paths and 0 notifications 2025/07/03 01:33:59 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991186737") 2025/07/03 01:34:00 DEBUG : box root 'rclone-test-vetereb4podu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1912629143112|09e9cb7b95d44e5d5667238c12926bfa7b815c73] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:00 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:00 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991186996") 2025/07/03 01:34:00 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991187231") 2025/07/03 01:34:00 DEBUG : box root 'rclone-test-vetereb4podu': ["file2"(0)|file|ITEM_UPLOAD|1912626085283|3a9b522a0dd38f930c06112f234c834e6290d02c] ignored due to old SequenceID ('\x00') 2025/07/03 01:34:00 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:00 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991187745") 2025/07/03 01:34:01 INFO : dir/file4.rclone_chunk.001_t0n724: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/07/03 01:34:01 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991187977") 2025/07/03 01:34:02 INFO : dir/file4.rclone_chunk.002_t0n724: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/07/03 01:34:02 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991188751") 2025/07/03 01:34:02 DEBUG : box root 'rclone-test-vetereb4podu': ["both2"(1)|file|ITEM_RENAME|1912615273993|ee65122b7f5591baab84c8b16db1e5787b3a2025] new parent not found 2025/07/03 01:34:02 DEBUG : box root 'rclone-test-vetereb4podu': ["only2.rclone_chunk.001_t0n5e3"(0)|file|ITEM_UPLOAD|1912634648900|0c63b3f53f4bf4aefa6e776740f1941a18e6589a] new parent not found 2025/07/03 01:34:02 DEBUG : box root 'rclone-test-vetereb4podu': Received 2 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:02 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991189740") 2025/07/03 01:34:03 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991189978") 2025/07/03 01:34:04 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991190738") 2025/07/03 01:34:05 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991191746") 2025/07/03 01:34:05 DEBUG : box root 'rclone-test-vetereb4podu': ["only2"(1)|file|ITEM_RENAME|1912634648900|077a1116b643ea965e3b009dab94041bb3009f8f] new parent not found 2025/07/03 01:34:05 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:05 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991192742") 2025/07/03 01:34:06 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991192979") 2025/07/03 01:34:06 DEBUG : box root 'rclone-test-vetereb4podu': ["file4.rclone_chunk.002_t0n724"(0)|file|ITEM_UPLOAD|1912613200003|32c598bd39f3bd323097b3f0110df0cd9ad4c86b] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:06 DEBUG : box root 'rclone-test-vetereb4podu': ["file4.rclone_chunk.001_t0n724"(0)|file|ITEM_UPLOAD|1912623436628|4675c6c0ff7f839ec32dc843a925d96f9d27bbd6] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:06 DEBUG : box root 'rclone-test-vetereb4podu': ["both3.rclone_chunk.001_t0n8i7"(0)|file|ITEM_UPLOAD|1912634143096|47176aad7e6374fd5c65231a82bb0ff4435359ce] new parent not found 2025/07/03 01:34:06 DEBUG : box root 'rclone-test-vetereb4podu': Received 3 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:06 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991193743") 2025/07/03 01:34:07 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991193992") 2025/07/03 01:34:08 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991194748") 2025/07/03 01:34:08 DEBUG : box root 'rclone-test-vetereb4podu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1912613200003|84c345270a64a155c3935e7297c69b042564e0a9] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:08 DEBUG : box root 'rclone-test-vetereb4podu': ["both3"(1)|file|ITEM_RENAME|1912634143096|5ab124a223b3151773df6623904dd18833e0aaba] new parent not found 2025/07/03 01:34:08 DEBUG : box root 'rclone-test-vetereb4podu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1912623436628|e7ef3b483eb13bdbf9cda8ca1f7c6e08a72ff484] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:08 DEBUG : box root 'rclone-test-vetereb4podu': Received 3 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:08 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991195745") 2025/07/03 01:34:09 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991195994") 2025/07/03 01:34:09 DEBUG : box root 'rclone-test-vetereb4podu': ["only3.rclone_chunk.001_t0ncn4"(0)|file|ITEM_UPLOAD|1912637966225|3319c2c24bc83fa3e79f702a6761c5c0bb58464c] new parent not found 2025/07/03 01:34:09 DEBUG : box root 'rclone-test-vetereb4podu': ["file4"(0)|file|ITEM_UPLOAD|1912634407184|ab9a16b1e3c866455add01c53105cb6d80daf91f] ignored due to old SequenceID ('\x00') 2025/07/03 01:34:09 DEBUG : box root 'rclone-test-vetereb4podu': Received 2 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:09 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991196741") 2025/07/03 01:34:09 INFO : dir/file3.rclone_chunk.001_t0nffd: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/07/03 01:34:10 INFO : dir/file3.rclone_chunk.002_t0nffd: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/07/03 01:34:10 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991196983") 2025/07/03 01:34:11 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991197742") 2025/07/03 01:34:12 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991198736") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/07/03 01:34:13 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991199756") 2025/07/03 01:34:13 DEBUG : box root 'rclone-test-vetereb4podu': ["only3"(1)|file|ITEM_RENAME|1912637966225|f6609e5a1e073be0a4b6b2b569595c74c7c89739] new parent not found 2025/07/03 01:34:13 DEBUG : box root 'rclone-test-vetereb4podu': ["both4.rclone_chunk.001_t0nf66"(0)|file|ITEM_UPLOAD|1912625171603|1669ae8ca4dfc924c8bf7887cf008d4aca537674] new parent not found 2025/07/03 01:34:13 DEBUG : box root 'rclone-test-vetereb4podu': ["file3.rclone_chunk.001_t0nffd"(0)|file|ITEM_UPLOAD|1912629121238|524fe215f8ecbeed8f36165e10a1aa1cb1f6b2a1] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:13 DEBUG : box root 'rclone-test-vetereb4podu': Received 3 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:13 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991200737") 2025/07/03 01:34:14 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991200970") 2025/07/03 01:34:15 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991201760") 2025/07/03 01:34:15 DEBUG : box root 'rclone-test-vetereb4podu': ["both4"(1)|file|ITEM_RENAME|1912625171603|e9de87934bf6379d752213a1ce00d1a163dab2b0] new parent not found 2025/07/03 01:34:15 DEBUG : box root 'rclone-test-vetereb4podu': ["file3.rclone_chunk.002_t0nffd"(0)|file|ITEM_UPLOAD|1912630418193|c33ea1e8f289bc1e1c112b4867a43e1d19ee5456] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:15 DEBUG : box root 'rclone-test-vetereb4podu': Received 2 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:15 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991202742") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/07/03 01:34:16 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991202973") 2025/07/03 01:34:16 DEBUG : box root 'rclone-test-vetereb4podu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1912629121238|1f93db395750ab4892fb8800bd70b3c9f0142ef5] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:16 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:16 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991203750") 2025/07/03 01:34:17 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991203984") 2025/07/03 01:34:17 DEBUG : box root 'rclone-test-vetereb4podu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1912630418193|dc046776ec8247482140b6cb6145115ede84854c] ignored due to old SequenceID ('\x01') 2025/07/03 01:34:17 DEBUG : box root 'rclone-test-vetereb4podu': ["only4.rclone_chunk.001_t0njbs"(0)|file|ITEM_UPLOAD|1912630813772|34fd585113ed7e4d6aa7426d8fa5c3ae22e06fec] new parent not found 2025/07/03 01:34:17 DEBUG : box root 'rclone-test-vetereb4podu': Received 2 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:17 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991204738") 2025/07/03 01:34:18 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991204975") 2025/07/03 01:34:18 DEBUG : box root 'rclone-test-vetereb4podu': ["only4"(1)|file|ITEM_RENAME|1912630813772|bdf2b8bb8540078a137599e05384ab67a1f3d27f] new parent not found 2025/07/03 01:34:18 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:18 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991205742") 2025/07/03 01:34:19 DEBUG : box root 'rclone-test-vetereb4podu': ["file3"(0)|file|ITEM_UPLOAD|1912626287131|34b6bd4c385b75f530decbe9306b786e76b3f67c] ignored due to old SequenceID ('\x00') 2025/07/03 01:34:19 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:19 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991205996") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/07/03 01:34:19 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991206232") 2025/07/03 01:34:20 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991206742") 2025/07/03 01:34:21 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991207735") 2025/07/03 01:34:21 DEBUG : box root 'rclone-test-vetereb4podu': ["both5.rclone_chunk.001_t0nn2x"(0)|file|ITEM_UPLOAD|1912635013592|94db588957c040614e15a4996469e666d3588198] new parent not found 2025/07/03 01:34:21 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:21 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991208747") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/07/03 01:34:22 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991208992") 2025/07/03 01:34:23 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991209747") 2025/07/03 01:34:24 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991210741") 2025/07/03 01:34:24 DEBUG : box root 'rclone-test-vetereb4podu': ["both5"(1)|file|ITEM_RENAME|1912635013592|c52044d4d129a98d64924c36c339ac9c91cd4e3e] new parent not found 2025/07/03 01:34:24 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:24 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991211732") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/07/03 01:34:25 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991211968") 2025/07/03 01:34:25 DEBUG : box root 'rclone-test-vetereb4podu': ["only5.rclone_chunk.001_t0nrt1"(0)|file|ITEM_UPLOAD|1912613555836|245dc70d29c3bf1178394eca71e86555e998361a] new parent not found 2025/07/03 01:34:25 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:25 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991212748") 2025/07/03 01:34:26 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991212979") 2025/07/03 01:34:27 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991213737") 2025/07/03 01:34:27 DEBUG : box root 'rclone-test-vetereb4podu': ["only5"(1)|file|ITEM_RENAME|1912613555836|8a01e63a4a1bfeb383e4ddf14aa80fae702d0b76] new parent not found 2025/07/03 01:34:27 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:27 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991214736") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/07/03 01:34:28 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991214964") 2025/07/03 01:34:29 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991215751") 2025/07/03 01:34:30 DEBUG : box root 'rclone-test-vetereb4podu': ["both6.rclone_chunk.001_t0nvqh"(0)|file|ITEM_UPLOAD|1912633441229|0de735225dd6de024843781b6a623a649dbbbbf4] new parent not found 2025/07/03 01:34:30 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:30 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991216761") 2025/07/03 01:34:30 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991216991") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/07/03 01:34:31 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991217747") 2025/07/03 01:34:32 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991218743") 2025/07/03 01:34:33 DEBUG : box root 'rclone-test-vetereb4podu': ["both6"(1)|file|ITEM_RENAME|1912633441229|57273e0e2978e885052f66417bac8531353590f8] new parent not found 2025/07/03 01:34:33 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:33 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991219754") 2025/07/03 01:34:33 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991220000") 2025/07/03 01:34:33 DEBUG : box root 'rclone-test-vetereb4podu': ["only6.rclone_chunk.001_t0nygb"(0)|file|ITEM_UPLOAD|1912618962698|5c7a2738d6d22e75a65d9489712a502d175dabbd] new parent not found 2025/07/03 01:34:33 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:33 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991220735") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/07/03 01:34:34 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991220967") 2025/07/03 01:34:34 DEBUG : box root 'rclone-test-vetereb4podu': ["only6"(1)|file|ITEM_RENAME|1912618962698|42213152f7e81d9992ec0d71e129ac2b55acba3c] new parent not found 2025/07/03 01:34:34 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:34 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991221747") 2025/07/03 01:34:35 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991221972") 2025/07/03 01:34:36 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991222740") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/07/03 01:34:37 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991223746") 2025/07/03 01:34:37 DEBUG : box root 'rclone-test-vetereb4podu': ["both7.rclone_chunk.001_t0o2ta"(0)|file|ITEM_UPLOAD|1912635014321|3c604d7ac0fd00db3408cd3b3ddb611e881f339f] new parent not found 2025/07/03 01:34:37 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:37 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991224741") 2025/07/03 01:34:38 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991224975") 2025/07/03 01:34:38 DEBUG : box root 'rclone-test-vetereb4podu': ["both7"(1)|file|ITEM_RENAME|1912635014321|d812cfd448739c010b828fb8722adeb666a1122d] new parent not found 2025/07/03 01:34:38 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:38 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991225743") 2025/07/03 01:34:39 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991225978") fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[dir/file2.rclone_chunk.001_t0my97:{} zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/07/03 01:34:40 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991226737") 2025/07/03 01:34:40 DEBUG : box root 'rclone-test-vetereb4podu': ["only7.rclone_chunk.001_t0o6um"(0)|file|ITEM_UPLOAD|1912615156174|38ae7ff69a68f618a9a6259d26b31f866eddc5ae] new parent not found 2025/07/03 01:34:40 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:40 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991227742") 2025/07/03 01:34:41 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991227986") 2025/07/03 01:34:41 DEBUG : box root 'rclone-test-vetereb4podu': ["only7"(1)|file|ITEM_RENAME|1912615156174|9938c87159c7ba39f024ebfdec8a3c96431803b1] new parent not found 2025/07/03 01:34:41 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:41 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991228739") 2025/07/03 01:34:42 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991228970") 2025/07/03 01:34:43 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991229761") 2025/07/03 01:34:44 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991230738") 2025/07/03 01:34:44 DEBUG : box root 'rclone-test-vetereb4podu': ["both8.rclone_chunk.001_t0o9rw"(0)|file|ITEM_UPLOAD|1912631769239|aa63951625f5aee491644b12d9f06cf3bf059265] new parent not found 2025/07/03 01:34:44 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:44 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991231737") 2025/07/03 01:34:45 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991231980") 2025/07/03 01:34:46 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991232734") 2025/07/03 01:34:46 DEBUG : box root 'rclone-test-vetereb4podu': ["both8"(1)|file|ITEM_RENAME|1912631769239|e92401ae2021a1a6e7a4a4e8ae1ee464b79bd003] new parent not found 2025/07/03 01:34:46 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:46 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991233743") 2025/07/03 01:34:47 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991233971") 2025/07/03 01:34:47 DEBUG : box root 'rclone-test-vetereb4podu': ["only8.rclone_chunk.001_t0odm6"(0)|file|ITEM_UPLOAD|1912628298518|70827687d6256ae39387bea93d0848e97ea03268] new parent not found 2025/07/03 01:34:47 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:47 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991234738") 2025/07/03 01:34:48 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991234972") 2025/07/03 01:34:49 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991235744") 2025/07/03 01:34:49 DEBUG : box root 'rclone-test-vetereb4podu': ["file2"(1)|file|ITEM_TRASH|1912626085283|8f2e35e2bef431650e4ef0fbdb36f30f265f9905] added old path ("dir/file2") for notify 2025/07/03 01:34:49 DEBUG : doChangeNotify("dir/file2", 1) 2025/07/03 01:34:49 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:34:49 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991236747") 2025/07/03 01:34:50 DEBUG : box root 'rclone-test-vetereb4podu': ["only8"(1)|file|ITEM_RENAME|1912628298518|b5549ed8c23fa5fe7baa6ee23d8cd157bbd8a6a1] new parent not found 2025/07/03 01:34:50 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:50 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991236990") 2025/07/03 01:34:50 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991237241") 2025/07/03 01:34:51 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991237742") 2025/07/03 01:34:51 DEBUG : box root 'rclone-test-vetereb4podu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1912629143112|99f311529f3fcc5a2a25dab6bae0e46dd677c0c3] added old path ("dir/file2.rclone_chunk.001") for notify 2025/07/03 01:34:51 DEBUG : box root 'rclone-test-vetereb4podu': ["both9.rclone_chunk.001_t0ohya"(0)|file|ITEM_UPLOAD|1912635404792|95823467abe382a88b82bf777e09b68bd8583e30] new parent not found 2025/07/03 01:34:51 DEBUG : doChangeNotify("dir/file2", 1) 2025/07/03 01:34:51 DEBUG : box root 'rclone-test-vetereb4podu': Received 2 events, resulting in 1 paths and 1 notifications 2025/07/03 01:34:51 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991238738") 2025/07/03 01:34:52 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991238981") 2025/07/03 01:34:52 DEBUG : box root 'rclone-test-vetereb4podu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1912634656097|cde7224d0c29520d165409e73bdc47f595afad02] added old path ("dir/file2.rclone_chunk.002") for notify 2025/07/03 01:34:52 DEBUG : doChangeNotify("dir/file2", 1) 2025/07/03 01:34:52 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:34:52 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991239735") 2025/07/03 01:34:53 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991239966") 2025/07/03 01:34:53 DEBUG : box root 'rclone-test-vetereb4podu': ["both9"(1)|file|ITEM_RENAME|1912635404792|c055ba65a54f401f2c7c7b070f653707356816e4] new parent not found 2025/07/03 01:34:53 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:53 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991240747") 2025/07/03 01:34:54 DEBUG : box root 'rclone-test-vetereb4podu': ["file4"(1)|file|ITEM_TRASH|1912634407184|78285aff4d2e552c39d22533adec2e0124cc7e60] added old path ("dir/file4") for notify 2025/07/03 01:34:54 DEBUG : doChangeNotify("dir/file4", 1) 2025/07/03 01:34:54 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:34:54 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991240980") 2025/07/03 01:34:54 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991241218") 2025/07/03 01:34:55 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991241740") 2025/07/03 01:34:55 DEBUG : box root 'rclone-test-vetereb4podu': ["only9.rclone_chunk.001_t0olqz"(0)|file|ITEM_UPLOAD|1912628058767|e76631475a64752bf9b8ecdddc743e1d9cba6e47] new parent not found 2025/07/03 01:34:55 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/03 01:34:55 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991242734") 2025/07/03 01:34:56 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991242975") 2025/07/03 01:34:57 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991243739") 2025/07/03 01:34:57 DEBUG : box root 'rclone-test-vetereb4podu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1912623436628|b2dd40b8c562a3580b55bb9d29daccd273a6245c] added old path ("dir/file4.rclone_chunk.001") for notify 2025/07/03 01:34:57 DEBUG : box root 'rclone-test-vetereb4podu': ["only9"(1)|file|ITEM_RENAME|1912628058767|06728df5badfb70babd794f0b322b1937a3add14] new parent not found 2025/07/03 01:34:57 DEBUG : doChangeNotify("dir/file4", 1) 2025/07/03 01:34:57 DEBUG : box root 'rclone-test-vetereb4podu': Received 2 events, resulting in 1 paths and 1 notifications 2025/07/03 01:34:57 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991244741") 2025/07/03 01:34:58 DEBUG : box root 'rclone-test-vetereb4podu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1912613200003|8fe97bc981845a8f7cce0a1d9bc37cf1ecaf50a4] added old path ("dir/file4.rclone_chunk.002") for notify 2025/07/03 01:34:58 DEBUG : doChangeNotify("dir/file4", 1) 2025/07/03 01:34:58 DEBUG : box root 'rclone-test-vetereb4podu': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/03 01:34:58 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991244982") 2025/07/03 01:34:58 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991245215") 2025/07/03 01:34:59 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991245736") 2025/07/03 01:34:59 DEBUG : box root 'rclone-test-vetereb4podu': ["file3"(1)|file|ITEM_TRASH|1912626287131|b74898ca3a637cabc3fc2f33ca1e3ef19aa0b75e] added old path ("dir/file3") for notify 2025/07/03 01:34:59 DEBUG : box root 'rclone-test-vetereb4podu': ["both10.rclone_chunk.001_t0opok"(0)|file|ITEM_UPLOAD|1912627376696|a27bfc37a8bcc54c0f59591440b8501975357671] new parent not found 2025/07/03 01:34:59 DEBUG : doChangeNotify("dir/file3", 1) 2025/07/03 01:34:59 DEBUG : box root 'rclone-test-vetereb4podu': Received 2 events, resulting in 1 paths and 1 notifications 2025/07/03 01:34:59 DEBUG : box root 'rclone-test-vetereb4podu': Checking for changes on remote (next_stream_position: "30401048991246747") === RUN TestIntegration/FsMkdir/FsPutFiles 2025/07/03 01:35:05 INFO : file name.txt.rclone_chunk.001_t0oylk: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/03 01:35:05 INFO : file name.txt.rclone_chunk.002_t0oylk: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/07/03 01:35:13 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_t0p6cj: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/07/03 01:35:14 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_t0p6cj: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/07/03 01:35:26 INFO : file name.txt.rclone_chunk.001_t0pg6m: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/03 01:35:27 INFO : file name.txt.rclone_chunk.002_t0pg6m: 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/07/03 01:35:35 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/07/03 01:35:35 DEBUG : Creating backend with remote "TestBox:" 2025/07/03 01:35:35 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/07/03 01:35:52 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_t0q8yn: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/07/03 01:35:52 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_t0q8yn: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/07/03 01:36:07 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_t0qnfy: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/07/03 01:36:08 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_t0qnfy: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/07/03 01:36:12 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu/dirToPurgeFromRoot" 2025/07/03 01:36:12 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/dirToPurgeFromRoot" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/07/03 01:36:19 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu/hello? sausage/êé" 2025/07/03 01:36:19 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/hello? sausage/êé" 2025/07/03 01:36:31 INFO : a/b/c/d/e.txt.rclone_chunk.001_t0r7ot: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/07/03 01:36:31 INFO : a/b/c/d/e.txt.rclone_chunk.002_t0r7ot: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/07/03 01:36:41 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/07/03 01:36:56 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/07/03 01:36:57 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/07/03 01:36:58 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/07/03 01:37:00 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/07/03 01:37:05 DEBUG : file name.txt: move 2 data chunks... 2025/07/03 01:37:07 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/07/03 01:37:09 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/07/03 01:37:10 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/07/03 01:37:15 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/07/03 01:37:16 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/03 01:37:18 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/07/03 01:37:19 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/07/03 01:37:25 DEBUG : other.txt: move 2 data chunks... 2025/07/03 01:37:26 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/07/03 01:37:28 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/07/03 01:37:29 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/07/03 01:37:33 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rivefah7zawi" 2025/07/03 01:37:33 DEBUG : Creating backend with remote "TestBox:rclone-test-rivefah7zawi" 2025/07/03 01:37:34 DEBUG : box root 'rclone-test-rivefah7zawi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/03 01:37:35 DEBUG : box root 'rclone-test-rivefah7zawi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/03 01:37:41 DEBUG : box root 'rclone-test-vetereb4podu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/03 01:37:45 DEBUG : box root 'rclone-test-vetereb4podu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/03 01:37:51 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-rivefah7zawi': 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/07/03 01:38:31 INFO : file name.txt.rclone_chunk.001_t0uiw7: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/03 01:38:31 INFO : file name.txt.rclone_chunk.002_t0uiw7: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/07/03 01:38:32 INFO : file name.txt.rclone_chunk.003_t0uiw7: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/07/03 01:38:33 INFO : file name.txt.rclone_chunk.004_t0uiw7: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/07/03 01:38:40 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/03 01:38:40 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/03 01:38:46 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-vetereb4podu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-vetereb4podu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/03 01:38:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu/not found.txt" 2025/07/03 01:38:46 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/not found.txt" 2025/07/03 01:38:49 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-vetereb4podu" from "TestChunkerChunk50bBox:rclone-test-vetereb4podu" 2025/07/03 01:38:49 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/07/03 01:38:56 INFO : rclone-test-vetereb4podu/created from root.txt.rclone_chunk.001_t0vezi: Moved (server-side) to: rclone-test-vetereb4podu/created from root.txt.rclone_chunk.001 2025/07/03 01:38:57 INFO : rclone-test-vetereb4podu/created from root.txt.rclone_chunk.002_t0vezi: Moved (server-side) to: rclone-test-vetereb4podu/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/07/03 01:39:24 INFO : piped data.txt.rclone_chunk.001_t0w7xe: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/03 01:39:33 INFO : piped data.txt.rclone_chunk.001_t0wd36: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/07/03 01:39:34 INFO : piped data.txt.rclone_chunk.002_t0wd36: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/07/03 01:39:34 INFO : piped data.txt.rclone_chunk.003_t0wd36: 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/07/03 01:39:43 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-vetereb4podu': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/07/03 01:39:48 INFO : small/emptyfile.rclone_chunk.001_t0wuj1: Moved (server-side) to: small/emptyfile 2025/07/03 01:39:56 INFO : small/smallfile.rclone_chunk.001_t0x3ew: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/07/03 01:40:13 INFO : corrupted/billy.rclone_chunk.001_t0xc4e: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/07/03 01:40:13 INFO : corrupted/billy.rclone_chunk.002_t0xc4e: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/07/03 01:40:14 INFO : corrupted/billy.rclone_chunk.003_t0xc4e: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/07/03 01:40:14 INFO : corrupted/billy.rclone_chunk.004_t0xc4e: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/07/03 01:40:15 INFO : corrupted/billy.rclone_chunk.005_t0xc4e: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/07/03 01:40:27 INFO : corrupted/silly1.rclone_chunk.001_t0xsbp: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/07/03 01:40:28 INFO : corrupted/silly1.rclone_chunk.002_t0xsbp: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/07/03 01:40:29 INFO : corrupted/silly1.rclone_chunk.003_t0xsbp: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/07/03 01:40:29 INFO : corrupted/silly1.rclone_chunk.004_t0xsbp: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/07/03 01:40:30 INFO : corrupted/silly1.rclone_chunk.005_t0xsbp: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/07/03 01:40:59 INFO : corrupted/silly2.rclone_chunk.001_t0y8ji: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/07/03 01:41:00 INFO : corrupted/silly2.rclone_chunk.002_t0y8ji: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/07/03 01:41:00 INFO : corrupted/silly2.rclone_chunk.003_t0y8ji: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/07/03 01:41:01 INFO : corrupted/silly2.rclone_chunk.004_t0y8ji: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/07/03 01:41:01 INFO : corrupted/silly2.rclone_chunk.005_t0y8ji: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/07/03 01:41:18 INFO : corrupted/silly3.rclone_chunk.001_t0z6fs: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/07/03 01:41:18 INFO : corrupted/silly3.rclone_chunk.002_t0z6fs: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/07/03 01:41:19 INFO : corrupted/silly3.rclone_chunk.003_t0z6fs: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/07/03 01:41:20 INFO : corrupted/silly3.rclone_chunk.004_t0z6fs: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/07/03 01:41:20 INFO : corrupted/silly3.rclone_chunk.005_t0z6fs: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/07/03 01:41:34 INFO : corrupted/willy.rclone_chunk.001_t0zl4e: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/07/03 01:41:35 INFO : corrupted/willy.rclone_chunk.002_t0zl4e: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/07/03 01:41:35 INFO : corrupted/willy.rclone_chunk.003_t0zl4e: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/07/03 01:41:36 INFO : corrupted/willy.rclone_chunk.004_t0zl4e: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/07/03 01:41:36 INFO : corrupted/willy.rclone_chunk.005_t0zl4e: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/07/03 01:41:50 INFO : corrupted/silly4.rclone_chunk.001_t103w7: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/07/03 01:41:51 INFO : corrupted/silly4.rclone_chunk.002_t103w7: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/07/03 01:41:52 INFO : corrupted/silly4.rclone_chunk.003_t103w7: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/07/03 01:41:52 INFO : corrupted/silly4.rclone_chunk.004_t103w7: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/07/03 01:41:53 INFO : corrupted/silly4.rclone_chunk.005_t103w7: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/07/03 01:41:57 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/07/03 01:42:07 INFO : corrupted/silly5.rclone_chunk.001_t10j23: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/07/03 01:42:07 INFO : corrupted/silly5.rclone_chunk.002_t10j23: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/07/03 01:42:08 INFO : corrupted/silly5.rclone_chunk.003_t10j23: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/07/03 01:42:09 INFO : corrupted/silly5.rclone_chunk.004_t10j23: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/07/03 01:42:09 INFO : corrupted/silly5.rclone_chunk.005_t10j23: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/07/03 01:42:12 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2025/07/03 01:42:35 INFO : wreaked/wreaker.rclone_chunk.001_t11gkz: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/07/03 01:42:36 INFO : wreaked/wreaker.rclone_chunk.002_t11gkz: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/07/03 01:42:41 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-vetereb4podu': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/07/03 01:42:58 ERROR : usermeta/today.rclone_chunk.001_t125k3: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1912639991950","file_version":{"type":"file_version","id":"2109875524750","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_t125k3"}}) 2025/07/03 01:43:00 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/07/03 01:43:01 INFO : usermeta/today.rclone_chunk.001_t125k3: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/07/03 01:43:13 ERROR : usermeta/past.rclone_chunk.001_t12k1o: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1912636453238","file_version":{"type":"file_version","id":"2109872053238","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_t12k1o"}}) 2025/07/03 01:43:15 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/07/03 01:43:16 INFO : usermeta/past.rclone_chunk.001_t12k1o: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/07/03 01:43:29 ERROR : usermeta/future.rclone_chunk.001_t1309c: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1912641606841","file_version":{"type":"file_version","id":"2109877211641","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_t1309c"}}) 2025/07/03 01:43:30 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/07/03 01:43:31 INFO : usermeta/future.rclone_chunk.001_t1309c: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/07/03 01:43:53 DEBUG : future/test: Can't move - required hash not found 2025/07/03 01:43:53 DEBUG : future/test: Can't move, switching to copy 2025/07/03 01:43:54 DEBUG : future/test: Can't copy - required hash not found 2025/07/03 01:43:55 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/07/03 01:43:55 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/07/03 01:43:57 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-vetereb4podu': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/07/03 01:44:46 INFO : backcomp/renamefile.rclone_chunk.001_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/07/03 01:44:46 INFO : backcomp/renamefile.rclone_chunk.002_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/07/03 01:44:47 INFO : backcomp/renamefile.rclone_chunk.003_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/07/03 01:44:47 INFO : backcomp/renamefile.rclone_chunk.004_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/07/03 01:44:48 INFO : backcomp/renamefile.rclone_chunk.005_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/07/03 01:44:48 INFO : backcomp/renamefile.rclone_chunk.006_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/07/03 01:44:49 INFO : backcomp/renamefile.rclone_chunk.007_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/07/03 01:44:50 INFO : backcomp/renamefile.rclone_chunk.008_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/07/03 01:44:50 INFO : backcomp/renamefile.rclone_chunk.009_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/07/03 01:44:51 INFO : backcomp/renamefile.rclone_chunk.010_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/07/03 01:44:51 INFO : backcomp/renamefile.rclone_chunk.011_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/07/03 01:44:52 INFO : backcomp/renamefile.rclone_chunk.012_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/07/03 01:44:53 INFO : backcomp/renamefile.rclone_chunk.013_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/07/03 01:44:53 INFO : backcomp/renamefile.rclone_chunk.014_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/07/03 01:44:54 INFO : backcomp/renamefile.rclone_chunk.015_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/07/03 01:44:55 INFO : backcomp/renamefile.rclone_chunk.016_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/07/03 01:44:55 INFO : backcomp/renamefile.rclone_chunk.017_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/07/03 01:44:56 INFO : backcomp/renamefile.rclone_chunk.018_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/07/03 01:44:56 INFO : backcomp/renamefile.rclone_chunk.019_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/07/03 01:44:57 INFO : backcomp/renamefile.rclone_chunk.020_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/07/03 01:44:58 INFO : backcomp/renamefile.rclone_chunk.021_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/07/03 01:44:58 INFO : backcomp/renamefile.rclone_chunk.022_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/07/03 01:44:59 INFO : backcomp/renamefile.rclone_chunk.023_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/07/03 01:44:59 INFO : backcomp/renamefile.rclone_chunk.024_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/07/03 01:45:00 INFO : backcomp/renamefile.rclone_chunk.025_t140ds: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/07/03 01:45:45 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu/servermovetest/subdir1" 2025/07/03 01:45:45 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/servermovetest/subdir1" 2025/07/03 01:45:48 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu/servermovetest/subdir2" 2025/07/03 01:45:48 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/servermovetest/subdir2" 2025/07/03 01:46:00 INFO : movefile.rclone_chunk.001_t17296: Moved (server-side) to: movefile.rclone_chunk.001 2025/07/03 01:46:00 INFO : movefile.rclone_chunk.002_t17296: Moved (server-side) to: movefile.rclone_chunk.002 2025/07/03 01:46:05 DEBUG : movefile: move 2 data chunks... 2025/07/03 01:46:08 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/07/03 01:46:09 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/07/03 01:46:11 INFO : movefile: Moved (server-side) 2025/07/03 01:46:12 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/07/03 01:46:18 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-vetereb4podu/md5all" 2025/07/03 01:46:18 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/07/03 01:46:18 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/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/07/03 01:46:28 INFO : unknown-size-put.txt.rclone_chunk.001_t17vri: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/07/03 01:46:29 INFO : unknown-size-put.txt.rclone_chunk.002_t17vri: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/07/03 01:46:29 INFO : unknown-size-put.txt.rclone_chunk.003_t17vri: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/03 01:46:42 INFO : unknown-size-update.txt.rclone_chunk.001_t18bd8: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/07/03 01:46:42 INFO : unknown-size-update.txt.rclone_chunk.002_t18bd8: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/07/03 01:47:01 INFO : unknown-size-update.txt.rclone_chunk.001_t18la5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/07/03 01:47:01 INFO : unknown-size-update.txt.rclone_chunk.002_t18la5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/07/03 01:47:02 INFO : unknown-size-update.txt.rclone_chunk.003_t18la5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/07/03 01:47:02 INFO : unknown-size-update.txt.rclone_chunk.004_t18la5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/07/03 01:47:03 INFO : unknown-size-update.txt.rclone_chunk.005_t18la5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/03 01:47:14 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vetereb4podu/deeper/nonexisting/directory" 2025/07/03 01:47:14 DEBUG : Creating backend with remote "TestBox:rclone-test-vetereb4podu/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/07/03 01:47:22 DEBUG : box root 'rclone-test-vetereb4podu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/03 01:47:22 ERROR : error listing: directory not found 2025/07/03 01:47:23 DEBUG : box root 'rclone-test-vetereb4podu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1227.48s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.98s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.07s) --- FAIL: TestIntegration/FsMkdir (1222.35s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (7.34s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.37s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.35s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.36s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (317.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (16.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (16.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (16.73s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (16.37s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (16.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (16.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (18.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (18.79s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (16.54s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (16.60s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (16.29s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (16.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (16.63s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (16.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (16.21s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (16.60s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (16.14s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (16.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (16.25s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.67s) --- PASS: TestIntegration/FsMkdir/FsPutError (67.20s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.97s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (76.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (681.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.89s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.52s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.82s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.75s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (2.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (15.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (17.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (20.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (14.89s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (39.69s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (18.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (1.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (1.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.99s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.71s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (20.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (6.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (19.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.39s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (17.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (6.92s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (1.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (10.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (23.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (6.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (16.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (397.74s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (18.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (147.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (21.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (49.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (21.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (103.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (32.91s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (3.37s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (52.55s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (15.92s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (36.63s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.73s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.74s) --- 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 1227.545s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished OK in 20m30.645591611s (try 1/5)