"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/27 02:14:39 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu"
2025/04/27 02:14:39 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/27 02:14:39 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu"
2025/04/27 02:14:40 DEBUG : box root 'rclone-test-wilojoy1dabu': 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/27 02:14:41 DEBUG : box root 'rclone-test-wilojoy1dabu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/27 02:14:42 DEBUG : box root 'rclone-test-wilojoy1dabu': 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/27 02:14:43 DEBUG : box root 'rclone-test-wilojoy1dabu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2025/04/27 02:14:44 INFO  : dir/subdir: Making directory
2025/04/27 02:14:47 INFO  : dir/subdir: Removing directory
2025/04/27 02:14:48 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/27 02:14:50 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/27 02:14:56 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_czutmh: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001
2025/04/27 02:14:56 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_czutmh: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:707: testing "．"
2025/04/27 02:15:09 INFO  : ．/．.rclone_chunk.001_czv6fm: Moved (server-side) to: ．/．.rclone_chunk.001
2025/04/27 02:15:09 INFO  : ．/．.rclone_chunk.002_czv6fm: Moved (server-side) to: ．/．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:707: testing "．．"
2025/04/27 02:15:21 INFO  : ．．/．．.rclone_chunk.001_czvijb: Moved (server-side) to: ．．/．．.rclone_chunk.001
2025/04/27 02:15:22 INFO  : ．．/．．.rclone_chunk.002_czvijb: Moved (server-side) to: ．．/．．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2025/04/27 02:15:33 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_czvv0x: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001
2025/04/27 02:15:34 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_czvv0x: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:707: testing " leading space"
2025/04/27 02:15:46 INFO  :  leading space/ leading space.rclone_chunk.001_czw7df: Moved (server-side) to:  leading space/ leading space.rclone_chunk.001
2025/04/27 02:15:46 INFO  :  leading space/ leading space.rclone_chunk.002_czw7df: 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/27 02:15:58 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_czwkkz: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001
2025/04/27 02:15:59 INFO  : ~leading tilde/~leading tilde.rclone_chunk.002_czwkkz: 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/27 02:16:11 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_czwwbz: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001
2025/04/27 02:16:12 INFO  : ␍leading CR/␍leading CR.rclone_chunk.002_czwwbz: 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/27 02:16:24 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_czx99i: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001
2025/04/27 02:16:24 INFO  : ␊leading LF/␊leading LF.rclone_chunk.002_czx99i: 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/27 02:16:36 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_czxla6: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001
2025/04/27 02:16:36 INFO  : ␉leading HT/␉leading HT.rclone_chunk.002_czxla6: 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/27 02:16:48 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_czxxyg: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001
2025/04/27 02:16:49 INFO  : ␋leading VT/␋leading VT.rclone_chunk.002_czxxyg: 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/27 02:17:01 INFO  : .leading dot/.leading dot.rclone_chunk.001_czyajd: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001
2025/04/27 02:17:01 INFO  : .leading dot/.leading dot.rclone_chunk.002_czyajd: 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/27 02:17:13 INFO  : trailing space /trailing space .rclone_chunk.001_czymo1: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001
2025/04/27 02:17:13 INFO  : trailing space /trailing space .rclone_chunk.002_czymo1: 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/27 02:17:25 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_czyzwb: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001
2025/04/27 02:17:26 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.002_czyzwb: 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/27 02:17:37 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_czzbhy: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001
2025/04/27 02:17:38 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.002_czzbhy: 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/27 02:17:50 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_czzna5: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001
2025/04/27 02:17:50 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.002_czzna5: 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/27 02:18:02 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_czzzuo: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001
2025/04/27 02:18:02 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.002_czzzuo: 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/27 02:18:14 INFO  : trailing dot./trailing dot..rclone_chunk.001_d00b71: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001
2025/04/27 02:18:14 INFO  : trailing dot./trailing dot..rclone_chunk.002_d00b71: 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/27 02:18:27 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_d00ofr: Moved (server-side) to: invalid utf-8�/invalid utf-8�.rclone_chunk.001
2025/04/27 02:18:27 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.002_d00ofr: 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/27 02:18:39 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_d010d4: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001
2025/04/27 02:18:39 INFO  : test%46.txt/test%46.txt.rclone_chunk.002_d010d4: 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/27 02:19:38 INFO  : zero-length-file.rclone_chunk.001_d02o60: 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/27 02:19:40 INFO  : dir: Making directory
2025/04/27 02:19:41 INFO  : dir/subdir1: Making directory
2025/04/27 02:19:42 INFO  : dir/subdir3: Making directory
2025/04/27 02:19:42 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205128658")
2025/04/27 02:19:43 INFO  : dir/subdir2: Making directory
2025/04/27 02:19:43 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205129874")
2025/04/27 02:19:44 DEBUG : box root 'rclone-test-wilojoy1dabu': ["zero-length-file.rclone_chunk.001_d02o60"(0)|file|ITEM_UPLOAD|1846563635846|0c2655ed517b5e1cf74d3da125c316878a4521ae] ignored due to old SequenceID ('\x01')
2025/04/27 02:19:44 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:19:44 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205130871")
2025/04/27 02:19:44 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205131098")
2025/04/27 02:19:45 DEBUG : box root 'rclone-test-wilojoy1dabu': ["zero-length-file"(1)|file|ITEM_RENAME|1846563635846|1b06a4579ea95fc895f35edbb3983a7736a6117f] ignored due to old SequenceID ('\x01')
2025/04/27 02:19:45 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/27 02:19:45 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205131886")
2025/04/27 02:19:45 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205132112")
2025/04/27 02:19:46 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:19:46 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205132871")
2025/04/27 02:19:46 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205133089")
2025/04/27 02:19:47 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205133872")
2025/04/27 02:19:48 DEBUG : box root 'rclone-test-wilojoy1dabu': ["dir"(0)|folder|ITEM_CREATE|318682566393|766435bd1e56e9a7b6339bb764920d388611e07c] added new path ("dir") for notify
2025/04/27 02:19:48 DEBUG : doChangeNotify("dir", 0)
2025/04/27 02:19:48 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/27 02:19:48 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205134883")
2025/04/27 02:19:48 INFO  : dir/file2.rclone_chunk.001_d02xuy: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/27 02:19:48 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205135114")
2025/04/27 02:19:48 INFO  : dir/file2.rclone_chunk.002_d02xuy: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/27 02:19:49 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205135870")
2025/04/27 02:19:50 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205136872")
2025/04/27 02:19:51 DEBUG : box root 'rclone-test-wilojoy1dabu': ["subdir2"(0)|folder|ITEM_CREATE|318681976526|31f51ddddb1a11a114a590c80418fe1a699d42f7] added new path ("dir/subdir2") for notify
2025/04/27 02:19:51 DEBUG : box root 'rclone-test-wilojoy1dabu': ["subdir3"(0)|folder|ITEM_CREATE|318681399972|4c6af546c8975e85e4235c89d88ed8b4dcfd0574] added new path ("dir/subdir3") for notify
2025/04/27 02:19:51 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/27 02:19:51 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/27 02:19:51 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/27 02:19:51 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205137875")
2025/04/27 02:19:51 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205138107")
2025/04/27 02:19:52 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205138876")
2025/04/27 02:19:53 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2.rclone_chunk.001_d02xuy"(0)|file|ITEM_UPLOAD|1846567720657|c6d32bad952a6d136f668602eaddbc7409cce2a5] ignored due to old SequenceID ('\x01')
2025/04/27 02:19:53 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/27 02:19:53 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205139877")
2025/04/27 02:19:53 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205140110")
2025/04/27 02:19:54 DEBUG : box root 'rclone-test-wilojoy1dabu': ["zero-length-file"(2)|file|ITEM_TRASH|1846563635846|a0c9b7e6b19a893652354f9ff463a3c547cd83c2] added old path ("zero-length-file") for notify
2025/04/27 02:19:54 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2.rclone_chunk.002_d02xuy"(0)|file|ITEM_UPLOAD|1846570552764|ab577cb16caaf610326a1f6cdebbc6b117620b43] ignored due to old SequenceID ('\x01')
2025/04/27 02:19:54 DEBUG : doChangeNotify("zero-length-file", 1)
2025/04/27 02:19:54 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/27 02:19:54 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205140879")
2025/04/27 02:19:54 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205141114")
2025/04/27 02:19:54 INFO  : dir/file4.rclone_chunk.001_d034z0: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/27 02:19:55 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1846570552764|c0446dde3e7d2648cacbe61e6821cdca1542c186] ignored due to old SequenceID ('\x01')
2025/04/27 02:19:55 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:19:55 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205141875")
2025/04/27 02:19:55 INFO  : dir/file4.rclone_chunk.002_d034z0: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/27 02:19:55 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205142091")
2025/04/27 02:19:56 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205142870")
2025/04/27 02:19:57 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2"(0)|file|ITEM_UPLOAD|1846565968258|57f710808c5d7bb457011272842638574b0ae279] ignored due to old SequenceID ('\x00')
2025/04/27 02:19:57 DEBUG : box root 'rclone-test-wilojoy1dabu': ["subdir1"(0)|folder|ITEM_CREATE|318682177920|81a3c94980a2265dde6286b2625016f6ca0807ba] ignored due to old SequenceID ('\x00')
2025/04/27 02:19:57 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/27 02:19:57 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205143875")
2025/04/27 02:19:57 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205144109")
2025/04/27 02:19:58 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205144874")
2025/04/27 02:19:59 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file4.rclone_chunk.001_d034z0"(0)|file|ITEM_UPLOAD|1846570237943|c6b42fb4277d3afd132b6153be21b3cda4009d29] ignored due to old SequenceID ('\x01')
2025/04/27 02:19:59 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:19:59 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205145870")
2025/04/27 02:19:59 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205146098")
2025/04/27 02:20:00 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file4.rclone_chunk.002_d034z0"(0)|file|ITEM_UPLOAD|1846563716692|d68e41875f27dd10a213265eeec544b1138b613a] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:00 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:00 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205146872")
2025/04/27 02:20:00 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205147182")
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1846563716692|da3ce81f54a3eea488ac48eefcdc14c34f3dbace] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205147873")
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1846570237943|dc761b522136906f3fe2eea3678450d627a1596d] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205148093")
2025/04/27 02:20:01 INFO  : dir/file3.rclone_chunk.001_d03a84: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1846567720657|3ccc54e0a4563feb1c3a7ac4b8dcdf9de8893c33] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205148310")
2025/04/27 02:20:01 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205148543")
2025/04/27 02:20:01 INFO  : dir/file3.rclone_chunk.002_d03a84: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/27 02:20:02 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205148874")
2025/04/27 02:20:03 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file4"(0)|file|ITEM_UPLOAD|1846564252201|53253bc9ed3fe3f10476125c7b7c137745214b43] ignored due to old SequenceID ('\x00')
2025/04/27 02:20:03 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:03 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205149871")
2025/04/27 02:20:03 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205150088")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/27 02:20:04 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205150871")
2025/04/27 02:20:05 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205151875")
2025/04/27 02:20:06 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205152872")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/27 02:20:07 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205153871")
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1846569340352|d4b4d0050ddff79933b96a74708a80ca8da215c4] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1846568415847|13ae6b03db54e914b35ee9e63f94f34a24b7d411] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205154874")
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file3"(0)|file|ITEM_UPLOAD|1846567168009|c69e177b486657720c7a000eeee3cbb6dc7733ea] ignored due to old SequenceID ('\x00')
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205155098")
2025/04/27 02:20:08 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205155331")
2025/04/27 02:20:09 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205155872")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/27 02:20:10 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205156872")
2025/04/27 02:20:11 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205157877")
2025/04/27 02:20:12 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205158873")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/27 02:20:13 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205159873")
2025/04/27 02:20:14 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205160875")
2025/04/27 02:20:15 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file3.rclone_chunk.001_d03a84"(0)|file|ITEM_UPLOAD|1846569340352|f988b0b86ae01a1c2d99c51e45f2e03b1d4e1006] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:15 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:15 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205161873")
2025/04/27 02:20:15 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205162097")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/27 02:20:16 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205162872")
2025/04/27 02:20:17 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205163872")
2025/04/27 02:20:18 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205164872")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/27 02:20:19 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205165873")
2025/04/27 02:20:20 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205166872")
2025/04/27 02:20:21 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205167874")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/27 02:20:22 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205168871")
2025/04/27 02:20:23 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205169871")
2025/04/27 02:20:24 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205170872")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/27 02:20:25 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205171878")
2025/04/27 02:20:26 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205172873")
2025/04/27 02:20:27 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205173872")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/27 02:20:28 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205174873")
2025/04/27 02:20:29 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205175874")
2025/04/27 02:20:30 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205176878")
    fstests.go:935: map[dir:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/27 02:20:31 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205177871")
2025/04/27 02:20:32 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205178872")
2025/04/27 02:20:33 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205179875")
2025/04/27 02:20:34 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file3.rclone_chunk.002_d03a84"(0)|file|ITEM_UPLOAD|1846568415847|18519180891e411f704b159492c3969035d560ef] ignored due to old SequenceID ('\x01')
2025/04/27 02:20:34 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/27 02:20:34 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205180872")
2025/04/27 02:20:34 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205181097")
2025/04/27 02:20:35 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205181875")
2025/04/27 02:20:36 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205182872")
2025/04/27 02:20:37 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205183873")
2025/04/27 02:20:38 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205184874")
2025/04/27 02:20:39 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2"(1)|file|ITEM_TRASH|1846565968258|993fe4fdb9154c9362a234e7988df56cc7f382d3] added old path ("dir/file2") for notify
2025/04/27 02:20:39 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/27 02:20:39 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/27 02:20:39 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205185877")
2025/04/27 02:20:39 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205186103")
2025/04/27 02:20:40 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205186873")
2025/04/27 02:20:41 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1846570552764|c1e8540a2e46ecbe9b7e5a3fb455a5bf78ef52c2] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/27 02:20:41 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1846567720657|db87041bd073e310c87fdf8cc2bd553134b44179] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/27 02:20:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/27 02:20:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/27 02:20:41 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/27 02:20:41 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205187872")
2025/04/27 02:20:41 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205188111")
2025/04/27 02:20:42 DEBUG : box root 'rclone-test-wilojoy1dabu': ["file4"(1)|file|ITEM_TRASH|1846564252201|d910be53d5c024105926b5b18ba1ad2226801a36] added old path ("dir/file4") for notify
2025/04/27 02:20:42 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/27 02:20:42 DEBUG : box root 'rclone-test-wilojoy1dabu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/27 02:20:42 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205188873")
2025/04/27 02:20:42 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205189109")
2025/04/27 02:20:43 DEBUG : box root 'rclone-test-wilojoy1dabu': Checking for changes on remote (next_stream_position: "30401043205189872")
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/04/27 02:20:48 INFO  : file name.txt.rclone_chunk.001_d04lnk: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/27 02:20:48 INFO  : file name.txt.rclone_chunk.002_d04lnk: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/27 02:20:55 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_d04sm8: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/04/27 02:20:55 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_d04sm8: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/04/27 02:21:05 INFO  : file name.txt.rclone_chunk.001_d050as: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/27 02:21:05 INFO  : file name.txt.rclone_chunk.002_d050as: 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/27 02:21:12 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:"
2025/04/27 02:21:12 DEBUG : Config file has changed externally - reloading
2025/04/27 02:21:12 DEBUG : Creating backend with remote "TestBox:"
2025/04/27 02:21:13 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/27 02:21:27 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.001_d05n71: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001
2025/04/27 02:21:27 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.002_d05n71: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2025/04/27 02:21:39 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_d0602n: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001
2025/04/27 02:21:40 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_d0602n: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002
2025/04/27 02:21:44 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu/dirToPurgeFromRoot"
2025/04/27 02:21:44 DEBUG : Config file has changed externally - reloading
2025/04/27 02:21:44 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/dirToPurgeFromRoot"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2025/04/27 02:21:47 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu/hello? sausage/êé"
2025/04/27 02:21:47 DEBUG : Config file has changed externally - reloading
2025/04/27 02:21:47 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/hello? sausage/êé"
2025/04/27 02:21:56 INFO  : a/b/c/d/e.txt.rclone_chunk.001_d06eco: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001
2025/04/27 02:21:57 INFO  : a/b/c/d/e.txt.rclone_chunk.002_d06eco: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2025/04/27 02:22:05 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/27 02:22:16 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks...
2025/04/27 02:22:17 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001
2025/04/27 02:22:17 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002
2025/04/27 02:22:18 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt
2025/04/27 02:22:23 DEBUG : file name.txt: move 2 data chunks...
2025/04/27 02:22:24 INFO  : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001
2025/04/27 02:22:25 INFO  : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002
2025/04/27 02:22:26 INFO  : file name.txt: Moved (server-side) to: moveTest/other.txt
2025/04/27 02:22:31 DEBUG : moveTest/other.txt: move 2 data chunks...
2025/04/27 02:22:32 INFO  : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/27 02:22:32 INFO  : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/27 02:22:33 INFO  : moveTest/other.txt: Moved (server-side) to: file name.txt
2025/04/27 02:22:38 DEBUG : other.txt: move 2 data chunks...
2025/04/27 02:22:39 INFO  : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/04/27 02:22:40 INFO  : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/04/27 02:22:41 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/27 02:22:44 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-kezawit0mara"
2025/04/27 02:22:44 DEBUG : Creating backend with remote "TestBox:rclone-test-kezawit0mara"
2025/04/27 02:22:45 DEBUG : box root 'rclone-test-kezawit0mara': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/27 02:22:46 DEBUG : box root 'rclone-test-kezawit0mara': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/27 02:22:51 DEBUG : box root 'rclone-test-wilojoy1dabu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/27 02:22:53 DEBUG : box root 'rclone-test-wilojoy1dabu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/27 02:22:59 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-kezawit0mara': 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/27 02:23:33 INFO  : file name.txt.rclone_chunk.001_d0917i: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/27 02:23:33 INFO  : file name.txt.rclone_chunk.002_d0917i: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/27 02:23:34 INFO  : file name.txt.rclone_chunk.003_d0917i: Moved (server-side) to: file name.txt.rclone_chunk.003
2025/04/27 02:23:34 INFO  : file name.txt.rclone_chunk.004_d0917i: Moved (server-side) to: file name.txt.rclone_chunk.004
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2025/04/27 02:23:41 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/04/27 02:23:41 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/04/27 02:23:45 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-wilojoy1dabu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-wilojoy1dabu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2025/04/27 02:23:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu/not found.txt"
2025/04/27 02:23:46 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/not found.txt"
2025/04/27 02:23:48 ERROR : : error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-wilojoy1dabu" from "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu"
2025/04/27 02:23:48 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/27 02:23:54 INFO  : rclone-test-wilojoy1dabu/created from root.txt.rclone_chunk.001_d09ry3: Moved (server-side) to: rclone-test-wilojoy1dabu/created from root.txt.rclone_chunk.001
2025/04/27 02:23:55 INFO  : rclone-test-wilojoy1dabu/created from root.txt.rclone_chunk.002_d09ry3: Moved (server-side) to: rclone-test-wilojoy1dabu/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/27 02:24:15 INFO  : piped data.txt.rclone_chunk.001_d0adr4: Moved (server-side) to: piped data.txt
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2025/04/27 02:24:21 INFO  : piped data.txt.rclone_chunk.001_d0aii8: Moved (server-side) to: piped data.txt.rclone_chunk.001
2025/04/27 02:24:22 INFO  : piped data.txt.rclone_chunk.002_d0aii8: Moved (server-side) to: piped data.txt.rclone_chunk.002
2025/04/27 02:24:22 INFO  : piped data.txt.rclone_chunk.003_d0aii8: 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/27 02:24:28 INFO  : Chunked 'TestChunkerChunk50bBox:rclone-test-wilojoy1dabu': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2025/04/27 02:24:32 INFO  : small/emptyfile.rclone_chunk.001_d0auhi: Moved (server-side) to: small/emptyfile
2025/04/27 02:24:39 INFO  : small/smallfile.rclone_chunk.001_d0b1fn: Moved (server-side) to: small/smallfile
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
2025/04/27 02:24:51 INFO  : corrupted/billy.rclone_chunk.001_d0b8sc: Moved (server-side) to: corrupted/billy.rclone_chunk.001
2025/04/27 02:24:52 INFO  : corrupted/billy.rclone_chunk.002_d0b8sc: Moved (server-side) to: corrupted/billy.rclone_chunk.002
2025/04/27 02:24:52 INFO  : corrupted/billy.rclone_chunk.003_d0b8sc: Moved (server-side) to: corrupted/billy.rclone_chunk.003
2025/04/27 02:24:53 INFO  : corrupted/billy.rclone_chunk.004_d0b8sc: Moved (server-side) to: corrupted/billy.rclone_chunk.004
2025/04/27 02:24:53 INFO  : corrupted/billy.rclone_chunk.005_d0b8sc: Moved (server-side) to: corrupted/billy.rclone_chunk.005
2025/04/27 02:25:03 INFO  : corrupted/silly1.rclone_chunk.001_d0blt8: Moved (server-side) to: corrupted/silly1.rclone_chunk.001
2025/04/27 02:25:04 INFO  : corrupted/silly1.rclone_chunk.002_d0blt8: Moved (server-side) to: corrupted/silly1.rclone_chunk.002
2025/04/27 02:25:05 INFO  : corrupted/silly1.rclone_chunk.003_d0blt8: Moved (server-side) to: corrupted/silly1.rclone_chunk.003
2025/04/27 02:25:05 INFO  : corrupted/silly1.rclone_chunk.004_d0blt8: Moved (server-side) to: corrupted/silly1.rclone_chunk.004
2025/04/27 02:25:06 INFO  : corrupted/silly1.rclone_chunk.005_d0blt8: Moved (server-side) to: corrupted/silly1.rclone_chunk.005
2025/04/27 02:25:17 INFO  : corrupted/silly2.rclone_chunk.001_d0by8w: Moved (server-side) to: corrupted/silly2.rclone_chunk.001
2025/04/27 02:25:18 INFO  : corrupted/silly2.rclone_chunk.002_d0by8w: Moved (server-side) to: corrupted/silly2.rclone_chunk.002
2025/04/27 02:25:18 INFO  : corrupted/silly2.rclone_chunk.003_d0by8w: Moved (server-side) to: corrupted/silly2.rclone_chunk.003
2025/04/27 02:25:18 INFO  : corrupted/silly2.rclone_chunk.004_d0by8w: Moved (server-side) to: corrupted/silly2.rclone_chunk.004
2025/04/27 02:25:19 INFO  : corrupted/silly2.rclone_chunk.005_d0by8w: Moved (server-side) to: corrupted/silly2.rclone_chunk.005
2025/04/27 02:25:32 INFO  : corrupted/silly3.rclone_chunk.001_d0cegy: Moved (server-side) to: corrupted/silly3.rclone_chunk.001
2025/04/27 02:25:33 INFO  : corrupted/silly3.rclone_chunk.002_d0cegy: Moved (server-side) to: corrupted/silly3.rclone_chunk.002
2025/04/27 02:25:33 INFO  : corrupted/silly3.rclone_chunk.003_d0cegy: Moved (server-side) to: corrupted/silly3.rclone_chunk.003
2025/04/27 02:25:34 INFO  : corrupted/silly3.rclone_chunk.004_d0cegy: Moved (server-side) to: corrupted/silly3.rclone_chunk.004
2025/04/27 02:25:34 INFO  : corrupted/silly3.rclone_chunk.005_d0cegy: Moved (server-side) to: corrupted/silly3.rclone_chunk.005
2025/04/27 02:25:45 INFO  : corrupted/willy.rclone_chunk.001_d0cqdy: Moved (server-side) to: corrupted/willy.rclone_chunk.001
2025/04/27 02:25:45 INFO  : corrupted/willy.rclone_chunk.002_d0cqdy: Moved (server-side) to: corrupted/willy.rclone_chunk.002
2025/04/27 02:25:46 INFO  : corrupted/willy.rclone_chunk.003_d0cqdy: Moved (server-side) to: corrupted/willy.rclone_chunk.003
2025/04/27 02:25:46 INFO  : corrupted/willy.rclone_chunk.004_d0cqdy: Moved (server-side) to: corrupted/willy.rclone_chunk.004
2025/04/27 02:25:47 INFO  : corrupted/willy.rclone_chunk.005_d0cqdy: Moved (server-side) to: corrupted/willy.rclone_chunk.005
2025/04/27 02:25:58 INFO  : corrupted/silly4.rclone_chunk.001_d0d3fi: Moved (server-side) to: corrupted/silly4.rclone_chunk.001
2025/04/27 02:25:59 INFO  : corrupted/silly4.rclone_chunk.002_d0d3fi: Moved (server-side) to: corrupted/silly4.rclone_chunk.002
2025/04/27 02:25:59 INFO  : corrupted/silly4.rclone_chunk.003_d0d3fi: Moved (server-side) to: corrupted/silly4.rclone_chunk.003
2025/04/27 02:26:00 INFO  : corrupted/silly4.rclone_chunk.004_d0d3fi: Moved (server-side) to: corrupted/silly4.rclone_chunk.004
2025/04/27 02:26:00 INFO  : corrupted/silly4.rclone_chunk.005_d0d3fi: Moved (server-side) to: corrupted/silly4.rclone_chunk.005
2025/04/27 02:26:04 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy"
2025/04/27 02:26:12 INFO  : corrupted/silly5.rclone_chunk.001_d0dhbq: Moved (server-side) to: corrupted/silly5.rclone_chunk.001
2025/04/27 02:26:12 INFO  : corrupted/silly5.rclone_chunk.002_d0dhbq: Moved (server-side) to: corrupted/silly5.rclone_chunk.002
2025/04/27 02:26:13 INFO  : corrupted/silly5.rclone_chunk.003_d0dhbq: Moved (server-side) to: corrupted/silly5.rclone_chunk.003
2025/04/27 02:26:13 INFO  : corrupted/silly5.rclone_chunk.004_d0dhbq: Moved (server-side) to: corrupted/silly5.rclone_chunk.004
2025/04/27 02:26:14 INFO  : corrupted/silly5.rclone_chunk.005_d0dhbq: Moved (server-side) to: corrupted/silly5.rclone_chunk.005
2025/04/27 02:26:16 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/27 02:26:31 INFO  : wreaked/wreaker.rclone_chunk.001_d0e43o: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001
2025/04/27 02:26:32 INFO  : wreaked/wreaker.rclone_chunk.002_d0e43o: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002
2025/04/27 02:26:36 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-wilojoy1dabu': invalid directory entry "wreaked/wreaker"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2025/04/27 02:26:48 ERROR : usermeta/today.rclone_chunk.001_d0eno7: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1846569395997","file_version":{"type":"file_version","id":"2035968410397","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_d0eno7"}})
2025/04/27 02:26:49 INFO  : usermeta/today.rclone_chunk.001: Deleted
2025/04/27 02:26:50 INFO  : usermeta/today.rclone_chunk.001_d0eno7: Moved (server-side) to: usermeta/today.rclone_chunk.001
2025/04/27 02:27:00 ERROR : usermeta/past.rclone_chunk.001_d0ezw5: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1846570878960","file_version":{"type":"file_version","id":"2035969970160","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_d0ezw5"}})
2025/04/27 02:27:02 INFO  : usermeta/past.rclone_chunk.001: Deleted
2025/04/27 02:27:02 INFO  : usermeta/past.rclone_chunk.001_d0ezw5: Moved (server-side) to: usermeta/past.rclone_chunk.001
2025/04/27 02:27:12 ERROR : usermeta/future.rclone_chunk.001_d0fbk7: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1846569445803","file_version":{"type":"file_version","id":"2035968484203","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_d0fbk7"}})
2025/04/27 02:27:14 INFO  : usermeta/future.rclone_chunk.001: Deleted
2025/04/27 02:27:14 INFO  : usermeta/future.rclone_chunk.001_d0fbk7: Moved (server-side) to: usermeta/future.rclone_chunk.001
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof
2025/04/27 02:27:31 DEBUG : future/test: Can't move - required hash not found
2025/04/27 02:27:31 DEBUG : future/test: Can't move, switching to copy
2025/04/27 02:27:32 DEBUG : future/test: Can't copy - required hash not found
2025/04/27 02:27:33 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/04/27 02:27:33 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/04/27 02:27:34 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-wilojoy1dabu': File to upload is small (3 bytes), uploading instead of streaming
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility
2025/04/27 02:28:12 INFO  : backcomp/renamefile.rclone_chunk.001_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001
2025/04/27 02:28:13 INFO  : backcomp/renamefile.rclone_chunk.002_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002
2025/04/27 02:28:13 INFO  : backcomp/renamefile.rclone_chunk.003_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003
2025/04/27 02:28:13 INFO  : backcomp/renamefile.rclone_chunk.004_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004
2025/04/27 02:28:14 INFO  : backcomp/renamefile.rclone_chunk.005_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005
2025/04/27 02:28:14 INFO  : backcomp/renamefile.rclone_chunk.006_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006
2025/04/27 02:28:15 INFO  : backcomp/renamefile.rclone_chunk.007_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007
2025/04/27 02:28:15 INFO  : backcomp/renamefile.rclone_chunk.008_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008
2025/04/27 02:28:16 INFO  : backcomp/renamefile.rclone_chunk.009_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009
2025/04/27 02:28:16 INFO  : backcomp/renamefile.rclone_chunk.010_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010
2025/04/27 02:28:17 INFO  : backcomp/renamefile.rclone_chunk.011_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011
2025/04/27 02:28:17 INFO  : backcomp/renamefile.rclone_chunk.012_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012
2025/04/27 02:28:18 INFO  : backcomp/renamefile.rclone_chunk.013_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013
2025/04/27 02:28:18 INFO  : backcomp/renamefile.rclone_chunk.014_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014
2025/04/27 02:28:19 INFO  : backcomp/renamefile.rclone_chunk.015_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015
2025/04/27 02:28:19 INFO  : backcomp/renamefile.rclone_chunk.016_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016
2025/04/27 02:28:19 INFO  : backcomp/renamefile.rclone_chunk.017_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017
2025/04/27 02:28:20 INFO  : backcomp/renamefile.rclone_chunk.018_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018
2025/04/27 02:28:20 INFO  : backcomp/renamefile.rclone_chunk.019_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019
2025/04/27 02:28:21 INFO  : backcomp/renamefile.rclone_chunk.020_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020
2025/04/27 02:28:21 INFO  : backcomp/renamefile.rclone_chunk.021_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021
2025/04/27 02:28:22 INFO  : backcomp/renamefile.rclone_chunk.022_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022
2025/04/27 02:28:22 INFO  : backcomp/renamefile.rclone_chunk.023_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023
2025/04/27 02:28:23 INFO  : backcomp/renamefile.rclone_chunk.024_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024
2025/04/27 02:28:23 INFO  : backcomp/renamefile.rclone_chunk.025_d0g3bm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove
2025/04/27 02:28:52 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu/servermovetest/subdir1"
2025/04/27 02:28:52 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/servermovetest/subdir1"
2025/04/27 02:28:54 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu/servermovetest/subdir2"
2025/04/27 02:28:54 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/servermovetest/subdir2"
2025/04/27 02:29:09 INFO  : movefile.rclone_chunk.001_d0i9co: Moved (server-side) to: movefile.rclone_chunk.001
2025/04/27 02:29:09 INFO  : movefile.rclone_chunk.002_d0i9co: Moved (server-side) to: movefile.rclone_chunk.002
2025/04/27 02:29:13 DEBUG : movefile: move 2 data chunks...
2025/04/27 02:29:15 INFO  : movefile.rclone_chunk.001: Moved (server-side)
2025/04/27 02:29:16 INFO  : movefile.rclone_chunk.002: Moved (server-side)
2025/04/27 02:29:17 INFO  : movefile: Moved (server-side)
2025/04/27 02:29:18 INFO  : movefile: Moved (server-side)
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow
2025/04/27 02:29:22 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-wilojoy1dabu/md5all"
2025/04/27 02:29:22 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name
2025/04/27 02:29:22 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/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/27 02:29:29 INFO  : unknown-size-put.txt.rclone_chunk.001_d0j1iz: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001
2025/04/27 02:29:29 INFO  : unknown-size-put.txt.rclone_chunk.002_d0j1iz: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002
2025/04/27 02:29:30 INFO  : unknown-size-put.txt.rclone_chunk.003_d0j1iz: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2025/04/27 02:29:39 INFO  : unknown-size-update.txt.rclone_chunk.001_d0jddt: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/04/27 02:29:40 INFO  : unknown-size-update.txt.rclone_chunk.002_d0jddt: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/04/27 02:29:54 INFO  : unknown-size-update.txt.rclone_chunk.001_d0jl51: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/04/27 02:29:54 INFO  : unknown-size-update.txt.rclone_chunk.002_d0jl51: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/04/27 02:29:54 INFO  : unknown-size-update.txt.rclone_chunk.003_d0jl51: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003
2025/04/27 02:29:55 INFO  : unknown-size-update.txt.rclone_chunk.004_d0jl51: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004
2025/04/27 02:29:55 INFO  : unknown-size-update.txt.rclone_chunk.005_d0jl51: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2025/04/27 02:30:03 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-wilojoy1dabu/deeper/nonexisting/directory"
2025/04/27 02:30:03 DEBUG : Creating backend with remote "TestBox:rclone-test-wilojoy1dabu/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/27 02:30:10 DEBUG : box root 'rclone-test-wilojoy1dabu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/27 02:30:10 ERROR : : error listing: directory not found
2025/04/27 02:30:10 DEBUG : box root 'rclone-test-wilojoy1dabu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsShutdown
--- FAIL: TestIntegration (931.11s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (0.45s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (0.55s)
    --- FAIL: TestIntegration/FsMkdir (927.58s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (5.18s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.33s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.31s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.31s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (235.91s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (13.29s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (12.48s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (12.12s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (12.41s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (12.49s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (12.92s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (12.35s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (12.41s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (12.30s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (12.49s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (12.26s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (12.48s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (12.06s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (12.30s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (12.18s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (11.98s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (12.57s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (12.09s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (12.40s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.61s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (48.10s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (5.47s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (63.62s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (519.86s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.65s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.67s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.27s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.48s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.67s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.64s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.65s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.91s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.14s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.23s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.65s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (12.66s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (13.18s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (15.45s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (11.18s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (30.28s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (15.07s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.37s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.89s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.91s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.90s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.89s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.89s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.90s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.90s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.91s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (2.99s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.90s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (2.93s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.29s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.42s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.33s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (17.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.91s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (4.88s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.40s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (15.26s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.68s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.34s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (13.24s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (4.72s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.91s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (7.39s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.26s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (16.39s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (4.57s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (11.83s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (295.56s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (14.51s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (103.99s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (16.02s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (37.29s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (17.47s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (74.69s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (30.00s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (1.57s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (39.15s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (11.65s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (27.50s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.92s)
        --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsDirectory (1.93s)
            --- 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	931.167s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 15m33.716283456s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]