"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/05 06:14:26 NOTICE: TestChunkerChunk50bBox: Starting server 2025/07/05 06:14:26 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure" 2025/07/05 06:14:26 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/05 06:14:26 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure" 2025/07/05 06:14:26 DEBUG : box root 'rclone-test-goruhoj9rure': Token expired but no uploads in progress - doing nothing 2025/07/05 06:14:26 DEBUG : TestBox: Loaded invalid token from config file - ignoring 2025/07/05 06:14:27 DEBUG : Saving config "token" in section "TestBox" of the config file 2025/07/05 06:14:27 DEBUG : TestBox: Saved new token in config file 2025/07/05 06:14:27 DEBUG : box root 'rclone-test-goruhoj9rure': 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/05 06:14:28 DEBUG : box root 'rclone-test-goruhoj9rure': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/05 06:14:28 DEBUG : box root 'rclone-test-goruhoj9rure': 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/05 06:14:31 DEBUG : box root 'rclone-test-goruhoj9rure': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/07/05 06:14:32 INFO : dir/subdir: Making directory 2025/07/05 06:14:35 INFO : dir/subdir: Removing directory 2025/07/05 06:14:37 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/05 06:14:39 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/05 06:14:45 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_x2z3lu: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/07/05 06:14:45 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_x2z3lu: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/07/05 06:15:00 INFO : ./..rclone_chunk.001_x2zhxq: Moved (server-side) to: ./..rclone_chunk.001 2025/07/05 06:15:00 INFO : ./..rclone_chunk.002_x2zhxq: Moved (server-side) to: ./..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/07/05 06:15:14 INFO : ../...rclone_chunk.001_x2zwud: Moved (server-side) to: ../...rclone_chunk.001 2025/07/05 06:15:15 INFO : ../...rclone_chunk.002_x2zwud: Moved (server-side) to: ../...rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/07/05 06:15:29 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001_x30bvz: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/07/05 06:15:30 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002_x30bvz: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/07/05 06:15:44 INFO : leading space/ leading space.rclone_chunk.001_x30qnj: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/07/05 06:15:44 INFO : leading space/ leading space.rclone_chunk.002_x30qnj: 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/05 06:15:58 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_x314a2: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/07/05 06:15:59 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_x314a2: 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/05 06:16:13 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_x31ic2: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/07/05 06:16:13 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_x31ic2: 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/05 06:16:27 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_x31x36: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/07/05 06:16:28 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_x31x36: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/07/05 06:16:42 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_x32c4u: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/07/05 06:16:42 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_x32c4u: 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/05 06:16:56 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_x32q92: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/07/05 06:16:57 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_x32q92: 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/05 06:17:11 INFO : .leading dot/.leading dot.rclone_chunk.001_x3358a: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/07/05 06:17:12 INFO : .leading dot/.leading dot.rclone_chunk.002_x3358a: 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/05 06:17:26 INFO : trailing space /trailing space .rclone_chunk.001_x33k1q: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/07/05 06:17:26 INFO : trailing space /trailing space .rclone_chunk.002_x33k1q: 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/05 06:17:40 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_x33yu4: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/07/05 06:17:41 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_x33yu4: 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/05 06:17:55 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_x34dh2: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/07/05 06:17:55 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_x34dh2: 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/05 06:18:09 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_x34rpt: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/07/05 06:18:10 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_x34rpt: 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/05 06:18:24 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_x3560s: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/07/05 06:18:25 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_x3560s: 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/05 06:18:39 INFO : trailing dot./trailing dot..rclone_chunk.001_x35luq: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/07/05 06:18:39 INFO : trailing dot./trailing dot..rclone_chunk.002_x35luq: 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/05 06:18:53 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_x35z3m: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/07/05 06:18:54 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_x35z3m: 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/05 06:19:08 INFO : test%46.txt/test%46.txt.rclone_chunk.001_x36e54: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/07/05 06:19:08 INFO : test%46.txt/test%46.txt.rclone_chunk.002_x36e54: 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/05 06:20:18 INFO : zero-length-file.rclone_chunk.001_x38eq0: 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/05 06:20:21 INFO : dir: Making directory 2025/07/05 06:20:23 INFO : dir/subdir1: Making directory 2025/07/05 06:20:24 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181169995") 2025/07/05 06:20:24 INFO : dir/subdir3: Making directory 2025/07/05 06:20:24 DEBUG : box root 'rclone-test-goruhoj9rure': ["zero-length-file.rclone_chunk.001_x38eq0"(0)|file|ITEM_UPLOAD|1915140153493|0be4d84dc0523439430289837a0a8f9a19123671] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:24 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:24 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181171215") 2025/07/05 06:20:25 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181171447") 2025/07/05 06:20:25 INFO : dir/subdir2: Making directory 2025/07/05 06:20:26 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181172212") 2025/07/05 06:20:26 DEBUG : box root 'rclone-test-goruhoj9rure': ["zero-length-file"(1)|file|ITEM_RENAME|1915140153493|fffd243aefcf5e5b6f5db0a770788095dfdda140] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:26 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:26 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181173212") 2025/07/05 06:20:27 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181173437") 2025/07/05 06:20:28 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181174210") 2025/07/05 06:20:28 DEBUG : box root 'rclone-test-goruhoj9rure': ["zero-length-file"(2)|file|ITEM_TRASH|1915140153493|5fc98af58f93e72e5ad9bb701aabf286e3153705] added old path ("zero-length-file") for notify 2025/07/05 06:20:28 DEBUG : doChangeNotify("zero-length-file", 1) 2025/07/05 06:20:28 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/05 06:20:28 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181175212") 2025/07/05 06:20:29 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181175443") 2025/07/05 06:20:30 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181176211") 2025/07/05 06:20:30 DEBUG : box root 'rclone-test-goruhoj9rure': ["dir"(0)|folder|ITEM_CREATE|329499529511|c8af4d8109eb989ad8fbb4150c24c1192a888964] added new path ("dir") for notify 2025/07/05 06:20:30 DEBUG : box root 'rclone-test-goruhoj9rure': ["subdir1"(0)|folder|ITEM_CREATE|329499054365|72a29c3ae6d02e59506839537bb7d6a22474b01f] added new path ("dir/subdir1") for notify 2025/07/05 06:20:30 DEBUG : doChangeNotify("dir", 0) 2025/07/05 06:20:30 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/07/05 06:20:30 DEBUG : box root 'rclone-test-goruhoj9rure': Received 2 events, resulting in 2 paths and 2 notifications 2025/07/05 06:20:30 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181177210") 2025/07/05 06:20:30 INFO : dir/file2.rclone_chunk.001_x38ogc: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/07/05 06:20:31 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181177448") 2025/07/05 06:20:31 INFO : dir/file2.rclone_chunk.002_x38ogc: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/07/05 06:20:31 DEBUG : box root 'rclone-test-goruhoj9rure': ["subdir3"(0)|folder|ITEM_CREATE|329498738146|b2a8990e9e482fcbdc6c7e40396971aa07e09c11] added new path ("dir/subdir3") for notify 2025/07/05 06:20:31 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/07/05 06:20:31 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/05 06:20:31 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181178207") 2025/07/05 06:20:31 DEBUG : box root 'rclone-test-goruhoj9rure': ["subdir2"(0)|folder|ITEM_CREATE|329496992832|2e96c8478e86d8b0002ea7243b250478637c852e] added new path ("dir/subdir2") for notify 2025/07/05 06:20:31 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/07/05 06:20:31 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/05 06:20:31 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181178431") 2025/07/05 06:20:32 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181178652") 2025/07/05 06:20:33 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181179214") 2025/07/05 06:20:34 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181180213") 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181181212") 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2.rclone_chunk.002_x38ogc"(0)|file|ITEM_UPLOAD|1915141576684|503da0dfeb9ed7ff554e3b3a380c75a6c4c567c3] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2.rclone_chunk.001_x38ogc"(0)|file|ITEM_UPLOAD|1915143832137|306fed0a0ecf17f05a220fa4f220ffdd8475380f] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': Received 2 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181182214") 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1915143832137|e9c1ceaca6ea734fb4494e6a8424266b5f9b8071] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:35 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181182438") 2025/07/05 06:20:36 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181182660") 2025/07/05 06:20:37 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181183215") 2025/07/05 06:20:37 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1915141576684|09a9480cd45d9e491844ca1afe4111a96ef7366a] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:37 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:37 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181184209") 2025/07/05 06:20:38 INFO : dir/file4.rclone_chunk.001_x38w28: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/07/05 06:20:38 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181184448") 2025/07/05 06:20:38 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2"(0)|file|ITEM_UPLOAD|1915141631310|e57f688bf9578e771b6d0466b9b5ccfa57ef3dcf] ignored due to old SequenceID ('\x00') 2025/07/05 06:20:38 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:38 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181185211") 2025/07/05 06:20:38 INFO : dir/file4.rclone_chunk.002_x38w28: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/07/05 06:20:39 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181185428") 2025/07/05 06:20:40 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181186213") 2025/07/05 06:20:41 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181187216") 2025/07/05 06:20:41 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4.rclone_chunk.001_x38w28"(0)|file|ITEM_UPLOAD|1915144802380|34c5810bd089bf7f3f204b1b78a81a44f76ed4f5] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:41 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:41 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181188214") 2025/07/05 06:20:42 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181188442") 2025/07/05 06:20:43 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181189209") 2025/07/05 06:20:43 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4.rclone_chunk.002_x38w28"(0)|file|ITEM_UPLOAD|1915140731973|1ca77c37037dfaf0dab2722653bf86967d499ca5] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:43 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:43 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181190221") 2025/07/05 06:20:44 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181190445") 2025/07/05 06:20:44 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1915144802380|cb274a67ac5933fe39bc5ce6a927f41f71194459] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:44 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:44 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181191213") 2025/07/05 06:20:45 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181191444") 2025/07/05 06:20:45 INFO : dir/file3.rclone_chunk.001_x3934d: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/07/05 06:20:45 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1915140731973|df0aa54cd52ff96b5e2c0f68127cef30d3ea27d3] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:45 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:45 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181192211") 2025/07/05 06:20:45 INFO : dir/file3.rclone_chunk.002_x3934d: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/07/05 06:20:46 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181192443") 2025/07/05 06:20:46 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4"(0)|file|ITEM_UPLOAD|1915136279264|a36c49d9cae4ef1ff40bfc635fcb648f07387267] ignored due to old SequenceID ('\x00') 2025/07/05 06:20:46 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:46 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181193214") 2025/07/05 06:20:47 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181193441") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/07/05 06:20:48 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181194210") 2025/07/05 06:20:49 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181195214") 2025/07/05 06:20:49 DEBUG : box root 'rclone-test-goruhoj9rure': ["file3.rclone_chunk.001_x3934d"(0)|file|ITEM_UPLOAD|1915139137615|5f0e6bd3e308773f223aec9b3d984b91f7aba860] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:49 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:49 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181196208") 2025/07/05 06:20:49 DEBUG : box root 'rclone-test-goruhoj9rure': ["file3.rclone_chunk.002_x3934d"(0)|file|ITEM_UPLOAD|1915137501226|af7e5902415cb2df216f80bddc59df05afad89b6] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:49 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:49 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181196433") 2025/07/05 06:20:50 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181196664") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/07/05 06:20:51 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181197211") 2025/07/05 06:20:51 DEBUG : box root 'rclone-test-goruhoj9rure': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1915139137615|5fadc8698fe610400651998a8be1632d3c84c5cf] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:51 DEBUG : box root 'rclone-test-goruhoj9rure': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1915137501226|8ea802a08a0bbfd03433d9fe324cb9b016b396cf] ignored due to old SequenceID ('\x01') 2025/07/05 06:20:51 DEBUG : box root 'rclone-test-goruhoj9rure': Received 2 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:51 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181198218") 2025/07/05 06:20:52 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181198455") 2025/07/05 06:20:53 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181199218") 2025/07/05 06:20:53 DEBUG : box root 'rclone-test-goruhoj9rure': ["file3"(0)|file|ITEM_UPLOAD|1915145614954|60346eb3d18cc2d4c27d40df297667e036008db8] ignored due to old SequenceID ('\x00') 2025/07/05 06:20:53 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 0 paths and 0 notifications 2025/07/05 06:20:53 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181200212") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/07/05 06:20:54 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181200439") 2025/07/05 06:20:55 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181201216") 2025/07/05 06:20:56 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181202217") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/07/05 06:20:57 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181203210") 2025/07/05 06:20:58 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181204214") 2025/07/05 06:20:59 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181205209") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/07/05 06:21:00 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181206211") 2025/07/05 06:21:01 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181207213") 2025/07/05 06:21:02 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181208215") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/07/05 06:21:03 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181209214") 2025/07/05 06:21:04 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181210215") 2025/07/05 06:21:05 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181211214") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/07/05 06:21:06 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181212209") 2025/07/05 06:21:07 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181213214") 2025/07/05 06:21:08 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181214213") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/07/05 06:21:09 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181215214") 2025/07/05 06:21:10 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181216209") 2025/07/05 06:21:11 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181217215") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/07/05 06:21:12 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181218211") 2025/07/05 06:21:13 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181219208") 2025/07/05 06:21:14 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181220219") 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/07/05 06:21:15 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181221214") 2025/07/05 06:21:16 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181222210") 2025/07/05 06:21:17 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181223207") 2025/07/05 06:21:18 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181224214") 2025/07/05 06:21:19 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181225213") 2025/07/05 06:21:20 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181226211") 2025/07/05 06:21:21 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181227210") 2025/07/05 06:21:22 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181228210") 2025/07/05 06:21:23 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181229215") 2025/07/05 06:21:23 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2"(1)|file|ITEM_TRASH|1915141631310|f4d3504d96a9d6a921034b5a0f935f3b83dafa28] added old path ("dir/file2") for notify 2025/07/05 06:21:23 DEBUG : doChangeNotify("dir/file2", 1) 2025/07/05 06:21:23 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/05 06:21:23 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181230224") 2025/07/05 06:21:23 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1915143832137|e893c327d6c3220434766795f77786e490d04b7f] added old path ("dir/file2.rclone_chunk.001") for notify 2025/07/05 06:21:23 DEBUG : doChangeNotify("dir/file2", 1) 2025/07/05 06:21:23 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/05 06:21:23 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181230455") 2025/07/05 06:21:24 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181230684") 2025/07/05 06:21:25 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181231208") 2025/07/05 06:21:26 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181232210") 2025/07/05 06:21:26 DEBUG : box root 'rclone-test-goruhoj9rure': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1915141576684|d1fd3034b98f16064b20f19bc1b4bb42f4707c0e] added old path ("dir/file2.rclone_chunk.002") for notify 2025/07/05 06:21:26 DEBUG : doChangeNotify("dir/file2", 1) 2025/07/05 06:21:26 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/05 06:21:26 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181233212") 2025/07/05 06:21:27 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181233440") 2025/07/05 06:21:28 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181234224") 2025/07/05 06:21:28 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4"(1)|file|ITEM_TRASH|1915136279264|0a6b966f7c0e7eb1247d48a46be8f19288ac221d] added old path ("dir/file4") for notify 2025/07/05 06:21:28 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1915144802380|32a157b19712b7cabb2c5078a7a65b47375454ce] added old path ("dir/file4.rclone_chunk.001") for notify 2025/07/05 06:21:28 DEBUG : doChangeNotify("dir/file4", 1) 2025/07/05 06:21:28 DEBUG : doChangeNotify("dir/file4", 1) 2025/07/05 06:21:28 DEBUG : box root 'rclone-test-goruhoj9rure': Received 2 events, resulting in 2 paths and 2 notifications 2025/07/05 06:21:28 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181235218") 2025/07/05 06:21:29 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181235449") 2025/07/05 06:21:30 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181236214") 2025/07/05 06:21:30 DEBUG : box root 'rclone-test-goruhoj9rure': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1915140731973|e3fa2b71335d09142dc768da709ef4ff11869e6a] added old path ("dir/file4.rclone_chunk.002") for notify 2025/07/05 06:21:30 DEBUG : doChangeNotify("dir/file4", 1) 2025/07/05 06:21:30 DEBUG : box root 'rclone-test-goruhoj9rure': Received 1 events, resulting in 1 paths and 1 notifications 2025/07/05 06:21:30 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181237214") 2025/07/05 06:21:31 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181237433") 2025/07/05 06:21:32 DEBUG : box root 'rclone-test-goruhoj9rure': Checking for changes on remote (next_stream_position: "30401049181238212") === RUN TestIntegration/FsMkdir/FsPutFiles 2025/07/05 06:21:36 INFO : file name.txt.rclone_chunk.001_x3aiu2: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/05 06:21:37 INFO : file name.txt.rclone_chunk.002_x3aiu2: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/07/05 06:21:43 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_x3apjw: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/07/05 06:21:44 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_x3apjw: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/07/05 06:21:55 INFO : file name.txt.rclone_chunk.001_x3ay4c: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/05 06:21:55 INFO : file name.txt.rclone_chunk.002_x3ay4c: 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/05 06:22:02 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/07/05 06:22:02 DEBUG : Creating backend with remote "TestBox:" 2025/07/05 06:22:03 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/05 06:22:17 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_x3bmqy: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/07/05 06:22:17 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_x3bmqy: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/07/05 06:22:30 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_x3bz38: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/07/05 06:22:31 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_x3bz38: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/07/05 06:22:35 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure/dirToPurgeFromRoot" 2025/07/05 06:22:35 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/dirToPurgeFromRoot" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/07/05 06:22:39 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure/hello? sausage/êé" 2025/07/05 06:22:39 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/hello? sausage/êé" 2025/07/05 06:22:50 INFO : a/b/c/d/e.txt.rclone_chunk.001_x3cgm3: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/07/05 06:22:51 INFO : a/b/c/d/e.txt.rclone_chunk.002_x3cgm3: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/07/05 06:22:59 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/05 06:23:12 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/07/05 06:23:13 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/07/05 06:23:14 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/07/05 06:23:16 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/07/05 06:23:20 DEBUG : file name.txt: move 2 data chunks... 2025/07/05 06:23:23 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/07/05 06:23:24 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/07/05 06:23:25 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/07/05 06:23:30 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/07/05 06:23:31 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/05 06:23:32 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/07/05 06:23:33 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/07/05 06:23:38 DEBUG : other.txt: move 2 data chunks... 2025/07/05 06:23:39 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/07/05 06:23:40 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/07/05 06:23:42 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/05 06:23:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-qaruboc7kivo" 2025/07/05 06:23:46 DEBUG : Creating backend with remote "TestBox:rclone-test-qaruboc7kivo" 2025/07/05 06:23:46 DEBUG : box root 'rclone-test-qaruboc7kivo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/05 06:23:47 DEBUG : box root 'rclone-test-qaruboc7kivo': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/05 06:23:53 DEBUG : box root 'rclone-test-goruhoj9rure': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/05 06:23:55 DEBUG : box root 'rclone-test-goruhoj9rure': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/05 06:24:01 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-qaruboc7kivo': 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/05 06:24:37 INFO : file name.txt.rclone_chunk.001_x3fdga: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/07/05 06:24:38 INFO : file name.txt.rclone_chunk.002_x3fdga: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/07/05 06:24:38 INFO : file name.txt.rclone_chunk.003_x3fdga: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/07/05 06:24:39 INFO : file name.txt.rclone_chunk.004_x3fdga: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/07/05 06:24:45 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/05 06:24:45 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/05 06:24:50 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-goruhoj9rure/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-goruhoj9rure/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/05 06:24:51 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure/not found.txt" 2025/07/05 06:24:51 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/not found.txt" 2025/07/05 06:24:53 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-goruhoj9rure" from "TestChunkerChunk50bBox:rclone-test-goruhoj9rure" 2025/07/05 06:24:53 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/05 06:24:59 INFO : rclone-test-goruhoj9rure/created from root.txt.rclone_chunk.001_x3g5rs: Moved (server-side) to: rclone-test-goruhoj9rure/created from root.txt.rclone_chunk.001 2025/07/05 06:25:00 INFO : rclone-test-goruhoj9rure/created from root.txt.rclone_chunk.002_x3g5rs: Moved (server-side) to: rclone-test-goruhoj9rure/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/05 06:25:24 INFO : piped data.txt.rclone_chunk.001_x3gvlx: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/05 06:25:32 INFO : piped data.txt.rclone_chunk.001_x3h07k: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/07/05 06:25:32 INFO : piped data.txt.rclone_chunk.002_x3h07k: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/07/05 06:25:33 INFO : piped data.txt.rclone_chunk.003_x3h07k: 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/05 06:25:41 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-goruhoj9rure': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/07/05 06:25:45 INFO : small/emptyfile.rclone_chunk.001_x3hfil: Moved (server-side) to: small/emptyfile 2025/07/05 06:25:52 INFO : small/smallfile.rclone_chunk.001_x3hnau: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/07/05 06:26:06 INFO : corrupted/billy.rclone_chunk.001_x3hvd5: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/07/05 06:26:07 INFO : corrupted/billy.rclone_chunk.002_x3hvd5: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/07/05 06:26:07 INFO : corrupted/billy.rclone_chunk.003_x3hvd5: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/07/05 06:26:08 INFO : corrupted/billy.rclone_chunk.004_x3hvd5: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/07/05 06:26:08 INFO : corrupted/billy.rclone_chunk.005_x3hvd5: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/07/05 06:26:19 INFO : corrupted/silly1.rclone_chunk.001_x3i9w8: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/07/05 06:26:20 INFO : corrupted/silly1.rclone_chunk.002_x3i9w8: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/07/05 06:26:20 INFO : corrupted/silly1.rclone_chunk.003_x3i9w8: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/07/05 06:26:21 INFO : corrupted/silly1.rclone_chunk.004_x3i9w8: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/07/05 06:26:21 INFO : corrupted/silly1.rclone_chunk.005_x3i9w8: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/07/05 06:26:33 INFO : corrupted/silly2.rclone_chunk.001_x3in5q: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/07/05 06:26:33 INFO : corrupted/silly2.rclone_chunk.002_x3in5q: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/07/05 06:26:34 INFO : corrupted/silly2.rclone_chunk.003_x3in5q: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/07/05 06:26:34 INFO : corrupted/silly2.rclone_chunk.004_x3in5q: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/07/05 06:26:35 INFO : corrupted/silly2.rclone_chunk.005_x3in5q: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/07/05 06:26:48 INFO : corrupted/silly3.rclone_chunk.001_x3j2p4: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/07/05 06:26:49 INFO : corrupted/silly3.rclone_chunk.002_x3j2p4: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/07/05 06:26:50 INFO : corrupted/silly3.rclone_chunk.003_x3j2p4: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/07/05 06:26:50 INFO : corrupted/silly3.rclone_chunk.004_x3j2p4: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/07/05 06:26:51 INFO : corrupted/silly3.rclone_chunk.005_x3j2p4: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/07/05 06:27:01 INFO : corrupted/willy.rclone_chunk.001_x3jfbq: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/07/05 06:27:02 INFO : corrupted/willy.rclone_chunk.002_x3jfbq: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/07/05 06:27:02 INFO : corrupted/willy.rclone_chunk.003_x3jfbq: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/07/05 06:27:03 INFO : corrupted/willy.rclone_chunk.004_x3jfbq: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/07/05 06:27:03 INFO : corrupted/willy.rclone_chunk.005_x3jfbq: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/07/05 06:27:16 INFO : corrupted/silly4.rclone_chunk.001_x3jtnc: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/07/05 06:27:16 INFO : corrupted/silly4.rclone_chunk.002_x3jtnc: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/07/05 06:27:17 INFO : corrupted/silly4.rclone_chunk.003_x3jtnc: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/07/05 06:27:17 INFO : corrupted/silly4.rclone_chunk.004_x3jtnc: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/07/05 06:27:18 INFO : corrupted/silly4.rclone_chunk.005_x3jtnc: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/07/05 06:27:21 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/07/05 06:27:29 INFO : corrupted/silly5.rclone_chunk.001_x3k7ui: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/07/05 06:27:29 INFO : corrupted/silly5.rclone_chunk.002_x3k7ui: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/07/05 06:27:30 INFO : corrupted/silly5.rclone_chunk.003_x3k7ui: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/07/05 06:27:31 INFO : corrupted/silly5.rclone_chunk.004_x3k7ui: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/07/05 06:27:31 INFO : corrupted/silly5.rclone_chunk.005_x3k7ui: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/07/05 06:27:34 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/05 06:27:52 INFO : wreaked/wreaker.rclone_chunk.001_x3kxbs: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/07/05 06:27:52 INFO : wreaked/wreaker.rclone_chunk.002_x3kxbs: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/07/05 06:27:57 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-goruhoj9rure': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/07/05 06:28:11 ERROR : usermeta/today.rclone_chunk.001_x3lj3n: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1915140332977","file_version":{"type":"file_version","id":"2112641984977","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_x3lj3n"}}) 2025/07/05 06:28:13 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/07/05 06:28:13 INFO : usermeta/today.rclone_chunk.001_x3lj3n: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/07/05 06:28:24 ERROR : usermeta/past.rclone_chunk.001_x3lwcb: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1915148726159","file_version":{"type":"file_version","id":"2112650620559","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_x3lwcb"}}) 2025/07/05 06:28:26 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/07/05 06:28:27 INFO : usermeta/past.rclone_chunk.001_x3lwcb: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/07/05 06:28:38 ERROR : usermeta/future.rclone_chunk.001_x3m9u9: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1915146981241","file_version":{"type":"file_version","id":"2112648784441","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_x3m9u9"}}) 2025/07/05 06:28:39 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/07/05 06:28:40 INFO : usermeta/future.rclone_chunk.001_x3m9u9: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/07/05 06:28:59 DEBUG : future/test: Can't move - required hash not found 2025/07/05 06:28:59 DEBUG : future/test: Can't move, switching to copy 2025/07/05 06:29:00 DEBUG : future/test: Can't copy - required hash not found 2025/07/05 06:29:01 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/07/05 06:29:01 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/07/05 06:29:02 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-goruhoj9rure': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/07/05 06:29:44 INFO : backcomp/renamefile.rclone_chunk.001_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/07/05 06:29:45 INFO : backcomp/renamefile.rclone_chunk.002_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/07/05 06:29:45 INFO : backcomp/renamefile.rclone_chunk.003_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/07/05 06:29:46 INFO : backcomp/renamefile.rclone_chunk.004_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/07/05 06:29:46 INFO : backcomp/renamefile.rclone_chunk.005_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/07/05 06:29:47 INFO : backcomp/renamefile.rclone_chunk.006_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/07/05 06:29:47 INFO : backcomp/renamefile.rclone_chunk.007_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/07/05 06:29:48 INFO : backcomp/renamefile.rclone_chunk.008_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/07/05 06:29:48 INFO : backcomp/renamefile.rclone_chunk.009_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/07/05 06:29:49 INFO : backcomp/renamefile.rclone_chunk.010_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/07/05 06:29:49 INFO : backcomp/renamefile.rclone_chunk.011_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/07/05 06:29:50 INFO : backcomp/renamefile.rclone_chunk.012_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/07/05 06:29:51 INFO : backcomp/renamefile.rclone_chunk.013_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/07/05 06:29:51 INFO : backcomp/renamefile.rclone_chunk.014_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/07/05 06:29:52 INFO : backcomp/renamefile.rclone_chunk.015_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/07/05 06:29:52 INFO : backcomp/renamefile.rclone_chunk.016_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/07/05 06:29:53 INFO : backcomp/renamefile.rclone_chunk.017_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/07/05 06:29:53 INFO : backcomp/renamefile.rclone_chunk.018_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/07/05 06:29:54 INFO : backcomp/renamefile.rclone_chunk.019_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/07/05 06:29:54 INFO : backcomp/renamefile.rclone_chunk.020_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/07/05 06:29:55 INFO : backcomp/renamefile.rclone_chunk.021_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/07/05 06:29:55 INFO : backcomp/renamefile.rclone_chunk.022_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/07/05 06:29:56 INFO : backcomp/renamefile.rclone_chunk.023_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/07/05 06:29:56 INFO : backcomp/renamefile.rclone_chunk.024_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/07/05 06:29:57 INFO : backcomp/renamefile.rclone_chunk.025_x3n4i2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/07/05 06:30:36 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure/servermovetest/subdir1" 2025/07/05 06:30:36 DEBUG : Config file has changed externally - reloading 2025/07/05 06:30:36 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/servermovetest/subdir1" 2025/07/05 06:30:38 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure/servermovetest/subdir2" 2025/07/05 06:30:38 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/servermovetest/subdir2" 2025/07/05 06:30:47 INFO : movefile.rclone_chunk.001_x3pr8a: Moved (server-side) to: movefile.rclone_chunk.001 2025/07/05 06:30:48 INFO : movefile.rclone_chunk.002_x3pr8a: Moved (server-side) to: movefile.rclone_chunk.002 2025/07/05 06:30:52 DEBUG : movefile: move 2 data chunks... 2025/07/05 06:30:54 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/07/05 06:30:56 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/07/05 06:30:57 INFO : movefile: Moved (server-side) 2025/07/05 06:30:58 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/07/05 06:31:02 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-goruhoj9rure/md5all" 2025/07/05 06:31:02 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/07/05 06:31:02 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/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/05 06:31:10 INFO : unknown-size-put.txt.rclone_chunk.001_x3qfro: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/07/05 06:31:11 INFO : unknown-size-put.txt.rclone_chunk.002_x3qfro: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/07/05 06:31:11 INFO : unknown-size-put.txt.rclone_chunk.003_x3qfro: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/05 06:31:22 INFO : unknown-size-update.txt.rclone_chunk.001_x3qt2b: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/07/05 06:31:23 INFO : unknown-size-update.txt.rclone_chunk.002_x3qt2b: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/07/05 06:31:37 INFO : unknown-size-update.txt.rclone_chunk.001_x3r1r0: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/07/05 06:31:38 INFO : unknown-size-update.txt.rclone_chunk.002_x3r1r0: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/07/05 06:31:38 INFO : unknown-size-update.txt.rclone_chunk.003_x3r1r0: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/07/05 06:31:39 INFO : unknown-size-update.txt.rclone_chunk.004_x3r1r0: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/07/05 06:31:40 INFO : unknown-size-update.txt.rclone_chunk.005_x3r1r0: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/05 06:31:49 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-goruhoj9rure/deeper/nonexisting/directory" 2025/07/05 06:31:49 DEBUG : Creating backend with remote "TestBox:rclone-test-goruhoj9rure/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/05 06:31:57 DEBUG : box root 'rclone-test-goruhoj9rure': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/07/05 06:31:57 ERROR : error listing: directory not found 2025/07/05 06:31:57 DEBUG : box root 'rclone-test-goruhoj9rure': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1051.50s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.49s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.97s) --- FAIL: TestIntegration/FsMkdir (1046.69s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (5.96s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.34s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.32s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.32s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (277.65s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (14.68s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (14.90s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (14.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (14.71s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (14.65s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (13.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (14.73s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (14.51s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (14.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (14.59s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (14.78s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (14.60s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (14.52s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (14.55s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (14.44s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (14.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (14.47s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (14.51s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (14.24s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutError (58.28s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (5.98s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (70.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (572.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.66s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.49s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.68s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.66s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (13.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (14.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (17.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (13.16s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (35.60s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (16.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.94s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.92s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.92s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (2.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (18.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (17.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.37s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (15.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.99s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.91s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (9.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (20.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (4.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (15.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (323.64s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (15.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (109.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (18.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (42.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (18.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (89.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (26.27s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (2.09s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (44.42s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (13.75s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (30.67s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.45s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.39s) --- 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 1051.534s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished OK in 17m34.481167543s (try 1/5)