"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestChunkerChunk50bBox:" 2025/03/14 01:05:08 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi" 2025/03/14 01:05:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/14 01:05:08 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi" 2025/03/14 01:05:08 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/14 01:05:09 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/03/14 01:05:09 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/14 01:05:10 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/03/14 01:05:13 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/03/14 01:05:14 INFO : dir/subdir: Making directory 2025/03/14 01:05:17 INFO : dir/subdir: Removing directory 2025/03/14 01:05:19 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/03/14 01:05:21 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/03/14 01:05:27 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_3fam1n: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/03/14 01:05:27 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_3fam1n: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/03/14 01:05:40 INFO : ．/．.rclone_chunk.001_3fazsg: Moved (server-side) to: ．/．.rclone_chunk.001 2025/03/14 01:05:41 INFO : ．/．.rclone_chunk.002_3fazsg: Moved (server-side) to: ．/．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/03/14 01:05:58 INFO : ．．/．．.rclone_chunk.001_3fbgwo: Moved (server-side) to: ．．/．．.rclone_chunk.001 2025/03/14 01:05:59 INFO : ．．/．．.rclone_chunk.002_3fbgwo: Moved (server-side) to: ．．/．．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/03/14 01:06:15 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_3fbw7k: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/03/14 01:06:15 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_3fbw7k: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/03/14 01:06:29 INFO : leading space/ leading space.rclone_chunk.001_3fcces: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/03/14 01:06:29 INFO : leading space/ leading space.rclone_chunk.002_3fcces: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/03/14 01:06:42 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_3fcpsa: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/03/14 01:06:42 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_3fcpsa: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/03/14 01:07:00 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_3fd533: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/03/14 01:07:01 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_3fd533: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/03/14 01:07:16 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_3fdm10: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/03/14 01:07:16 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_3fdm10: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/03/14 01:07:29 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_3fe0a8: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/03/14 01:07:30 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_3fe0a8: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/03/14 01:07:42 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_3fedpf: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/03/14 01:07:43 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_3fedpf: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/03/14 01:08:01 INFO : .leading dot/.leading dot.rclone_chunk.001_3fet3y: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/03/14 01:08:02 INFO : .leading dot/.leading dot.rclone_chunk.002_3fet3y: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/03/14 01:08:17 INFO : trailing space /trailing space .rclone_chunk.001_3ffcbk: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/03/14 01:08:18 INFO : trailing space /trailing space .rclone_chunk.002_3ffcbk: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/03/14 01:08:32 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_3ffrly: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/03/14 01:08:32 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_3ffrly: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/03/14 01:08:46 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_3fg4se: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/03/14 01:08:47 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_3fg4se: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/03/14 01:09:03 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_3fglo6: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/03/14 01:09:04 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_3fglo6: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/03/14 01:09:19 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_3fh21l: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/03/14 01:09:19 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_3fh21l: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/03/14 01:09:32 INFO : trailing dot./trailing dot..rclone_chunk.001_3fhf4t: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/03/14 01:09:32 INFO : trailing dot./trailing dot..rclone_chunk.002_3fhf4t: 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/03/14 01:09:46 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_3fhs1h: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/03/14 01:09:47 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_3fhs1h: 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/03/14 01:10:03 INFO : test%46.txt/test%46.txt.rclone_chunk.001_3fi90v: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/03/14 01:10:04 INFO : test%46.txt/test%46.txt.rclone_chunk.002_3fi90v: 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/03/14 01:11:16 INFO : zero-length-file.rclone_chunk.001_3fkbyn: 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/03/14 01:11:19 INFO : dir: Making directory 2025/03/14 01:11:20 INFO : dir/subdir1: Making directory 2025/03/14 01:11:21 INFO : dir/subdir3: Making directory 2025/03/14 01:11:21 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399427367") 2025/03/14 01:11:21 DEBUG : box root 'rclone-test-vomotis4dosi': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/14 01:11:21 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399428604") 2025/03/14 01:11:22 INFO : dir/subdir2: Making directory 2025/03/14 01:11:22 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399428833") 2025/03/14 01:11:22 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.019_3fiorx"(1)|file|ITEM_TRASH|1802726826471|ba8af976fd690ee914e14fd179ba785a41201e4c] ignored due to duplicate EventID 2025/03/14 01:11:23 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399429607") 2025/03/14 01:11:24 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399430591") 2025/03/14 01:11:25 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399431598") 2025/03/14 01:11:26 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399432593") 2025/03/14 01:11:27 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399433636") 2025/03/14 01:11:28 INFO : dir/file2.rclone_chunk.001_3fkm4x: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/03/14 01:11:28 INFO : dir/file2.rclone_chunk.002_3fkm4x: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/03/14 01:11:28 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399434594") 2025/03/14 01:11:29 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399435604") 2025/03/14 01:11:30 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399436595") 2025/03/14 01:11:31 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399437593") 2025/03/14 01:11:32 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399438591") 2025/03/14 01:11:33 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399439590") 2025/03/14 01:11:34 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399440587") 2025/03/14 01:11:35 INFO : dir/file4.rclone_chunk.001_3fkugr: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/03/14 01:11:35 INFO : dir/file4.rclone_chunk.002_3fkugr: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/03/14 01:11:35 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399441593") 2025/03/14 01:11:36 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399442631") 2025/03/14 01:11:37 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399443594") 2025/03/14 01:11:38 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399444591") 2025/03/14 01:11:39 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399445591") 2025/03/14 01:11:40 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399446592") 2025/03/14 01:11:41 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399447595") 2025/03/14 01:11:42 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399448594") 2025/03/14 01:11:42 INFO : dir/file3.rclone_chunk.001_3fl1kt: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/03/14 01:11:43 INFO : dir/file3.rclone_chunk.002_3fl1kt: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/03/14 01:11:43 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399449620") 2025/03/14 01:11:44 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399450593") 2025/03/14 01:11:45 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399451602") 2025/03/14 01:11:46 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399452625") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/14 01:11:47 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399453618") 2025/03/14 01:11:48 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399454612") 2025/03/14 01:11:48 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file.rclone_chunk.001_3fkbyn"(0)|file|ITEM_UPLOAD|1802727416688|8f014fcaf2961e6c2171eecb014b006f24530141] ignored due to old SequenceID ('\x01') 2025/03/14 01:11:48 DEBUG : box root 'rclone-test-vomotis4dosi': Received 4 events, resulting in 0 paths and 0 notifications 2025/03/14 01:11:48 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399455607") 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': ["all_changed"(0)|folder|ITEM_CREATE|311642809875|d7435728d03277573f8348a2a397a157392f66db] new parent not found 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': ["path1"(0)|folder|ITEM_CREATE|311643450393|489352711c7b38a6d4bb9fbaf954cbb6f8a4b909] new parent not found 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1802740981757|d2ec5fcf0545b7dd070cacc33b3fcf3cbf7cf37c] ignored due to old SequenceID ('\x01') 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy2.txt"(0)|file|ITEM_UPLOAD|1802725660551|faf8b4e2fd40889e8d4073fe9f6bce386f24294a] new parent not found 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': Received 8 events, resulting in 0 paths and 0 notifications 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399455877") 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': ["all_changed"(0)|folder|ITEM_CREATE|311642809875|d7435728d03277573f8348a2a397a157392f66db] ignored due to duplicate EventID 2025/03/14 01:11:49 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399456163") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/14 01:11:50 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399456631") 2025/03/14 01:11:50 DEBUG : box root 'rclone-test-vomotis4dosi': ["path1"(0)|folder|ITEM_CREATE|311643450393|489352711c7b38a6d4bb9fbaf954cbb6f8a4b909] ignored due to duplicate EventID 2025/03/14 01:11:50 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.018_3fiorx"(1)|file|ITEM_TRASH|1802730119450|319a58e33387083d992887b73a456e625345f05d] ignored due to duplicate EventID 2025/03/14 01:11:50 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.014_3fiorx"(1)|file|ITEM_TRASH|1802731070390|bc2a1265ed67cf81ac1893f93399fb5f3563fff1] ignored due to duplicate EventID 2025/03/14 01:11:51 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399457628") 2025/03/14 01:11:51 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1802740981757|d2ec5fcf0545b7dd070cacc33b3fcf3cbf7cf37c] ignored due to duplicate EventID 2025/03/14 01:11:51 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.015_3fiorx"(1)|file|ITEM_TRASH|1802730611119|0d9b67ffab8fcb662230aff033aa53e4e510e267] ignored due to duplicate EventID 2025/03/14 01:11:52 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399458630") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/14 01:11:52 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy2.txt"(0)|file|ITEM_UPLOAD|1802725660551|faf8b4e2fd40889e8d4073fe9f6bce386f24294a] ignored due to duplicate EventID 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399459619") 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.002_3fkm4x"(0)|file|ITEM_UPLOAD|1802740981757|18417affec2b1570c62da131a1ac58849988e7cc] ignored due to old SequenceID ('\x01') 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["011109zo"(0)|folder|ITEM_CREATE|311645044489|675c1a2f96b1f75facb42267912cfe0b03716f6b] new parent not found 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_UPLOAD|1802735536620|2bda6ecc85a3d6759d851d1c87cb220b23285d12] new parent not found 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802737475245|acd7eecc0db8aeb05a098e2d074dfcb90e09eee0] new parent not found 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1802731211897|d087fbc3c9e9b8d89427c1c06c963a6fb0ee4f7d] new parent not found 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_UPLOAD|1802728726818|a3d898c0cf2bae348860f58529e68530be61dd21] new parent not found 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1802728715219|e2d1b503309bec48e351dfcb58785f5382230f3f] new parent not found 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir3"(0)|folder|ITEM_CREATE|311641122119|bd68332cff6ca1b57eaf312488d9118d0dfa01b6] ignored due to old SequenceID ('\x00') 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.006_3fiorx"(0)|file|ITEM_UPLOAD|1802740696343|a7dfd126559681db1994992c8579660389b35e20] added new path ("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt.rclone_chunk.006_3fiorx") for notify 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy5.txt"(0)|file|ITEM_RENAME|1802728002927|97931cbff02134d4605f31959bf5eb83d1b955be] new parent not found 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(2)|file|ITEM_TRASH|1802727416688|3cd70156e738995b80c0aa6631f016e7eec1cef3] added old path ("zero-length-file") for notify 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir"(0)|folder|ITEM_CREATE|311643123686|0aa9786c370088977f416abc28f2ed04c556171c] new parent not found 2025/03/14 01:11:53 DEBUG : doChangeNotify("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt.rclone_chunk.006_3fiorx", 1) 2025/03/14 01:11:53 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt.rclone_chunk.006_3fiorx", 1 2025/03/14 01:11:53 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': Received 13 events, resulting in 2 paths and 2 notifications 2025/03/14 01:11:53 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399460628") 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_UPLOAD|1802735536620|2bda6ecc85a3d6759d851d1c87cb220b23285d12] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399460970") 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802737475245|acd7eecc0db8aeb05a098e2d074dfcb90e09eee0] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1802731211897|d087fbc3c9e9b8d89427c1c06c963a6fb0ee4f7d] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_UPLOAD|1802728726818|a3d898c0cf2bae348860f58529e68530be61dd21] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1802728715219|e2d1b503309bec48e351dfcb58785f5382230f3f] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir3"(0)|folder|ITEM_CREATE|311641122119|bd68332cff6ca1b57eaf312488d9118d0dfa01b6] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.006_3fiorx"(0)|file|ITEM_UPLOAD|1802740696343|a7dfd126559681db1994992c8579660389b35e20] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy5.txt"(0)|file|ITEM_RENAME|1802728002927|97931cbff02134d4605f31959bf5eb83d1b955be] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(2)|file|ITEM_TRASH|1802727416688|3cd70156e738995b80c0aa6631f016e7eec1cef3] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802737475245|4dce19d0c7056c01eba6c4db3873a853ca322586] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir"(0)|folder|ITEM_CREATE|311643123686|0aa9786c370088977f416abc28f2ed04c556171c] ignored due to duplicate EventID 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir2"(0)|folder|ITEM_CREATE|311640966894|57118f261e1e5a8f84721fcfcb4062c1ba9ed20d] ignored due to old SequenceID ('\x00') 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': Received 11 events, resulting in 0 paths and 0 notifications 2025/03/14 01:11:54 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399461630") 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802737475245|acd7eecc0db8aeb05a098e2d074dfcb90e09eee0] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1802731211897|d087fbc3c9e9b8d89427c1c06c963a6fb0ee4f7d] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399461953") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_UPLOAD|1802728726818|a3d898c0cf2bae348860f58529e68530be61dd21] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1802728715219|e2d1b503309bec48e351dfcb58785f5382230f3f] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir3"(0)|folder|ITEM_CREATE|311641122119|bd68332cff6ca1b57eaf312488d9118d0dfa01b6] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.006_3fiorx"(0)|file|ITEM_UPLOAD|1802740696343|a7dfd126559681db1994992c8579660389b35e20] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy5.txt"(0)|file|ITEM_RENAME|1802728002927|97931cbff02134d4605f31959bf5eb83d1b955be] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(2)|file|ITEM_TRASH|1802727416688|3cd70156e738995b80c0aa6631f016e7eec1cef3] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802737475245|4dce19d0c7056c01eba6c4db3873a853ca322586] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir"(0)|folder|ITEM_CREATE|311643123686|0aa9786c370088977f416abc28f2ed04c556171c] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir2"(0)|folder|ITEM_CREATE|311640966894|57118f261e1e5a8f84721fcfcb4062c1ba9ed20d] ignored due to duplicate EventID 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2"(0)|file|ITEM_UPLOAD|1802728581137|458a93c57041fa12e04456a5707be1c02075de89] ignored due to old SequenceID ('\x00') 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1802735706053|70de20c7ce423bfe59c4ad658f4ea541fe54373e] new parent not found 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.001_3fkugr"(0)|file|ITEM_UPLOAD|1802742261030|d2b0415d5f10ec0d32c020ab60b82aef3fb04831] ignored due to old SequenceID ('\x01') 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy2.txt"(0)|file|ITEM_RENAME|1802725660551|0eb6a0ffa522683b93f41297aad0d52ce009e17e] new parent not found 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': Received 13 events, resulting in 0 paths and 0 notifications 2025/03/14 01:11:55 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399462604") 2025/03/14 01:11:56 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir3"(0)|folder|ITEM_CREATE|311641122119|bd68332cff6ca1b57eaf312488d9118d0dfa01b6] ignored due to duplicate EventID 2025/03/14 01:11:56 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399462925") 2025/03/14 01:11:56 DEBUG : box root 'rclone-test-vomotis4dosi': ["z.txt.rclone_chunk.006_3fiorx"(0)|file|ITEM_UPLOAD|1802740696343|a7dfd126559681db1994992c8579660389b35e20] ignored due to duplicate EventID 2025/03/14 01:11:57 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399463623") 2025/03/14 01:11:57 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy5.txt"(0)|file|ITEM_RENAME|1802728002927|97931cbff02134d4605f31959bf5eb83d1b955be] ignored due to duplicate EventID 2025/03/14 01:11:57 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(2)|file|ITEM_TRASH|1802727416688|3cd70156e738995b80c0aa6631f016e7eec1cef3] ignored due to duplicate EventID 2025/03/14 01:11:57 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802737475245|4dce19d0c7056c01eba6c4db3873a853ca322586] ignored due to duplicate EventID 2025/03/14 01:11:57 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir"(0)|folder|ITEM_CREATE|311643123686|0aa9786c370088977f416abc28f2ed04c556171c] ignored due to duplicate EventID 2025/03/14 01:11:58 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399464655") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/14 01:11:58 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir2"(0)|folder|ITEM_CREATE|311640966894|57118f261e1e5a8f84721fcfcb4062c1ba9ed20d] ignored due to duplicate EventID 2025/03/14 01:11:59 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399465610") 2025/03/14 01:11:59 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2"(0)|file|ITEM_UPLOAD|1802728581137|458a93c57041fa12e04456a5707be1c02075de89] ignored due to duplicate EventID 2025/03/14 01:11:59 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1802735706053|70de20c7ce423bfe59c4ad658f4ea541fe54373e] ignored due to duplicate EventID 2025/03/14 01:11:59 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.001_3fkugr"(0)|file|ITEM_UPLOAD|1802742261030|d2b0415d5f10ec0d32c020ab60b82aef3fb04831] ignored due to duplicate EventID 2025/03/14 01:11:59 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy2.txt"(0)|file|ITEM_RENAME|1802725660551|0eb6a0ffa522683b93f41297aad0d52ce009e17e] ignored due to duplicate EventID 2025/03/14 01:12:00 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399466638") 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy5.txt"(0)|file|ITEM_RENAME|1802728002927|4a3804e6facea272af9b76cb7c9323c1b617cb8c] new parent not found 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir1"(0)|folder|ITEM_CREATE|311643862918|32a70e93db12c88df4a48a30811f8185ba2f3a34] ignored due to old SequenceID ('\x00') 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1802732133225|83f26148b1051b5c503cf7ae62197c7e46d0cc41] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.001_3fkm4x"(0)|file|ITEM_UPLOAD|1802732133225|a12ce36258bd87d2a153fa3db49f23f409949e6e] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1802729066281|54bb3746b1d9e6e74b87d1e65256f63b5c2b26f7] new parent not found 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["dir"(0)|folder|ITEM_CREATE|311642908247|3f5256d9aba73b94c089fc85693f48f188f01e13] added new path ("dir") for notify 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1802742261030|ba78e9e5624a91e11a12ab985fb438521b7045ac] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802725415894|962502679fddee000d979552f8d336944b53ff5f] new parent not found 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(0)|file|ITEM_RENAME|1802731211897|3387d8ced1838b1b8d4088bbf4cccad137a783e2] new parent not found 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3"(0)|file|ITEM_UPLOAD|1802742013395|76ad5996bd4edd5d08c645558cb6b24113feb280] ignored due to old SequenceID ('\x00') 2025/03/14 01:12:01 DEBUG : doChangeNotify("dir", 0) 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': Received 10 events, resulting in 1 paths and 1 notifications 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399467742") 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1802729066281|54bb3746b1d9e6e74b87d1e65256f63b5c2b26f7] ignored due to duplicate EventID 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["dir"(0)|folder|ITEM_CREATE|311642908247|3f5256d9aba73b94c089fc85693f48f188f01e13] ignored due to duplicate EventID 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1802742261030|ba78e9e5624a91e11a12ab985fb438521b7045ac] ignored due to duplicate EventID 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802725415894|962502679fddee000d979552f8d336944b53ff5f] ignored due to duplicate EventID 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(0)|file|ITEM_RENAME|1802731211897|3387d8ced1838b1b8d4088bbf4cccad137a783e2] ignored due to duplicate EventID 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3"(0)|file|ITEM_UPLOAD|1802742013395|76ad5996bd4edd5d08c645558cb6b24113feb280] ignored due to duplicate EventID 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1802741674842|386dcf34e84fdc32a7ca3a3c279e3e0a35239817] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': Received 7 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399468158") 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1802729066281|54bb3746b1d9e6e74b87d1e65256f63b5c2b26f7] ignored due to duplicate EventID 2025/03/14 01:12:01 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399468480") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["dir"(0)|folder|ITEM_CREATE|311642908247|3f5256d9aba73b94c089fc85693f48f188f01e13] ignored due to duplicate EventID 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1802742261030|ba78e9e5624a91e11a12ab985fb438521b7045ac] ignored due to duplicate EventID 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802725415894|962502679fddee000d979552f8d336944b53ff5f] ignored due to duplicate EventID 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(0)|file|ITEM_RENAME|1802731211897|3387d8ced1838b1b8d4088bbf4cccad137a783e2] ignored due to duplicate EventID 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3"(0)|file|ITEM_UPLOAD|1802742013395|76ad5996bd4edd5d08c645558cb6b24113feb280] ignored due to duplicate EventID 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1802741674842|386dcf34e84fdc32a7ca3a3c279e3e0a35239817] ignored due to duplicate EventID 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|ba68120424ecdc7599fbdb1af975a38bdc110c6c] new parent not found 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_RENAME|1802728715219|c91c810c70af42efc42e9479de3af2665c606b8a] new parent not found 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': Received 8 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399468814") 2025/03/14 01:12:02 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399469175") 2025/03/14 01:12:03 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399469640") 2025/03/14 01:12:03 DEBUG : box root 'rclone-test-vomotis4dosi': ["dir"(0)|folder|ITEM_CREATE|311642908247|3f5256d9aba73b94c089fc85693f48f188f01e13] ignored due to duplicate EventID 2025/03/14 01:12:04 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399470731") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/03/14 01:12:04 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1802742261030|ba78e9e5624a91e11a12ab985fb438521b7045ac] ignored due to duplicate EventID 2025/03/14 01:12:04 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802725415894|962502679fddee000d979552f8d336944b53ff5f] ignored due to duplicate EventID 2025/03/14 01:12:05 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399471613") 2025/03/14 01:12:05 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(0)|file|ITEM_RENAME|1802731211897|3387d8ced1838b1b8d4088bbf4cccad137a783e2] ignored due to duplicate EventID 2025/03/14 01:12:05 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3"(0)|file|ITEM_UPLOAD|1802742013395|76ad5996bd4edd5d08c645558cb6b24113feb280] ignored due to duplicate EventID 2025/03/14 01:12:05 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1802741674842|386dcf34e84fdc32a7ca3a3c279e3e0a35239817] ignored due to duplicate EventID 2025/03/14 01:12:05 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|ba68120424ecdc7599fbdb1af975a38bdc110c6c] ignored due to duplicate EventID 2025/03/14 01:12:05 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_RENAME|1802728715219|c91c810c70af42efc42e9479de3af2665c606b8a] ignored due to duplicate EventID 2025/03/14 01:12:06 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399472622") 2025/03/14 01:12:06 DEBUG : box root 'rclone-test-vomotis4dosi': ["path1"(0)|folder|ITEM_CREATE|311643942998|01828b63771fb01a3638ea13a8fb38abb9251c8f] new parent not found 2025/03/14 01:12:06 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy2.txt"(0)|file|ITEM_RENAME|1802725660551|feb252a923d268f5977aac0bc82c28007e581fc3] new parent not found 2025/03/14 01:12:06 DEBUG : box root 'rclone-test-vomotis4dosi': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:06 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399473617") 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy5.txt"(0)|file|ITEM_UPLOAD|1802728002927|324fce1769c4569a552d4ac9a315c98a25f72561] new parent not found 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399473881") 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4"(0)|file|ITEM_UPLOAD|1802731677377|759921ec52da4f44258a0aea200ef32d61c315e8] ignored due to old SequenceID ('\x00') 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(0)|file|ITEM_RENAME|1802729066281|7847522f90059c7b57695bb54e2eb7d305ee6bed] new parent not found 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(0)|file|ITEM_RENAME|1802729066281|e4f02437e3c4cb6670ee331c0e86c7091e648b3a] new parent not found 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_RENAME|1802728726818|57126234f77bf1e5634fcc783d3f6bd1b71a5600] new parent not found 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1802731550254|de01c4d57aa814821ec08df89586ccb460d29900] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.002_3fkugr"(0)|file|ITEM_UPLOAD|1802731550254|0cad6bb3f105e15cb0ae02aa161e87797cce613b] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_RENAME|1802728726818|7d724d834072c4efcca7d5d960773d178fe11a69] new parent not found 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(0)|file|ITEM_RENAME|1802735706053|d86cc7de21fa432a370ad752e77ef5d08a2fb0b3] new parent not found 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002_3fl1kt"(0)|file|ITEM_UPLOAD|1802741674842|4a8afea5cf6717295fcf6d65d9870715d8f0d871] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|763b78419525ce86ad0f55330c873d335cff75e0] new parent not found 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': Received 10 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399474132") 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4"(0)|file|ITEM_UPLOAD|1802731677377|759921ec52da4f44258a0aea200ef32d61c315e8] ignored due to duplicate EventID 2025/03/14 01:12:07 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399474435") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399474700") 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(0)|file|ITEM_RENAME|1802729066281|7847522f90059c7b57695bb54e2eb7d305ee6bed] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(0)|file|ITEM_RENAME|1802729066281|e4f02437e3c4cb6670ee331c0e86c7091e648b3a] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_RENAME|1802728726818|57126234f77bf1e5634fcc783d3f6bd1b71a5600] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1802731550254|de01c4d57aa814821ec08df89586ccb460d29900] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.002_3fkugr"(0)|file|ITEM_UPLOAD|1802731550254|0cad6bb3f105e15cb0ae02aa161e87797cce613b] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_RENAME|1802728726818|7d724d834072c4efcca7d5d960773d178fe11a69] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(0)|file|ITEM_RENAME|1802735706053|d86cc7de21fa432a370ad752e77ef5d08a2fb0b3] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002_3fl1kt"(0)|file|ITEM_UPLOAD|1802741674842|4a8afea5cf6717295fcf6d65d9870715d8f0d871] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|763b78419525ce86ad0f55330c873d335cff75e0] ignored due to duplicate EventID 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1802730316679|f178c73e6f034b9512b011ada1623146af1c23a0] ignored due to old SequenceID ('\x01') 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': Received 11 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:08 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399475644") 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.rclone_chunk.002_3fkugr"(0)|file|ITEM_UPLOAD|1802731550254|0cad6bb3f105e15cb0ae02aa161e87797cce613b] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_RENAME|1802728726818|7d724d834072c4efcca7d5d960773d178fe11a69] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(0)|file|ITEM_RENAME|1802735706053|d86cc7de21fa432a370ad752e77ef5d08a2fb0b3] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002_3fl1kt"(0)|file|ITEM_UPLOAD|1802741674842|4a8afea5cf6717295fcf6d65d9870715d8f0d871] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|763b78419525ce86ad0f55330c873d335cff75e0] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802731660416|5d966fb404a96f0b14eb3f140e60fc7453121041] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1802730316679|f178c73e6f034b9512b011ada1623146af1c23a0] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399475947") 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(0)|file|ITEM_RENAME|1802728726818|7d724d834072c4efcca7d5d960773d178fe11a69] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(0)|file|ITEM_RENAME|1802735706053|d86cc7de21fa432a370ad752e77ef5d08a2fb0b3] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002_3fl1kt"(0)|file|ITEM_UPLOAD|1802741674842|4a8afea5cf6717295fcf6d65d9870715d8f0d871] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|763b78419525ce86ad0f55330c873d335cff75e0] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802731660416|5d966fb404a96f0b14eb3f140e60fc7453121041] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1802730316679|f178c73e6f034b9512b011ada1623146af1c23a0] ignored due to duplicate EventID 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802742270067|391321fbeda2d7e9b6cec43e7558c56ccc9a2342] new parent not found 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': Received 8 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:09 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399476634") 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(0)|file|ITEM_RENAME|1802735706053|d86cc7de21fa432a370ad752e77ef5d08a2fb0b3] ignored due to duplicate EventID 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002_3fl1kt"(0)|file|ITEM_UPLOAD|1802741674842|4a8afea5cf6717295fcf6d65d9870715d8f0d871] ignored due to duplicate EventID 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|763b78419525ce86ad0f55330c873d335cff75e0] ignored due to duplicate EventID 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802731660416|5d966fb404a96f0b14eb3f140e60fc7453121041] ignored due to duplicate EventID 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1802730316679|f178c73e6f034b9512b011ada1623146af1c23a0] ignored due to duplicate EventID 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802725415894|5dcc49c03f9491f7c6aaac6fd0cfd6c80e506469] ignored due to duplicate EventID 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802742270067|391321fbeda2d7e9b6cec43e7558c56ccc9a2342] ignored due to duplicate EventID 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399476926") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/03/14 01:12:10 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.002_3fl1kt"(0)|file|ITEM_UPLOAD|1802741674842|4a8afea5cf6717295fcf6d65d9870715d8f0d871] ignored due to duplicate EventID 2025/03/14 01:12:11 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399477605") 2025/03/14 01:12:11 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_RENAME|1802735536620|763b78419525ce86ad0f55330c873d335cff75e0] ignored due to duplicate EventID 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399478619") 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802731660416|5d966fb404a96f0b14eb3f140e60fc7453121041] ignored due to duplicate EventID 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1802730316679|f178c73e6f034b9512b011ada1623146af1c23a0] ignored due to duplicate EventID 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802725415894|5dcc49c03f9491f7c6aaac6fd0cfd6c80e506469] ignored due to duplicate EventID 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802742270067|391321fbeda2d7e9b6cec43e7558c56ccc9a2342] ignored due to duplicate EventID 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_RENAME|1802728715219|ff6b0bcb6afa29a0cabb665fb1a82b135bb3d64c] new parent not found 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': ["path1"(0)|folder|ITEM_CREATE|311645371145|eefe0079ec3190f982870872eb05e5ed656c2efb] new parent not found 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:12 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399479609") 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802725415894|5dcc49c03f9491f7c6aaac6fd0cfd6c80e506469] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802742270067|391321fbeda2d7e9b6cec43e7558c56ccc9a2342] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_RENAME|1802728715219|ff6b0bcb6afa29a0cabb665fb1a82b135bb3d64c] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["path1"(0)|folder|ITEM_CREATE|311645371145|eefe0079ec3190f982870872eb05e5ed656c2efb] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399479882") fstests.go:935: map[dir:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(1)|file|ITEM_TRASH|1802725415894|5dcc49c03f9491f7c6aaac6fd0cfd6c80e506469] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1802742270067|391321fbeda2d7e9b6cec43e7558c56ccc9a2342] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_RENAME|1802728715219|ff6b0bcb6afa29a0cabb665fb1a82b135bb3d64c] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': ["path1"(0)|folder|ITEM_CREATE|311645371145|eefe0079ec3190f982870872eb05e5ed656c2efb] ignored due to duplicate EventID 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': Received 5 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:13 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399480614") 2025/03/14 01:12:14 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399480880") 2025/03/14 01:12:14 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(0)|file|ITEM_RENAME|1802728715219|ff6b0bcb6afa29a0cabb665fb1a82b135bb3d64c] ignored due to duplicate EventID 2025/03/14 01:12:15 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399481626") 2025/03/14 01:12:16 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399482601") 2025/03/14 01:12:16 DEBUG : box root 'rclone-test-vomotis4dosi': ["path1"(0)|folder|ITEM_CREATE|311645371145|eefe0079ec3190f982870872eb05e5ed656c2efb] ignored due to duplicate EventID 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399483610") 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy3.txt"(1)|file|ITEM_TRASH|1802728715219|af737aca29c819473e0f85b92cf661555e6d78b3] ignored due to duplicate EventID 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_UPLOAD|1802731053418|c5f7b655148dd11ccf0aca86ce7ec91c12a1d44b] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.txt"(0)|file|ITEM_UPLOAD|1802730232048|7908d49dad5b875f62b3c6c1f2df3e22f85c7c03] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file5.txt"(0)|file|ITEM_UPLOAD|1802735821547|7c8296fc1475c508bbdd7996e324f0f13a44288f] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.txt"(0)|file|ITEM_UPLOAD|1802728602040|6e8bf9c7c2bb36d014bb027e07a9b37775b8ce95] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file8.txt"(0)|file|ITEM_UPLOAD|1802742051920|3132e0e9fb3520b23fb6383a9ade8686c9bcb079] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["backupdir"(0)|folder|ITEM_CREATE|311642615408|3dd15a9d62ac70cd9e75a2582fc22f711e37eb33] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file6.txt"(0)|file|ITEM_UPLOAD|1802728640944|2ea54b8595d90d35f2e383b1694137c3929760d8] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.txt"(0)|file|ITEM_UPLOAD|1802727904787|dd5a875670e60e0bf00568b068a6be7e704c25f8] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': ["file7.txt"(0)|file|ITEM_UPLOAD|1802736213475|32dc44d6ea4c20ca43dc34d97f8d30b6c6aa40dd] new parent not found 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': Received 18 events, resulting in 0 paths and 0 notifications 2025/03/14 01:12:17 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399484609") 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(0)|file|ITEM_UPLOAD|1802731053418|c5f7b655148dd11ccf0aca86ce7ec91c12a1d44b] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy5.txt"(1)|file|ITEM_TRASH|1802728002927|9d95d17fd50b198c5a0c1acbd6b9d97023f4357e] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file20.txt"(1)|file|ITEM_TRASH|1802728726818|84bf2b99b0fc1fae76f70b86bbbb0e58aae2383d] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.txt"(0)|file|ITEM_UPLOAD|1802730232048|7908d49dad5b875f62b3c6c1f2df3e22f85c7c03] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file5.txt"(0)|file|ITEM_UPLOAD|1802735821547|7c8296fc1475c508bbdd7996e324f0f13a44288f] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399484966") 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["subdir"(1)|folder|ITEM_TRASH|311643123686|2ed47d44e14602168b287cd37c0c883cef81c2a7] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file3.txt"(0)|file|ITEM_UPLOAD|1802728602040|6e8bf9c7c2bb36d014bb027e07a9b37775b8ce95] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file8.txt"(0)|file|ITEM_UPLOAD|1802742051920|3132e0e9fb3520b23fb6383a9ade8686c9bcb079] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy2.txt"(1)|file|ITEM_TRASH|1802725660551|2bb1b6b74b789f298c6cf596e1bb4a677227d9e2] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1802735706053|73f46c9db8d125516623482ad6a7f0944f3b15c4] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["backupdir"(0)|folder|ITEM_CREATE|311642615408|3dd15a9d62ac70cd9e75a2582fc22f711e37eb33] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file6.txt"(0)|file|ITEM_UPLOAD|1802728640944|2ea54b8595d90d35f2e383b1694137c3929760d8] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(1)|file|ITEM_TRASH|1802735536620|58b65fd4e86219947839220995bc472237b5c30f] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(1)|file|ITEM_TRASH|1802729066281|f7a63110a46a874414a46baa2b243533efae77cc] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.txt"(0)|file|ITEM_UPLOAD|1802727904787|dd5a875670e60e0bf00568b068a6be7e704c25f8] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file7.txt"(0)|file|ITEM_UPLOAD|1802736213475|32dc44d6ea4c20ca43dc34d97f8d30b6c6aa40dd] ignored due to duplicate EventID 2025/03/14 01:12:18 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(1)|file|ITEM_TRASH|1802731211897|90f074e7967de02db152b016cd9390618d4311de] ignored due to duplicate EventID 2025/03/14 01:12:19 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399485614") 2025/03/14 01:12:19 DEBUG : box root 'rclone-test-vomotis4dosi': ["file8.txt"(0)|file|ITEM_UPLOAD|1802742051920|3132e0e9fb3520b23fb6383a9ade8686c9bcb079] ignored due to duplicate EventID 2025/03/14 01:12:19 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy2.txt"(1)|file|ITEM_TRASH|1802725660551|2bb1b6b74b789f298c6cf596e1bb4a677227d9e2] ignored due to duplicate EventID 2025/03/14 01:12:19 DEBUG : box root 'rclone-test-vomotis4dosi': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1802735706053|73f46c9db8d125516623482ad6a7f0944f3b15c4] ignored due to duplicate EventID 2025/03/14 01:12:19 DEBUG : box root 'rclone-test-vomotis4dosi': ["backupdir"(0)|folder|ITEM_CREATE|311642615408|3dd15a9d62ac70cd9e75a2582fc22f711e37eb33] ignored due to duplicate EventID 2025/03/14 01:12:19 DEBUG : box root 'rclone-test-vomotis4dosi': ["file6.txt"(0)|file|ITEM_UPLOAD|1802728640944|2ea54b8595d90d35f2e383b1694137c3929760d8] ignored due to duplicate EventID 2025/03/14 01:12:20 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399486599") 2025/03/14 01:12:20 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.txt"(1)|file|ITEM_TRASH|1802735536620|58b65fd4e86219947839220995bc472237b5c30f] ignored due to duplicate EventID 2025/03/14 01:12:20 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy4.txt"(1)|file|ITEM_TRASH|1802729066281|f7a63110a46a874414a46baa2b243533efae77cc] ignored due to duplicate EventID 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399487605") 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': ["file4.txt"(0)|file|ITEM_UPLOAD|1802727904787|dd5a875670e60e0bf00568b068a6be7e704c25f8] ignored due to duplicate EventID 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': ["file7.txt"(0)|file|ITEM_UPLOAD|1802736213475|32dc44d6ea4c20ca43dc34d97f8d30b6c6aa40dd] ignored due to duplicate EventID 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': ["file1.copy1.txt"(1)|file|ITEM_TRASH|1802731211897|90f074e7967de02db152b016cd9390618d4311de] ignored due to duplicate EventID 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1802740981757|8ae11856406ca0687a010283489b987e6f1d6ff7] added old path ("dir/file2.rclone_chunk.002") for notify 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(1)|file|ITEM_RENAME|1802727416688|29051da20ea85b8093790006fc48cdcda1fad501] added new path ("zero-length-file") for notify 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1802732133225|64a082618b3039c8d2657d8121394449a041aa55] added old path ("dir/file2.rclone_chunk.001") for notify 2025/03/14 01:12:21 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/14 01:12:21 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/14 01:12:21 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': Received 6 events, resulting in 3 paths and 3 notifications 2025/03/14 01:12:21 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399488597") 2025/03/14 01:12:22 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1802740981757|8ae11856406ca0687a010283489b987e6f1d6ff7] ignored due to duplicate EventID 2025/03/14 01:12:22 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(1)|file|ITEM_RENAME|1802727416688|29051da20ea85b8093790006fc48cdcda1fad501] ignored due to duplicate EventID 2025/03/14 01:12:22 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1802732133225|64a082618b3039c8d2657d8121394449a041aa55] ignored due to duplicate EventID 2025/03/14 01:12:22 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399488852") 2025/03/14 01:12:22 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1802740981757|8ae11856406ca0687a010283489b987e6f1d6ff7] ignored due to duplicate EventID 2025/03/14 01:12:22 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(1)|file|ITEM_RENAME|1802727416688|29051da20ea85b8093790006fc48cdcda1fad501] ignored due to duplicate EventID 2025/03/14 01:12:22 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1802732133225|64a082618b3039c8d2657d8121394449a041aa55] ignored due to duplicate EventID 2025/03/14 01:12:23 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399489597") 2025/03/14 01:12:23 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1802740981757|8ae11856406ca0687a010283489b987e6f1d6ff7] ignored due to duplicate EventID 2025/03/14 01:12:23 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(1)|file|ITEM_RENAME|1802727416688|29051da20ea85b8093790006fc48cdcda1fad501] ignored due to duplicate EventID 2025/03/14 01:12:23 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1802732133225|64a082618b3039c8d2657d8121394449a041aa55] ignored due to duplicate EventID 2025/03/14 01:12:24 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399490594") 2025/03/14 01:12:24 DEBUG : box root 'rclone-test-vomotis4dosi': ["zero-length-file"(1)|file|ITEM_RENAME|1802727416688|29051da20ea85b8093790006fc48cdcda1fad501] ignored due to duplicate EventID 2025/03/14 01:12:25 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399491603") 2025/03/14 01:12:25 DEBUG : box root 'rclone-test-vomotis4dosi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1802732133225|64a082618b3039c8d2657d8121394449a041aa55] ignored due to duplicate EventID 2025/03/14 01:12:26 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399492597") 2025/03/14 01:12:27 DEBUG : box root 'rclone-test-vomotis4dosi': Checking for changes on remote (next_stream_position: "30401039399493609") === RUN TestIntegration/FsMkdir/FsPutFiles 2025/03/14 01:12:32 INFO : file name.txt.rclone_chunk.001_3fmfag: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/14 01:12:33 INFO : file name.txt.rclone_chunk.002_3fmfag: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/14 01:12:39 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_3fmmce: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/14 01:12:40 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_3fmmce: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/14 01:12:52 INFO : file name.txt.rclone_chunk.001_3fmvwa: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/14 01:12:53 INFO : file name.txt.rclone_chunk.002_3fmvwa: 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/03/14 01:13:02 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/14 01:13:02 DEBUG : Creating backend with remote "TestBox:" 2025/03/14 01:13:02 DEBUG : Reset feature "ListR" 2025/03/14 01:13:02 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/03/14 01:13:19 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_3fnpv0: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/03/14 01:13:20 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_3fnpv0: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/03/14 01:13:32 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_3fo26l: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/03/14 01:13:33 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_3fo26l: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/03/14 01:13:37 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi/dirToPurgeFromRoot" 2025/03/14 01:13:37 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/dirToPurgeFromRoot" 2025/03/14 01:13:38 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/14 01:13:41 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi/hello? sausage/êé" 2025/03/14 01:13:41 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/hello? sausage/êé" 2025/03/14 01:13:43 DEBUG : Reset feature "ListR" 2025/03/14 01:13:53 INFO : a/b/c/d/e.txt.rclone_chunk.001_3foib0: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/03/14 01:13:53 INFO : a/b/c/d/e.txt.rclone_chunk.002_3foib0: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/03/14 01:14:03 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/03/14 01:14:17 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/03/14 01:14:18 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/03/14 01:14:19 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/03/14 01:14:20 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/03/14 01:14:25 DEBUG : file name.txt: move 2 data chunks... 2025/03/14 01:14:26 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/03/14 01:14:27 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/03/14 01:14:29 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/03/14 01:14:33 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/03/14 01:14:34 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/14 01:14:35 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/14 01:14:36 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/03/14 01:14:40 DEBUG : other.txt: move 2 data chunks... 2025/03/14 01:14:41 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/03/14 01:14:42 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/03/14 01:14:43 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/03/14 01:14:50 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-witewob5tino" 2025/03/14 01:14:50 DEBUG : Creating backend with remote "TestBox:rclone-test-witewob5tino" 2025/03/14 01:14:51 DEBUG : box root 'rclone-test-witewob5tino': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/14 01:14:51 DEBUG : Reset feature "ListR" 2025/03/14 01:14:52 DEBUG : box root 'rclone-test-witewob5tino': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/14 01:14:58 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/14 01:15:02 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/14 01:15:10 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-witewob5tino': 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/03/14 01:15:50 INFO : file name.txt.rclone_chunk.001_3frqis: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/03/14 01:15:51 INFO : file name.txt.rclone_chunk.002_3frqis: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/03/14 01:15:52 INFO : file name.txt.rclone_chunk.003_3frqis: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/03/14 01:15:52 INFO : file name.txt.rclone_chunk.004_3frqis: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/03/14 01:16:01 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/14 01:16:01 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/14 01:16:06 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-vomotis4dosi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-vomotis4dosi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2025/03/14 01:16:06 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/14 01:16:06 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi/not found.txt" 2025/03/14 01:16:06 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/not found.txt" 2025/03/14 01:16:08 DEBUG : Reset feature "ListR" 2025/03/14 01:16:09 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-vomotis4dosi" from "TestChunkerChunk50bBox:rclone-test-vomotis4dosi" 2025/03/14 01:16:09 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/03/14 01:16:09 DEBUG : Reset feature "ListR" === 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/03/14 01:16:16 INFO : rclone-test-vomotis4dosi/created from root.txt.rclone_chunk.001_3fsnky: Moved (server-side) to: rclone-test-vomotis4dosi/created from root.txt.rclone_chunk.001 2025/03/14 01:16:17 INFO : rclone-test-vomotis4dosi/created from root.txt.rclone_chunk.002_3fsnky: Moved (server-side) to: rclone-test-vomotis4dosi/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/03/14 01:16:38 INFO : piped data.txt.rclone_chunk.001_3ftaz7: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/03/14 01:16:47 INFO : piped data.txt.rclone_chunk.001_3ftgup: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/03/14 01:16:48 INFO : piped data.txt.rclone_chunk.002_3ftgup: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/03/14 01:16:48 INFO : piped data.txt.rclone_chunk.003_3ftgup: 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/03/14 01:16:56 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-vomotis4dosi': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/03/14 01:17:02 INFO : small/emptyfile.rclone_chunk.001_3ftwfd: Moved (server-side) to: small/emptyfile 2025/03/14 01:17:10 INFO : small/smallfile.rclone_chunk.001_3fu6xt: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/03/14 01:17:25 INFO : corrupted/billy.rclone_chunk.001_3fuf0q: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/03/14 01:17:26 INFO : corrupted/billy.rclone_chunk.002_3fuf0q: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/03/14 01:17:26 INFO : corrupted/billy.rclone_chunk.003_3fuf0q: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/03/14 01:17:27 INFO : corrupted/billy.rclone_chunk.004_3fuf0q: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/03/14 01:17:27 INFO : corrupted/billy.rclone_chunk.005_3fuf0q: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/03/14 01:17:39 INFO : corrupted/silly1.rclone_chunk.001_3fuug1: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/03/14 01:17:40 INFO : corrupted/silly1.rclone_chunk.002_3fuug1: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/03/14 01:17:40 INFO : corrupted/silly1.rclone_chunk.003_3fuug1: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/03/14 01:17:41 INFO : corrupted/silly1.rclone_chunk.004_3fuug1: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/03/14 01:17:41 INFO : corrupted/silly1.rclone_chunk.005_3fuug1: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/03/14 01:17:56 INFO : corrupted/silly2.rclone_chunk.001_3fv8ii: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/03/14 01:17:57 INFO : corrupted/silly2.rclone_chunk.002_3fv8ii: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/03/14 01:17:57 INFO : corrupted/silly2.rclone_chunk.003_3fv8ii: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/03/14 01:17:58 INFO : corrupted/silly2.rclone_chunk.004_3fv8ii: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/03/14 01:17:59 INFO : corrupted/silly2.rclone_chunk.005_3fv8ii: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/03/14 01:18:21 INFO : corrupted/silly3.rclone_chunk.001_3fvyv9: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/03/14 01:18:21 INFO : corrupted/silly3.rclone_chunk.002_3fvyv9: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/03/14 01:18:22 INFO : corrupted/silly3.rclone_chunk.003_3fvyv9: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/03/14 01:18:22 INFO : corrupted/silly3.rclone_chunk.004_3fvyv9: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/03/14 01:18:23 INFO : corrupted/silly3.rclone_chunk.005_3fvyv9: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/03/14 01:18:35 INFO : corrupted/willy.rclone_chunk.001_3fwd9m: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/03/14 01:18:35 INFO : corrupted/willy.rclone_chunk.002_3fwd9m: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/03/14 01:18:36 INFO : corrupted/willy.rclone_chunk.003_3fwd9m: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/03/14 01:18:36 INFO : corrupted/willy.rclone_chunk.004_3fwd9m: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/03/14 01:18:37 INFO : corrupted/willy.rclone_chunk.005_3fwd9m: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/03/14 01:18:55 INFO : corrupted/silly4.rclone_chunk.001_3fwsp2: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/03/14 01:18:55 INFO : corrupted/silly4.rclone_chunk.002_3fwsp2: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/03/14 01:18:56 INFO : corrupted/silly4.rclone_chunk.003_3fwsp2: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/03/14 01:18:57 INFO : corrupted/silly4.rclone_chunk.004_3fwsp2: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/03/14 01:18:57 INFO : corrupted/silly4.rclone_chunk.005_3fwsp2: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/03/14 01:19:01 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/03/14 01:19:15 INFO : corrupted/silly5.rclone_chunk.001_3fxdp2: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/03/14 01:19:16 INFO : corrupted/silly5.rclone_chunk.002_3fxdp2: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/03/14 01:19:16 INFO : corrupted/silly5.rclone_chunk.003_3fxdp2: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/03/14 01:19:17 INFO : corrupted/silly5.rclone_chunk.004_3fxdp2: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/03/14 01:19:17 INFO : corrupted/silly5.rclone_chunk.005_3fxdp2: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/03/14 01:19:20 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2025/03/14 01:19:35 INFO : wreaked/wreaker.rclone_chunk.001_3fy592: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/03/14 01:19:35 INFO : wreaked/wreaker.rclone_chunk.002_3fy592: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/03/14 01:19:40 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-vomotis4dosi': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/03/14 01:19:56 ERROR : usermeta/today.rclone_chunk.001_3fys6s: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1802747053988","file_version":{"type":"file_version","id":"1986985319588","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_3fys6s"}}) 2025/03/14 01:19:58 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/03/14 01:19:59 INFO : usermeta/today.rclone_chunk.001_3fys6s: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/03/14 01:20:11 ERROR : usermeta/past.rclone_chunk.001_3fz7a7: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1802750368694","file_version":{"type":"file_version","id":"1986989073494","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_3fz7a7"}}) 2025/03/14 01:20:13 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/03/14 01:20:13 INFO : usermeta/past.rclone_chunk.001_3fz7a7: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/03/14 01:20:25 ERROR : usermeta/future.rclone_chunk.001_3fzl46: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1802746426936","file_version":{"type":"file_version","id":"1986984529336","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_3fzl46"}}) 2025/03/14 01:20:27 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/03/14 01:20:27 INFO : usermeta/future.rclone_chunk.001_3fzl46: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/03/14 01:20:47 DEBUG : future/test: Can't move - required hash not found 2025/03/14 01:20:47 DEBUG : future/test: Can't move, switching to copy 2025/03/14 01:20:48 DEBUG : future/test: Can't copy - required hash not found 2025/03/14 01:20:49 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/14 01:20:49 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/03/14 01:20:51 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-vomotis4dosi': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/03/14 01:21:36 INFO : backcomp/renamefile.rclone_chunk.001_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/03/14 01:21:37 INFO : backcomp/renamefile.rclone_chunk.002_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/03/14 01:21:37 INFO : backcomp/renamefile.rclone_chunk.003_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/03/14 01:21:38 INFO : backcomp/renamefile.rclone_chunk.004_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/03/14 01:21:38 INFO : backcomp/renamefile.rclone_chunk.005_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/03/14 01:21:39 INFO : backcomp/renamefile.rclone_chunk.006_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/03/14 01:21:39 INFO : backcomp/renamefile.rclone_chunk.007_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/03/14 01:21:40 INFO : backcomp/renamefile.rclone_chunk.008_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/03/14 01:21:40 INFO : backcomp/renamefile.rclone_chunk.009_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/03/14 01:21:41 INFO : backcomp/renamefile.rclone_chunk.010_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/03/14 01:21:41 INFO : backcomp/renamefile.rclone_chunk.011_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/03/14 01:21:42 INFO : backcomp/renamefile.rclone_chunk.012_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/03/14 01:21:42 INFO : backcomp/renamefile.rclone_chunk.013_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/03/14 01:21:43 INFO : backcomp/renamefile.rclone_chunk.014_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/03/14 01:21:44 INFO : backcomp/renamefile.rclone_chunk.015_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/03/14 01:21:45 INFO : backcomp/renamefile.rclone_chunk.016_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/03/14 01:21:45 INFO : backcomp/renamefile.rclone_chunk.017_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/03/14 01:21:46 INFO : backcomp/renamefile.rclone_chunk.018_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/03/14 01:21:47 INFO : backcomp/renamefile.rclone_chunk.019_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/03/14 01:21:47 INFO : backcomp/renamefile.rclone_chunk.020_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/03/14 01:21:48 INFO : backcomp/renamefile.rclone_chunk.021_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/03/14 01:21:49 INFO : backcomp/renamefile.rclone_chunk.022_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/03/14 01:21:49 INFO : backcomp/renamefile.rclone_chunk.023_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/03/14 01:21:50 INFO : backcomp/renamefile.rclone_chunk.024_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/03/14 01:21:51 INFO : backcomp/renamefile.rclone_chunk.025_3g0j0e: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/03/14 01:22:26 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi/servermovetest/subdir1" 2025/03/14 01:22:26 DEBUG : Config file has changed externally - reloading 2025/03/14 01:22:26 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/servermovetest/subdir1" 2025/03/14 01:22:28 DEBUG : Reset feature "ListR" 2025/03/14 01:22:28 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi/servermovetest/subdir2" 2025/03/14 01:22:28 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/servermovetest/subdir2" 2025/03/14 01:22:30 DEBUG : Reset feature "ListR" 2025/03/14 01:22:36 INFO : movefile.rclone_chunk.001_3g3513: Moved (server-side) to: movefile.rclone_chunk.001 2025/03/14 01:22:37 INFO : movefile.rclone_chunk.002_3g3513: Moved (server-side) to: movefile.rclone_chunk.002 2025/03/14 01:22:41 DEBUG : movefile: move 2 data chunks... 2025/03/14 01:22:43 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/03/14 01:22:44 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/03/14 01:22:47 INFO : movefile: Moved (server-side) 2025/03/14 01:22:49 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/03/14 01:22:56 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-vomotis4dosi/md5all" 2025/03/14 01:22:56 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/03/14 01:22:56 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/md5all" 2025/03/14 01:22:58 DEBUG : Reset feature "ListR" 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/03/14 01:23:05 INFO : unknown-size-put.txt.rclone_chunk.001_3g3yfg: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/03/14 01:23:05 INFO : unknown-size-put.txt.rclone_chunk.002_3g3yfg: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/03/14 01:23:06 INFO : unknown-size-put.txt.rclone_chunk.003_3g3yfg: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/03/14 01:23:18 INFO : unknown-size-update.txt.rclone_chunk.001_3g4du4: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/14 01:23:18 INFO : unknown-size-update.txt.rclone_chunk.002_3g4du4: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/14 01:23:34 INFO : unknown-size-update.txt.rclone_chunk.001_3g4m8f: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/03/14 01:23:34 INFO : unknown-size-update.txt.rclone_chunk.002_3g4m8f: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/03/14 01:23:35 INFO : unknown-size-update.txt.rclone_chunk.003_3g4m8f: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/03/14 01:23:35 INFO : unknown-size-update.txt.rclone_chunk.004_3g4m8f: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/03/14 01:23:36 INFO : unknown-size-update.txt.rclone_chunk.005_3g4m8f: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/03/14 01:23:43 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vomotis4dosi/deeper/nonexisting/directory" 2025/03/14 01:23:43 DEBUG : Creating backend with remote "TestBox:rclone-test-vomotis4dosi/deeper/nonexisting/directory" 2025/03/14 01:23:46 DEBUG : Reset feature "ListR" === 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/03/14 01:23:53 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/14 01:23:53 ERROR : : error listing: directory not found 2025/03/14 01:23:53 DEBUG : box root 'rclone-test-vomotis4dosi': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1125.73s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.59s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.02s) --- FAIL: TestIntegration/FsMkdir (1121.40s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.20s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.32s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.43s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.33s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (291.35s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (13.64s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (16.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (17.07s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (15.43s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (13.25s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (15.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (17.55s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (13.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (13.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (15.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (19.45s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (14.69s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (13.71s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (16.85s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (16.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (13.85s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (12.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (16.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (15.49s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutError (58.91s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.94s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (69.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (630.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (2.13s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (2.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.64s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.74s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.82s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (2.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (2.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (13.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (14.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (19.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (14.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (35.19s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (21.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (1.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (1.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (1.16s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (1.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (1.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (5.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (21.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (17.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (2.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.42s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (15.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.48s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.98s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (7.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (21.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (16.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (361.68s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (19.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (133.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (19.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (45.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (21.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (90.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (29.39s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (2.57s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (45.30s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (15.18s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (30.11s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (3.08s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.65s) --- 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 1125.762s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 18m47.786025002s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]