"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/10/07 01:09:49 NOTICE: TestB2: Stopped server 2025/10/07 01:09:49 NOTICE: TestB2: Starting server 2025/10/07 01:09:49 DEBUG : Creating backend with remote "TestB2:rclone-test-kidiniq4zadu" 2025/10/07 01:09:49 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/10/07 01:09:52 INFO : dir/subdir: Making directory fstest.go:250: Filtering empty directory "dir" fstest.go:250: Filtering empty directory "dir/subdir" 2025/10/07 01:09:52 INFO : dir/subdir: Removing directory fstest.go:250: Filtering empty directory "dir" 2025/10/07 01:09:52 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/10/07 01:10:17 DEBUG : writer-at-subdir/writer-at-file: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/10/07 01:10:17 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/10/07 01:10:20 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/10/07 01:10:20 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/10/07 01:10:20 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/10/07 01:10:20 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/10/07 01:10:20 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/10/07 01:10:20 DEBUG : writer-at-subdir/writer-at-file: Finishing large file upload with 0 parts === 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/10/07 01:10:27 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/10/07 01:10:29 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/10/07 01:10:33 INFO : B2 bucket rclone-test-kidiniq4zadu: cleaning bucket "rclone-test-kidiniq4zadu" of all files 2025/10/07 01:10:34 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce86055_d20251007_m011033_c001_v0001171_t0029_u01759799433346") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/10/07 01:10:35 DEBUG : Creating backend with remote "TestB2:rclone-test-kidiniq4zadu/dirToPurgeFromRoot" 2025/10/07 01:10:36 INFO : B2 bucket rclone-test-kidiniq4zadu path dirToPurgeFromRoot: cleaning bucket "rclone-test-kidiniq4zadu" of all files 2025/10/07 01:10:37 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce86065_d20251007_m011034_c001_v0001171_t0018_u01759799434965") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/07 01:10:37 DEBUG : Creating backend with remote "TestB2:rclone-test-kidiniq4zadu/hello? sausage/êé" 2025/10/07 01:10:41 INFO : B2 bucket rclone-test-kidiniq4zadu path hello? sausage/êé: cleaning bucket "rclone-test-kidiniq4zadu" of all files 2025/10/07 01:10:41 DEBUG : a/b/c/d/e.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f106d48f50b29d9d7_d20251007_m011040_c001_v0001101_t0057_u01759799440242") === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2025/10/07 01:10:42 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_copy_file": EOF) 2025/10/07 01:10:42 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/07 01:10:43 DEBUG : pacer: Reducing sleep to 10ms === 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/10/07 01:10:50 DEBUG : Creating backend with remote "TestB2:rclone-test-kidiniq4zadu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/07 01:10:52 DEBUG : Creating backend with remote "TestB2:rclone-test-kidiniq4zadu/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-kidiniq4zadu" from "TestB2:rclone-test-kidiniq4zadu" 2025/10/07 01:10:54 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/10/07 01:11:05 DEBUG : Creating backend with remote "TestB2:rclone-test-guxowud2woci" 2025/10/07 01:11:08 DEBUG : B2 bucket rclone-test-guxowud2woci: Purge remote 2025/10/07 01:11:08 INFO : B2 bucket rclone-test-guxowud2woci: cleaning bucket "rclone-test-guxowud2woci" of all files 2025/10/07 01:11:08 DEBUG : somefile: Deleting (id "4_zbf62dda3308dbbcb9f980e1b_f4062464fda9d577e_d20251007_m011107_c001_v0001116_t0050_u01759799467647") === 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/10/07 01:11:10 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/07 01:11:10 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/10/07 01:11:13 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/10/07 01:11:13 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/10/07 01:11:13 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.164Ki offset 6Mi/6.106Mi 2025/10/07 01:11:13 DEBUG : test-metadata: Sending chunk 1 length 110760 2025/10/07 01:11:15 DEBUG : test-metadata: Done sending chunk 1 2025/10/07 01:11:16 DEBUG : test-metadata: Done sending chunk 0 2025/10/07 01:11:16 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/10/07 01:11:26 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1171-00.backblaze.com/b2api/v1/b2_upload_file/5fd2bd53307dbbcb9f980e1b/c001_v0001171_t0027": EOF 2025/10/07 01:11:26 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1171-00.backblaze.com/b2api/v1/b2_upload_file/5fd2bd53307dbbcb9f980e1b/c001_v0001171_t0027": EOF) 2025/10/07 01:11:26 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1171-00.backblaze.com/b2api/v1/b2_upload_file/5fd2bd53307dbbcb9f980e1b/c001_v0001171_t0027": EOF - low level retry 1/10 2025/10/07 01:11:28 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-10-07-011121-276.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/10/07 01:11:31 DEBUG : oldPath = "TestB2:rclone-test-kidiniq4zadu/versions/test-versions-v2025-10-07-011121-276.txt" 2025/10/07 01:11:31 DEBUG : newPath = "TestB2,versions:rclone-test-kidiniq4zadu/versions/test-versions-v2025-10-07-011121-276.txt" 2025/10/07 01:11:31 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-kidiniq4zadu/versions/test-versions-v2025-10-07-011121-276.txt" 2025/10/07 01:11:31 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/10/07 01:11:32 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-kidiniq4zadu/versions/test-versions-v2025-10-07-011121-276.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-kidiniq4zadu/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/Before/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun 2025/10/07 01:11:35 INFO : B2 bucket rclone-test-kidiniq4zadu: cleaning bucket "rclone-test-kidiniq4zadu" of all hidden files 2025/10/07 01:11:35 DEBUG : leading space/ leading space: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc79_d20251007_m010959_c001_v7007000_t0000_u01759799399969") as it is a hide marker 2025/10/07 01:11:35 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : leading space/ leading space: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f08_d20251007_m010959_c001_v0001171_t0019_u01759799399279") 2025/10/07 01:11:35 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc77_d20251007_m010958_c001_v7007000_t0000_u01759799398915") as it is a hide marker 2025/10/07 01:11:35 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85efc_d20251007_m010958_c001_v0001171_t0049_u01759799398132") 2025/10/07 01:11:35 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc86_d20251007_m011006_c001_v7007000_t0000_u01759799406578") as it is a hide marker 2025/10/07 01:11:35 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : .leading dot/.leading dot: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f4b_d20251007_m011005_c001_v0001171_t0033_u01759799405836") 2025/10/07 01:11:35 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : created from root.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f40492fcb19228d42_d20251007_m011101_c001_v7007000_t0000_u01759799461734") as it is a hide marker 2025/10/07 01:11:35 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : created from root.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1173b7b27c1a0fd0_d20251007_m011100_c001_v0001183_t0004_u01759799460803") 2025/10/07 01:11:35 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : file name.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb1377_d20251007_m011109_c001_v7007000_t0000_u01759799469719") as it is a hide marker 2025/10/07 01:11:35 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce860e3_d20251007_m011049_c001_v0001171_t0048_u01759799449738") 2025/10/07 01:11:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f116f3935f02a6b68_d20251007_m011046_c001_v0001099_t0021_u01759799446219") 2025/10/07 01:11:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce86015_d20251007_m011025_c001_v0001171_t0001_u01759799425032") 2025/10/07 01:11:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85fff_d20251007_m011023_c001_v0001171_t0052_u01759799423874") 2025/10/07 01:11:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce8600f_d20251007_m011024_c001_v0001171_t0053_u01759799424368") "upload" dated 2025-10-07 01:10:24.368 +0000 UTC (1m11.616728971s ago) 2025/10/07 01:11:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa78ee1_d20251007_m011044_c001_v7007000_t0000_u01759799444016") as it is a hide marker 2025/10/07 01:11:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f117c049ecba84eff_d20251007_m011043_c001_v0001180_t0026_u01759799443821") 2025/10/07 01:11:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1198d1499a8d2f40_d20251007_m011043_c001_v0001177_t0038_u01759799443184") 2025/10/07 01:11:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bca1_d20251007_m011014_c001_v7007000_t0000_u01759799414456") as it is a hide marker 2025/10/07 01:11:35 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f94_d20251007_m011013_c001_v0001171_t0042_u01759799413669") 2025/10/07 01:11:35 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : piped data.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb137a_d20251007_m011111_c001_v7007000_t0000_u01759799471580") as it is a hide marker 2025/10/07 01:11:35 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : piped data.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce861b9_d20251007_m011111_c001_v0001171_t0053_u01759799471026") 2025/10/07 01:11:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : piped data.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb1378_d20251007_m011110_c001_v7007000_t0000_u01759799470843") 2025/10/07 01:11:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : piped data.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40019f5d3ce861b1_d20251007_m011110_c001_v0001171_t0027_u01759799470477") 2025/10/07 01:11:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bca5_d20251007_m011015_c001_v7007000_t0000_u01759799415505") as it is a hide marker 2025/10/07 01:11:35 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85fa4_d20251007_m011014_c001_v0001171_t0039_u01759799414820") 2025/10/07 01:11:35 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : test-metadata: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f408c1cfbd073202f_d20251007_m011118_c001_v7007000_t0000_u01759799478725") as it is a hide marker 2025/10/07 01:11:35 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : test-metadata: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2180a1b26dcb137c_d20251007_m011113_c001_v0001157_t0019_u01759799473535") 2025/10/07 01:11:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : test-metadata: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb137b_d20251007_m011112_c001_v7007000_t0000_u01759799472610") 2025/10/07 01:11:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : test-metadata: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce861c1_d20251007_m011111_c001_v0001171_t0014_u01759799471764") 2025/10/07 01:11:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc8d_d20251007_m011008_c001_v7007000_t0000_u01759799408678") as it is a hide marker 2025/10/07 01:11:35 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f59_d20251007_m011008_c001_v0001171_t0056_u01759799408057") 2025/10/07 01:11:35 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc95_d20251007_m011010_c001_v7007000_t0000_u01759799410838") as it is a hide marker 2025/10/07 01:11:35 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f71_d20251007_m011010_c001_v0001171_t0056_u01759799410134") 2025/10/07 01:11:35 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc92_d20251007_m011009_c001_v7007000_t0000_u01759799409737") as it is a hide marker 2025/10/07 01:11:35 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f63_d20251007_m011009_c001_v0001171_t0041_u01759799409043") 2025/10/07 01:11:35 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc9a_d20251007_m011012_c001_v7007000_t0000_u01759799412229") as it is a hide marker 2025/10/07 01:11:35 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f7d_d20251007_m011011_c001_v0001171_t0035_u01759799411203") 2025/10/07 01:11:35 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc9d_d20251007_m011013_c001_v7007000_t0000_u01759799413302") as it is a hide marker 2025/10/07 01:11:35 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f87_d20251007_m011012_c001_v0001171_t0002_u01759799412593") 2025/10/07 01:11:35 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing space /trailing space : Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc8a_d20251007_m011007_c001_v7007000_t0000_u01759799407690") as it is a hide marker 2025/10/07 01:11:35 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : trailing space /trailing space : Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f4f_d20251007_m011006_c001_v0001171_t0038_u01759799406957") 2025/10/07 01:11:35 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2827_d20251007_m011129_c001_v0001116_t0009_u01759799489119") "upload" dated 2025-10-07 01:11:29.119 +0000 UTC (6.866071104s ago) 2025/10/07 01:11:35 DEBUG : versions/test-versions.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41428c7da54f1a20_d20251007_m011124_c001_v7007000_t0000_u01759799484304") 2025/10/07 01:11:35 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : versions/test-versions.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce86219_d20251007_m011121_c001_v0001171_t0007_u01759799481276") 2025/10/07 01:11:35 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bcb3_d20251007_m011023_c001_v7007000_t0000_u01759799423317") as it is a hide marker 2025/10/07 01:11:35 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f210e8027cf83bcaf_d20251007_m011017_c001_v0001179_t0010_u01759799417733") 2025/10/07 01:11:35 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : zero-length-file: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bcad_d20251007_m011017_c001_v7007000_t0000_u01759799417377") as it is a hide marker 2025/10/07 01:11:35 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : zero-length-file: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40019f5d3ce85fbd_d20251007_m011016_c001_v0001171_t0027_u01759799416820") 2025/10/07 01:11:35 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7b_d20251007_m011001_c001_v7007000_t0000_u01759799401025") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f0e_d20251007_m011000_c001_v0001171_t0023_u01759799400332") 2025/10/07 01:11:35 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc73_d20251007_m010955_c001_v7007000_t0000_u01759799395393") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85ec8_d20251007_m010954_c001_v0001171_t0031_u01759799394339") 2025/10/07 01:11:35 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7e_d20251007_m011004_c001_v7007000_t0000_u01759799404203") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f31_d20251007_m011003_c001_v0001171_t0055_u01759799403454") 2025/10/07 01:11:35 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7d_d20251007_m011003_c001_v7007000_t0000_u01759799403090") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f1f_d20251007_m011002_c001_v0001171_t0023_u01759799402431") 2025/10/07 01:11:35 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc82_d20251007_m011005_c001_v7007000_t0000_u01759799405461") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f41_d20251007_m011004_c001_v0001171_t0032_u01759799404577") 2025/10/07 01:11:35 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7c_d20251007_m011002_c001_v7007000_t0000_u01759799402062") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f16_d20251007_m011001_c001_v0001171_t0001_u01759799401393") 2025/10/07 01:11:35 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ．/．: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc74_d20251007_m010956_c001_v7007000_t0000_u01759799396421") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ．/．: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ．/．: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85eda_d20251007_m010955_c001_v0001171_t0036_u01759799395756") 2025/10/07 01:11:35 NOTICE: ．/．: Skipped delete as --dry-run is set 2025/10/07 01:11:35 DEBUG : ．．/．．: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc76_d20251007_m010957_c001_v7007000_t0000_u01759799397752") as it is a hide marker 2025/10/07 01:11:35 NOTICE: ．．/．．: Skipped remove hide marker as --dry-run is set 2025/10/07 01:11:35 DEBUG : ．．/．．: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85eec_d20251007_m010956_c001_v0001171_t0021_u01759799396787") 2025/10/07 01:11:35 NOTICE: ．．/．．: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/10/07 01:11:36 INFO : B2 bucket rclone-test-kidiniq4zadu: cleaning bucket "rclone-test-kidiniq4zadu" of all hidden files 2025/10/07 01:11:36 DEBUG : leading space/ leading space: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc79_d20251007_m010959_c001_v7007000_t0000_u01759799399969") as it is a hide marker 2025/10/07 01:11:36 DEBUG : leading space/ leading space: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f08_d20251007_m010959_c001_v0001171_t0019_u01759799399279") 2025/10/07 01:11:36 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc77_d20251007_m010958_c001_v7007000_t0000_u01759799398915") as it is a hide marker 2025/10/07 01:11:36 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85efc_d20251007_m010958_c001_v0001171_t0049_u01759799398132") 2025/10/07 01:11:36 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc86_d20251007_m011006_c001_v7007000_t0000_u01759799406578") as it is a hide marker 2025/10/07 01:11:36 DEBUG : .leading dot/.leading dot: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f4b_d20251007_m011005_c001_v0001171_t0033_u01759799405836") 2025/10/07 01:11:36 DEBUG : created from root.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f40492fcb19228d42_d20251007_m011101_c001_v7007000_t0000_u01759799461734") as it is a hide marker 2025/10/07 01:11:36 DEBUG : created from root.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1173b7b27c1a0fd0_d20251007_m011100_c001_v0001183_t0004_u01759799460803") 2025/10/07 01:11:36 DEBUG : file name.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb1377_d20251007_m011109_c001_v7007000_t0000_u01759799469719") as it is a hide marker 2025/10/07 01:11:36 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce860e3_d20251007_m011049_c001_v0001171_t0048_u01759799449738") 2025/10/07 01:11:36 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f116f3935f02a6b68_d20251007_m011046_c001_v0001099_t0021_u01759799446219") 2025/10/07 01:11:36 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce86015_d20251007_m011025_c001_v0001171_t0001_u01759799425032") 2025/10/07 01:11:36 DEBUG : file name.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85fff_d20251007_m011023_c001_v0001171_t0052_u01759799423874") 2025/10/07 01:11:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce8600f_d20251007_m011024_c001_v0001171_t0053_u01759799424368") "upload" dated 2025-10-07 01:10:24.368 +0000 UTC (1m12.630908126s ago) 2025/10/07 01:11:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa78ee1_d20251007_m011044_c001_v7007000_t0000_u01759799444016") as it is a hide marker 2025/10/07 01:11:37 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f117c049ecba84eff_d20251007_m011043_c001_v0001180_t0026_u01759799443821") 2025/10/07 01:11:37 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1198d1499a8d2f40_d20251007_m011043_c001_v0001177_t0038_u01759799443184") 2025/10/07 01:11:37 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bca1_d20251007_m011014_c001_v7007000_t0000_u01759799414456") as it is a hide marker 2025/10/07 01:11:37 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f94_d20251007_m011013_c001_v0001171_t0042_u01759799413669") 2025/10/07 01:11:37 DEBUG : piped data.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb137a_d20251007_m011111_c001_v7007000_t0000_u01759799471580") as it is a hide marker 2025/10/07 01:11:37 DEBUG : piped data.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce861b9_d20251007_m011111_c001_v0001171_t0053_u01759799471026") 2025/10/07 01:11:37 DEBUG : piped data.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb1378_d20251007_m011110_c001_v7007000_t0000_u01759799470843") 2025/10/07 01:11:37 DEBUG : piped data.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40019f5d3ce861b1_d20251007_m011110_c001_v0001171_t0027_u01759799470477") 2025/10/07 01:11:37 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bca5_d20251007_m011015_c001_v7007000_t0000_u01759799415505") as it is a hide marker 2025/10/07 01:11:37 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85fa4_d20251007_m011014_c001_v0001171_t0039_u01759799414820") 2025/10/07 01:11:37 DEBUG : test-metadata: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f408c1cfbd073202f_d20251007_m011118_c001_v7007000_t0000_u01759799478725") as it is a hide marker 2025/10/07 01:11:37 DEBUG : test-metadata: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2180a1b26dcb137c_d20251007_m011113_c001_v0001157_t0019_u01759799473535") 2025/10/07 01:11:37 DEBUG : test-metadata: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb137b_d20251007_m011112_c001_v7007000_t0000_u01759799472610") 2025/10/07 01:11:37 DEBUG : test-metadata: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce861c1_d20251007_m011111_c001_v0001171_t0014_u01759799471764") 2025/10/07 01:11:37 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc8d_d20251007_m011008_c001_v7007000_t0000_u01759799408678") as it is a hide marker 2025/10/07 01:11:37 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f59_d20251007_m011008_c001_v0001171_t0056_u01759799408057") 2025/10/07 01:11:37 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc95_d20251007_m011010_c001_v7007000_t0000_u01759799410838") as it is a hide marker 2025/10/07 01:11:37 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f71_d20251007_m011010_c001_v0001171_t0056_u01759799410134") 2025/10/07 01:11:37 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc92_d20251007_m011009_c001_v7007000_t0000_u01759799409737") as it is a hide marker 2025/10/07 01:11:37 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f63_d20251007_m011009_c001_v0001171_t0041_u01759799409043") 2025/10/07 01:11:37 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc9a_d20251007_m011012_c001_v7007000_t0000_u01759799412229") as it is a hide marker 2025/10/07 01:11:38 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f7d_d20251007_m011011_c001_v0001171_t0035_u01759799411203") 2025/10/07 01:11:38 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc9d_d20251007_m011013_c001_v7007000_t0000_u01759799413302") as it is a hide marker 2025/10/07 01:11:38 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f87_d20251007_m011012_c001_v0001171_t0002_u01759799412593") 2025/10/07 01:11:38 DEBUG : trailing space /trailing space : Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc8a_d20251007_m011007_c001_v7007000_t0000_u01759799407690") as it is a hide marker 2025/10/07 01:11:38 DEBUG : trailing space /trailing space : Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f4f_d20251007_m011006_c001_v0001171_t0038_u01759799406957") 2025/10/07 01:11:38 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2827_d20251007_m011129_c001_v0001116_t0009_u01759799489119") "upload" dated 2025-10-07 01:11:29.119 +0000 UTC (9.173226553s ago) 2025/10/07 01:11:38 DEBUG : versions/test-versions.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41428c7da54f1a20_d20251007_m011124_c001_v7007000_t0000_u01759799484304") 2025/10/07 01:11:38 DEBUG : versions/test-versions.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce86219_d20251007_m011121_c001_v0001171_t0007_u01759799481276") 2025/10/07 01:11:38 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bcb3_d20251007_m011023_c001_v7007000_t0000_u01759799423317") as it is a hide marker 2025/10/07 01:11:38 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f210e8027cf83bcaf_d20251007_m011017_c001_v0001179_t0010_u01759799417733") 2025/10/07 01:11:38 DEBUG : zero-length-file: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bcad_d20251007_m011017_c001_v7007000_t0000_u01759799417377") as it is a hide marker 2025/10/07 01:11:38 DEBUG : zero-length-file: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40019f5d3ce85fbd_d20251007_m011016_c001_v0001171_t0027_u01759799416820") 2025/10/07 01:11:38 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7b_d20251007_m011001_c001_v7007000_t0000_u01759799401025") as it is a hide marker 2025/10/07 01:11:38 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f0e_d20251007_m011000_c001_v0001171_t0023_u01759799400332") 2025/10/07 01:11:38 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc73_d20251007_m010955_c001_v7007000_t0000_u01759799395393") as it is a hide marker 2025/10/07 01:11:38 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85ec8_d20251007_m010954_c001_v0001171_t0031_u01759799394339") 2025/10/07 01:11:38 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7e_d20251007_m011004_c001_v7007000_t0000_u01759799404203") as it is a hide marker 2025/10/07 01:11:38 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f31_d20251007_m011003_c001_v0001171_t0055_u01759799403454") 2025/10/07 01:11:38 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7d_d20251007_m011003_c001_v7007000_t0000_u01759799403090") as it is a hide marker 2025/10/07 01:11:38 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f1f_d20251007_m011002_c001_v0001171_t0023_u01759799402431") 2025/10/07 01:11:38 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc82_d20251007_m011005_c001_v7007000_t0000_u01759799405461") as it is a hide marker 2025/10/07 01:11:39 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f41_d20251007_m011004_c001_v0001171_t0032_u01759799404577") 2025/10/07 01:11:39 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc7c_d20251007_m011002_c001_v7007000_t0000_u01759799402062") as it is a hide marker 2025/10/07 01:11:39 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85f16_d20251007_m011001_c001_v0001171_t0001_u01759799401393") 2025/10/07 01:11:39 DEBUG : ．/．: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc74_d20251007_m010956_c001_v7007000_t0000_u01759799396421") as it is a hide marker 2025/10/07 01:11:39 DEBUG : ．/．: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85eda_d20251007_m010955_c001_v0001171_t0036_u01759799395756") 2025/10/07 01:11:39 DEBUG : ．．/．．: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bc76_d20251007_m010957_c001_v7007000_t0000_u01759799397752") as it is a hide marker 2025/10/07 01:11:39 DEBUG : ．．/．．: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce85eec_d20251007_m010956_c001_v0001171_t0021_u01759799396787") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/10/07 01:11:39 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/10/07 01:11:40 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/10/07 01:11:40 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/10/07 01:11:40 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/10/07 01:11:40 INFO : B2 bucket rclone-test-kidiniq4zadu: cleaning bucket "rclone-test-kidiniq4zadu" of pending multipart uploads older than 0s 2025/10/07 01:11:41 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce8600f_d20251007_m011024_c001_v0001171_t0053_u01759799424368") "upload" dated 2025-10-07 01:10:24.368 +0000 UTC (1m16.775036692s ago) 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a35_d20251007_m011140_c001_v0001090_t0021_u01759799500080") as it is a start marker (upload started at 2025-10-07 01:11:40.08 +0000 UTC) 2025/10/07 01:11:41 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a36_d20251007_m011140_c001_v0001099_t0017_u01759799500273") as it is a start marker (upload started at 2025-10-07 01:11:40.273 +0000 UTC) 2025/10/07 01:11:41 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a37_d20251007_m011140_c001_v0001183_t0034_u01759799500469") as it is a start marker (upload started at 2025-10-07 01:11:40.469 +0000 UTC) 2025/10/07 01:11:41 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a38_d20251007_m011140_c001_v0001131_t0036_u01759799500673") as it is a start marker (upload started at 2025-10-07 01:11:40.673 +0000 UTC) 2025/10/07 01:11:41 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/10/07 01:11:41 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f41428c7da54f1a34_d20251007_m011139_c001_v7007000_t0000_u01759799499900") "hide" dated 2025-10-07 01:11:39.9 +0000 UTC (1.243196161s ago) 2025/10/07 01:11:41 DEBUG : versions/test-versions.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2827_d20251007_m011129_c001_v0001116_t0009_u01759799489119") 2025/10/07 01:11:41 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/10/07 01:11:41 INFO : B2 bucket rclone-test-kidiniq4zadu: cleaning bucket "rclone-test-kidiniq4zadu" of pending multipart uploads older than 0s 2025/10/07 01:11:41 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce8600f_d20251007_m011024_c001_v0001171_t0053_u01759799424368") "upload" dated 2025-10-07 01:10:24.368 +0000 UTC (1m17.14167656s ago) 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a35_d20251007_m011140_c001_v0001090_t0021_u01759799500080") as it is a start marker (upload started at 2025-10-07 01:11:40.08 +0000 UTC) 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a36_d20251007_m011140_c001_v0001099_t0017_u01759799500273") as it is a start marker (upload started at 2025-10-07 01:11:40.273 +0000 UTC) 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a37_d20251007_m011140_c001_v0001183_t0034_u01759799500469") as it is a start marker (upload started at 2025-10-07 01:11:40.469 +0000 UTC) 2025/10/07 01:11:41 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a38_d20251007_m011140_c001_v0001131_t0036_u01759799500673") as it is a start marker (upload started at 2025-10-07 01:11:40.673 +0000 UTC) 2025/10/07 01:11:41 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z5fd2bd53307dbbcb9f980e1b_f41428c7da54f1a34_d20251007_m011139_c001_v7007000_t0000_u01759799499900") "hide" dated 2025-10-07 01:11:39.9 +0000 UTC (1.609838664s ago) 2025/10/07 01:11:41 DEBUG : versions/test-versions.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2827_d20251007_m011129_c001_v0001116_t0009_u01759799489119") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/10/07 01:11:42 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/10/07 01:11:42 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/10/07 01:11:42 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/10/07 01:11:43 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/10/07 01:11:43 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/10/07 01:11:43 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/10/07 01:11:43 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/10/07 01:11:44 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/10/07 01:11:46 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/10/07 01:11:46 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/10/07 01:11:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:11:49 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/10/07 01:11:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a43_d20251007_m011149_c001_v0001098_t0009_u01759799509292") 2025/10/07 01:11:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:11:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:11:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/07 01:11:50 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:11:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:11:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/10/07 01:11:53 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/10/07 01:11:53 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/10/07 01:11:53 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/10/07 01:11:53 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/10/07 01:11:55 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/10/07 01:12:05 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/10/07 01:12:05 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/10/07 01:12:08 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:12:08 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/10/07 01:12:09 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27eeb_d20251007_m011209_c001_v0001100_t0007_u01759799529001") 2025/10/07 01:12:09 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/07 01:12:09 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/10/07 01:12:09 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/07 01:12:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:12:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:12:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/10/07 01:12:13 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/10/07 01:12:13 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/10/07 01:12:14 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/10/07 01:12:14 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/10/07 01:12:14 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/10/07 01:12:14 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/10/07 01:12:15 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/10/07 01:12:16 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/10/07 01:12:16 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/10/07 01:12:16 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/10/07 01:12:17 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:12:17 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/10/07 01:12:18 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f2090fc5fa41d5fdf_d20251007_m011218_c001_v0001104_t0037_u01759799538086") 2025/10/07 01:12:18 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/07 01:12:18 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/10/07 01:12:18 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:12:18 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/07 01:12:19 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/10/07 01:12:20 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:12:21 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:12:21 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/10/07 01:12:22 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/10/07 01:12:22 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/10/07 01:12:22 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/10/07 01:12:22 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/10/07 01:12:23 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/10/07 01:12:25 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/10/07 01:12:25 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/10/07 01:12:26 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:12:26 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/10/07 01:12:26 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f2090fc5fa41d5ff2_d20251007_m011226_c001_v0001184_t0058_u01759799546590") 2025/10/07 01:12:26 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:12:26 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:12:26 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/07 01:12:27 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:12:28 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:12:28 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/10/07 01:12:30 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/10/07 01:12:30 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/10/07 01:12:30 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/10/07 01:12:30 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/10/07 01:12:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/10/07 01:12:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/10/07 01:12:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/10/07 01:12:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:12:34 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/10/07 01:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f02_d20251007_m011235_c001_v0001099_t0010_u01759799555012") 2025/10/07 01:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/07 01:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/07 01:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/10/07 01:12:36 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:12:37 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:12:37 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/10/07 01:12:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/10/07 01:12:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/10/07 01:12:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/10/07 01:12:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/10/07 01:12:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/10/07 01:12:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/10/07 01:12:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/10/07 01:12:41 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/10/07 01:12:42 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/10/07 01:12:42 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/10/07 01:12:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:12:43 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/10/07 01:12:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f2180a1b26dcb13d1_d20251007_m011243_c001_v0001178_t0031_u01759799563768") 2025/10/07 01:12:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/07 01:12:44 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:12:44 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/10/07 01:12:44 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/10/07 01:12:44 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/10/07 01:12:46 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:12:46 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:12:46 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/10/07 01:12:48 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/10/07 01:12:48 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/10/07 01:12:48 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/10/07 01:12:48 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/10/07 01:12:49 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/10/07 01:12:50 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/10/07 01:12:50 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/10/07 01:12:52 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:12:52 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/10/07 01:12:52 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f2180a1b26dcb13e0_d20251007_m011252_c001_v0001157_t0005_u01759799572190") 2025/10/07 01:12:52 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:12:52 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:12:52 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/07 01:12:53 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:12:54 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:12:54 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/10/07 01:12:56 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/10/07 01:12:56 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/10/07 01:12:56 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/10/07 01:12:56 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/10/07 01:12:59 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/10/07 01:12:59 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/10/07 01:12:59 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/10/07 01:13:00 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:13:00 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/10/07 01:13:00 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f14_d20251007_m011300_c001_v0001183_t0015_u01759799580824") 2025/10/07 01:13:00 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/07 01:13:01 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/07 01:13:01 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/10/07 01:13:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:13:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:13:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/10/07 01:13:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/10/07 01:13:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/10/07 01:13:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/10/07 01:13:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/10/07 01:13:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/10/07 01:13:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/10/07 01:13:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/10/07 01:13:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/10/07 01:13:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/10/07 01:13:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/10/07 01:13:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:13:09 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/10/07 01:13:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f20109ad4bf8b1b90_d20251007_m011309_c001_v0001109_t0012_u01759799589569") 2025/10/07 01:13:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/07 01:13:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:13:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/10/07 01:13:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/10/07 01:13:10 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/10/07 01:13:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:13:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:13:12 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/10/07 01:13:14 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/10/07 01:13:14 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/10/07 01:13:14 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/10/07 01:13:14 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/10/07 01:13:15 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/10/07 01:13:17 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/10/07 01:13:17 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/10/07 01:13:18 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:13:18 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/10/07 01:13:18 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f20_d20251007_m011318_c001_v0001117_t0027_u01759799598793") 2025/10/07 01:13:18 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:13:18 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:13:18 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/07 01:13:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:13:21 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:13:21 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/10/07 01:13:23 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/10/07 01:13:23 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/10/07 01:13:23 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/10/07 01:13:23 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/10/07 01:13:25 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/10/07 01:13:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/10/07 01:13:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/10/07 01:13:28 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:13:28 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/10/07 01:13:28 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f20109ad4bf8b1ba8_d20251007_m011328_c001_v0001181_t0025_u01759799608272") 2025/10/07 01:13:28 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/07 01:13:28 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/10/07 01:13:28 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/07 01:13:30 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:13:31 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:13:31 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/10/07 01:13:33 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/10/07 01:13:33 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/10/07 01:13:34 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/10/07 01:13:34 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/10/07 01:13:34 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/10/07 01:13:34 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/10/07 01:13:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/10/07 01:13:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/10/07 01:13:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/10/07 01:13:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/10/07 01:13:38 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:13:38 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/10/07 01:13:39 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f209c971cf40e5326_d20251007_m011338_c001_v0001134_t0011_u01759799618995") 2025/10/07 01:13:39 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/07 01:13:39 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:13:39 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/10/07 01:13:39 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/10/07 01:13:39 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/10/07 01:13:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/07 01:13:39 DEBUG : pacer: Reducing sleep to 10ms 2025/10/07 01:13:40 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/10/07 01:13:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:13:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:13:41 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/10/07 01:13:44 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/10/07 01:13:44 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/10/07 01:13:44 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/10/07 01:13:44 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/10/07 01:13:45 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/10/07 01:13:47 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/10/07 01:13:47 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/10/07 01:13:48 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:13:48 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/10/07 01:13:49 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f209c971cf40e5329_d20251007_m011349_c001_v0001182_t0020_u01759799629084") 2025/10/07 01:13:49 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:13:49 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/07 01:13:49 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:13:49 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/10/07 01:13:49 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/07 01:13:49 DEBUG : pacer: Reducing sleep to 10ms 2025/10/07 01:13:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:13:51 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:13:51 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/10/07 01:13:53 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/10/07 01:13:53 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/10/07 01:13:53 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/10/07 01:13:53 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/10/07 01:13:55 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/10/07 01:13:56 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/10/07 01:13:56 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/10/07 01:13:58 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:13:58 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/10/07 01:13:58 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da9644a_d20251007_m011358_c001_v0001154_t0008_u01759799638403") 2025/10/07 01:13:58 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/07 01:13:58 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/07 01:13:58 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/10/07 01:14:01 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:14:01 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:14:01 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/10/07 01:14:04 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/10/07 01:14:04 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/10/07 01:14:04 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/10/07 01:14:04 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/10/07 01:14:04 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/10/07 01:14:04 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/10/07 01:14:05 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/10/07 01:14:06 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/10/07 01:14:06 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/10/07 01:14:06 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/10/07 01:14:09 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:14:09 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/10/07 01:14:09 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f210e8027cf83bef9_d20251007_m011409_c001_v0001092_t0036_u01759799649173") 2025/10/07 01:14:09 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/07 01:14:09 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:14:09 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/10/07 01:14:09 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/07 01:14:10 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/10/07 01:14:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:14:13 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:14:13 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/10/07 01:14:17 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/10/07 01:14:17 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/10/07 01:14:17 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/10/07 01:14:17 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/10/07 01:14:18 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/10/07 01:14:20 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/10/07 01:14:20 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/10/07 01:14:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:14:22 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/10/07 01:14:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f2196046f111f6f22_d20251007_m011422_c001_v0001137_t0018_u01759799662438") 2025/10/07 01:14:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:14:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/07 01:14:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00016cbd0), retryAfter:1000000000} 2025/10/07 01:14:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:23 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:23 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0037d98f0), retryAfter:1000000000} 2025/10/07 01:14:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:23 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:24 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:25 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00049a5a0), retryAfter:1000000000} 2025/10/07 01:14:25 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:25 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:25 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:25 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/07 01:14:26 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:27 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:28 DEBUG : pacer: Reducing sleep to 250ms 2025/10/07 01:14:29 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00016d7d0), retryAfter:1000000000} 2025/10/07 01:14:29 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:29 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:29 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:29 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:30 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:30 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00038d740), retryAfter:1000000000} 2025/10/07 01:14:30 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:30 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:30 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:31 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:32 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:32 DEBUG : pacer: Reducing sleep to 250ms 2025/10/07 01:14:32 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:14:32 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00017f230), retryAfter:1000000000} 2025/10/07 01:14:32 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:32 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:32 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:33 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:33 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00017f530), retryAfter:1000000000} 2025/10/07 01:14:33 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:33 DEBUG : pacer: low level retry 6/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:34 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:35 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00032c990), retryAfter:1000000000} 2025/10/07 01:14:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:35 DEBUG : pacer: low level retry 7/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:35 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:36 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:37 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:37 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00032cf60), retryAfter:1000000000} 2025/10/07 01:14:37 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:37 DEBUG : pacer: low level retry 8/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:37 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:38 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:39 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:39 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0001735c0), retryAfter:1000000000} 2025/10/07 01:14:39 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:39 DEBUG : pacer: low level retry 9/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:39 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:40 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:41 DEBUG : pacer: Reducing sleep to 500ms 2025/10/07 01:14:42 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000176000), retryAfter:1000000000} 2025/10/07 01:14:42 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:42 DEBUG : pacer: low level retry 10/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/07 01:14:42 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/07 01:14:42 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Error sending chunk 1: no tomes available (503 service_unavailable): trying again in 1s 2025/10/07 01:14:42 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Cancelling large file upload 2025/10/07 01:14:43 DEBUG : pacer: Reducing sleep to 500ms fstests.go:143: PutLarge error: no tomes available (503 service_unavailable): trying again in 1s - low level retry 1/10 2025/10/07 01:14:45 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:14:45 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/10/07 01:14:45 DEBUG : pacer: Reducing sleep to 250ms 2025/10/07 01:14:45 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da964d1_d20251007_m011445_c001_v0001183_t0026_u01759799685522") 2025/10/07 01:14:45 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:14:45 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/07 01:14:46 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/07 01:14:46 DEBUG : pacer: Reducing sleep to 125ms 2025/10/07 01:14:46 DEBUG : pacer: Reducing sleep to 62.5ms 2025/10/07 01:14:47 DEBUG : pacer: Reducing sleep to 31.25ms 2025/10/07 01:14:47 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:14:49 DEBUG : pacer: Reducing sleep to 15.625ms 2025/10/07 01:14:49 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:14:49 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts 2025/10/07 01:14:49 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/10/07 01:14:52 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/10/07 01:14:52 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/10/07 01:14:53 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/10/07 01:14:53 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/10/07 01:14:55 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/10/07 01:14:55 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/10/07 01:14:55 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/10/07 01:14:58 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:14:58 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/10/07 01:14:58 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da96527_d20251007_m011458_c001_v0001146_t0011_u01759799698241") 2025/10/07 01:14:58 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/07 01:14:58 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/07 01:14:58 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/10/07 01:15:01 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:15:01 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:15:01 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/10/07 01:15:04 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/10/07 01:15:04 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/10/07 01:15:04 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/10/07 01:15:04 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/10/07 01:15:04 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/10/07 01:15:04 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/10/07 01:15:05 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/10/07 01:15:06 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/10/07 01:15:07 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/10/07 01:15:07 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/10/07 01:15:09 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/07 01:15:09 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/10/07 01:15:09 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e3c_d20251007_m011509_c001_v0001184_t0035_u01759799709797") 2025/10/07 01:15:09 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/07 01:15:10 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/07 01:15:10 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/07 01:15:10 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/10/07 01:15:11 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/10/07 01:15:12 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/10/07 01:15:13 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/10/07 01:15:13 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/10/07 01:15:22 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e45_d20251007_m011522_c001_v0001038_t0036_u01759799722408") 2025/10/07 01:15:22 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/10/07 01:15:22 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/07 01:15:22 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/07 01:15:23 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/07 01:15:23 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/10/07 01:15:24 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/10/07 01:15:24 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/07 01:15:25 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/10/07 01:15:25 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/10/07 01:15:27 DEBUG : chunked-copy: Done sending chunk 0 2025/10/07 01:15:27 DEBUG : chunked-copy: Done sending chunk 1 2025/10/07 01:15:27 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/07 01:15:28 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e52_d20251007_m011528_c001_v0001181_t0050_u01759799728476") 2025/10/07 01:15:28 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/10/07 01:15:28 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/07 01:15:28 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/07 01:15:28 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/07 01:15:28 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/10/07 01:15:31 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/10/07 01:15:31 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/07 01:15:31 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/10/07 01:15:31 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/07 01:15:33 DEBUG : chunked-copy: Done sending chunk 0 2025/10/07 01:15:33 DEBUG : chunked-copy: Done sending chunk 1 2025/10/07 01:15:33 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/07 01:15:34 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z5fd2bd53307dbbcb9f980e1b_f2202c3ba8aa79239_d20251007_m011534_c001_v0001038_t0030_u01759799734196") 2025/10/07 01:15:34 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/10/07 01:15:34 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/07 01:15:34 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/07 01:15:35 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/07 01:15:35 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/10/07 01:15:37 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/10/07 01:15:37 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/07 01:15:37 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/10/07 01:15:37 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/10/07 01:15:39 DEBUG : chunked-copy: Done sending chunk 0 2025/10/07 01:15:39 DEBUG : chunked-copy: Done sending chunk 1 2025/10/07 01:15:39 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/07 01:15:40 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_z5fd2bd53307dbbcb9f980e1b_f2202c3ba8aa79249_d20251007_m011540_c001_v0001184_t0007_u01759799740729") 2025/10/07 01:15:40 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/10/07 01:15:40 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/07 01:15:40 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/10/07 01:15:41 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/10/07 01:15:41 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/07 01:15:41 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/07 01:15:41 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/07 01:15:42 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/07 01:15:44 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/07 01:15:45 DEBUG : Creating backend with remote "TestB2:rclone-test-kidiniq4zadu/deeper/nonexisting/directory" 2025/10/07 01:15:45 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/10/07 01:15:46 INFO : B2 bucket rclone-test-kidiniq4zadu: cleaning bucket "rclone-test-kidiniq4zadu" of all files 2025/10/07 01:15:47 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f415b62f10da964dc_d20251007_m011452_c001_v7007000_t0000_u01759799692077") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da964d1_d20251007_m011445_c001_v0001183_t0026_u01759799685522") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4196046f111f6f21_d20251007_m011421_c001_v7007000_t0000_u01759799661822") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da96494_d20251007_m011417_c001_v0001154_t0016_u01759799657195") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e3e_d20251007_m011515_c001_v7007000_t0000_u01759799715148") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e3c_d20251007_m011509_c001_v0001184_t0035_u01759799709797") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e3b_d20251007_m011509_c001_v7007000_t0000_u01759799709171") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da9654a_d20251007_m011503_c001_v0001178_t0020_u01759799703804") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f415b62f10da96549_d20251007_m011503_c001_v7007000_t0000_u01759799703623") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da96527_d20251007_m011458_c001_v0001146_t0011_u01759799698241") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f415b62f10da9651e_d20251007_m011457_c001_v7007000_t0000_u01759799697640") 2025/10/07 01:15:47 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da964dd_d20251007_m011452_c001_v0001184_t0058_u01759799692259") 2025/10/07 01:15:47 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27f0b_d20251007_m011247_c001_v7007000_t0000_u01759799567603") 2025/10/07 01:15:47 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2180a1b26dcb13d1_d20251007_m011243_c001_v0001178_t0031_u01759799563768") 2025/10/07 01:15:47 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27f06_d20251007_m011239_c001_v7007000_t0000_u01759799559072") 2025/10/07 01:15:47 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f02_d20251007_m011235_c001_v0001099_t0010_u01759799555012") 2025/10/07 01:15:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb13ce_d20251007_m011243_c001_v7007000_t0000_u01759799563321") 2025/10/07 01:15:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f07_d20251007_m011239_c001_v0001184_t0003_u01759799559253") 2025/10/07 01:15:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27f01_d20251007_m011234_c001_v7007000_t0000_u01759799554480") 2025/10/07 01:15:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27efc_d20251007_m011230_c001_v0001099_t0048_u01759799550071") 2025/10/07 01:15:48 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27efb_d20251007_m011229_c001_v7007000_t0000_u01759799549886") 2025/10/07 01:15:48 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2090fc5fa41d5ff2_d20251007_m011226_c001_v0001184_t0058_u01759799546590") 2025/10/07 01:15:48 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4090fc5fa41d5ff0_d20251007_m011226_c001_v7007000_t0000_u01759799546178") 2025/10/07 01:15:48 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27ef7_d20251007_m011222_c001_v0001145_t0028_u01759799542453") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40109ad4bf8b1b9d_d20251007_m011314_c001_v7007000_t0000_u01759799594111") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f20109ad4bf8b1b90_d20251007_m011309_c001_v0001109_t0012_u01759799589569") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27f1a_d20251007_m011304_c001_v7007000_t0000_u01759799584664") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f14_d20251007_m011300_c001_v0001183_t0015_u01759799580824") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40109ad4bf8b1b8f_d20251007_m011309_c001_v7007000_t0000_u01759799589182") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f1b_d20251007_m011304_c001_v0001146_t0021_u01759799584847") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27f13_d20251007_m011300_c001_v7007000_t0000_u01759799580423") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2180a1b26dcb13eb_d20251007_m011256_c001_v0001029_t0000_u01759799576086") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb13ea_d20251007_m011255_c001_v7007000_t0000_u01759799575904") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2180a1b26dcb13e0_d20251007_m011252_c001_v0001157_t0005_u01759799572190") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4180a1b26dcb13de_d20251007_m011251_c001_v7007000_t0000_u01759799571806") 2025/10/07 01:15:48 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f0c_d20251007_m011247_c001_v0001032_t0059_u01759799567784") 2025/10/07 01:15:48 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27ef6_d20251007_m011222_c001_v7007000_t0000_u01759799542270") 2025/10/07 01:15:48 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2090fc5fa41d5fdf_d20251007_m011218_c001_v0001104_t0037_u01759799538086") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4090fc5fa41d5fde_d20251007_m011217_c001_v7007000_t0000_u01759799537657") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27ef2_d20251007_m011213_c001_v0001136_t0044_u01759799533283") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27ef1_d20251007_m011213_c001_v7007000_t0000_u01759799533065") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27eeb_d20251007_m011209_c001_v0001100_t0007_u01759799529001") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27ee9_d20251007_m011208_c001_v7007000_t0000_u01759799528527") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f200b2f8ced32d52f_d20251007_m011152_c001_v0001102_t0039_u01759799512856") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f400b2f8ced32d52e_d20251007_m011152_c001_v7007000_t0000_u01759799512667") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a43_d20251007_m011149_c001_v0001098_t0009_u01759799509292") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41428c7da54f1a41_d20251007_m011148_c001_v7007000_t0000_u01759799508853") 2025/10/07 01:15:49 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21428c7da54f1a3b_d20251007_m011143_c001_v0001153_t0010_u01759799503618") 2025/10/07 01:15:49 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41170a00954ddaea_d20251007_m011343_c001_v7007000_t0000_u01759799623478") 2025/10/07 01:15:49 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f209c971cf40e5326_d20251007_m011338_c001_v0001134_t0011_u01759799618995") 2025/10/07 01:15:49 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40109ad4bf8b1bad_d20251007_m011332_c001_v7007000_t0000_u01759799612970") 2025/10/07 01:15:49 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f20109ad4bf8b1ba8_d20251007_m011328_c001_v0001181_t0025_u01759799608272") 2025/10/07 01:15:49 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f409c971cf40e5325_d20251007_m011338_c001_v7007000_t0000_u01759799618528") 2025/10/07 01:15:49 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f20109ad4bf8b1bae_d20251007_m011333_c001_v0001171_t0000_u01759799613158") 2025/10/07 01:15:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40109ad4bf8b1ba7_d20251007_m011327_c001_v7007000_t0000_u01759799607722") 2025/10/07 01:15:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f20109ad4bf8b1ba3_d20251007_m011323_c001_v0001182_t0044_u01759799603130") 2025/10/07 01:15:50 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f40109ad4bf8b1ba2_d20251007_m011322_c001_v7007000_t0000_u01759799602941") 2025/10/07 01:15:50 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21538102f8d27f20_d20251007_m011318_c001_v0001117_t0027_u01759799598793") 2025/10/07 01:15:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41538102f8d27f1f_d20251007_m011318_c001_v7007000_t0000_u01759799598242") 2025/10/07 01:15:50 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f20109ad4bf8b1b9f_d20251007_m011314_c001_v0001172_t0014_u01759799594294") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f415b62f10da96492_d20251007_m011417_c001_v7007000_t0000_u01759799657014") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f210e8027cf83bef9_d20251007_m011409_c001_v0001092_t0036_u01759799649173") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f410e8027cf83bef7_d20251007_m011408_c001_v7007000_t0000_u01759799648627") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da9644e_d20251007_m011403_c001_v0001182_t0009_u01759799643741") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f415b62f10da9644d_d20251007_m011403_c001_v7007000_t0000_u01759799643560") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da9644a_d20251007_m011358_c001_v0001154_t0008_u01759799638403") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f415b62f10da96449_d20251007_m011357_c001_v7007000_t0000_u01759799637853") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f215b62f10da96435_d20251007_m011352_c001_v0001179_t0042_u01759799632894") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f415b62f10da96432_d20251007_m011352_c001_v7007000_t0000_u01759799632711") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f209c971cf40e5329_d20251007_m011349_c001_v0001182_t0020_u01759799629084") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f409c971cf40e5328_d20251007_m011348_c001_v7007000_t0000_u01759799628438") 2025/10/07 01:15:50 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f21170a00954ddaeb_d20251007_m011343_c001_v0001115_t0031_u01759799623722") 2025/10/07 01:15:50 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa7924c_d20251007_m011542_c001_v7007000_t0000_u01759799742656") 2025/10/07 01:15:50 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e97_d20251007_m011537_c001_v0001093_t0059_u01759799737077") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e92_d20251007_m011536_c001_v7007000_t0000_u01759799736442") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e65_d20251007_m011530_c001_v0001171_t0057_u01759799730813") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e60_d20251007_m011530_c001_v7007000_t0000_u01759799730226") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2202c3ba8aa79227_d20251007_m011524_c001_v0001040_t0055_u01759799724674") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa79223_d20251007_m011524_c001_v7007000_t0000_u01759799724041") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2aca_d20251007_m011520_c001_v0001116_t0047_u01759799720233") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e42_d20251007_m011519_c001_v7007000_t0000_u01759799719769") 2025/10/07 01:15:51 DEBUG : chunked-copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2aba_d20251007_m011515_c001_v0001116_t0004_u01759799715943") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa7924b_d20251007_m011542_c001_v7007000_t0000_u01759799742439") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2202c3ba8aa79249_d20251007_m011540_c001_v0001184_t0007_u01759799740729") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e90_d20251007_m011536_c001_v7007000_t0000_u01759799736261") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f2202c3ba8aa79239_d20251007_m011534_c001_v0001038_t0030_u01759799734196") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e5d_d20251007_m011530_c001_v7007000_t0000_u01759799730043") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e52_d20251007_m011528_c001_v0001181_t0050_u01759799728476") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa79220_d20251007_m011523_c001_v7007000_t0000_u01759799723858") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f216c43b8fe769e45_d20251007_m011522_c001_v0001038_t0036_u01759799722408") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f416c43b8fe769e41_d20251007_m011519_c001_v7007000_t0000_u01759799719587") 2025/10/07 01:15:51 DEBUG : chunked-copy.copy: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f107e399bfd71c4a6_d20251007_m011518_c001_v0001131_t0033_u01759799718560") 2025/10/07 01:15:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f10019f5d3ce8600f_d20251007_m011024_c001_v0001171_t0053_u01759799424368") 2025/10/07 01:15:51 DEBUG : unknown-size-put.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa7924e_d20251007_m011543_c001_v7007000_t0000_u01759799743657") 2025/10/07 01:15:51 DEBUG : unknown-size-put.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2b1d_d20251007_m011543_c001_v0001116_t0013_u01759799743200") 2025/10/07 01:15:51 DEBUG : unknown-size-update.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f4202c3ba8aa79250_d20251007_m011545_c001_v7007000_t0000_u01759799745460") 2025/10/07 01:15:52 DEBUG : unknown-size-update.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2b23_d20251007_m011544_c001_v0001116_t0037_u01759799744831") 2025/10/07 01:15:52 DEBUG : unknown-size-update.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f1024a5f1fa1f2b1f_d20251007_m011543_c001_v0001116_t0013_u01759799743841") 2025/10/07 01:15:52 DEBUG : versions/test-versions.txt: Deleting (id "4_z5fd2bd53307dbbcb9f980e1b_f41428c7da54f1a34_d20251007_m011139_c001_v7007000_t0000_u01759799499900") 2025/10/07 01:15:53 INFO : B2 bucket rclone-test-kidiniq4zadu: cleaning bucket "rclone-test-kidiniq4zadu" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (364.10s) --- 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.36s) --- PASS: TestIntegration/FsMkdir (361.89s) --- 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 (22.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (1.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (1.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.35s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (1.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.06s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (1.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (1.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.10s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.07s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.39s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.08s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.05s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.11s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (5.94s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (80.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.56s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (1.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.00s) --- 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.18s) --- 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.19s) --- 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.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (7.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (1.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.44s) --- 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.58s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (31.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (6.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (21.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (3.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject (0.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.39s) --- 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.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (211.72s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (38.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.82s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (20.40s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.54s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (9.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.62s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (25.33s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (7.62s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (9.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.59s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (8.53s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.28s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (26.51s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (8.30s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (4.10s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.76s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (9.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.93s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (29.43s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.83s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.65s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (10.03s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (5.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (10.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.01s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (33.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (9.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.85s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (13.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (8.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (58.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (35.06s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (30.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (11.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.98s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (11.53s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.98s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (27.51s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.62s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (4.28s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (6.18s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (6.22s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (6.21s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (2.81s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.80s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.29s) --- 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 364.118s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 6m5.061621498s (try 1/5)