"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:" 2022/01/12 05:34:19 DEBUG : Creating backend with remote "TestB2:rclone-test-wopeboz2tabajeh0boserab7" 2022/01/12 05:34:19 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 2022/01/12 05:34:23 DEBUG : dir/subdir: Making directory fstest.go:251: Filtering empty directory "dir" fstest.go:251: Filtering empty directory "dir/subdir" 2022/01/12 05:34:23 INFO : dir/subdir: Removing directory fstest.go:251: Filtering empty directory "dir" 2022/01/12 05:34:23 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 2022/01/12 05:35:21 DEBUG : Couldn't decode error response: EOF 2022/01/12 05:35:21 DEBUG : Couldn't decode error response: EOF === RUN TestIntegration/FsMkdir/FsPutError 2022/01/12 05:35:21 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 2022/01/12 05:35:30 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2022/01/12 05:35:31 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 2022/01/12 05:35:34 DEBUG : Couldn't decode error response: EOF === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2022/01/12 05:35:36 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145fc_d20220112_m053535_c001_v0001043_t0050") === 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 2022/01/12 05:35:46 DEBUG : Creating backend with remote "TestB2:rclone-test-wopeboz2tabajeh0boserab7/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2022/01/12 05:35:48 DEBUG : Creating backend with remote "TestB2:rclone-test-wopeboz2tabajeh0boserab7/not found.txt" 2022/01/12 05:35:48 DEBUG : Couldn't decode error response: EOF === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1503: Opening root remote "TestB2:" path "rclone-test-wopeboz2tabajeh0boserab7" from "TestB2:rclone-test-wopeboz2tabajeh0boserab7" 2022/01/12 05:35:49 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 2022/01/12 05:35:56 DEBUG : Couldn't decode error response: EOF 2022/01/12 05:35:58 DEBUG : Couldn't decode error response: EOF 2022/01/12 05:35:59 DEBUG : Couldn't decode error response: EOF 2022/01/12 05:35:59 DEBUG : Creating backend with remote "TestB2:rclone-test-jiguqej5lurocov1teqajip6" 2022/01/12 05:36:03 DEBUG : Couldn't decode error response: EOF 2022/01/12 05:36:04 DEBUG : B2 bucket rclone-test-jiguqej5lurocov1teqajip6: Purge remote 2022/01/12 05:36:04 DEBUG : somefile: Deleting (id "4_z9f423d03c09d4bcb7fe80e1b_f1129b03e7aa829ef_d20220112_m053601_c001_v0001105_t0020") === 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 2022/01/12 05:36:07 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2022/01/12 05:36:10 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 2022/01/12 05:36:11 DEBUG : chunked-5Mi-5.000Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f293_d20220112_m053611_c001_v0001137_t0050") 2022/01/12 05:36:11 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 5242880 2022/01/12 05:36:11 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 2 length 1 2022/01/12 05:36:15 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 2 2022/01/12 05:36:15 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2022/01/12 05:36:15 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2022/01/12 05:36:22 DEBUG : chunked-5Mi-10Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f299_d20220112_m053622_c001_v0001043_t0041") 2022/01/12 05:36:22 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2022/01/12 05:36:22 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 2 length 5242880 2022/01/12 05:36:25 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 2 2022/01/12 05:36:26 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2022/01/12 05:36:26 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2022/01/12 05:36:31 DEBUG : chunked-5Mi-10.000Mi.bin: Starting upload of large file in 3 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f29e_d20220112_m053631_c001_v0001136_t0051") 2022/01/12 05:36:31 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2022/01/12 05:36:31 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 5242880 2022/01/12 05:36:31 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 3 length 1 2022/01/12 05:36:33 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 3 2022/01/12 05:36:33 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2022/01/12 05:36:34 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2022/01/12 05:36:34 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 2022/01/12 05:36:36 DEBUG : chunked-5.054Mi-5.054Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f2a2_d20220112_m053636_c001_v0001136_t0056") 2022/01/12 05:36:36 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 2 length 1 2022/01/12 05:36:36 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 5300000 2022/01/12 05:36:37 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 2 2022/01/12 05:36:39 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2022/01/12 05:36:39 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2022/01/12 05:36:41 DEBUG : chunked-5.054Mi-10.109Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f2a5_d20220112_m053641_c001_v0001157_t0001") 2022/01/12 05:36:41 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2022/01/12 05:36:42 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 5300000 2022/01/12 05:36:44 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2022/01/12 05:36:44 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2022/01/12 05:36:44 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2022/01/12 05:36:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: Starting upload of large file in 3 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f2aa_d20220112_m053647_c001_v0001036_t0000") 2022/01/12 05:36:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2022/01/12 05:36:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 3 length 1 2022/01/12 05:36:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 5300000 2022/01/12 05:36:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 3 2022/01/12 05:37:15 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2022/01/12 05:38:21 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2022/01/12 05:38:21 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 2022/01/12 05:38:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f206099551a993c46_d20220112_m053827_c001_v0001105_t0027") 2022/01/12 05:38:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 2 length 1 2022/01/12 05:38:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 5300053 2022/01/12 05:38:28 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 2 2022/01/12 05:38:31 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2022/01/12 05:38:31 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2022/01/12 05:38:37 DEBUG : chunked-5.055Mi-10.109Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f206099551a993c48_d20220112_m053837_c001_v0001131_t0029") 2022/01/12 05:38:37 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2022/01/12 05:38:37 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 5300053 2022/01/12 05:39:17 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2022/01/12 05:39:59 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2022/01/12 05:39:59 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2022/01/12 05:40:04 DEBUG : chunked-5.055Mi-10.109Mi.bin: Starting upload of large file in 3 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f2058cbde6dffab28_d20220112_m054004_c001_v0001041_t0049") 2022/01/12 05:40:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2022/01/12 05:40:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 5300053 2022/01/12 05:40:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 3 length 1 2022/01/12 05:40:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 3 2022/01/12 05:40:11 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2022/01/12 05:43:13 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2022/01/12 05:43:13 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 2022/01/12 05:43:19 DEBUG : chunked-6.667Mi-6.667Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f322_d20220112_m054319_c001_v0001097_t0021") 2022/01/12 05:43:19 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 6990506 2022/01/12 05:43:19 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 2 length 1 2022/01/12 05:43:22 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2022/01/12 05:43:22 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 2 2022/01/12 05:43:22 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2022/01/12 05:43:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f325_d20220112_m054326_c001_v0001041_t0022") 2022/01/12 05:43:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2022/01/12 05:43:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 6990506 2022/01/12 05:44:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2022/01/12 05:45:52 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2022/01/12 05:45:52 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2022/01/12 05:45:59 DEBUG : chunked-6.667Mi-13.333Mi.bin: Starting upload of large file in 3 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21750d624885bdce_d20220112_m054559_c001_v0001131_t0005") 2022/01/12 05:45:59 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2022/01/12 05:45:59 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 6990506 2022/01/12 05:45:59 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 3 length 1 2022/01/12 05:46:01 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 3 2022/01/12 05:46:02 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2022/01/12 05:46:29 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2022/01/12 05:46:29 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 2022/01/12 05:46:34 DEBUG : chunked-8Mi-8.000Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947e2_d20220112_m054634_c001_v0001120_t0052") 2022/01/12 05:46:34 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 2 length 1 2022/01/12 05:46:34 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 8388608 2022/01/12 05:46:36 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 2 2022/01/12 05:46:41 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2022/01/12 05:46:41 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2022/01/12 05:46:45 DEBUG : chunked-8Mi-16Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947e7_d20220112_m054645_c001_v0001113_t0009") 2022/01/12 05:46:46 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2022/01/12 05:46:46 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 2 length 8388608 2022/01/12 05:46:49 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2022/01/12 05:46:50 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 2 2022/01/12 05:46:50 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2022/01/12 05:46:54 DEBUG : chunked-8Mi-16.000Mi.bin: Starting upload of large file in 3 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947e9_d20220112_m054654_c001_v0001105_t0051") 2022/01/12 05:46:55 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2022/01/12 05:46:55 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 3 length 1 2022/01/12 05:46:55 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 8388608 2022/01/12 05:46:57 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 3 2022/01/12 05:46:59 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2022/01/12 05:47:00 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2022/01/12 05:47:00 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 2022/01/12 05:47:06 DEBUG : chunked-10Mi-10.000Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947ec_d20220112_m054706_c001_v0001150_t0048") 2022/01/12 05:47:07 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 2 length 1 2022/01/12 05:47:07 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 10485760 2022/01/12 05:47:08 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 2 2022/01/12 05:47:10 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2022/01/12 05:47:10 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2022/01/12 05:47:14 DEBUG : chunked-10Mi-20Mi.bin: Starting upload of large file in 2 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947f0_d20220112_m054714_c001_v0001098_t0056") 2022/01/12 05:47:14 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2022/01/12 05:47:15 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 2 length 10485760 2022/01/12 05:47:20 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2022/01/12 05:48:26 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 2 2022/01/12 05:48:26 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2022/01/12 05:48:31 DEBUG : chunked-10Mi-20.000Mi.bin: Starting upload of large file in 3 chunks (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21750d624885bdf6_d20220112_m054831_c001_v0001105_t0041") 2022/01/12 05:48:32 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2022/01/12 05:48:32 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 3 length 1 2022/01/12 05:48:32 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 10485760 2022/01/12 05:48:34 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 3 2022/01/12 05:48:36 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2022/01/12 05:48:37 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2022/01/12 05:48:37 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2022/01/12 05:48:43 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2022/01/12 05:48:48 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2022/01/12 05:48:50 DEBUG : Creating backend with remote "TestB2:rclone-test-wopeboz2tabajeh0boserab7/deeper/nonexisting/directory" 2022/01/12 05:48:51 DEBUG : Couldn't decode error response: EOF 2022/01/12 05:48:51 DEBUG : Couldn't decode error response: EOF 2022/01/12 05:48:51 DEBUG : leading space/ leading space: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f110e725a1bd64bff_d20220112_m053445_c001_v0001113_t0035") 2022/01/12 05:48:51 DEBUG : leading space/ leading space: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1455f_d20220112_m053442_c001_v0001043_t0001") 2022/01/12 05:48:51 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1195ce9b5e71ea15_d20220112_m053439_c001_v0001109_t0016") 2022/01/12 05:48:51 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14555_d20220112_m053437_c001_v0001043_t0017") 2022/01/12 05:48:51 DEBUG : .leading dot/.leading dot: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f107a2c7ae4aa44c5_d20220112_m053458_c001_v0001117_t0041") 2022/01/12 05:48:51 DEBUG : .leading dot/.leading dot: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14591_d20220112_m053457_c001_v0001043_t0051") 2022/01/12 05:48:51 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f10293e72784cb931_d20220112_m054713_c001_v0001109_t0036") 2022/01/12 05:48:51 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947ec_d20220112_m054706_c001_v0001150_t0048") 2022/01/12 05:48:51 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f103109aa0ddd10f4_d20220112_m054842_c001_v0001145_t0031") 2022/01/12 05:48:51 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21750d624885bdf6_d20220112_m054831_c001_v0001105_t0041") 2022/01/12 05:48:52 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f110880b245f45461_d20220112_m054830_c001_v0001134_t0025") 2022/01/12 05:48:52 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947f0_d20220112_m054714_c001_v0001098_t0056") 2022/01/12 05:48:52 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f115ac477b7601ea2_d20220112_m053826_c001_v0001105_t0030") 2022/01/12 05:48:52 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f2aa_d20220112_m053647_c001_v0001036_t0000") 2022/01/12 05:48:52 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f112dd91e813dc27a_d20220112_m053646_c001_v0001109_t0052") 2022/01/12 05:48:53 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f2a5_d20220112_m053641_c001_v0001157_t0001") 2022/01/12 05:48:53 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f11259a2a0a072c23_d20220112_m053641_c001_v0001150_t0040") 2022/01/12 05:48:53 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f2a2_d20220112_m053636_c001_v0001136_t0056") 2022/01/12 05:48:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f115bf35c4bacc1c6_d20220112_m054318_c001_v0001161_t0047") 2022/01/12 05:48:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f2058cbde6dffab28_d20220112_m054004_c001_v0001041_t0049") 2022/01/12 05:48:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1176cd0628275c7d_d20220112_m054003_c001_v0001012_t0036") 2022/01/12 05:48:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f206099551a993c48_d20220112_m053837_c001_v0001131_t0029") 2022/01/12 05:48:53 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f107a2c7ae4aa507e_d20220112_m053836_c001_v0001117_t0015") 2022/01/12 05:48:54 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f206099551a993c46_d20220112_m053827_c001_v0001105_t0027") 2022/01/12 05:48:54 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f113609b5ecb9427e_d20220112_m053636_c001_v0001134_t0034") 2022/01/12 05:48:54 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f29e_d20220112_m053631_c001_v0001136_t0051") 2022/01/12 05:48:54 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f11406b410668662a_d20220112_m053630_c001_v0001097_t0011") 2022/01/12 05:48:54 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f299_d20220112_m053622_c001_v0001043_t0041") 2022/01/12 05:48:54 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f11797d79e132f798_d20220112_m053618_c001_v0001105_t0053") 2022/01/12 05:48:54 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f293_d20220112_m053611_c001_v0001137_t0050") 2022/01/12 05:48:55 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f118a6b0f624b128d_d20220112_m054633_c001_v0001097_t0001") 2022/01/12 05:48:55 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21750d624885bdce_d20220112_m054559_c001_v0001131_t0005") 2022/01/12 05:48:55 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f113f7a07d2b6aec1_d20220112_m054558_c001_v0001136_t0016") 2022/01/12 05:48:55 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f325_d20220112_m054326_c001_v0001041_t0022") 2022/01/12 05:48:55 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f106eb3390800abdb_d20220112_m054325_c001_v0001109_t0035") 2022/01/12 05:48:55 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21529928f534f322_d20220112_m054319_c001_v0001097_t0021") 2022/01/12 05:48:55 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f100ce1ab60766232_d20220112_m054705_c001_v0001105_t0022") 2022/01/12 05:48:56 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947e9_d20220112_m054654_c001_v0001105_t0051") 2022/01/12 05:48:56 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f109f4a2f68582724_d20220112_m054654_c001_v0001165_t0015") 2022/01/12 05:48:56 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947e7_d20220112_m054645_c001_v0001113_t0009") 2022/01/12 05:48:56 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f119ce1a3ea8b7c79_d20220112_m054645_c001_v0001105_t0020") 2022/01/12 05:48:56 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f21942027aae947e2_d20220112_m054634_c001_v0001120_t0052") 2022/01/12 05:48:56 DEBUG : created from root.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f117c2a3cb4fd1b16_d20220112_m053556_c001_v0001157_t0010") 2022/01/12 05:48:56 DEBUG : created from root.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f114388878ed2abd5_d20220112_m053554_c001_v0001136_t0015") 2022/01/12 05:48:56 DEBUG : file name.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f10450ad076f2266b_d20220112_m053605_c001_v0001022_t0006") 2022/01/12 05:48:57 DEBUG : file name.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1460e_d20220112_m053545_c001_v0001043_t0018") 2022/01/12 05:48:57 DEBUG : file name.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1170d046be28816e_d20220112_m053542_c001_v0001161_t0027") 2022/01/12 05:48:57 DEBUG : file name.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145e6_d20220112_m053527_c001_v0001043_t0013") 2022/01/12 05:48:57 DEBUG : file name.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145dd_d20220112_m053525_c001_v0001043_t0022") 2022/01/12 05:48:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145e2_d20220112_m053526_c001_v0001043_t0057") 2022/01/12 05:48:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f101ae074d4a2b5e3_d20220112_m053538_c001_v0001037_t0052") 2022/01/12 05:48:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1054982d151005aa_d20220112_m053537_c001_v0001117_t0016") 2022/01/12 05:48:57 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f107a009d39efa946_d20220112_m053515_c001_v0001105_t0041") 2022/01/12 05:48:57 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145be_d20220112_m053514_c001_v0001043_t0015") 2022/01/12 05:48:57 DEBUG : piped data.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f102bb1c81e3c82f3_d20220112_m053611_c001_v0001165_t0012") 2022/01/12 05:48:58 DEBUG : piped data.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1464e_d20220112_m053610_c001_v0001043_t0005") 2022/01/12 05:48:58 DEBUG : piped data.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1188d7d59199a497_d20220112_m053609_c001_v0001042_t0032") 2022/01/12 05:48:58 DEBUG : piped data.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1463d_d20220112_m053608_c001_v0001043_t0007") 2022/01/12 05:48:58 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f118065f94f54a032_d20220112_m053519_c001_v0001093_t0007") 2022/01/12 05:48:58 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145c4_d20220112_m053515_c001_v0001043_t0055") 2022/01/12 05:48:58 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f119ce1a3ea8b150a_d20220112_m053504_c001_v0001105_t0004") 2022/01/12 05:48:58 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145a5_d20220112_m053503_c001_v0001043_t0008") 2022/01/12 05:48:58 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f10404e880779ba3e_d20220112_m053508_c001_v0001097_t0046") 2022/01/12 05:48:58 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145ae_d20220112_m053507_c001_v0001043_t0038") 2022/01/12 05:48:59 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1033948d010a172e_d20220112_m053505_c001_v0001109_t0031") 2022/01/12 05:48:59 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145a8_d20220112_m053504_c001_v0001043_t0007") 2022/01/12 05:48:59 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f10479b04486828bf_d20220112_m053512_c001_v0001098_t0056") 2022/01/12 05:48:59 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145b9_d20220112_m053511_c001_v0001043_t0028") 2022/01/12 05:48:59 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f119e7d60c075b803_d20220112_m053513_c001_v0001038_t0049") 2022/01/12 05:48:59 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145bb_d20220112_m053512_c001_v0001043_t0024") 2022/01/12 05:48:59 DEBUG : trailing space /trailing space : Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f11984a642932f1b3_d20220112_m053502_c001_v0001165_t0050") 2022/01/12 05:48:59 DEBUG : trailing space /trailing space : Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1459a_d20220112_m053500_c001_v0001043_t0011") 2022/01/12 05:48:59 DEBUG : unknown-size-put.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f10567ad7584b1490_d20220112_m054846_c001_v0001105_t0026") 2022/01/12 05:48:59 DEBUG : unknown-size-put.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14b09_d20220112_m054845_c001_v0001043_t0054") 2022/01/12 05:48:59 DEBUG : unknown-size-update.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f116809182eb21904_d20220112_m054849_c001_v0001043_t0044") 2022/01/12 05:48:59 DEBUG : unknown-size-update.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14b13_d20220112_m054848_c001_v0001043_t0005") 2022/01/12 05:48:59 DEBUG : unknown-size-update.txt: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14b11_d20220112_m054846_c001_v0001043_t0005") 2022/01/12 05:49:00 DEBUG : zero-length-file: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f119947a12e99c594_d20220112_m053522_c001_v0001117_t0016") 2022/01/12 05:49:00 DEBUG : zero-length-file: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d145d1_d20220112_m053521_c001_v0001043_t0006") 2022/01/12 05:49:00 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f118065f94f549fd6_d20220112_m053447_c001_v0001093_t0022") 2022/01/12 05:49:00 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1456c_d20220112_m053446_c001_v0001043_t0057") 2022/01/12 05:49:00 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f101d5933e74ae8d9_d20220112_m053427_c001_v0001134_t0010") 2022/01/12 05:49:00 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14533_d20220112_m053425_c001_v0001043_t0036") 2022/01/12 05:49:00 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f117aca2479c5fc39_d20220112_m053455_c001_v0001145_t0032") 2022/01/12 05:49:00 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14586_d20220112_m053454_c001_v0001043_t0048") 2022/01/12 05:49:00 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1092b20e8ae0ad3e_d20220112_m053453_c001_v0001021_t0007") 2022/01/12 05:49:00 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1457d_d20220112_m053451_c001_v0001043_t0053") 2022/01/12 05:49:00 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1137b0cfad066d3a_d20220112_m053457_c001_v0001109_t0042") 2022/01/12 05:49:00 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d1458c_d20220112_m053456_c001_v0001043_t0024") 2022/01/12 05:49:00 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1050b710db5ed7fd_d20220112_m053450_c001_v0001097_t0055") 2022/01/12 05:49:00 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14574_d20220112_m053449_c001_v0001043_t0007") 2022/01/12 05:49:00 DEBUG : ./.: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f116ce72b8d1e7f48_d20220112_m053429_c001_v0001044_t0024") 2022/01/12 05:49:01 DEBUG : ./.: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14537_d20220112_m053427_c001_v0001043_t0043") 2022/01/12 05:49:01 DEBUG : ../..: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1119e88a747c0c0d_d20220112_m053435_c001_v0001117_t0005") 2022/01/12 05:49:01 DEBUG : ../..: Deleting (id "4_z6fa2bd23c07d4bcb7fe80e1b_f1128c6cec3d14543_d20220112_m053431_c001_v0001043_t0043") === RUN TestIntegration/FsShutdown fstests.go:2003: Shutdown method not supported --- PASS: TestIntegration (884.43s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.72s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.59s) --- PASS: TestIntegration/FsMkdir (880.74s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.55s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding (56.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (2.85s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (4.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (5.87s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (2.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (6.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (2.87s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (2.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (2.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (2.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (2.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (2.21s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (2.67s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (3.84s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.29s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.54s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (5.07s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (3.64s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (46.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.43s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.68s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.19s) --- 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.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (7.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (3.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (8.31s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (2.91s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (3.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (2.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.93s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (752.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (24.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (10.83s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.79s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (5.19s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (110.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (5.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (5.26s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (100.21s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (291.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (10.10s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (87.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (194.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (195.43s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (7.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (152.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (35.28s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (32.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (11.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (9.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (11.93s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (97.08s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (7.47s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (77.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (12.47s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (6.52s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (3.23s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (3.28s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.15s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/b2 884.457s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 14m45.272190481s (try 1/5)