"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/11/05 04:06:04 DEBUG : Creating backend with remote "TestB2:rclone-test-gogojol2doha" 2025/11/05 04:06:04 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/11/05 04:06:07 INFO : dir/subdir: Making directory fstest.go:250: Filtering empty directory "dir" fstest.go:250: Filtering empty directory "dir/subdir" 2025/11/05 04:06:07 INFO : dir/subdir: Removing directory fstest.go:250: Filtering empty directory "dir" 2025/11/05 04:06:07 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/11/05 04:06:34 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/11/05 04:06:34 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/11/05 04:06:37 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/11/05 04:06:37 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/11/05 04:06:37 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/11/05 04:06:37 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/11/05 04:06:37 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/11/05 04:06:37 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/11/05 04:06:44 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/11/05 04:06:46 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/11/05 04:06:51 INFO : B2 bucket rclone-test-gogojol2doha: cleaning bucket "rclone-test-gogojol2doha" of all files 2025/11/05 04:06:51 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e63_d20251105_m040650_c001_v0001120_t0042_u01762315610364") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/11/05 04:06:53 DEBUG : Creating backend with remote "TestB2:rclone-test-gogojol2doha/dirToPurgeFromRoot" 2025/11/05 04:06:54 INFO : B2 bucket rclone-test-gogojol2doha path dirToPurgeFromRoot: cleaning bucket "rclone-test-gogojol2doha" of all files 2025/11/05 04:06:55 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e75_d20251105_m040652_c001_v0001120_t0007_u01762315612329") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/11/05 04:06:55 DEBUG : Creating backend with remote "TestB2:rclone-test-gogojol2doha/hello? sausage/êé" 2025/11/05 04:06:59 INFO : B2 bucket rclone-test-gogojol2doha path hello? sausage/êé: cleaning bucket "rclone-test-gogojol2doha" of all files 2025/11/05 04:06:59 DEBUG : a/b/c/d/e.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f112d7c05af37cc53_d20251105_m040657_c001_v0001036_t0015_u01762315617923") === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1289: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1342: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1459: FS has no DirMover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/11/05 04:07:09 DEBUG : Creating backend with remote "TestB2:rclone-test-gogojol2doha/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/05 04:07:11 DEBUG : Creating backend with remote "TestB2:rclone-test-gogojol2doha/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-gogojol2doha" from "TestB2:rclone-test-gogojol2doha" 2025/11/05 04:07:13 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/11/05 04:07:24 DEBUG : Creating backend with remote "TestB2:rclone-test-lutogif3hafi" 2025/11/05 04:07:27 DEBUG : B2 bucket rclone-test-lutogif3hafi: Purge remote 2025/11/05 04:07:27 INFO : B2 bucket rclone-test-lutogif3hafi: cleaning bucket "rclone-test-lutogif3hafi" of all files 2025/11/05 04:07:28 DEBUG : somefile: Deleting (id "4_zdf12bd33302d5b2b9fa80e1b_f411088ff0aa04b59_d20251105_m040726_c001_v0001144_t0031_u01762315646876") === 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/11/05 04:07:29 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/05 04:07:30 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/11/05 04:07:33 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/11/05 04:07:33 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/11/05 04:07:33 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.360Ki offset 6Mi/6.106Mi 2025/11/05 04:07:33 DEBUG : test-metadata: Sending chunk 1 length 110961 2025/11/05 04:07:34 DEBUG : test-metadata: Done sending chunk 1 2025/11/05 04:07:35 DEBUG : test-metadata: Done sending chunk 0 2025/11/05 04:07:35 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/11/05 04:07:46 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1120-18.backblaze.com/b2api/v1/b2_upload_file/0ff27df3301d5b2b9fa80e1b/c001_v0001120_t0048": EOF 2025/11/05 04:07:46 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1120-18.backblaze.com/b2api/v1/b2_upload_file/0ff27df3301d5b2b9fa80e1b/c001_v0001120_t0048": EOF) 2025/11/05 04:07:46 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1120-18.backblaze.com/b2api/v1/b2_upload_file/0ff27df3301d5b2b9fa80e1b/c001_v0001120_t0048": EOF - low level retry 1/10 2025/11/05 04:07:49 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-11-05-040741-650.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/11/05 04:07:51 DEBUG : oldPath = "TestB2:rclone-test-gogojol2doha/versions/test-versions-v2025-11-05-040741-650.txt" 2025/11/05 04:07:51 DEBUG : newPath = "TestB2,versions:rclone-test-gogojol2doha/versions/test-versions-v2025-11-05-040741-650.txt" 2025/11/05 04:07:51 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-gogojol2doha/versions/test-versions-v2025-11-05-040741-650.txt" 2025/11/05 04:07:51 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/11/05 04:07:52 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-gogojol2doha/versions/test-versions-v2025-11-05-040741-650.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-gogojol2doha/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/11/05 04:07:56 INFO : B2 bucket rclone-test-gogojol2doha: cleaning bucket "rclone-test-gogojol2doha" of all hidden files 2025/11/05 04:07:56 DEBUG : leading space/ leading space: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed641_d20251105_m040614_c001_v7007000_t0000_u01762315574998") as it is a hide marker 2025/11/05 04:07:56 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : leading space/ leading space: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057da3_d20251105_m040614_c001_v0001120_t0022_u01762315574214") 2025/11/05 04:07:56 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed63c_d20251105_m040613_c001_v7007000_t0000_u01762315573846") as it is a hide marker 2025/11/05 04:07:56 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d9d_d20251105_m040613_c001_v0001120_t0003_u01762315573196") 2025/11/05 04:07:56 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed66a_d20251105_m040622_c001_v7007000_t0000_u01762315582700") as it is a hide marker 2025/11/05 04:07:56 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : .leading dot/.leading dot: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dd4_d20251105_m040622_c001_v0001120_t0055_u01762315582070") 2025/11/05 04:07:56 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : created from root.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f4116d128e0989834_d20251105_m040721_c001_v7007000_t0000_u01762315641031") as it is a hide marker 2025/11/05 04:07:56 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : created from root.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f11198a6c1f4dd9d3_d20251105_m040719_c001_v0001150_t0042_u01762315639752") 2025/11/05 04:07:56 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : file name.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d2112_d20251105_m040728_c001_v7007000_t0000_u01762315648936") as it is a hide marker 2025/11/05 04:07:56 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057ec5_d20251105_m040708_c001_v0001120_t0038_u01762315628308") 2025/11/05 04:07:56 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f117e1b875f5308ce_d20251105_m040704_c001_v0001137_t0036_u01762315624609") 2025/11/05 04:07:56 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e3d_d20251105_m040642_c001_v0001120_t0019_u01762315602164") 2025/11/05 04:07:56 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e2d_d20251105_m040640_c001_v0001120_t0006_u01762315600935") 2025/11/05 04:07:56 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e37_d20251105_m040641_c001_v0001120_t0036_u01762315601583") "upload" dated 2025-11-05 04:06:41.583 +0000 UTC (1m14.694890431s ago) 2025/11/05 04:07:56 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f4116d128e09897c4_d20251105_m040702_c001_v7007000_t0000_u01762315622409") as it is a hide marker 2025/11/05 04:07:56 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f1085ff892d6e4261_d20251105_m040702_c001_v0001161_t0003_u01762315622047") 2025/11/05 04:07:56 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f105efec774689305_d20251105_m040700_c001_v0001040_t0012_u01762315620967") 2025/11/05 04:07:56 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed696_d20251105_m040631_c001_v7007000_t0000_u01762315591325") as it is a hide marker 2025/11/05 04:07:56 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057df8_d20251105_m040630_c001_v0001120_t0001_u01762315590321") 2025/11/05 04:07:56 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : piped data.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d211d_d20251105_m040730_c001_v7007000_t0000_u01762315650801") as it is a hide marker 2025/11/05 04:07:56 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : piped data.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057f2d_d20251105_m040730_c001_v0001120_t0052_u01762315650206") 2025/11/05 04:07:56 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : piped data.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d2117_d20251105_m040730_c001_v7007000_t0000_u01762315650024") 2025/11/05 04:07:56 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : piped data.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f418036ad05057f27_d20251105_m040729_c001_v0001120_t0048_u01762315649663") 2025/11/05 04:07:56 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed69d_d20251105_m040632_c001_v7007000_t0000_u01762315592735") as it is a hide marker 2025/11/05 04:07:56 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dfe_d20251105_m040631_c001_v0001120_t0030_u01762315591702") 2025/11/05 04:07:56 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : test-metadata: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f409b81d624a0ecca_d20251105_m040738_c001_v7007000_t0000_u01762315658061") as it is a hide marker 2025/11/05 04:07:56 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : test-metadata: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f200b1d56230d2126_d20251105_m040733_c001_v0001182_t0004_u01762315653023") 2025/11/05 04:07:56 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : test-metadata: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d2122_d20251105_m040732_c001_v7007000_t0000_u01762315652095") 2025/11/05 04:07:56 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : test-metadata: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057f31_d20251105_m040730_c001_v0001120_t0045_u01762315650994") 2025/11/05 04:07:56 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed677_d20251105_m040625_c001_v7007000_t0000_u01762315585440") as it is a hide marker 2025/11/05 04:07:56 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dde_d20251105_m040624_c001_v0001120_t0042_u01762315584344") 2025/11/05 04:07:56 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed67f_d20251105_m040627_c001_v7007000_t0000_u01762315587480") as it is a hide marker 2025/11/05 04:07:56 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057de8_d20251105_m040626_c001_v0001120_t0002_u01762315586840") 2025/11/05 04:07:56 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed67a_d20251105_m040626_c001_v7007000_t0000_u01762315586479") as it is a hide marker 2025/11/05 04:07:56 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057de4_d20251105_m040625_c001_v0001120_t0020_u01762315585799") 2025/11/05 04:07:56 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed68a_d20251105_m040628_c001_v7007000_t0000_u01762315588890") as it is a hide marker 2025/11/05 04:07:56 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dec_d20251105_m040627_c001_v0001120_t0014_u01762315587839") 2025/11/05 04:07:56 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed68e_d20251105_m040629_c001_v7007000_t0000_u01762315589963") as it is a hide marker 2025/11/05 04:07:56 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057df4_d20251105_m040629_c001_v0001120_t0054_u01762315589249") 2025/11/05 04:07:56 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing space /trailing space : Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed670_d20251105_m040623_c001_v7007000_t0000_u01762315583979") as it is a hide marker 2025/11/05 04:07:56 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : trailing space /trailing space : Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dda_d20251105_m040623_c001_v0001120_t0037_u01762315583059") 2025/11/05 04:07:56 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f216389f8e2_d20251105_m040749_c001_v0001090_t0009_u01762315669635") "upload" dated 2025-11-05 04:07:49.635 +0000 UTC (6.644639012s ago) 2025/11/05 04:07:56 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f423e001ce84daa26_d20251105_m040744_c001_v7007000_t0000_u01762315664801") 2025/11/05 04:07:56 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057f59_d20251105_m040741_c001_v0001120_t0025_u01762315661650") 2025/11/05 04:07:56 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed6ec_d20251105_m040640_c001_v7007000_t0000_u01762315600381") as it is a hide marker 2025/11/05 04:07:56 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f215cf15e07eed6a4_d20251105_m040634_c001_v0001180_t0005_u01762315594911") 2025/11/05 04:07:56 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : zero-length-file: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed6a3_d20251105_m040634_c001_v7007000_t0000_u01762315594568") as it is a hide marker 2025/11/05 04:07:56 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : zero-length-file: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f418036ad05057e06_d20251105_m040634_c001_v0001120_t0048_u01762315594014") 2025/11/05 04:07:56 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed646_d20251105_m040616_c001_v7007000_t0000_u01762315576237") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057da9_d20251105_m040615_c001_v0001120_t0044_u01762315575357") 2025/11/05 04:07:56 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed632_d20251105_m040610_c001_v7007000_t0000_u01762315570673") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d85_d20251105_m040609_c001_v0001120_t0055_u01762315569585") 2025/11/05 04:07:56 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed663_d20251105_m040620_c001_v7007000_t0000_u01762315580566") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dbc_d20251105_m040619_c001_v0001120_t0015_u01762315579166") 2025/11/05 04:07:56 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed65a_d20251105_m040618_c001_v7007000_t0000_u01762315578805") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057db2_d20251105_m040617_c001_v0001120_t0044_u01762315577712") 2025/11/05 04:07:56 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed669_d20251105_m040621_c001_v7007000_t0000_u01762315581710") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dca_d20251105_m040620_c001_v0001120_t0035_u01762315580928") 2025/11/05 04:07:56 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed64e_d20251105_m040617_c001_v7007000_t0000_u01762315577353") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057db0_d20251105_m040616_c001_v0001120_t0046_u01762315576595") 2025/11/05 04:07:56 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ．/．: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed636_d20251105_m040611_c001_v7007000_t0000_u01762315571724") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ．/．: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ．/．: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d93_d20251105_m040611_c001_v0001120_t0028_u01762315571031") 2025/11/05 04:07:56 NOTICE: ．/．: Skipped delete as --dry-run is set 2025/11/05 04:07:56 DEBUG : ．．/．．: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed637_d20251105_m040612_c001_v7007000_t0000_u01762315572836") as it is a hide marker 2025/11/05 04:07:56 NOTICE: ．．/．．: Skipped remove hide marker as --dry-run is set 2025/11/05 04:07:56 DEBUG : ．．/．．: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d99_d20251105_m040612_c001_v0001120_t0050_u01762315572083") 2025/11/05 04:07:56 NOTICE: ．．/．．: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/11/05 04:07:56 INFO : B2 bucket rclone-test-gogojol2doha: cleaning bucket "rclone-test-gogojol2doha" of all hidden files 2025/11/05 04:07:56 DEBUG : leading space/ leading space: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed641_d20251105_m040614_c001_v7007000_t0000_u01762315574998") as it is a hide marker 2025/11/05 04:07:56 DEBUG : leading space/ leading space: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057da3_d20251105_m040614_c001_v0001120_t0022_u01762315574214") 2025/11/05 04:07:56 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed63c_d20251105_m040613_c001_v7007000_t0000_u01762315573846") as it is a hide marker 2025/11/05 04:07:56 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d9d_d20251105_m040613_c001_v0001120_t0003_u01762315573196") 2025/11/05 04:07:56 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed66a_d20251105_m040622_c001_v7007000_t0000_u01762315582700") as it is a hide marker 2025/11/05 04:07:56 DEBUG : .leading dot/.leading dot: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dd4_d20251105_m040622_c001_v0001120_t0055_u01762315582070") 2025/11/05 04:07:56 DEBUG : created from root.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f4116d128e0989834_d20251105_m040721_c001_v7007000_t0000_u01762315641031") as it is a hide marker 2025/11/05 04:07:56 DEBUG : created from root.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f11198a6c1f4dd9d3_d20251105_m040719_c001_v0001150_t0042_u01762315639752") 2025/11/05 04:07:56 DEBUG : file name.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d2112_d20251105_m040728_c001_v7007000_t0000_u01762315648936") as it is a hide marker 2025/11/05 04:07:56 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057ec5_d20251105_m040708_c001_v0001120_t0038_u01762315628308") 2025/11/05 04:07:57 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f117e1b875f5308ce_d20251105_m040704_c001_v0001137_t0036_u01762315624609") 2025/11/05 04:07:57 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e3d_d20251105_m040642_c001_v0001120_t0019_u01762315602164") 2025/11/05 04:07:57 DEBUG : file name.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e2d_d20251105_m040640_c001_v0001120_t0006_u01762315600935") 2025/11/05 04:07:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e37_d20251105_m040641_c001_v0001120_t0036_u01762315601583") "upload" dated 2025-11-05 04:06:41.583 +0000 UTC (1m15.712086665s ago) 2025/11/05 04:07:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f4116d128e09897c4_d20251105_m040702_c001_v7007000_t0000_u01762315622409") as it is a hide marker 2025/11/05 04:07:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f1085ff892d6e4261_d20251105_m040702_c001_v0001161_t0003_u01762315622047") 2025/11/05 04:07:57 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f105efec774689305_d20251105_m040700_c001_v0001040_t0012_u01762315620967") 2025/11/05 04:07:57 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed696_d20251105_m040631_c001_v7007000_t0000_u01762315591325") as it is a hide marker 2025/11/05 04:07:57 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057df8_d20251105_m040630_c001_v0001120_t0001_u01762315590321") 2025/11/05 04:07:57 DEBUG : piped data.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d211d_d20251105_m040730_c001_v7007000_t0000_u01762315650801") as it is a hide marker 2025/11/05 04:07:57 DEBUG : piped data.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057f2d_d20251105_m040730_c001_v0001120_t0052_u01762315650206") 2025/11/05 04:07:57 DEBUG : piped data.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d2117_d20251105_m040730_c001_v7007000_t0000_u01762315650024") 2025/11/05 04:07:57 DEBUG : piped data.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f418036ad05057f27_d20251105_m040729_c001_v0001120_t0048_u01762315649663") 2025/11/05 04:07:57 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed69d_d20251105_m040632_c001_v7007000_t0000_u01762315592735") as it is a hide marker 2025/11/05 04:07:57 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dfe_d20251105_m040631_c001_v0001120_t0030_u01762315591702") 2025/11/05 04:07:57 DEBUG : test-metadata: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f409b81d624a0ecca_d20251105_m040738_c001_v7007000_t0000_u01762315658061") as it is a hide marker 2025/11/05 04:07:57 DEBUG : test-metadata: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f200b1d56230d2126_d20251105_m040733_c001_v0001182_t0004_u01762315653023") 2025/11/05 04:07:57 DEBUG : test-metadata: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f400b1d56230d2122_d20251105_m040732_c001_v7007000_t0000_u01762315652095") 2025/11/05 04:07:58 DEBUG : test-metadata: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057f31_d20251105_m040730_c001_v0001120_t0045_u01762315650994") 2025/11/05 04:07:58 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed677_d20251105_m040625_c001_v7007000_t0000_u01762315585440") as it is a hide marker 2025/11/05 04:07:58 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dde_d20251105_m040624_c001_v0001120_t0042_u01762315584344") 2025/11/05 04:07:58 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed67f_d20251105_m040627_c001_v7007000_t0000_u01762315587480") as it is a hide marker 2025/11/05 04:07:58 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057de8_d20251105_m040626_c001_v0001120_t0002_u01762315586840") 2025/11/05 04:07:58 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed67a_d20251105_m040626_c001_v7007000_t0000_u01762315586479") as it is a hide marker 2025/11/05 04:07:58 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057de4_d20251105_m040625_c001_v0001120_t0020_u01762315585799") 2025/11/05 04:07:58 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed68a_d20251105_m040628_c001_v7007000_t0000_u01762315588890") as it is a hide marker 2025/11/05 04:07:58 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dec_d20251105_m040627_c001_v0001120_t0014_u01762315587839") 2025/11/05 04:07:58 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed68e_d20251105_m040629_c001_v7007000_t0000_u01762315589963") as it is a hide marker 2025/11/05 04:07:58 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057df4_d20251105_m040629_c001_v0001120_t0054_u01762315589249") 2025/11/05 04:07:58 DEBUG : trailing space /trailing space : Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed670_d20251105_m040623_c001_v7007000_t0000_u01762315583979") as it is a hide marker 2025/11/05 04:07:58 DEBUG : trailing space /trailing space : Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dda_d20251105_m040623_c001_v0001120_t0037_u01762315583059") 2025/11/05 04:07:58 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f216389f8e2_d20251105_m040749_c001_v0001090_t0009_u01762315669635") "upload" dated 2025-11-05 04:07:49.635 +0000 UTC (8.973403363s ago) 2025/11/05 04:07:58 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f423e001ce84daa26_d20251105_m040744_c001_v7007000_t0000_u01762315664801") 2025/11/05 04:07:58 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057f59_d20251105_m040741_c001_v0001120_t0025_u01762315661650") 2025/11/05 04:07:58 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed6ec_d20251105_m040640_c001_v7007000_t0000_u01762315600381") as it is a hide marker 2025/11/05 04:07:58 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f215cf15e07eed6a4_d20251105_m040634_c001_v0001180_t0005_u01762315594911") 2025/11/05 04:07:58 DEBUG : zero-length-file: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed6a3_d20251105_m040634_c001_v7007000_t0000_u01762315594568") as it is a hide marker 2025/11/05 04:07:58 DEBUG : zero-length-file: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f418036ad05057e06_d20251105_m040634_c001_v0001120_t0048_u01762315594014") 2025/11/05 04:07:58 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed646_d20251105_m040616_c001_v7007000_t0000_u01762315576237") as it is a hide marker 2025/11/05 04:07:58 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057da9_d20251105_m040615_c001_v0001120_t0044_u01762315575357") 2025/11/05 04:07:58 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed632_d20251105_m040610_c001_v7007000_t0000_u01762315570673") as it is a hide marker 2025/11/05 04:07:59 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d85_d20251105_m040609_c001_v0001120_t0055_u01762315569585") 2025/11/05 04:07:59 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed663_d20251105_m040620_c001_v7007000_t0000_u01762315580566") as it is a hide marker 2025/11/05 04:07:59 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dbc_d20251105_m040619_c001_v0001120_t0015_u01762315579166") 2025/11/05 04:07:59 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed65a_d20251105_m040618_c001_v7007000_t0000_u01762315578805") as it is a hide marker 2025/11/05 04:07:59 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057db2_d20251105_m040617_c001_v0001120_t0044_u01762315577712") 2025/11/05 04:07:59 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed669_d20251105_m040621_c001_v7007000_t0000_u01762315581710") as it is a hide marker 2025/11/05 04:07:59 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057dca_d20251105_m040620_c001_v0001120_t0035_u01762315580928") 2025/11/05 04:07:59 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed64e_d20251105_m040617_c001_v7007000_t0000_u01762315577353") as it is a hide marker 2025/11/05 04:07:59 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057db0_d20251105_m040616_c001_v0001120_t0046_u01762315576595") 2025/11/05 04:07:59 DEBUG : ．/．: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed636_d20251105_m040611_c001_v7007000_t0000_u01762315571724") as it is a hide marker 2025/11/05 04:07:59 DEBUG : ．/．: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d93_d20251105_m040611_c001_v0001120_t0028_u01762315571031") 2025/11/05 04:07:59 DEBUG : ．．/．．: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eed637_d20251105_m040612_c001_v7007000_t0000_u01762315572836") as it is a hide marker 2025/11/05 04:07:59 DEBUG : ．．/．．: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057d99_d20251105_m040612_c001_v0001120_t0050_u01762315572083") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/11/05 04:08:00 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/11/05 04:08:00 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/11/05 04:08:00 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/11/05 04:08:00 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/11/05 04:08:01 INFO : B2 bucket rclone-test-gogojol2doha: cleaning bucket "rclone-test-gogojol2doha" of pending multipart uploads older than 0s 2025/11/05 04:08:01 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e37_d20251105_m040641_c001_v0001120_t0036_u01762315601583") "upload" dated 2025-11-05 04:06:41.583 +0000 UTC (1m19.847491732s ago) 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f80447067e_d20251105_m040800_c001_v0001172_t0000_u01762315680402") as it is a start marker (upload started at 2025-11-05 04:08:00.402 +0000 UTC) 2025/11/05 04:08:01 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f80447067f_d20251105_m040800_c001_v0001178_t0049_u01762315680585") as it is a start marker (upload started at 2025-11-05 04:08:00.585 +0000 UTC) 2025/11/05 04:08:01 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f804470681_d20251105_m040800_c001_v0001178_t0022_u01762315680768") as it is a start marker (upload started at 2025-11-05 04:08:00.768 +0000 UTC) 2025/11/05 04:08:01 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f804470682_d20251105_m040800_c001_v0001101_t0038_u01762315680960") as it is a start marker (upload started at 2025-11-05 04:08:00.96 +0000 UTC) 2025/11/05 04:08:01 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/11/05 04:08:01 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f419682f80447067c_d20251105_m040800_c001_v7007000_t0000_u01762315680221") "hide" dated 2025-11-05 04:08:00.221 +0000 UTC (1.209715972s ago) 2025/11/05 04:08:01 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f216389f8e2_d20251105_m040749_c001_v0001090_t0009_u01762315669635") 2025/11/05 04:08:01 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/11/05 04:08:01 INFO : B2 bucket rclone-test-gogojol2doha: cleaning bucket "rclone-test-gogojol2doha" of pending multipart uploads older than 0s 2025/11/05 04:08:01 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e37_d20251105_m040641_c001_v0001120_t0036_u01762315601583") "upload" dated 2025-11-05 04:06:41.583 +0000 UTC (1m20.217408593s ago) 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f80447067e_d20251105_m040800_c001_v0001172_t0000_u01762315680402") as it is a start marker (upload started at 2025-11-05 04:08:00.402 +0000 UTC) 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f80447067f_d20251105_m040800_c001_v0001178_t0049_u01762315680585") as it is a start marker (upload started at 2025-11-05 04:08:00.585 +0000 UTC) 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f804470681_d20251105_m040800_c001_v0001178_t0022_u01762315680768") as it is a start marker (upload started at 2025-11-05 04:08:00.768 +0000 UTC) 2025/11/05 04:08:01 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f804470682_d20251105_m040800_c001_v0001101_t0038_u01762315680960") as it is a start marker (upload started at 2025-11-05 04:08:00.96 +0000 UTC) 2025/11/05 04:08:01 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff27df3301d5b2b9fa80e1b_f419682f80447067c_d20251105_m040800_c001_v7007000_t0000_u01762315680221") "hide" dated 2025-11-05 04:08:00.221 +0000 UTC (1.579788135s ago) 2025/11/05 04:08:01 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f216389f8e2_d20251105_m040749_c001_v0001090_t0009_u01762315669635") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/11/05 04:08:02 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/11/05 04:08:02 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/11/05 04:08:02 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/11/05 04:08:04 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/11/05 04:08:04 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/11/05 04:08:04 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/11/05 04:08:04 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/11/05 04:08:05 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/11/05 04:08:06 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/11/05 04:08:06 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/11/05 04:08:09 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:08:09 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/11/05 04:08:09 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f80447070b_d20251105_m040809_c001_v0001184_t0000_u01762315689810") 2025/11/05 04:08:09 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:08:09 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/05 04:08:09 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/05 04:08:10 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:08:12 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:08:12 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/11/05 04:08:13 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/11/05 04:08:13 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/11/05 04:08:13 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/11/05 04:08:13 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/11/05 04:08:15 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/11/05 04:08:15 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/11/05 04:08:15 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/11/05 04:08:17 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:08:17 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/11/05 04:08:17 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f21673bf139e2bb04_d20251105_m040817_c001_v0001040_t0043_u01762315697727") 2025/11/05 04:08:17 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/05 04:08:18 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/05 04:08:18 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/11/05 04:08:20 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:08:21 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:08:21 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/11/05 04:08:23 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/11/05 04:08:23 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/11/05 04:08:23 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/11/05 04:08:23 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/11/05 04:08:23 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/11/05 04:08:23 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/11/05 04:08:24 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/11/05 04:08:25 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/11/05 04:08:25 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/11/05 04:08:25 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/11/05 04:08:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:08:27 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/11/05 04:08:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f220343d706a36342_d20251105_m040827_c001_v0001177_t0059_u01762315707643") 2025/11/05 04:08:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/05 04:08:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:08:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/05 04:08:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/11/05 04:08:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/11/05 04:08:29 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:08:30 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:08:30 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/11/05 04:08:32 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/11/05 04:08:32 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/11/05 04:08:32 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/11/05 04:08:32 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/11/05 04:08:32 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/11/05 04:08:34 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/11/05 04:08:34 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/11/05 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:08:35 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/11/05 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f220343d706a36361_d20251105_m040835_c001_v0001181_t0002_u01762315715715") 2025/11/05 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/11/05 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/05 04:08:36 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:08:38 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:08:38 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/11/05 04:08:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/11/05 04:08:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/11/05 04:08:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/11/05 04:08:39 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/11/05 04:08:42 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/11/05 04:08:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/11/05 04:08:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/11/05 04:08:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:08:50 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/11/05 04:08:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2a5b_d20251105_m040851_c001_v0001117_t0052_u01762315731081") 2025/11/05 04:08:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/05 04:08:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/11/05 04:08:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/05 04:08:54 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:08:54 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:08:54 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/11/05 04:08:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/11/05 04:08:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/11/05 04:08:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/11/05 04:08:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/11/05 04:08:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/11/05 04:08:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/11/05 04:08:57 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/11/05 04:08:58 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/11/05 04:08:58 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/11/05 04:08:58 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/11/05 04:09:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:09:00 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/11/05 04:09:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f215cf15e07eedc8f_d20251105_m040900_c001_v0001105_t0054_u01762315740437") 2025/11/05 04:09:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/05 04:09:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:09:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/11/05 04:09:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/11/05 04:09:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/11/05 04:09:03 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:09:03 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:09:03 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/11/05 04:09:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/11/05 04:09:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:09:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/11/05 04:09:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:14:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Post "https://pod-000-1098-14.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0032": net/http: timeout awaiting response headers: &url.Error{Op:"Post", URL:"https://pod-000-1098-14.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0032", Err:(*http.timeoutError)(0xff5590)} 2025/11/05 04:14:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Post "https://pod-000-1098-14.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0032": net/http: timeout awaiting response headers 2025/11/05 04:14:05 DEBUG : pacer: low level retry 1/10 (error Post "https://pod-000-1098-14.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0032": net/http: timeout awaiting response headers) 2025/11/05 04:14:05 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/05 04:14:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:14:06 DEBUG : pacer: Reducing sleep to 10ms 2025/11/05 04:14:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Post "https://pod-000-1098-09.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0015": write tcp 65.108.87.141:47550->206.190.209.40:443: i/o timeout: &url.Error{Op:"Post", URL:"https://pod-000-1098-09.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0015", Err:(*tls.permanentError)(0xc0009742f0)} 2025/11/05 04:14:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Post "https://pod-000-1098-09.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0015": write tcp 65.108.87.141:47550->206.190.209.40:443: i/o timeout 2025/11/05 04:14:06 DEBUG : pacer: low level retry 1/10 (error Post "https://pod-000-1098-09.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0015": write tcp 65.108.87.141:47550->206.190.209.40:443: i/o timeout) 2025/11/05 04:14:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/05 04:14:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:14:07 DEBUG : pacer: Reducing sleep to 10ms 2025/11/05 04:19:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Post "https://pod-000-1098-05.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0043": net/http: timeout awaiting response headers: &url.Error{Op:"Post", URL:"https://pod-000-1098-05.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0043", Err:(*http.timeoutError)(0xff5590)} 2025/11/05 04:19:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Post "https://pod-000-1098-05.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0043": net/http: timeout awaiting response headers 2025/11/05 04:19:06 DEBUG : pacer: low level retry 2/10 (error Post "https://pod-000-1098-05.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0043": net/http: timeout awaiting response headers) 2025/11/05 04:19:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/05 04:19:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:07 DEBUG : pacer: Reducing sleep to 10ms 2025/11/05 04:19:07 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00029f620), retryAfter:1000000000} 2025/11/05 04:19:07 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:07 DEBUG : pacer: low level retry 3/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:07 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:07 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:08 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Post "https://pod-000-1098-12.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0006": write tcp 65.108.87.141:45744->206.190.209.43:443: i/o timeout: &url.Error{Op:"Post", URL:"https://pod-000-1098-12.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0006", Err:(*tls.permanentError)(0xc0008321b0)} 2025/11/05 04:19:08 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Post "https://pod-000-1098-12.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0006": write tcp 65.108.87.141:45744->206.190.209.43:443: i/o timeout 2025/11/05 04:19:08 DEBUG : pacer: low level retry 2/10 (error Post "https://pod-000-1098-12.backblaze.com/b2api/v1/b2_upload_part/4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2ab8_d20251105_m040904_c001_v0001098_t0030_u01762315744781/0006": write tcp 65.108.87.141:45744->206.190.209.43:443: i/o timeout) 2025/11/05 04:19:08 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/11/05 04:19:08 DEBUG : pacer: Reducing sleep to 1s 2025/11/05 04:19:09 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0012588d0), retryAfter:1000000000} 2025/11/05 04:19:09 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:09 DEBUG : pacer: low level retry 4/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:10 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:11 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:12 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:13 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000478060), retryAfter:1000000000} 2025/11/05 04:19:13 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:13 DEBUG : pacer: low level retry 3/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:13 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:13 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:14 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000478960), retryAfter:1000000000} 2025/11/05 04:19:14 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:14 DEBUG : pacer: low level retry 5/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:14 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:14 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:15 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:16 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:17 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc001259860), retryAfter:1000000000} 2025/11/05 04:19:17 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:17 DEBUG : pacer: low level retry 4/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:17 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:17 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:18 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0004791d0), retryAfter:1000000000} 2025/11/05 04:19:18 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:18 DEBUG : pacer: low level retry 6/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:18 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:18 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:19 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:20 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:21 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0002d89c0), retryAfter:1000000000} 2025/11/05 04:19:21 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:21 DEBUG : pacer: low level retry 5/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:21 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:21 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:22 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0004799e0), retryAfter:1000000000} 2025/11/05 04:19:22 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:22 DEBUG : pacer: low level retry 7/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:22 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:22 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:23 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:24 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0002d9050), retryAfter:1000000000} 2025/11/05 04:19:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:25 DEBUG : pacer: low level retry 6/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:25 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:25 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:26 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00037a9c0), retryAfter:1000000000} 2025/11/05 04:19:26 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:26 DEBUG : pacer: low level retry 8/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:26 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:26 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:28 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:29 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0003473e0), retryAfter:1000000000} 2025/11/05 04:19:29 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:29 DEBUG : pacer: low level retry 7/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:29 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:29 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:30 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00037b8f0), retryAfter:1000000000} 2025/11/05 04:19:30 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:30 DEBUG : pacer: low level retry 9/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:30 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:30 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:31 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:32 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:33 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000340000), retryAfter:1000000000} 2025/11/05 04:19:33 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:33 DEBUG : pacer: low level retry 8/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:33 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:33 DEBUG : pacer: Reducing sleep to 500ms 2025/11/05 04:19:34 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1 (retry=true): Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000340f60), retryAfter:1000000000} 2025/11/05 04:19:34 DEBUG : chunked-5.055Mi-5.055Mi.bin: Clearing part upload URL because of error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:34 DEBUG : pacer: low level retry 10/10 (error Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s) 2025/11/05 04:19:34 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/05 04:19:34 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 1: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:34 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:35 DEBUG : chunked-5.055Mi-5.055Mi.bin: Error sending chunk 0: failed to get upload URL: Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s 2025/11/05 04:19:35 DEBUG : chunked-5.055Mi-5.055Mi.bin: Cancelling multipart upload 2025/11/05 04:19:35 DEBUG : chunked-5.055Mi-5.055Mi.bin: Cancelling large file upload 2025/11/05 04:19:36 DEBUG : pacer: Reducing sleep to 500ms fstests.go:143: PutLarge error: Service temporarily unavailable, please try again. (503 service_unavailable): trying again in 1s - low level retry 1/10 2025/11/05 04:19:39 DEBUG : pacer: Reducing sleep to 250ms 2025/11/05 04:19:39 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/11/05 04:19:39 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/11/05 04:19:39 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/05 04:19:39 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:40 DEBUG : pacer: Reducing sleep to 125ms 2025/11/05 04:19:40 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/05 04:19:40 DEBUG : pacer: Reducing sleep to 31.25ms 2025/11/05 04:19:40 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/11/05 04:19:42 DEBUG : pacer: Reducing sleep to 15.625ms 2025/11/05 04:19:42 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/11/05 04:19:42 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts 2025/11/05 04:19:42 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/11/05 04:19:45 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:19:45 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/11/05 04:19:45 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f2222faa0dd753606_d20251105_m041945_c001_v0001182_t0000_u01762316385457") 2025/11/05 04:19:45 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:19:45 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/11/05 04:19:45 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:46 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:19:47 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:19:47 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/11/05 04:19:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/11/05 04:19:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/11/05 04:19:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/11/05 04:19:51 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/11/05 04:19:51 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/11/05 04:19:51 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/11/05 04:19:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:19:53 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/11/05 04:19:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbc06_d20251105_m041953_c001_v0001038_t0032_u01762316393597") 2025/11/05 04:19:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/05 04:19:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/11/05 04:19:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:19:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:19:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/11/05 04:19:58 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/11/05 04:19:58 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/11/05 04:19:58 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/11/05 04:19:58 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/11/05 04:19:58 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/11/05 04:19:58 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/11/05 04:19:59 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/11/05 04:20:00 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/11/05 04:20:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/11/05 04:20:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/11/05 04:20:02 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:20:02 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/11/05 04:20:02 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f20407664aa0d738b_d20251105_m042002_c001_v0001177_t0035_u01762316402755") 2025/11/05 04:20:02 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/05 04:20:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:20:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/11/05 04:20:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/11/05 04:20:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/11/05 04:20:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:20:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:20:05 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/11/05 04:20:07 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/11/05 04:20:07 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/11/05 04:20:07 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/11/05 04:20:07 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/11/05 04:20:08 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/11/05 04:20:09 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/11/05 04:20:09 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/11/05 04:20:11 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:20:11 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/11/05 04:20:11 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f20407664aa0d7394_d20251105_m042011_c001_v0001130_t0022_u01762316411193") 2025/11/05 04:20:11 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:20:11 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/11/05 04:20:11 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/05 04:20:12 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:20:13 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:20:13 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/11/05 04:20:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/11/05 04:20:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/11/05 04:20:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/11/05 04:20:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/11/05 04:20:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/11/05 04:20:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/11/05 04:20:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/11/05 04:20:19 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:20:19 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/11/05 04:20:20 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbcc5_d20251105_m042019_c001_v0001184_t0048_u01762316419990") 2025/11/05 04:20:20 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/05 04:20:20 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/05 04:20:20 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/11/05 04:20:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:20:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:20:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/11/05 04:20:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/11/05 04:20:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/11/05 04:20:25 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/11/05 04:20:25 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/11/05 04:20:25 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/11/05 04:20:25 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/11/05 04:20:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/11/05 04:20:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/11/05 04:20:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/11/05 04:20:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/11/05 04:20:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:20:29 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/11/05 04:20:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f219b66f47bb9e1ca_d20251105_m042029_c001_v0001100_t0003_u01762316429415") 2025/11/05 04:20:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/05 04:20:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:20:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/11/05 04:20:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/11/05 04:20:30 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/11/05 04:20:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:20:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:20:32 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/11/05 04:20:34 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/11/05 04:20:34 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/11/05 04:20:34 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/11/05 04:20:34 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/11/05 04:20:35 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/11/05 04:20:36 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/11/05 04:20:36 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/11/05 04:20:38 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:20:38 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/11/05 04:20:38 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f219b66f47bb9e2d4_d20251105_m042038_c001_v0001153_t0013_u01762316438594") 2025/11/05 04:20:38 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:20:38 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/05 04:20:38 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/05 04:20:39 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:20:41 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:20:41 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/11/05 04:20:43 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/11/05 04:20:43 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/11/05 04:20:43 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/11/05 04:20:43 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/11/05 04:20:45 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/11/05 04:20:45 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/11/05 04:20:45 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/11/05 04:20:48 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:20:48 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/11/05 04:20:48 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbe3e_d20251105_m042048_c001_v0001145_t0057_u01762316448107") 2025/11/05 04:20:48 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/05 04:20:48 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/05 04:20:48 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/11/05 04:20:51 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:20:51 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:20:51 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/11/05 04:20:53 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/11/05 04:20:53 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/11/05 04:20:53 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/11/05 04:20:53 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/11/05 04:20:53 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/11/05 04:20:53 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/11/05 04:20:55 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/11/05 04:20:56 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/11/05 04:20:56 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/11/05 04:20:56 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/11/05 04:20:58 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:20:58 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/11/05 04:20:59 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f22167a6f23f62d46_d20251105_m042059_c001_v0001176_t0028_u01762316459013") 2025/11/05 04:20:59 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/05 04:20:59 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:20:59 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/05 04:20:59 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/11/05 04:21:00 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/11/05 04:21:01 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:21:02 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:21:02 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/11/05 04:21:04 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/11/05 04:21:04 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/11/05 04:21:04 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/11/05 04:21:04 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/11/05 04:21:05 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/11/05 04:21:07 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/11/05 04:21:07 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/11/05 04:21:09 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:21:09 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/11/05 04:21:09 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e721d61_d20251105_m042109_c001_v0001115_t0022_u01762316469549") 2025/11/05 04:21:09 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:21:09 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/05 04:21:09 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/05 04:21:10 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:21:12 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:21:12 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/11/05 04:21:14 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/11/05 04:21:14 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/11/05 04:21:15 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/11/05 04:21:15 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/11/05 04:21:17 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/11/05 04:21:18 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/11/05 04:21:18 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/11/05 04:21:20 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:21:20 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/11/05 04:21:20 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e721d8f_d20251105_m042120_c001_v0001181_t0053_u01762316480838") 2025/11/05 04:21:20 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/05 04:21:21 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/05 04:21:21 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/11/05 04:21:23 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:21:23 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:21:23 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/11/05 04:21:26 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/11/05 04:21:26 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/11/05 04:21:27 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/11/05 04:21:27 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/11/05 04:21:27 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/11/05 04:21:27 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/11/05 04:21:28 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/11/05 04:21:29 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/11/05 04:21:29 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/11/05 04:21:29 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/11/05 04:21:32 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/05 04:21:32 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/11/05 04:21:32 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff27df3301d5b2b9fa80e1b_f22167a6f23f62eea_d20251105_m042132_c001_v0001042_t0033_u01762316492328") 2025/11/05 04:21:32 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/05 04:21:32 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/05 04:21:32 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/05 04:21:32 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/11/05 04:21:34 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/11/05 04:21:35 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/11/05 04:21:35 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/11/05 04:21:35 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/11/05 04:21:44 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e722023_d20251105_m042144_c001_v0001182_t0006_u01762316504408") 2025/11/05 04:21:44 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/11/05 04:21:44 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/05 04:21:44 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/05 04:21:45 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/05 04:21:45 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/11/05 04:21:47 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/11/05 04:21:47 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/05 04:21:47 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/11/05 04:21:47 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/11/05 04:21:49 DEBUG : chunked-copy: Done sending chunk 0 2025/11/05 04:21:50 DEBUG : chunked-copy: Done sending chunk 1 2025/11/05 04:21:50 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/05 04:21:51 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fc114_d20251105_m042150_c001_v0001178_t0018_u01762316510959") 2025/11/05 04:21:51 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/11/05 04:21:51 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/05 04:21:51 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/05 04:21:51 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/05 04:21:51 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/11/05 04:21:53 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/11/05 04:21:53 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/05 04:21:53 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/11/05 04:21:53 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/11/05 04:21:55 DEBUG : chunked-copy: Done sending chunk 0 2025/11/05 04:21:56 DEBUG : chunked-copy: Done sending chunk 1 2025/11/05 04:21:56 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/05 04:21:56 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e722078_d20251105_m042156_c001_v0001116_t0028_u01762316516796") 2025/11/05 04:21:56 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/11/05 04:21:56 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/05 04:21:57 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/05 04:21:57 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/05 04:21:57 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/11/05 04:21:59 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/11/05 04:21:59 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/05 04:22:00 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/11/05 04:22:00 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/11/05 04:22:02 DEBUG : chunked-copy: Done sending chunk 0 2025/11/05 04:22:02 DEBUG : chunked-copy: Done sending chunk 1 2025/11/05 04:22:02 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/05 04:22:03 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e72208d_d20251105_m042202_c001_v0001032_t0058_u01762316522923") 2025/11/05 04:22:03 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/11/05 04:22:03 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/05 04:22:03 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/11/05 04:22:03 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/11/05 04:22:03 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/05 04:22:07 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/05 04:22:07 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/11/05 04:22:08 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/05 04:22:10 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/05 04:22:11 DEBUG : Creating backend with remote "TestB2:rclone-test-gogojol2doha/deeper/nonexisting/directory" 2025/11/05 04:22:11 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/11/05 04:22:12 INFO : B2 bucket rclone-test-gogojol2doha: cleaning bucket "rclone-test-gogojol2doha" of all files 2025/11/05 04:22:12 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721d6f_d20251105_m042114_c001_v7007000_t0000_u01762316474307") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e721d61_d20251105_m042109_c001_v0001115_t0022_u01762316469549") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721d60_d20251105_m042108_c001_v7007000_t0000_u01762316468968") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e721d49_d20251105_m042104_c001_v0001099_t0030_u01762316464385") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721f8e_d20251105_m042137_c001_v7007000_t0000_u01762316497899") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f22167a6f23f62eea_d20251105_m042132_c001_v0001042_t0033_u01762316492328") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f42167a6f23f62ee2_d20251105_m042131_c001_v7007000_t0000_u01762316491769") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e721e2d_d20251105_m042126_c001_v0001130_t0038_u01762316486117") 2025/11/05 04:22:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721e26_d20251105_m042125_c001_v7007000_t0000_u01762316485936") 2025/11/05 04:22:13 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e721d8f_d20251105_m042120_c001_v0001181_t0053_u01762316480838") 2025/11/05 04:22:13 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721d88_d20251105_m042120_c001_v7007000_t0000_u01762316480223") 2025/11/05 04:22:13 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e721d73_d20251105_m042114_c001_v0001041_t0055_u01762316474490") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f405b1c37b5bf2ab5_d20251105_m040904_c001_v7007000_t0000_u01762315744597") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f215cf15e07eedc8f_d20251105_m040900_c001_v0001105_t0054_u01762315740437") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f405b1c37b5bf2a67_d20251105_m040855_c001_v7007000_t0000_u01762315735722") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2a5b_d20251105_m040851_c001_v0001117_t0052_u01762315731081") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f415cf15e07eedc8d_d20251105_m040900_c001_v7007000_t0000_u01762315740013") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f205b1c37b5bf2a68_d20251105_m040855_c001_v0001178_t0028_u01762315735905") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f405b1c37b5bf2a57_d20251105_m040850_c001_v7007000_t0000_u01762315730655") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21673bf139e2bba7_d20251105_m040839_c001_v0001120_t0055_u01762315719187") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41673bf139e2bba6_d20251105_m040839_c001_v7007000_t0000_u01762315719004") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f220343d706a36361_d20251105_m040835_c001_v0001181_t0002_u01762315715715") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f420343d706a3635e_d20251105_m040835_c001_v7007000_t0000_u01762315715324") 2025/11/05 04:22:13 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21673bf139e2bb86_d20251105_m040831_c001_v0001153_t0011_u01762315711672") 2025/11/05 04:22:13 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbc49_d20251105_m042006_c001_v7007000_t0000_u01762316406554") 2025/11/05 04:22:13 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f20407664aa0d738b_d20251105_m042002_c001_v0001177_t0035_u01762316402755") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbc13_d20251105_m041957_c001_v7007000_t0000_u01762316397859") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbc06_d20251105_m041953_c001_v0001038_t0032_u01762316393597") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f40407664aa0d7389_d20251105_m042002_c001_v7007000_t0000_u01762316402365") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbc15_d20251105_m041958_c001_v0001153_t0023_u01762316398045") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbc00_d20251105_m041953_c001_v7007000_t0000_u01762316393176") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbbf3_d20251105_m041949_c001_v0001183_t0025_u01762316389167") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbbf2_d20251105_m041948_c001_v7007000_t0000_u01762316388986") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f2222faa0dd753606_d20251105_m041945_c001_v0001182_t0000_u01762316385457") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f4222faa0dd753602_d20251105_m041945_c001_v7007000_t0000_u01762316385090") 2025/11/05 04:22:14 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f2222faa0dd7535eb_d20251105_m041938_c001_v0001109_t0051_u01762316378995") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41673bf139e2bb82_d20251105_m040831_c001_v7007000_t0000_u01762315711489") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f220343d706a36342_d20251105_m040827_c001_v0001177_t0059_u01762315707643") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f420343d706a36340_d20251105_m040827_c001_v7007000_t0000_u01762315707227") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21673bf139e2bb24_d20251105_m040822_c001_v0001099_t0016_u01762315702810") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41673bf139e2bb23_d20251105_m040822_c001_v7007000_t0000_u01762315702626") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21673bf139e2bb04_d20251105_m040817_c001_v0001040_t0043_u01762315697727") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41673bf139e2bb03_d20251105_m040817_c001_v7007000_t0000_u01762315697311") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21673bf139e2bae2_d20251105_m040813_c001_v0001179_t0040_u01762315693295") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41673bf139e2bae1_d20251105_m040813_c001_v7007000_t0000_u01762315693112") 2025/11/05 04:22:14 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f80447070b_d20251105_m040809_c001_v0001184_t0000_u01762315689810") 2025/11/05 04:22:15 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419682f804470700_d20251105_m040809_c001_v7007000_t0000_u01762315689423") 2025/11/05 04:22:15 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f219682f804470694_d20251105_m040803_c001_v0001134_t0029_u01762315683936") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbd8b_d20251105_m042033_c001_v7007000_t0000_u01762316433848") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f219b66f47bb9e1ca_d20251105_m042029_c001_v0001100_t0003_u01762316429415") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbd0c_d20251105_m042024_c001_v7007000_t0000_u01762316424251") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbcc5_d20251105_m042019_c001_v0001184_t0048_u01762316419990") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419b66f47bb9e1b0_d20251105_m042028_c001_v7007000_t0000_u01762316428944") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbd11_d20251105_m042024_c001_v0001181_t0018_u01762316424432") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbcc4_d20251105_m042019_c001_v7007000_t0000_u01762316419517") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbcb3_d20251105_m042015_c001_v0001184_t0050_u01762316415046") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbcb1_d20251105_m042014_c001_v7007000_t0000_u01762316414865") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f20407664aa0d7394_d20251105_m042011_c001_v0001130_t0022_u01762316411193") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f40407664aa0d7392_d20251105_m042010_c001_v7007000_t0000_u01762316410640") 2025/11/05 04:22:15 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbc4d_d20251105_m042006_c001_v0001180_t0020_u01762316406736") 2025/11/05 04:22:15 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721d47_d20251105_m042104_c001_v7007000_t0000_u01762316464204") 2025/11/05 04:22:15 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f22167a6f23f62d46_d20251105_m042059_c001_v0001176_t0028_u01762316459013") 2025/11/05 04:22:15 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f42167a6f23f62d44_d20251105_m042058_c001_v7007000_t0000_u01762316458526") 2025/11/05 04:22:15 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbe52_d20251105_m042053_c001_v0001109_t0055_u01762316453204") 2025/11/05 04:22:15 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbe50_d20251105_m042053_c001_v7007000_t0000_u01762316453022") 2025/11/05 04:22:15 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbe3e_d20251105_m042048_c001_v0001145_t0057_u01762316448107") 2025/11/05 04:22:16 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbe3c_d20251105_m042047_c001_v7007000_t0000_u01762316447610") 2025/11/05 04:22:16 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbe0e_d20251105_m042042_c001_v0001099_t0046_u01762316442713") 2025/11/05 04:22:16 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fbe0c_d20251105_m042042_c001_v7007000_t0000_u01762316442533") 2025/11/05 04:22:16 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f219b66f47bb9e2d4_d20251105_m042038_c001_v0001153_t0013_u01762316438594") 2025/11/05 04:22:16 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419b66f47bb9e2c4_d20251105_m042038_c001_v7007000_t0000_u01762316438006") 2025/11/05 04:22:16 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fbd8e_d20251105_m042034_c001_v0001182_t0023_u01762316434030") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419b66f47bb9e72f_d20251105_m042208_c001_v7007000_t0000_u01762316528425") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fc1b4_d20251105_m042159_c001_v0001177_t0055_u01762316519584") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fc1ab_d20251105_m042158_c001_v7007000_t0000_u01762316518952") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fc144_d20251105_m042153_c001_v0001184_t0031_u01762316513487") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fc136_d20251105_m042152_c001_v7007000_t0000_u01762316512808") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e722047_d20251105_m042147_c001_v0001043_t0054_u01762316507054") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e722040_d20251105_m042146_c001_v7007000_t0000_u01762316506415") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f21638a0169_d20251105_m042142_c001_v0001090_t0008_u01762316502622") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721ff5_d20251105_m042142_c001_v7007000_t0000_u01762316502204") 2025/11/05 04:22:16 DEBUG : chunked-copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f21638a015f_d20251105_m042138_c001_v0001090_t0057_u01762316498702") 2025/11/05 04:22:16 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419b66f47bb9e72e_d20251105_m042208_c001_v7007000_t0000_u01762316528241") 2025/11/05 04:22:16 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e72208d_d20251105_m042202_c001_v0001032_t0058_u01762316522923") 2025/11/05 04:22:16 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fc1a7_d20251105_m042158_c001_v7007000_t0000_u01762316518771") 2025/11/05 04:22:16 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e722078_d20251105_m042156_c001_v0001116_t0028_u01762316516796") 2025/11/05 04:22:16 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f41823ea56c5fc131_d20251105_m042152_c001_v7007000_t0000_u01762316512626") 2025/11/05 04:22:16 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f21823ea56c5fc114_d20251105_m042150_c001_v0001178_t0018_u01762316510959") 2025/11/05 04:22:17 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e72203f_d20251105_m042146_c001_v7007000_t0000_u01762316506231") 2025/11/05 04:22:17 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f208b8c205e722023_d20251105_m042144_c001_v0001182_t0006_u01762316504408") 2025/11/05 04:22:17 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f408b8c205e721fee_d20251105_m042142_c001_v7007000_t0000_u01762316502021") 2025/11/05 04:22:17 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f100e83ea0ec9bdbf_d20251105_m042141_c001_v0001165_t0056_u01762316501224") 2025/11/05 04:22:17 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f118036ad05057e37_d20251105_m040641_c001_v0001120_t0036_u01762315601583") 2025/11/05 04:22:17 DEBUG : unknown-size-put.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419b66f47bb9e731_d20251105_m042209_c001_v7007000_t0000_u01762316529513") 2025/11/05 04:22:17 DEBUG : unknown-size-put.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f21638a0199_d20251105_m042209_c001_v0001090_t0020_u01762316529029") 2025/11/05 04:22:17 DEBUG : unknown-size-update.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419b66f47bb9e73c_d20251105_m042211_c001_v7007000_t0000_u01762316531021") 2025/11/05 04:22:17 DEBUG : unknown-size-update.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f21638a019f_d20251105_m042210_c001_v0001090_t0042_u01762316530524") 2025/11/05 04:22:17 DEBUG : unknown-size-update.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f10293f21638a019b_d20251105_m042209_c001_v0001090_t0045_u01762316529695") 2025/11/05 04:22:17 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff27df3301d5b2b9fa80e1b_f419682f80447067c_d20251105_m040800_c001_v7007000_t0000_u01762315680221") 2025/11/05 04:22:18 INFO : B2 bucket rclone-test-gogojol2doha: cleaning bucket "rclone-test-gogojol2doha" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (974.37s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.55s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.43s) --- PASS: TestIntegration/FsMkdir (972.04s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.54s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.19s) --- 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 (24.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (1.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (1.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (1.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.14s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.45s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (1.76s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.14s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.46s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.41s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.07s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.38s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.39s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.10s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (5.82s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (83.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.38s) --- 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.55s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (3.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.55s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.39s) --- 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.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.36s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (32.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.29s) --- 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 (5.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (22.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.07s) --- 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.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (3.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.44s) --- 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.36s) --- 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.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.49s) --- 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.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (814.15s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (27.74s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.36s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (9.51s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (5.32s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (8.86s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.26s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (33.11s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (7.51s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.68s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (16.72s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (5.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (8.88s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (661.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (644.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (3.90s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.88s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (8.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.19s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (27.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (9.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (4.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (9.60s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (4.91s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (30.36s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (8.68s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.51s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.49s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.41s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (11.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.67s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (33.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (10.11s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (5.34s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (11.63s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (11.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (6.13s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (30.58s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.31s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (4.21s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (6.39s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (6.14s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (9.53s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (2.54s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.03s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.51s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.28s) --- 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 974.398s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 16m16.386091061s (try 1/5)