"go test -v -timeout 1h0m0s -remote TestChunkerS3: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:418: Using remote "TestChunkerS3:" 2022/03/23 05:00:59 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9" 2022/03/23 05:00:59 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/03/23 05:00:59 DEBUG : Creating backend with remote "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9" 2022/03/23 05:00:59 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:487: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2022/03/23 05:01:00 INFO : S3 bucket rclone-test-ceyupuf5fobayic9paxekeg9: Bucket "rclone-test-ceyupuf5fobayic9paxekeg9" created with ACL "private" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty 2022/03/23 05:01:00 INFO : S3 bucket rclone-test-ceyupuf5fobayic9paxekeg9: Bucket "rclone-test-ceyupuf5fobayic9paxekeg9" deleted === RUN TestIntegration/FsMkdir 2022/03/23 05:01:01 INFO : S3 bucket rclone-test-ceyupuf5fobayic9paxekeg9: Bucket "rclone-test-ceyupuf5fobayic9paxekeg9" created with ACL "private" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2022/03/23 05:01:01 DEBUG : dir/subdir: Making directory fstest.go:251: Filtering empty directory "dir" fstest.go:251: Filtering empty directory "dir/subdir" 2022/03/23 05:01:01 INFO : dir/subdir: Removing directory fstest.go:251: Filtering empty directory "dir" 2022/03/23 05:01:01 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:378: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:378: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:674: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2022/03/23 05:01:02 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_6r8hx0: md5 = 02853a1de3bc7e42af60cc5d8db08a62 OK 2022/03/23 05:01:02 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_6r8hx0: Copied (server-side copy) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡ 2022/03/23 05:01:02 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_6r8hx0: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:674: testing "．" 2022/03/23 05:01:03 DEBUG : ．/．.rclone_chunk.001_6r8htk: md5 = 650fbe789e3dff28a913b3a88162eccc OK 2022/03/23 05:01:03 INFO : ．/．.rclone_chunk.001_6r8htk: Copied (server-side copy) to: ．/． 2022/03/23 05:01:03 INFO : ．/．.rclone_chunk.001_6r8htk: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:674: testing "．．" 2022/03/23 05:01:03 DEBUG : ．．/．．.rclone_chunk.001_6r8i8a: md5 = 0ceb85ac6c49cf4098e529646e66c48f OK 2022/03/23 05:01:03 INFO : ．．/．．.rclone_chunk.001_6r8i8a: Copied (server-side copy) to: ．．/．． 2022/03/23 05:01:03 INFO : ．．/．．.rclone_chunk.001_6r8i8a: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:674: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2022/03/23 05:01:04 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_6r8j61: md5 = 632543c4ca606a266bab9e7ff0bbf36c OK 2022/03/23 05:01:04 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_6r8j61: Copied (server-side copy) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~ 2022/03/23 05:01:04 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_6r8j61: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:674: testing " leading space" 2022/03/23 05:01:05 DEBUG : leading space/ leading space.rclone_chunk.001_6r8k6z: md5 = 02405fbd87bb93b7b7df190019503f61 OK 2022/03/23 05:01:05 INFO : leading space/ leading space.rclone_chunk.001_6r8k6z: Copied (server-side copy) to: leading space/ leading space 2022/03/23 05:01:05 INFO : leading space/ leading space.rclone_chunk.001_6r8k6z: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:674: testing "~leading tilde" 2022/03/23 05:01:06 DEBUG : ~leading tilde/~leading tilde.rclone_chunk.001_6r8kun: md5 = a14cc7c7009f5421b73e13d268e8b99e OK 2022/03/23 05:01:06 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_6r8kun: Copied (server-side copy) to: ~leading tilde/~leading tilde 2022/03/23 05:01:06 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_6r8kun: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:674: testing "␍leading CR" 2022/03/23 05:01:07 DEBUG : ␍leading CR/␍leading CR.rclone_chunk.001_6r8l03: md5 = c4828bbf2b40a8cd7f4c54c1499f075f OK 2022/03/23 05:01:07 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_6r8l03: Copied (server-side copy) to: ␍leading CR/␍leading CR 2022/03/23 05:01:07 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_6r8l03: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:674: testing "␊leading LF" 2022/03/23 05:01:07 DEBUG : ␊leading LF/␊leading LF.rclone_chunk.001_6r8m8k: md5 = 7f828f9fad6849e8aba513af0ecc591b OK 2022/03/23 05:01:07 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_6r8m8k: Copied (server-side copy) to: ␊leading LF/␊leading LF 2022/03/23 05:01:07 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_6r8m8k: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:674: testing "␉leading HT" 2022/03/23 05:01:08 DEBUG : ␉leading HT/␉leading HT.rclone_chunk.001_6r8nj5: md5 = ccb60f20ad23d731e78bae5cb3b38d1c OK 2022/03/23 05:01:08 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_6r8nj5: Copied (server-side copy) to: ␉leading HT/␉leading HT 2022/03/23 05:01:08 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_6r8nj5: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:674: testing "␋leading VT" 2022/03/23 05:01:09 DEBUG : ␋leading VT/␋leading VT.rclone_chunk.001_6r8oxo: md5 = 2e5b5ac1a2da8f49e67175d3e8ffe2fc OK 2022/03/23 05:01:09 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_6r8oxo: Copied (server-side copy) to: ␋leading VT/␋leading VT 2022/03/23 05:01:09 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_6r8oxo: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:674: testing ".leading dot" 2022/03/23 05:01:10 DEBUG : .leading dot/.leading dot.rclone_chunk.001_6r8o1i: md5 = c2a1bb8bfeca03a9dc333c7084a5bf64 OK 2022/03/23 05:01:10 INFO : .leading dot/.leading dot.rclone_chunk.001_6r8o1i: Copied (server-side copy) to: .leading dot/.leading dot 2022/03/23 05:01:10 INFO : .leading dot/.leading dot.rclone_chunk.001_6r8o1i: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:674: testing "trailing space " 2022/03/23 05:01:11 DEBUG : trailing space /trailing space .rclone_chunk.001_6r8ppg: md5 = 47df8f82c0cef682c9f5bc416c8690c3 OK 2022/03/23 05:01:11 INFO : trailing space /trailing space .rclone_chunk.001_6r8ppg: Copied (server-side copy) to: trailing space /trailing space 2022/03/23 05:01:11 INFO : trailing space /trailing space .rclone_chunk.001_6r8ppg: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:674: testing "trailing CR␍" 2022/03/23 05:01:12 DEBUG : trailing CR␍/trailing CR␍.rclone_chunk.001_6r8qtt: md5 = 22f90c66224b12aa903f7f714626d454 OK 2022/03/23 05:01:12 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_6r8qtt: Copied (server-side copy) to: trailing CR␍/trailing CR␍ 2022/03/23 05:01:12 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_6r8qtt: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:674: testing "trailing LF␊" 2022/03/23 05:01:12 DEBUG : trailing LF␊/trailing LF␊.rclone_chunk.001_6r8rf3: md5 = 808f65d333b466a3151813f7305aa093 OK 2022/03/23 05:01:12 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_6r8rf3: Copied (server-side copy) to: trailing LF␊/trailing LF␊ 2022/03/23 05:01:12 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_6r8rf3: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:674: testing "trailing HT␉" 2022/03/23 05:01:13 DEBUG : trailing HT␉/trailing HT␉.rclone_chunk.001_6r8sd5: md5 = 00829a810c8d25f16dfadd15bb5d587c OK 2022/03/23 05:01:13 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_6r8sd5: Copied (server-side copy) to: trailing HT␉/trailing HT␉ 2022/03/23 05:01:13 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_6r8sd5: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:674: testing "trailing VT␋" 2022/03/23 05:01:14 DEBUG : trailing VT␋/trailing VT␋.rclone_chunk.001_6r8tj5: md5 = da8da327bafa6dfc21a6f4506b6c00a6 OK 2022/03/23 05:01:14 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_6r8tj5: Copied (server-side copy) to: trailing VT␋/trailing VT␋ 2022/03/23 05:01:14 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_6r8tj5: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:674: testing "trailing dot." 2022/03/23 05:01:15 DEBUG : trailing dot./trailing dot..rclone_chunk.001_6r8tyj: md5 = 2e89adfa5e9e638b6087734a5eb79a5d OK 2022/03/23 05:01:15 INFO : trailing dot./trailing dot..rclone_chunk.001_6r8tyj: Copied (server-side copy) to: trailing dot./trailing dot. 2022/03/23 05:01:15 INFO : trailing dot./trailing dot..rclone_chunk.001_6r8tyj: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:674: testing "invalid utf-8\xfe" 2022/03/23 05:01:16 DEBUG : invalid utf-8/invalid utf-8.rclone_chunk.001_6r8u4k: md5 = 3eb4544386a6cfd6278162e3a41f3eba OK 2022/03/23 05:01:16 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_6r8u4k: Copied (server-side copy) to: invalid utf-8/invalid utf-8 2022/03/23 05:01:16 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_6r8u4k: Deleted === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:674: testing "test%46.txt" 2022/03/23 05:01:16 DEBUG : test%46.txt/test%46.txt.rclone_chunk.001_6r8vc1: md5 = 9a8eb5057535767e2c89f676cd01040e OK 2022/03/23 05:01:16 INFO : test%46.txt/test%46.txt.rclone_chunk.001_6r8vc1: Copied (server-side copy) to: test%46.txt/test%46.txt 2022/03/23 05:01:16 INFO : test%46.txt/test%46.txt.rclone_chunk.001_6r8vc1: Deleted === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength 2022/03/23 05:01:18 DEBUG : zero-length-file.rclone_chunk.001_6r8wsl: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2022/03/23 05:01:18 INFO : zero-length-file.rclone_chunk.001_6r8wsl: Copied (server-side copy) to: zero-length-file 2022/03/23 05:01:18 INFO : zero-length-file.rclone_chunk.001_6r8wsl: Deleted === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:747: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:783: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2022/03/23 05:01:18 DEBUG : file name.txt.rclone_chunk.001_6r8x3s: md5 = f8db57142511f788795ff9b7f693889d OK 2022/03/23 05:01:18 INFO : file name.txt.rclone_chunk.001_6r8x3s: Copied (server-side copy) to: file name.txt 2022/03/23 05:01:18 INFO : file name.txt.rclone_chunk.001_6r8x3s: Deleted 2022/03/23 05:01:19 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_6r8x56: md5 = eba77bdbac02c3cfc272e2fdad31479c OK 2022/03/23 05:01:19 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_6r8x56: Copied (server-side copy) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt 2022/03/23 05:01:19 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_6r8x56: Deleted 2022/03/23 05:01:19 DEBUG : file name.txt.rclone_chunk.001_6r8ykd: md5 = 65722c7b38c8ef609e549de409cb1407 OK 2022/03/23 05:01:19 INFO : file name.txt.rclone_chunk.001_6r8ykd: Copied (server-side copy) to: file name.txt 2022/03/23 05:01:20 INFO : file name.txt.rclone_chunk.001_6r8ykd: Deleted === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:378: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2022/03/23 05:01:20 DEBUG : Creating backend with remote "TestChunkerS3:" 2022/03/23 05:01:20 DEBUG : Config file has changed externaly - reloading 2022/03/23 05:01:20 DEBUG : Creating backend with remote "TestS3:" 2022/03/23 05:01:20 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:378: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:378: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:378: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1036: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1068: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2022/03/23 05:01:22 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy non-chunked object... === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1139: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1210: FS has no DirMover interface === 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:1343: MimeType 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 2022/03/23 05:01:25 DEBUG : file name.txt.rclone_chunk.001_6r937u: md5 = e9b19aec51369718bc9f1cad0474a360 OK 2022/03/23 05:01:25 INFO : file name.txt.rclone_chunk.001_6r937u: Copied (server-side copy) to: file name.txt 2022/03/23 05:01:25 INFO : file name.txt.rclone_chunk.001_6r937u: Deleted === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2022/03/23 05:01:25 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2022/03/23 05:01:25 DEBUG : Creating backend with remote "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2022/03/23 05:01:25 DEBUG : fs cache: adding new entry for parent of "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2022/03/23 05:01:25 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2022/03/23 05:01:25 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9/not found.txt" 2022/03/23 05:01:25 DEBUG : Creating backend with remote "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/not found.txt" 2022/03/23 05:01:25 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1492: Can't list from root on this remote === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:1596: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:392: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:1728: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2022/03/23 05:01:26 NOTICE: S3 bucket rclone-test-ceyupuf5fobayic9paxekeg9: Streaming uploads using chunk size 5Mi will have maximum file size of 48.828Gi 2022/03/23 05:01:26 DEBUG : piped data.txt.rclone_chunk.001_6r95h4: multipart upload starting chunk 1 size 0 offset 0/off 2022/03/23 05:01:26 DEBUG : piped data.txt.rclone_chunk.001_6r95h4: Multipart upload Etag: 59adb24ef3cdbe0297f05b395827453f-1 OK 2022/03/23 05:01:26 INFO : piped data.txt.rclone_chunk.001_6r95h4: Copied (server-side copy) to: piped data.txt 2022/03/23 05:01:26 INFO : piped data.txt.rclone_chunk.001_6r95h4: Deleted === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2022/03/23 05:01:27 DEBUG : piped data.txt.rclone_chunk.001_6r96v0: multipart upload starting chunk 1 size 100 offset 0/off 2022/03/23 05:01:27 DEBUG : piped data.txt.rclone_chunk.001_6r96v0: Multipart upload Etag: 7f24a46c0e49d54d1b2cb35850e9b3b1-1 OK 2022/03/23 05:01:27 INFO : piped data.txt.rclone_chunk.001_6r96v0: Copied (server-side copy) to: piped data.txt 2022/03/23 05:01:27 INFO : piped data.txt.rclone_chunk.001_6r96v0: Deleted === 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 2022/03/23 05:01:27 INFO : Chunked 'TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2022/03/23 05:01:28 DEBUG : small/emptyfile.rclone_chunk.001_6r96ou: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2022/03/23 05:01:28 INFO : small/emptyfile.rclone_chunk.001_6r96ou: Copied (server-side copy) to: small/emptyfile 2022/03/23 05:01:28 INFO : small/emptyfile.rclone_chunk.001_6r96ou: Deleted 2022/03/23 05:01:28 DEBUG : small/smallfile.rclone_chunk.001_6r97wn: md5 = a60852f204ed8028c1c58808b746d115 OK 2022/03/23 05:01:28 INFO : small/smallfile.rclone_chunk.001_6r97wn: Copied (server-side copy) to: small/smallfile 2022/03/23 05:01:28 INFO : small/smallfile.rclone_chunk.001_6r97wn: Deleted 2022/03/23 05:01:29 DEBUG : Waiting for deletions to finish 2022/03/23 05:01:29 INFO : small: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption chunker_internal_test.go:467: this test requires small chunks === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow chunker_internal_test.go:584: this test requires small chunks === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2022/03/23 05:01:29 DEBUG : usermeta/today.rclone_chunk.001_6r98hx: md5 = f9af2f31f4e4284fb7081584cbaa97e1 OK 2022/03/23 05:01:29 INFO : usermeta/today.rclone_chunk.001_6r98hx: Copied (server-side copy) to: usermeta/today.rclone_chunk.001 2022/03/23 05:01:29 INFO : usermeta/today.rclone_chunk.001_6r98hx: Deleted 2022/03/23 05:01:30 DEBUG : usermeta/past.rclone_chunk.001_6r998x: md5 = 078b72de2a9230309abb5a7db80a13c4 OK 2022/03/23 05:01:30 INFO : usermeta/past.rclone_chunk.001_6r998x: Copied (server-side copy) to: usermeta/past.rclone_chunk.001 2022/03/23 05:01:30 INFO : usermeta/past.rclone_chunk.001_6r998x: Deleted 2022/03/23 05:01:31 DEBUG : usermeta/future.rclone_chunk.001_6r9abm: md5 = 82e240013837bf80c807dba600b4594d OK 2022/03/23 05:01:31 INFO : usermeta/future.rclone_chunk.001_6r9abm: Copied (server-side copy) to: usermeta/future.rclone_chunk.001 2022/03/23 05:01:32 INFO : usermeta/future.rclone_chunk.001_6r9abm: Deleted 2022/03/23 05:01:32 DEBUG : Waiting for deletions to finish 2022/03/23 05:01:32 INFO : usermeta: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2022/03/23 05:01:33 DEBUG : future/test: Can't copy - required hash not found 2022/03/23 05:01:33 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2022/03/23 05:01:33 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2022/03/23 05:01:33 DEBUG : Chunked 'TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9': File to upload is small (3 bytes), uploading instead of streaming 2022/03/23 05:01:33 ERROR : future/test: Failed to copy: refusing to put: unknown metadata, please upgrade rclone 2022/03/23 05:01:33 DEBUG : Waiting for deletions to finish 2022/03/23 05:01:33 INFO : future/test.rclone_chunk.003: Deleted 2022/03/23 05:01:33 INFO : future/test: Deleted 2022/03/23 05:01:33 INFO : future/test.rclone_chunk.001: Deleted 2022/03/23 05:01:33 INFO : future/test.rclone_chunk.002: Deleted 2022/03/23 05:01:33 INFO : future: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2022/03/23 05:01:36 DEBUG : backcomp/renamefile.rclone_chunk.001_6r9cw8: md5 = 03bebe996bff178b805ab3ce517723c1 OK 2022/03/23 05:01:36 INFO : backcomp/renamefile.rclone_chunk.001_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.001 2022/03/23 05:01:36 INFO : backcomp/renamefile.rclone_chunk.001_6r9cw8: Deleted 2022/03/23 05:01:36 DEBUG : backcomp/renamefile.rclone_chunk.002_6r9cw8: md5 = eeb870b0e803555a2425365f37ff7c2c OK 2022/03/23 05:01:36 INFO : backcomp/renamefile.rclone_chunk.002_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.002 2022/03/23 05:01:36 INFO : backcomp/renamefile.rclone_chunk.002_6r9cw8: Deleted 2022/03/23 05:01:36 DEBUG : backcomp/renamefile.rclone_chunk.003_6r9cw8: md5 = 5d78ef617dfb783d7bcb6d0605f044ef OK 2022/03/23 05:01:36 INFO : backcomp/renamefile.rclone_chunk.003_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.003 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.003_6r9cw8: Deleted 2022/03/23 05:01:37 DEBUG : backcomp/renamefile.rclone_chunk.004_6r9cw8: md5 = 933e40161bae469da7946cade95333c5 OK 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.004_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.004 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.004_6r9cw8: Deleted 2022/03/23 05:01:37 DEBUG : backcomp/renamefile.rclone_chunk.005_6r9cw8: md5 = 87029cd0a9a7dc14e96de56966568109 OK 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.005_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.005 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.005_6r9cw8: Deleted 2022/03/23 05:01:37 DEBUG : backcomp/renamefile.rclone_chunk.006_6r9cw8: md5 = 4d94952b4ddca5104aea7f90a2269406 OK 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.006_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.006 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.006_6r9cw8: Deleted 2022/03/23 05:01:37 DEBUG : backcomp/renamefile.rclone_chunk.007_6r9cw8: md5 = 0be247d54edf1750360bc6035b1ebf17 OK 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.007_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.007 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.007_6r9cw8: Deleted 2022/03/23 05:01:37 DEBUG : backcomp/renamefile.rclone_chunk.008_6r9cw8: md5 = 4c242758cd3463822dae4a2da91f54db OK 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.008_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.008 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.008_6r9cw8: Deleted 2022/03/23 05:01:37 DEBUG : backcomp/renamefile.rclone_chunk.009_6r9cw8: md5 = 0abbca5078b3fe44d7e120a7cec9ac01 OK 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.009_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.009 2022/03/23 05:01:37 INFO : backcomp/renamefile.rclone_chunk.009_6r9cw8: Deleted 2022/03/23 05:01:38 DEBUG : backcomp/renamefile.rclone_chunk.010_6r9cw8: md5 = ebcca6d87f604b68e5c77583e39ec190 OK 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.010_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.010 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.010_6r9cw8: Deleted 2022/03/23 05:01:38 DEBUG : backcomp/renamefile.rclone_chunk.011_6r9cw8: md5 = 2cae1be5c60bab0d13b9b578863bcc29 OK 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.011_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.011 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.011_6r9cw8: Deleted 2022/03/23 05:01:38 DEBUG : backcomp/renamefile.rclone_chunk.012_6r9cw8: md5 = 2265f7af0297a4b9a65c4c9f48fd7d76 OK 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.012_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.012 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.012_6r9cw8: Deleted 2022/03/23 05:01:38 DEBUG : backcomp/renamefile.rclone_chunk.013_6r9cw8: md5 = bc7c4e835fa2a3b1ed92ad489ef557f5 OK 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.013_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.013 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.013_6r9cw8: Deleted 2022/03/23 05:01:38 DEBUG : backcomp/renamefile.rclone_chunk.014_6r9cw8: md5 = 9084661b663799eb35d655eaff4868de OK 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.014_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.014 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.014_6r9cw8: Deleted 2022/03/23 05:01:38 DEBUG : backcomp/renamefile.rclone_chunk.015_6r9cw8: md5 = 3f08956133ee0e6004e4785ed2fd993d OK 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.015_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.015 2022/03/23 05:01:38 INFO : backcomp/renamefile.rclone_chunk.015_6r9cw8: Deleted 2022/03/23 05:01:39 DEBUG : backcomp/renamefile.rclone_chunk.016_6r9cw8: md5 = a417ee78cffde26189da431a67ad132c OK 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.016_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.016 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.016_6r9cw8: Deleted 2022/03/23 05:01:39 DEBUG : backcomp/renamefile.rclone_chunk.017_6r9cw8: md5 = 360201640d77c619dd6d00e200c6ba08 OK 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.017_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.017 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.017_6r9cw8: Deleted 2022/03/23 05:01:39 DEBUG : backcomp/renamefile.rclone_chunk.018_6r9cw8: md5 = acdbe3fea566b416a716949928464ad0 OK 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.018_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.018 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.018_6r9cw8: Deleted 2022/03/23 05:01:39 DEBUG : backcomp/renamefile.rclone_chunk.019_6r9cw8: md5 = 82d132a417ff4069613749885a7be6a6 OK 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.019_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.019 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.019_6r9cw8: Deleted 2022/03/23 05:01:39 DEBUG : backcomp/renamefile.rclone_chunk.020_6r9cw8: md5 = deed566891b6d67b55cd55361d570247 OK 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.020_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.020 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.020_6r9cw8: Deleted 2022/03/23 05:01:39 DEBUG : backcomp/renamefile.rclone_chunk.021_6r9cw8: md5 = b41b33280b8d5f28210671314599f779 OK 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.021_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.021 2022/03/23 05:01:39 INFO : backcomp/renamefile.rclone_chunk.021_6r9cw8: Deleted 2022/03/23 05:01:40 DEBUG : backcomp/renamefile.rclone_chunk.022_6r9cw8: md5 = 2aba13c6190f3d4143022a52694f8f6f OK 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.022_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.022 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.022_6r9cw8: Deleted 2022/03/23 05:01:40 DEBUG : backcomp/renamefile.rclone_chunk.023_6r9cw8: md5 = 1f46d263582e7e06b2e4fb71347f3e18 OK 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.023_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.023 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.023_6r9cw8: Deleted 2022/03/23 05:01:40 DEBUG : backcomp/renamefile.rclone_chunk.024_6r9cw8: md5 = f1a8f0310ad638af6d6a28f0ba45eb2b OK 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.024_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.024 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.024_6r9cw8: Deleted 2022/03/23 05:01:40 DEBUG : backcomp/renamefile.rclone_chunk.025_6r9cw8: md5 = 9eb104b7509179168b4471a9bc37c787 OK 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.025_6r9cw8: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.025 2022/03/23 05:01:40 INFO : backcomp/renamefile.rclone_chunk.025_6r9cw8: Deleted 2022/03/23 05:01:42 DEBUG : Waiting for deletions to finish 2022/03/23 05:01:42 INFO : backcomp: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2022/03/23 05:01:42 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9/servermovetest/subdir1" 2022/03/23 05:01:42 DEBUG : Creating backend with remote "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/servermovetest/subdir1" 2022/03/23 05:01:42 DEBUG : Reset feature "ListR" 2022/03/23 05:01:42 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9/servermovetest/subdir2" 2022/03/23 05:01:42 DEBUG : Creating backend with remote "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/servermovetest/subdir2" 2022/03/23 05:01:42 DEBUG : Reset feature "ListR" 2022/03/23 05:01:43 DEBUG : movefile.rclone_chunk.001_6r9mst: md5 = 900150983cd24fb0d6963f7d28e17f72 OK 2022/03/23 05:01:43 INFO : movefile.rclone_chunk.001_6r9mst: Copied (server-side copy) to: movefile.rclone_chunk.001 2022/03/23 05:01:43 INFO : movefile.rclone_chunk.001_6r9mst: Deleted 2022/03/23 05:01:43 DEBUG : movefile.rclone_chunk.002_6r9mst: md5 = 4ed9407630eb1000c0f6b63842defa7d OK 2022/03/23 05:01:43 INFO : movefile.rclone_chunk.002_6r9mst: Copied (server-side copy) to: movefile.rclone_chunk.002 2022/03/23 05:01:43 INFO : movefile.rclone_chunk.002_6r9mst: Deleted 2022/03/23 05:01:44 DEBUG : movefile: copy 2 data chunks... 2022/03/23 05:01:44 DEBUG : movefile: md5 = e80b5017098950fc58aad83c8c14978e OK 2022/03/23 05:01:44 INFO : movefile: Copied (server-side copy) 2022/03/23 05:01:45 INFO : movefile: Deleted 2022/03/23 05:01:45 DEBUG : Waiting for deletions to finish 2022/03/23 05:01:45 INFO : servermovetest/subdir2/movefile.rclone_chunk.001: Deleted 2022/03/23 05:01:45 INFO : servermovetest/subdir2/movefile: Deleted 2022/03/23 05:01:45 INFO : servermovetest/subdir2/movefile.rclone_chunk.002: Deleted 2022/03/23 05:01:45 INFO : servermovetest: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2022/03/23 05:01:45 DEBUG : Creating backend with remote "TestChunkerS3,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-ceyupuf5fobayic9paxekeg9/md5all" 2022/03/23 05:01:45 DEBUG : TestChunkerS3: detected overridden config - adding "{r7Izf}" suffix to name 2022/03/23 05:01:45 DEBUG : Creating backend with remote "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/md5all" 2022/03/23 05:01:45 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:1807: *chunker.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2022/03/23 05:01:45 DEBUG : unknown-size-put.txt.rclone_chunk.001_6r9ok0: multipart upload starting chunk 1 size 100 offset 0/off 2022/03/23 05:01:45 DEBUG : unknown-size-put.txt.rclone_chunk.001_6r9ok0: Multipart upload Etag: 7c35686d4012ec7fab1461b6188b0e06-1 OK 2022/03/23 05:01:46 INFO : unknown-size-put.txt.rclone_chunk.001_6r9ok0: Copied (server-side copy) to: unknown-size-put.txt 2022/03/23 05:01:46 INFO : unknown-size-put.txt.rclone_chunk.001_6r9ok0: Deleted === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2022/03/23 05:01:46 DEBUG : unknown-size-update.txt.rclone_chunk.001_6r9ptk: md5 = 68610a096f53a980e48c54d47a36be94 OK 2022/03/23 05:01:46 INFO : unknown-size-update.txt.rclone_chunk.001_6r9ptk: Copied (server-side copy) to: unknown-size-update.txt 2022/03/23 05:01:46 INFO : unknown-size-update.txt.rclone_chunk.001_6r9ptk: Deleted 2022/03/23 05:01:46 DEBUG : unknown-size-update.txt.rclone_chunk.001_6r9pj9: multipart upload starting chunk 1 size 200 offset 0/off 2022/03/23 05:01:47 DEBUG : unknown-size-update.txt.rclone_chunk.001_6r9pj9: Multipart upload Etag: 70e845ff547f7f6755ab9cd76930ebe9-1 OK 2022/03/23 05:01:47 INFO : unknown-size-update.txt.rclone_chunk.001_6r9pj9: Copied (server-side copy) to: unknown-size-update.txt 2022/03/23 05:01:47 INFO : unknown-size-update.txt.rclone_chunk.001_6r9pj9: Deleted === RUN TestIntegration/FsMkdir/FsRootCollapse 2022/03/23 05:01:47 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9/deeper/nonexisting/directory" 2022/03/23 05:01:47 DEBUG : Creating backend with remote "TestS3:rclone-test-ceyupuf5fobayic9paxekeg9/deeper/nonexisting/directory" 2022/03/23 05:01:47 DEBUG : Reset feature "ListR" 2022/03/23 05:01:47 DEBUG : Waiting for deletions to finish 2022/03/23 05:01:47 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2022/03/23 05:01:48 INFO : Chunked 'TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9': Removing directory 2022/03/23 05:01:48 INFO : S3 bucket rclone-test-ceyupuf5fobayic9paxekeg9: Bucket "rclone-test-ceyupuf5fobayic9paxekeg9" deleted 2022/03/23 05:01:48 ERROR : : error listing: directory not found 2022/03/23 05:01:48 DEBUG : Waiting for deletions to finish 2022/03/23 05:01:48 ERROR : : error listing: directory not found 2022/03/23 05:01:48 ERROR : Chunked 'TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9': Failed to list "": directory not found 2022/03/23 05:01:48 INFO : Chunked 'TestChunkerS3:rclone-test-ceyupuf5fobayic9paxekeg9': Removing directory 2022/03/23 05:01:48 ERROR : : Failed to rmdir: bucket already deleted === CONT TestIntegration/FsMkdir fstests.go:1989: Warning: this should produce fs.ErrorDirNotFound === RUN TestIntegration/FsShutdown fstests.go:2003: Shutdown method not supported --- PASS: TestIntegration (48.59s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.19s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.25s) --- PASS: TestIntegration/FsMkdir (47.48s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.13s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.04s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.05s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.04s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (15.36s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.74s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.79s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.78s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.76s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.76s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.77s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.85s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.78s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.76s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.82s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.79s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.79s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.79s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.81s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.79s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.78s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.25s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.65s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (27.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.24s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.19s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.10s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.10s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.64s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.19s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.42s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (17.69s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (1.52s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (3.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (1.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (8.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (2.67s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (0.14s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (1.99s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.63s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.35s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.19s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/chunker 48.629s "go test -v -timeout 1h0m0s -remote TestChunkerS3: -verbose" - Finished OK in 55.049247761s (try 1/5)