"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/29 02:20:21 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati"
2025/04/29 02:20:21 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/29 02:20:21 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati"
2025/04/29 02:20:21 DEBUG : box root 'rclone-test-huporud9yati': 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/29 02:20:22 DEBUG : box root 'rclone-test-huporud9yati': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/29 02:20:22 DEBUG : box root 'rclone-test-huporud9yati': 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/29 02:20:25 DEBUG : box root 'rclone-test-huporud9yati': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2025/04/29 02:20:25 INFO  : dir/subdir: Making directory
2025/04/29 02:20:28 INFO  : dir/subdir: Removing directory
2025/04/29 02:20:30 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/29 02:20:32 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/29 02:20:37 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_gpgbh2: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001
2025/04/29 02:20:38 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_gpgbh2: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:707: testing "．"
2025/04/29 02:20:50 INFO  : ．/．.rclone_chunk.001_gpgn7r: Moved (server-side) to: ．/．.rclone_chunk.001
2025/04/29 02:20:51 INFO  : ．/．.rclone_chunk.002_gpgn7r: Moved (server-side) to: ．/．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:707: testing "．．"
2025/04/29 02:21:03 INFO  : ．．/．．.rclone_chunk.001_gph0cc: Moved (server-side) to: ．．/．．.rclone_chunk.001
2025/04/29 02:21:03 INFO  : ．．/．．.rclone_chunk.002_gph0cc: Moved (server-side) to: ．．/．．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2025/04/29 02:21:16 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_gphdi0: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001
2025/04/29 02:21:16 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_gphdi0: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:707: testing " leading space"
2025/04/29 02:21:29 INFO  :  leading space/ leading space.rclone_chunk.001_gphqbq: Moved (server-side) to:  leading space/ leading space.rclone_chunk.001
2025/04/29 02:21:29 INFO  :  leading space/ leading space.rclone_chunk.002_gphqbq: 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/29 02:21:43 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_gpi3c8: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001
2025/04/29 02:21:43 INFO  : ~leading tilde/~leading tilde.rclone_chunk.002_gpi3c8: 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/29 02:21:56 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_gpihcl: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001
2025/04/29 02:21:56 INFO  : ␍leading CR/␍leading CR.rclone_chunk.002_gpihcl: 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/29 02:22:09 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_gpiu9f: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001
2025/04/29 02:22:10 INFO  : ␊leading LF/␊leading LF.rclone_chunk.002_gpiu9f: 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/29 02:22:22 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_gpj7i7: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001
2025/04/29 02:22:22 INFO  : ␉leading HT/␉leading HT.rclone_chunk.002_gpj7i7: 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/29 02:22:35 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_gpjk1x: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001
2025/04/29 02:22:35 INFO  : ␋leading VT/␋leading VT.rclone_chunk.002_gpjk1x: 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/29 02:22:48 INFO  : .leading dot/.leading dot.rclone_chunk.001_gpjxet: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001
2025/04/29 02:22:48 INFO  : .leading dot/.leading dot.rclone_chunk.002_gpjxet: 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/29 02:23:00 INFO  : trailing space /trailing space .rclone_chunk.001_gpka6s: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001
2025/04/29 02:23:01 INFO  : trailing space /trailing space .rclone_chunk.002_gpka6s: 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/29 02:23:14 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_gpkn2e: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001
2025/04/29 02:23:14 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.002_gpkn2e: 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/29 02:23:27 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_gpl0ic: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001
2025/04/29 02:23:27 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.002_gpl0ic: 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/29 02:23:39 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_gpld41: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001
2025/04/29 02:23:40 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.002_gpld41: 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/29 02:23:52 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_gplq7k: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001
2025/04/29 02:23:53 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.002_gplq7k: 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/29 02:24:06 INFO  : trailing dot./trailing dot..rclone_chunk.001_gpm39s: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001
2025/04/29 02:24:06 INFO  : trailing dot./trailing dot..rclone_chunk.002_gpm39s: 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/29 02:24:18 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_gpmge5: Moved (server-side) to: invalid utf-8�/invalid utf-8�.rclone_chunk.001
2025/04/29 02:24:19 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.002_gpmge5: 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/29 02:24:32 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_gpmtf3: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001
2025/04/29 02:24:32 INFO  : test%46.txt/test%46.txt.rclone_chunk.002_gpmtf3: 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/29 02:25:36 INFO  : zero-length-file.rclone_chunk.001_gpom2u: 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/29 02:25:38 INFO  : dir: Making directory
2025/04/29 02:25:40 INFO  : dir/subdir1: Making directory
2025/04/29 02:25:41 INFO  : dir/subdir3: Making directory
2025/04/29 02:25:41 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378286897")
2025/04/29 02:25:42 INFO  : dir/subdir2: Making directory
2025/04/29 02:25:42 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378288118")
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378289116")
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378290126")
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': ["zero-length-file"(1)|file|ITEM_RENAME|1848163203930|09a8cf0d84c39bc54aa8df176305fef6a3fe813f] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378290363")
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:43 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378290587")
2025/04/29 02:25:44 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378290813")
2025/04/29 02:25:44 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:44 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378291115")
2025/04/29 02:25:45 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378291335")
2025/04/29 02:25:45 DEBUG : box root 'rclone-test-huporud9yati': ["zero-length-file"(2)|file|ITEM_TRASH|1848163203930|c0379c064498b53ba14b483e9fcdaa49644be81b] added old path ("zero-length-file") for notify
2025/04/29 02:25:45 DEBUG : doChangeNotify("zero-length-file", 1)
2025/04/29 02:25:45 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/29 02:25:45 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378292119")
2025/04/29 02:25:46 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378292343")
2025/04/29 02:25:46 INFO  : dir/file2.rclone_chunk.001_gpowg7: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/29 02:25:47 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378293113")
2025/04/29 02:25:47 INFO  : dir/file2.rclone_chunk.002_gpowg7: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/29 02:25:47 DEBUG : box root 'rclone-test-huporud9yati': ["subdir1"(0)|folder|ITEM_CREATE|318938063695|d07faef1679277ece799f2df6f362ba751e6dec6] added new path ("dir/subdir1") for notify
2025/04/29 02:25:47 DEBUG : box root 'rclone-test-huporud9yati': ["zero-length-file.rclone_chunk.001_gpom2u"(0)|file|ITEM_UPLOAD|1848163203930|7d9b0d31d11384811465e5d1cfc326174f49da13] added new path ("zero-length-file.rclone_chunk.001_gpom2u") for notify
2025/04/29 02:25:47 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/29 02:25:47 DEBUG : doChangeNotify("zero-length-file.rclone_chunk.001_gpom2u", 1)
2025/04/29 02:25:47 DEBUG : box root 'rclone-test-huporud9yati': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/29 02:25:47 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378294118")
2025/04/29 02:25:48 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378294348")
2025/04/29 02:25:49 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378295127")
2025/04/29 02:25:49 DEBUG : box root 'rclone-test-huporud9yati': ["subdir3"(0)|folder|ITEM_CREATE|318937358356|9ed1559a94b5920a6f665fa68848c78e0082d6a5] added new path ("dir/subdir3") for notify
2025/04/29 02:25:49 DEBUG : box root 'rclone-test-huporud9yati': ["subdir2"(0)|folder|ITEM_CREATE|318938310254|78e38b88390feeacb1253af52630342a0c2c3f9e] added new path ("dir/subdir2") for notify
2025/04/29 02:25:49 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/29 02:25:49 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/29 02:25:49 DEBUG : box root 'rclone-test-huporud9yati': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/29 02:25:49 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378296115")
2025/04/29 02:25:50 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378296344")
2025/04/29 02:25:50 DEBUG : box root 'rclone-test-huporud9yati': ["file2.rclone_chunk.001_gpowg7"(0)|file|ITEM_UPLOAD|1848160998006|64f84a768860a61b91b4ea3984c8d5c6c7fae1e4] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:50 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:50 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378297115")
2025/04/29 02:25:51 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378297339")
2025/04/29 02:25:52 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378298118")
2025/04/29 02:25:52 DEBUG : box root 'rclone-test-huporud9yati': ["file2.rclone_chunk.002_gpowg7"(0)|file|ITEM_UPLOAD|1848161490779|ebbefce1241c08d46b5619ac09daf9ca26ccf505] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:52 DEBUG : box root 'rclone-test-huporud9yati': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1848160998006|f54e9b4ef803936c9a781e94103e80da405c98e3] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:52 DEBUG : box root 'rclone-test-huporud9yati': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:52 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378299117")
2025/04/29 02:25:53 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378299347")
2025/04/29 02:25:53 DEBUG : box root 'rclone-test-huporud9yati': ["dir"(0)|folder|ITEM_CREATE|318937352481|cff7d2eb9a331be827ef08735dc3e2faed7c4663] added new path ("dir") for notify
2025/04/29 02:25:53 DEBUG : doChangeNotify("dir", 0)
2025/04/29 02:25:53 DEBUG : box root 'rclone-test-huporud9yati': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/29 02:25:53 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378300115")
2025/04/29 02:25:53 INFO  : dir/file4.rclone_chunk.001_gpp2w6: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/29 02:25:54 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378300342")
2025/04/29 02:25:54 INFO  : dir/file4.rclone_chunk.002_gpp2w6: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/29 02:25:54 DEBUG : box root 'rclone-test-huporud9yati': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1848161490779|20a511484d72beb02d3448d51c5908749a0fe236] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:54 DEBUG : box root 'rclone-test-huporud9yati': ["file2"(0)|file|ITEM_UPLOAD|1848168069087|5507bfc1242cfb0dd99b441370d2c918e263fc1b] ignored due to old SequenceID ('\x00')
2025/04/29 02:25:54 DEBUG : box root 'rclone-test-huporud9yati': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:54 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378301118")
2025/04/29 02:25:55 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378301350")
2025/04/29 02:25:56 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378302122")
2025/04/29 02:25:57 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378303119")
2025/04/29 02:25:58 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378304120")
2025/04/29 02:25:58 DEBUG : box root 'rclone-test-huporud9yati': ["file4.rclone_chunk.001_gpp2w6"(0)|file|ITEM_UPLOAD|1848169057972|d5b5fe998e910bc73bf2799f2a2986a651dbed02] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:58 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:58 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378305124")
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378305348")
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1848169057972|48291701b984c56b5fc4f83a63666fbc0615d0d6] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378306117")
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': ["file4.rclone_chunk.002_gpp2w6"(0)|file|ITEM_UPLOAD|1848160830451|4a923fd52dd704d83dc9c4015b764edadce26f67] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378306342")
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1848160830451|dd888ffb28aa96732faaf501849a3f01be732abc] ignored due to old SequenceID ('\x01')
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:25:59 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378306569")
2025/04/29 02:26:00 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378306795")
2025/04/29 02:26:00 INFO  : dir/file3.rclone_chunk.001_gpp9z1: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/29 02:26:01 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378307116")
2025/04/29 02:26:01 INFO  : dir/file3.rclone_chunk.002_gpp9z1: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/29 02:26:02 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378308119")
2025/04/29 02:26:03 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378309119")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/29 02:26:04 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378310112")
2025/04/29 02:26:05 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378311112")
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378312122")
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': ["file3.rclone_chunk.002_gpp9z1"(0)|file|ITEM_UPLOAD|1848159083698|11ab6649818609921cfeed1145cba8318e178564] ignored due to old SequenceID ('\x01')
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1848163981425|bb8017e427187a665e81e69ed265767abcf73625] ignored due to old SequenceID ('\x01')
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378313112")
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1848159083698|fb77c08802588301305d17ad32d6991af03b5d3d] ignored due to old SequenceID ('\x01')
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:26:06 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378313343")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/29 02:26:07 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378313565")
2025/04/29 02:26:08 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378314116")
2025/04/29 02:26:08 DEBUG : box root 'rclone-test-huporud9yati': ["file3"(0)|file|ITEM_UPLOAD|1848161529273|869c8f65af6943ebac350215596c9eb8ed6c398f] ignored due to old SequenceID ('\x00')
2025/04/29 02:26:08 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:26:08 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378315118")
2025/04/29 02:26:09 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378315338")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/29 02:26:10 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378316117")
2025/04/29 02:26:10 DEBUG : box root 'rclone-test-huporud9yati': ["file4"(0)|file|ITEM_UPLOAD|1848158929510|dd97020a322504a4916bf32cdf72c21408911844] ignored due to old SequenceID ('\x00')
2025/04/29 02:26:10 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:26:10 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378317119")
2025/04/29 02:26:11 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378317342")
2025/04/29 02:26:12 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378318117")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/29 02:26:13 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378319123")
2025/04/29 02:26:13 DEBUG : box root 'rclone-test-huporud9yati': ["file3.rclone_chunk.001_gpp9z1"(0)|file|ITEM_UPLOAD|1848163981425|d21fcb2e7163a870addcd8785ea2d14cc12f9bad] ignored due to old SequenceID ('\x01')
2025/04/29 02:26:13 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/29 02:26:13 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378320119")
2025/04/29 02:26:14 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378320345")
2025/04/29 02:26:15 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378321114")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/29 02:26:16 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378322114")
2025/04/29 02:26:17 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378323134")
2025/04/29 02:26:18 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378324122")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/29 02:26:19 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378325114")
2025/04/29 02:26:20 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378326116")
2025/04/29 02:26:21 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378327120")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/29 02:26:22 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378328117")
2025/04/29 02:26:23 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378329118")
2025/04/29 02:26:24 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378330115")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/29 02:26:25 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378331130")
2025/04/29 02:26:26 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378332120")
2025/04/29 02:26:27 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378333114")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/29 02:26:28 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378334113")
2025/04/29 02:26:29 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378335119")
2025/04/29 02:26:30 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378336116")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[zero-length-file:{} zero-length-file.rclone_chunk.001_gpom2u:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/29 02:26:31 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378337114")
2025/04/29 02:26:32 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378338115")
2025/04/29 02:26:33 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378339117")
2025/04/29 02:26:34 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378340114")
2025/04/29 02:26:35 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378341126")
2025/04/29 02:26:36 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378342114")
2025/04/29 02:26:37 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378343117")
2025/04/29 02:26:38 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378344115")
2025/04/29 02:26:39 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378345119")
2025/04/29 02:26:39 DEBUG : box root 'rclone-test-huporud9yati': ["file2"(1)|file|ITEM_TRASH|1848168069087|1b45dddbc7d33fb9a7ccb319f32421373c13060e] added old path ("dir/file2") for notify
2025/04/29 02:26:39 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/29 02:26:39 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/29 02:26:39 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378346127")
2025/04/29 02:26:40 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378346346")
2025/04/29 02:26:40 DEBUG : box root 'rclone-test-huporud9yati': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1848161490779|5a9be7a26558a60f5e754c9f1b271fc972440699] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/29 02:26:40 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/29 02:26:40 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/29 02:26:40 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378347122")
2025/04/29 02:26:41 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378347345")
2025/04/29 02:26:41 DEBUG : box root 'rclone-test-huporud9yati': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1848160998006|bceab47ce812a45bfa66d9ae70e364bc08520f93] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/29 02:26:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/29 02:26:41 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/29 02:26:41 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378348120")
2025/04/29 02:26:42 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378348346")
2025/04/29 02:26:42 DEBUG : box root 'rclone-test-huporud9yati': ["file4"(1)|file|ITEM_TRASH|1848158929510|d806b0b88516375ab1c824d34fde56bd1d710100] added old path ("dir/file4") for notify
2025/04/29 02:26:42 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/29 02:26:42 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/29 02:26:42 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378349116")
2025/04/29 02:26:43 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378349349")
2025/04/29 02:26:43 DEBUG : box root 'rclone-test-huporud9yati': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1848160830451|bb33849b961eb1d17a51f19b185e5db66cc9e70a] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/29 02:26:43 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/29 02:26:43 DEBUG : box root 'rclone-test-huporud9yati': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/29 02:26:43 DEBUG : box root 'rclone-test-huporud9yati': Checking for changes on remote (next_stream_position: "30401043378350116")
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/04/29 02:26:48 INFO  : file name.txt.rclone_chunk.001_gpql1b: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/29 02:26:48 INFO  : file name.txt.rclone_chunk.002_gpql1b: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/29 02:26:55 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_gpqsc1: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/04/29 02:26:55 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_gpqsc1: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/04/29 02:27:05 INFO  : file name.txt.rclone_chunk.001_gpr015: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/29 02:27:06 INFO  : file name.txt.rclone_chunk.002_gpr015: 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/29 02:27:13 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:"
2025/04/29 02:27:13 DEBUG : Config file has changed externally - reloading
2025/04/29 02:27:13 DEBUG : Creating backend with remote "TestBox:"
2025/04/29 02:27:14 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/29 02:27:28 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.001_gpro0t: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001
2025/04/29 02:27:28 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.002_gpro0t: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2025/04/29 02:27:41 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_gps1bo: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001
2025/04/29 02:27:42 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_gps1bo: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002
2025/04/29 02:27:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati/dirToPurgeFromRoot"
2025/04/29 02:27:46 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/dirToPurgeFromRoot"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2025/04/29 02:27:50 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati/hello? sausage/êé"
2025/04/29 02:27:50 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/hello? sausage/êé"
2025/04/29 02:28:00 INFO  : a/b/c/d/e.txt.rclone_chunk.001_gpsh71: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001
2025/04/29 02:28:01 INFO  : a/b/c/d/e.txt.rclone_chunk.002_gpsh71: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2025/04/29 02:28:08 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/29 02:28:20 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks...
2025/04/29 02:28:21 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001
2025/04/29 02:28:22 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002
2025/04/29 02:28:23 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt
2025/04/29 02:28:27 DEBUG : file name.txt: move 2 data chunks...
2025/04/29 02:28:29 INFO  : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001
2025/04/29 02:28:30 INFO  : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002
2025/04/29 02:28:31 INFO  : file name.txt: Moved (server-side) to: moveTest/other.txt
2025/04/29 02:28:35 DEBUG : moveTest/other.txt: move 2 data chunks...
2025/04/29 02:28:36 INFO  : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/29 02:28:37 INFO  : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/29 02:28:38 INFO  : moveTest/other.txt: Moved (server-side) to: file name.txt
2025/04/29 02:28:43 DEBUG : other.txt: move 2 data chunks...
2025/04/29 02:28:44 INFO  : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/04/29 02:28:45 INFO  : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/04/29 02:28:46 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/29 02:28:49 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-zetaved8hito"
2025/04/29 02:28:49 DEBUG : Creating backend with remote "TestBox:rclone-test-zetaved8hito"
2025/04/29 02:28:50 DEBUG : box root 'rclone-test-zetaved8hito': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/29 02:28:51 DEBUG : box root 'rclone-test-zetaved8hito': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/29 02:28:56 DEBUG : box root 'rclone-test-huporud9yati': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/29 02:28:58 DEBUG : box root 'rclone-test-huporud9yati': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/29 02:29:04 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-zetaved8hito': 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/29 02:29:39 INFO  : file name.txt.rclone_chunk.001_gpv7re: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/04/29 02:29:40 INFO  : file name.txt.rclone_chunk.002_gpv7re: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/04/29 02:29:40 INFO  : file name.txt.rclone_chunk.003_gpv7re: Moved (server-side) to: file name.txt.rclone_chunk.003
2025/04/29 02:29:41 INFO  : file name.txt.rclone_chunk.004_gpv7re: Moved (server-side) to: file name.txt.rclone_chunk.004
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2025/04/29 02:29:48 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/04/29 02:29:48 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/04/29 02:29:53 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-huporud9yati/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-huporud9yati/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2025/04/29 02:29:53 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati/not found.txt"
2025/04/29 02:29:53 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/not found.txt"
2025/04/29 02:29:56 ERROR : : error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-huporud9yati" from "TestChunkerChunk50bBox:rclone-test-huporud9yati"
2025/04/29 02:29:56 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/29 02:30:02 INFO  : rclone-test-huporud9yati/created from root.txt.rclone_chunk.001_gpvzpl: Moved (server-side) to: rclone-test-huporud9yati/created from root.txt.rclone_chunk.001
2025/04/29 02:30:03 INFO  : rclone-test-huporud9yati/created from root.txt.rclone_chunk.002_gpvzpl: Moved (server-side) to: rclone-test-huporud9yati/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/29 02:30:24 INFO  : piped data.txt.rclone_chunk.001_gpwmpq: Moved (server-side) to: piped data.txt
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2025/04/29 02:30:31 INFO  : piped data.txt.rclone_chunk.001_gpwrd3: Moved (server-side) to: piped data.txt.rclone_chunk.001
2025/04/29 02:30:32 INFO  : piped data.txt.rclone_chunk.002_gpwrd3: Moved (server-side) to: piped data.txt.rclone_chunk.002
2025/04/29 02:30:32 INFO  : piped data.txt.rclone_chunk.003_gpwrd3: 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/29 02:30:38 INFO  : Chunked 'TestChunkerChunk50bBox:rclone-test-huporud9yati': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2025/04/29 02:30:43 INFO  : small/emptyfile.rclone_chunk.001_gpx4pl: Moved (server-side) to: small/emptyfile
2025/04/29 02:30:49 INFO  : small/smallfile.rclone_chunk.001_gpxcjm: Moved (server-side) to: small/smallfile
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
2025/04/29 02:31:03 INFO  : corrupted/billy.rclone_chunk.001_gpxjmv: Moved (server-side) to: corrupted/billy.rclone_chunk.001
2025/04/29 02:31:03 INFO  : corrupted/billy.rclone_chunk.002_gpxjmv: Moved (server-side) to: corrupted/billy.rclone_chunk.002
2025/04/29 02:31:04 INFO  : corrupted/billy.rclone_chunk.003_gpxjmv: Moved (server-side) to: corrupted/billy.rclone_chunk.003
2025/04/29 02:31:04 INFO  : corrupted/billy.rclone_chunk.004_gpxjmv: Moved (server-side) to: corrupted/billy.rclone_chunk.004
2025/04/29 02:31:05 INFO  : corrupted/billy.rclone_chunk.005_gpxjmv: Moved (server-side) to: corrupted/billy.rclone_chunk.005
2025/04/29 02:31:16 INFO  : corrupted/silly1.rclone_chunk.001_gpxwgd: Moved (server-side) to: corrupted/silly1.rclone_chunk.001
2025/04/29 02:31:16 INFO  : corrupted/silly1.rclone_chunk.002_gpxwgd: Moved (server-side) to: corrupted/silly1.rclone_chunk.002
2025/04/29 02:31:17 INFO  : corrupted/silly1.rclone_chunk.003_gpxwgd: Moved (server-side) to: corrupted/silly1.rclone_chunk.003
2025/04/29 02:31:17 INFO  : corrupted/silly1.rclone_chunk.004_gpxwgd: Moved (server-side) to: corrupted/silly1.rclone_chunk.004
2025/04/29 02:31:18 INFO  : corrupted/silly1.rclone_chunk.005_gpxwgd: Moved (server-side) to: corrupted/silly1.rclone_chunk.005
2025/04/29 02:31:29 INFO  : corrupted/silly2.rclone_chunk.001_gpyaim: Moved (server-side) to: corrupted/silly2.rclone_chunk.001
2025/04/29 02:31:30 INFO  : corrupted/silly2.rclone_chunk.002_gpyaim: Moved (server-side) to: corrupted/silly2.rclone_chunk.002
2025/04/29 02:31:31 INFO  : corrupted/silly2.rclone_chunk.003_gpyaim: Moved (server-side) to: corrupted/silly2.rclone_chunk.003
2025/04/29 02:31:31 INFO  : corrupted/silly2.rclone_chunk.004_gpyaim: Moved (server-side) to: corrupted/silly2.rclone_chunk.004
2025/04/29 02:31:32 INFO  : corrupted/silly2.rclone_chunk.005_gpyaim: Moved (server-side) to: corrupted/silly2.rclone_chunk.005
2025/04/29 02:31:45 INFO  : corrupted/silly3.rclone_chunk.001_gpyq00: Moved (server-side) to: corrupted/silly3.rclone_chunk.001
2025/04/29 02:31:46 INFO  : corrupted/silly3.rclone_chunk.002_gpyq00: Moved (server-side) to: corrupted/silly3.rclone_chunk.002
2025/04/29 02:31:46 INFO  : corrupted/silly3.rclone_chunk.003_gpyq00: Moved (server-side) to: corrupted/silly3.rclone_chunk.003
2025/04/29 02:31:47 INFO  : corrupted/silly3.rclone_chunk.004_gpyq00: Moved (server-side) to: corrupted/silly3.rclone_chunk.004
2025/04/29 02:31:47 INFO  : corrupted/silly3.rclone_chunk.005_gpyq00: Moved (server-side) to: corrupted/silly3.rclone_chunk.005
2025/04/29 02:31:58 INFO  : corrupted/willy.rclone_chunk.001_gpz3bi: Moved (server-side) to: corrupted/willy.rclone_chunk.001
2025/04/29 02:31:59 INFO  : corrupted/willy.rclone_chunk.002_gpz3bi: Moved (server-side) to: corrupted/willy.rclone_chunk.002
2025/04/29 02:31:59 INFO  : corrupted/willy.rclone_chunk.003_gpz3bi: Moved (server-side) to: corrupted/willy.rclone_chunk.003
2025/04/29 02:32:00 INFO  : corrupted/willy.rclone_chunk.004_gpz3bi: Moved (server-side) to: corrupted/willy.rclone_chunk.004
2025/04/29 02:32:00 INFO  : corrupted/willy.rclone_chunk.005_gpz3bi: Moved (server-side) to: corrupted/willy.rclone_chunk.005
2025/04/29 02:32:12 INFO  : corrupted/silly4.rclone_chunk.001_gpzhev: Moved (server-side) to: corrupted/silly4.rclone_chunk.001
2025/04/29 02:32:13 INFO  : corrupted/silly4.rclone_chunk.002_gpzhev: Moved (server-side) to: corrupted/silly4.rclone_chunk.002
2025/04/29 02:32:13 INFO  : corrupted/silly4.rclone_chunk.003_gpzhev: Moved (server-side) to: corrupted/silly4.rclone_chunk.003
2025/04/29 02:32:14 INFO  : corrupted/silly4.rclone_chunk.004_gpzhev: Moved (server-side) to: corrupted/silly4.rclone_chunk.004
2025/04/29 02:32:14 INFO  : corrupted/silly4.rclone_chunk.005_gpzhev: Moved (server-side) to: corrupted/silly4.rclone_chunk.005
2025/04/29 02:32:18 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy"
2025/04/29 02:32:26 INFO  : corrupted/silly5.rclone_chunk.001_gpzv21: Moved (server-side) to: corrupted/silly5.rclone_chunk.001
2025/04/29 02:32:27 INFO  : corrupted/silly5.rclone_chunk.002_gpzv21: Moved (server-side) to: corrupted/silly5.rclone_chunk.002
2025/04/29 02:32:27 INFO  : corrupted/silly5.rclone_chunk.003_gpzv21: Moved (server-side) to: corrupted/silly5.rclone_chunk.003
2025/04/29 02:32:28 INFO  : corrupted/silly5.rclone_chunk.004_gpzv21: Moved (server-side) to: corrupted/silly5.rclone_chunk.004
2025/04/29 02:32:28 INFO  : corrupted/silly5.rclone_chunk.005_gpzv21: Moved (server-side) to: corrupted/silly5.rclone_chunk.005
2025/04/29 02:32:31 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/29 02:32:47 INFO  : wreaked/wreaker.rclone_chunk.001_gq0kxi: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001
2025/04/29 02:32:48 INFO  : wreaked/wreaker.rclone_chunk.002_gq0kxi: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002
2025/04/29 02:32:52 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-huporud9yati': invalid directory entry "wreaked/wreaker"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2025/04/29 02:33:05 ERROR : usermeta/today.rclone_chunk.001_gq14r6: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1848163287973","file_version":{"type":"file_version","id":"2037738210373","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_gq14r6"}})
2025/04/29 02:33:07 INFO  : usermeta/today.rclone_chunk.001: Deleted
2025/04/29 02:33:07 INFO  : usermeta/today.rclone_chunk.001_gq14r6: Moved (server-side) to: usermeta/today.rclone_chunk.001
2025/04/29 02:33:18 ERROR : usermeta/past.rclone_chunk.001_gq1ghu: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1848169666973","file_version":{"type":"file_version","id":"2037744490973","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_gq1ghu"}})
2025/04/29 02:33:19 INFO  : usermeta/past.rclone_chunk.001: Deleted
2025/04/29 02:33:20 INFO  : usermeta/past.rclone_chunk.001_gq1ghu: Moved (server-side) to: usermeta/past.rclone_chunk.001
2025/04/29 02:33:30 ERROR : usermeta/future.rclone_chunk.001_gq1tyf: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1848169185308","file_version":{"type":"file_version","id":"2037744122108","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_gq1tyf"}})
2025/04/29 02:33:32 INFO  : usermeta/future.rclone_chunk.001: Deleted
2025/04/29 02:33:32 INFO  : usermeta/future.rclone_chunk.001_gq1tyf: Moved (server-side) to: usermeta/future.rclone_chunk.001
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof
2025/04/29 02:33:51 DEBUG : future/test: Can't move - required hash not found
2025/04/29 02:33:51 DEBUG : future/test: Can't move, switching to copy
2025/04/29 02:33:51 DEBUG : future/test: Can't copy - required hash not found
2025/04/29 02:33:52 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/04/29 02:33:52 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/04/29 02:33:54 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-huporud9yati': File to upload is small (3 bytes), uploading instead of streaming
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility
2025/04/29 02:34:32 INFO  : backcomp/renamefile.rclone_chunk.001_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001
2025/04/29 02:34:33 INFO  : backcomp/renamefile.rclone_chunk.002_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002
2025/04/29 02:34:33 INFO  : backcomp/renamefile.rclone_chunk.003_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003
2025/04/29 02:34:34 INFO  : backcomp/renamefile.rclone_chunk.004_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004
2025/04/29 02:34:34 INFO  : backcomp/renamefile.rclone_chunk.005_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005
2025/04/29 02:34:35 INFO  : backcomp/renamefile.rclone_chunk.006_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006
2025/04/29 02:34:35 INFO  : backcomp/renamefile.rclone_chunk.007_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007
2025/04/29 02:34:36 INFO  : backcomp/renamefile.rclone_chunk.008_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008
2025/04/29 02:34:36 INFO  : backcomp/renamefile.rclone_chunk.009_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009
2025/04/29 02:34:37 INFO  : backcomp/renamefile.rclone_chunk.010_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010
2025/04/29 02:34:37 INFO  : backcomp/renamefile.rclone_chunk.011_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011
2025/04/29 02:34:38 INFO  : backcomp/renamefile.rclone_chunk.012_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012
2025/04/29 02:34:38 INFO  : backcomp/renamefile.rclone_chunk.013_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013
2025/04/29 02:34:39 INFO  : backcomp/renamefile.rclone_chunk.014_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014
2025/04/29 02:34:39 INFO  : backcomp/renamefile.rclone_chunk.015_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015
2025/04/29 02:34:40 INFO  : backcomp/renamefile.rclone_chunk.016_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016
2025/04/29 02:34:40 INFO  : backcomp/renamefile.rclone_chunk.017_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017
2025/04/29 02:34:41 INFO  : backcomp/renamefile.rclone_chunk.018_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018
2025/04/29 02:34:41 INFO  : backcomp/renamefile.rclone_chunk.019_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019
2025/04/29 02:34:42 INFO  : backcomp/renamefile.rclone_chunk.020_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020
2025/04/29 02:34:42 INFO  : backcomp/renamefile.rclone_chunk.021_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021
2025/04/29 02:34:43 INFO  : backcomp/renamefile.rclone_chunk.022_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022
2025/04/29 02:34:43 INFO  : backcomp/renamefile.rclone_chunk.023_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023
2025/04/29 02:34:44 INFO  : backcomp/renamefile.rclone_chunk.024_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024
2025/04/29 02:34:44 INFO  : backcomp/renamefile.rclone_chunk.025_gq2mi2: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove
2025/04/29 02:35:15 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati/servermovetest/subdir1"
2025/04/29 02:35:15 DEBUG : Config file has changed externally - reloading
2025/04/29 02:35:15 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/servermovetest/subdir1"
2025/04/29 02:35:17 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati/servermovetest/subdir2"
2025/04/29 02:35:17 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/servermovetest/subdir2"
2025/04/29 02:35:26 INFO  : movefile.rclone_chunk.001_gq4wog: Moved (server-side) to: movefile.rclone_chunk.001
2025/04/29 02:35:26 INFO  : movefile.rclone_chunk.002_gq4wog: Moved (server-side) to: movefile.rclone_chunk.002
2025/04/29 02:35:30 DEBUG : movefile: move 2 data chunks...
2025/04/29 02:35:32 INFO  : movefile.rclone_chunk.001: Moved (server-side)
2025/04/29 02:35:33 INFO  : movefile.rclone_chunk.002: Moved (server-side)
2025/04/29 02:35:34 INFO  : movefile: Moved (server-side)
2025/04/29 02:35:35 INFO  : movefile: Moved (server-side)
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow
2025/04/29 02:35:40 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-huporud9yati/md5all"
2025/04/29 02:35:40 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name
2025/04/29 02:35:40 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/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/29 02:35:47 INFO  : unknown-size-put.txt.rclone_chunk.001_gq5jas: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001
2025/04/29 02:35:47 INFO  : unknown-size-put.txt.rclone_chunk.002_gq5jas: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002
2025/04/29 02:35:48 INFO  : unknown-size-put.txt.rclone_chunk.003_gq5jas: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2025/04/29 02:35:57 INFO  : unknown-size-update.txt.rclone_chunk.001_gq5v0m: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/04/29 02:35:58 INFO  : unknown-size-update.txt.rclone_chunk.002_gq5v0m: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/04/29 02:36:12 INFO  : unknown-size-update.txt.rclone_chunk.001_gq6399: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/04/29 02:36:13 INFO  : unknown-size-update.txt.rclone_chunk.002_gq6399: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/04/29 02:36:13 INFO  : unknown-size-update.txt.rclone_chunk.003_gq6399: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003
2025/04/29 02:36:14 INFO  : unknown-size-update.txt.rclone_chunk.004_gq6399: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004
2025/04/29 02:36:14 INFO  : unknown-size-update.txt.rclone_chunk.005_gq6399: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2025/04/29 02:36:22 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-huporud9yati/deeper/nonexisting/directory"
2025/04/29 02:36:22 DEBUG : Config file has changed externally - reloading
2025/04/29 02:36:22 DEBUG : Creating backend with remote "TestBox:rclone-test-huporud9yati/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/29 02:36:29 DEBUG : box root 'rclone-test-huporud9yati': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/29 02:36:29 ERROR : : error listing: directory not found
2025/04/29 02:36:29 DEBUG : box root 'rclone-test-huporud9yati': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsShutdown
--- FAIL: TestIntegration (968.57s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (0.47s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (0.76s)
    --- FAIL: TestIntegration/FsMkdir (965.05s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (5.50s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.31s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.33s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.30s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (247.74s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (12.79s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (12.87s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (12.53s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (13.35s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (13.21s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (13.67s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (13.31s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (13.07s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (12.85s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (12.86s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (12.95s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (13.06s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (12.70s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (12.83s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (13.06s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (13.02s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (13.07s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (13.41s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (12.83s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.62s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (52.33s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (5.85s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (65.15s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (537.92s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.69s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.68s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.36s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.97s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.70s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.65s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.64s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.91s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.19s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.27s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.68s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (12.80s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (14.56s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (16.41s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (11.75s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (31.04s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (15.49s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.29s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.89s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.89s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.93s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.92s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.94s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.91s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.93s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.92s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.15s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.90s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.07s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.34s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.52s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.32s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (17.89s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.93s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.43s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.94s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (16.08s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.69s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.36s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (14.03s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.47s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.93s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (7.57s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.27s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (17.64s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (12.65s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (303.06s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (15.12s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (108.64s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (17.29s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (39.47s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (17.71s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (78.75s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (24.44s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (1.63s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (40.12s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (11.92s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (28.20s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.49s)
        --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsDirectory (2.01s)
            --- 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	968.608s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 16m13.548768158s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]