"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/06/26 21:24:10 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje"
2025/06/26 21:24:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/06/26 21:24:10 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje"
2025/06/26 21:24:11 DEBUG : box root 'rclone-test-rubodap4leje': 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/06/26 21:24:12 DEBUG : box root 'rclone-test-rubodap4leje': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/06/26 21:24:12 DEBUG : box root 'rclone-test-rubodap4leje': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsString
=== RUN   TestIntegration/FsName
=== RUN   TestIntegration/FsRoot
=== RUN   TestIntegration/FsRmdirEmpty
=== RUN   TestIntegration/FsMkdir
2025/06/26 21:24:15 DEBUG : box root 'rclone-test-rubodap4leje': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2025/06/26 21:24:16 INFO  : dir/subdir: Making directory
2025/06/26 21:24:19 INFO  : dir/subdir: Removing directory
2025/06/26 21:24:21 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/06/26 21:24:23 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/06/26 21:24:29 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_hl3bsk: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001
2025/06/26 21:24:30 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_hl3bsk: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:707: testing "．"
2025/06/26 21:24:44 INFO  : ．/．.rclone_chunk.001_hl3qm0: Moved (server-side) to: ．/．.rclone_chunk.001
2025/06/26 21:24:45 INFO  : ．/．.rclone_chunk.002_hl3qm0: Moved (server-side) to: ．/．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:707: testing "．．"
2025/06/26 21:25:00 INFO  : ．．/．．.rclone_chunk.001_hl46lf: Moved (server-side) to: ．．/．．.rclone_chunk.001
2025/06/26 21:25:01 INFO  : ．．/．．.rclone_chunk.002_hl46lf: Moved (server-side) to: ．．/．．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2025/06/26 21:25:16 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_hl4ma0: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001
2025/06/26 21:25:16 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_hl4ma0: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:707: testing " leading space"
2025/06/26 21:25:32 INFO  :  leading space/ leading space.rclone_chunk.001_hl51df: Moved (server-side) to:  leading space/ leading space.rclone_chunk.001
2025/06/26 21:25:32 INFO  :  leading space/ leading space.rclone_chunk.002_hl51df: Moved (server-side) to:  leading space/ leading space.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:707: testing "~leading tilde"
2025/06/26 21:25:47 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_hl5g7v: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001
2025/06/26 21:25:47 INFO  : ~leading tilde/~leading tilde.rclone_chunk.002_hl5g7v: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:707: testing "␍leading CR"
2025/06/26 21:26:02 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_hl5wda: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001
2025/06/26 21:26:03 INFO  : ␍leading CR/␍leading CR.rclone_chunk.002_hl5wda: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:707: testing "␊leading LF"
2025/06/26 21:26:18 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_hl6bu6: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001
2025/06/26 21:26:18 INFO  : ␊leading LF/␊leading LF.rclone_chunk.002_hl6bu6: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:707: testing "␉leading HT"
2025/06/26 21:26:33 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_hl6r1w: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001
2025/06/26 21:26:34 INFO  : ␉leading HT/␉leading HT.rclone_chunk.002_hl6r1w: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:707: testing "␋leading VT"
2025/06/26 21:26:48 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_hl7608: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001
2025/06/26 21:26:49 INFO  : ␋leading VT/␋leading VT.rclone_chunk.002_hl7608: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:707: testing ".leading dot"
2025/06/26 21:27:04 INFO  : .leading dot/.leading dot.rclone_chunk.001_hl7mpf: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001
2025/06/26 21:27:04 INFO  : .leading dot/.leading dot.rclone_chunk.002_hl7mpf: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:707: testing "trailing space "
2025/06/26 21:27:19 INFO  : trailing space /trailing space .rclone_chunk.001_hl81r2: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001
2025/06/26 21:27:20 INFO  : trailing space /trailing space .rclone_chunk.002_hl81r2: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:707: testing "trailing CR␍"
2025/06/26 21:27:34 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_hl8ge1: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001
2025/06/26 21:27:35 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.002_hl8ge1: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:707: testing "trailing LF␊"
2025/06/26 21:27:50 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_hl8vis: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001
2025/06/26 21:27:50 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.002_hl8vis: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:707: testing "trailing HT␉"
2025/06/26 21:28:05 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_hl9b4e: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001
2025/06/26 21:28:05 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.002_hl9b4e: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:707: testing "trailing VT␋"
2025/06/26 21:28:20 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_hl9qpi: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001
2025/06/26 21:28:21 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.002_hl9qpi: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:707: testing "trailing dot."
2025/06/26 21:28:36 INFO  : trailing dot./trailing dot..rclone_chunk.001_hla58w: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001
2025/06/26 21:28:36 INFO  : trailing dot./trailing dot..rclone_chunk.002_hla58w: 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/06/26 21:28:51 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_hlal9k: Moved (server-side) to: invalid utf-8�/invalid utf-8�.rclone_chunk.001
2025/06/26 21:28:52 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.002_hlal9k: 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/06/26 21:29:07 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_hlb08d: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001
2025/06/26 21:29:07 INFO  : test%46.txt/test%46.txt.rclone_chunk.002_hlb08d: 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/06/26 21:30:23 INFO  : zero-length-file.rclone_chunk.001_hld6xe: 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/06/26 21:30:26 INFO  : dir: Making directory
2025/06/26 21:30:28 INFO  : dir/subdir1: Making directory
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458174892")
2025/06/26 21:30:29 INFO  : dir/subdir3: Making directory
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.txt.rclone_chunk.001_hld2tr"(0)|file|ITEM_UPLOAD|1906255660185|ddc8aad9127c7dd4a709dc573d34c3b2cb611dad] new parent not found
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': ["file1.txt.rclone_chunk.001_hld3zv"(0)|file|ITEM_UPLOAD|1906259163679|00b9ae831c039fe76cb8a3ceefef116b0e09826b] new parent not found
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.txt.rclone_chunk.001_hld34c"(0)|file|ITEM_UPLOAD|1906264333588|e4880923aac0f94856243264727c045f39f9a486] new parent not found
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.txt.rclone_chunk.001_hld3f6"(0)|file|ITEM_UPLOAD|1906262620012|2f237d3845816916086fb30feef383fc24eae842] new parent not found
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': Received 4 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458176124")
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': ["zero-length-file"(1)|file|ITEM_RENAME|1906258832883|19f30179fc47a4571b8afd2e1cc9ff003d0783f0] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:29 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458176380")
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458176618")
2025/06/26 21:30:30 INFO  : dir/subdir2: Making directory
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': ["file1.txt"(1)|file|ITEM_RENAME|1906259163679|004379d3e69692d95d88f538350784d3bf8612c4] new parent not found
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458177126")
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.txt"(1)|file|ITEM_RENAME|1906264333588|c57620bc6f27e47e65186f612503dde567a94d8a] new parent not found
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458177367")
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.txt"(1)|file|ITEM_RENAME|1906262620012|8a9ce0c70dc1f4d7c03d6ba25ddcbced0fa89e68] new parent not found
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:30 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458177603")
2025/06/26 21:30:31 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.txt"(1)|file|ITEM_RENAME|1906255660185|9616644dc53920197489f9911ecb0f2a97b32e0c] new parent not found
2025/06/26 21:30:31 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:31 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458177839")
2025/06/26 21:30:31 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458178074")
2025/06/26 21:30:32 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458178307")
2025/06/26 21:30:32 DEBUG : box root 'rclone-test-rubodap4leje': ["file5.txt.rclone_chunk.001_hldash"(0)|file|ITEM_UPLOAD|1906257232476|564556d670af7cf2446060ee6351394e87b6cd68] new parent not found
2025/06/26 21:30:32 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:32 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458179121")
2025/06/26 21:30:33 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458179358")
2025/06/26 21:30:33 DEBUG : box root 'rclone-test-rubodap4leje': ["file7.txt.rclone_chunk.001_hldaw6"(0)|file|ITEM_UPLOAD|1906261237367|dfe7bde8d438a0837dd87bf5a0fc7dcd9d22d810] new parent not found
2025/06/26 21:30:33 DEBUG : box root 'rclone-test-rubodap4leje': ["file6.txt.rclone_chunk.001_hldatq"(0)|file|ITEM_UPLOAD|1906257397960|ec3ea2acad68b45f0a7cafff8b5b0c41c1c50da9] new parent not found
2025/06/26 21:30:33 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.001_hldbka"(0)|file|ITEM_UPLOAD|1906263342462|ec7655b79d3d21be9c453d0829b11d33313f8263] new parent not found
2025/06/26 21:30:33 DEBUG : box root 'rclone-test-rubodap4leje': ["zero-length-file"(2)|file|ITEM_TRASH|1906258832883|493aeabfe03da41bf831850b1fb5224c04efabe4] added old path ("zero-length-file") for notify
2025/06/26 21:30:33 DEBUG : doChangeNotify("zero-length-file", 1)
2025/06/26 21:30:33 DEBUG : box root 'rclone-test-rubodap4leje': Received 4 events, resulting in 1 paths and 1 notifications
2025/06/26 21:30:33 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458180119")
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458180376")
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.002_hldbka"(0)|file|ITEM_UPLOAD|1906254484106|487c080d2e58c0e1a3252c693fbcb65b872200f8] new parent not found
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': ["file6.txt"(1)|file|ITEM_RENAME|1906257397960|9cecc375e66ce134e6338636344c78f5a91f7549] new parent not found
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': ["file7.txt"(1)|file|ITEM_RENAME|1906261237367|c665a667000ee243b9c4e0d40d91810de927c29c] new parent not found
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': ["file5.txt"(1)|file|ITEM_RENAME|1906257232476|da3131bbe5cb953ca18eba7d0bc3dc56c8d777b4] new parent not found
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': Received 4 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458181122")
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': ["dir"(0)|folder|ITEM_CREATE|328112425315|6e96bcf849edea90afa0c05c8e89a78e753e38c1] added new path ("dir") for notify
2025/06/26 21:30:34 DEBUG : doChangeNotify("dir", 0)
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 1 paths and 1 notifications
2025/06/26 21:30:34 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458181376")
2025/06/26 21:30:35 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458181613")
2025/06/26 21:30:35 DEBUG : box root 'rclone-test-rubodap4leje': ["subdir1"(0)|folder|ITEM_CREATE|328111868637|ae119674952d62a07327fa51e2c61d5dd2672c0c] added new path ("dir/subdir1") for notify
2025/06/26 21:30:35 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/06/26 21:30:35 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 1 paths and 1 notifications
2025/06/26 21:30:35 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458182126")
2025/06/26 21:30:35 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.003_hldbka"(0)|file|ITEM_UPLOAD|1906260073804|7cc38748882255cb9759b0b1cf5892c567f7c60f] new parent not found
2025/06/26 21:30:35 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:35 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458182368")
2025/06/26 21:30:35 INFO  : dir/file2.rclone_chunk.001_hldh78: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/06/26 21:30:36 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458182600")
2025/06/26 21:30:36 INFO  : dir/file2.rclone_chunk.002_hldh78: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/06/26 21:30:37 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458183123")
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458184120")
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': ["subdir2"(0)|folder|ITEM_CREATE|328112154863|598835d8531eb9b6286b3dd57ccc14e73065fad1] added new path ("dir/subdir2") for notify
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': ["subdir3"(0)|folder|ITEM_CREATE|328110990189|e589f3bb38e5c9f9fe3ce4daca46c031262a0aa0] added new path ("dir/subdir3") for notify
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.002"(1)|file|ITEM_RENAME|1906254484106|99bb78bd45fe94b1fa7612b6a5f32acb6b073101] new parent not found
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.001"(1)|file|ITEM_RENAME|1906263342462|9efdb568a512d584ba980fdff64dd32086e15fa9] new parent not found
2025/06/26 21:30:38 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/06/26 21:30:38 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': Received 4 events, resulting in 2 paths and 2 notifications
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458185121")
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.003"(1)|file|ITEM_RENAME|1906260073804|2e346b1b3eb1c5cd54e6f97e76d76b64223be007] new parent not found
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458185377")
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.rclone_chunk.001_hldh78"(0)|file|ITEM_UPLOAD|1906256790328|cbbd216f81a29f12353c324318c88101f04c1812] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:38 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458185606")
2025/06/26 21:30:39 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458185850")
2025/06/26 21:30:40 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458186129")
2025/06/26 21:30:40 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1906260434158|d8795e25114e9737804632d613b385585e65dde7] new parent not found
2025/06/26 21:30:40 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.rclone_chunk.002_hldh78"(0)|file|ITEM_UPLOAD|1906260988488|7c5ec27fa01b9886c5110c732eb6bad75d31e87a] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:40 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:40 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458187123")
2025/06/26 21:30:41 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458187373")
2025/06/26 21:30:42 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458188122")
2025/06/26 21:30:42 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1906256790328|3fb866fc99364e226ceb9d0883642d886437f139] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:42 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1906260988488|05e4d2fdea1e9f253ac925ce82541b75ce099a6c] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:42 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:42 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458189128")
2025/06/26 21:30:43 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458189369")
2025/06/26 21:30:43 DEBUG : box root 'rclone-test-rubodap4leje': ["file2"(0)|file|ITEM_UPLOAD|1906265087380|4ff61cbacec7812b3831135f02ec1a0ec69c6772] ignored due to old SequenceID ('\x00')
2025/06/26 21:30:43 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:43 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458190120")
2025/06/26 21:30:43 INFO  : dir/file4.rclone_chunk.001_hldpc5: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/06/26 21:30:44 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458190355")
2025/06/26 21:30:44 INFO  : dir/file4.rclone_chunk.002_hldpc5: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/06/26 21:30:45 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458191126")
2025/06/26 21:30:46 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458192121")
2025/06/26 21:30:46 DEBUG : box root 'rclone-test-rubodap4leje': ["path2"(0)|folder|ITEM_CREATE|328113472432|639dea04d3026989a9181fba60447124f290a5ce] new parent not found
2025/06/26 21:30:46 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.txt.rclone_chunk.001_hldlgn"(0)|file|ITEM_UPLOAD|1906264890039|b9be647b198dbb83dced43453fa05fbf0caf2944] new parent not found
2025/06/26 21:30:46 DEBUG : box root 'rclone-test-rubodap4leje': ["file1.txt.rclone_chunk.001_hldlom"(0)|file|ITEM_UPLOAD|1906260998112|431953b3e0081f61cce33792e647289b6df03b90] new parent not found
2025/06/26 21:30:46 DEBUG : box root 'rclone-test-rubodap4leje': Received 3 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:46 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458193125")
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458193383")
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.txt.rclone_chunk.001_hldmwo"(0)|file|ITEM_UPLOAD|1906256038904|3172ffcb8120aa6249ffc3fe6b08c710480d8fbe] new parent not found
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.txt.rclone_chunk.001_hldmj8"(0)|file|ITEM_UPLOAD|1906262199777|799c4df451631fd6d461f2820beed27f4d526fd9] new parent not found
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.rclone_chunk.001_hldpc5"(0)|file|ITEM_UPLOAD|1906257253363|bcb36c59958252cf8696840e2968466ca3005095] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.txt"(1)|file|ITEM_RENAME|1906264890039|85adc32900f50929eee695a22fb70af30b6a4462] new parent not found
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': ["file1.txt"(1)|file|ITEM_RENAME|1906260998112|b788a08cfebe42cf3e0a396e4549f978bdaf3a8b] new parent not found
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.txt"(1)|file|ITEM_RENAME|1906262199777|9dc09ff57febe463bf2b08472772830bbd66fd0c] new parent not found
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': Received 6 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:47 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458194120")
2025/06/26 21:30:48 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458194393")
2025/06/26 21:30:48 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.txt"(1)|file|ITEM_RENAME|1906256038904|29f9ce6d28dd565a90c83f15b11932dc886c9362] new parent not found
2025/06/26 21:30:48 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:48 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458195122")
2025/06/26 21:30:49 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458195360")
2025/06/26 21:30:49 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1906257253363|c0cd0954b3b9fb7c1a35abeffad59715eda272cb] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:49 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:49 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458196119")
2025/06/26 21:30:50 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458196369")
2025/06/26 21:30:50 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.rclone_chunk.002_hldpc5"(0)|file|ITEM_UPLOAD|1906262771509|934f49d860f16300d14092399ef605b8ab9e1d08] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:50 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1906262771509|d3478794e93a321016ccdbf0b20f1bd596e37cc0] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:50 DEBUG : box root 'rclone-test-rubodap4leje': ["file6.txt.rclone_chunk.001_hldscz"(0)|file|ITEM_UPLOAD|1906255699025|c155c2becf9d9d4a0794908cc0e397355d26ec88] new parent not found
2025/06/26 21:30:50 DEBUG : box root 'rclone-test-rubodap4leje': ["file5.txt.rclone_chunk.001_hldsvs"(0)|file|ITEM_UPLOAD|1906260073290|3268521f40aee9c1aae570adee0ec985f0946b23] new parent not found
2025/06/26 21:30:50 DEBUG : box root 'rclone-test-rubodap4leje': Received 4 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:50 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458197134")
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458197387")
2025/06/26 21:30:51 INFO  : dir/file3.rclone_chunk.001_hldx7h: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.001_hldtqd"(0)|file|ITEM_UPLOAD|1906260378749|f63e929ac309745bd942379c66429d0b080b2b2e] new parent not found
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': ["file7.txt.rclone_chunk.001_hldttk"(0)|file|ITEM_UPLOAD|1906256744619|5177592a5569105ac446d7859655f9a1694983c3] new parent not found
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': ["file6.txt"(1)|file|ITEM_RENAME|1906255699025|c42c557fdb0d36fd25ca0902b4877b805249475c] new parent not found
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': Received 3 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458198123")
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': ["file5.txt"(1)|file|ITEM_RENAME|1906260073290|8421038c27107ed99c59fee95e52edf6cdb82ae3] new parent not found
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': ["file4"(0)|file|ITEM_UPLOAD|1906261799304|345e62e4ec820ad1925c8d9c6123c45c0d6a38fc] ignored due to old SequenceID ('\x00')
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:51 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458198375")
2025/06/26 21:30:51 INFO  : dir/file3.rclone_chunk.002_hldx7h: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/06/26 21:30:52 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458198617")
2025/06/26 21:30:53 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458199127")
2025/06/26 21:30:53 DEBUG : box root 'rclone-test-rubodap4leje': ["file7.txt"(1)|file|ITEM_RENAME|1906256744619|9f9bddc5a915d31757c7cfa832b893126667607f] new parent not found
2025/06/26 21:30:53 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.002_hldtqd"(0)|file|ITEM_UPLOAD|1906261710423|c4ab1beef31328a7bf03bf60d055733c119c73c2] new parent not found
2025/06/26 21:30:53 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:53 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458200122")
2025/06/26 21:30:54 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458200359")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/06/26 21:30:54 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.003_hldtqd"(0)|file|ITEM_UPLOAD|1906259648978|bc62d4f1aa1836cd6fff6d0844e9840edb18ab0a] new parent not found
2025/06/26 21:30:54 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:54 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458201126")
2025/06/26 21:30:54 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.001"(1)|file|ITEM_RENAME|1906260378749|00ed6a9c5cbd5c98673a9e0acf347819e94a023e] new parent not found
2025/06/26 21:30:54 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:54 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458201361")
2025/06/26 21:30:55 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458201592")
2025/06/26 21:30:55 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.rclone_chunk.001_hldx7h"(0)|file|ITEM_UPLOAD|1906263470287|a842006abdaa4599252b456c01886dd24f762f8e] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:55 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:55 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458202125")
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458202361")
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.002"(1)|file|ITEM_RENAME|1906261710423|ea9de1494c6833be82942a3e87962a3d8a4580f0] new parent not found
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.rclone_chunk.002_hldx7h"(0)|file|ITEM_UPLOAD|1906263339738|8168bba7c2c6f133d16f77b02c65198964e8dbbf] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458203127")
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST.rclone_chunk.003"(1)|file|ITEM_RENAME|1906259648978|546f0abff59be881098649e11af129ae7dd850b7] new parent not found
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:56 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458203368")
2025/06/26 21:30:57 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458203605")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/06/26 21:30:57 DEBUG : box root 'rclone-test-rubodap4leje': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1906265010743|90ad6a05f6ed48b82fd9e49eb10dd3a27c362968] new parent not found
2025/06/26 21:30:57 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1906263339738|d49e3d10c048cd355bfd94942337305b30c4882d] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:57 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:57 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458204121")
2025/06/26 21:30:58 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458204358")
2025/06/26 21:30:58 DEBUG : box root 'rclone-test-rubodap4leje': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1906263470287|93362c8bebff9c477799d024b2f9cb9a72efeadb] ignored due to old SequenceID ('\x01')
2025/06/26 21:30:58 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:58 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458205123")
2025/06/26 21:30:58 DEBUG : box root 'rclone-test-rubodap4leje': ["file3"(0)|file|ITEM_UPLOAD|1906260738253|f5ddbf597f6a471c6047bc9a25003ecc80d3e8f0] ignored due to old SequenceID ('\x00')
2025/06/26 21:30:58 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:30:58 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458205357")
2025/06/26 21:30:59 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458205589")
2025/06/26 21:31:00 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458206123")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/06/26 21:31:01 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458207125")
2025/06/26 21:31:01 DEBUG : box root 'rclone-test-rubodap4leje': ["modtime_write_test.rclone_chunk.001_hle2kr"(0)|file|ITEM_UPLOAD|1906263090251|e37360a20eba710bbaed126d4260aff83c7609c1] new parent not found
2025/06/26 21:31:01 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:01 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458208127")
2025/06/26 21:31:02 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458208378")
2025/06/26 21:31:02 DEBUG : box root 'rclone-test-rubodap4leje': ["modtime_write_test"(1)|file|ITEM_RENAME|1906263090251|bc237f0905a33f74e17cef52a6a045a00732a8b5] new parent not found
2025/06/26 21:31:02 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:02 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458209122")
2025/06/26 21:31:03 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458209351")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/06/26 21:31:04 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458210121")
2025/06/26 21:31:04 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:04 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458211123")
2025/06/26 21:31:05 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458211362")
2025/06/26 21:31:06 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458212126")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/06/26 21:31:06 DEBUG : box root 'rclone-test-rubodap4leje': ["modtime_write_test.rclone_chunk.001_hle7iv"(0)|file|ITEM_UPLOAD|1906263340050|2bf3023776375f9fd072ced3bc739432c083191c] new parent not found
2025/06/26 21:31:06 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:06 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458213122")
2025/06/26 21:31:07 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458213357")
2025/06/26 21:31:08 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458214126")
2025/06/26 21:31:08 DEBUG : box root 'rclone-test-rubodap4leje': ["modtime_write_test"(1)|file|ITEM_RENAME|1906263340050|5d526e3e2b6e4a08911ec8ee46bdf94a7fc1cbf6] new parent not found
2025/06/26 21:31:08 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:08 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458215119")
2025/06/26 21:31:08 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:08 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458215357")
2025/06/26 21:31:09 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458215591")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/06/26 21:31:10 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458216126")
2025/06/26 21:31:11 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458217124")
2025/06/26 21:31:12 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458218124")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/06/26 21:31:13 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458219124")
2025/06/26 21:31:13 DEBUG : box root 'rclone-test-rubodap4leje': ["file10.txt"(1)|file|ITEM_RENAME|1906263466938|e63db55560683ef5b528c142d354ac8f41a83237] new parent not found
2025/06/26 21:31:13 DEBUG : box root 'rclone-test-rubodap4leje': ["file10.txt.rclone_chunk.001_hleepz"(0)|file|ITEM_UPLOAD|1906263466938|6f695b18a971f6b3a9e6b52a815ffc0c415a4502] new parent not found
2025/06/26 21:31:13 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:13 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458220128")
2025/06/26 21:31:14 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458220364")
2025/06/26 21:31:15 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458221121")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/06/26 21:31:16 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458222125")
2025/06/26 21:31:16 DEBUG : box root 'rclone-test-rubodap4leje': ["file1.txt.rclone_chunk.001_hleip5"(0)|file|ITEM_UPLOAD|1906263968897|630a28d700ddb4f19a8596733f9c71bc262e5c75] new parent not found
2025/06/26 21:31:16 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:16 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458223129")
2025/06/26 21:31:17 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458223373")
2025/06/26 21:31:18 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458224124")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/06/26 21:31:19 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458225122")
2025/06/26 21:31:19 DEBUG : box root 'rclone-test-rubodap4leje': ["file1.txt"(1)|file|ITEM_RENAME|1906263968897|28bd2edd4cbbbb85fc2a131bfa4d02eb2a459ce9] new parent not found
2025/06/26 21:31:19 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:19 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458226121")
2025/06/26 21:31:20 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458226358")
2025/06/26 21:31:21 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458227122")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/06/26 21:31:22 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458228125")
2025/06/26 21:31:22 DEBUG : box root 'rclone-test-rubodap4leje': ["file11.txt.rclone_chunk.001_hleou4"(0)|file|ITEM_UPLOAD|1906256104732|22638730aa82e2c7c21ddb7adf4666d51f77f633] new parent not found
2025/06/26 21:31:22 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:22 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458229121")
2025/06/26 21:31:23 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458229359")
2025/06/26 21:31:24 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458230128")
2025/06/26 21:31:25 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458231122")
2025/06/26 21:31:25 DEBUG : box root 'rclone-test-rubodap4leje': ["file11.txt"(1)|file|ITEM_RENAME|1906256104732|d157e83ef103e081b87a4393a80a06cf1281f5fc] new parent not found
2025/06/26 21:31:25 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:25 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458232129")
2025/06/26 21:31:26 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458232365")
2025/06/26 21:31:27 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458233135")
2025/06/26 21:31:27 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.txt.rclone_chunk.001_hlesds"(0)|file|ITEM_UPLOAD|1906256524357|a47c4282b349d8d05bbb6a048935c6b3cc2212f8] new parent not found
2025/06/26 21:31:27 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:27 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458234124")
2025/06/26 21:31:28 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458234365")
2025/06/26 21:31:29 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458235129")
2025/06/26 21:31:29 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:29 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458236122")
2025/06/26 21:31:29 DEBUG : box root 'rclone-test-rubodap4leje': ["file2"(1)|file|ITEM_TRASH|1906265087380|2f87f928848a2908a23b1ff676206a836430de09] added old path ("dir/file2") for notify
2025/06/26 21:31:29 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.txt"(1)|file|ITEM_RENAME|1906256524357|3f2937960a5d10f4c2aa2e276d476e99a0fcd626] new parent not found
2025/06/26 21:31:29 DEBUG : doChangeNotify("dir/file2", 1)
2025/06/26 21:31:29 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 1 paths and 1 notifications
2025/06/26 21:31:29 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458236358")
2025/06/26 21:31:30 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458236600")
2025/06/26 21:31:30 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1906256790328|bc5b53106d6023c82e475aced6172e06b09264c7] added old path ("dir/file2.rclone_chunk.001") for notify
2025/06/26 21:31:30 DEBUG : doChangeNotify("dir/file2", 1)
2025/06/26 21:31:30 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 1 paths and 1 notifications
2025/06/26 21:31:30 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458237118")
2025/06/26 21:31:31 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458237359")
2025/06/26 21:31:32 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458238126")
2025/06/26 21:31:32 DEBUG : box root 'rclone-test-rubodap4leje': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1906260988488|9024efd4e2764ce877e57aa6e791d9df51277476] added old path ("dir/file2.rclone_chunk.002") for notify
2025/06/26 21:31:32 DEBUG : doChangeNotify("dir/file2", 1)
2025/06/26 21:31:32 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 1 paths and 1 notifications
2025/06/26 21:31:32 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458239121")
2025/06/26 21:31:32 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 0 paths and 0 notifications
2025/06/26 21:31:32 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458239356")
2025/06/26 21:31:33 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458239588")
2025/06/26 21:31:34 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458240125")
2025/06/26 21:31:34 DEBUG : box root 'rclone-test-rubodap4leje': ["file4"(1)|file|ITEM_TRASH|1906261799304|9e1efad02f262dcb4f7397d26dba9277cbdc43a6] added old path ("dir/file4") for notify
2025/06/26 21:31:34 DEBUG : doChangeNotify("dir/file4", 1)
2025/06/26 21:31:34 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 1 paths and 1 notifications
2025/06/26 21:31:34 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458241121")
2025/06/26 21:31:35 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458241353")
2025/06/26 21:31:35 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1906257253363|9568c83939e0bf82f7368b06933c0059d21c6dcf] added old path ("dir/file4.rclone_chunk.001") for notify
2025/06/26 21:31:35 DEBUG : doChangeNotify("dir/file4", 1)
2025/06/26 21:31:35 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 1 paths and 1 notifications
2025/06/26 21:31:35 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458242123")
2025/06/26 21:31:36 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458242367")
2025/06/26 21:31:37 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458243122")
2025/06/26 21:31:37 DEBUG : box root 'rclone-test-rubodap4leje': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1906262771509|d734dd1121c4ea303dd47575e1f7dd64e3ab07e3] added old path ("dir/file4.rclone_chunk.002") for notify
2025/06/26 21:31:37 DEBUG : box root 'rclone-test-rubodap4leje': ["file5.txt.rclone_chunk.001_hlf3kx"(0)|file|ITEM_UPLOAD|1906263231736|88b2c0a5d7098a894bcce40b6e37d99cf75d3dd4] new parent not found
2025/06/26 21:31:37 DEBUG : doChangeNotify("dir/file4", 1)
2025/06/26 21:31:37 DEBUG : box root 'rclone-test-rubodap4leje': Received 2 events, resulting in 1 paths and 1 notifications
2025/06/26 21:31:37 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458244126")
2025/06/26 21:31:38 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458244366")
2025/06/26 21:31:38 DEBUG : box root 'rclone-test-rubodap4leje': ["file3"(1)|file|ITEM_TRASH|1906260738253|be37e315c298781349ecf7085c5a3128e303beb1] added old path ("dir/file3") for notify
2025/06/26 21:31:38 DEBUG : doChangeNotify("dir/file3", 1)
2025/06/26 21:31:38 DEBUG : box root 'rclone-test-rubodap4leje': Received 1 events, resulting in 1 paths and 1 notifications
2025/06/26 21:31:38 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458245126")
2025/06/26 21:31:39 DEBUG : box root 'rclone-test-rubodap4leje': Checking for changes on remote (next_stream_position: "30401048458245360")
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/06/26 21:31:43 INFO  : file name.txt.rclone_chunk.001_hlfdgl: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/06/26 21:31:44 INFO  : file name.txt.rclone_chunk.002_hlfdgl: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/06/26 21:31:51 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_hlflfg: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/06/26 21:31:52 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_hlflfg: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/06/26 21:32:04 INFO  : file name.txt.rclone_chunk.001_hlfu0v: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/06/26 21:32:04 INFO  : file name.txt.rclone_chunk.002_hlfu0v: 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/06/26 21:32:12 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:"
2025/06/26 21:32:12 DEBUG : Creating backend with remote "TestBox:"
2025/06/26 21:32:12 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/06/26 21:32:27 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.001_hlgk4q: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001
2025/06/26 21:32:28 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.002_hlgk4q: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2025/06/26 21:32:42 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_hlgyk6: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001
2025/06/26 21:32:42 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_hlgyk6: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002
2025/06/26 21:32:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje/dirToPurgeFromRoot"
2025/06/26 21:32:46 DEBUG : Config file has changed externally - reloading
2025/06/26 21:32:46 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/dirToPurgeFromRoot"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2025/06/26 21:32:51 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje/hello? sausage/êé"
2025/06/26 21:32:51 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/hello? sausage/êé"
2025/06/26 21:33:02 INFO  : a/b/c/d/e.txt.rclone_chunk.001_hlhff6: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001
2025/06/26 21:33:03 INFO  : a/b/c/d/e.txt.rclone_chunk.002_hlhff6: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2025/06/26 21:33:12 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/06/26 21:33:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks...
2025/06/26 21:33:27 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001
2025/06/26 21:33:28 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002
2025/06/26 21:33:29 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt
2025/06/26 21:33:34 DEBUG : file name.txt: move 2 data chunks...
2025/06/26 21:33:36 INFO  : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001
2025/06/26 21:33:38 INFO  : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002
2025/06/26 21:33:39 INFO  : file name.txt: Moved (server-side) to: moveTest/other.txt
2025/06/26 21:33:44 DEBUG : moveTest/other.txt: move 2 data chunks...
2025/06/26 21:33:45 INFO  : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/06/26 21:33:46 INFO  : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/06/26 21:33:48 INFO  : moveTest/other.txt: Moved (server-side) to: file name.txt
2025/06/26 21:33:53 DEBUG : other.txt: move 2 data chunks...
2025/06/26 21:33:54 INFO  : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/06/26 21:33:55 INFO  : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/06/26 21:33:56 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/06/26 21:34:01 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-fudelud1hefi"
2025/06/26 21:34:01 DEBUG : Creating backend with remote "TestBox:rclone-test-fudelud1hefi"
2025/06/26 21:34:01 DEBUG : box root 'rclone-test-fudelud1hefi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/06/26 21:34:02 DEBUG : box root 'rclone-test-fudelud1hefi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/06/26 21:34:08 DEBUG : box root 'rclone-test-rubodap4leje': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/06/26 21:34:11 DEBUG : box root 'rclone-test-rubodap4leje': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/06/26 21:34:17 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-fudelud1hefi': 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/06/26 21:34:55 INFO  : file name.txt.rclone_chunk.001_hlkju0: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/06/26 21:34:56 INFO  : file name.txt.rclone_chunk.002_hlkju0: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/06/26 21:34:56 INFO  : file name.txt.rclone_chunk.003_hlkju0: Moved (server-side) to: file name.txt.rclone_chunk.003
2025/06/26 21:34:57 INFO  : file name.txt.rclone_chunk.004_hlkju0: Moved (server-side) to: file name.txt.rclone_chunk.004
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2025/06/26 21:35:05 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/06/26 21:35:05 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/06/26 21:35:09 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-rubodap4leje/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-rubodap4leje/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2025/06/26 21:35:10 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje/not found.txt"
2025/06/26 21:35:10 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/not found.txt"
2025/06/26 21:35:13 ERROR : error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-rubodap4leje" from "TestChunkerChunk50bBox:rclone-test-rubodap4leje"
2025/06/26 21:35:13 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/06/26 21:35:19 INFO  : rclone-test-rubodap4leje/created from root.txt.rclone_chunk.001_hlld9d: Moved (server-side) to: rclone-test-rubodap4leje/created from root.txt.rclone_chunk.001
2025/06/26 21:35:20 INFO  : rclone-test-rubodap4leje/created from root.txt.rclone_chunk.002_hlld9d: Moved (server-side) to: rclone-test-rubodap4leje/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/06/26 21:35:45 INFO  : piped data.txt.rclone_chunk.001_hlm44d: Moved (server-side) to: piped data.txt
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2025/06/26 21:35:53 INFO  : piped data.txt.rclone_chunk.001_hlmazg: Moved (server-side) to: piped data.txt.rclone_chunk.001
2025/06/26 21:35:54 INFO  : piped data.txt.rclone_chunk.002_hlmazg: Moved (server-side) to: piped data.txt.rclone_chunk.002
2025/06/26 21:35:55 INFO  : piped data.txt.rclone_chunk.003_hlmazg: 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/06/26 21:36:03 INFO  : Chunked 'TestChunkerChunk50bBox:rclone-test-rubodap4leje': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2025/06/26 21:36:07 INFO  : small/emptyfile.rclone_chunk.001_hlmp7r: Moved (server-side) to: small/emptyfile
2025/06/26 21:36:14 INFO  : small/smallfile.rclone_chunk.001_hlmxy1: Moved (server-side) to: small/smallfile
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
2025/06/26 21:36:30 INFO  : corrupted/billy.rclone_chunk.001_hln629: Moved (server-side) to: corrupted/billy.rclone_chunk.001
2025/06/26 21:36:30 INFO  : corrupted/billy.rclone_chunk.002_hln629: Moved (server-side) to: corrupted/billy.rclone_chunk.002
2025/06/26 21:36:31 INFO  : corrupted/billy.rclone_chunk.003_hln629: Moved (server-side) to: corrupted/billy.rclone_chunk.003
2025/06/26 21:36:31 INFO  : corrupted/billy.rclone_chunk.004_hln629: Moved (server-side) to: corrupted/billy.rclone_chunk.004
2025/06/26 21:36:32 INFO  : corrupted/billy.rclone_chunk.005_hln629: Moved (server-side) to: corrupted/billy.rclone_chunk.005
2025/06/26 21:36:44 INFO  : corrupted/silly1.rclone_chunk.001_hlnlu0: Moved (server-side) to: corrupted/silly1.rclone_chunk.001
2025/06/26 21:36:44 INFO  : corrupted/silly1.rclone_chunk.002_hlnlu0: Moved (server-side) to: corrupted/silly1.rclone_chunk.002
2025/06/26 21:36:45 INFO  : corrupted/silly1.rclone_chunk.003_hlnlu0: Moved (server-side) to: corrupted/silly1.rclone_chunk.003
2025/06/26 21:36:45 INFO  : corrupted/silly1.rclone_chunk.004_hlnlu0: Moved (server-side) to: corrupted/silly1.rclone_chunk.004
2025/06/26 21:36:46 INFO  : corrupted/silly1.rclone_chunk.005_hlnlu0: Moved (server-side) to: corrupted/silly1.rclone_chunk.005
2025/06/26 21:36:59 INFO  : corrupted/silly2.rclone_chunk.001_hlo02h: Moved (server-side) to: corrupted/silly2.rclone_chunk.001
2025/06/26 21:36:59 INFO  : corrupted/silly2.rclone_chunk.002_hlo02h: Moved (server-side) to: corrupted/silly2.rclone_chunk.002
2025/06/26 21:37:00 INFO  : corrupted/silly2.rclone_chunk.003_hlo02h: Moved (server-side) to: corrupted/silly2.rclone_chunk.003
2025/06/26 21:37:00 INFO  : corrupted/silly2.rclone_chunk.004_hlo02h: Moved (server-side) to: corrupted/silly2.rclone_chunk.004
2025/06/26 21:37:01 INFO  : corrupted/silly2.rclone_chunk.005_hlo02h: Moved (server-side) to: corrupted/silly2.rclone_chunk.005
2025/06/26 21:37:16 INFO  : corrupted/silly3.rclone_chunk.001_hlohk4: Moved (server-side) to: corrupted/silly3.rclone_chunk.001
2025/06/26 21:37:16 INFO  : corrupted/silly3.rclone_chunk.002_hlohk4: Moved (server-side) to: corrupted/silly3.rclone_chunk.002
2025/06/26 21:37:17 INFO  : corrupted/silly3.rclone_chunk.003_hlohk4: Moved (server-side) to: corrupted/silly3.rclone_chunk.003
2025/06/26 21:37:17 INFO  : corrupted/silly3.rclone_chunk.004_hlohk4: Moved (server-side) to: corrupted/silly3.rclone_chunk.004
2025/06/26 21:37:18 INFO  : corrupted/silly3.rclone_chunk.005_hlohk4: Moved (server-side) to: corrupted/silly3.rclone_chunk.005
2025/06/26 21:37:30 INFO  : corrupted/willy.rclone_chunk.001_hlovst: Moved (server-side) to: corrupted/willy.rclone_chunk.001
2025/06/26 21:37:30 INFO  : corrupted/willy.rclone_chunk.002_hlovst: Moved (server-side) to: corrupted/willy.rclone_chunk.002
2025/06/26 21:37:31 INFO  : corrupted/willy.rclone_chunk.003_hlovst: Moved (server-side) to: corrupted/willy.rclone_chunk.003
2025/06/26 21:37:32 INFO  : corrupted/willy.rclone_chunk.004_hlovst: Moved (server-side) to: corrupted/willy.rclone_chunk.004
2025/06/26 21:37:32 INFO  : corrupted/willy.rclone_chunk.005_hlovst: Moved (server-side) to: corrupted/willy.rclone_chunk.005
2025/06/26 21:37:45 INFO  : corrupted/silly4.rclone_chunk.001_hlpay5: Moved (server-side) to: corrupted/silly4.rclone_chunk.001
2025/06/26 21:37:46 INFO  : corrupted/silly4.rclone_chunk.002_hlpay5: Moved (server-side) to: corrupted/silly4.rclone_chunk.002
2025/06/26 21:37:47 INFO  : corrupted/silly4.rclone_chunk.003_hlpay5: Moved (server-side) to: corrupted/silly4.rclone_chunk.003
2025/06/26 21:37:47 INFO  : corrupted/silly4.rclone_chunk.004_hlpay5: Moved (server-side) to: corrupted/silly4.rclone_chunk.004
2025/06/26 21:37:48 INFO  : corrupted/silly4.rclone_chunk.005_hlpay5: Moved (server-side) to: corrupted/silly4.rclone_chunk.005
2025/06/26 21:37:51 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy"
2025/06/26 21:38:01 INFO  : corrupted/silly5.rclone_chunk.001_hlppax: Moved (server-side) to: corrupted/silly5.rclone_chunk.001
2025/06/26 21:38:02 INFO  : corrupted/silly5.rclone_chunk.002_hlppax: Moved (server-side) to: corrupted/silly5.rclone_chunk.002
2025/06/26 21:38:02 INFO  : corrupted/silly5.rclone_chunk.003_hlppax: Moved (server-side) to: corrupted/silly5.rclone_chunk.003
2025/06/26 21:38:03 INFO  : corrupted/silly5.rclone_chunk.004_hlppax: Moved (server-side) to: corrupted/silly5.rclone_chunk.004
2025/06/26 21:38:03 INFO  : corrupted/silly5.rclone_chunk.005_hlppax: Moved (server-side) to: corrupted/silly5.rclone_chunk.005
2025/06/26 21:38:06 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow
2025/06/26 21:38:29 INFO  : wreaked/wreaker.rclone_chunk.001_hlqlas: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001
2025/06/26 21:38:29 INFO  : wreaked/wreaker.rclone_chunk.002_hlqlas: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002
2025/06/26 21:38:34 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-rubodap4leje': invalid directory entry "wreaked/wreaker"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2025/06/26 21:38:49 ERROR : usermeta/today.rclone_chunk.001_hlr9kr: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1906265786038","file_version":{"type":"file_version","id":"2102790928438","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_hlr9kr"}})
2025/06/26 21:38:51 INFO  : usermeta/today.rclone_chunk.001: Deleted
2025/06/26 21:38:52 INFO  : usermeta/today.rclone_chunk.001_hlr9kr: Moved (server-side) to: usermeta/today.rclone_chunk.001
2025/06/26 21:39:03 ERROR : usermeta/past.rclone_chunk.001_hlrnnj: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1906268787879","file_version":{"type":"file_version","id":"2102793990279","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_hlrnnj"}})
2025/06/26 21:39:05 INFO  : usermeta/past.rclone_chunk.001: Deleted
2025/06/26 21:39:06 INFO  : usermeta/past.rclone_chunk.001_hlrnnj: Moved (server-side) to: usermeta/past.rclone_chunk.001
2025/06/26 21:39:17 ERROR : usermeta/future.rclone_chunk.001_hls1od: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1906263501077","file_version":{"type":"file_version","id":"2102788537877","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_hls1od"}})
2025/06/26 21:39:19 INFO  : usermeta/future.rclone_chunk.001: Deleted
2025/06/26 21:39:20 INFO  : usermeta/future.rclone_chunk.001_hls1od: Moved (server-side) to: usermeta/future.rclone_chunk.001
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof
2025/06/26 21:39:40 DEBUG : future/test: Can't move - required hash not found
2025/06/26 21:39:40 DEBUG : future/test: Can't move, switching to copy
2025/06/26 21:39:41 DEBUG : future/test: Can't copy - required hash not found
2025/06/26 21:39:42 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/06/26 21:39:42 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/06/26 21:39:43 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-rubodap4leje': File to upload is small (3 bytes), uploading instead of streaming
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility
2025/06/26 21:40:27 INFO  : backcomp/renamefile.rclone_chunk.001_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001
2025/06/26 21:40:28 INFO  : backcomp/renamefile.rclone_chunk.002_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002
2025/06/26 21:40:28 INFO  : backcomp/renamefile.rclone_chunk.003_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003
2025/06/26 21:40:29 INFO  : backcomp/renamefile.rclone_chunk.004_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004
2025/06/26 21:40:29 INFO  : backcomp/renamefile.rclone_chunk.005_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005
2025/06/26 21:40:30 INFO  : backcomp/renamefile.rclone_chunk.006_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006
2025/06/26 21:40:31 INFO  : backcomp/renamefile.rclone_chunk.007_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007
2025/06/26 21:40:31 INFO  : backcomp/renamefile.rclone_chunk.008_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008
2025/06/26 21:40:32 INFO  : backcomp/renamefile.rclone_chunk.009_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009
2025/06/26 21:40:32 INFO  : backcomp/renamefile.rclone_chunk.010_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010
2025/06/26 21:40:33 INFO  : backcomp/renamefile.rclone_chunk.011_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011
2025/06/26 21:40:33 INFO  : backcomp/renamefile.rclone_chunk.012_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012
2025/06/26 21:40:34 INFO  : backcomp/renamefile.rclone_chunk.013_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013
2025/06/26 21:40:35 INFO  : backcomp/renamefile.rclone_chunk.014_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014
2025/06/26 21:40:35 INFO  : backcomp/renamefile.rclone_chunk.015_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015
2025/06/26 21:40:36 INFO  : backcomp/renamefile.rclone_chunk.016_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016
2025/06/26 21:40:36 INFO  : backcomp/renamefile.rclone_chunk.017_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017
2025/06/26 21:40:37 INFO  : backcomp/renamefile.rclone_chunk.018_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018
2025/06/26 21:40:37 INFO  : backcomp/renamefile.rclone_chunk.019_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019
2025/06/26 21:40:38 INFO  : backcomp/renamefile.rclone_chunk.020_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020
2025/06/26 21:40:39 INFO  : backcomp/renamefile.rclone_chunk.021_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021
2025/06/26 21:40:39 INFO  : backcomp/renamefile.rclone_chunk.022_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022
2025/06/26 21:40:40 INFO  : backcomp/renamefile.rclone_chunk.023_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023
2025/06/26 21:40:40 INFO  : backcomp/renamefile.rclone_chunk.024_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024
2025/06/26 21:40:41 INFO  : backcomp/renamefile.rclone_chunk.025_hlsysm: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove
2025/06/26 21:41:23 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje/servermovetest/subdir1"
2025/06/26 21:41:23 DEBUG : Config file has changed externally - reloading
2025/06/26 21:41:23 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/servermovetest/subdir1"
2025/06/26 21:41:25 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje/servermovetest/subdir2"
2025/06/26 21:41:25 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/servermovetest/subdir2"
2025/06/26 21:41:34 INFO  : movefile.rclone_chunk.001_hlvppy: Moved (server-side) to: movefile.rclone_chunk.001
2025/06/26 21:41:34 INFO  : movefile.rclone_chunk.002_hlvppy: Moved (server-side) to: movefile.rclone_chunk.002
2025/06/26 21:41:38 DEBUG : movefile: move 2 data chunks...
2025/06/26 21:41:41 INFO  : movefile.rclone_chunk.001: Moved (server-side)
2025/06/26 21:41:42 INFO  : movefile.rclone_chunk.002: Moved (server-side)
2025/06/26 21:41:43 INFO  : movefile: Moved (server-side)
2025/06/26 21:41:44 INFO  : movefile: Moved (server-side)
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow
2025/06/26 21:41:49 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-rubodap4leje/md5all"
2025/06/26 21:41:49 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name
2025/06/26 21:41:49 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/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/06/26 21:41:57 INFO  : unknown-size-put.txt.rclone_chunk.001_hlwdr5: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001
2025/06/26 21:41:57 INFO  : unknown-size-put.txt.rclone_chunk.002_hlwdr5: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002
2025/06/26 21:41:58 INFO  : unknown-size-put.txt.rclone_chunk.003_hlwdr5: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2025/06/26 21:42:10 INFO  : unknown-size-update.txt.rclone_chunk.001_hlws8k: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/06/26 21:42:11 INFO  : unknown-size-update.txt.rclone_chunk.002_hlws8k: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/06/26 21:42:26 INFO  : unknown-size-update.txt.rclone_chunk.001_hlx1wb: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/06/26 21:42:27 INFO  : unknown-size-update.txt.rclone_chunk.002_hlx1wb: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/06/26 21:42:27 INFO  : unknown-size-update.txt.rclone_chunk.003_hlx1wb: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003
2025/06/26 21:42:28 INFO  : unknown-size-update.txt.rclone_chunk.004_hlx1wb: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004
2025/06/26 21:42:28 INFO  : unknown-size-update.txt.rclone_chunk.005_hlx1wb: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2025/06/26 21:42:38 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rubodap4leje/deeper/nonexisting/directory"
2025/06/26 21:42:38 DEBUG : Creating backend with remote "TestBox:rclone-test-rubodap4leje/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/06/26 21:42:47 DEBUG : box root 'rclone-test-rubodap4leje': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/06/26 21:42:47 ERROR : error listing: directory not found
2025/06/26 21:42:47 DEBUG : box root 'rclone-test-rubodap4leje': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsShutdown
--- FAIL: TestIntegration (1116.64s)
    --- 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 (1.13s)
    --- FAIL: TestIntegration/FsMkdir (1112.76s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.63s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.34s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.31s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.32s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (292.91s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (15.32s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (15.59s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (15.60s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (15.36s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (15.63s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (15.40s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (15.22s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (15.77s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (15.53s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (15.06s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (15.26s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (15.33s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (15.31s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (15.16s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (15.51s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (15.09s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (16.01s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (15.10s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (15.34s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.70s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (62.85s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.51s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (72.41s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (612.10s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.72s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.73s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.35s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.50s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.71s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.71s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.75s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.97s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.38s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.41s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.73s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (13.98s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (15.33s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (18.66s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (13.98s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (36.87s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (17.49s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.30s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.94s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.94s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.96s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.95s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.96s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.96s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.99s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.95s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.51s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.96s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.33s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.59s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.38s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (20.50s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.07s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.20s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (3.13s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (17.64s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.70s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.36s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (15.58s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (6.30s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.97s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (9.81s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.29s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (21.03s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.64s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (15.38s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (348.22s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (16.87s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (123.03s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (20.83s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (44.25s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (19.64s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (95.82s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (26.19s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (1.61s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (47.38s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (14.48s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (32.89s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (3.03s)
        --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsDirectory (2.34s)
            --- SKIP: TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap (0.00s)
    --- PASS: TestIntegration/FsShutdown (0.00s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	1116.706s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished OK in 18m39.733884369s (try 1/5)