"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/04/25 05:32:17 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu"
2025/04/25 05:32:17 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/25 05:32:17 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu"
2025/04/25 05:32:17 DEBUG : TestBox: Loaded invalid token from config file - ignoring
2025/04/25 05:32:18 DEBUG : Saving config "token" in section "TestBox" of the config file
2025/04/25 05:32:18 DEBUG : TestBox: Saved new token in config file
2025/04/25 05:32:18 DEBUG : box root 'rclone-test-horoxup8demu': 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/04/25 05:32:19 DEBUG : box root 'rclone-test-horoxup8demu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/25 05:32:20 DEBUG : box root 'rclone-test-horoxup8demu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsString
=== RUN   TestIntegration/FsName
=== RUN   TestIntegration/FsRoot
=== RUN   TestIntegration/FsRmdirEmpty
=== RUN   TestIntegration/FsMkdir
2025/04/25 05:32:22 DEBUG : box root 'rclone-test-horoxup8demu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2025/04/25 05:32:23 INFO  : dir/subdir: Making directory
2025/04/25 05:32:26 INFO  : dir/subdir: Removing directory
2025/04/25 05:32:28 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/04/25 05:32:31 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/04/25 05:32:37 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_9jo9vm: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001
2025/04/25 05:32:37 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_9jo9vm: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:707: testing "．"
2025/04/25 05:32:52 INFO  : ．/．.rclone_chunk.001_9joptf: Moved (server-side) to: ．/．.rclone_chunk.001
2025/04/25 05:32:52 INFO  : ．/．.rclone_chunk.002_9joptf: Moved (server-side) to: ．/．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:707: testing "．．"
2025/04/25 05:33:07 INFO  : ．．/．．.rclone_chunk.001_9jp41p: Moved (server-side) to: ．．/．．.rclone_chunk.001
2025/04/25 05:33:08 INFO  : ．．/．．.rclone_chunk.002_9jp41p: Moved (server-side) to: ．．/．．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2025/04/25 05:33:22 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_9jpivx: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001
2025/04/25 05:33:22 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_9jpivx: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:707: testing " leading space"
2025/04/25 05:33:37 INFO  :  leading space/ leading space.rclone_chunk.001_9jpy0x: Moved (server-side) to:  leading space/ leading space.rclone_chunk.001
2025/04/25 05:33:38 INFO  :  leading space/ leading space.rclone_chunk.002_9jpy0x: Moved (server-side) to:  leading space/ leading space.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:707: testing "~leading tilde"
2025/04/25 05:33:53 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_9jqd7z: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001
2025/04/25 05:33:53 INFO  : ~leading tilde/~leading tilde.rclone_chunk.002_9jqd7z: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:707: testing "␍leading CR"
2025/04/25 05:34:07 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_9jqs1o: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001
2025/04/25 05:34:08 INFO  : ␍leading CR/␍leading CR.rclone_chunk.002_9jqs1o: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:707: testing "␊leading LF"
2025/04/25 05:34:23 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_9jr7xq: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001
2025/04/25 05:34:23 INFO  : ␊leading LF/␊leading LF.rclone_chunk.002_9jr7xq: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:707: testing "␉leading HT"
2025/04/25 05:34:38 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_9jrm8k: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001
2025/04/25 05:34:38 INFO  : ␉leading HT/␉leading HT.rclone_chunk.002_9jrm8k: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:707: testing "␋leading VT"
2025/04/25 05:34:53 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_9js1ha: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001
2025/04/25 05:34:53 INFO  : ␋leading VT/␋leading VT.rclone_chunk.002_9js1ha: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:707: testing ".leading dot"
2025/04/25 05:35:08 INFO  : .leading dot/.leading dot.rclone_chunk.001_9jsgp7: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001
2025/04/25 05:35:08 INFO  : .leading dot/.leading dot.rclone_chunk.002_9jsgp7: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:707: testing "trailing space "
2025/04/25 05:35:23 INFO  : trailing space /trailing space .rclone_chunk.001_9jsvzi: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001
2025/04/25 05:35:24 INFO  : trailing space /trailing space .rclone_chunk.002_9jsvzi: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:707: testing "trailing CR␍"
2025/04/25 05:35:38 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_9jtacj: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001
2025/04/25 05:35:38 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.002_9jtacj: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:707: testing "trailing LF␊"
2025/04/25 05:35:52 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_9jtp95: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001
2025/04/25 05:35:53 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.002_9jtp95: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:707: testing "trailing HT␉"
2025/04/25 05:36:08 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_9ju41w: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001
2025/04/25 05:36:08 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.002_9ju41w: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:707: testing "trailing VT␋"
2025/04/25 05:36:22 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_9jujjt: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001
2025/04/25 05:36:23 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.002_9jujjt: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:707: testing "trailing dot."
2025/04/25 05:36:37 INFO  : trailing dot./trailing dot..rclone_chunk.001_9juybg: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001
2025/04/25 05:36:38 INFO  : trailing dot./trailing dot..rclone_chunk.002_9juybg: 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/04/25 05:36:52 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_9jvdn9: Moved (server-side) to: invalid utf-8�/invalid utf-8�.rclone_chunk.001
2025/04/25 05:36:53 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.002_9jvdn9: 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/04/25 05:37:07 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_9jvrnx: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001
2025/04/25 05:37:07 INFO  : test%46.txt/test%46.txt.rclone_chunk.002_9jvrnx: 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/04/25 05:38:20 INFO  : zero-length-file.rclone_chunk.001_9jxukf: 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/04/25 05:38:23 INFO  : dir: Making directory
2025/04/25 05:38:25 INFO  : dir/subdir1: Making directory
2025/04/25 05:38:26 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044251897")
2025/04/25 05:38:26 INFO  : dir/subdir3: Making directory
2025/04/25 05:38:27 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044253119")
2025/04/25 05:38:27 INFO  : dir/subdir2: Making directory
2025/04/25 05:38:28 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044254135")
2025/04/25 05:38:28 DEBUG : box root 'rclone-test-horoxup8demu': ["zero-length-file"(1)|file|ITEM_RENAME|1844902934399|a481a600af32330e3d082c171c2f85f8968effc7] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:28 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:28 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044255129")
2025/04/25 05:38:29 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044255373")
2025/04/25 05:38:30 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044256144")
2025/04/25 05:38:31 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044257131")
2025/04/25 05:38:31 DEBUG : box root 'rclone-test-horoxup8demu': ["dir"(0)|folder|ITEM_CREATE|318421943538|2a75f9d721192173dd178b5395c19616f5f3f345] added new path ("dir") for notify
2025/04/25 05:38:31 DEBUG : box root 'rclone-test-horoxup8demu': ["zero-length-file"(2)|file|ITEM_TRASH|1844902934399|742a2d2cf1b1b0c0e5859d7ae41330263fdd3420] added old path ("zero-length-file") for notify
2025/04/25 05:38:31 DEBUG : doChangeNotify("dir", 0)
2025/04/25 05:38:31 DEBUG : doChangeNotify("zero-length-file", 1)
2025/04/25 05:38:31 DEBUG : box root 'rclone-test-horoxup8demu': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/25 05:38:31 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044258138")
2025/04/25 05:38:32 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044258391")
2025/04/25 05:38:32 DEBUG : box root 'rclone-test-horoxup8demu': ["subdir1"(0)|folder|ITEM_CREATE|318422578913|1755221c28a1272e1f2f21340b398f2c18fa2cc8] added new path ("dir/subdir1") for notify
2025/04/25 05:38:32 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/25 05:38:32 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:38:32 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044259128")
2025/04/25 05:38:32 INFO  : dir/file2.rclone_chunk.001_9jy5kn: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/25 05:38:33 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044259368")
2025/04/25 05:38:33 INFO  : dir/file2.rclone_chunk.002_9jy5kn: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/25 05:38:34 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044260125")
2025/04/25 05:38:34 DEBUG : box root 'rclone-test-horoxup8demu': ["subdir3"(0)|folder|ITEM_CREATE|318420784602|41348b2cad334c555c97e007148289b0cb5ceb34] added new path ("dir/subdir3") for notify
2025/04/25 05:38:34 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/25 05:38:34 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:38:34 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044261127")
2025/04/25 05:38:35 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044261361")
2025/04/25 05:38:36 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044262126")
2025/04/25 05:38:36 DEBUG : box root 'rclone-test-horoxup8demu': ["subdir2"(0)|folder|ITEM_CREATE|318423692643|ede7dc5832d813cfaf3f6b65f3da6b2a62682199] ignored due to old SequenceID ('\x00')
2025/04/25 05:38:36 DEBUG : box root 'rclone-test-horoxup8demu': ["file2.rclone_chunk.001_9jy5kn"(0)|file|ITEM_UPLOAD|1844910853288|0767643e970eeff1309e6a61f65769b2d9007246] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:36 DEBUG : box root 'rclone-test-horoxup8demu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:36 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044263120")
2025/04/25 05:38:37 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044263354")
2025/04/25 05:38:38 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044264127")
2025/04/25 05:38:39 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044265129")
2025/04/25 05:38:39 DEBUG : box root 'rclone-test-horoxup8demu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1844910853288|f64c30de47ebed99d4474c42cf2db35c95407443] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:39 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:39 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044266130")
2025/04/25 05:38:40 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044266366")
2025/04/25 05:38:40 INFO  : dir/file4.rclone_chunk.001_9jydi1: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/25 05:38:41 INFO  : dir/file4.rclone_chunk.002_9jydi1: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/25 05:38:41 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044267121")
2025/04/25 05:38:42 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044268132")
2025/04/25 05:38:43 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044269122")
2025/04/25 05:38:44 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044270134")
2025/04/25 05:38:44 DEBUG : box root 'rclone-test-horoxup8demu': ["file2.rclone_chunk.002_9jy5kn"(0)|file|ITEM_UPLOAD|1844909816519|e70c199a1e432cda088fc250b2bc8d79cf1e2c74] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:44 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:44 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044271129")
2025/04/25 05:38:44 DEBUG : box root 'rclone-test-horoxup8demu': ["file4.rclone_chunk.001_9jydi1"(0)|file|ITEM_UPLOAD|1844904369079|499a48745017c05bf2559fc7593cd69e6d95e8a1] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:44 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:44 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044271360")
2025/04/25 05:38:45 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044271592")
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044272129")
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': ["file4.rclone_chunk.002_9jydi1"(0)|file|ITEM_UPLOAD|1844910762437|5470e949e7999ad4c6c00d545d5667355624cf7e] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044273123")
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1844904369079|94b5b39919f5a4b0ba6554bdb3e445a55a19b277] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044273352")
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': ["file2"(0)|file|ITEM_UPLOAD|1844911612777|1ddc092c53590af08a0eb24068f1d2747e2df63b] ignored due to old SequenceID ('\x00')
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:46 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044273590")
2025/04/25 05:38:47 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044273840")
2025/04/25 05:38:47 DEBUG : box root 'rclone-test-horoxup8demu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1844910762437|0bcaf3452c9253c80014716682a1399d21d47b10] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:47 DEBUG : box root 'rclone-test-horoxup8demu': ["file4"(0)|file|ITEM_UPLOAD|1844900338848|f1bb6df974b12dbb7898f7faaaa4b2e2c95d6066] ignored due to old SequenceID ('\x00')
2025/04/25 05:38:47 DEBUG : box root 'rclone-test-horoxup8demu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:47 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044274135")
2025/04/25 05:38:48 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044274380")
2025/04/25 05:38:48 INFO  : dir/file3.rclone_chunk.001_9jylc4: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/25 05:38:48 DEBUG : box root 'rclone-test-horoxup8demu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1844909816519|93fa15a019e890f78a033f1250d908411ae6f0dc] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:48 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:48 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044275135")
2025/04/25 05:38:48 INFO  : dir/file3.rclone_chunk.002_9jylc4: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/25 05:38:49 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044275374")
2025/04/25 05:38:50 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044276127")
2025/04/25 05:38:51 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044277124")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/25 05:38:52 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044278121")
2025/04/25 05:38:52 DEBUG : box root 'rclone-test-horoxup8demu': ["file3.rclone_chunk.001_9jylc4"(0)|file|ITEM_UPLOAD|1844899990804|68ed59ef783464b1966f1bbc96b84a32c7e7a988] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:52 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:52 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044279131")
2025/04/25 05:38:53 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044279364")
2025/04/25 05:38:54 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044280131")
2025/04/25 05:38:54 DEBUG : box root 'rclone-test-horoxup8demu': ["file3.rclone_chunk.002_9jylc4"(0)|file|ITEM_UPLOAD|1844902417297|29b403406b2908a1f430996c49e9a1b2d25be3a6] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:54 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:54 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044281158")
2025/04/25 05:38:54 DEBUG : box root 'rclone-test-horoxup8demu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1844902417297|20526d33f03087c16315d77bb9762b7988c1dbc4] ignored due to old SequenceID ('\x01')
2025/04/25 05:38:54 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:54 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044281393")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/25 05:38:55 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044281629")
2025/04/25 05:38:56 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044282122")
2025/04/25 05:38:57 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044283125")
2025/04/25 05:38:57 DEBUG : box root 'rclone-test-horoxup8demu': ["file3"(0)|file|ITEM_UPLOAD|1844901573070|ed1661b80318287a68a97a46a82140de98645c01] ignored due to old SequenceID ('\x00')
2025/04/25 05:38:57 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:38:57 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044284131")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/25 05:38:58 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044284369")
2025/04/25 05:38:59 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044285121")
2025/04/25 05:39:00 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044286127")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/25 05:39:01 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044287127")
2025/04/25 05:39:01 DEBUG : box root 'rclone-test-horoxup8demu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1844899990804|3622c16d7078348d2d20e320a643a895593a15f7] ignored due to old SequenceID ('\x01')
2025/04/25 05:39:01 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/25 05:39:01 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044288124")
2025/04/25 05:39:02 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044288383")
2025/04/25 05:39:03 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044289128")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/25 05:39:04 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044290127")
2025/04/25 05:39:05 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044291122")
2025/04/25 05:39:06 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044292130")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/25 05:39:07 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044293122")
2025/04/25 05:39:08 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044294131")
2025/04/25 05:39:09 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044295133")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/25 05:39:10 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044296125")
2025/04/25 05:39:11 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044297124")
2025/04/25 05:39:12 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044298126")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/25 05:39:13 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044299131")
2025/04/25 05:39:14 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044300132")
2025/04/25 05:39:15 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044301123")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/25 05:39:16 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044302126")
2025/04/25 05:39:17 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044303127")
2025/04/25 05:39:18 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044304127")
    fstests.go:935: map[dir:{} dir/subdir1:{} 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/04/25 05:39:19 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044305130")
2025/04/25 05:39:20 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044306135")
2025/04/25 05:39:21 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044307127")
2025/04/25 05:39:22 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044308136")
2025/04/25 05:39:23 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044309129")
2025/04/25 05:39:24 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044310127")
2025/04/25 05:39:25 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044311126")
2025/04/25 05:39:26 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044312125")
2025/04/25 05:39:27 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044313121")
2025/04/25 05:39:27 DEBUG : box root 'rclone-test-horoxup8demu': ["file2"(1)|file|ITEM_TRASH|1844911612777|1e7f03f7f2c0d41a915cfb98fd8cc6c8cac54071] added old path ("dir/file2") for notify
2025/04/25 05:39:27 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/25 05:39:27 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:39:27 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044314125")
2025/04/25 05:39:28 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044314353")
2025/04/25 05:39:28 DEBUG : box root 'rclone-test-horoxup8demu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1844910853288|9aff5a4b1944a08be7dafd73af2fd659c4ed17db] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/25 05:39:28 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/25 05:39:28 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:39:28 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044315120")
2025/04/25 05:39:29 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044315368")
2025/04/25 05:39:30 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044316122")
2025/04/25 05:39:30 DEBUG : box root 'rclone-test-horoxup8demu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1844909816519|22301dd536798a1804e481e95508af908f37475f] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/25 05:39:30 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/25 05:39:30 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:39:30 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044317119")
2025/04/25 05:39:31 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044317354")
2025/04/25 05:39:31 DEBUG : box root 'rclone-test-horoxup8demu': ["file4"(1)|file|ITEM_TRASH|1844900338848|b9b611ea53a6fe087a68e669134cd2697e5c6e86] added old path ("dir/file4") for notify
2025/04/25 05:39:31 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/25 05:39:31 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:39:31 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044318122")
2025/04/25 05:39:32 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044318352")
2025/04/25 05:39:32 DEBUG : box root 'rclone-test-horoxup8demu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1844904369079|3373edaaf87cc98a76f211bf2cdc478b417c0655] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/25 05:39:32 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/25 05:39:32 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:39:32 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044319130")
2025/04/25 05:39:33 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044319361")
2025/04/25 05:39:33 DEBUG : box root 'rclone-test-horoxup8demu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1844910762437|7df2ea3df465e0e6a04b4862cceb26d1594a6909] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/25 05:39:33 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/25 05:39:33 DEBUG : box root 'rclone-test-horoxup8demu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/25 05:39:33 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044320142")
2025/04/25 05:39:34 DEBUG : box root 'rclone-test-horoxup8demu': Checking for changes on remote (next_stream_position: "30401043044320376")
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/04/25 05:39:39 INFO  : file name.txt.rclone_chunk.001_9jzzka: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/25 05:39:39 INFO  : file name.txt.rclone_chunk.002_9jzzka: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/25 05:39:47 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_9k07lq: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/04/25 05:39:48 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_9k07lq: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/04/25 05:40:00 INFO  : file name.txt.rclone_chunk.001_9k0hf6: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/25 05:40:00 INFO  : file name.txt.rclone_chunk.002_9k0hf6: 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/04/25 05:40:08 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:"
2025/04/25 05:40:08 DEBUG : Creating backend with remote "TestBox:"
2025/04/25 05:40:09 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/04/25 05:40:25 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.001_9k18v3: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001
2025/04/25 05:40:26 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.002_9k18v3: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2025/04/25 05:40:40 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_9k1nex: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001
2025/04/25 05:40:40 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_9k1nex: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002
2025/04/25 05:40:45 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu/dirToPurgeFromRoot"
2025/04/25 05:40:45 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/dirToPurgeFromRoot"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2025/04/25 05:40:51 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu/hello? sausage/êé"
2025/04/25 05:40:51 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/hello? sausage/êé"
2025/04/25 05:41:02 INFO  : a/b/c/d/e.txt.rclone_chunk.001_9k25zq: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001
2025/04/25 05:41:03 INFO  : a/b/c/d/e.txt.rclone_chunk.002_9k25zq: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2025/04/25 05:41:11 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/04/25 05:41:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks...
2025/04/25 05:41:26 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001
2025/04/25 05:41:27 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002
2025/04/25 05:41:28 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt
2025/04/25 05:41:33 DEBUG : file name.txt: move 2 data chunks...
2025/04/25 05:41:35 INFO  : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001
2025/04/25 05:41:36 INFO  : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002
2025/04/25 05:41:38 INFO  : file name.txt: Moved (server-side) to: moveTest/other.txt
2025/04/25 05:41:43 DEBUG : moveTest/other.txt: move 2 data chunks...
2025/04/25 05:41:44 INFO  : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/25 05:41:44 INFO  : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/25 05:41:45 INFO  : moveTest/other.txt: Moved (server-side) to: file name.txt
2025/04/25 05:41:51 DEBUG : other.txt: move 2 data chunks...
2025/04/25 05:41:52 INFO  : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/04/25 05:41:53 INFO  : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/04/25 05:41:54 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/04/25 05:41:58 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-zomabos6tahe"
2025/04/25 05:41:58 DEBUG : Creating backend with remote "TestBox:rclone-test-zomabos6tahe"
2025/04/25 05:41:59 DEBUG : box root 'rclone-test-zomabos6tahe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/25 05:42:00 DEBUG : box root 'rclone-test-zomabos6tahe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/25 05:42:06 DEBUG : box root 'rclone-test-horoxup8demu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/25 05:42:09 DEBUG : box root 'rclone-test-horoxup8demu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/25 05:42:16 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-zomabos6tahe': 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/04/25 05:42:55 INFO  : file name.txt.rclone_chunk.001_9k5ara: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/25 05:42:55 INFO  : file name.txt.rclone_chunk.002_9k5ara: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/25 05:42:56 INFO  : file name.txt.rclone_chunk.003_9k5ara: Moved (server-side) to: file name.txt.rclone_chunk.003
2025/04/25 05:42:56 INFO  : file name.txt.rclone_chunk.004_9k5ara: Moved (server-side) to: file name.txt.rclone_chunk.004
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2025/04/25 05:43:04 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/04/25 05:43:04 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/04/25 05:43:09 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-horoxup8demu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-horoxup8demu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2025/04/25 05:43:10 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu/not found.txt"
2025/04/25 05:43:10 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/not found.txt"
2025/04/25 05:43:12 ERROR : : error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-horoxup8demu" from "TestChunkerChunk50bBox:rclone-test-horoxup8demu"
2025/04/25 05:43:12 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/04/25 05:43:21 INFO  : rclone-test-horoxup8demu/created from root.txt.rclone_chunk.001_9k6577: Moved (server-side) to: rclone-test-horoxup8demu/created from root.txt.rclone_chunk.001
2025/04/25 05:43:22 INFO  : rclone-test-horoxup8demu/created from root.txt.rclone_chunk.002_9k6577: Moved (server-side) to: rclone-test-horoxup8demu/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/04/25 05:43:46 INFO  : piped data.txt.rclone_chunk.001_9k6wc8: Moved (server-side) to: piped data.txt
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2025/04/25 05:43:55 INFO  : piped data.txt.rclone_chunk.001_9k72ui: Moved (server-side) to: piped data.txt.rclone_chunk.001
2025/04/25 05:43:56 INFO  : piped data.txt.rclone_chunk.002_9k72ui: Moved (server-side) to: piped data.txt.rclone_chunk.002
2025/04/25 05:43:56 INFO  : piped data.txt.rclone_chunk.003_9k72ui: 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/04/25 05:44:04 INFO  : Chunked 'TestChunkerChunk50bBox:rclone-test-horoxup8demu': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2025/04/25 05:44:09 INFO  : small/emptyfile.rclone_chunk.001_9k7h4f: Moved (server-side) to: small/emptyfile
2025/04/25 05:44:16 INFO  : small/smallfile.rclone_chunk.001_9k7qqm: Moved (server-side) to: small/smallfile
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
2025/04/25 05:44:32 INFO  : corrupted/billy.rclone_chunk.001_9k7zuz: Moved (server-side) to: corrupted/billy.rclone_chunk.001
2025/04/25 05:44:33 INFO  : corrupted/billy.rclone_chunk.002_9k7zuz: Moved (server-side) to: corrupted/billy.rclone_chunk.002
2025/04/25 05:44:33 INFO  : corrupted/billy.rclone_chunk.003_9k7zuz: Moved (server-side) to: corrupted/billy.rclone_chunk.003
2025/04/25 05:44:34 INFO  : corrupted/billy.rclone_chunk.004_9k7zuz: Moved (server-side) to: corrupted/billy.rclone_chunk.004
2025/04/25 05:44:34 INFO  : corrupted/billy.rclone_chunk.005_9k7zuz: Moved (server-side) to: corrupted/billy.rclone_chunk.005
2025/04/25 05:44:47 INFO  : corrupted/silly1.rclone_chunk.001_9k8env: Moved (server-side) to: corrupted/silly1.rclone_chunk.001
2025/04/25 05:44:47 INFO  : corrupted/silly1.rclone_chunk.002_9k8env: Moved (server-side) to: corrupted/silly1.rclone_chunk.002
2025/04/25 05:44:48 INFO  : corrupted/silly1.rclone_chunk.003_9k8env: Moved (server-side) to: corrupted/silly1.rclone_chunk.003
2025/04/25 05:44:49 INFO  : corrupted/silly1.rclone_chunk.004_9k8env: Moved (server-side) to: corrupted/silly1.rclone_chunk.004
2025/04/25 05:44:49 INFO  : corrupted/silly1.rclone_chunk.005_9k8env: Moved (server-side) to: corrupted/silly1.rclone_chunk.005
2025/04/25 05:45:03 INFO  : corrupted/silly2.rclone_chunk.001_9k8u6r: Moved (server-side) to: corrupted/silly2.rclone_chunk.001
2025/04/25 05:45:03 INFO  : corrupted/silly2.rclone_chunk.002_9k8u6r: Moved (server-side) to: corrupted/silly2.rclone_chunk.002
2025/04/25 05:45:04 INFO  : corrupted/silly2.rclone_chunk.003_9k8u6r: Moved (server-side) to: corrupted/silly2.rclone_chunk.003
2025/04/25 05:45:04 INFO  : corrupted/silly2.rclone_chunk.004_9k8u6r: Moved (server-side) to: corrupted/silly2.rclone_chunk.004
2025/04/25 05:45:05 INFO  : corrupted/silly2.rclone_chunk.005_9k8u6r: Moved (server-side) to: corrupted/silly2.rclone_chunk.005
2025/04/25 05:45:21 INFO  : corrupted/silly3.rclone_chunk.001_9k9cnh: Moved (server-side) to: corrupted/silly3.rclone_chunk.001
2025/04/25 05:45:21 INFO  : corrupted/silly3.rclone_chunk.002_9k9cnh: Moved (server-side) to: corrupted/silly3.rclone_chunk.002
2025/04/25 05:45:22 INFO  : corrupted/silly3.rclone_chunk.003_9k9cnh: Moved (server-side) to: corrupted/silly3.rclone_chunk.003
2025/04/25 05:45:23 INFO  : corrupted/silly3.rclone_chunk.004_9k9cnh: Moved (server-side) to: corrupted/silly3.rclone_chunk.004
2025/04/25 05:45:23 INFO  : corrupted/silly3.rclone_chunk.005_9k9cnh: Moved (server-side) to: corrupted/silly3.rclone_chunk.005
2025/04/25 05:45:36 INFO  : corrupted/willy.rclone_chunk.001_9k9rok: Moved (server-side) to: corrupted/willy.rclone_chunk.001
2025/04/25 05:45:36 INFO  : corrupted/willy.rclone_chunk.002_9k9rok: Moved (server-side) to: corrupted/willy.rclone_chunk.002
2025/04/25 05:45:37 INFO  : corrupted/willy.rclone_chunk.003_9k9rok: Moved (server-side) to: corrupted/willy.rclone_chunk.003
2025/04/25 05:45:38 INFO  : corrupted/willy.rclone_chunk.004_9k9rok: Moved (server-side) to: corrupted/willy.rclone_chunk.004
2025/04/25 05:45:38 INFO  : corrupted/willy.rclone_chunk.005_9k9rok: Moved (server-side) to: corrupted/willy.rclone_chunk.005
2025/04/25 05:45:53 INFO  : corrupted/silly4.rclone_chunk.001_9ka8lj: Moved (server-side) to: corrupted/silly4.rclone_chunk.001
2025/04/25 05:45:53 INFO  : corrupted/silly4.rclone_chunk.002_9ka8lj: Moved (server-side) to: corrupted/silly4.rclone_chunk.002
2025/04/25 05:45:54 INFO  : corrupted/silly4.rclone_chunk.003_9ka8lj: Moved (server-side) to: corrupted/silly4.rclone_chunk.003
2025/04/25 05:45:54 INFO  : corrupted/silly4.rclone_chunk.004_9ka8lj: Moved (server-side) to: corrupted/silly4.rclone_chunk.004
2025/04/25 05:45:55 INFO  : corrupted/silly4.rclone_chunk.005_9ka8lj: Moved (server-side) to: corrupted/silly4.rclone_chunk.005
2025/04/25 05:45:59 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy"
2025/04/25 05:46:09 INFO  : corrupted/silly5.rclone_chunk.001_9kaooz: Moved (server-side) to: corrupted/silly5.rclone_chunk.001
2025/04/25 05:46:09 INFO  : corrupted/silly5.rclone_chunk.002_9kaooz: Moved (server-side) to: corrupted/silly5.rclone_chunk.002
2025/04/25 05:46:10 INFO  : corrupted/silly5.rclone_chunk.003_9kaooz: Moved (server-side) to: corrupted/silly5.rclone_chunk.003
2025/04/25 05:46:11 INFO  : corrupted/silly5.rclone_chunk.004_9kaooz: Moved (server-side) to: corrupted/silly5.rclone_chunk.004
2025/04/25 05:46:11 INFO  : corrupted/silly5.rclone_chunk.005_9kaooz: Moved (server-side) to: corrupted/silly5.rclone_chunk.005
2025/04/25 05:46:14 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow
2025/04/25 05:46:35 INFO  : wreaked/wreaker.rclone_chunk.001_9kbjly: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001
2025/04/25 05:46:36 INFO  : wreaked/wreaker.rclone_chunk.002_9kbjly: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002
2025/04/25 05:46:41 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-horoxup8demu': invalid directory entry "wreaked/wreaker"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2025/04/25 05:46:56 ERROR : usermeta/today.rclone_chunk.001_9kc6lt: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1844912060520","file_version":{"type":"file_version","id":"2034170701320","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_9kc6lt"}})
2025/04/25 05:46:58 INFO  : usermeta/today.rclone_chunk.001: Deleted
2025/04/25 05:46:58 INFO  : usermeta/today.rclone_chunk.001_9kc6lt: Moved (server-side) to: usermeta/today.rclone_chunk.001
2025/04/25 05:47:10 ERROR : usermeta/past.rclone_chunk.001_9kcls5: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1844920628699","file_version":{"type":"file_version","id":"2034179403899","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_9kcls5"}})
2025/04/25 05:47:12 INFO  : usermeta/past.rclone_chunk.001: Deleted
2025/04/25 05:47:13 INFO  : usermeta/past.rclone_chunk.001_9kcls5: Moved (server-side) to: usermeta/past.rclone_chunk.001
2025/04/25 05:47:24 ERROR : usermeta/future.rclone_chunk.001_9kczwk: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1844911405879","file_version":{"type":"file_version","id":"2034170029879","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_9kczwk"}})
2025/04/25 05:47:26 INFO  : usermeta/future.rclone_chunk.001: Deleted
2025/04/25 05:47:27 INFO  : usermeta/future.rclone_chunk.001_9kczwk: Moved (server-side) to: usermeta/future.rclone_chunk.001
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof
2025/04/25 05:47:47 DEBUG : future/test: Can't move - required hash not found
2025/04/25 05:47:47 DEBUG : future/test: Can't move, switching to copy
2025/04/25 05:47:48 DEBUG : future/test: Can't copy - required hash not found
2025/04/25 05:47:49 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/04/25 05:47:49 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/04/25 05:47:51 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-horoxup8demu': File to upload is small (3 bytes), uploading instead of streaming
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility
2025/04/25 05:48:36 INFO  : backcomp/renamefile.rclone_chunk.001_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001
2025/04/25 05:48:37 INFO  : backcomp/renamefile.rclone_chunk.002_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002
2025/04/25 05:48:38 INFO  : backcomp/renamefile.rclone_chunk.003_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003
2025/04/25 05:48:38 INFO  : backcomp/renamefile.rclone_chunk.004_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004
2025/04/25 05:48:39 INFO  : backcomp/renamefile.rclone_chunk.005_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005
2025/04/25 05:48:39 INFO  : backcomp/renamefile.rclone_chunk.006_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006
2025/04/25 05:48:40 INFO  : backcomp/renamefile.rclone_chunk.007_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007
2025/04/25 05:48:40 INFO  : backcomp/renamefile.rclone_chunk.008_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008
2025/04/25 05:48:41 INFO  : backcomp/renamefile.rclone_chunk.009_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009
2025/04/25 05:48:42 INFO  : backcomp/renamefile.rclone_chunk.010_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010
2025/04/25 05:48:42 INFO  : backcomp/renamefile.rclone_chunk.011_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011
2025/04/25 05:48:43 INFO  : backcomp/renamefile.rclone_chunk.012_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012
2025/04/25 05:48:43 INFO  : backcomp/renamefile.rclone_chunk.013_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013
2025/04/25 05:48:44 INFO  : backcomp/renamefile.rclone_chunk.014_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014
2025/04/25 05:48:45 INFO  : backcomp/renamefile.rclone_chunk.015_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015
2025/04/25 05:48:45 INFO  : backcomp/renamefile.rclone_chunk.016_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016
2025/04/25 05:48:46 INFO  : backcomp/renamefile.rclone_chunk.017_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017
2025/04/25 05:48:46 INFO  : backcomp/renamefile.rclone_chunk.018_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018
2025/04/25 05:48:47 INFO  : backcomp/renamefile.rclone_chunk.019_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019
2025/04/25 05:48:47 INFO  : backcomp/renamefile.rclone_chunk.020_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020
2025/04/25 05:48:48 INFO  : backcomp/renamefile.rclone_chunk.021_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021
2025/04/25 05:48:48 INFO  : backcomp/renamefile.rclone_chunk.022_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022
2025/04/25 05:48:49 INFO  : backcomp/renamefile.rclone_chunk.023_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023
2025/04/25 05:48:50 INFO  : backcomp/renamefile.rclone_chunk.024_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024
2025/04/25 05:48:50 INFO  : backcomp/renamefile.rclone_chunk.025_9kdw3d: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove
2025/04/25 05:49:27 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu/servermovetest/subdir1"
2025/04/25 05:49:27 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/servermovetest/subdir1"
2025/04/25 05:49:29 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu/servermovetest/subdir2"
2025/04/25 05:49:29 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/servermovetest/subdir2"
2025/04/25 05:49:38 INFO  : movefile.rclone_chunk.001_9kgki9: Moved (server-side) to: movefile.rclone_chunk.001
2025/04/25 05:49:39 INFO  : movefile.rclone_chunk.002_9kgki9: Moved (server-side) to: movefile.rclone_chunk.002
2025/04/25 05:49:44 DEBUG : movefile: move 2 data chunks...
2025/04/25 05:49:47 INFO  : movefile.rclone_chunk.001: Moved (server-side)
2025/04/25 05:49:48 INFO  : movefile.rclone_chunk.002: Moved (server-side)
2025/04/25 05:49:49 INFO  : movefile: Moved (server-side)
2025/04/25 05:49:50 INFO  : movefile: Moved (server-side)
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow
2025/04/25 05:49:55 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-horoxup8demu/md5all"
2025/04/25 05:49:55 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name
2025/04/25 05:49:55 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/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/04/25 05:50:03 INFO  : unknown-size-put.txt.rclone_chunk.001_9kha7l: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001
2025/04/25 05:50:04 INFO  : unknown-size-put.txt.rclone_chunk.002_9kha7l: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002
2025/04/25 05:50:04 INFO  : unknown-size-put.txt.rclone_chunk.003_9kha7l: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2025/04/25 05:50:16 INFO  : unknown-size-update.txt.rclone_chunk.001_9kho4i: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/04/25 05:50:16 INFO  : unknown-size-update.txt.rclone_chunk.002_9kho4i: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/04/25 05:50:33 INFO  : unknown-size-update.txt.rclone_chunk.001_9khyyx: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/04/25 05:50:34 INFO  : unknown-size-update.txt.rclone_chunk.002_9khyyx: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/04/25 05:50:34 INFO  : unknown-size-update.txt.rclone_chunk.003_9khyyx: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003
2025/04/25 05:50:35 INFO  : unknown-size-update.txt.rclone_chunk.004_9khyyx: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004
2025/04/25 05:50:35 INFO  : unknown-size-update.txt.rclone_chunk.005_9khyyx: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2025/04/25 05:50:44 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-horoxup8demu/deeper/nonexisting/directory"
2025/04/25 05:50:44 DEBUG : Creating backend with remote "TestBox:rclone-test-horoxup8demu/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/04/25 05:50:53 DEBUG : box root 'rclone-test-horoxup8demu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/25 05:50:53 ERROR : : error listing: directory not found
2025/04/25 05:50:53 DEBUG : box root 'rclone-test-horoxup8demu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsShutdown
--- FAIL: TestIntegration (1116.08s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (0.56s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (0.89s)
    --- FAIL: TestIntegration/FsMkdir (1111.54s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.41s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.34s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.35s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.36s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (284.93s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (15.11s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (15.14s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (14.75s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (15.14s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (15.10s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (15.43s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (14.96s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (14.89s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (15.20s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (15.19s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (15.08s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (14.91s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (14.72s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (14.96s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (14.92s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (14.87s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (14.86s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (14.72s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (14.62s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.72s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (60.48s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.62s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (70.68s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (622.92s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.93s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.86s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.54s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.60s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.80s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.76s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.95s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.05s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.55s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.55s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.93s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.33s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (14.85s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (16.72s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (18.90s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (13.52s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (35.21s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (18.39s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.38s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (1.01s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (1.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (1.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (1.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (1.07s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (1.05s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (1.02s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.97s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.53s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.98s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.20s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.74s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.86s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.58s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (19.69s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.02s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.85s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.71s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (20.54s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (2.87s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.39s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (17.28s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (6.36s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (1.06s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (8.84s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.30s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (20.84s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.58s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (15.26s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (353.17s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (17.46s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (128.08s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (20.25s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (44.70s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (20.37s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (92.57s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (27.82s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (1.91s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (47.10s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (14.05s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (33.05s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (3.19s)
        --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsDirectory (2.45s)
            --- 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	1116.148s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 18m39.120668174s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]