"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestChunkerChunk50bBox:" 2025/03/07 09:44:41 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi" 2025/03/07 09:44:41 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/07 09:44:41 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi" 2025/03/07 09:44:41 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:44:42 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/03/07 09:44:43 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:44:43 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/03/07 09:44:46 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/03/07 09:44:47 INFO : dir/subdir: Making directory 2025/03/07 09:44:51 INFO : dir/subdir: Removing directory 2025/03/07 09:44:52 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/03/07 09:44:55 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/03/07 09:45:01 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_r4odrc: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/03/07 09:45:02 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_r4odrc: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/03/07 09:45:16 INFO : ./..rclone_chunk.001_r4osqe: Moved (server-side) to: ./..rclone_chunk.001 2025/03/07 09:45:17 INFO : ./..rclone_chunk.002_r4osqe: Moved (server-side) to: ./..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/03/07 09:45:30 INFO : ../...rclone_chunk.001_r4p6nn: Moved (server-side) to: ../...rclone_chunk.001 2025/03/07 09:45:31 INFO : ../...rclone_chunk.002_r4p6nn: Moved (server-side) to: ../...rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/03/07 09:45:44 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001_r4pjpw: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/03/07 09:45:45 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002_r4pjpw: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/03/07 09:46:00 INFO : leading space/ leading space.rclone_chunk.001_r4pzb1: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/03/07 09:46:00 INFO : leading space/ leading space.rclone_chunk.002_r4pzb1: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/03/07 09:46:14 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_r4qe3w: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/03/07 09:46:15 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_r4qe3w: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/03/07 09:46:28 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_r4qsre: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/03/07 09:46:28 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_r4qsre: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/03/07 09:46:41 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_r4r5ei: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/03/07 09:46:41 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_r4r5ei: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/03/07 09:46:56 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_r4rk3l: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/03/07 09:46:57 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_r4rk3l: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/03/07 09:47:11 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_r4rzne: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/03/07 09:47:12 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_r4rzne: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/03/07 09:47:26 INFO : .leading dot/.leading dot.rclone_chunk.001_r4sehj: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/03/07 09:47:26 INFO : .leading dot/.leading dot.rclone_chunk.002_r4sehj: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/03/07 09:47:40 INFO : trailing space /trailing space .rclone_chunk.001_r4ss3z: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/03/07 09:47:40 INFO : trailing space /trailing space .rclone_chunk.002_r4ss3z: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/03/07 09:47:55 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_r4t70q: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/03/07 09:47:56 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_r4t70q: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/03/07 09:48:10 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_r4tmob: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/03/07 09:48:11 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_r4tmob: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/03/07 09:48:30 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_r4u54w: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/03/07 09:48:30 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_r4u54w: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/03/07 09:48:43 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_r4ujzv: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/03/07 09:48:44 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_r4ujzv: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/03/07 09:48:59 INFO : trailing dot./trailing dot..rclone_chunk.001_r4uyx9: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/03/07 09:48:59 INFO : trailing dot./trailing dot..rclone_chunk.002_r4uyx9: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/03/07 09:49:14 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_r4vdmf: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/03/07 09:49:14 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_r4vdmf: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/03/07 09:49:29 INFO : test%46.txt/test%46.txt.rclone_chunk.001_r4vswq: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/03/07 09:49:29 INFO : test%46.txt/test%46.txt.rclone_chunk.002_r4vswq: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError fstests.go:747: Reduce file size due to limit 1024 === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/03/07 09:50:37 INFO : zero-length-file.rclone_chunk.001_r4xqdr: Moved (server-side) to: zero-length-file === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/03/07 09:50:40 INFO : dir: Making directory 2025/03/07 09:50:41 INFO : dir/subdir1: Making directory 2025/03/07 09:50:42 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825788602") 2025/03/07 09:50:42 INFO : dir/subdir3: Making directory 2025/03/07 09:50:43 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825789832") 2025/03/07 09:50:44 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 3 events, resulting in 0 paths and 0 notifications 2025/03/07 09:50:44 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825790835") 2025/03/07 09:50:44 INFO : dir/subdir2: Making directory 2025/03/07 09:50:44 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825791070") 2025/03/07 09:50:45 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.008_r4w6vt"(1)|file|ITEM_TRASH|1796609869410|6ebf74f77abcc12d01ecd947401e2444f763930f] ignored due to duplicate EventID 2025/03/07 09:50:45 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.004_r4w6vt"(1)|file|ITEM_TRASH|1796598055172|b565f5bba31a9983c794a442ca3975a202a14c41] ignored due to duplicate EventID 2025/03/07 09:50:45 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.009_r4w6vt"(1)|file|ITEM_TRASH|1796595179250|1e402b5c882c65f9a598102a288bcd341ecab5e8] ignored due to duplicate EventID 2025/03/07 09:50:45 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825791888") 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.008_r4w6vt"(1)|file|ITEM_TRASH|1796609869410|6ebf74f77abcc12d01ecd947401e2444f763930f] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.004_r4w6vt"(1)|file|ITEM_TRASH|1796598055172|b565f5bba31a9983c794a442ca3975a202a14c41] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.009_r4w6vt"(1)|file|ITEM_TRASH|1796595179250|1e402b5c882c65f9a598102a288bcd341ecab5e8] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 5 events, resulting in 0 paths and 0 notifications 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825792861") 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.008_r4w6vt"(1)|file|ITEM_TRASH|1796609869410|6ebf74f77abcc12d01ecd947401e2444f763930f] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.004_r4w6vt"(1)|file|ITEM_TRASH|1796598055172|b565f5bba31a9983c794a442ca3975a202a14c41] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.009_r4w6vt"(1)|file|ITEM_TRASH|1796595179250|1e402b5c882c65f9a598102a288bcd341ecab5e8] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.016_r4w6vt"(1)|file|ITEM_TRASH|1796585506841|c8cb9b53eb1da196b41fcae3b881ebebd1f29c14] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.012_r4w6vt"(1)|file|ITEM_TRASH|1796594257971|1877c7e160150171655f980e06c2cf67ab13d24e] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file"(1)|file|ITEM_RENAME|1796585051300|298cef107f5cba36400bb445003b2b9803d70af4] ignored due to old SequenceID ('\x01') 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825793142") 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.008_r4w6vt"(1)|file|ITEM_TRASH|1796609869410|6ebf74f77abcc12d01ecd947401e2444f763930f] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.004_r4w6vt"(1)|file|ITEM_TRASH|1796598055172|b565f5bba31a9983c794a442ca3975a202a14c41] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.009_r4w6vt"(1)|file|ITEM_TRASH|1796595179250|1e402b5c882c65f9a598102a288bcd341ecab5e8] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.016_r4w6vt"(1)|file|ITEM_TRASH|1796585506841|c8cb9b53eb1da196b41fcae3b881ebebd1f29c14] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.012_r4w6vt"(1)|file|ITEM_TRASH|1796594257971|1877c7e160150171655f980e06c2cf67ab13d24e] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file"(1)|file|ITEM_RENAME|1796585051300|298cef107f5cba36400bb445003b2b9803d70af4] ignored due to duplicate EventID 2025/03/07 09:50:46 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825793394") 2025/03/07 09:50:47 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.004_r4w6vt"(1)|file|ITEM_TRASH|1796598055172|b565f5bba31a9983c794a442ca3975a202a14c41] ignored due to duplicate EventID 2025/03/07 09:50:47 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825793857") 2025/03/07 09:50:48 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.009_r4w6vt"(1)|file|ITEM_TRASH|1796595179250|1e402b5c882c65f9a598102a288bcd341ecab5e8] ignored due to duplicate EventID 2025/03/07 09:50:48 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825794848") 2025/03/07 09:50:49 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825795844") 2025/03/07 09:50:50 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.016_r4w6vt"(1)|file|ITEM_TRASH|1796585506841|c8cb9b53eb1da196b41fcae3b881ebebd1f29c14] ignored due to duplicate EventID 2025/03/07 09:50:50 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825796832") 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.012_r4w6vt"(1)|file|ITEM_TRASH|1796594257971|1877c7e160150171655f980e06c2cf67ab13d24e] ignored due to duplicate EventID 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file"(1)|file|ITEM_RENAME|1796585051300|298cef107f5cba36400bb445003b2b9803d70af4] ignored due to duplicate EventID 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 4 events, resulting in 0 paths and 0 notifications 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825797846") 2025/03/07 09:50:51 INFO : dir/file2.rclone_chunk.001_r4y2ij: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file.rclone_chunk.001_r4xqdr"(0)|file|ITEM_UPLOAD|1796585051300|1adfd91d6134158a6d91c2a46b3d97e6b71ba4e7] ignored due to old SequenceID ('\x01') 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 5 events, resulting in 0 paths and 0 notifications 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825798120") 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file.rclone_chunk.001_r4xqdr"(0)|file|ITEM_UPLOAD|1796585051300|1adfd91d6134158a6d91c2a46b3d97e6b71ba4e7] ignored due to duplicate EventID 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.011_r4w6vt"(1)|file|ITEM_TRASH|1796591476161|418b9859c759b0dce162c0a838817a4ba27037ef] ignored due to duplicate EventID 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.015_r4w6vt"(1)|file|ITEM_TRASH|1796587676643|c3db31e92a3c5110554b2b80ab3d2c294241c157] ignored due to duplicate EventID 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.018_r4w6vt"(1)|file|ITEM_TRASH|1796611556729|0e449d194264ce040d9993e4e0a3d8dd77409793] ignored due to duplicate EventID 2025/03/07 09:50:51 INFO : dir/file2.rclone_chunk.002_r4y2ij: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/03/07 09:50:51 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825798412") 2025/03/07 09:50:52 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file.rclone_chunk.001_r4xqdr"(0)|file|ITEM_UPLOAD|1796585051300|1adfd91d6134158a6d91c2a46b3d97e6b71ba4e7] ignored due to duplicate EventID 2025/03/07 09:50:52 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.011_r4w6vt"(1)|file|ITEM_TRASH|1796591476161|418b9859c759b0dce162c0a838817a4ba27037ef] ignored due to duplicate EventID 2025/03/07 09:50:52 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825798840") 2025/03/07 09:50:53 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.015_r4w6vt"(1)|file|ITEM_TRASH|1796587676643|c3db31e92a3c5110554b2b80ab3d2c294241c157] ignored due to duplicate EventID 2025/03/07 09:50:53 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825799833") 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.018_r4w6vt"(1)|file|ITEM_TRASH|1796611556729|0e449d194264ce040d9993e4e0a3d8dd77409793] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["dir"(0)|folder|ITEM_CREATE|310589027941|7c7d4d18ffe8e0544b4a87b54daf2c882e7272ae] added new path ("dir") for notify 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir1"(0)|folder|ITEM_CREATE|310586764044|ea26f4e7a2bbbbaecea2f7b2279a485b3e42ee9a] added new path ("dir/subdir1") for notify 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir3"(0)|folder|ITEM_CREATE|310588470161|0a25c34bd89645606afad9f908a94ff23e3e0195] added new path ("dir/subdir3") for notify 2025/03/07 09:50:54 DEBUG : doChangeNotify("dir", 0) 2025/03/07 09:50:54 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/03/07 09:50:54 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 8 events, resulting in 3 paths and 3 notifications 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825800839") 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.020_r4w6vt"(1)|file|ITEM_TRASH|1796586411673|f2906195fd95bd098a5bf50c1b49e0865b430d68] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["dir"(0)|folder|ITEM_CREATE|310589027941|7c7d4d18ffe8e0544b4a87b54daf2c882e7272ae] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir1"(0)|folder|ITEM_CREATE|310586764044|ea26f4e7a2bbbbaecea2f7b2279a485b3e42ee9a] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.013_r4w6vt"(1)|file|ITEM_TRASH|1796585728174|1cf37dfeb99ed41508d55833e433efd65a886dc8] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.019_r4w6vt"(1)|file|ITEM_TRASH|1796613415019|c4401cfae6ef206b54d4738ba34559ae3057dca0] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir3"(0)|folder|ITEM_CREATE|310588470161|0a25c34bd89645606afad9f908a94ff23e3e0195] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.017_r4w6vt"(1)|file|ITEM_TRASH|1796591365626|5030abf5c505200dff4b86344feaaff78daf78fd] ignored due to duplicate EventID 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir2"(0)|folder|ITEM_CREATE|310586217038|5d76708b3dc6839d86efe3d0d7ecb162fa68e68b] added new path ("dir/subdir2") for notify 2025/03/07 09:50:54 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 8 events, resulting in 1 paths and 1 notifications 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825801079") 2025/03/07 09:50:54 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825801358") 2025/03/07 09:50:55 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825801853") 2025/03/07 09:50:56 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825802837") 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.020_r4w6vt"(1)|file|ITEM_TRASH|1796586411673|f2906195fd95bd098a5bf50c1b49e0865b430d68] ignored due to duplicate EventID 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': ["dir"(0)|folder|ITEM_CREATE|310589027941|7c7d4d18ffe8e0544b4a87b54daf2c882e7272ae] ignored due to duplicate EventID 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir1"(0)|folder|ITEM_CREATE|310586764044|ea26f4e7a2bbbbaecea2f7b2279a485b3e42ee9a] ignored due to duplicate EventID 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.013_r4w6vt"(1)|file|ITEM_TRASH|1796585728174|1cf37dfeb99ed41508d55833e433efd65a886dc8] ignored due to duplicate EventID 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.019_r4w6vt"(1)|file|ITEM_TRASH|1796613415019|c4401cfae6ef206b54d4738ba34559ae3057dca0] ignored due to duplicate EventID 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir3"(0)|folder|ITEM_CREATE|310588470161|0a25c34bd89645606afad9f908a94ff23e3e0195] ignored due to duplicate EventID 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': ["z.txt.rclone_chunk.017_r4w6vt"(1)|file|ITEM_TRASH|1796591365626|5030abf5c505200dff4b86344feaaff78daf78fd] ignored due to duplicate EventID 2025/03/07 09:50:57 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825803827") 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir2"(0)|folder|ITEM_CREATE|310586217038|5d76708b3dc6839d86efe3d0d7ecb162fa68e68b] ignored due to duplicate EventID 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file"(2)|file|ITEM_TRASH|1796585051300|66c74f9f05ad3e31c70543796811b51c7a949f6a] added old path ("zero-length-file") for notify 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1796606044031|50e8c51d5593e755fc65227e6329fd27e6a740bc] ignored due to old SequenceID ('\x01') 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1796587933537|d34457102839667721db89561b19e12f536659b6] ignored due to old SequenceID ('\x01') 2025/03/07 09:50:58 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 4 events, resulting in 1 paths and 1 notifications 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825804839") 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["subdir2"(0)|folder|ITEM_CREATE|310586217038|5d76708b3dc6839d86efe3d0d7ecb162fa68e68b] ignored due to duplicate EventID 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file"(2)|file|ITEM_TRASH|1796585051300|66c74f9f05ad3e31c70543796811b51c7a949f6a] ignored due to duplicate EventID 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1796606044031|50e8c51d5593e755fc65227e6329fd27e6a740bc] ignored due to duplicate EventID 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1796587933537|d34457102839667721db89561b19e12f536659b6] ignored due to duplicate EventID 2025/03/07 09:50:58 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825805113") 2025/03/07 09:50:59 INFO : dir/file4.rclone_chunk.001_r4ya9s: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/03/07 09:50:59 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825805832") 2025/03/07 09:50:59 INFO : dir/file4.rclone_chunk.002_r4ya9s: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/03/07 09:51:00 DEBUG : box root 'rclone-test-paqiqox6yebi': ["zero-length-file"(2)|file|ITEM_TRASH|1796585051300|66c74f9f05ad3e31c70543796811b51c7a949f6a] ignored due to duplicate EventID 2025/03/07 09:51:00 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1796606044031|50e8c51d5593e755fc65227e6329fd27e6a740bc] ignored due to duplicate EventID 2025/03/07 09:51:00 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825806837") 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1796587933537|d34457102839667721db89561b19e12f536659b6] ignored due to duplicate EventID 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.002_r4y2ij"(0)|file|ITEM_UPLOAD|1796587933537|40f20fa10ef95173774940a2b7b85ac36cf9bc35] ignored due to old SequenceID ('\x01') 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.001_r4y2ij"(0)|file|ITEM_UPLOAD|1796606044031|c8fed98e3e1df6c09ac5427b36fc658e5031a8f1] ignored due to old SequenceID ('\x01') 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4.rclone_chunk.001_r4ya9s"(0)|file|ITEM_UPLOAD|1796587165298|14da2cb19bdd930388f908ae864dc87870ba61d9] added new path ("dir/file4.rclone_chunk.001_r4ya9s") for notify 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2"(0)|file|ITEM_UPLOAD|1796590239848|bd4bfd35c99a5487308ed8b997e2dab551c9089b] ignored due to old SequenceID ('\x00') 2025/03/07 09:51:01 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_r4ya9s", 1) 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 5 events, resulting in 1 paths and 1 notifications 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825807835") 2025/03/07 09:51:01 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825808074") 2025/03/07 09:51:02 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825808832") 2025/03/07 09:51:03 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.002_r4y2ij"(0)|file|ITEM_UPLOAD|1796587933537|40f20fa10ef95173774940a2b7b85ac36cf9bc35] ignored due to duplicate EventID 2025/03/07 09:51:03 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825809838") 2025/03/07 09:51:04 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2.rclone_chunk.001_r4y2ij"(0)|file|ITEM_UPLOAD|1796606044031|c8fed98e3e1df6c09ac5427b36fc658e5031a8f1] ignored due to duplicate EventID 2025/03/07 09:51:04 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4.rclone_chunk.001_r4ya9s"(0)|file|ITEM_UPLOAD|1796587165298|14da2cb19bdd930388f908ae864dc87870ba61d9] ignored due to duplicate EventID 2025/03/07 09:51:04 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825810832") 2025/03/07 09:51:05 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file2"(0)|file|ITEM_UPLOAD|1796590239848|bd4bfd35c99a5487308ed8b997e2dab551c9089b] ignored due to duplicate EventID 2025/03/07 09:51:05 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825811839") 2025/03/07 09:51:06 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825812839") 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1796587165298|3888c027b8d17d42e7f98b7ef9f33575a2516c50] ignored due to old SequenceID ('\x01') 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825813831") 2025/03/07 09:51:07 INFO : dir/file3.rclone_chunk.001_r4yi4m: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1796592103107|13305dbdbb4b858329583edda640f4bcfbee23d6] ignored due to old SequenceID ('\x01') 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4.rclone_chunk.002_r4ya9s"(0)|file|ITEM_UPLOAD|1796592103107|c4305a142e87096c2056ae9efb32f0629da2655c] ignored due to old SequenceID ('\x01') 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4"(0)|file|ITEM_UPLOAD|1796592836570|76338d74768ab8b523a8b7e2f310bb7f9fd8142c] ignored due to old SequenceID ('\x00') 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001_r4yi4m"(0)|file|ITEM_UPLOAD|1796593017143|010035cd84eb1dd7d248e3c31c818b6995934e99] added new path ("dir/file3.rclone_chunk.001_r4yi4m") for notify 2025/03/07 09:51:07 DEBUG : doChangeNotify("dir/file3.rclone_chunk.001_r4yi4m", 1) 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 4 events, resulting in 1 paths and 1 notifications 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825814068") 2025/03/07 09:51:07 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825814318") 2025/03/07 09:51:07 INFO : dir/file3.rclone_chunk.002_r4yi4m: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/03/07 09:51:08 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1796592103107|13305dbdbb4b858329583edda640f4bcfbee23d6] ignored due to duplicate EventID 2025/03/07 09:51:08 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4.rclone_chunk.002_r4ya9s"(0)|file|ITEM_UPLOAD|1796592103107|c4305a142e87096c2056ae9efb32f0629da2655c] ignored due to duplicate EventID 2025/03/07 09:51:08 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825814876") 2025/03/07 09:51:09 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file4"(0)|file|ITEM_UPLOAD|1796592836570|76338d74768ab8b523a8b7e2f310bb7f9fd8142c] ignored due to duplicate EventID 2025/03/07 09:51:09 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001_r4yi4m"(0)|file|ITEM_UPLOAD|1796593017143|010035cd84eb1dd7d248e3c31c818b6995934e99] ignored due to duplicate EventID 2025/03/07 09:51:09 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825815829") 2025/03/07 09:51:10 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001_r4yi4m"(0)|file|ITEM_UPLOAD|1796593017143|010035cd84eb1dd7d248e3c31c818b6995934e99] ignored due to duplicate EventID 2025/03/07 09:51:10 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002_r4yi4m"(0)|file|ITEM_UPLOAD|1796592481923|ea0d62cc167545cd1cbf6f4b17a4a595df92a07f] added new path ("dir/file3.rclone_chunk.002_r4yi4m") for notify 2025/03/07 09:51:10 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1796592481923|233166583d8362e4bc5ce5c311e7633f098b7e32] added new path ("dir/file3.rclone_chunk.002") for notify 2025/03/07 09:51:10 DEBUG : doChangeNotify("dir/file3.rclone_chunk.002_r4yi4m", 1) 2025/03/07 09:51:10 DEBUG : doChangeNotify("dir/file3", 1) 2025/03/07 09:51:10 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 3 events, resulting in 2 paths and 2 notifications 2025/03/07 09:51:10 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825816832") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/07 09:51:10 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825817071") 2025/03/07 09:51:11 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001_r4yi4m"(0)|file|ITEM_UPLOAD|1796593017143|010035cd84eb1dd7d248e3c31c818b6995934e99] ignored due to duplicate EventID 2025/03/07 09:51:11 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825817828") 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002_r4yi4m"(0)|file|ITEM_UPLOAD|1796592481923|ea0d62cc167545cd1cbf6f4b17a4a595df92a07f] ignored due to duplicate EventID 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1796592481923|233166583d8362e4bc5ce5c311e7633f098b7e32] ignored due to duplicate EventID 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1796593017143|5d22dda4aacee41bbe49a124520425bdd1599cb5] ignored due to old SequenceID ('\x01') 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 3 events, resulting in 0 paths and 0 notifications 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825818853") 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002_r4yi4m"(0)|file|ITEM_UPLOAD|1796592481923|ea0d62cc167545cd1cbf6f4b17a4a595df92a07f] ignored due to duplicate EventID 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1796592481923|233166583d8362e4bc5ce5c311e7633f098b7e32] ignored due to duplicate EventID 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1796593017143|5d22dda4aacee41bbe49a124520425bdd1599cb5] ignored due to duplicate EventID 2025/03/07 09:51:12 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825819086") 2025/03/07 09:51:13 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002_r4yi4m"(0)|file|ITEM_UPLOAD|1796592481923|ea0d62cc167545cd1cbf6f4b17a4a595df92a07f] ignored due to duplicate EventID 2025/03/07 09:51:13 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1796592481923|233166583d8362e4bc5ce5c311e7633f098b7e32] ignored due to duplicate EventID 2025/03/07 09:51:13 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1796593017143|5d22dda4aacee41bbe49a124520425bdd1599cb5] ignored due to duplicate EventID 2025/03/07 09:51:13 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3"(0)|file|ITEM_UPLOAD|1796611119745|f66d29f20f944d1536361e09e769aa1744b5a9ba] ignored due to old SequenceID ('\x00') 2025/03/07 09:51:13 DEBUG : box root 'rclone-test-paqiqox6yebi': Received 4 events, resulting in 0 paths and 0 notifications 2025/03/07 09:51:13 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825819834") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/07 09:51:13 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825820083") 2025/03/07 09:51:14 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002_r4yi4m"(0)|file|ITEM_UPLOAD|1796592481923|ea0d62cc167545cd1cbf6f4b17a4a595df92a07f] ignored due to duplicate EventID 2025/03/07 09:51:14 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1796592481923|233166583d8362e4bc5ce5c311e7633f098b7e32] ignored due to duplicate EventID 2025/03/07 09:51:14 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1796593017143|5d22dda4aacee41bbe49a124520425bdd1599cb5] ignored due to duplicate EventID 2025/03/07 09:51:14 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3"(0)|file|ITEM_UPLOAD|1796611119745|f66d29f20f944d1536361e09e769aa1744b5a9ba] ignored due to duplicate EventID 2025/03/07 09:51:14 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825820834") 2025/03/07 09:51:15 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1796593017143|5d22dda4aacee41bbe49a124520425bdd1599cb5] ignored due to duplicate EventID 2025/03/07 09:51:15 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825821833") 2025/03/07 09:51:16 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3"(0)|file|ITEM_UPLOAD|1796611119745|f66d29f20f944d1536361e09e769aa1744b5a9ba] ignored due to duplicate EventID fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/07 09:51:16 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825822848") 2025/03/07 09:51:17 DEBUG : box root 'rclone-test-paqiqox6yebi': ["file3"(0)|file|ITEM_UPLOAD|1796611119745|f66d29f20f944d1536361e09e769aa1744b5a9ba] ignored due to duplicate EventID 2025/03/07 09:51:17 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825823832") 2025/03/07 09:51:18 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825824835") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/07 09:51:19 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825825834") 2025/03/07 09:51:20 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825826832") 2025/03/07 09:51:21 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825827828") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/07 09:51:22 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825828828") 2025/03/07 09:51:23 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825829827") 2025/03/07 09:51:24 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825830832") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/07 09:51:25 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825831838") 2025/03/07 09:51:26 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825832835") 2025/03/07 09:51:27 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825833831") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/03/07 09:51:28 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825834828") 2025/03/07 09:51:29 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825835826") 2025/03/07 09:51:30 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825836827") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/03/07 09:51:31 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825837827") 2025/03/07 09:51:32 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825838824") 2025/03/07 09:51:33 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825839827") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/03/07 09:51:34 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825840824") 2025/03/07 09:51:35 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825841832") 2025/03/07 09:51:36 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825842827") fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[dir/file3:{} dir/file3.rclone_chunk.001_r4yi4m:{} dir/file3.rclone_chunk.002_r4yi4m:{} dir/file4.rclone_chunk.001_r4ya9s:{} zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/03/07 09:51:37 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825843824") 2025/03/07 09:51:38 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825844836") 2025/03/07 09:51:39 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825845824") 2025/03/07 09:51:40 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825846824") 2025/03/07 09:51:41 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825847832") 2025/03/07 09:51:42 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825848833") 2025/03/07 09:51:43 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825849835") 2025/03/07 09:51:44 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825850843") 2025/03/07 09:51:45 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825851857") 2025/03/07 09:51:46 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825852836") 2025/03/07 09:51:47 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825853856") 2025/03/07 09:51:48 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825854831") 2025/03/07 09:51:49 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825855857") 2025/03/07 09:51:50 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825856841") 2025/03/07 09:51:51 DEBUG : box root 'rclone-test-paqiqox6yebi': Checking for changes on remote (next_stream_position: "30401038825857871") === RUN TestIntegration/FsMkdir/FsPutFiles 2025/03/07 09:51:57 INFO : file name.txt.rclone_chunk.001_r4zw0g: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/07 09:51:57 INFO : file name.txt.rclone_chunk.002_r4zw0g: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/07 09:52:05 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_r505tb: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/07 09:52:06 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_r505tb: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/07 09:52:17 INFO : file name.txt.rclone_chunk.001_r50eid: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/07 09:52:18 INFO : file name.txt.rclone_chunk.002_r50eid: Moved (server-side) to: file name.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/03/07 09:52:26 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/07 09:52:26 DEBUG : Creating backend with remote "TestBox:" 2025/03/07 09:52:26 DEBUG : Reset feature "ListR" 2025/03/07 09:52:26 DEBUG : box root '': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2025/03/07 09:52:42 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_r514fy: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/03/07 09:52:42 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_r514fy: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/03/07 09:52:57 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_r51kix: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/03/07 09:52:58 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_r51kix: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/03/07 09:53:03 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi/dirToPurgeFromRoot" 2025/03/07 09:53:03 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/dirToPurgeFromRoot" 2025/03/07 09:53:04 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/07 09:53:07 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi/hello? sausage/êé" 2025/03/07 09:53:07 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/hello? sausage/êé" 2025/03/07 09:53:08 DEBUG : Reset feature "ListR" 2025/03/07 09:53:18 INFO : a/b/c/d/e.txt.rclone_chunk.001_r521x3: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/03/07 09:53:19 INFO : a/b/c/d/e.txt.rclone_chunk.002_r521x3: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/03/07 09:53:27 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy 2 data chunks... === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1289: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/03/07 09:53:39 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/03/07 09:53:40 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/03/07 09:53:40 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/03/07 09:53:41 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/03/07 09:53:47 DEBUG : file name.txt: move 2 data chunks... 2025/03/07 09:53:49 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/03/07 09:53:50 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/03/07 09:53:51 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/03/07 09:53:57 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/03/07 09:53:58 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/07 09:53:59 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/07 09:54:00 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/03/07 09:54:05 DEBUG : other.txt: move 2 data chunks... 2025/03/07 09:54:06 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/07 09:54:07 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/07 09:54:08 INFO : other.txt: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/03/07 09:54:12 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-lukedig4foci" 2025/03/07 09:54:12 DEBUG : Config file has changed externally - reloading 2025/03/07 09:54:12 DEBUG : Creating backend with remote "TestBox:rclone-test-lukedig4foci" 2025/03/07 09:54:13 DEBUG : box root 'rclone-test-lukedig4foci': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:54:13 DEBUG : Reset feature "ListR" 2025/03/07 09:54:14 DEBUG : box root 'rclone-test-lukedig4foci': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:54:20 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:54:23 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:54:29 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-lukedig4foci': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/03/07 09:55:09 INFO : file name.txt.rclone_chunk.001_r553j5: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/07 09:55:09 INFO : file name.txt.rclone_chunk.002_r553j5: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/07 09:55:10 INFO : file name.txt.rclone_chunk.003_r553j5: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/03/07 09:55:10 INFO : file name.txt.rclone_chunk.004_r553j5: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/03/07 09:55:18 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/07 09:55:18 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/07 09:55:24 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-paqiqox6yebi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-paqiqox6yebi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2025/03/07 09:55:24 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/07 09:55:24 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi/not found.txt" 2025/03/07 09:55:24 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/not found.txt" 2025/03/07 09:55:26 DEBUG : Reset feature "ListR" 2025/03/07 09:55:26 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-paqiqox6yebi" from "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi" 2025/03/07 09:55:26 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/07 09:55:26 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/03/07 09:55:33 INFO : rclone-test-paqiqox6yebi/created from root.txt.rclone_chunk.001_r55xoi: Moved (server-side) to: rclone-test-paqiqox6yebi/created from root.txt.rclone_chunk.001 2025/03/07 09:55:34 INFO : rclone-test-paqiqox6yebi/created from root.txt.rclone_chunk.002_r55xoi: Moved (server-side) to: rclone-test-paqiqox6yebi/created from root.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/03/07 09:55:57 INFO : piped data.txt.rclone_chunk.001_r56m6d: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/03/07 09:56:05 INFO : piped data.txt.rclone_chunk.001_r56rg9: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/03/07 09:56:06 INFO : piped data.txt.rclone_chunk.002_r56rg9: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/03/07 09:56:06 INFO : piped data.txt.rclone_chunk.003_r56rg9: Moved (server-side) to: piped data.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge chunker_internal_test.go:906: -upload-kilobytes is not set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat 2025/03/07 09:56:13 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-paqiqox6yebi': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/03/07 09:56:18 INFO : small/emptyfile.rclone_chunk.001_r575he: Moved (server-side) to: small/emptyfile 2025/03/07 09:56:25 INFO : small/smallfile.rclone_chunk.001_r57edd: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/03/07 09:56:40 INFO : corrupted/billy.rclone_chunk.001_r57m44: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/03/07 09:56:41 INFO : corrupted/billy.rclone_chunk.002_r57m44: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/03/07 09:56:41 INFO : corrupted/billy.rclone_chunk.003_r57m44: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/03/07 09:56:42 INFO : corrupted/billy.rclone_chunk.004_r57m44: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/03/07 09:56:42 INFO : corrupted/billy.rclone_chunk.005_r57m44: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/03/07 09:56:55 INFO : corrupted/silly1.rclone_chunk.001_r582x0: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/03/07 09:56:56 INFO : corrupted/silly1.rclone_chunk.002_r582x0: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/03/07 09:56:56 INFO : corrupted/silly1.rclone_chunk.003_r582x0: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/03/07 09:56:57 INFO : corrupted/silly1.rclone_chunk.004_r582x0: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/03/07 09:56:57 INFO : corrupted/silly1.rclone_chunk.005_r582x0: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/03/07 09:57:11 INFO : corrupted/silly2.rclone_chunk.001_r58i82: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/03/07 09:57:12 INFO : corrupted/silly2.rclone_chunk.002_r58i82: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/03/07 09:57:12 INFO : corrupted/silly2.rclone_chunk.003_r58i82: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/03/07 09:57:13 INFO : corrupted/silly2.rclone_chunk.004_r58i82: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/03/07 09:57:14 INFO : corrupted/silly2.rclone_chunk.005_r58i82: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/03/07 09:57:30 INFO : corrupted/silly3.rclone_chunk.001_r590p8: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/03/07 09:57:30 INFO : corrupted/silly3.rclone_chunk.002_r590p8: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/03/07 09:57:31 INFO : corrupted/silly3.rclone_chunk.003_r590p8: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/03/07 09:57:31 INFO : corrupted/silly3.rclone_chunk.004_r590p8: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/03/07 09:57:32 INFO : corrupted/silly3.rclone_chunk.005_r590p8: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/03/07 09:57:43 INFO : corrupted/willy.rclone_chunk.001_r59fzi: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/03/07 09:57:44 INFO : corrupted/willy.rclone_chunk.002_r59fzi: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/03/07 09:57:45 INFO : corrupted/willy.rclone_chunk.003_r59fzi: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/03/07 09:57:45 INFO : corrupted/willy.rclone_chunk.004_r59fzi: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/03/07 09:57:46 INFO : corrupted/willy.rclone_chunk.005_r59fzi: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/03/07 09:58:00 INFO : corrupted/silly4.rclone_chunk.001_r59vl6: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/03/07 09:58:01 INFO : corrupted/silly4.rclone_chunk.002_r59vl6: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/03/07 09:58:01 INFO : corrupted/silly4.rclone_chunk.003_r59vl6: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/03/07 09:58:02 INFO : corrupted/silly4.rclone_chunk.004_r59vl6: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/03/07 09:58:02 INFO : corrupted/silly4.rclone_chunk.005_r59vl6: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/03/07 09:58:07 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/03/07 09:58:17 INFO : corrupted/silly5.rclone_chunk.001_r5acjt: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/03/07 09:58:18 INFO : corrupted/silly5.rclone_chunk.002_r5acjt: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/03/07 09:58:18 INFO : corrupted/silly5.rclone_chunk.003_r5acjt: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/03/07 09:58:19 INFO : corrupted/silly5.rclone_chunk.004_r5acjt: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/03/07 09:58:19 INFO : corrupted/silly5.rclone_chunk.005_r5acjt: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/03/07 09:58:22 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2025/03/07 09:58:38 INFO : wreaked/wreaker.rclone_chunk.001_r5b1li: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/03/07 09:58:38 INFO : wreaked/wreaker.rclone_chunk.002_r5b1li: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/03/07 09:58:44 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-paqiqox6yebi': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/03/07 09:58:58 ERROR : usermeta/today.rclone_chunk.001_r5bnq3: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1796592429381","file_version":{"type":"file_version","id":"1980038462181","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_r5bnq3"}}) 2025/03/07 09:58:59 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/03/07 09:59:00 INFO : usermeta/today.rclone_chunk.001_r5bnq3: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/03/07 09:59:12 ERROR : usermeta/past.rclone_chunk.001_r5c1i3: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1796593415006","file_version":{"type":"file_version","id":"1980039630206","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_r5c1i3"}}) 2025/03/07 09:59:14 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/03/07 09:59:14 INFO : usermeta/past.rclone_chunk.001_r5c1i3: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/03/07 09:59:26 ERROR : usermeta/future.rclone_chunk.001_r5cf0c: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1796619988738","file_version":{"type":"file_version","id":"1980065822338","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_r5cf0c"}}) 2025/03/07 09:59:28 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/03/07 09:59:28 INFO : usermeta/future.rclone_chunk.001_r5cf0c: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/03/07 09:59:48 DEBUG : future/test: Can't move - required hash not found 2025/03/07 09:59:48 DEBUG : future/test: Can't move, switching to copy 2025/03/07 09:59:49 DEBUG : future/test: Can't copy - required hash not found 2025/03/07 09:59:50 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/07 09:59:50 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/07 09:59:52 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-paqiqox6yebi': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/03/07 10:00:37 INFO : backcomp/renamefile.rclone_chunk.001_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/03/07 10:00:38 INFO : backcomp/renamefile.rclone_chunk.002_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/03/07 10:00:38 INFO : backcomp/renamefile.rclone_chunk.003_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/03/07 10:00:39 INFO : backcomp/renamefile.rclone_chunk.004_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/03/07 10:00:39 INFO : backcomp/renamefile.rclone_chunk.005_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/03/07 10:00:40 INFO : backcomp/renamefile.rclone_chunk.006_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/03/07 10:00:40 INFO : backcomp/renamefile.rclone_chunk.007_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/03/07 10:00:41 INFO : backcomp/renamefile.rclone_chunk.008_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/03/07 10:00:41 INFO : backcomp/renamefile.rclone_chunk.009_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/03/07 10:00:42 INFO : backcomp/renamefile.rclone_chunk.010_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/03/07 10:00:42 INFO : backcomp/renamefile.rclone_chunk.011_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/03/07 10:00:43 INFO : backcomp/renamefile.rclone_chunk.012_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/03/07 10:00:43 INFO : backcomp/renamefile.rclone_chunk.013_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/03/07 10:00:44 INFO : backcomp/renamefile.rclone_chunk.014_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/03/07 10:00:44 INFO : backcomp/renamefile.rclone_chunk.015_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/03/07 10:00:45 INFO : backcomp/renamefile.rclone_chunk.016_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/03/07 10:00:46 INFO : backcomp/renamefile.rclone_chunk.017_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/03/07 10:00:46 INFO : backcomp/renamefile.rclone_chunk.018_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/03/07 10:00:47 INFO : backcomp/renamefile.rclone_chunk.019_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/03/07 10:00:47 INFO : backcomp/renamefile.rclone_chunk.020_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/03/07 10:00:48 INFO : backcomp/renamefile.rclone_chunk.021_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/03/07 10:00:48 INFO : backcomp/renamefile.rclone_chunk.022_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/03/07 10:00:49 INFO : backcomp/renamefile.rclone_chunk.023_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/03/07 10:00:50 INFO : backcomp/renamefile.rclone_chunk.024_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/03/07 10:00:50 INFO : backcomp/renamefile.rclone_chunk.025_r5dcfd: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/03/07 10:01:23 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi/servermovetest/subdir1" 2025/03/07 10:01:23 DEBUG : Config file has changed externally - reloading 2025/03/07 10:01:23 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/servermovetest/subdir1" 2025/03/07 10:01:25 DEBUG : Reset feature "ListR" 2025/03/07 10:01:25 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi/servermovetest/subdir2" 2025/03/07 10:01:25 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/servermovetest/subdir2" 2025/03/07 10:01:27 DEBUG : Reset feature "ListR" 2025/03/07 10:01:34 INFO : movefile.rclone_chunk.001_r5fv7l: Moved (server-side) to: movefile.rclone_chunk.001 2025/03/07 10:01:35 INFO : movefile.rclone_chunk.002_r5fv7l: Moved (server-side) to: movefile.rclone_chunk.002 2025/03/07 10:01:39 DEBUG : movefile: move 2 data chunks... 2025/03/07 10:01:41 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/03/07 10:01:42 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/03/07 10:01:43 INFO : movefile: Moved (server-side) 2025/03/07 10:01:45 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/03/07 10:01:50 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-paqiqox6yebi/md5all" 2025/03/07 10:01:50 DEBUG : Config file has changed externally - reloading 2025/03/07 10:01:50 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/03/07 10:01:50 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/md5all" 2025/03/07 10:01:52 DEBUG : Reset feature "ListR" chunker_internal_test.go:878: this test needs a base fs with slow hash, e.g. local === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *chunker.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2485: *chunker.Fs does not implement SetCopyCutoff === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/03/07 10:01:57 INFO : unknown-size-put.txt.rclone_chunk.001_r5gkuo: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/03/07 10:01:58 INFO : unknown-size-put.txt.rclone_chunk.002_r5gkuo: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/03/07 10:01:58 INFO : unknown-size-put.txt.rclone_chunk.003_r5gkuo: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/03/07 10:02:09 INFO : unknown-size-update.txt.rclone_chunk.001_r5gxcm: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/07 10:02:10 INFO : unknown-size-update.txt.rclone_chunk.002_r5gxcm: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/07 10:02:26 INFO : unknown-size-update.txt.rclone_chunk.001_r5h62o: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/07 10:02:27 INFO : unknown-size-update.txt.rclone_chunk.002_r5h62o: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/07 10:02:27 INFO : unknown-size-update.txt.rclone_chunk.003_r5h62o: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/03/07 10:02:28 INFO : unknown-size-update.txt.rclone_chunk.004_r5h62o: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/03/07 10:02:28 INFO : unknown-size-update.txt.rclone_chunk.005_r5h62o: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/03/07 10:02:36 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-paqiqox6yebi/deeper/nonexisting/directory" 2025/03/07 10:02:36 DEBUG : Creating backend with remote "TestBox:rclone-test-paqiqox6yebi/deeper/nonexisting/directory" 2025/03/07 10:02:38 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory === RUN TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata fstests.go:2742: Directories don't support ReadDirMetadata === RUN TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata fstests.go:2754: Directories don't support WriteDirMetadata === RUN TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime fstests.go:2768: Directories don't support WriteDirSetModTime === RUN TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap 2025/03/07 10:02:42 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 10:02:42 ERROR : : error listing: directory not found 2025/03/07 10:02:43 DEBUG : box root 'rclone-test-paqiqox6yebi': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1082.21s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.74s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.10s) --- FAIL: TestIntegration/FsMkdir (1077.64s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.68s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.42s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.39s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.38s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (281.89s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (14.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (14.77s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (13.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (15.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (14.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (13.89s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (12.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (14.83s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (15.06s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (14.82s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (14.13s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (14.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (15.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (19.35s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (13.88s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (14.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (15.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (14.83s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (13.98s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.65s) --- PASS: TestIntegration/FsMkdir/FsPutError (56.62s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.02s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (71.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (599.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.99s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.50s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.72s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.71s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (15.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (15.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (17.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (11.86s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (35.84s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (17.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.95s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.97s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.95s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (1.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (4.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (5.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (19.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (16.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.42s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (14.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.34s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (1.21s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (8.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (19.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (14.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (338.41s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (17.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (122.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (19.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (43.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (20.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (88.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (26.25s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (1.79s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (44.30s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (13.30s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (31.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.04s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.28s) --- 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 1082.252s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 18m4.990126969s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]