"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:183: potato: want error strconv.ParseInt: parsing "potato": invalid syntax got error --- PASS: TestParseTimeString (0.00s) === RUN TestIntegration fstests.go:438: Using remote "TestB2:" 2025/03/19 02:02:29 DEBUG : Creating backend with remote "TestB2:rclone-test-heteyon0zono" 2025/03/19 02:02:29 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/03/19 02:02:32 INFO : dir/subdir: Making directory fstest.go:244: Filtering empty directory "dir" fstest.go:244: Filtering empty directory "dir/subdir" 2025/03/19 02:02:32 INFO : dir/subdir: Removing directory fstest.go:244: Filtering empty directory "dir" 2025/03/19 02:02:32 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:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter 2025/03/19 02:02:54 DEBUG : writer-at-subdir/writer-at-file: Streaming upload with --b2-chunk-size 96Mi allows uploads of up to 937.500Gi and will fail only when that limit is reached. 2025/03/19 02:02:54 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:02:55 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000400fc0), retryAfter:1000000000} 2025/03/19 02:02:55 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:02:55 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:02:55 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:02:55 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:02:56 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:02:57 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000450b70), retryAfter:1000000000} 2025/03/19 02:02:57 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:02:57 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:02:57 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:02:57 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:02:58 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:02:59 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0002f09c0), retryAfter:1000000000} 2025/03/19 02:02:59 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:02:59 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:02:59 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:02:59 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:03:00 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:03:01 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000401a40), retryAfter:1000000000} 2025/03/19 02:03:01 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:03:01 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:03:01 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:03:01 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:03:02 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:03:03 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000401dd0), retryAfter:1000000000} 2025/03/19 02:03:03 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:03:03 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:03:03 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:03:03 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:03:04 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:03:05 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0004514d0), retryAfter:1000000000} 2025/03/19 02:03:05 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:03:05 DEBUG : pacer: low level retry 6/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:03:05 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:03:05 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:03:06 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:03:07 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0002e0480), retryAfter:1000000000} 2025/03/19 02:03:07 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:03:07 DEBUG : pacer: low level retry 7/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:03:07 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:03:07 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:03:08 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:03:09 DEBUG : writer-at-subdir/writer-at-file: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000204b40), retryAfter:1000000000} 2025/03/19 02:03:09 DEBUG : writer-at-subdir/writer-at-file: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/19 02:03:09 DEBUG : pacer: low level retry 8/10 (error no tomes available (503 service_unavailable)) 2025/03/19 02:03:09 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/19 02:03:09 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/19 02:03:10 DEBUG : pacer: Reducing sleep to 500ms 2025/03/19 02:03:13 DEBUG : pacer: Reducing sleep to 250ms 2025/03/19 02:03:13 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/03/19 02:03:13 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/03/19 02:03:13 DEBUG : pacer: Reducing sleep to 125ms 2025/03/19 02:03:13 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/03/19 02:03:13 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/03/19 02:03:14 DEBUG : pacer: Reducing sleep to 62.5ms 2025/03/19 02:03:14 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/03/19 02:03:14 DEBUG : writer-at-subdir/writer-at-file: Finishing large file upload with 0 parts 2025/03/19 02:03:14 DEBUG : pacer: Reducing sleep to 31.25ms 2025/03/19 02:03:15 DEBUG : pacer: Reducing sleep to 15.625ms 2025/03/19 02:03:15 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: 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 2025/03/19 02:03:20 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/03/19 02:03:22 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:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2025/03/19 02:03:27 INFO : B2 bucket rclone-test-heteyon0zono: cleaning bucket "rclone-test-heteyon0zono" of all files 2025/03/19 02:03:27 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabd85_d20250319_m020326_c001_v0001184_t0053_u01742349806688") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/03/19 02:03:28 DEBUG : Creating backend with remote "TestB2:rclone-test-heteyon0zono/dirToPurgeFromRoot" 2025/03/19 02:03:29 INFO : B2 bucket rclone-test-heteyon0zono path dirToPurgeFromRoot: cleaning bucket "rclone-test-heteyon0zono" of all files 2025/03/19 02:03:30 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabdb7_d20250319_m020327_c001_v0001184_t0054_u01742349807803") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/19 02:03:30 DEBUG : Creating backend with remote "TestB2:rclone-test-heteyon0zono/hello? sausage/êé" 2025/03/19 02:03:34 INFO : B2 bucket rclone-test-heteyon0zono path hello? sausage/êé: cleaning bucket "rclone-test-heteyon0zono" of all files 2025/03/19 02:03:34 DEBUG : a/b/c/d/e.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11648badf5925263_d20250319_m020332_c001_v0001105_t0052_u01742349812935") === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1289: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1342: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1459: 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/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/03/19 02:03:43 DEBUG : Creating backend with remote "TestB2:rclone-test-heteyon0zono/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/19 02:03:45 DEBUG : Creating backend with remote "TestB2:rclone-test-heteyon0zono/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-heteyon0zono" from "TestB2:rclone-test-heteyon0zono" 2025/03/19 02:03:47 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 2025/03/19 02:03:58 DEBUG : Creating backend with remote "TestB2:rclone-test-cosibuz0binu" 2025/03/19 02:04:01 DEBUG : B2 bucket rclone-test-cosibuz0binu: Purge remote 2025/03/19 02:04:01 INFO : B2 bucket rclone-test-cosibuz0binu: cleaning bucket "rclone-test-cosibuz0binu" of all files 2025/03/19 02:04:01 DEBUG : somefile: Deleting (id "4_z5fe2add3204dabcb9f580e1b_f406bc34b1eb648af_d20250319_m020400_c001_v0001131_t0014_u01742349840658") === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2131: Can't have // in paths === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/03/19 02:04:03 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/03/19 02:04:03 DEBUG : piped data.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB 2025/03/19 02:04:06 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/03/19 02:04:06 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/03/19 02:04:06 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.877Ki offset 6Mi/6.106Mi 2025/03/19 02:04:06 DEBUG : test-metadata: Sending chunk 1 length 111490 2025/03/19 02:04:08 DEBUG : test-metadata: Done sending chunk 1 2025/03/19 02:04:08 DEBUG : test-metadata: Done sending chunk 0 2025/03/19 02:04:08 DEBUG : test-metadata: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions 2025/03/19 02:04:16 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_hide_file": EOF) 2025/03/19 02:04:16 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/19 02:04:16 DEBUG : pacer: Reducing sleep to 10ms 2025/03/19 02:04:19 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1184-16.backblaze.com/b2api/v1/b2_upload_file/df425d63203dabcb9f580e1b/c001_v0001184_t0015": EOF 2025/03/19 02:04:19 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1184-16.backblaze.com/b2api/v1/b2_upload_file/df425d63203dabcb9f580e1b/c001_v0001184_t0015": EOF) 2025/03/19 02:04:19 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1184-16.backblaze.com/b2api/v1/b2_upload_file/df425d63203dabcb9f580e1b/c001_v0001184_t0015": EOF - low level retry 1/10 2025/03/19 02:04:21 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent === NAME TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions-v2025-03-19-020413-906.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs 2025/03/19 02:04:23 DEBUG : oldPath = "TestB2:rclone-test-heteyon0zono/versions/test-versions-v2025-03-19-020413-906.txt" 2025/03/19 02:04:23 DEBUG : newPath = "TestB2,versions:rclone-test-heteyon0zono/versions/test-versions-v2025-03-19-020413-906.txt" 2025/03/19 02:04:23 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-heteyon0zono/versions/test-versions-v2025-03-19-020413-906.txt" 2025/03/19 02:04:23 DEBUG : Config file has changed externally - reloading 2025/03/19 02:04:23 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/03/19 02:04:24 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-heteyon0zono/versions/test-versions-v2025-03-19-020413-906.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-heteyon0zono/versions" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun 2025/03/19 02:04:26 INFO : B2 bucket rclone-test-heteyon0zono: cleaning bucket "rclone-test-heteyon0zono" of all hidden files 2025/03/19 02:04:26 DEBUG : leading space/ leading space: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1285_d20250319_m020239_c001_v7007000_t0000_u01742349759544") as it is a hide marker 2025/03/19 02:04:26 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : leading space/ leading space: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab576_d20250319_m020238_c001_v0001184_t0046_u01742349758960") 2025/03/19 02:04:26 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1283_d20250319_m020238_c001_v7007000_t0000_u01742349758598") as it is a hide marker 2025/03/19 02:04:26 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab542_d20250319_m020237_c001_v0001184_t0040_u01742349757997") 2025/03/19 02:04:26 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1293_d20250319_m020245_c001_v7007000_t0000_u01742349765214") as it is a hide marker 2025/03/19 02:04:26 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : .leading dot/.leading dot: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab63a_d20250319_m020244_c001_v0001184_t0051_u01742349764653") 2025/03/19 02:04:26 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : created from root.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a509984fe_d20250319_m020354_c001_v7007000_t0000_u01742349834810") as it is a hide marker 2025/03/19 02:04:26 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : created from root.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f102448edda64fa81_d20250319_m020353_c001_v0001184_t0010_u01742349833880") 2025/03/19 02:04:26 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : file name.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197eec_d20250319_m020402_c001_v7007000_t0000_u01742349842808") as it is a hide marker 2025/03/19 02:04:26 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac069_d20250319_m020342_c001_v0001184_t0050_u01742349822883") 2025/03/19 02:04:26 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f106f0ee9d6c31b0d_d20250319_m020339_c001_v0001184_t0056_u01742349819400") 2025/03/19 02:04:26 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabbdf_d20250319_m020318_c001_v0001184_t0042_u01742349798468") 2025/03/19 02:04:26 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabba9_d20250319_m020317_c001_v0001184_t0011_u01742349797706") 2025/03/19 02:04:26 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabbc7_d20250319_m020318_c001_v0001184_t0059_u01742349798086") "upload" dated 2025-03-19 02:03:18.086 +0000 UTC (1m8.398299031s ago) 2025/03/19 02:04:26 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f405e632e5c3863c5_d20250319_m020337_c001_v7007000_t0000_u01742349817179") as it is a hide marker 2025/03/19 02:04:26 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f104f43760327fb41_d20250319_m020336_c001_v0001184_t0022_u01742349816872") 2025/03/19 02:04:26 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f1114e906467b939f_d20250319_m020336_c001_v0001037_t0023_u01742349816051") 2025/03/19 02:04:26 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e129d_d20250319_m020251_c001_v7007000_t0000_u01742349771885") as it is a hide marker 2025/03/19 02:04:26 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab73c_d20250319_m020251_c001_v0001184_t0029_u01742349771304") 2025/03/19 02:04:26 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : piped data.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197eee_d20250319_m020404_c001_v7007000_t0000_u01742349844557") as it is a hide marker 2025/03/19 02:04:26 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : piped data.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac511_d20250319_m020404_c001_v0001184_t0037_u01742349844112") 2025/03/19 02:04:26 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : piped data.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197eed_d20250319_m020403_c001_v7007000_t0000_u01742349843898") 2025/03/19 02:04:26 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : piped data.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41673ae665dac4db_d20250319_m020403_c001_v0001184_t0015_u01742349843529") 2025/03/19 02:04:26 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e129f_d20250319_m020252_c001_v7007000_t0000_u01742349772808") as it is a hide marker 2025/03/19 02:04:26 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab766_d20250319_m020252_c001_v0001184_t0043_u01742349772247") 2025/03/19 02:04:26 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : test-metadata: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f415632f400e0e911_d20250319_m020411_c001_v7007000_t0000_u01742349851365") as it is a hide marker 2025/03/19 02:04:26 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : test-metadata: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2061b707f1197ef1_d20250319_m020406_c001_v0001131_t0012_u01742349846234") 2025/03/19 02:04:26 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : test-metadata: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197ef0_d20250319_m020405_c001_v7007000_t0000_u01742349845474") 2025/03/19 02:04:26 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : test-metadata: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac545_d20250319_m020404_c001_v0001184_t0008_u01742349844737") 2025/03/19 02:04:26 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1296_d20250319_m020247_c001_v7007000_t0000_u01742349767072") as it is a hide marker 2025/03/19 02:04:26 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab683_d20250319_m020246_c001_v0001184_t0009_u01742349766514") 2025/03/19 02:04:26 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1298_d20250319_m020248_c001_v7007000_t0000_u01742349768993") as it is a hide marker 2025/03/19 02:04:26 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab6cd_d20250319_m020248_c001_v0001184_t0054_u01742349768430") 2025/03/19 02:04:26 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1297_d20250319_m020248_c001_v7007000_t0000_u01742349768013") as it is a hide marker 2025/03/19 02:04:26 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab6a3_d20250319_m020247_c001_v0001184_t0025_u01742349767433") 2025/03/19 02:04:26 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1299_d20250319_m020249_c001_v7007000_t0000_u01742349769984") as it is a hide marker 2025/03/19 02:04:26 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab6fd_d20250319_m020249_c001_v0001184_t0054_u01742349769428") 2025/03/19 02:04:26 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e129b_d20250319_m020250_c001_v7007000_t0000_u01742349770941") as it is a hide marker 2025/03/19 02:04:26 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab71e_d20250319_m020250_c001_v0001184_t0018_u01742349770345") 2025/03/19 02:04:26 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing space /trailing space : Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1294_d20250319_m020246_c001_v7007000_t0000_u01742349766153") as it is a hide marker 2025/03/19 02:04:26 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : trailing space /trailing space : Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab657_d20250319_m020245_c001_v0001184_t0055_u01742349765576") 2025/03/19 02:04:26 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11a9d_d20250319_m020421_c001_v0001106_t0034_u01742349861648") "upload" dated 2025-03-19 02:04:21.648 +0000 UTC (4.836647109s ago) 2025/03/19 02:04:26 DEBUG : versions/test-versions.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41822b4612957fe6_d20250319_m020416_c001_v7007000_t0000_u01742349856901") 2025/03/19 02:04:26 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : versions/test-versions.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac7b9_d20250319_m020413_c001_v0001184_t0006_u01742349853906") 2025/03/19 02:04:26 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e12cf_d20250319_m020317_c001_v7007000_t0000_u01742349797154") as it is a hide marker 2025/03/19 02:04:26 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zdf425d63203dabcb9f580e1b_f203c9dea2b7e12a7_d20250319_m020254_c001_v0001134_t0044_u01742349774886") 2025/03/19 02:04:26 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : zero-length-file: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e12a6_d20250319_m020254_c001_v7007000_t0000_u01742349774638") as it is a hide marker 2025/03/19 02:04:26 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : zero-length-file: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41673ae665dab7b6_d20250319_m020254_c001_v0001184_t0015_u01742349774086") 2025/03/19 02:04:26 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1286_d20250319_m020240_c001_v7007000_t0000_u01742349760524") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab5aa_d20250319_m020239_c001_v0001184_t0052_u01742349759908") 2025/03/19 02:04:26 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e127e_d20250319_m020235_c001_v7007000_t0000_u01742349755757") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab4b6_d20250319_m020234_c001_v0001184_t0043_u01742349754830") 2025/03/19 02:04:26 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e128f_d20250319_m020243_c001_v7007000_t0000_u01742349763367") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab61a_d20250319_m020242_c001_v0001184_t0051_u01742349762806") 2025/03/19 02:04:26 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e128b_d20250319_m020242_c001_v7007000_t0000_u01742349762444") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab5fa_d20250319_m020241_c001_v0001184_t0047_u01742349761825") 2025/03/19 02:04:26 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1291_d20250319_m020244_c001_v7007000_t0000_u01742349764292") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab622_d20250319_m020243_c001_v0001184_t0000_u01742349763727") 2025/03/19 02:04:26 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1287_d20250319_m020241_c001_v7007000_t0000_u01742349761456") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab5cd_d20250319_m020240_c001_v0001184_t0024_u01742349760900") 2025/03/19 02:04:26 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ．/．: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1280_d20250319_m020236_c001_v7007000_t0000_u01742349756700") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ．/．: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ．/．: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab4e8_d20250319_m020236_c001_v0001184_t0043_u01742349756119") 2025/03/19 02:04:26 NOTICE: ．/．: Skipped delete as --dry-run is set 2025/03/19 02:04:26 DEBUG : ．．/．．: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1282_d20250319_m020237_c001_v7007000_t0000_u01742349757637") as it is a hide marker 2025/03/19 02:04:26 NOTICE: ．．/．．: Skipped remove hide marker as --dry-run is set 2025/03/19 02:04:26 DEBUG : ．．/．．: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab51a_d20250319_m020237_c001_v0001184_t0051_u01742349757060") 2025/03/19 02:04:26 NOTICE: ．．/．．: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/03/19 02:04:26 INFO : B2 bucket rclone-test-heteyon0zono: cleaning bucket "rclone-test-heteyon0zono" of all hidden files 2025/03/19 02:04:26 DEBUG : leading space/ leading space: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1285_d20250319_m020239_c001_v7007000_t0000_u01742349759544") as it is a hide marker 2025/03/19 02:04:26 DEBUG : leading space/ leading space: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab576_d20250319_m020238_c001_v0001184_t0046_u01742349758960") 2025/03/19 02:04:26 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1283_d20250319_m020238_c001_v7007000_t0000_u01742349758598") as it is a hide marker 2025/03/19 02:04:26 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab542_d20250319_m020237_c001_v0001184_t0040_u01742349757997") 2025/03/19 02:04:26 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1293_d20250319_m020245_c001_v7007000_t0000_u01742349765214") as it is a hide marker 2025/03/19 02:04:26 DEBUG : .leading dot/.leading dot: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab63a_d20250319_m020244_c001_v0001184_t0051_u01742349764653") 2025/03/19 02:04:26 DEBUG : created from root.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a509984fe_d20250319_m020354_c001_v7007000_t0000_u01742349834810") as it is a hide marker 2025/03/19 02:04:26 DEBUG : created from root.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f102448edda64fa81_d20250319_m020353_c001_v0001184_t0010_u01742349833880") 2025/03/19 02:04:26 DEBUG : file name.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197eec_d20250319_m020402_c001_v7007000_t0000_u01742349842808") as it is a hide marker 2025/03/19 02:04:27 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac069_d20250319_m020342_c001_v0001184_t0050_u01742349822883") 2025/03/19 02:04:27 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f106f0ee9d6c31b0d_d20250319_m020339_c001_v0001184_t0056_u01742349819400") 2025/03/19 02:04:27 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabbdf_d20250319_m020318_c001_v0001184_t0042_u01742349798468") 2025/03/19 02:04:27 DEBUG : file name.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabba9_d20250319_m020317_c001_v0001184_t0011_u01742349797706") 2025/03/19 02:04:27 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabbc7_d20250319_m020318_c001_v0001184_t0059_u01742349798086") "upload" dated 2025-03-19 02:03:18.086 +0000 UTC (1m9.403937939s ago) 2025/03/19 02:04:27 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f405e632e5c3863c5_d20250319_m020337_c001_v7007000_t0000_u01742349817179") as it is a hide marker 2025/03/19 02:04:27 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f104f43760327fb41_d20250319_m020336_c001_v0001184_t0022_u01742349816872") 2025/03/19 02:04:27 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f1114e906467b939f_d20250319_m020336_c001_v0001037_t0023_u01742349816051") 2025/03/19 02:04:27 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e129d_d20250319_m020251_c001_v7007000_t0000_u01742349771885") as it is a hide marker 2025/03/19 02:04:27 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab73c_d20250319_m020251_c001_v0001184_t0029_u01742349771304") 2025/03/19 02:04:27 DEBUG : piped data.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197eee_d20250319_m020404_c001_v7007000_t0000_u01742349844557") as it is a hide marker 2025/03/19 02:04:27 DEBUG : piped data.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac511_d20250319_m020404_c001_v0001184_t0037_u01742349844112") 2025/03/19 02:04:27 DEBUG : piped data.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197eed_d20250319_m020403_c001_v7007000_t0000_u01742349843898") 2025/03/19 02:04:27 DEBUG : piped data.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41673ae665dac4db_d20250319_m020403_c001_v0001184_t0015_u01742349843529") 2025/03/19 02:04:27 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e129f_d20250319_m020252_c001_v7007000_t0000_u01742349772808") as it is a hide marker 2025/03/19 02:04:28 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab766_d20250319_m020252_c001_v0001184_t0043_u01742349772247") 2025/03/19 02:04:28 DEBUG : test-metadata: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f415632f400e0e911_d20250319_m020411_c001_v7007000_t0000_u01742349851365") as it is a hide marker 2025/03/19 02:04:28 DEBUG : test-metadata: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2061b707f1197ef1_d20250319_m020406_c001_v0001131_t0012_u01742349846234") 2025/03/19 02:04:28 DEBUG : test-metadata: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1197ef0_d20250319_m020405_c001_v7007000_t0000_u01742349845474") 2025/03/19 02:04:28 DEBUG : test-metadata: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac545_d20250319_m020404_c001_v0001184_t0008_u01742349844737") 2025/03/19 02:04:28 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1296_d20250319_m020247_c001_v7007000_t0000_u01742349767072") as it is a hide marker 2025/03/19 02:04:28 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab683_d20250319_m020246_c001_v0001184_t0009_u01742349766514") 2025/03/19 02:04:28 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1298_d20250319_m020248_c001_v7007000_t0000_u01742349768993") as it is a hide marker 2025/03/19 02:04:28 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab6cd_d20250319_m020248_c001_v0001184_t0054_u01742349768430") 2025/03/19 02:04:28 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1297_d20250319_m020248_c001_v7007000_t0000_u01742349768013") as it is a hide marker 2025/03/19 02:04:28 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab6a3_d20250319_m020247_c001_v0001184_t0025_u01742349767433") 2025/03/19 02:04:28 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1299_d20250319_m020249_c001_v7007000_t0000_u01742349769984") as it is a hide marker 2025/03/19 02:04:28 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab6fd_d20250319_m020249_c001_v0001184_t0054_u01742349769428") 2025/03/19 02:04:28 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e129b_d20250319_m020250_c001_v7007000_t0000_u01742349770941") as it is a hide marker 2025/03/19 02:04:28 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab71e_d20250319_m020250_c001_v0001184_t0018_u01742349770345") 2025/03/19 02:04:28 DEBUG : trailing space /trailing space : Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1294_d20250319_m020246_c001_v7007000_t0000_u01742349766153") as it is a hide marker 2025/03/19 02:04:28 DEBUG : trailing space /trailing space : Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab657_d20250319_m020245_c001_v0001184_t0055_u01742349765576") 2025/03/19 02:04:28 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11a9d_d20250319_m020421_c001_v0001106_t0034_u01742349861648") "upload" dated 2025-03-19 02:04:21.648 +0000 UTC (7.144703587s ago) 2025/03/19 02:04:28 DEBUG : versions/test-versions.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41822b4612957fe6_d20250319_m020416_c001_v7007000_t0000_u01742349856901") 2025/03/19 02:04:28 DEBUG : versions/test-versions.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dac7b9_d20250319_m020413_c001_v0001184_t0006_u01742349853906") 2025/03/19 02:04:28 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e12cf_d20250319_m020317_c001_v7007000_t0000_u01742349797154") as it is a hide marker 2025/03/19 02:04:28 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zdf425d63203dabcb9f580e1b_f203c9dea2b7e12a7_d20250319_m020254_c001_v0001134_t0044_u01742349774886") 2025/03/19 02:04:28 DEBUG : zero-length-file: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e12a6_d20250319_m020254_c001_v7007000_t0000_u01742349774638") as it is a hide marker 2025/03/19 02:04:29 DEBUG : zero-length-file: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41673ae665dab7b6_d20250319_m020254_c001_v0001184_t0015_u01742349774086") 2025/03/19 02:04:29 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1286_d20250319_m020240_c001_v7007000_t0000_u01742349760524") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab5aa_d20250319_m020239_c001_v0001184_t0052_u01742349759908") 2025/03/19 02:04:29 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e127e_d20250319_m020235_c001_v7007000_t0000_u01742349755757") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab4b6_d20250319_m020234_c001_v0001184_t0043_u01742349754830") 2025/03/19 02:04:29 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e128f_d20250319_m020243_c001_v7007000_t0000_u01742349763367") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab61a_d20250319_m020242_c001_v0001184_t0051_u01742349762806") 2025/03/19 02:04:29 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e128b_d20250319_m020242_c001_v7007000_t0000_u01742349762444") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab5fa_d20250319_m020241_c001_v0001184_t0047_u01742349761825") 2025/03/19 02:04:29 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1291_d20250319_m020244_c001_v7007000_t0000_u01742349764292") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab622_d20250319_m020243_c001_v0001184_t0000_u01742349763727") 2025/03/19 02:04:29 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1287_d20250319_m020241_c001_v7007000_t0000_u01742349761456") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab5cd_d20250319_m020240_c001_v0001184_t0024_u01742349760900") 2025/03/19 02:04:29 DEBUG : ．/．: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1280_d20250319_m020236_c001_v7007000_t0000_u01742349756700") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ．/．: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab4e8_d20250319_m020236_c001_v0001184_t0043_u01742349756119") 2025/03/19 02:04:29 DEBUG : ．．/．．: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1282_d20250319_m020237_c001_v7007000_t0000_u01742349757637") as it is a hide marker 2025/03/19 02:04:29 DEBUG : ．．/．．: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dab51a_d20250319_m020237_c001_v0001184_t0051_u01742349757060") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/03/19 02:04:30 DEBUG : unfinished/unfinished-1: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. 2025/03/19 02:04:30 DEBUG : unfinished/unfinished-2: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. 2025/03/19 02:04:30 DEBUG : unfinished/unfinished-3: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. 2025/03/19 02:04:31 DEBUG : unfinished/unfinished-4: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun 2025/03/19 02:04:31 INFO : B2 bucket rclone-test-heteyon0zono: cleaning bucket "rclone-test-heteyon0zono" of pending multipart uploads older than 0s 2025/03/19 02:04:31 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabbc7_d20250319_m020318_c001_v0001184_t0059_u01742349798086") "upload" dated 2025-03-19 02:03:18.086 +0000 UTC (1m13.584282475s ago) 2025/03/19 02:04:31 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabb9_d20250319_m020430_c001_v0001183_t0023_u01742349870624") as it is a start marker (upload started at 2025-03-19 02:04:30.624 +0000 UTC) 2025/03/19 02:04:31 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/03/19 02:04:31 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabba_d20250319_m020430_c001_v0001184_t0038_u01742349870806") as it is a start marker (upload started at 2025-03-19 02:04:30.806 +0000 UTC) 2025/03/19 02:04:31 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/03/19 02:04:31 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabbb_d20250319_m020430_c001_v0001182_t0037_u01742349870990") as it is a start marker (upload started at 2025-03-19 02:04:30.99 +0000 UTC) 2025/03/19 02:04:31 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/03/19 02:04:31 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabbc_d20250319_m020431_c001_v0001183_t0020_u01742349871181") as it is a start marker (upload started at 2025-03-19 02:04:31.181 +0000 UTC) 2025/03/19 02:04:31 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/03/19 02:04:31 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aabb8_d20250319_m020430_c001_v7007000_t0000_u01742349870442") "hide" dated 2025-03-19 02:04:30.442 +0000 UTC (1.228389745s ago) 2025/03/19 02:04:31 DEBUG : versions/test-versions.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11a9d_d20250319_m020421_c001_v0001106_t0034_u01742349861648") 2025/03/19 02:04:31 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/03/19 02:04:31 INFO : B2 bucket rclone-test-heteyon0zono: cleaning bucket "rclone-test-heteyon0zono" of pending multipart uploads older than 0s 2025/03/19 02:04:32 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabbc7_d20250319_m020318_c001_v0001184_t0059_u01742349798086") "upload" dated 2025-03-19 02:03:18.086 +0000 UTC (1m13.948503068s ago) 2025/03/19 02:04:32 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabb9_d20250319_m020430_c001_v0001183_t0023_u01742349870624") as it is a start marker (upload started at 2025-03-19 02:04:30.624 +0000 UTC) 2025/03/19 02:04:32 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabba_d20250319_m020430_c001_v0001184_t0038_u01742349870806") as it is a start marker (upload started at 2025-03-19 02:04:30.806 +0000 UTC) 2025/03/19 02:04:32 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabbb_d20250319_m020430_c001_v0001182_t0037_u01742349870990") as it is a start marker (upload started at 2025-03-19 02:04:30.99 +0000 UTC) 2025/03/19 02:04:32 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabbc_d20250319_m020431_c001_v0001183_t0020_u01742349871181") as it is a start marker (upload started at 2025-03-19 02:04:31.181 +0000 UTC) 2025/03/19 02:04:32 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aabb8_d20250319_m020430_c001_v7007000_t0000_u01742349870442") "hide" dated 2025-03-19 02:04:30.442 +0000 UTC (1.592637368s ago) 2025/03/19 02:04:32 DEBUG : versions/test-versions.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11a9d_d20250319_m020421_c001_v0001106_t0034_u01742349861648") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/03/19 02:04:32 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/03/19 02:04:32 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/03/19 02:04:33 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 2025/03/19 02:04:34 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/03/19 02:04:34 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/03/19 02:04:34 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/03/19 02:04:34 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/03/19 02:04:35 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/03/19 02:04:36 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/03/19 02:04:36 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/03/19 02:04:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:04:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 5Mi allows uploads of up to 48.828Gi and will fail only when that limit is reached. 2025/03/19 02:04:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21822b4612958000_d20250319_m020439_c001_v0001183_t0010_u01742349879455") 2025/03/19 02:04:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:04:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/03/19 02:04:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/03/19 02:04:39 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/03/19 02:04:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/19 02:04:39 DEBUG : pacer: Reducing sleep to 10ms 2025/03/19 02:04:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:04:41 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:04:41 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/03/19 02:04:43 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/03/19 02:04:43 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/03/19 02:04:43 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/03/19 02:04:43 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/03/19 02:04:45 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/03/19 02:04:46 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/03/19 02:04:46 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/03/19 02:04:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:04:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: Streaming upload with --b2-chunk-size 5Mi allows uploads of up to 48.828Gi and will fail only when that limit is reached. 2025/03/19 02:04:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21822b4612958011_d20250319_m020447_c001_v0001153_t0021_u01742349887769") 2025/03/19 02:04:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/03/19 02:04:48 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/19 02:04:48 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/03/19 02:04:50 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:04:50 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:04:50 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/03/19 02:04:52 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/03/19 02:04:52 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/03/19 02:04:52 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/03/19 02:04:52 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/03/19 02:04:52 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/03/19 02:04:52 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/03/19 02:04:53 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/03/19 02:04:54 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/03/19 02:04:54 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/03/19 02:04:54 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/03/19 02:04:55 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:04:55 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 5Mi allows uploads of up to 48.828Gi and will fail only when that limit is reached. 2025/03/19 02:04:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf73fe6_d20250319_m020456_c001_v0001091_t0041_u01742349896088") 2025/03/19 02:04:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/03/19 02:04:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:04:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/03/19 02:04:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/03/19 02:04:57 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/03/19 02:04:58 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:04:58 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:04:58 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 2025/03/19 02:05:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/03/19 02:05:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/03/19 02:05:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/03/19 02:05:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/03/19 02:05:01 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/03/19 02:05:02 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/03/19 02:05:02 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/03/19 02:05:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:05:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/03/19 02:05:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21822b461295801b_d20250319_m020504_c001_v0001150_t0019_u01742349904168") 2025/03/19 02:05:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:05:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/03/19 02:05:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/03/19 02:05:05 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:05:06 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:05:06 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/03/19 02:05:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/03/19 02:05:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/03/19 02:05:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/03/19 02:05:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/03/19 02:05:10 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/03/19 02:05:10 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/03/19 02:05:10 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/03/19 02:05:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:05:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/03/19 02:05:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21822b461295802e_d20250319_m020512_c001_v0001179_t0017_u01742349912210") 2025/03/19 02:05:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/03/19 02:05:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/19 02:05:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/03/19 02:05:14 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:05:14 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:05:14 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/03/19 02:05:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/03/19 02:05:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/03/19 02:05:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/03/19 02:05:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/03/19 02:05:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/03/19 02:05:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/03/19 02:05:18 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/03/19 02:05:19 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/03/19 02:05:19 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/03/19 02:05:19 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/03/19 02:05:21 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:05:21 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/03/19 02:05:21 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f2126bda746bd7367_d20250319_m020521_c001_v0001165_t0057_u01742349921197") 2025/03/19 02:05:21 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/03/19 02:05:21 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:05:21 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/03/19 02:05:21 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/03/19 02:05:22 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/03/19 02:05:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:05:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:05:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 2025/03/19 02:05:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/03/19 02:05:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/03/19 02:05:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/03/19 02:05:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/03/19 02:05:26 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/03/19 02:05:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/03/19 02:05:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/03/19 02:05:29 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:05:29 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/03/19 02:05:29 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf73ffe_d20250319_m020529_c001_v0001182_t0014_u01742349929293") 2025/03/19 02:05:29 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:05:29 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/03/19 02:05:29 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/03/19 02:05:30 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:05:31 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:05:31 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/03/19 02:05:33 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/03/19 02:05:33 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/03/19 02:05:33 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/03/19 02:05:33 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/03/19 02:05:35 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/03/19 02:05:35 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/03/19 02:05:35 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/03/19 02:05:37 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:05:37 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/03/19 02:05:37 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf74006_d20250319_m020537_c001_v0001177_t0040_u01742349937372") 2025/03/19 02:05:37 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/03/19 02:05:37 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/19 02:05:37 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/03/19 02:05:39 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:05:39 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:05:39 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/03/19 02:05:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/03/19 02:05:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/03/19 02:05:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/03/19 02:05:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/03/19 02:05:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/03/19 02:05:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/03/19 02:05:42 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/03/19 02:05:44 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/03/19 02:05:44 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/03/19 02:05:44 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/03/19 02:05:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:05:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/03/19 02:05:46 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21838ca0e18562d3_d20250319_m020545_c001_v0001184_t0045_u01742349945978") 2025/03/19 02:05:46 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/03/19 02:05:46 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:05:46 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/03/19 02:05:46 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/03/19 02:05:47 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/03/19 02:05:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:05:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:05:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 2025/03/19 02:05:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/03/19 02:05:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/03/19 02:05:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/03/19 02:05:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/19 02:05:51 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/03/19 02:05:52 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/03/19 02:05:52 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/03/19 02:05:54 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:05:54 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/03/19 02:05:54 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f2126bda746bd7383_d20250319_m020554_c001_v0001109_t0032_u01742349954389") 2025/03/19 02:05:54 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:05:54 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/03/19 02:05:54 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/03/19 02:05:55 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:05:57 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:05:57 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/03/19 02:05:58 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/03/19 02:05:58 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/03/19 02:05:58 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/03/19 02:05:58 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/03/19 02:06:01 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/03/19 02:06:01 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/03/19 02:06:01 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/03/19 02:06:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:06:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/03/19 02:06:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf74018_d20250319_m020603_c001_v0001043_t0029_u01742349963819") 2025/03/19 02:06:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/03/19 02:06:04 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/19 02:06:04 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/03/19 02:06:06 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:06:06 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:06:06 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/03/19 02:06:08 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/03/19 02:06:08 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/03/19 02:06:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/03/19 02:06:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/03/19 02:06:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/03/19 02:06:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/03/19 02:06:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/03/19 02:06:11 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/03/19 02:06:11 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/03/19 02:06:11 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/03/19 02:06:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:06:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/03/19 02:06:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f201c96a9eb97b541_d20250319_m020614_c001_v0001184_t0020_u01742349974162") 2025/03/19 02:06:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/03/19 02:06:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:06:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/03/19 02:06:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/03/19 02:06:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/03/19 02:06:16 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:06:17 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:06:17 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 2025/03/19 02:06:19 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/03/19 02:06:19 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/03/19 02:06:19 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/03/19 02:06:19 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/03/19 02:06:20 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/03/19 02:06:22 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/03/19 02:06:22 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/03/19 02:06:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:06:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/03/19 02:06:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f201c96a9eb97b546_d20250319_m020623_c001_v0001100_t0051_u01742349983638") 2025/03/19 02:06:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:06:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/03/19 02:06:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/03/19 02:06:24 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:06:26 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:06:26 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/03/19 02:06:28 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/03/19 02:06:28 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/03/19 02:06:28 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/03/19 02:06:28 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/03/19 02:06:30 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/03/19 02:06:30 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/03/19 02:06:30 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/03/19 02:06:32 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:06:32 DEBUG : chunked-8Mi-16Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/03/19 02:06:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac43_d20250319_m020632_c001_v0001134_t0025_u01742349992985") 2025/03/19 02:06:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/03/19 02:06:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/19 02:06:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/03/19 02:06:35 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:06:35 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:06:35 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/03/19 02:06:38 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/03/19 02:06:38 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/03/19 02:06:38 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/03/19 02:06:38 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/03/19 02:06:38 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/03/19 02:06:38 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/03/19 02:06:39 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/03/19 02:06:40 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/03/19 02:06:41 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/03/19 02:06:41 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/03/19 02:06:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:06:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/03/19 02:06:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f205e3d2a50998a2a_d20250319_m020643_c001_v0001037_t0041_u01742350003201") 2025/03/19 02:06:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/03/19 02:06:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:06:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/03/19 02:06:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/03/19 02:06:45 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/03/19 02:06:46 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:06:46 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:06:46 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 2025/03/19 02:06:48 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/03/19 02:06:48 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/03/19 02:06:48 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/03/19 02:06:48 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/03/19 02:06:49 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/03/19 02:06:51 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/03/19 02:06:51 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/03/19 02:06:53 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:06:53 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 10Mi allows uploads of up to 97.656Gi and will fail only when that limit is reached. 2025/03/19 02:06:53 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac55_d20250319_m020653_c001_v0001184_t0043_u01742350013448") 2025/03/19 02:06:53 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:06:53 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/03/19 02:06:53 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/03/19 02:06:54 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:06:56 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:06:56 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/03/19 02:06:58 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/03/19 02:06:58 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/03/19 02:06:58 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/03/19 02:06:58 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/03/19 02:07:01 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/03/19 02:07:01 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/03/19 02:07:01 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/03/19 02:07:03 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:07:03 DEBUG : chunked-10Mi-20Mi-streamed.bin: Streaming upload with --b2-chunk-size 10Mi allows uploads of up to 97.656Gi and will fail only when that limit is reached. 2025/03/19 02:07:04 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f203c9dea2b7e13e4_d20250319_m020704_c001_v0001181_t0034_u01742350024038") 2025/03/19 02:07:04 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/03/19 02:07:04 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/19 02:07:04 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/03/19 02:07:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:07:07 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:07:07 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/03/19 02:07:09 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/03/19 02:07:09 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/03/19 02:07:10 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/03/19 02:07:10 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/03/19 02:07:10 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/03/19 02:07:10 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/03/19 02:07:10 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/03/19 02:07:12 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/03/19 02:07:12 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/03/19 02:07:12 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/03/19 02:07:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/19 02:07:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 10Mi allows uploads of up to 97.656Gi and will fail only when that limit is reached. 2025/03/19 02:07:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_zdf425d63203dabcb9f580e1b_f21838ca0e18566ea_d20250319_m020715_c001_v0001177_t0038_u01742350035590") 2025/03/19 02:07:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/03/19 02:07:16 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/19 02:07:16 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/03/19 02:07:16 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/03/19 02:07:16 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/03/19 02:07:18 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/03/19 02:07:18 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/03/19 02:07:18 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsCopyChunked === RUN TestIntegration/FsMkdir/FsCopyChunked/5242880 === RUN TestIntegration/FsMkdir/FsCopyChunked/5242881 2025/03/19 02:07:29 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zdf425d63203dabcb9f580e1b_f2061b707f1198410_d20250319_m020728_c001_v0001131_t0009_u01742350048943") 2025/03/19 02:07:29 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/03/19 02:07:29 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/19 02:07:29 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/19 02:07:29 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/19 02:07:29 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/03/19 02:07:31 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/03/19 02:07:31 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/03/19 02:07:32 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/03/19 02:07:32 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/03/19 02:07:34 DEBUG : chunked-copy: Done sending chunk 0 2025/03/19 02:07:34 DEBUG : chunked-copy: Done sending chunk 1 2025/03/19 02:07:34 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/03/19 02:07:35 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zdf425d63203dabcb9f580e1b_f2061b707f1198441_d20250319_m020734_c001_v0001115_t0011_u01742350054977") 2025/03/19 02:07:35 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/03/19 02:07:35 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/19 02:07:35 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/19 02:07:36 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/19 02:07:36 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/03/19 02:07:38 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/03/19 02:07:38 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/03/19 02:07:38 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/03/19 02:07:38 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/03/19 02:07:41 DEBUG : chunked-copy: Done sending chunk 1 2025/03/19 02:07:50 DEBUG : chunked-copy: Done sending chunk 0 2025/03/19 02:07:50 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/03/19 02:07:52 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zdf425d63203dabcb9f580e1b_f207bac1305e02473_d20250319_m020752_c001_v0001146_t0008_u01742350072359") 2025/03/19 02:07:52 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/03/19 02:07:52 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/19 02:07:53 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/19 02:07:53 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/19 02:07:53 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/03/19 02:07:56 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/03/19 02:07:56 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/03/19 02:07:56 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/03/19 02:07:56 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/03/19 02:07:58 DEBUG : chunked-copy: Done sending chunk 0 2025/03/19 02:07:58 DEBUG : chunked-copy: Done sending chunk 1 2025/03/19 02:07:58 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/03/19 02:07:59 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_zdf425d63203dabcb9f580e1b_f207bac1305e0247e_d20250319_m020759_c001_v0001176_t0043_u01742350079588") 2025/03/19 02:07:59 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/03/19 02:07:59 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/19 02:07:59 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/03/19 02:07:59 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/03/19 02:08:00 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/19 02:08:00 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/19 02:08:00 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/03/19 02:08:02 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/03/19 02:08:05 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/03/19 02:08:06 DEBUG : Creating backend with remote "TestB2:rclone-test-heteyon0zono/deeper/nonexisting/directory" 2025/03/19 02:08:06 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2717: Can't test if can't have empty directories 2025/03/19 02:08:08 INFO : B2 bucket rclone-test-heteyon0zono: cleaning bucket "rclone-test-heteyon0zono" of all files 2025/03/19 02:08:08 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e13dc_d20250319_m020657_c001_v7007000_t0000_u01742350017569") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac55_d20250319_m020653_c001_v0001184_t0043_u01742350013448") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aac54_d20250319_m020652_c001_v7007000_t0000_u01742350012933") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac52_d20250319_m020648_c001_v0001182_t0033_u01742350008446") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f11983fb_d20250319_m020720_c001_v7007000_t0000_u01742350040794") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21838ca0e18566ea_d20250319_m020715_c001_v0001177_t0038_u01742350035590") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41838ca0e18566e9_d20250319_m020715_c001_v7007000_t0000_u01742350035101") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f203c9dea2b7e13ec_d20250319_m020709_c001_v0001182_t0059_u01742350029304") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e13ea_d20250319_m020709_c001_v7007000_t0000_u01742350029121") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f203c9dea2b7e13e4_d20250319_m020704_c001_v0001181_t0034_u01742350024038") 2025/03/19 02:08:08 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e13e3_d20250319_m020703_c001_v7007000_t0000_u01742350023547") 2025/03/19 02:08:09 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f203c9dea2b7e13dd_d20250319_m020657_c001_v0001172_t0041_u01742350017750") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4126bda746bd7369_d20250319_m020525_c001_v7007000_t0000_u01742349925246") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2126bda746bd7367_d20250319_m020521_c001_v0001165_t0057_u01742349921197") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf73ff2_d20250319_m020516_c001_v7007000_t0000_u01742349916048") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21822b461295802e_d20250319_m020512_c001_v0001179_t0017_u01742349912210") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4126bda746bd7366_d20250319_m020520_c001_v7007000_t0000_u01742349920858") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf73ff3_d20250319_m020516_c001_v0001115_t0008_u01742349916232") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41822b461295802b_d20250319_m020511_c001_v7007000_t0000_u01742349911864") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf73ff0_d20250319_m020507_c001_v0001184_t0051_u01742349907757") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf73fef_d20250319_m020507_c001_v7007000_t0000_u01742349907573") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21822b461295801b_d20250319_m020504_c001_v0001150_t0019_u01742349904168") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41822b4612958019_d20250319_m020503_c001_v7007000_t0000_u01742349903827") 2025/03/19 02:08:09 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf73feb_d20250319_m020500_c001_v0001182_t0010_u01742349900212") 2025/03/19 02:08:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf7400c_d20250319_m020549_c001_v7007000_t0000_u01742349949820") 2025/03/19 02:08:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21838ca0e18562d3_d20250319_m020545_c001_v0001184_t0045_u01742349945978") 2025/03/19 02:08:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4126bda746bd7378_d20250319_m020541_c001_v7007000_t0000_u01742349941251") 2025/03/19 02:08:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf74006_d20250319_m020537_c001_v0001177_t0040_u01742349937372") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41838ca0e18562d2_d20250319_m020545_c001_v7007000_t0000_u01742349945636") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2126bda746bd7379_d20250319_m020541_c001_v0001172_t0024_u01742349941436") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf74005_d20250319_m020537_c001_v7007000_t0000_u01742349937033") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2126bda746bd7375_d20250319_m020532_c001_v0001101_t0031_u01742349932869") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4126bda746bd7374_d20250319_m020532_c001_v7007000_t0000_u01742349932685") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf73ffe_d20250319_m020529_c001_v0001182_t0014_u01742349929293") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf73ffd_d20250319_m020528_c001_v7007000_t0000_u01742349928930") 2025/03/19 02:08:10 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2126bda746bd736a_d20250319_m020525_c001_v0001184_t0015_u01742349925431") 2025/03/19 02:08:10 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf73fea_d20250319_m020500_c001_v7007000_t0000_u01742349900029") 2025/03/19 02:08:10 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf73fe6_d20250319_m020456_c001_v0001091_t0041_u01742349896088") 2025/03/19 02:08:10 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf73fe5_d20250319_m020455_c001_v7007000_t0000_u01742349895742") 2025/03/19 02:08:10 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabed_d20250319_m020451_c001_v0001180_t0035_u01742349891811") 2025/03/19 02:08:10 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aabec_d20250319_m020451_c001_v7007000_t0000_u01742349891628") 2025/03/19 02:08:10 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21822b4612958011_d20250319_m020447_c001_v0001153_t0021_u01742349887769") 2025/03/19 02:08:10 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41822b4612958010_d20250319_m020447_c001_v7007000_t0000_u01742349887426") 2025/03/19 02:08:11 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aabc5_d20250319_m020442_c001_v0001117_t0037_u01742349882941") 2025/03/19 02:08:11 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aabc4_d20250319_m020442_c001_v7007000_t0000_u01742349882759") 2025/03/19 02:08:11 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21822b4612958000_d20250319_m020439_c001_v0001183_t0010_u01742349879455") 2025/03/19 02:08:11 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41822b4612957fff_d20250319_m020439_c001_v7007000_t0000_u01742349879120") 2025/03/19 02:08:11 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21822b4612957ff7_d20250319_m020434_c001_v0001183_t0007_u01742349874140") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aac31_d20250319_m020618_c001_v7007000_t0000_u01742349978783") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f201c96a9eb97b541_d20250319_m020614_c001_v0001184_t0020_u01742349974162") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf7401a_d20250319_m020608_c001_v7007000_t0000_u01742349968372") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf74018_d20250319_m020603_c001_v0001043_t0029_u01742349963819") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f401c96a9eb97b540_d20250319_m020613_c001_v7007000_t0000_u01742349973745") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf7401b_d20250319_m020608_c001_v0001176_t0029_u01742349968564") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf74017_d20250319_m020603_c001_v7007000_t0000_u01742349963400") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf74012_d20250319_m020558_c001_v0001040_t0012_u01742349958449") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f41772f004bf74011_d20250319_m020558_c001_v7007000_t0000_u01742349958256") 2025/03/19 02:08:11 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2126bda746bd7383_d20250319_m020554_c001_v0001109_t0032_u01742349954389") 2025/03/19 02:08:12 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4126bda746bd7382_d20250319_m020553_c001_v7007000_t0000_u01742349953986") 2025/03/19 02:08:12 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f21772f004bf7400d_d20250319_m020550_c001_v0001134_t0035_u01742349950002") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aac51_d20250319_m020648_c001_v7007000_t0000_u01742350008262") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f205e3d2a50998a2a_d20250319_m020643_c001_v0001037_t0041_u01742350003201") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a50998a29_d20250319_m020642_c001_v7007000_t0000_u01742350002777") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac49_d20250319_m020637_c001_v0001184_t0035_u01742349997835") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aac48_d20250319_m020637_c001_v7007000_t0000_u01742349997651") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac43_d20250319_m020632_c001_v0001134_t0025_u01742349992985") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aac42_d20250319_m020632_c001_v7007000_t0000_u01742349992549") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac3c_d20250319_m020627_c001_v0001043_t0017_u01742349987679") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aac3b_d20250319_m020627_c001_v7007000_t0000_u01742349987495") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f201c96a9eb97b546_d20250319_m020623_c001_v0001100_t0051_u01742349983638") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f401c96a9eb97b545_d20250319_m020623_c001_v7007000_t0000_u01742349983202") 2025/03/19 02:08:12 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zdf425d63203dabcb9f580e1b_f217201493a5aac32_d20250319_m020618_c001_v0001092_t0032_u01742349978967") 2025/03/19 02:08:12 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a50998a76_d20250319_m020802_c001_v7007000_t0000_u01742350082244") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f205e3d2a50998a70_d20250319_m020756_c001_v0001103_t0051_u01742350076302") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a50998a6c_d20250319_m020755_c001_v7007000_t0000_u01742350075776") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2061b707f119844a_d20250319_m020738_c001_v0001144_t0016_u01742350058238") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1198449_d20250319_m020737_c001_v7007000_t0000_u01742350057742") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f203c9dea2b7e1435_d20250319_m020731_c001_v0001180_t0015_u01742350051705") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1434_d20250319_m020731_c001_v7007000_t0000_u01742350051185") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11df3_d20250319_m020725_c001_v0001106_t0006_u01742350045819") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f11983fe_d20250319_m020725_c001_v7007000_t0000_u01742350045448") 2025/03/19 02:08:13 DEBUG : chunked-copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11dd5_d20250319_m020721_c001_v0001106_t0002_u01742350041494") 2025/03/19 02:08:13 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a50998a75_d20250319_m020802_c001_v7007000_t0000_u01742350082055") 2025/03/19 02:08:13 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f207bac1305e0247e_d20250319_m020759_c001_v0001176_t0043_u01742350079588") 2025/03/19 02:08:13 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a50998a6a_d20250319_m020755_c001_v7007000_t0000_u01742350075595") 2025/03/19 02:08:13 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f207bac1305e02473_d20250319_m020752_c001_v0001146_t0008_u01742350072359") 2025/03/19 02:08:13 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f1198447_d20250319_m020737_c001_v7007000_t0000_u01742350057561") 2025/03/19 02:08:14 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2061b707f1198441_d20250319_m020734_c001_v0001115_t0011_u01742350054977") 2025/03/19 02:08:14 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f403c9dea2b7e1433_d20250319_m020731_c001_v7007000_t0000_u01742350051004") 2025/03/19 02:08:14 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f2061b707f1198410_d20250319_m020728_c001_v0001131_t0009_u01742350048943") 2025/03/19 02:08:14 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f4061b707f11983fd_d20250319_m020725_c001_v7007000_t0000_u01742350045268") 2025/03/19 02:08:14 DEBUG : chunked-copy.copy: Deleting (id "4_zdf425d63203dabcb9f580e1b_f116955c993d54d11_d20250319_m020724_c001_v0001029_t0000_u01742350044084") 2025/03/19 02:08:14 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f11673ae665dabbc7_d20250319_m020318_c001_v0001184_t0059_u01742349798086") 2025/03/19 02:08:14 DEBUG : unknown-size-put.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a50998a7a_d20250319_m020803_c001_v7007000_t0000_u01742350083974") 2025/03/19 02:08:14 DEBUG : unknown-size-put.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11e78_d20250319_m020802_c001_v0001106_t0017_u01742350082787") 2025/03/19 02:08:14 DEBUG : unknown-size-update.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f405e3d2a50998a83_d20250319_m020806_c001_v7007000_t0000_u01742350086188") 2025/03/19 02:08:14 DEBUG : unknown-size-update.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11e8a_d20250319_m020805_c001_v0001106_t0031_u01742350085408") 2025/03/19 02:08:14 DEBUG : unknown-size-update.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f111e3f4ebaa11e84_d20250319_m020804_c001_v0001106_t0044_u01742350084164") 2025/03/19 02:08:14 DEBUG : versions/test-versions.txt: Deleting (id "4_zdf425d63203dabcb9f580e1b_f417201493a5aabb8_d20250319_m020430_c001_v7007000_t0000_u01742349870442") 2025/03/19 02:08:22 INFO : B2 bucket rclone-test-heteyon0zono: cleaning bucket "rclone-test-heteyon0zono" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (352.65s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.56s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.45s) --- PASS: TestIntegration/FsMkdir (350.53s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.54s) --- 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 (19.06s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (1.83s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.95s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.92s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.92s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.92s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.92s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.92s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.10s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (22.52s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (76.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.73s) --- 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.55s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (1.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.26s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.19s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (7.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (1.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.45s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (29.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (6.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (5.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (19.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (1.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.55s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (166.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (26.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (8.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (8.40s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (25.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (7.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (8.47s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (9.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (24.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (7.44s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (3.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (8.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (28.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.28s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (10.12s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (4.97s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (10.40s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (29.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (8.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.16s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (10.61s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.49s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (32.53s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (9.30s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (4.62s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (11.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (11.67s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.69s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (41.45s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.65s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (5.74s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (6.55s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (18.04s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (6.46s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (3.94s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.74s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (2.21s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.03s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/b2 352.670s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 5m53.224436458s (try 1/5)