"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/21 01:25:15 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu"
2025/05/21 01:25:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/21 01:25:15 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu"
2025/05/21 01:25:16 DEBUG : box root 'rclone-test-nolozob8dinu': 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/05/21 01:25:18 DEBUG : box root 'rclone-test-nolozob8dinu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/21 01:25:18 DEBUG : box root 'rclone-test-nolozob8dinu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsString
=== RUN   TestIntegration/FsName
=== RUN   TestIntegration/FsRoot
=== RUN   TestIntegration/FsRmdirEmpty
=== RUN   TestIntegration/FsMkdir
2025/05/21 01:25:21 DEBUG : box root 'rclone-test-nolozob8dinu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2025/05/21 01:25:22 INFO  : dir/subdir: Making directory
2025/05/21 01:25:26 INFO  : dir/subdir: Removing directory
2025/05/21 01:25:28 INFO  : dir: Removing directory
=== RUN   TestIntegration/FsMkdir/FsListEmpty
=== RUN   TestIntegration/FsMkdir/FsListDirEmpty
=== RUN   TestIntegration/FsMkdir/FsListRDirEmpty
    fstests.go:399: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsListDirNotFound
2025/05/21 01:25:30 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/05/21 01:25:37 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_ldks4m: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001
2025/05/21 01:25:38 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_ldks4m: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:707: testing "．"
2025/05/21 01:25:53 INFO  : ．/．.rclone_chunk.001_ldl9tn: Moved (server-side) to: ．/．.rclone_chunk.001
2025/05/21 01:25:54 INFO  : ．/．.rclone_chunk.002_ldl9tn: Moved (server-side) to: ．/．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:707: testing "．．"
2025/05/21 01:26:10 INFO  : ．．/．．.rclone_chunk.001_ldlpbz: Moved (server-side) to: ．．/．．.rclone_chunk.001
2025/05/21 01:26:11 INFO  : ．．/．．.rclone_chunk.002_ldlpbz: Moved (server-side) to: ．．/．．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2025/05/21 01:26:26 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_ldm646: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001
2025/05/21 01:26:27 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_ldm646: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:707: testing " leading space"
2025/05/21 01:26:43 INFO  :  leading space/ leading space.rclone_chunk.001_ldmnns: Moved (server-side) to:  leading space/ leading space.rclone_chunk.001
2025/05/21 01:26:44 INFO  :  leading space/ leading space.rclone_chunk.002_ldmnns: Moved (server-side) to:  leading space/ leading space.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:707: testing "~leading tilde"
2025/05/21 01:26:59 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_ldn31z: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001
2025/05/21 01:27:00 INFO  : ~leading tilde/~leading tilde.rclone_chunk.002_ldn31z: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:707: testing "␍leading CR"
2025/05/21 01:27:16 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_ldnk38: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001
2025/05/21 01:27:17 INFO  : ␍leading CR/␍leading CR.rclone_chunk.002_ldnk38: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:707: testing "␊leading LF"
2025/05/21 01:27:33 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_ldo08a: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001
2025/05/21 01:27:33 INFO  : ␊leading LF/␊leading LF.rclone_chunk.002_ldo08a: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:707: testing "␉leading HT"
2025/05/21 01:27:49 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_ldoh0e: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001
2025/05/21 01:27:50 INFO  : ␉leading HT/␉leading HT.rclone_chunk.002_ldoh0e: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:707: testing "␋leading VT"
2025/05/21 01:28:07 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_ldoxt0: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001
2025/05/21 01:28:07 INFO  : ␋leading VT/␋leading VT.rclone_chunk.002_ldoxt0: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:707: testing ".leading dot"
2025/05/21 01:28:23 INFO  : .leading dot/.leading dot.rclone_chunk.001_ldpej1: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001
2025/05/21 01:28:23 INFO  : .leading dot/.leading dot.rclone_chunk.002_ldpej1: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002
2025/05/21 01:28:32 DEBUG : TestBox: Loaded invalid token from config file - ignoring
2025/05/21 01:28:32 DEBUG : Config file has changed externally - reloading
2025/05/21 01:28:32 DEBUG : Saving config "token" in section "TestBox" of the config file
2025/05/21 01:28:32 DEBUG : TestBox: Saved new token in config file
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:707: testing "trailing space "
2025/05/21 01:28:40 INFO  : trailing space /trailing space .rclone_chunk.001_ldpv0c: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001
2025/05/21 01:28:40 INFO  : trailing space /trailing space .rclone_chunk.002_ldpv0c: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:707: testing "trailing CR␍"
2025/05/21 01:28:56 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_ldqcof: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001
2025/05/21 01:28:57 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.002_ldqcof: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:707: testing "trailing LF␊"
2025/05/21 01:29:12 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_ldqsn0: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001
2025/05/21 01:29:13 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.002_ldqsn0: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:707: testing "trailing HT␉"
2025/05/21 01:29:28 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_ldr8qe: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001
2025/05/21 01:29:29 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.002_ldr8qe: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:707: testing "trailing VT␋"
2025/05/21 01:29:45 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_ldro0z: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001
2025/05/21 01:29:45 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.002_ldro0z: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:707: testing "trailing dot."
2025/05/21 01:30:01 INFO  : trailing dot./trailing dot..rclone_chunk.001_lds4wp: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001
2025/05/21 01:30:02 INFO  : trailing dot./trailing dot..rclone_chunk.002_lds4wp: 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/05/21 01:30:18 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_ldslu8: Moved (server-side) to: invalid utf-8�/invalid utf-8�.rclone_chunk.001
2025/05/21 01:30:18 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.002_ldslu8: 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/05/21 01:30:34 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_ldt2hh: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001
2025/05/21 01:30:35 INFO  : test%46.txt/test%46.txt.rclone_chunk.002_ldt2hh: 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/05/21 01:31:55 INFO  : zero-length-file.rclone_chunk.001_ldvc37: 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/05/21 01:31:59 INFO  : dir: Making directory
2025/05/21 01:32:00 INFO  : dir/subdir1: Making directory
2025/05/21 01:32:01 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275867574")
2025/05/21 01:32:02 DEBUG : box root 'rclone-test-nolozob8dinu': ["zero-length-file"(1)|file|ITEM_RENAME|1868417084788|04a6c12f84194aab6076037756b78d0db666f489] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:02 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:02 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275868818")
2025/05/21 01:32:02 INFO  : dir/subdir3: Making directory
2025/05/21 01:32:02 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275869064")
2025/05/21 01:32:03 DEBUG : box root 'rclone-test-nolozob8dinu': ["zero-length-file.rclone_chunk.001_ldvc37"(0)|file|ITEM_UPLOAD|1868417084788|9ed6b3b094b62abbeba65933d79f19c5cae34932] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:03 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.copy5.txt"(0)|file|ITEM_UPLOAD|1868317494682|a2c81e0ad12e6031807061161329b3fedd6adc31] new parent not found
2025/05/21 01:32:03 DEBUG : box root 'rclone-test-nolozob8dinu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:03 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275869809")
2025/05/21 01:32:03 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:03 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275870051")
2025/05/21 01:32:03 INFO  : dir/subdir2: Making directory
2025/05/21 01:32:03 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275870280")
2025/05/21 01:32:04 DEBUG : box root 'rclone-test-nolozob8dinu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1868417799672|09fcccd330d1d05dad23b858c1ae7fe1957e6f83] new parent not found
2025/05/21 01:32:04 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:04 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275870814")
2025/05/21 01:32:04 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275871065")
2025/05/21 01:32:05 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275871820")
2025/05/21 01:32:06 DEBUG : box root 'rclone-test-nolozob8dinu': ["zero-length-file"(2)|file|ITEM_TRASH|1868417084788|60fc539d4ead0817bbaaba4386485e0542bc75a5] added old path ("zero-length-file") for notify
2025/05/21 01:32:06 DEBUG : box root 'rclone-test-nolozob8dinu': ["dir"(0)|folder|ITEM_CREATE|322176153064|8015c29742ae9c11e21f52efd871b567d46f399d] added new path ("dir") for notify
2025/05/21 01:32:06 DEBUG : box root 'rclone-test-nolozob8dinu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1868418764458|b0c3556a8152a9fdf1bea2627d4741e4fdf0a501] new parent not found
2025/05/21 01:32:06 DEBUG : doChangeNotify("zero-length-file", 1)
2025/05/21 01:32:06 DEBUG : doChangeNotify("dir", 0)
2025/05/21 01:32:06 DEBUG : box root 'rclone-test-nolozob8dinu': Received 4 events, resulting in 2 paths and 2 notifications
2025/05/21 01:32:06 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275872809")
2025/05/21 01:32:06 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275873071")
2025/05/21 01:32:07 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275873828")
2025/05/21 01:32:08 DEBUG : box root 'rclone-test-nolozob8dinu': ["subdir1"(0)|folder|ITEM_CREATE|322178955839|8c5a279ebdb94f8b21d284d37e938b4e0d90f128] added new path ("dir/subdir1") for notify
2025/05/21 01:32:08 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/21 01:32:08 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/21 01:32:08 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275874806")
2025/05/21 01:32:08 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:08 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275875054")
2025/05/21 01:32:08 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275875293")
2025/05/21 01:32:09 INFO  : dir/file2.rclone_chunk.001_ldvpd5: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/21 01:32:09 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275875809")
2025/05/21 01:32:10 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:10 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275876809")
2025/05/21 01:32:10 DEBUG : box root 'rclone-test-nolozob8dinu': ["subdir"(0)|folder|ITEM_CREATE|322174196994|cf429987e8a38c24f8ba7ec697c0e244be60e931] new parent not found
2025/05/21 01:32:10 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:10 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275877057")
2025/05/21 01:32:10 INFO  : dir/file2.rclone_chunk.002_ldvpd5: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/21 01:32:10 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275877295")
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275877811")
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': ["subdir2"(0)|folder|ITEM_CREATE|322176111853|53377ccad5626699a637ee74853698423cbc112b] added new path ("dir/subdir2") for notify
2025/05/21 01:32:11 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275878046")
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': ["subdir3"(0)|folder|ITEM_CREATE|322177266982|db6bde3a5d5b92190c359dc3041775278b519a6c] added new path ("dir/subdir3") for notify
2025/05/21 01:32:11 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275878286")
2025/05/21 01:32:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275878516")
2025/05/21 01:32:12 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275878807")
2025/05/21 01:32:13 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275879809")
2025/05/21 01:32:14 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.rclone_chunk.001_ldvpd5"(0)|file|ITEM_UPLOAD|1868420067769|40742f3d0ca1cb1d0548da40bb4e59d66c05c28e] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:14 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:14 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275880805")
2025/05/21 01:32:14 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275881052")
2025/05/21 01:32:15 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.rclone_chunk.002_ldvpd5"(0)|file|ITEM_UPLOAD|1868420898161|77f8b97685201bd6c2cd21b0d07968ee854a19b9] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:15 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:15 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275881819")
2025/05/21 01:32:15 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275882067")
2025/05/21 01:32:16 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1868420898161|e63706cb74753d106f16f9b111a30ab1d4b1cd6e] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:16 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1868420067769|5cc4befcfb3a07cffbec765d1e42119f5e394c0c] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:16 DEBUG : box root 'rclone-test-nolozob8dinu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:16 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275882805")
2025/05/21 01:32:16 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275883046")
2025/05/21 01:32:17 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275883813")
2025/05/21 01:32:18 INFO  : dir/file4.rclone_chunk.001_ldvxf7: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/21 01:32:18 DEBUG : box root 'rclone-test-nolozob8dinu': ["ReadFile.rclone_chunk.001_ldvtz1"(0)|file|ITEM_UPLOAD|1868337896507|9e2d2c9c3a86c905b02030ea5f3f002bf3f08525] new parent not found
2025/05/21 01:32:18 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:18 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275884807")
2025/05/21 01:32:18 INFO  : dir/file4.rclone_chunk.002_ldvxf7: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/21 01:32:18 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275885053")
2025/05/21 01:32:19 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2"(0)|file|ITEM_UPLOAD|1868417490886|dde36cc367563c357504a8ab42edff0b7561243d] ignored due to old SequenceID ('\x00')
2025/05/21 01:32:19 DEBUG : box root 'rclone-test-nolozob8dinu': ["ReadFile"(1)|file|ITEM_RENAME|1868337896507|3e557b71e7af0360ddf22d3e900314936b8bf888] new parent not found
2025/05/21 01:32:19 DEBUG : box root 'rclone-test-nolozob8dinu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:19 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275885812")
2025/05/21 01:32:19 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275886056")
2025/05/21 01:32:20 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275886805")
2025/05/21 01:32:21 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:21 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275887811")
2025/05/21 01:32:21 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4.rclone_chunk.001_ldvxf7"(0)|file|ITEM_UPLOAD|1868420642187|3d22c75bf30840aba87de1a669abde8259a0d0f1] added new path ("dir/file4.rclone_chunk.001_ldvxf7") for notify
2025/05/21 01:32:21 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_ldvxf7", 1)
2025/05/21 01:32:21 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/21 01:32:21 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275888049")
2025/05/21 01:32:21 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275888304")
2025/05/21 01:32:22 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275888806")
2025/05/21 01:32:23 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:23 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275889808")
2025/05/21 01:32:23 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275890048")
2025/05/21 01:32:24 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4.rclone_chunk.002_ldvxf7"(0)|file|ITEM_UPLOAD|1868420850154|e23c115a0f4aaebd51917474773ea69ec62290ef] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:24 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1868420642187|5606321281a2164aeb36f03487db508e2288e932] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:24 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:24 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275890808")
2025/05/21 01:32:24 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275891055")
2025/05/21 01:32:25 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275891808")
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1868420850154|f875017c7a33a4d0e3e2e830db0dfd627a78eaf6] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4"(0)|file|ITEM_UPLOAD|1868348805040|a7b7033edeed20eb93acfce502e8cc3e9d03e6f4] ignored due to old SequenceID ('\x00')
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275892806")
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.rclone_chunk.001_ldw226"(0)|file|ITEM_UPLOAD|1868410782146|25311c82a53649042a6e6e75d693faf67df8d5a6] new parent not found
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275893046")
2025/05/21 01:32:26 INFO  : dir/file3.rclone_chunk.001_ldw53s: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/21 01:32:26 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275893290")
2025/05/21 01:32:27 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.txt"(0)|file|ITEM_UPLOAD|1868421534019|a46a67f0876eb87cb3894f7013a30d6a0892b823] new parent not found
2025/05/21 01:32:27 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:27 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275893809")
2025/05/21 01:32:27 INFO  : dir/file3.rclone_chunk.002_ldw53s: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/21 01:32:27 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275894049")
2025/05/21 01:32:28 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1"(1)|file|ITEM_RENAME|1868410782146|8d928a9eb2c593ebc713d44687eb133ebe026fbf] new parent not found
2025/05/21 01:32:28 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:28 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275894823")
2025/05/21 01:32:28 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275895053")
2025/05/21 01:32:29 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275895811")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/21 01:32:30 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.rclone_chunk.001_ldw5zx"(0)|file|ITEM_UPLOAD|1868331063721|f6d3433ae476b013fb51dc62c0f7d28103fc611b] new parent not found
2025/05/21 01:32:30 DEBUG : box root 'rclone-test-nolozob8dinu': ["file3.rclone_chunk.001_ldw53s"(0)|file|ITEM_UPLOAD|1868343424165|c70fa9786083a5a62a675fc029b2699f5de3e0e2] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:30 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:30 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275896814")
2025/05/21 01:32:30 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275897061")
2025/05/21 01:32:31 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2"(1)|file|ITEM_RENAME|1868331063721|ac4115d7457beac63180bdf41bc3eecd92c1383d] new parent not found
2025/05/21 01:32:31 DEBUG : box root 'rclone-test-nolozob8dinu': ["file3.rclone_chunk.002_ldw53s"(0)|file|ITEM_UPLOAD|1868418140973|d6e8cb8b533b6403f420412bf10d84719f64ede6] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:31 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:31 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275897851")
2025/05/21 01:32:31 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275898102")
2025/05/21 01:32:32 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275898810")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/21 01:32:33 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1868348946683|b7d0c4a37707692106549391a9806dbb5133ff3b] new parent not found
2025/05/21 01:32:33 DEBUG : box root 'rclone-test-nolozob8dinu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1868343424165|e8c0b02910434ed846fe1a7ca8cfb7e7f30b3892] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:33 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:33 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275899812")
2025/05/21 01:32:33 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275900057")
2025/05/21 01:32:34 DEBUG : box root 'rclone-test-nolozob8dinu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1868418140973|77a2f631cde07b5428a5bd7804ee35728195a430] ignored due to old SequenceID ('\x01')
2025/05/21 01:32:34 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:34 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275900811")
2025/05/21 01:32:34 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275901055")
2025/05/21 01:32:35 DEBUG : box root 'rclone-test-nolozob8dinu': ["file3"(0)|file|ITEM_UPLOAD|1868412217444|6d83f15f39568b4e5f823794c91f77c424c7648d] ignored due to old SequenceID ('\x00')
2025/05/21 01:32:35 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:35 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275901812")
2025/05/21 01:32:35 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275902050")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/21 01:32:36 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275902804")
2025/05/21 01:32:37 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.copy2.txt"(0)|file|ITEM_UPLOAD|1868412882084|8f72778be6fc2814d3ccd5ddefebda6445b6d712] new parent not found
2025/05/21 01:32:37 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:37 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275903806")
2025/05/21 01:32:37 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275904041")
2025/05/21 01:32:38 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275904808")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/21 01:32:39 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275905807")
2025/05/21 01:32:40 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275906812")
2025/05/21 01:32:41 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275907806")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/21 01:32:42 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1868367657105|481158c389f4ea7590f96e16efc173c758bd0f07] new parent not found
2025/05/21 01:32:42 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:42 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275908806")
2025/05/21 01:32:42 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275909047")
2025/05/21 01:32:43 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275909806")
2025/05/21 01:32:44 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:44 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275910809")
2025/05/21 01:32:44 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275911048")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/21 01:32:45 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275911809")
2025/05/21 01:32:46 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275912812")
2025/05/21 01:32:47 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1868326436463|e0cba427ea2a4f576599f4ebf891623d3ea8f7ef] new parent not found
2025/05/21 01:32:47 DEBUG : box root 'rclone-test-nolozob8dinu': ["rclone-test-ronusip6teto"(0)|folder|ITEM_CREATE|322173856728|c8571f6a507709f3a60aa37765fe27adb7a91321] new parent not found
2025/05/21 01:32:47 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:47 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275913809")
2025/05/21 01:32:47 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275914061")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/21 01:32:48 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275914811")
2025/05/21 01:32:49 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275915809")
2025/05/21 01:32:50 DEBUG : box root 'rclone-test-nolozob8dinu': ["A1"(0)|folder|ITEM_CREATE|322178236760|8bb4a35a13937b4c077bb4495c2936f95595ba6a] new parent not found
2025/05/21 01:32:50 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.copy5.txt"(0)|file|ITEM_UPLOAD|1868412363706|e21ca06db1cebbb9717b0bdaaf08b597a53d1a82] new parent not found
2025/05/21 01:32:50 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:50 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275916805")
2025/05/21 01:32:50 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275917056")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/21 01:32:51 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275917809")
2025/05/21 01:32:52 DEBUG : box root 'rclone-test-nolozob8dinu': ["B1"(0)|folder|ITEM_CREATE|322175627525|16572bf53c3270972cad0615c928ada71f65c46c] new parent not found
2025/05/21 01:32:52 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:52 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275918802")
2025/05/21 01:32:52 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275919041")
2025/05/21 01:32:53 DEBUG : box root 'rclone-test-nolozob8dinu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1868420212048|d7458b54fb01097aecfc8358d7452bdd906494a7] new parent not found
2025/05/21 01:32:53 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:53 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275919810")
2025/05/21 01:32:53 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275920054")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/21 01:32:54 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275920816")
2025/05/21 01:32:55 DEBUG : box root 'rclone-test-nolozob8dinu': ["one.rclone_chunk.001_ldwqin"(0)|file|ITEM_UPLOAD|1868418115160|8714c9bdfe7b4d6371abb7117217c7e3fe809bc8] new parent not found
2025/05/21 01:32:55 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:55 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275921816")
2025/05/21 01:32:55 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275922058")
2025/05/21 01:32:56 DEBUG : box root 'rclone-test-nolozob8dinu': ["one"(1)|file|ITEM_RENAME|1868418115160|fcb56f3e2d74317b871d97a6587c123fbe418310] new parent not found
2025/05/21 01:32:56 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:56 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275922812")
2025/05/21 01:32:56 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275923055")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file4.rclone_chunk.001_ldvxf7:{} zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1868362873365|6a8c885e4ba9e7a5281d5ed4c7c2945483c0fe7c] new parent not found
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': ["C1"(0)|folder|ITEM_CREATE|322175622189|d2c1ce90fc74716bb5f8d7b93b9f6321e474987c] new parent not found
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275923810")
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': ["A2"(0)|folder|ITEM_CREATE|322178807490|ca70f499e0d5a665a76127fe3ff6ac55899a753c] new parent not found
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275924055")
2025/05/21 01:32:57 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275924300")
2025/05/21 01:32:58 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275924807")
2025/05/21 01:32:59 DEBUG : box root 'rclone-test-nolozob8dinu': ["B2"(0)|folder|ITEM_CREATE|322176428685|78b9bc122a8e5658c590b281f09568085f4e7f07] new parent not found
2025/05/21 01:32:59 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:59 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275925808")
2025/05/21 01:32:59 DEBUG : box root 'rclone-test-nolozob8dinu': ["C2"(0)|folder|ITEM_CREATE|322175410998|dba691dc5910200b81227af6bd6587f03d3661d3] new parent not found
2025/05/21 01:32:59 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:32:59 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275926047")
2025/05/21 01:32:59 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275926278")
2025/05/21 01:33:00 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:00 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275926803")
2025/05/21 01:33:00 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275927073")
2025/05/21 01:33:01 DEBUG : box root 'rclone-test-nolozob8dinu': ["C3"(0)|folder|ITEM_CREATE|322179068510|cc8641afa9cc10f3ddeb5780d00fb7b41d80d78d] new parent not found
2025/05/21 01:33:01 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:01 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275927814")
2025/05/21 01:33:01 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275928052")
2025/05/21 01:33:02 DEBUG : box root 'rclone-test-nolozob8dinu': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:02 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275928809")
2025/05/21 01:33:02 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:02 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275929066")
2025/05/21 01:33:02 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275929316")
2025/05/21 01:33:03 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275929809")
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': ["A3"(0)|folder|ITEM_CREATE|322174539801|b8711ad81e2469c75e53bf51288aedd83316513c] new parent not found
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': ["B3"(0)|folder|ITEM_CREATE|322178488175|ae4a938feccb84d370839d7d2e98423115dda36d] new parent not found
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275930810")
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': ["C4"(0)|folder|ITEM_CREATE|322179083195|fdcb53e0c5b8c39cc25fdb73f1678a173edba100] new parent not found
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275931059")
2025/05/21 01:33:04 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275931294")
2025/05/21 01:33:05 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275931809")
2025/05/21 01:33:06 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2"(1)|file|ITEM_TRASH|1868417490886|e945fd0f622543786a826fa6850dd4def5266e7a] added old path ("dir/file2") for notify
2025/05/21 01:33:06 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/21 01:33:06 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/21 01:33:06 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275932811")
2025/05/21 01:33:06 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1868420067769|c5226ca7ec87ebeb2ff907806bd2b09050121f58] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/21 01:33:06 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/21 01:33:06 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/21 01:33:06 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275933055")
2025/05/21 01:33:06 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275933308")
2025/05/21 01:33:07 DEBUG : box root 'rclone-test-nolozob8dinu': ["two.rclone_chunk.001_ldx662"(0)|file|ITEM_UPLOAD|1868382213485|0126dd506bd6428703adc0d53d89716869941d83] new parent not found
2025/05/21 01:33:07 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:07 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275933816")
2025/05/21 01:33:07 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275934077")
2025/05/21 01:33:08 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1868420898161|ad3560a195713bad614aa688a78e6ec1b78342a4] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/21 01:33:08 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/21 01:33:08 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/21 01:33:08 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275934809")
2025/05/21 01:33:08 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275935071")
2025/05/21 01:33:09 DEBUG : box root 'rclone-test-nolozob8dinu': ["two"(1)|file|ITEM_RENAME|1868382213485|2620e5dc5bcf308886b170a7ee2b91e9ee8b4994] new parent not found
2025/05/21 01:33:09 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:09 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275935811")
2025/05/21 01:33:09 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275936044")
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': ["dry_run"(0)|folder|ITEM_CREATE|322175589039|af4359d99338fcd14b320ae2a2a5101d5c7997bb] new parent not found
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275936814")
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': ["path1"(0)|folder|ITEM_CREATE|322177660003|05add8ebb16e6a3925f8eec6ba43e511723290fc] new parent not found
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4"(1)|file|ITEM_TRASH|1868348805040|1b758fd62d531a9db7f125ed5f331ef78aaf1890] added old path ("dir/file4") for notify
2025/05/21 01:33:10 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275937048")
2025/05/21 01:33:10 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275937286")
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275937808")
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275938051")
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1868420642187|0a1dc624d1ab6878c8186bc856848c6094769e3e] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/21 01:33:11 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275938284")
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': ["file1.txt"(0)|file|ITEM_UPLOAD|1868318128785|141e0fd447b88ecb09132aea7ef5b1dd004e79c8] new parent not found
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': ["file3.txt"(0)|file|ITEM_UPLOAD|1868420204931|c4043debd238fd87666ab98ce670756c690c227b] new parent not found
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:11 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275938534")
2025/05/21 01:33:12 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4.txt"(0)|file|ITEM_UPLOAD|1868412611084|71f881a9859663cbb1fc6a6144c759925d249047] new parent not found
2025/05/21 01:33:12 DEBUG : box root 'rclone-test-nolozob8dinu': ["file2.txt"(0)|file|ITEM_UPLOAD|1868359168567|bb1c54f33a1113c2b900e05f25039452a6b86412] new parent not found
2025/05/21 01:33:12 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:12 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275938789")
2025/05/21 01:33:12 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275939029")
2025/05/21 01:33:12 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275939275")
2025/05/21 01:33:13 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275939819")
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1868420850154|b9432a8c3532458c18960b39e53c97b0dce11072] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': ["file6.txt"(0)|file|ITEM_UPLOAD|1868386526382|c9366497e2f17b3c382ac1dc5a738f4a5a91f7f3] new parent not found
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': ["file7.txt"(0)|file|ITEM_UPLOAD|1868365945363|99333d2f27faf39208dd14d96a479d4e25986cc7] new parent not found
2025/05/21 01:33:14 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Received 6 events, resulting in 1 paths and 1 notifications
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275940812")
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275941086")
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': ["file5.txt"(0)|file|ITEM_UPLOAD|1868363025416|52cc79f240c2cdac2a647f065137b1d938ae75ea] new parent not found
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275941328")
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:14 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275941575")
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275941817")
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275942054")
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': ["file3"(1)|file|ITEM_TRASH|1868412217444|0717ffe5e9272c2a0c8f8e1081e45d3f3e136157] added old path ("dir/file3") for notify
2025/05/21 01:33:15 DEBUG : doChangeNotify("dir/file3", 1)
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275942293")
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1868420987723|151985913b98ccf34d429d448fbcd1fabe785f16] new parent not found
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/21 01:33:15 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275942551")
2025/05/21 01:33:16 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275942788")
2025/05/21 01:33:16 DEBUG : box root 'rclone-test-nolozob8dinu': Checking for changes on remote (next_stream_position: "30401045275943026")
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2025/05/21 01:33:21 INFO  : file name.txt.rclone_chunk.001_ldxp9q: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/05/21 01:33:22 INFO  : file name.txt.rclone_chunk.002_ldxp9q: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/05/21 01:33:29 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_ldxx1d: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/05/21 01:33:30 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_ldxx1d: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/05/21 01:33:43 INFO  : file name.txt.rclone_chunk.001_ldy7yx: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/05/21 01:33:43 INFO  : file name.txt.rclone_chunk.002_ldy7yx: 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/05/21 01:33:51 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:"
2025/05/21 01:33:51 DEBUG : Config file has changed externally - reloading
2025/05/21 01:33:51 DEBUG : Creating backend with remote "TestBox:"
2025/05/21 01:33:52 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/05/21 01:34:09 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.001_ldyzfu: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001
2025/05/21 01:34:10 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.002_ldyzfu: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2025/05/21 01:34:25 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_ldzfdg: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001
2025/05/21 01:34:26 INFO  : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_ldzfdg: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002
2025/05/21 01:34:30 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu/dirToPurgeFromRoot"
2025/05/21 01:34:30 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/dirToPurgeFromRoot"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2025/05/21 01:34:36 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu/hello? sausage/êé"
2025/05/21 01:34:36 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/hello? sausage/êé"
2025/05/21 01:34:48 INFO  : a/b/c/d/e.txt.rclone_chunk.001_ldzzgi: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001
2025/05/21 01:34:49 INFO  : a/b/c/d/e.txt.rclone_chunk.002_ldzzgi: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2025/05/21 01:34:58 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/05/21 01:35:14 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks...
2025/05/21 01:35:15 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001
2025/05/21 01:35:17 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002
2025/05/21 01:35:18 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt
2025/05/21 01:35:23 DEBUG : file name.txt: move 2 data chunks...
2025/05/21 01:35:25 INFO  : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001
2025/05/21 01:35:27 INFO  : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002
2025/05/21 01:35:28 INFO  : file name.txt: Moved (server-side) to: moveTest/other.txt
2025/05/21 01:35:34 DEBUG : moveTest/other.txt: move 2 data chunks...
2025/05/21 01:35:35 INFO  : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/05/21 01:35:36 INFO  : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/05/21 01:35:38 INFO  : moveTest/other.txt: Moved (server-side) to: file name.txt
2025/05/21 01:35:43 DEBUG : other.txt: move 2 data chunks...
2025/05/21 01:35:44 INFO  : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2025/05/21 01:35:46 INFO  : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2025/05/21 01:35:47 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/05/21 01:35:51 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-tipexon0rego"
2025/05/21 01:35:51 DEBUG : Creating backend with remote "TestBox:rclone-test-tipexon0rego"
2025/05/21 01:35:52 DEBUG : box root 'rclone-test-tipexon0rego': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/21 01:35:54 DEBUG : box root 'rclone-test-tipexon0rego': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/21 01:36:02 DEBUG : box root 'rclone-test-nolozob8dinu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/21 01:36:06 DEBUG : box root 'rclone-test-nolozob8dinu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/21 01:36:14 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-tipexon0rego': 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/05/21 01:36:54 INFO  : file name.txt.rclone_chunk.001_le3fzx: Moved (server-side) to: file name.txt.rclone_chunk.001
2025/05/21 01:36:55 INFO  : file name.txt.rclone_chunk.002_le3fzx: Moved (server-side) to: file name.txt.rclone_chunk.002
2025/05/21 01:36:55 INFO  : file name.txt.rclone_chunk.003_le3fzx: Moved (server-side) to: file name.txt.rclone_chunk.003
2025/05/21 01:36:56 INFO  : file name.txt.rclone_chunk.004_le3fzx: Moved (server-side) to: file name.txt.rclone_chunk.004
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2025/05/21 01:37:04 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/05/21 01:37:04 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2025/05/21 01:37:11 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-nolozob8dinu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-nolozob8dinu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2025/05/21 01:37:11 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu/not found.txt"
2025/05/21 01:37:11 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/not found.txt"
2025/05/21 01:37:15 ERROR : : error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-nolozob8dinu" from "TestChunkerChunk50bBox:rclone-test-nolozob8dinu"
2025/05/21 01:37:15 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:"
2025/05/21 01:37:15 DEBUG : Config file has changed externally - reloading
=== 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/05/21 01:37:22 INFO  : rclone-test-nolozob8dinu/created from root.txt.rclone_chunk.001_le4daa: Moved (server-side) to: rclone-test-nolozob8dinu/created from root.txt.rclone_chunk.001
2025/05/21 01:37:23 INFO  : rclone-test-nolozob8dinu/created from root.txt.rclone_chunk.002_le4daa: Moved (server-side) to: rclone-test-nolozob8dinu/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/05/21 01:37:51 INFO  : piped data.txt.rclone_chunk.001_le58sh: Moved (server-side) to: piped data.txt
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2025/05/21 01:38:00 INFO  : piped data.txt.rclone_chunk.001_le5e8k: Moved (server-side) to: piped data.txt.rclone_chunk.001
2025/05/21 01:38:00 INFO  : piped data.txt.rclone_chunk.002_le5e8k: Moved (server-side) to: piped data.txt.rclone_chunk.002
2025/05/21 01:38:01 INFO  : piped data.txt.rclone_chunk.003_le5e8k: 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/05/21 01:38:10 INFO  : Chunked 'TestChunkerChunk50bBox:rclone-test-nolozob8dinu': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2025/05/21 01:38:15 INFO  : small/emptyfile.rclone_chunk.001_le5vqq: Moved (server-side) to: small/emptyfile
2025/05/21 01:38:23 INFO  : small/smallfile.rclone_chunk.001_le64k2: Moved (server-side) to: small/smallfile
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
2025/05/21 01:38:39 INFO  : corrupted/billy.rclone_chunk.001_le6d2g: Moved (server-side) to: corrupted/billy.rclone_chunk.001
2025/05/21 01:38:40 INFO  : corrupted/billy.rclone_chunk.002_le6d2g: Moved (server-side) to: corrupted/billy.rclone_chunk.002
2025/05/21 01:38:40 INFO  : corrupted/billy.rclone_chunk.003_le6d2g: Moved (server-side) to: corrupted/billy.rclone_chunk.003
2025/05/21 01:38:41 INFO  : corrupted/billy.rclone_chunk.004_le6d2g: Moved (server-side) to: corrupted/billy.rclone_chunk.004
2025/05/21 01:38:42 INFO  : corrupted/billy.rclone_chunk.005_le6d2g: Moved (server-side) to: corrupted/billy.rclone_chunk.005
2025/05/21 01:38:55 INFO  : corrupted/silly1.rclone_chunk.001_le6txa: Moved (server-side) to: corrupted/silly1.rclone_chunk.001
2025/05/21 01:38:55 INFO  : corrupted/silly1.rclone_chunk.002_le6txa: Moved (server-side) to: corrupted/silly1.rclone_chunk.002
2025/05/21 01:38:56 INFO  : corrupted/silly1.rclone_chunk.003_le6txa: Moved (server-side) to: corrupted/silly1.rclone_chunk.003
2025/05/21 01:38:56 INFO  : corrupted/silly1.rclone_chunk.004_le6txa: Moved (server-side) to: corrupted/silly1.rclone_chunk.004
2025/05/21 01:38:57 INFO  : corrupted/silly1.rclone_chunk.005_le6txa: Moved (server-side) to: corrupted/silly1.rclone_chunk.005
2025/05/21 01:39:11 INFO  : corrupted/silly2.rclone_chunk.001_le79af: Moved (server-side) to: corrupted/silly2.rclone_chunk.001
2025/05/21 01:39:12 INFO  : corrupted/silly2.rclone_chunk.002_le79af: Moved (server-side) to: corrupted/silly2.rclone_chunk.002
2025/05/21 01:39:12 INFO  : corrupted/silly2.rclone_chunk.003_le79af: Moved (server-side) to: corrupted/silly2.rclone_chunk.003
2025/05/21 01:39:13 INFO  : corrupted/silly2.rclone_chunk.004_le79af: Moved (server-side) to: corrupted/silly2.rclone_chunk.004
2025/05/21 01:39:13 INFO  : corrupted/silly2.rclone_chunk.005_le79af: Moved (server-side) to: corrupted/silly2.rclone_chunk.005
2025/05/21 01:39:30 INFO  : corrupted/silly3.rclone_chunk.001_le7sfv: Moved (server-side) to: corrupted/silly3.rclone_chunk.001
2025/05/21 01:39:31 INFO  : corrupted/silly3.rclone_chunk.002_le7sfv: Moved (server-side) to: corrupted/silly3.rclone_chunk.002
2025/05/21 01:39:31 INFO  : corrupted/silly3.rclone_chunk.003_le7sfv: Moved (server-side) to: corrupted/silly3.rclone_chunk.003
2025/05/21 01:39:32 INFO  : corrupted/silly3.rclone_chunk.004_le7sfv: Moved (server-side) to: corrupted/silly3.rclone_chunk.004
2025/05/21 01:39:33 INFO  : corrupted/silly3.rclone_chunk.005_le7sfv: Moved (server-side) to: corrupted/silly3.rclone_chunk.005
2025/05/21 01:39:47 INFO  : corrupted/willy.rclone_chunk.001_le88zy: Moved (server-side) to: corrupted/willy.rclone_chunk.001
2025/05/21 01:39:47 INFO  : corrupted/willy.rclone_chunk.002_le88zy: Moved (server-side) to: corrupted/willy.rclone_chunk.002
2025/05/21 01:39:48 INFO  : corrupted/willy.rclone_chunk.003_le88zy: Moved (server-side) to: corrupted/willy.rclone_chunk.003
2025/05/21 01:39:49 INFO  : corrupted/willy.rclone_chunk.004_le88zy: Moved (server-side) to: corrupted/willy.rclone_chunk.004
2025/05/21 01:39:49 INFO  : corrupted/willy.rclone_chunk.005_le88zy: Moved (server-side) to: corrupted/willy.rclone_chunk.005
2025/05/21 01:40:04 INFO  : corrupted/silly4.rclone_chunk.001_le8qd3: Moved (server-side) to: corrupted/silly4.rclone_chunk.001
2025/05/21 01:40:04 INFO  : corrupted/silly4.rclone_chunk.002_le8qd3: Moved (server-side) to: corrupted/silly4.rclone_chunk.002
2025/05/21 01:40:05 INFO  : corrupted/silly4.rclone_chunk.003_le8qd3: Moved (server-side) to: corrupted/silly4.rclone_chunk.003
2025/05/21 01:40:06 INFO  : corrupted/silly4.rclone_chunk.004_le8qd3: Moved (server-side) to: corrupted/silly4.rclone_chunk.004
2025/05/21 01:40:06 INFO  : corrupted/silly4.rclone_chunk.005_le8qd3: Moved (server-side) to: corrupted/silly4.rclone_chunk.005
2025/05/21 01:40:10 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy"
2025/05/21 01:40:21 INFO  : corrupted/silly5.rclone_chunk.001_le97hp: Moved (server-side) to: corrupted/silly5.rclone_chunk.001
2025/05/21 01:40:22 INFO  : corrupted/silly5.rclone_chunk.002_le97hp: Moved (server-side) to: corrupted/silly5.rclone_chunk.002
2025/05/21 01:40:22 INFO  : corrupted/silly5.rclone_chunk.003_le97hp: Moved (server-side) to: corrupted/silly5.rclone_chunk.003
2025/05/21 01:40:23 INFO  : corrupted/silly5.rclone_chunk.004_le97hp: Moved (server-side) to: corrupted/silly5.rclone_chunk.004
2025/05/21 01:40:24 INFO  : corrupted/silly5.rclone_chunk.005_le97hp: Moved (server-side) to: corrupted/silly5.rclone_chunk.005
2025/05/21 01:40:27 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow
2025/05/21 01:40:52 INFO  : wreaked/wreaker.rclone_chunk.001_lea6s1: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001
2025/05/21 01:40:53 INFO  : wreaked/wreaker.rclone_chunk.002_lea6s1: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002
2025/05/21 01:40:58 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-nolozob8dinu': invalid directory entry "wreaked/wreaker"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2025/05/21 01:41:14 ERROR : usermeta/today.rclone_chunk.001_leaw8w: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1868425797405","file_version":{"type":"file_version","id":"2060484751005","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_leaw8w"}})
2025/05/21 01:41:16 INFO  : usermeta/today.rclone_chunk.001: Deleted
2025/05/21 01:41:17 INFO  : usermeta/today.rclone_chunk.001_leaw8w: Moved (server-side) to: usermeta/today.rclone_chunk.001
2025/05/21 01:41:29 ERROR : usermeta/past.rclone_chunk.001_lebb3n: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1868428302038","file_version":{"type":"file_version","id":"2060487368438","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_lebb3n"}})
2025/05/21 01:41:31 INFO  : usermeta/past.rclone_chunk.001: Deleted
2025/05/21 01:41:32 INFO  : usermeta/past.rclone_chunk.001_lebb3n: Moved (server-side) to: usermeta/past.rclone_chunk.001
2025/05/21 01:41:45 ERROR : usermeta/future.rclone_chunk.001_lebqpz: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1868428887847","file_version":{"type":"file_version","id":"2060487930247","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_lebqpz"}})
2025/05/21 01:41:47 INFO  : usermeta/future.rclone_chunk.001: Deleted
2025/05/21 01:41:48 INFO  : usermeta/future.rclone_chunk.001_lebqpz: Moved (server-side) to: usermeta/future.rclone_chunk.001
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof
2025/05/21 01:42:10 DEBUG : future/test: Can't move - required hash not found
2025/05/21 01:42:10 DEBUG : future/test: Can't move, switching to copy
2025/05/21 01:42:10 DEBUG : future/test: Can't copy - required hash not found
2025/05/21 01:42:11 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/05/21 01:42:11 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone
2025/05/21 01:42:13 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-nolozob8dinu': File to upload is small (3 bytes), uploading instead of streaming
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility
2025/05/21 01:43:01 INFO  : backcomp/renamefile.rclone_chunk.001_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001
2025/05/21 01:43:01 INFO  : backcomp/renamefile.rclone_chunk.002_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002
2025/05/21 01:43:02 INFO  : backcomp/renamefile.rclone_chunk.003_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003
2025/05/21 01:43:03 INFO  : backcomp/renamefile.rclone_chunk.004_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004
2025/05/21 01:43:03 INFO  : backcomp/renamefile.rclone_chunk.005_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005
2025/05/21 01:43:04 INFO  : backcomp/renamefile.rclone_chunk.006_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006
2025/05/21 01:43:04 INFO  : backcomp/renamefile.rclone_chunk.007_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007
2025/05/21 01:43:05 INFO  : backcomp/renamefile.rclone_chunk.008_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008
2025/05/21 01:43:05 INFO  : backcomp/renamefile.rclone_chunk.009_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009
2025/05/21 01:43:06 INFO  : backcomp/renamefile.rclone_chunk.010_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010
2025/05/21 01:43:07 INFO  : backcomp/renamefile.rclone_chunk.011_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011
2025/05/21 01:43:08 INFO  : backcomp/renamefile.rclone_chunk.012_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012
2025/05/21 01:43:08 INFO  : backcomp/renamefile.rclone_chunk.013_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013
2025/05/21 01:43:09 INFO  : backcomp/renamefile.rclone_chunk.014_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014
2025/05/21 01:43:09 INFO  : backcomp/renamefile.rclone_chunk.015_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015
2025/05/21 01:43:10 INFO  : backcomp/renamefile.rclone_chunk.016_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016
2025/05/21 01:43:11 INFO  : backcomp/renamefile.rclone_chunk.017_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017
2025/05/21 01:43:11 INFO  : backcomp/renamefile.rclone_chunk.018_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018
2025/05/21 01:43:12 INFO  : backcomp/renamefile.rclone_chunk.019_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019
2025/05/21 01:43:12 INFO  : backcomp/renamefile.rclone_chunk.020_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020
2025/05/21 01:43:13 INFO  : backcomp/renamefile.rclone_chunk.021_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021
2025/05/21 01:43:14 INFO  : backcomp/renamefile.rclone_chunk.022_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022
2025/05/21 01:43:14 INFO  : backcomp/renamefile.rclone_chunk.023_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023
2025/05/21 01:43:15 INFO  : backcomp/renamefile.rclone_chunk.024_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024
2025/05/21 01:43:15 INFO  : backcomp/renamefile.rclone_chunk.025_lecq3x: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove
2025/05/21 01:44:01 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu/servermovetest/subdir1"
2025/05/21 01:44:01 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/servermovetest/subdir1"
2025/05/21 01:44:03 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu/servermovetest/subdir2"
2025/05/21 01:44:03 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/servermovetest/subdir2"
2025/05/21 01:44:14 INFO  : movefile.rclone_chunk.001_lefr86: Moved (server-side) to: movefile.rclone_chunk.001
2025/05/21 01:44:15 INFO  : movefile.rclone_chunk.002_lefr86: Moved (server-side) to: movefile.rclone_chunk.002
2025/05/21 01:44:20 DEBUG : movefile: move 2 data chunks...
2025/05/21 01:44:23 INFO  : movefile.rclone_chunk.001: Moved (server-side)
2025/05/21 01:44:25 INFO  : movefile.rclone_chunk.002: Moved (server-side)
2025/05/21 01:44:26 INFO  : movefile: Moved (server-side)
2025/05/21 01:44:27 INFO  : movefile: Moved (server-side)
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow
2025/05/21 01:44:33 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-nolozob8dinu/md5all"
2025/05/21 01:44:33 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name
2025/05/21 01:44:33 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/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/05/21 01:44:42 INFO  : unknown-size-put.txt.rclone_chunk.001_legkmo: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001
2025/05/21 01:44:43 INFO  : unknown-size-put.txt.rclone_chunk.002_legkmo: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002
2025/05/21 01:44:43 INFO  : unknown-size-put.txt.rclone_chunk.003_legkmo: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2025/05/21 01:44:57 INFO  : unknown-size-update.txt.rclone_chunk.001_leh08b: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/05/21 01:44:57 INFO  : unknown-size-update.txt.rclone_chunk.002_leh08b: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/05/21 01:45:15 INFO  : unknown-size-update.txt.rclone_chunk.001_lehaqz: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2025/05/21 01:45:16 INFO  : unknown-size-update.txt.rclone_chunk.002_lehaqz: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2025/05/21 01:45:17 INFO  : unknown-size-update.txt.rclone_chunk.003_lehaqz: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003
2025/05/21 01:45:17 INFO  : unknown-size-update.txt.rclone_chunk.004_lehaqz: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004
2025/05/21 01:45:18 INFO  : unknown-size-update.txt.rclone_chunk.005_lehaqz: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2025/05/21 01:45:29 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nolozob8dinu/deeper/nonexisting/directory"
2025/05/21 01:45:29 DEBUG : Creating backend with remote "TestBox:rclone-test-nolozob8dinu/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/05/21 01:45:38 DEBUG : box root 'rclone-test-nolozob8dinu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/21 01:45:38 ERROR : : error listing: directory not found
2025/05/21 01:45:38 DEBUG : box root 'rclone-test-nolozob8dinu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsShutdown
--- FAIL: TestIntegration (1223.12s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (1.08s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (1.11s)
    --- FAIL: TestIntegration/FsMkdir (1217.75s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.85s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.34s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.34s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.34s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (314.40s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (16.96s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (16.66s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (16.23s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (16.77s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (16.45s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (16.53s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (16.82s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (16.38s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (16.46s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (17.24s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (16.99s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (16.19s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (16.07s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (16.31s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (15.83s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (16.71s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (16.27s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (16.63s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (16.53s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.68s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (66.80s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (7.15s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (77.26s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (679.06s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.90s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.91s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.57s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.01s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.75s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.75s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.92s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.99s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.56s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.52s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.87s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.34s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (15.83s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (17.47s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (20.27s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (15.78s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (39.19s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (23.76s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.35s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (1.02s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (1.01s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (1.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (1.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (1.05s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (1.04s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (1.07s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (1.03s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.52s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (1.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.40s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.58s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.75s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.49s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (21.46s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.08s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (7.54s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (3.18s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (21.33s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.91s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.42s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (19.00s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (7.47s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (1.04s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (10.66s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.30s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (22.23s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.83s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (16.39s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (385.31s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (18.39s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (137.05s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (22.22s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (48.18s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (21.59s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (103.51s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (31.62s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (2.74s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (53.27s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (16.25s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (37.02s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (3.07s)
        --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsDirectory (2.79s)
            --- 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	1223.169s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 20m26.184469924s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]