"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestChunkerChunk50bBox:" 2025/05/19 01:10:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu" 2025/05/19 01:10:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/19 01:10:46 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu" 2025/05/19 01:10:47 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/05/19 01:10:49 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/19 01:10:49 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/05/19 01:10:53 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/05/19 01:10:54 INFO : dir/subdir: Making directory 2025/05/19 01:10:58 INFO : dir/subdir: Removing directory 2025/05/19 01:11:00 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/05/19 01:11:04 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/05/19 01:11:11 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_hnkqb3: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2025/05/19 01:11:12 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_hnkqb3: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/05/19 01:11:26 INFO : ./..rclone_chunk.001_hnl6qj: Moved (server-side) to: ./..rclone_chunk.001 2025/05/19 01:11:27 INFO : ./..rclone_chunk.002_hnl6qj: Moved (server-side) to: ./..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/05/19 01:11:42 INFO : ../...rclone_chunk.001_hnlllq: Moved (server-side) to: ../...rclone_chunk.001 2025/05/19 01:11:42 INFO : ../...rclone_chunk.002_hnlllq: Moved (server-side) to: ../...rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/05/19 01:11:57 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001_hnm0ys: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.001 2025/05/19 01:11:58 INFO : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002_hnm0ys: Moved (server-side) to: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/05/19 01:12:12 INFO : leading space/ leading space.rclone_chunk.001_hnmgqr: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2025/05/19 01:12:13 INFO : leading space/ leading space.rclone_chunk.002_hnmgqr: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/05/19 01:12:27 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_hnmv7a: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2025/05/19 01:12:28 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_hnmv7a: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/05/19 01:12:42 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_hnna4n: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2025/05/19 01:12:43 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_hnna4n: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/05/19 01:12:58 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_hnnpc0: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2025/05/19 01:12:58 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_hnnpc0: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/05/19 01:13:13 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_hno5gg: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2025/05/19 01:13:14 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_hno5gg: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/05/19 01:13:28 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_hnokvl: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2025/05/19 01:13:29 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_hnokvl: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/05/19 01:13:44 INFO : .leading dot/.leading dot.rclone_chunk.001_hnozfn: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2025/05/19 01:13:44 INFO : .leading dot/.leading dot.rclone_chunk.002_hnozfn: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/05/19 01:13:59 INFO : trailing space /trailing space .rclone_chunk.001_hnpeas: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2025/05/19 01:13:59 INFO : trailing space /trailing space .rclone_chunk.002_hnpeas: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/05/19 01:14:14 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_hnpt3j: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2025/05/19 01:14:15 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_hnpt3j: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/05/19 01:14:29 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_hnq9ac: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2025/05/19 01:14:30 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_hnq9ac: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/05/19 01:14:44 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_hnqovj: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2025/05/19 01:14:45 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_hnqovj: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/05/19 01:15:00 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_hnr3r7: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2025/05/19 01:15:01 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_hnr3r7: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/05/19 01:15:16 INFO : trailing dot./trailing dot..rclone_chunk.001_hnrjlu: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2025/05/19 01:15:16 INFO : trailing dot./trailing dot..rclone_chunk.002_hnrjlu: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/05/19 01:15:31 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_hnrzl2: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2025/05/19 01:15:32 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_hnrzl2: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/05/19 01:15:46 INFO : test%46.txt/test%46.txt.rclone_chunk.001_hnsesw: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2025/05/19 01:15:47 INFO : test%46.txt/test%46.txt.rclone_chunk.002_hnsesw: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError fstests.go:747: Reduce file size due to limit 1024 === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/05/19 01:17:02 INFO : zero-length-file.rclone_chunk.001_hnuigw: Moved (server-side) to: zero-length-file === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/05/19 01:17:04 INFO : dir: Making directory 2025/05/19 01:17:06 INFO : dir/subdir1: Making directory 2025/05/19 01:17:07 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102172957") 2025/05/19 01:17:07 INFO : dir/subdir3: Making directory 2025/05/19 01:17:07 DEBUG : box root 'rclone-test-cefudal4kehu': ["zero-length-file"(1)|file|ITEM_RENAME|1866032718016|74f2e5a7fd040ec7e1e5e321701bf31710d62708] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:07 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:07 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102174192") 2025/05/19 01:17:08 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102174449") 2025/05/19 01:17:08 INFO : dir/subdir2: Making directory 2025/05/19 01:17:09 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102175190") 2025/05/19 01:17:10 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102176200") 2025/05/19 01:17:11 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102177195") 2025/05/19 01:17:11 DEBUG : box root 'rclone-test-cefudal4kehu': ["zero-length-file"(2)|file|ITEM_TRASH|1866032718016|60a53fe9c632b4c6a85cf004a24f3f29a3af4503] added old path ("zero-length-file") for notify 2025/05/19 01:17:11 DEBUG : doChangeNotify("zero-length-file", 1) 2025/05/19 01:17:11 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:17:11 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102178188") 2025/05/19 01:17:12 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102178425") 2025/05/19 01:17:12 DEBUG : box root 'rclone-test-cefudal4kehu': ["dir"(0)|folder|ITEM_CREATE|321764920098|ab019f9cfc90fcbc47ecb98336fe36580b3fa08c] added new path ("dir") for notify 2025/05/19 01:17:12 DEBUG : doChangeNotify("dir", 0) 2025/05/19 01:17:12 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:17:12 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102179184") 2025/05/19 01:17:13 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102179428") 2025/05/19 01:17:14 INFO : dir/file2.rclone_chunk.001_hnutnm: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/05/19 01:17:14 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102180190") 2025/05/19 01:17:14 INFO : dir/file2.rclone_chunk.002_hnutnm: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/05/19 01:17:15 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102181192") 2025/05/19 01:17:15 DEBUG : box root 'rclone-test-cefudal4kehu': ["subdir3"(0)|folder|ITEM_CREATE|321761404735|8acb12e7286ddcf90ec8794ca060797250d49ed7] added new path ("dir/subdir3") for notify 2025/05/19 01:17:15 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/05/19 01:17:15 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:17:15 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102182196") 2025/05/19 01:17:15 DEBUG : box root 'rclone-test-cefudal4kehu': ["subdir2"(0)|folder|ITEM_CREATE|321761322530|83e6c0252dc7d2464263dbe10b8f1d9c7cc62f97] added new path ("dir/subdir2") for notify 2025/05/19 01:17:15 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/05/19 01:17:15 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:17:15 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102182439") 2025/05/19 01:17:16 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102182687") 2025/05/19 01:17:16 DEBUG : box root 'rclone-test-cefudal4kehu': ["subdir1"(0)|folder|ITEM_CREATE|321763566652|6109904677e1f1ad22ecb9c1d3adf23c190c98f3] added new path ("dir/subdir1") for notify 2025/05/19 01:17:16 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/05/19 01:17:16 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:17:16 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102183183") 2025/05/19 01:17:17 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102183419") 2025/05/19 01:17:17 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2.rclone_chunk.001_hnutnm"(0)|file|ITEM_UPLOAD|1866038195710|ad1345c9d98531ef8d5e84026c58ab0044aa85e5] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:17 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:17 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102184185") 2025/05/19 01:17:18 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102184431") 2025/05/19 01:17:19 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102185186") 2025/05/19 01:17:19 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2.rclone_chunk.002_hnutnm"(0)|file|ITEM_UPLOAD|1866037506766|b590b034952a3f72557aa3dc2b83f8e79f9661d0] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:19 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:19 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102186190") 2025/05/19 01:17:20 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102186431") 2025/05/19 01:17:20 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1866038195710|24e732cab2a291cf8b4ea65b4ba216d692ad5018] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:20 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:20 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102187198") 2025/05/19 01:17:21 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102187435") 2025/05/19 01:17:21 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1866037506766|ae43f2f37043aa7fb883c9725876ddaba9858e45] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:21 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:21 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102188189") 2025/05/19 01:17:21 INFO : dir/file4.rclone_chunk.001_hnv1k1: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/05/19 01:17:22 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102188426") 2025/05/19 01:17:22 INFO : dir/file4.rclone_chunk.002_hnv1k1: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/05/19 01:17:23 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102189186") 2025/05/19 01:17:23 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2"(0)|file|ITEM_UPLOAD|1866035720918|5782745511ecb5117c73a4c5f2fe2a1791f72a28] ignored due to old SequenceID ('\x00') 2025/05/19 01:17:23 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:23 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102190183") 2025/05/19 01:17:24 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102190423") 2025/05/19 01:17:25 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102191185") 2025/05/19 01:17:25 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4.rclone_chunk.001_hnv1k1"(0)|file|ITEM_UPLOAD|1866034991589|69c5342096868d660ceae8690e267cbfb8c558b9] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:25 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:25 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102192182") 2025/05/19 01:17:26 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102192424") 2025/05/19 01:17:27 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102193184") 2025/05/19 01:17:27 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4.rclone_chunk.002_hnv1k1"(0)|file|ITEM_UPLOAD|1866038894334|6c0d10d887b2141e355c0581a742a90408651ef5] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:27 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:27 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102194182") 2025/05/19 01:17:28 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102194418") 2025/05/19 01:17:28 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1866034991589|1ab0bb9795251e720cdfda9d024e5fc60efa6a71] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:28 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:28 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102195188") 2025/05/19 01:17:29 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102195422") 2025/05/19 01:17:30 INFO : dir/file3.rclone_chunk.001_hnv9r2: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/05/19 01:17:30 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102196187") 2025/05/19 01:17:30 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1866038894334|8fc2de02f82c98646c7bfe6621ca2024ec141b99] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:30 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:30 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102197185") 2025/05/19 01:17:30 INFO : dir/file3.rclone_chunk.002_hnv9r2: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/05/19 01:17:31 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102197429") 2025/05/19 01:17:32 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102198187") 2025/05/19 01:17:32 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4"(0)|file|ITEM_UPLOAD|1866036321176|f0da42bf7b2e4fdd0f280efa6abd8e2f1553882c] ignored due to old SequenceID ('\x00') 2025/05/19 01:17:32 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:32 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102199196") 2025/05/19 01:17:33 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102199442") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/05/19 01:17:33 DEBUG : box root 'rclone-test-cefudal4kehu': ["file3.rclone_chunk.001_hnv9r2"(0)|file|ITEM_UPLOAD|1866030602035|c7bff61c9fdfacfef00610cc1b9352c04d18a658] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:33 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:33 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102200184") 2025/05/19 01:17:34 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102200420") 2025/05/19 01:17:35 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102201191") 2025/05/19 01:17:35 DEBUG : box root 'rclone-test-cefudal4kehu': ["file3.rclone_chunk.002_hnv9r2"(0)|file|ITEM_UPLOAD|1866034592713|d9f9ec5d8efd86c438388969d0c45b5b8450cf12] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:35 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:35 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102202191") 2025/05/19 01:17:36 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102202431") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/05/19 01:17:36 DEBUG : box root 'rclone-test-cefudal4kehu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1866030602035|85ad8b218373c7b6323cc50806ef9df195592acf] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:36 DEBUG : box root 'rclone-test-cefudal4kehu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1866034592713|ccd2f8903cbc3159c8ce0d34d23c1082ccc9becf] ignored due to old SequenceID ('\x01') 2025/05/19 01:17:36 DEBUG : box root 'rclone-test-cefudal4kehu': Received 2 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:36 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102203186") 2025/05/19 01:17:37 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102203431") 2025/05/19 01:17:38 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102204180") 2025/05/19 01:17:39 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102205186") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/05/19 01:17:39 DEBUG : box root 'rclone-test-cefudal4kehu': ["file3"(0)|file|ITEM_UPLOAD|1866030824479|9604bae82c4a70b10b30db2f70f7e2b852867188] ignored due to old SequenceID ('\x00') 2025/05/19 01:17:39 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/19 01:17:39 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102206201") 2025/05/19 01:17:40 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102206446") 2025/05/19 01:17:41 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102207182") 2025/05/19 01:17:42 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102208188") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/05/19 01:17:43 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102209186") 2025/05/19 01:17:44 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102210176") 2025/05/19 01:17:45 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102211186") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/05/19 01:17:46 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102212186") 2025/05/19 01:17:47 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102213186") 2025/05/19 01:17:48 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102214187") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/05/19 01:17:49 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102215190") 2025/05/19 01:17:50 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102216229") 2025/05/19 01:17:51 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102217181") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/05/19 01:17:52 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102218185") 2025/05/19 01:17:53 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102219204") 2025/05/19 01:17:54 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102220196") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/05/19 01:17:55 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102221191") 2025/05/19 01:17:56 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102222193") 2025/05/19 01:17:57 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102223191") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/05/19 01:17:58 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102224188") 2025/05/19 01:17:59 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102225190") 2025/05/19 01:18:00 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102226196") fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/05/19 01:18:01 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102227194") 2025/05/19 01:18:02 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102228182") 2025/05/19 01:18:03 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102229193") 2025/05/19 01:18:04 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102230199") 2025/05/19 01:18:05 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102231190") 2025/05/19 01:18:06 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102232201") 2025/05/19 01:18:07 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102233183") 2025/05/19 01:18:07 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2"(1)|file|ITEM_TRASH|1866035720918|6463382d59421445c43c0d81282d0b674e018d05] added old path ("dir/file2") for notify 2025/05/19 01:18:07 DEBUG : doChangeNotify("dir/file2", 1) 2025/05/19 01:18:07 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:18:07 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102234191") 2025/05/19 01:18:08 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102234429") 2025/05/19 01:18:09 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102235189") 2025/05/19 01:18:10 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102236185") 2025/05/19 01:18:10 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1866038195710|1d58b6da8eeed5f9a98876bb6a3c6b932e93f4a9] added old path ("dir/file2.rclone_chunk.001") for notify 2025/05/19 01:18:10 DEBUG : doChangeNotify("dir/file2", 1) 2025/05/19 01:18:10 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:18:10 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102237184") 2025/05/19 01:18:11 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102237427") 2025/05/19 01:18:11 DEBUG : box root 'rclone-test-cefudal4kehu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1866037506766|bac9e310f986022b8e1a02611d5c9ad6fb2eb47f] added old path ("dir/file2.rclone_chunk.002") for notify 2025/05/19 01:18:11 DEBUG : doChangeNotify("dir/file2", 1) 2025/05/19 01:18:11 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:18:11 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102238185") 2025/05/19 01:18:12 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102238429") 2025/05/19 01:18:13 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102239191") 2025/05/19 01:18:13 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4"(1)|file|ITEM_TRASH|1866036321176|be58271d0af582763477dcef5a3e9c6fc5f79451] added old path ("dir/file4") for notify 2025/05/19 01:18:13 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1866034991589|3953c1013db29d70aad8db6462a041f94ef6a59b] added old path ("dir/file4.rclone_chunk.001") for notify 2025/05/19 01:18:13 DEBUG : doChangeNotify("dir/file4", 1) 2025/05/19 01:18:13 DEBUG : doChangeNotify("dir/file4", 1) 2025/05/19 01:18:13 DEBUG : box root 'rclone-test-cefudal4kehu': Received 2 events, resulting in 2 paths and 2 notifications 2025/05/19 01:18:13 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102240188") 2025/05/19 01:18:14 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102240443") 2025/05/19 01:18:15 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102241205") 2025/05/19 01:18:15 DEBUG : box root 'rclone-test-cefudal4kehu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1866038894334|be05bb8581f30f644851ee8504419fb7539f8797] added old path ("dir/file4.rclone_chunk.002") for notify 2025/05/19 01:18:15 DEBUG : doChangeNotify("dir/file4", 1) 2025/05/19 01:18:15 DEBUG : box root 'rclone-test-cefudal4kehu': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/19 01:18:15 DEBUG : box root 'rclone-test-cefudal4kehu': Checking for changes on remote (next_stream_position: "30401045102242184") === RUN TestIntegration/FsMkdir/FsPutFiles 2025/05/19 01:18:21 INFO : file name.txt.rclone_chunk.001_hnwos1: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/05/19 01:18:21 INFO : file name.txt.rclone_chunk.002_hnwos1: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/05/19 01:18:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_hnww7q: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/05/19 01:18:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_hnww7q: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/05/19 01:18:41 INFO : file name.txt.rclone_chunk.001_hnx64e: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/05/19 01:18:41 INFO : file name.txt.rclone_chunk.002_hnx64e: Moved (server-side) to: file name.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/05/19 01:18:49 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" 2025/05/19 01:18:49 DEBUG : Creating backend with remote "TestBox:" 2025/05/19 01:18:50 DEBUG : box root '': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2025/05/19 01:19:07 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_hnxx1e: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2025/05/19 01:19:08 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_hnxx1e: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/05/19 01:19:22 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001_hnydrf: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.001 2025/05/19 01:19:23 INFO : dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002_hnydrf: Moved (server-side) to: dirToPurgeFromRoot/fileToPurgeFromRoot.txt.rclone_chunk.002 2025/05/19 01:19:27 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu/dirToPurgeFromRoot" 2025/05/19 01:19:27 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/dirToPurgeFromRoot" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/05/19 01:19:33 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu/hello? sausage/êé" 2025/05/19 01:19:33 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/hello? sausage/êé" 2025/05/19 01:19:45 INFO : a/b/c/d/e.txt.rclone_chunk.001_hnyvfe: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.001 2025/05/19 01:19:45 INFO : a/b/c/d/e.txt.rclone_chunk.002_hnyvfe: Moved (server-side) to: a/b/c/d/e.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/05/19 01:19:55 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy 2 data chunks... === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1289: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/05/19 01:20:08 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2025/05/19 01:20:09 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2025/05/19 01:20:10 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2025/05/19 01:20:11 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2025/05/19 01:20:16 DEBUG : file name.txt: move 2 data chunks... 2025/05/19 01:20:18 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2025/05/19 01:20:19 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2025/05/19 01:20:20 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2025/05/19 01:20:26 DEBUG : moveTest/other.txt: move 2 data chunks... 2025/05/19 01:20:27 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/05/19 01:20:28 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/05/19 01:20:29 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2025/05/19 01:20:34 DEBUG : other.txt: move 2 data chunks... 2025/05/19 01:20:35 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2025/05/19 01:20:36 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2025/05/19 01:20:37 INFO : other.txt: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/05/19 01:20:41 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-fefozoh7fogi" 2025/05/19 01:20:41 DEBUG : Creating backend with remote "TestBox:rclone-test-fefozoh7fogi" 2025/05/19 01:20:42 DEBUG : box root 'rclone-test-fefozoh7fogi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/19 01:20:44 DEBUG : box root 'rclone-test-fefozoh7fogi': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/19 01:20:51 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/19 01:20:55 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/19 01:21:02 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-fefozoh7fogi': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/05/19 01:21:43 INFO : file name.txt.rclone_chunk.001_ho252d: Moved (server-side) to: file name.txt.rclone_chunk.001 2025/05/19 01:21:44 INFO : file name.txt.rclone_chunk.002_ho252d: Moved (server-side) to: file name.txt.rclone_chunk.002 2025/05/19 01:21:44 INFO : file name.txt.rclone_chunk.003_ho252d: Moved (server-side) to: file name.txt.rclone_chunk.003 2025/05/19 01:21:45 INFO : file name.txt.rclone_chunk.004_ho252d: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/05/19 01:21:52 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/05/19 01:21:52 DEBUG : Config file has changed externally - reloading 2025/05/19 01:21:52 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/05/19 01:21:59 DEBUG : fs cache: renaming child cache item "TestBox:rclone-test-cefudal4kehu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" to be canonical for parent "TestBox:rclone-test-cefudal4kehu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/05/19 01:21:59 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu/not found.txt" 2025/05/19 01:21:59 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/not found.txt" 2025/05/19 01:22:02 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestChunkerChunk50bBox:" path "rclone-test-cefudal4kehu" from "TestChunkerChunk50bBox:rclone-test-cefudal4kehu" 2025/05/19 01:22:02 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/05/19 01:22:09 INFO : rclone-test-cefudal4kehu/created from root.txt.rclone_chunk.001_ho315g: Moved (server-side) to: rclone-test-cefudal4kehu/created from root.txt.rclone_chunk.001 2025/05/19 01:22:10 INFO : rclone-test-cefudal4kehu/created from root.txt.rclone_chunk.002_ho315g: Moved (server-side) to: rclone-test-cefudal4kehu/created from root.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/05/19 01:22:34 INFO : piped data.txt.rclone_chunk.001_ho3r7u: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/05/19 01:22:43 INFO : piped data.txt.rclone_chunk.001_ho3xcd: Moved (server-side) to: piped data.txt.rclone_chunk.001 2025/05/19 01:22:43 INFO : piped data.txt.rclone_chunk.002_ho3xcd: Moved (server-side) to: piped data.txt.rclone_chunk.002 2025/05/19 01:22:44 INFO : piped data.txt.rclone_chunk.003_ho3xcd: Moved (server-side) to: piped data.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge chunker_internal_test.go:906: -upload-kilobytes is not set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat 2025/05/19 01:22:52 INFO : Chunked 'TestChunkerChunk50bBox:rclone-test-cefudal4kehu': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2025/05/19 01:22:57 INFO : small/emptyfile.rclone_chunk.001_ho4ctv: Moved (server-side) to: small/emptyfile 2025/05/19 01:23:04 INFO : small/smallfile.rclone_chunk.001_ho4l8z: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2025/05/19 01:23:20 INFO : corrupted/billy.rclone_chunk.001_ho4uir: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2025/05/19 01:23:21 INFO : corrupted/billy.rclone_chunk.002_ho4uir: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2025/05/19 01:23:21 INFO : corrupted/billy.rclone_chunk.003_ho4uir: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2025/05/19 01:23:22 INFO : corrupted/billy.rclone_chunk.004_ho4uir: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2025/05/19 01:23:22 INFO : corrupted/billy.rclone_chunk.005_ho4uir: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2025/05/19 01:23:35 INFO : corrupted/silly1.rclone_chunk.001_ho594q: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2025/05/19 01:23:36 INFO : corrupted/silly1.rclone_chunk.002_ho594q: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2025/05/19 01:23:36 INFO : corrupted/silly1.rclone_chunk.003_ho594q: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2025/05/19 01:23:37 INFO : corrupted/silly1.rclone_chunk.004_ho594q: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2025/05/19 01:23:37 INFO : corrupted/silly1.rclone_chunk.005_ho594q: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2025/05/19 01:23:51 INFO : corrupted/silly2.rclone_chunk.001_ho5pji: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2025/05/19 01:23:51 INFO : corrupted/silly2.rclone_chunk.002_ho5pji: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2025/05/19 01:23:52 INFO : corrupted/silly2.rclone_chunk.003_ho5pji: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2025/05/19 01:23:52 INFO : corrupted/silly2.rclone_chunk.004_ho5pji: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2025/05/19 01:23:53 INFO : corrupted/silly2.rclone_chunk.005_ho5pji: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2025/05/19 01:24:09 INFO : corrupted/silly3.rclone_chunk.001_ho67mu: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2025/05/19 01:24:10 INFO : corrupted/silly3.rclone_chunk.002_ho67mu: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2025/05/19 01:24:10 INFO : corrupted/silly3.rclone_chunk.003_ho67mu: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2025/05/19 01:24:11 INFO : corrupted/silly3.rclone_chunk.004_ho67mu: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2025/05/19 01:24:11 INFO : corrupted/silly3.rclone_chunk.005_ho67mu: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2025/05/19 01:24:24 INFO : corrupted/willy.rclone_chunk.001_ho6m8l: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2025/05/19 01:24:25 INFO : corrupted/willy.rclone_chunk.002_ho6m8l: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2025/05/19 01:24:26 INFO : corrupted/willy.rclone_chunk.003_ho6m8l: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2025/05/19 01:24:26 INFO : corrupted/willy.rclone_chunk.004_ho6m8l: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2025/05/19 01:24:26 INFO : corrupted/willy.rclone_chunk.005_ho6m8l: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2025/05/19 01:24:41 INFO : corrupted/silly4.rclone_chunk.001_ho7393: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2025/05/19 01:24:41 INFO : corrupted/silly4.rclone_chunk.002_ho7393: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2025/05/19 01:24:42 INFO : corrupted/silly4.rclone_chunk.003_ho7393: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2025/05/19 01:24:42 INFO : corrupted/silly4.rclone_chunk.004_ho7393: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2025/05/19 01:24:43 INFO : corrupted/silly4.rclone_chunk.005_ho7393: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2025/05/19 01:24:47 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2025/05/19 01:24:57 INFO : corrupted/silly5.rclone_chunk.001_ho7j9c: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2025/05/19 01:24:57 INFO : corrupted/silly5.rclone_chunk.002_ho7j9c: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2025/05/19 01:24:58 INFO : corrupted/silly5.rclone_chunk.003_ho7j9c: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2025/05/19 01:24:59 INFO : corrupted/silly5.rclone_chunk.004_ho7j9c: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2025/05/19 01:24:59 INFO : corrupted/silly5.rclone_chunk.005_ho7j9c: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2025/05/19 01:25:02 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2025/05/19 01:25:24 INFO : wreaked/wreaker.rclone_chunk.001_ho8fy5: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2025/05/19 01:25:25 INFO : wreaked/wreaker.rclone_chunk.002_ho8fy5: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2025/05/19 01:25:30 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-cefudal4kehu': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2025/05/19 01:25:45 ERROR : usermeta/today.rclone_chunk.001_ho920s: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1866039563716","file_version":{"type":"file_version","id":"2057783447716","sha1":"7be49e353ee21561206e1da71b883cd5538b9973"},"sequence_id":"0","etag":"0","sha1":"7be49e353ee21561206e1da71b883cd5538b9973","name":"today.rclone_chunk.001_ho920s"}}) 2025/05/19 01:25:47 INFO : usermeta/today.rclone_chunk.001: Deleted 2025/05/19 01:25:47 INFO : usermeta/today.rclone_chunk.001_ho920s: Moved (server-side) to: usermeta/today.rclone_chunk.001 2025/05/19 01:26:00 ERROR : usermeta/past.rclone_chunk.001_ho9hau: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1866038193295","file_version":{"type":"file_version","id":"2057781851695","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774"},"sequence_id":"0","etag":"0","sha1":"19ce348da906ba7f953608f75d61d9f2d9bb6774","name":"past.rclone_chunk.001_ho9hau"}}) 2025/05/19 01:26:01 INFO : usermeta/past.rclone_chunk.001: Deleted 2025/05/19 01:26:02 INFO : usermeta/past.rclone_chunk.001_ho9hau: Moved (server-side) to: usermeta/past.rclone_chunk.001 2025/05/19 01:26:14 ERROR : usermeta/future.rclone_chunk.001_ho9vpr: Couldn't move: Error "item_name_in_use" (409): Item with the same name already exists ({"conflicts":{"type":"file","id":"1866044780818","file_version":{"type":"file_version","id":"2057788600018","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba"},"sequence_id":"0","etag":"0","sha1":"4f93e7315127f1e93e7e33b2c1b3cc8be5a6d6ba","name":"future.rclone_chunk.001_ho9vpr"}}) 2025/05/19 01:26:15 INFO : usermeta/future.rclone_chunk.001: Deleted 2025/05/19 01:26:16 INFO : usermeta/future.rclone_chunk.001_ho9vpr: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2025/05/19 01:26:37 DEBUG : future/test: Can't move - required hash not found 2025/05/19 01:26:37 DEBUG : future/test: Can't move, switching to copy 2025/05/19 01:26:38 DEBUG : future/test: Can't copy - required hash not found 2025/05/19 01:26:39 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/05/19 01:26:39 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2025/05/19 01:26:40 DEBUG : Chunked 'TestChunkerChunk50bBox:rclone-test-cefudal4kehu': File to upload is small (3 bytes), uploading instead of streaming === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2025/05/19 01:27:27 INFO : backcomp/renamefile.rclone_chunk.001_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2025/05/19 01:27:27 INFO : backcomp/renamefile.rclone_chunk.002_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2025/05/19 01:27:28 INFO : backcomp/renamefile.rclone_chunk.003_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2025/05/19 01:27:28 INFO : backcomp/renamefile.rclone_chunk.004_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2025/05/19 01:27:29 INFO : backcomp/renamefile.rclone_chunk.005_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2025/05/19 01:27:29 INFO : backcomp/renamefile.rclone_chunk.006_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2025/05/19 01:27:30 INFO : backcomp/renamefile.rclone_chunk.007_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2025/05/19 01:27:30 INFO : backcomp/renamefile.rclone_chunk.008_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2025/05/19 01:27:31 INFO : backcomp/renamefile.rclone_chunk.009_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2025/05/19 01:27:32 INFO : backcomp/renamefile.rclone_chunk.010_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2025/05/19 01:27:32 INFO : backcomp/renamefile.rclone_chunk.011_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2025/05/19 01:27:33 INFO : backcomp/renamefile.rclone_chunk.012_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2025/05/19 01:27:33 INFO : backcomp/renamefile.rclone_chunk.013_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2025/05/19 01:27:34 INFO : backcomp/renamefile.rclone_chunk.014_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2025/05/19 01:27:34 INFO : backcomp/renamefile.rclone_chunk.015_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2025/05/19 01:27:35 INFO : backcomp/renamefile.rclone_chunk.016_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2025/05/19 01:27:35 INFO : backcomp/renamefile.rclone_chunk.017_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2025/05/19 01:27:36 INFO : backcomp/renamefile.rclone_chunk.018_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2025/05/19 01:27:37 INFO : backcomp/renamefile.rclone_chunk.019_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2025/05/19 01:27:37 INFO : backcomp/renamefile.rclone_chunk.020_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2025/05/19 01:27:38 INFO : backcomp/renamefile.rclone_chunk.021_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2025/05/19 01:27:38 INFO : backcomp/renamefile.rclone_chunk.022_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2025/05/19 01:27:39 INFO : backcomp/renamefile.rclone_chunk.023_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2025/05/19 01:27:39 INFO : backcomp/renamefile.rclone_chunk.024_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2025/05/19 01:27:40 INFO : backcomp/renamefile.rclone_chunk.025_hoatju: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2025/05/19 01:28:17 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu/servermovetest/subdir1" 2025/05/19 01:28:17 DEBUG : Config file has changed externally - reloading 2025/05/19 01:28:17 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/servermovetest/subdir1" 2025/05/19 01:28:20 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu/servermovetest/subdir2" 2025/05/19 01:28:20 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/servermovetest/subdir2" 2025/05/19 01:28:32 INFO : movefile.rclone_chunk.001_hodj09: Moved (server-side) to: movefile.rclone_chunk.001 2025/05/19 01:28:32 INFO : movefile.rclone_chunk.002_hodj09: Moved (server-side) to: movefile.rclone_chunk.002 2025/05/19 01:28:37 DEBUG : movefile: move 2 data chunks... 2025/05/19 01:28:39 INFO : movefile.rclone_chunk.001: Moved (server-side) 2025/05/19 01:28:40 INFO : movefile.rclone_chunk.002: Moved (server-side) 2025/05/19 01:28:41 INFO : movefile: Moved (server-side) 2025/05/19 01:28:42 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2025/05/19 01:28:48 DEBUG : Creating backend with remote "TestChunkerChunk50bBox,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-cefudal4kehu/md5all" 2025/05/19 01:28:48 DEBUG : TestChunkerChunk50bBox: detected overridden config - adding "{r7Izf}" suffix to name 2025/05/19 01:28:48 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/md5all" chunker_internal_test.go:878: this test needs a base fs with slow hash, e.g. local === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *chunker.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2485: *chunker.Fs does not implement SetCopyCutoff === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/05/19 01:28:56 INFO : unknown-size-put.txt.rclone_chunk.001_hoeano: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2025/05/19 01:28:57 INFO : unknown-size-put.txt.rclone_chunk.002_hoeano: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2025/05/19 01:28:57 INFO : unknown-size-put.txt.rclone_chunk.003_hoeano: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/05/19 01:29:10 INFO : unknown-size-update.txt.rclone_chunk.001_hoepfd: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/05/19 01:29:10 INFO : unknown-size-update.txt.rclone_chunk.002_hoepfd: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/05/19 01:29:38 INFO : unknown-size-update.txt.rclone_chunk.001_hoezp9: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2025/05/19 01:29:39 INFO : unknown-size-update.txt.rclone_chunk.002_hoezp9: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2025/05/19 01:29:39 INFO : unknown-size-update.txt.rclone_chunk.003_hoezp9: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2025/05/19 01:29:39 DEBUG : Config file has changed externally - reloading 2025/05/19 01:29:39 DEBUG : TestBox: Loaded invalid token from config file - ignoring 2025/05/19 01:29:40 DEBUG : Saving config "token" in section "TestBox" of the config file 2025/05/19 01:29:40 DEBUG : TestBox: Saved new token in config file 2025/05/19 01:29:41 INFO : unknown-size-update.txt.rclone_chunk.004_hoezp9: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2025/05/19 01:29:41 INFO : unknown-size-update.txt.rclone_chunk.005_hoezp9: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 2025/05/19 01:29:49 DEBUG : box root 'rclone-test-cefudal4kehu/servermovetest/subdir1': Token expired but no uploads in progress - doing nothing 2025/05/19 01:29:49 DEBUG : box root 'rclone-test-cefudal4kehu/not found.txt': Token expired but no uploads in progress - doing nothing 2025/05/19 01:29:49 DEBUG : box root 'rclone-test-cefudal4kehu/servermovetest/subdir2': Token expired but no uploads in progress - doing nothing 2025/05/19 01:29:49 DEBUG : box root 'rclone-test-cefudal4kehu/md5all': Token expired but no uploads in progress - doing nothing 2025/05/19 01:29:49 DEBUG : box root 'rclone-test-fefozoh7fogi': Token expired but no uploads in progress - doing nothing 2025/05/19 01:29:49 DEBUG : box root '': Token expired but no uploads in progress - doing nothing 2025/05/19 01:29:49 DEBUG : box root 'rclone-test-cefudal4kehu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt': Token expired but no uploads in progress - doing nothing 2025/05/19 01:29:49 DEBUG : box root 'rclone-test-cefudal4kehu/dirToPurgeFromRoot': Token expired but no uploads in progress - doing nothing === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/05/19 01:29:50 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cefudal4kehu/deeper/nonexisting/directory" 2025/05/19 01:29:50 DEBUG : Creating backend with remote "TestBox:rclone-test-cefudal4kehu/deeper/nonexisting/directory" === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory === RUN TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata fstests.go:2742: Directories don't support ReadDirMetadata === RUN TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata fstests.go:2754: Directories don't support WriteDirMetadata === RUN TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime fstests.go:2768: Directories don't support WriteDirSetModTime === RUN TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap 2025/05/19 01:29:59 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/19 01:29:59 ERROR : : error listing: directory not found 2025/05/19 01:29:59 DEBUG : box root 'rclone-test-cefudal4kehu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (1153.89s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (1.02s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.44s) --- FAIL: TestIntegration/FsMkdir (1147.50s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (9.15s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.37s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.37s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.37s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (292.53s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (15.83s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (15.36s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (14.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (15.50s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (15.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (14.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (15.54s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (14.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (15.47s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (15.21s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (14.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (15.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (15.30s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (14.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (15.88s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (15.95s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (15.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (14.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (16.54s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.71s) --- PASS: TestIntegration/FsMkdir/FsPutError (60.24s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (6.62s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (71.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (634.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (2.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.53s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.81s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.77s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (3.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (2.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (15.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (16.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (19.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (13.93s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (34.77s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (21.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (1.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (1.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.98s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (1.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (1.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (3.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (2.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (5.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (2.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (20.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (1.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (7.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (18.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.39s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (15.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.83s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (1.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (9.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (21.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (15.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (358.13s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (17.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (128.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (20.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (45.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (20.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (92.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (30.50s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (2.30s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (59.69s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (14.46s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (45.23s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (3.77s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsDirectory (2.30s) --- 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 1153.947s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024" - Finished ERROR in 19m17.319266215s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]