"go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) === RUN TestUrlEncode --- PASS: TestUrlEncode (0.00s) === RUN TestTimeString --- PASS: TestTimeString (0.00s) === RUN TestParseTimeString b2_internal_test.go:166: potato: want error strconv.ParseInt: parsing "potato": invalid syntax got error --- PASS: TestParseTimeString (0.00s) === RUN TestIntegration fstests.go:418: Using remote "TestB2:" 2021/12/13 05:44:47 DEBUG : Creating backend with remote "TestB2:rclone-test-qakiwiz2yovokuh0tobuced0" 2021/12/13 05:44:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap fstests.go:459: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:487: No commands in this remote === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2021/12/13 05:44:51 DEBUG : dir/subdir: Making directory fstest.go:251: Filtering empty directory "dir" fstest.go:251: Filtering empty directory "dir/subdir" 2021/12/13 05:44:51 INFO : dir/subdir: Removing directory fstest.go:251: Filtering empty directory "dir" 2021/12/13 05:44:51 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty === RUN TestIntegration/FsMkdir/FsListDirNotFound === RUN TestIntegration/FsMkdir/FsListRDirNotFound === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:674: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:674: testing "．" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:674: testing "．．" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:674: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:674: testing " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:674: testing "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:674: testing "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:674: testing "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:674: testing "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:674: testing "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:674: testing ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:674: testing "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:674: testing "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:674: testing "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:674: testing "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:674: testing "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:674: testing "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:674: testing "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:674: testing "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound 2021/12/13 05:45:47 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:45:47 DEBUG : Couldn't decode error response: EOF === RUN TestIntegration/FsMkdir/FsPutError 2021/12/13 05:45:47 DEBUG : Couldn't decode error response: EOF === RUN TestIntegration/FsMkdir/FsPutZeroLength === 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 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2021/12/13 05:45:58 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2021/12/13 05:45:59 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 === 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 2021/12/13 05:46:02 DEBUG : Couldn't decode error response: EOF === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2021/12/13 05:46:04 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6b33_d20211213_m054602_c001_v0001039_t0033") === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === 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 === 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 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2021/12/13 05:46:14 DEBUG : Creating backend with remote "TestB2:rclone-test-qakiwiz2yovokuh0tobuced0/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2021/12/13 05:46:16 DEBUG : Creating backend with remote "TestB2:rclone-test-qakiwiz2yovokuh0tobuced0/not found.txt" 2021/12/13 05:46:16 DEBUG : Couldn't decode error response: EOF === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1503: Opening root remote "TestB2:" path "rclone-test-qakiwiz2yovokuh0tobuced0" from "TestB2:rclone-test-qakiwiz2yovokuh0tobuced0" 2021/12/13 05:46:17 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink 2021/12/13 05:46:23 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:46:25 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:46:25 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:46:26 DEBUG : Creating backend with remote "TestB2:rclone-test-bafuhey1remoqak0xanibar7" 2021/12/13 05:46:29 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:46:29 DEBUG : B2 bucket rclone-test-bafuhey1remoqak0xanibar7: Purge remote 2021/12/13 05:46:29 DEBUG : somefile: Deleting (id "4_z4fd2fd83503dbb2b7fd80e1b_f114ca876ba542dac_d20211213_m054628_c001_v0001161_t0000") === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:392: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:1699: Not a wrapping Fs === 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 2021/12/13 05:46:33 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2021/12/13 05:46:35 DEBUG : piped data.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/Internal fstests.go:1790: *b2.Fs does not implement InternalTester === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 2021/12/13 05:46:37 DEBUG : chunked-5Mi-5.000Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec23e_d20211213_m054637_c001_v0001097_t0017") 2021/12/13 05:46:37 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 5242880 2021/12/13 05:46:37 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 2 length 1 2021/12/13 05:46:38 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 2 2021/12/13 05:46:40 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2021/12/13 05:46:40 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2021/12/13 05:46:43 DEBUG : chunked-5Mi-10Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec240_d20211213_m054643_c001_v0001146_t0054") 2021/12/13 05:46:43 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2021/12/13 05:46:43 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 2 length 5242880 2021/12/13 05:46:45 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 2 2021/12/13 05:46:46 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2021/12/13 05:46:46 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2021/12/13 05:46:49 DEBUG : chunked-5Mi-10.000Mi.bin: Starting upload of large file in 3 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec243_d20211213_m054648_c001_v0001097_t0054") 2021/12/13 05:46:49 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2021/12/13 05:46:49 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 5242880 2021/12/13 05:46:49 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 3 length 1 2021/12/13 05:46:50 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 3 2021/12/13 05:46:51 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2021/12/13 05:46:52 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2021/12/13 05:46:52 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 2021/12/13 05:46:56 DEBUG : chunked-5.054Mi-5.054Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec246_d20211213_m054656_c001_v0001015_t0033") 2021/12/13 05:46:56 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 2 length 1 2021/12/13 05:46:56 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 5300000 2021/12/13 05:46:57 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 2 2021/12/13 05:47:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2021/12/13 05:47:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2021/12/13 05:47:04 DEBUG : chunked-5.054Mi-10.109Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec247_d20211213_m054704_c001_v0001117_t0029") 2021/12/13 05:47:04 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2021/12/13 05:47:04 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 5300000 2021/12/13 05:47:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2021/12/13 05:47:09 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2021/12/13 05:47:09 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2021/12/13 05:47:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Starting upload of large file in 3 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec249_d20211213_m054716_c001_v0001144_t0002") 2021/12/13 05:47:17 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2021/12/13 05:47:17 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 3 length 1 2021/12/13 05:47:17 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 5300000 2021/12/13 05:47:18 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 3 2021/12/13 05:47:19 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2021/12/13 05:47:20 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2021/12/13 05:47:20 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 2021/12/13 05:47:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec24c_d20211213_m054724_c001_v0001146_t0042") 2021/12/13 05:47:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 5300053 2021/12/13 05:47:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 2 length 1 2021/12/13 05:47:26 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 2 2021/12/13 05:47:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2021/12/13 05:47:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2021/12/13 05:47:29 DEBUG : chunked-5.055Mi-10.109Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec24e_d20211213_m054729_c001_v0001043_t0020") 2021/12/13 05:47:29 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2021/12/13 05:47:30 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 5300053 2021/12/13 05:47:36 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2021/12/13 05:47:57 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2021/12/13 05:47:57 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2021/12/13 05:48:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Starting upload of large file in 3 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c084a_d20211213_m054806_c001_v0001134_t0024") 2021/12/13 05:48:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2021/12/13 05:48:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 3 length 1 2021/12/13 05:48:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 5300053 2021/12/13 05:48:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 3 2021/12/13 05:48:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2021/12/13 05:48:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2021/12/13 05:48:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 2021/12/13 05:48:13 DEBUG : chunked-6.667Mi-6.667Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c084b_d20211213_m054813_c001_v0001097_t0049") 2021/12/13 05:48:13 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 2 length 1 2021/12/13 05:48:13 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 6990506 2021/12/13 05:48:15 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 2 2021/12/13 05:48:18 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2021/12/13 05:48:18 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2021/12/13 05:48:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c084f_d20211213_m054825_c001_v0001097_t0031") 2021/12/13 05:48:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2021/12/13 05:48:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 6990506 2021/12/13 05:48:29 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2021/12/13 05:48:29 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2021/12/13 05:48:29 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2021/12/13 05:48:34 DEBUG : chunked-6.667Mi-13.333Mi.bin: Starting upload of large file in 3 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c0851_d20211213_m054834_c001_v0001117_t0027") 2021/12/13 05:48:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2021/12/13 05:48:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 3 length 1 2021/12/13 05:48:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 6990506 2021/12/13 05:48:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 3 2021/12/13 05:48:38 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2021/12/13 05:48:40 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2021/12/13 05:48:40 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts 2021/12/13 05:48:40 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_finish_large_file": EOF) 2021/12/13 05:48:40 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/12/13 05:48:42 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 2021/12/13 05:48:46 DEBUG : chunked-8Mi-8.000Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec258_d20211213_m054846_c001_v0001097_t0042") 2021/12/13 05:48:47 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 2 length 1 2021/12/13 05:48:47 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 8388608 2021/12/13 05:48:48 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 2 2021/12/13 05:48:50 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2021/12/13 05:48:50 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2021/12/13 05:48:54 DEBUG : chunked-8Mi-16Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec25a_d20211213_m054854_c001_v0001092_t0013") 2021/12/13 05:48:55 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2021/12/13 05:48:55 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 2 length 8388608 2021/12/13 05:48:58 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2021/12/13 05:49:00 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 2 2021/12/13 05:49:00 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts 2021/12/13 05:49:00 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_finish_large_file": EOF) 2021/12/13 05:49:00 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/12/13 05:49:02 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2021/12/13 05:49:07 DEBUG : chunked-8Mi-16.000Mi.bin: Starting upload of large file in 3 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6d8_d20211213_m054907_c001_v0001134_t0026") 2021/12/13 05:49:08 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2021/12/13 05:49:08 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 3 length 1 2021/12/13 05:49:08 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 8388608 2021/12/13 05:49:09 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 3 2021/12/13 05:49:10 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2021/12/13 05:49:11 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2021/12/13 05:49:11 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 2021/12/13 05:49:15 DEBUG : chunked-10Mi-10.000Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6da_d20211213_m054915_c001_v0001097_t0047") 2021/12/13 05:49:16 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 2 length 1 2021/12/13 05:49:16 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 10485760 2021/12/13 05:49:20 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2021/12/13 05:49:20 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 2 2021/12/13 05:49:20 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2021/12/13 05:49:25 DEBUG : chunked-10Mi-20Mi.bin: Starting upload of large file in 2 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6dc_d20211213_m054925_c001_v0001091_t0045") 2021/12/13 05:49:25 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2021/12/13 05:49:26 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 2 length 10485760 2021/12/13 05:49:29 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 2 2021/12/13 05:49:31 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2021/12/13 05:49:31 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2021/12/13 05:49:35 DEBUG : chunked-10Mi-20.000Mi.bin: Starting upload of large file in 3 chunks (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6df_d20211213_m054935_c001_v0001043_t0006") 2021/12/13 05:49:36 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2021/12/13 05:49:36 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 3 length 1 2021/12/13 05:49:36 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 10485760 2021/12/13 05:49:37 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 3 2021/12/13 05:49:39 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2021/12/13 05:49:39 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2021/12/13 05:49:39 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2021/12/13 05:49:43 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2021/12/13 05:49:46 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2021/12/13 05:49:47 DEBUG : Creating backend with remote "TestB2:rclone-test-qakiwiz2yovokuh0tobuced0/deeper/nonexisting/directory" 2021/12/13 05:49:48 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:49:48 DEBUG : Couldn't decode error response: EOF 2021/12/13 05:49:48 DEBUG : leading space/ leading space: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1156338eb47cbe1f_d20211213_m054506_c001_v0001037_t0001") 2021/12/13 05:49:48 DEBUG : leading space/ leading space: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6a87_d20211213_m054504_c001_v0001039_t0029") 2021/12/13 05:49:48 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f100dcca35ffb8e14_d20211213_m054503_c001_v0001000_t0014") 2021/12/13 05:49:48 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6a7a_d20211213_m054500_c001_v0001039_t0048") 2021/12/13 05:49:48 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f109796854ed0fdf5_d20211213_m054528_c001_v0001044_t0046") 2021/12/13 05:49:48 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6abf_d20211213_m054525_c001_v0001039_t0032") 2021/12/13 05:49:48 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1038f118e0641d1a_d20211213_m054924_c001_v0001093_t0053") 2021/12/13 05:49:48 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6da_d20211213_m054915_c001_v0001097_t0047") 2021/12/13 05:49:48 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f10171925db04c02a_d20211213_m054943_c001_v0001136_t0044") 2021/12/13 05:49:49 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6df_d20211213_m054935_c001_v0001043_t0006") 2021/12/13 05:49:49 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117744c7ac570a27_d20211213_m054935_c001_v0001117_t0019") 2021/12/13 05:49:49 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6dc_d20211213_m054925_c001_v0001091_t0045") 2021/12/13 05:49:49 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f105e40ffbdef1ca6_d20211213_m054724_c001_v0001040_t0047") 2021/12/13 05:49:49 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec249_d20211213_m054716_c001_v0001144_t0002") 2021/12/13 05:49:49 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117b0e3318813fc2_d20211213_m054713_c001_v0001025_t0017") 2021/12/13 05:49:49 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec247_d20211213_m054704_c001_v0001117_t0029") 2021/12/13 05:49:49 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f118e218fffdb27eb_d20211213_m054703_c001_v0001145_t0048") 2021/12/13 05:49:49 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec246_d20211213_m054656_c001_v0001015_t0033") 2021/12/13 05:49:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f115ce568866d3bdf_d20211213_m054813_c001_v0001165_t0007") 2021/12/13 05:49:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c084a_d20211213_m054806_c001_v0001134_t0024") 2021/12/13 05:49:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f11810dbaf87fca3b_d20211213_m054801_c001_v0001037_t0036") 2021/12/13 05:49:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec24e_d20211213_m054729_c001_v0001043_t0020") 2021/12/13 05:49:49 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f100883a5ab4a1f29_d20211213_m054728_c001_v0001036_t0013") 2021/12/13 05:49:49 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec24c_d20211213_m054724_c001_v0001146_t0042") 2021/12/13 05:49:50 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f108f9cfe129868e2_d20211213_m054655_c001_v0001043_t0024") 2021/12/13 05:49:50 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec243_d20211213_m054648_c001_v0001097_t0054") 2021/12/13 05:49:50 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1186876f4ba6cc3f_d20211213_m054648_c001_v0001043_t0005") 2021/12/13 05:49:50 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec240_d20211213_m054643_c001_v0001146_t0054") 2021/12/13 05:49:50 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f108f37d48392316d_d20211213_m054642_c001_v0001001_t0033") 2021/12/13 05:49:50 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec23e_d20211213_m054637_c001_v0001097_t0017") 2021/12/13 05:49:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f116b6bd261298fed_d20211213_m054846_c001_v0001157_t0031") 2021/12/13 05:49:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c0851_d20211213_m054834_c001_v0001117_t0027") 2021/12/13 05:49:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1157c4ab028692ec_d20211213_m054833_c001_v0001097_t0017") 2021/12/13 05:49:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c084f_d20211213_m054825_c001_v0001097_t0031") 2021/12/13 05:49:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1033a36894f67308_d20211213_m054823_c001_v0001032_t0032") 2021/12/13 05:49:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f213c0e782f0c084b_d20211213_m054813_c001_v0001097_t0049") 2021/12/13 05:49:50 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f101e21edc0ef5be7_d20211213_m054915_c001_v0001150_t0040") 2021/12/13 05:49:50 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2013c4b60875c6d8_d20211213_m054907_c001_v0001134_t0026") 2021/12/13 05:49:50 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1124b8da6f204bef_d20211213_m054906_c001_v0001113_t0030") 2021/12/13 05:49:50 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec25a_d20211213_m054854_c001_v0001092_t0013") 2021/12/13 05:49:50 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f112d5d36287ce66f_d20211213_m054854_c001_v0001150_t0039") 2021/12/13 05:49:50 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f2080bf31593ec258_d20211213_m054846_c001_v0001097_t0042") 2021/12/13 05:49:51 DEBUG : created from root.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1154aacf750277f5_d20211213_m054623_c001_v0001136_t0057") 2021/12/13 05:49:51 DEBUG : created from root.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f102a9b817b764fd8_d20211213_m054622_c001_v0001134_t0030") 2021/12/13 05:49:51 DEBUG : file name.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f100e1ff1d82425d5_d20211213_m054631_c001_v0001117_t0025") 2021/12/13 05:49:51 DEBUG : file name.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6b55_d20211213_m054613_c001_v0001039_t0012") 2021/12/13 05:49:51 DEBUG : file name.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1053ebf0fe987f09_d20211213_m054609_c001_v0001043_t0018") 2021/12/13 05:49:51 DEBUG : file name.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6b18_d20211213_m054552_c001_v0001039_t0010") 2021/12/13 05:49:51 DEBUG : file name.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6b0b_d20211213_m054549_c001_v0001039_t0016") 2021/12/13 05:49:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6b0f_d20211213_m054550_c001_v0001039_t0029") 2021/12/13 05:49:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f114ca876ba542d50_d20211213_m054606_c001_v0001161_t0024") 2021/12/13 05:49:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f109723f23e93df9f_d20211213_m054605_c001_v0001000_t0038") 2021/12/13 05:49:51 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f101201c183283d97_d20211213_m054544_c001_v0001097_t0030") 2021/12/13 05:49:51 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6af0_d20211213_m054543_c001_v0001039_t0049") 2021/12/13 05:49:51 DEBUG : piped data.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f101fdb77b84d507d_d20211213_m054636_c001_v0001120_t0028") 2021/12/13 05:49:51 DEBUG : piped data.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6ba7_d20211213_m054635_c001_v0001039_t0005") 2021/12/13 05:49:51 DEBUG : piped data.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f111c94f5b96d0f24_d20211213_m054634_c001_v0001097_t0029") 2021/12/13 05:49:51 DEBUG : piped data.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6b9e_d20211213_m054633_c001_v0001039_t0032") 2021/12/13 05:49:51 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f10659e5d6febfcd9_d20211213_m054546_c001_v0001153_t0006") 2021/12/13 05:49:51 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6afb_d20211213_m054545_c001_v0001039_t0047") 2021/12/13 05:49:51 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1077360dfe977535_d20211213_m054531_c001_v0001137_t0002") 2021/12/13 05:49:51 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6acd_d20211213_m054530_c001_v0001039_t0040") 2021/12/13 05:49:51 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f111eab648912bdb5_d20211213_m054537_c001_v0001144_t0036") 2021/12/13 05:49:52 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6adc_d20211213_m054536_c001_v0001039_t0029") 2021/12/13 05:49:52 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f113240f4efb1f43d_d20211213_m054535_c001_v0001113_t0025") 2021/12/13 05:49:52 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6ad4_d20211213_m054532_c001_v0001039_t0013") 2021/12/13 05:49:52 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f100597a7711bed1b_d20211213_m054541_c001_v0001008_t0035") 2021/12/13 05:49:52 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6ae3_d20211213_m054538_c001_v0001039_t0040") 2021/12/13 05:49:52 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1011cb6657aeccfe_d20211213_m054542_c001_v0001161_t0007") 2021/12/13 05:49:52 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6aee_d20211213_m054541_c001_v0001039_t0034") 2021/12/13 05:49:52 DEBUG : trailing space /trailing space : Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1192d8399ce9b955_d20211213_m054530_c001_v0001144_t0010") 2021/12/13 05:49:52 DEBUG : trailing space /trailing space : Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6ac8_d20211213_m054529_c001_v0001039_t0007") 2021/12/13 05:49:52 DEBUG : unknown-size-put.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f10289b91d57cbfdb_d20211213_m054945_c001_v0001157_t0016") 2021/12/13 05:49:52 DEBUG : unknown-size-put.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6da0_d20211213_m054944_c001_v0001039_t0037") 2021/12/13 05:49:52 DEBUG : unknown-size-update.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117c393f3508a14d_d20211213_m054947_c001_v0001044_t0049") 2021/12/13 05:49:52 DEBUG : unknown-size-update.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6da8_d20211213_m054946_c001_v0001039_t0026") 2021/12/13 05:49:52 DEBUG : unknown-size-update.txt: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6da4_d20211213_m054945_c001_v0001039_t0012") 2021/12/13 05:49:52 DEBUG : zero-length-file: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f101e8fd545fa14a9_d20211213_m054548_c001_v0001023_t0019") 2021/12/13 05:49:52 DEBUG : zero-length-file: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6b08_d20211213_m054547_c001_v0001039_t0024") 2021/12/13 05:49:52 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1102acf37b03f98a_d20211213_m054513_c001_v0001117_t0025") 2021/12/13 05:49:52 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6a99_d20211213_m054512_c001_v0001039_t0022") 2021/12/13 05:49:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1137a33dabab76f5_d20211213_m054455_c001_v0001161_t0003") 2021/12/13 05:49:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6a5e_d20211213_m054453_c001_v0001039_t0043") 2021/12/13 05:49:52 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f11498aa31bacd71b_d20211213_m054523_c001_v0001165_t0001") 2021/12/13 05:49:52 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6ab2_d20211213_m054519_c001_v0001039_t0032") 2021/12/13 05:49:53 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f111a0eebfeec80af_d20211213_m054519_c001_v0001013_t0022") 2021/12/13 05:49:53 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6aac_d20211213_m054518_c001_v0001039_t0004") 2021/12/13 05:49:53 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f114fcc851a2d952b_d20211213_m054524_c001_v0001113_t0036") 2021/12/13 05:49:53 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6abb_d20211213_m054523_c001_v0001039_t0003") 2021/12/13 05:49:53 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1130c4e9e7bad941_d20211213_m054517_c001_v0001093_t0049") 2021/12/13 05:49:53 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6aa1_d20211213_m054514_c001_v0001039_t0006") 2021/12/13 05:49:53 DEBUG : ．/．: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f113e08a8f71e5dcd_d20211213_m054458_c001_v0001136_t0005") 2021/12/13 05:49:53 DEBUG : ．/．: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6a69_d20211213_m054456_c001_v0001039_t0041") 2021/12/13 05:49:53 DEBUG : ．．/．．: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f1053e0eace85c34a_d20211213_m054459_c001_v0001134_t0016") 2021/12/13 05:49:53 DEBUG : ．．/．．: Deleting (id "4_z8fa27df3502dbb2b7fd80e1b_f117289f808ee6a72_d20211213_m054458_c001_v0001039_t0016") === RUN TestIntegration/FsShutdown fstests.go:2003: Shutdown method not supported --- PASS: TestIntegration (306.76s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.68s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.43s) --- PASS: TestIntegration/FsMkdir (303.99s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.50s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.17s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.17s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.17s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.17s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding (54.30s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (3.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (2.79s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.64s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (4.47s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (6.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (2.86s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (3.55s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.69s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (3.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.75s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (3.65s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.60s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.69s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (4.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.87s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (3.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.64s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (2.43s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.26s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.33s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.65s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (48.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.68s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.43s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.20s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (2.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (2.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (6.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (3.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (6.82s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (2.37s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (4.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (2.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (1.60s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (186.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (18.83s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (5.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (5.82s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (7.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (28.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (8.21s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (12.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (8.11s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (48.37s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (4.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (36.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (7.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (33.28s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (12.63s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (8.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (11.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (29.11s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (8.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (13.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (7.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (28.26s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (9.56s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (10.52s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (8.18s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (3.52s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.63s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.90s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.07s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/b2 306.778s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 5m7.619550563s (try 1/5)