"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/14 04:29:16 DEBUG : Creating backend with remote "TestB2:rclone-test-nibinos7xugu" 2025/11/14 04:29:16 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/14 04:29:22 INFO : dir/subdir: Making directory fstest.go:250: Filtering empty directory "dir" fstest.go:250: Filtering empty directory "dir/subdir" 2025/11/14 04:29:22 INFO : dir/subdir: Removing directory fstest.go:250: Filtering empty directory "dir" 2025/11/14 04:29:22 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/14 04:29:45 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/14 04:29:46 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/11/14 04:29:48 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/11/14 04:29:48 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/11/14 04:29:48 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/11/14 04:29:48 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/11/14 04:29:48 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/11/14 04:29:48 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/14 04:29:55 DEBUG : Creating backend with remote "TestB2:" 2025/11/14 04:29:55 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/11/14 04:29:56 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/14 04:30:01 INFO : B2 bucket rclone-test-nibinos7xugu: cleaning bucket "rclone-test-nibinos7xugu" of all files 2025/11/14 04:30:01 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af570cb_d20251114_m043000_c001_v0001179_t0034_u01763094600787") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/11/14 04:30:02 DEBUG : Creating backend with remote "TestB2:rclone-test-nibinos7xugu/dirToPurgeFromRoot" 2025/11/14 04:30:04 INFO : B2 bucket rclone-test-nibinos7xugu path dirToPurgeFromRoot: cleaning bucket "rclone-test-nibinos7xugu" of all files 2025/11/14 04:30:04 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af570d8_d20251114_m043002_c001_v0001179_t0055_u01763094602373") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/11/14 04:30:05 DEBUG : Creating backend with remote "TestB2:rclone-test-nibinos7xugu/hello? sausage/êé" 2025/11/14 04:30:07 DEBUG : a/b/c/d/e.txt: Clearing upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/11/14 04:30:07 DEBUG : pacer: low level retry 1/1 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/11/14 04:30:07 DEBUG : pacer: Rate limited, increasing sleep to 1s fstests.go:143: Put error: CPU too busy (503 service_unavailable): trying again in 1s - low level retry 1/10 2025/11/14 04:30:10 DEBUG : pacer: Reducing sleep to 500ms 2025/11/14 04:30:11 DEBUG : pacer: Reducing sleep to 250ms 2025/11/14 04:30:12 DEBUG : pacer: Reducing sleep to 125ms 2025/11/14 04:30:12 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/14 04:30:12 DEBUG : pacer: Reducing sleep to 31.25ms 2025/11/14 04:30:12 DEBUG : pacer: Reducing sleep to 15.625ms 2025/11/14 04:30:12 DEBUG : pacer: Reducing sleep to 10ms 2025/11/14 04:30:13 INFO : B2 bucket rclone-test-nibinos7xugu path hello? sausage/êé: cleaning bucket "rclone-test-nibinos7xugu" of all files 2025/11/14 04:30:13 DEBUG : a/b/c/d/e.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f11849ea561544863_d20251114_m043011_c001_v0001182_t0019_u01763094611388") === 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/14 04:30:24 DEBUG : Creating backend with remote "TestB2:rclone-test-nibinos7xugu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/14 04:30:26 DEBUG : Creating backend with remote "TestB2:rclone-test-nibinos7xugu/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-nibinos7xugu" from "TestB2:rclone-test-nibinos7xugu" 2025/11/14 04:30:28 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/14 04:30:40 DEBUG : Creating backend with remote "TestB2:rclone-test-guqofit9fivu" 2025/11/14 04:30:44 DEBUG : B2 bucket rclone-test-guqofit9fivu: Purge remote 2025/11/14 04:30:44 INFO : B2 bucket rclone-test-guqofit9fivu: cleaning bucket "rclone-test-guqofit9fivu" of all files 2025/11/14 04:30:44 DEBUG : somefile: Deleting (id "4_z2f923dc3a01d8b0b9fa80e1b_f4019c64776bc48b5_d20251114_m043043_c001_v0001172_t0054_u01763094643280") === 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/14 04:30:46 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/14 04:30:47 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/14 04:30:50 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/11/14 04:30:50 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/11/14 04:30:50 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.778Ki offset 6Mi/6.106Mi 2025/11/14 04:30:50 DEBUG : test-metadata: Sending chunk 1 length 111389 2025/11/14 04:30:51 DEBUG : test-metadata: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000342930), retryAfter:1000000000} 2025/11/14 04:30:51 DEBUG : test-metadata: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/11/14 04:30:51 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/11/14 04:30:51 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/14 04:30:51 DEBUG : test-metadata: Sending chunk 1 length 111389 2025/11/14 04:30:52 DEBUG : pacer: Reducing sleep to 500ms 2025/11/14 04:30:53 DEBUG : test-metadata: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00032b9e0), retryAfter:1000000000} 2025/11/14 04:30:53 DEBUG : test-metadata: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/11/14 04:30:53 DEBUG : pacer: low level retry 2/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/11/14 04:30:53 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/14 04:30:53 DEBUG : test-metadata: Sending chunk 1 length 111389 2025/11/14 04:30:54 DEBUG : pacer: Reducing sleep to 500ms 2025/11/14 04:30:55 DEBUG : pacer: Reducing sleep to 250ms 2025/11/14 04:30:55 DEBUG : test-metadata: Done sending chunk 1 2025/11/14 04:31:04 DEBUG : pacer: Reducing sleep to 125ms 2025/11/14 04:31:04 DEBUG : test-metadata: Done sending chunk 0 2025/11/14 04:31:04 DEBUG : test-metadata: Finishing large file upload with 2 parts 2025/11/14 04:31:05 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/14 04:31:06 DEBUG : pacer: Reducing sleep to 31.25ms 2025/11/14 04:31:06 DEBUG : pacer: Reducing sleep to 15.625ms === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress 2025/11/14 04:31:06 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions 2025/11/14 04:31:15 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1179-04.backblaze.com/b2api/v1/b2_upload_file/8f720d13a00d8b0b9fa80e1b/c001_v0001179_t0040": EOF 2025/11/14 04:31:15 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1179-04.backblaze.com/b2api/v1/b2_upload_file/8f720d13a00d8b0b9fa80e1b/c001_v0001179_t0040": EOF) 2025/11/14 04:31:15 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1179-04.backblaze.com/b2api/v1/b2_upload_file/8f720d13a00d8b0b9fa80e1b/c001_v0001179_t0040": EOF - low level retry 1/10 2025/11/14 04:31:17 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-14-043110-605.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/14 04:31:20 DEBUG : oldPath = "TestB2:rclone-test-nibinos7xugu/versions/test-versions-v2025-11-14-043110-605.txt" 2025/11/14 04:31:20 DEBUG : newPath = "TestB2,versions:rclone-test-nibinos7xugu/versions/test-versions-v2025-11-14-043110-605.txt" 2025/11/14 04:31:20 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-nibinos7xugu/versions/test-versions-v2025-11-14-043110-605.txt" 2025/11/14 04:31:20 DEBUG : Config file has changed externally - reloading 2025/11/14 04:31:20 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/11/14 04:31:21 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-nibinos7xugu/versions/test-versions-v2025-11-14-043110-605.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-nibinos7xugu/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/14 04:31:24 INFO : B2 bucket rclone-test-nibinos7xugu: cleaning bucket "rclone-test-nibinos7xugu" of all hidden files 2025/11/14 04:31:24 DEBUG : leading space/ leading space: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d3_d20251114_m042929_c001_v7007000_t0000_u01763094569906") as it is a hide marker 2025/11/14 04:31:24 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : leading space/ leading space: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fcf_d20251114_m042929_c001_v0001179_t0053_u01763094569293") 2025/11/14 04:31:24 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d2_d20251114_m042928_c001_v7007000_t0000_u01763094568922") as it is a hide marker 2025/11/14 04:31:24 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fc1_d20251114_m042928_c001_v0001179_t0030_u01763094568337") 2025/11/14 04:31:24 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e0_d20251114_m042935_c001_v7007000_t0000_u01763094575778") as it is a hide marker 2025/11/14 04:31:24 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56ffd_d20251114_m042935_c001_v0001179_t0057_u01763094575186") 2025/11/14 04:31:24 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : created from root.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f41389e634126ad17_d20251114_m043036_c001_v7007000_t0000_u01763094636752") as it is a hide marker 2025/11/14 04:31:24 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : created from root.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f104879f84ee74685_d20251114_m043035_c001_v0001134_t0051_u01763094635567") 2025/11/14 04:31:24 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : file name.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60c_d20251114_m043046_c001_v7007000_t0000_u01763094646446") as it is a hide marker 2025/11/14 04:31:24 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57187_d20251114_m043024_c001_v0001179_t0054_u01763094624219") 2025/11/14 04:31:24 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1061ae6ea4d05138_d20251114_m043020_c001_v0001180_t0033_u01763094620672") 2025/11/14 04:31:24 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5709e_d20251114_m042952_c001_v0001179_t0017_u01763094592870") 2025/11/14 04:31:24 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57098_d20251114_m042952_c001_v0001179_t0056_u01763094592029") 2025/11/14 04:31:24 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5709c_d20251114_m042952_c001_v0001179_t0032_u01763094592454") "upload" dated 2025-11-14 04:29:52.454 +0000 UTC (1m32.413877649s ago) 2025/11/14 04:31:24 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641632_d20251114_m043018_c001_v7007000_t0000_u01763094618323") as it is a hide marker 2025/11/14 04:31:24 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f111113703eb3f3cc_d20251114_m043017_c001_v0001099_t0057_u01763094617839") 2025/11/14 04:31:24 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1182b8bd37fc51e9_d20251114_m043014_c001_v0001161_t0039_u01763094614751") 2025/11/14 04:31:24 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8ec_d20251114_m042942_c001_v7007000_t0000_u01763094582746") as it is a hide marker 2025/11/14 04:31:24 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57044_d20251114_m042942_c001_v0001179_t0020_u01763094582105") 2025/11/14 04:31:24 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : piped data.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60e_d20251114_m043048_c001_v7007000_t0000_u01763094648217") as it is a hide marker 2025/11/14 04:31:24 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : piped data.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5725c_d20251114_m043047_c001_v0001179_t0014_u01763094647752") 2025/11/14 04:31:24 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : piped data.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60d_d20251114_m043047_c001_v7007000_t0000_u01763094647556") 2025/11/14 04:31:24 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : piped data.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4047b9682af57258_d20251114_m043047_c001_v0001179_t0040_u01763094647181") 2025/11/14 04:31:24 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8ef_d20251114_m042943_c001_v7007000_t0000_u01763094583712") as it is a hide marker 2025/11/14 04:31:24 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57048_d20251114_m042943_c001_v0001179_t0049_u01763094583118") 2025/11/14 04:31:24 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : test-metadata: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dc95_d20251114_m043108_c001_v7007000_t0000_u01763094668043") as it is a hide marker 2025/11/14 04:31:24 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : test-metadata: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa610_d20251114_m043050_c001_v0001161_t0052_u01763094650063") 2025/11/14 04:31:24 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : test-metadata: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60f_d20251114_m043049_c001_v7007000_t0000_u01763094649190") 2025/11/14 04:31:24 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : test-metadata: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5725e_d20251114_m043048_c001_v0001179_t0013_u01763094648412") 2025/11/14 04:31:24 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e5_d20251114_m042937_c001_v7007000_t0000_u01763094577801") as it is a hide marker 2025/11/14 04:31:24 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5700f_d20251114_m042937_c001_v0001179_t0036_u01763094577161") 2025/11/14 04:31:24 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e7_d20251114_m042939_c001_v7007000_t0000_u01763094579752") as it is a hide marker 2025/11/14 04:31:24 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5701a_d20251114_m042939_c001_v0001179_t0015_u01763094579150") 2025/11/14 04:31:24 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e6_d20251114_m042938_c001_v7007000_t0000_u01763094578775") as it is a hide marker 2025/11/14 04:31:24 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57014_d20251114_m042938_c001_v0001179_t0014_u01763094578176") 2025/11/14 04:31:24 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e8_d20251114_m042940_c001_v7007000_t0000_u01763094580686") as it is a hide marker 2025/11/14 04:31:24 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57026_d20251114_m042940_c001_v0001179_t0043_u01763094580126") 2025/11/14 04:31:24 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e9_d20251114_m042941_c001_v7007000_t0000_u01763094581718") as it is a hide marker 2025/11/14 04:31:24 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5702e_d20251114_m042941_c001_v0001179_t0058_u01763094581064") 2025/11/14 04:31:24 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing space /trailing space : Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e3_d20251114_m042936_c001_v7007000_t0000_u01763094576785") as it is a hide marker 2025/11/14 04:31:24 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : trailing space /trailing space : Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57005_d20251114_m042936_c001_v0001179_t0013_u01763094576151") 2025/11/14 04:31:24 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b23bf_d20251114_m043118_c001_v0001178_t0019_u01763094678436") "upload" dated 2025-11-14 04:31:18.436 +0000 UTC (6.432663873s ago) 2025/11/14 04:31:24 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f40214feff7df63cd_d20251114_m043113_c001_v7007000_t0000_u01763094673618") 2025/11/14 04:31:24 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af572e4_d20251114_m043110_c001_v0001179_t0007_u01763094670605") 2025/11/14 04:31:24 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8fb_d20251114_m042951_c001_v7007000_t0000_u01763094591479") as it is a hide marker 2025/11/14 04:31:24 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2123496e5c53a8f2_d20251114_m042945_c001_v0001184_t0046_u01763094585923") 2025/11/14 04:31:24 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : zero-length-file: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8f1_d20251114_m042945_c001_v7007000_t0000_u01763094585578") as it is a hide marker 2025/11/14 04:31:24 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : zero-length-file: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4047b9682af57056_d20251114_m042945_c001_v0001179_t0040_u01763094585011") 2025/11/14 04:31:24 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d5_d20251114_m042930_c001_v7007000_t0000_u01763094570929") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fd7_d20251114_m042930_c001_v0001179_t0052_u01763094570281") 2025/11/14 04:31:24 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8cc_d20251114_m042925_c001_v7007000_t0000_u01763094565951") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fa1_d20251114_m042924_c001_v0001179_t0033_u01763094564914") 2025/11/14 04:31:24 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8dd_d20251114_m042933_c001_v7007000_t0000_u01763094573852") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56feb_d20251114_m042933_c001_v0001179_t0041_u01763094573280") 2025/11/14 04:31:24 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8da_d20251114_m042932_c001_v7007000_t0000_u01763094572906") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fe6_d20251114_m042932_c001_v0001179_t0025_u01763094572333") 2025/11/14 04:31:24 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8df_d20251114_m042934_c001_v7007000_t0000_u01763094574811") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56ff5_d20251114_m042934_c001_v0001179_t0030_u01763094574224") 2025/11/14 04:31:24 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d8_d20251114_m042931_c001_v7007000_t0000_u01763094571896") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fde_d20251114_m042931_c001_v0001179_t0049_u01763094571306") 2025/11/14 04:31:24 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ．/．: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8cd_d20251114_m042926_c001_v7007000_t0000_u01763094566947") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ．/．: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ．/．: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fa7_d20251114_m042926_c001_v0001179_t0058_u01763094566353") 2025/11/14 04:31:24 NOTICE: ．/．: Skipped delete as --dry-run is set 2025/11/14 04:31:24 DEBUG : ．．/．．: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d0_d20251114_m042927_c001_v7007000_t0000_u01763094567904") as it is a hide marker 2025/11/14 04:31:24 NOTICE: ．．/．．: Skipped remove hide marker as --dry-run is set 2025/11/14 04:31:24 DEBUG : ．．/．．: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fb1_d20251114_m042927_c001_v0001179_t0030_u01763094567319") 2025/11/14 04:31:24 NOTICE: ．．/．．: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/11/14 04:31:25 INFO : B2 bucket rclone-test-nibinos7xugu: cleaning bucket "rclone-test-nibinos7xugu" of all hidden files 2025/11/14 04:31:25 DEBUG : leading space/ leading space: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d3_d20251114_m042929_c001_v7007000_t0000_u01763094569906") as it is a hide marker 2025/11/14 04:31:25 DEBUG : leading space/ leading space: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fcf_d20251114_m042929_c001_v0001179_t0053_u01763094569293") 2025/11/14 04:31:25 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d2_d20251114_m042928_c001_v7007000_t0000_u01763094568922") as it is a hide marker 2025/11/14 04:31:25 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fc1_d20251114_m042928_c001_v0001179_t0030_u01763094568337") 2025/11/14 04:31:25 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e0_d20251114_m042935_c001_v7007000_t0000_u01763094575778") as it is a hide marker 2025/11/14 04:31:25 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56ffd_d20251114_m042935_c001_v0001179_t0057_u01763094575186") 2025/11/14 04:31:25 DEBUG : created from root.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f41389e634126ad17_d20251114_m043036_c001_v7007000_t0000_u01763094636752") as it is a hide marker 2025/11/14 04:31:25 DEBUG : created from root.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f104879f84ee74685_d20251114_m043035_c001_v0001134_t0051_u01763094635567") 2025/11/14 04:31:25 DEBUG : file name.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60c_d20251114_m043046_c001_v7007000_t0000_u01763094646446") as it is a hide marker 2025/11/14 04:31:25 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57187_d20251114_m043024_c001_v0001179_t0054_u01763094624219") 2025/11/14 04:31:25 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1061ae6ea4d05138_d20251114_m043020_c001_v0001180_t0033_u01763094620672") 2025/11/14 04:31:25 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5709e_d20251114_m042952_c001_v0001179_t0017_u01763094592870") 2025/11/14 04:31:25 DEBUG : file name.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57098_d20251114_m042952_c001_v0001179_t0056_u01763094592029") 2025/11/14 04:31:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5709c_d20251114_m042952_c001_v0001179_t0032_u01763094592454") "upload" dated 2025-11-14 04:29:52.454 +0000 UTC (1m33.468757581s ago) 2025/11/14 04:31:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641632_d20251114_m043018_c001_v7007000_t0000_u01763094618323") as it is a hide marker 2025/11/14 04:31:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f111113703eb3f3cc_d20251114_m043017_c001_v0001099_t0057_u01763094617839") 2025/11/14 04:31:26 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1182b8bd37fc51e9_d20251114_m043014_c001_v0001161_t0039_u01763094614751") 2025/11/14 04:31:26 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8ec_d20251114_m042942_c001_v7007000_t0000_u01763094582746") as it is a hide marker 2025/11/14 04:31:26 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57044_d20251114_m042942_c001_v0001179_t0020_u01763094582105") 2025/11/14 04:31:26 DEBUG : piped data.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60e_d20251114_m043048_c001_v7007000_t0000_u01763094648217") as it is a hide marker 2025/11/14 04:31:26 DEBUG : piped data.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5725c_d20251114_m043047_c001_v0001179_t0014_u01763094647752") 2025/11/14 04:31:26 DEBUG : piped data.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60d_d20251114_m043047_c001_v7007000_t0000_u01763094647556") 2025/11/14 04:31:26 DEBUG : piped data.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4047b9682af57258_d20251114_m043047_c001_v0001179_t0040_u01763094647181") 2025/11/14 04:31:26 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8ef_d20251114_m042943_c001_v7007000_t0000_u01763094583712") as it is a hide marker 2025/11/14 04:31:26 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57048_d20251114_m042943_c001_v0001179_t0049_u01763094583118") 2025/11/14 04:31:26 DEBUG : test-metadata: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dc95_d20251114_m043108_c001_v7007000_t0000_u01763094668043") as it is a hide marker 2025/11/14 04:31:26 DEBUG : test-metadata: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa610_d20251114_m043050_c001_v0001161_t0052_u01763094650063") 2025/11/14 04:31:26 DEBUG : test-metadata: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa60f_d20251114_m043049_c001_v7007000_t0000_u01763094649190") 2025/11/14 04:31:26 DEBUG : test-metadata: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5725e_d20251114_m043048_c001_v0001179_t0013_u01763094648412") 2025/11/14 04:31:26 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e5_d20251114_m042937_c001_v7007000_t0000_u01763094577801") as it is a hide marker 2025/11/14 04:31:26 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5700f_d20251114_m042937_c001_v0001179_t0036_u01763094577161") 2025/11/14 04:31:26 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e7_d20251114_m042939_c001_v7007000_t0000_u01763094579752") as it is a hide marker 2025/11/14 04:31:26 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5701a_d20251114_m042939_c001_v0001179_t0015_u01763094579150") 2025/11/14 04:31:26 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e6_d20251114_m042938_c001_v7007000_t0000_u01763094578775") as it is a hide marker 2025/11/14 04:31:27 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57014_d20251114_m042938_c001_v0001179_t0014_u01763094578176") 2025/11/14 04:31:27 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e8_d20251114_m042940_c001_v7007000_t0000_u01763094580686") as it is a hide marker 2025/11/14 04:31:27 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57026_d20251114_m042940_c001_v0001179_t0043_u01763094580126") 2025/11/14 04:31:27 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e9_d20251114_m042941_c001_v7007000_t0000_u01763094581718") as it is a hide marker 2025/11/14 04:31:27 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5702e_d20251114_m042941_c001_v0001179_t0058_u01763094581064") 2025/11/14 04:31:27 DEBUG : trailing space /trailing space : Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8e3_d20251114_m042936_c001_v7007000_t0000_u01763094576785") as it is a hide marker 2025/11/14 04:31:27 DEBUG : trailing space /trailing space : Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af57005_d20251114_m042936_c001_v0001179_t0013_u01763094576151") 2025/11/14 04:31:27 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b23bf_d20251114_m043118_c001_v0001178_t0019_u01763094678436") "upload" dated 2025-11-14 04:31:18.436 +0000 UTC (8.96570924s ago) 2025/11/14 04:31:27 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f40214feff7df63cd_d20251114_m043113_c001_v7007000_t0000_u01763094673618") 2025/11/14 04:31:27 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af572e4_d20251114_m043110_c001_v0001179_t0007_u01763094670605") 2025/11/14 04:31:27 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8fb_d20251114_m042951_c001_v7007000_t0000_u01763094591479") as it is a hide marker 2025/11/14 04:31:27 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2123496e5c53a8f2_d20251114_m042945_c001_v0001184_t0046_u01763094585923") 2025/11/14 04:31:27 DEBUG : zero-length-file: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8f1_d20251114_m042945_c001_v7007000_t0000_u01763094585578") as it is a hide marker 2025/11/14 04:31:27 DEBUG : zero-length-file: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4047b9682af57056_d20251114_m042945_c001_v0001179_t0040_u01763094585011") 2025/11/14 04:31:27 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d5_d20251114_m042930_c001_v7007000_t0000_u01763094570929") as it is a hide marker 2025/11/14 04:31:27 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fd7_d20251114_m042930_c001_v0001179_t0052_u01763094570281") 2025/11/14 04:31:27 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8cc_d20251114_m042925_c001_v7007000_t0000_u01763094565951") as it is a hide marker 2025/11/14 04:31:27 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fa1_d20251114_m042924_c001_v0001179_t0033_u01763094564914") 2025/11/14 04:31:27 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8dd_d20251114_m042933_c001_v7007000_t0000_u01763094573852") as it is a hide marker 2025/11/14 04:31:28 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56feb_d20251114_m042933_c001_v0001179_t0041_u01763094573280") 2025/11/14 04:31:28 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8da_d20251114_m042932_c001_v7007000_t0000_u01763094572906") as it is a hide marker 2025/11/14 04:31:28 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fe6_d20251114_m042932_c001_v0001179_t0025_u01763094572333") 2025/11/14 04:31:28 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8df_d20251114_m042934_c001_v7007000_t0000_u01763094574811") as it is a hide marker 2025/11/14 04:31:28 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56ff5_d20251114_m042934_c001_v0001179_t0030_u01763094574224") 2025/11/14 04:31:28 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d8_d20251114_m042931_c001_v7007000_t0000_u01763094571896") as it is a hide marker 2025/11/14 04:31:28 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fde_d20251114_m042931_c001_v0001179_t0049_u01763094571306") 2025/11/14 04:31:28 DEBUG : ．/．: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8cd_d20251114_m042926_c001_v7007000_t0000_u01763094566947") as it is a hide marker 2025/11/14 04:31:28 DEBUG : ．/．: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fa7_d20251114_m042926_c001_v0001179_t0058_u01763094566353") 2025/11/14 04:31:28 DEBUG : ．．/．．: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53a8d0_d20251114_m042927_c001_v7007000_t0000_u01763094567904") as it is a hide marker 2025/11/14 04:31:28 DEBUG : ．．/．．: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af56fb1_d20251114_m042927_c001_v0001179_t0030_u01763094567319") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/11/14 04:31:29 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/14 04:31:29 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/14 04:31:29 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/14 04:31:29 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/14 04:31:30 INFO : B2 bucket rclone-test-nibinos7xugu: cleaning bucket "rclone-test-nibinos7xugu" of pending multipart uploads older than 0s 2025/11/14 04:31:30 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5709c_d20251114_m042952_c001_v0001179_t0032_u01763094592454") "upload" dated 2025-11-14 04:29:52.454 +0000 UTC (1m38.113715887s ago) 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461712_d20251114_m043129_c001_v0001157_t0053_u01763094689453") as it is a start marker (upload started at 2025-11-14 04:31:29.453 +0000 UTC) 2025/11/14 04:31:30 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461713_d20251114_m043129_c001_v0001144_t0023_u01763094689647") as it is a start marker (upload started at 2025-11-14 04:31:29.647 +0000 UTC) 2025/11/14 04:31:30 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461715_d20251114_m043129_c001_v0001105_t0007_u01763094689841") as it is a start marker (upload started at 2025-11-14 04:31:29.841 +0000 UTC) 2025/11/14 04:31:30 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461716_d20251114_m043130_c001_v0001161_t0042_u01763094690031") as it is a start marker (upload started at 2025-11-14 04:31:30.031 +0000 UTC) 2025/11/14 04:31:30 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/11/14 04:31:30 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f415744888f461711_d20251114_m043129_c001_v7007000_t0000_u01763094689263") "hide" dated 2025-11-14 04:31:29.263 +0000 UTC (1.304939958s ago) 2025/11/14 04:31:30 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b23bf_d20251114_m043118_c001_v0001178_t0019_u01763094678436") 2025/11/14 04:31:30 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/11/14 04:31:30 INFO : B2 bucket rclone-test-nibinos7xugu: cleaning bucket "rclone-test-nibinos7xugu" of pending multipart uploads older than 0s 2025/11/14 04:31:30 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5709c_d20251114_m042952_c001_v0001179_t0032_u01763094592454") "upload" dated 2025-11-14 04:29:52.454 +0000 UTC (1m38.480645626s ago) 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461712_d20251114_m043129_c001_v0001157_t0053_u01763094689453") as it is a start marker (upload started at 2025-11-14 04:31:29.453 +0000 UTC) 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461713_d20251114_m043129_c001_v0001144_t0023_u01763094689647") as it is a start marker (upload started at 2025-11-14 04:31:29.647 +0000 UTC) 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461715_d20251114_m043129_c001_v0001105_t0007_u01763094689841") as it is a start marker (upload started at 2025-11-14 04:31:29.841 +0000 UTC) 2025/11/14 04:31:30 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f461716_d20251114_m043130_c001_v0001161_t0042_u01763094690031") as it is a start marker (upload started at 2025-11-14 04:31:30.031 +0000 UTC) 2025/11/14 04:31:30 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f720d13a00d8b0b9fa80e1b_f415744888f461711_d20251114_m043129_c001_v7007000_t0000_u01763094689263") "hide" dated 2025-11-14 04:31:29.263 +0000 UTC (1.671905002s ago) 2025/11/14 04:31:30 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b23bf_d20251114_m043118_c001_v0001178_t0019_u01763094678436") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/11/14 04:31:31 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/11/14 04:31:31 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/11/14 04:31:32 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/14 04:31:33 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/11/14 04:31:33 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/11/14 04:31:33 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/11/14 04:31:33 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/11/14 04:31:35 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/11/14 04:31:36 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/11/14 04:31:36 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/11/14 04:31:38 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:31:38 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/14 04:31:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2034dd4fe8a502da_d20251114_m043138_c001_v0001176_t0056_u01763094698959") 2025/11/14 04:31:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:31:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/14 04:31:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/14 04:31:39 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:31:41 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:31:41 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/11/14 04:31:42 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/11/14 04:31:42 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/11/14 04:31:43 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/11/14 04:31:43 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/11/14 04:31:45 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/11/14 04:31:45 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/11/14 04:31:45 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/11/14 04:31:46 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:31:46 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/14 04:31:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2034dd4fe8a502e1_d20251114_m043147_c001_v0001157_t0028_u01763094707023") 2025/11/14 04:31:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/14 04:31:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/14 04:31:47 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/11/14 04:31:49 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:31:49 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:31:49 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/11/14 04:31:51 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/11/14 04:31:51 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/11/14 04:31:51 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/11/14 04:31:51 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/11/14 04:31:51 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/11/14 04:31:51 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/11/14 04:31:52 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/11/14 04:31:54 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/11/14 04:31:54 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/11/14 04:31:54 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/11/14 04:31:55 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:31:55 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 5Mi allows uploads of up to 48.828Gi and will fail only when that limit is reached. 2025/11/14 04:31:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dce2_d20251114_m043156_c001_v0001093_t0001_u01763094716055") 2025/11/14 04:31:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/14 04:31:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:31:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/14 04:31:56 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/11/14 04:31:57 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/11/14 04:31:58 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:31:58 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:31:58 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 2025/11/14 04:32:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/11/14 04:32:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/11/14 04:32:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/11/14 04:32:00 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/11/14 04:32:01 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/11/14 04:32:03 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/11/14 04:32:03 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/11/14 04:32:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:32:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/11/14 04:32:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dce5_d20251114_m043204_c001_v0001100_t0051_u01763094724574") 2025/11/14 04:32:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:32:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/11/14 04:32:04 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/14 04:32:05 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:32:07 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:32:07 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/11/14 04:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/11/14 04:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/11/14 04:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/11/14 04:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/11/14 04:32:10 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/11/14 04:32:11 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/11/14 04:32:11 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/11/14 04:32:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:32:12 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/11/14 04:32:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dceb_d20251114_m043212_c001_v0001131_t0018_u01763094732962") 2025/11/14 04:32:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/14 04:32:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/14 04:32:13 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/11/14 04:32:15 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:32:16 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:32:16 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/11/14 04:32:18 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/11/14 04:32:18 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/11/14 04:32:18 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/11/14 04:32:18 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/11/14 04:32:18 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/11/14 04:32:19 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/11/14 04:32:19 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/11/14 04:32:21 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/11/14 04:32:21 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/11/14 04:32:21 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/11/14 04:32:22 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:32:22 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/14 04:32:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2196b5bd76bbaa83_d20251114_m043222_c001_v0001157_t0027_u01763094742880") 2025/11/14 04:32:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/14 04:32:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:32:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/11/14 04:32:23 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/11/14 04:32:24 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/11/14 04:32:25 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:32:26 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:32:26 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/14 04:32:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/11/14 04:32:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/11/14 04:32:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/14 04:32:27 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:29 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/11/14 04:32:30 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/11/14 04:32:30 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/11/14 04:32:31 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:32:31 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/14 04:32:31 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2196b5bd76bbaa91_d20251114_m043231_c001_v0001161_t0022_u01763094751751") 2025/11/14 04:32:31 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:32:31 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/11/14 04:32:31 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:32 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000394cc0), retryAfter:1000000000} 2025/11/14 04:32:32 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/11/14 04:32:32 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/11/14 04:32:32 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/14 04:32:32 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:32 DEBUG : pacer: Reducing sleep to 500ms 2025/11/14 04:32:32 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:32:33 DEBUG : pacer: Reducing sleep to 250ms 2025/11/14 04:32:34 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000332870), retryAfter:1000000000} 2025/11/14 04:32:34 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/11/14 04:32:34 DEBUG : pacer: low level retry 2/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/11/14 04:32:34 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/14 04:32:34 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:37 DEBUG : pacer: Reducing sleep to 500ms 2025/11/14 04:32:37 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:32:37 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts 2025/11/14 04:32:37 DEBUG : pacer: Reducing sleep to 250ms 2025/11/14 04:32:38 DEBUG : pacer: Reducing sleep to 125ms 2025/11/14 04:32:38 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/14 04:32:40 DEBUG : pacer: Reducing sleep to 31.25ms === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/11/14 04:32:40 DEBUG : pacer: Reducing sleep to 15.625ms 2025/11/14 04:32:40 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/11/14 04:32:40 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/11/14 04:32:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/11/14 04:32:41 DEBUG : pacer: Reducing sleep to 10ms 2025/11/14 04:32:43 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/11/14 04:32:43 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/11/14 04:32:43 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/11/14 04:32:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:32:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/11/14 04:32:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa62a_d20251114_m043245_c001_v0001183_t0007_u01763094765466") 2025/11/14 04:32:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/14 04:32:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/11/14 04:32:47 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:32:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:32:48 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/11/14 04:32:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/11/14 04:32:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/11/14 04:32:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/11/14 04:32:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/11/14 04:32:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/11/14 04:32:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/11/14 04:32:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/11/14 04:32:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/11/14 04:32:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/11/14 04:32:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:32:54 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/14 04:32:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641821_d20251114_m043254_c001_v0001117_t0052_u01763094774288") 2025/11/14 04:32:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/14 04:32:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:32:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/11/14 04:32:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/11/14 04:32:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/11/14 04:32:57 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:32:57 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:32:57 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/14 04:32:59 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/11/14 04:32:59 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/11/14 04:32:59 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/11/14 04:32:59 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/11/14 04:33:00 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/11/14 04:33:01 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/11/14 04:33:01 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/11/14 04:33:03 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:33:03 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/14 04:33:03 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa636_d20251114_m043303_c001_v0001172_t0055_u01763094783431") 2025/11/14 04:33:03 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:33:03 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/11/14 04:33:03 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/14 04:33:04 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:33:06 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:33:06 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/11/14 04:33:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/11/14 04:33:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/11/14 04:33:08 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/11/14 04:33:08 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/11/14 04:33:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/11/14 04:33:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/11/14 04:33:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/11/14 04:33:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:33:12 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/14 04:33:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641839_d20251114_m043312_c001_v0001098_t0013_u01763094792532") 2025/11/14 04:33:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/14 04:33:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/14 04:33:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/11/14 04:33:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:33:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:33:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/11/14 04:33:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/11/14 04:33:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/11/14 04:33:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/11/14 04:33:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/11/14 04:33:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/11/14 04:33:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/11/14 04:33:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/11/14 04:33:19 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/11/14 04:33:20 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/11/14 04:33:20 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/11/14 04:33:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:33:21 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/14 04:33:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f204ae298e5cb1bd7_d20251114_m043321_c001_v0001093_t0050_u01763094801968") 2025/11/14 04:33:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/14 04:33:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:33:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/11/14 04:33:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/11/14 04:33:23 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/11/14 04:33:24 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:33:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:33:25 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/14 04:33:27 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/11/14 04:33:27 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/11/14 04:33:27 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/11/14 04:33:27 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/11/14 04:33:28 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/11/14 04:33:30 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/11/14 04:33:30 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/11/14 04:33:31 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:33:31 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/14 04:33:32 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f204ae298e5cb1bde_d20251114_m043331_c001_v0001182_t0056_u01763094811899") 2025/11/14 04:33:32 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:33:32 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/14 04:33:32 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/14 04:33:32 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:33:34 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:33:34 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/11/14 04:33:36 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/11/14 04:33:36 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/11/14 04:33:36 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/11/14 04:33:36 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/11/14 04:33:38 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/11/14 04:33:39 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/11/14 04:33:39 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/11/14 04:33:41 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:33:41 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/14 04:33:41 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641868_d20251114_m043341_c001_v0001106_t0049_u01763094821136") 2025/11/14 04:33:41 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/14 04:33:41 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/14 04:33:41 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/11/14 04:33:44 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:33:44 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:33:44 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/11/14 04:33:46 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/11/14 04:33:46 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/11/14 04:33:47 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/11/14 04:33:47 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/11/14 04:33:47 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/11/14 04:33:47 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/11/14 04:33:48 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/11/14 04:33:49 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/11/14 04:33:49 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/11/14 04:33:49 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/11/14 04:33:52 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:33:52 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/14 04:33:52 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d7280064187a_d20251114_m043352_c001_v0001136_t0001_u01763094832587") 2025/11/14 04:33:52 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/14 04:33:53 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:33:53 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/14 04:33:53 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/11/14 04:33:53 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/11/14 04:33:55 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:33:55 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:33:55 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/14 04:33:58 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/11/14 04:33:58 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/11/14 04:33:58 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/11/14 04:33:58 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/11/14 04:33:59 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/11/14 04:34:00 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/11/14 04:34:00 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/11/14 04:34:03 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:34:03 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/14 04:34:03 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641883_d20251114_m043403_c001_v0001102_t0053_u01763094843150") 2025/11/14 04:34:03 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:34:03 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/14 04:34:03 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/14 04:34:04 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:34:06 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:34:06 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/11/14 04:34:08 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/11/14 04:34:08 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/11/14 04:34:08 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/11/14 04:34:08 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/11/14 04:34:11 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/11/14 04:34:11 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/11/14 04:34:11 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/11/14 04:34:14 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:34:14 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/14 04:34:14 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f21096641a40a1131_d20251114_m043414_c001_v0001146_t0034_u01763094854624") 2025/11/14 04:34:14 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/14 04:34:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/14 04:34:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/11/14 04:34:17 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:34:17 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:34:17 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/11/14 04:34:20 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/11/14 04:34:20 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/11/14 04:34:20 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/11/14 04:34:20 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/11/14 04:34:20 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/11/14 04:34:20 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/11/14 04:34:21 DEBUG : chunked-10Mi-20.000Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000395590), retryAfter:1000000000} 2025/11/14 04:34:21 DEBUG : chunked-10Mi-20.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/14 04:34:21 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/14 04:34:21 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/14 04:34:21 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/11/14 04:34:22 DEBUG : pacer: Reducing sleep to 500ms 2025/11/14 04:34:22 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/11/14 04:34:22 DEBUG : pacer: Reducing sleep to 250ms 2025/11/14 04:34:23 DEBUG : pacer: Reducing sleep to 125ms 2025/11/14 04:34:23 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/11/14 04:34:26 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/14 04:34:26 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/11/14 04:34:26 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts 2025/11/14 04:34:27 DEBUG : pacer: Reducing sleep to 31.25ms 2025/11/14 04:34:27 DEBUG : pacer: Reducing sleep to 15.625ms 2025/11/14 04:34:27 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/11/14 04:34:30 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/14 04:34:30 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/14 04:34:30 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f720d13a00d8b0b9fa80e1b_f20214feff7df65dd_d20251114_m043430_c001_v0001102_t0043_u01763094870888") 2025/11/14 04:34:30 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/14 04:34:31 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/14 04:34:31 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/14 04:34:31 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/11/14 04:34:32 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/11/14 04:34:33 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/11/14 04:34:34 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/11/14 04:34:34 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/14 04:34:42 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8f720d13a00d8b0b9fa80e1b_f20214feff7df6612_d20251114_m043442_c001_v0001154_t0008_u01763094882197") 2025/11/14 04:34:42 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/11/14 04:34:42 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/14 04:34:42 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/14 04:34:48 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/14 04:34:48 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/11/14 04:34:51 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/11/14 04:34:51 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/14 04:34:52 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/11/14 04:34:52 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/11/14 04:34:54 DEBUG : chunked-copy: Done sending chunk 1 2025/11/14 04:34:54 DEBUG : chunked-copy: Done sending chunk 0 2025/11/14 04:34:54 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/14 04:34:55 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8f720d13a00d8b0b9fa80e1b_f211f5bf7c30f93e1_d20251114_m043455_c001_v0001179_t0030_u01763094895321") 2025/11/14 04:34:55 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/11/14 04:34:55 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/14 04:34:55 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/14 04:34:55 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/14 04:34:55 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/11/14 04:34:57 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/11/14 04:34:57 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/14 04:34:58 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/11/14 04:34:58 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/11/14 04:35:00 DEBUG : chunked-copy: Done sending chunk 0 2025/11/14 04:35:01 DEBUG : chunked-copy: Done sending chunk 1 2025/11/14 04:35:01 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/14 04:35:02 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8f720d13a00d8b0b9fa80e1b_f211f5bf7c30f93eb_d20251114_m043501_c001_v0001161_t0026_u01763094901969") 2025/11/14 04:35:02 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/11/14 04:35:02 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/14 04:35:04 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/14 04:35:04 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/14 04:35:04 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/11/14 04:35:06 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/11/14 04:35:06 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/14 04:35:06 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/11/14 04:35:06 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/11/14 04:35:09 DEBUG : chunked-copy: Done sending chunk 0 2025/11/14 04:35:09 DEBUG : chunked-copy: Done sending chunk 1 2025/11/14 04:35:09 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/14 04:35:09 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_z8f720d13a00d8b0b9fa80e1b_f211f5bf7c30f93fb_d20251114_m043509_c001_v0001131_t0017_u01763094909737") 2025/11/14 04:35:09 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/11/14 04:35:09 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/14 04:35:09 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/11/14 04:35:10 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/11/14 04:35:10 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/14 04:35:10 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/14 04:35:10 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/11/14 04:35:11 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/14 04:35:13 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/14 04:35:13 DEBUG : Creating backend with remote "TestB2:rclone-test-nibinos7xugu/deeper/nonexisting/directory" === 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/14 04:35:15 INFO : B2 bucket rclone-test-nibinos7xugu: cleaning bucket "rclone-test-nibinos7xugu" of all files 2025/11/14 04:35:15 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f41096641a40a1128_d20251114_m043407_c001_v7007000_t0000_u01763094847645") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641883_d20251114_m043403_c001_v0001102_t0053_u01763094843150") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641882_d20251114_m043402_c001_v7007000_t0000_u01763094842389") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f21096641a40a111e_d20251114_m043357_c001_v0001172_t0045_u01763094837732") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f40214feff7df6601_d20251114_m043436_c001_v7007000_t0000_u01763094876194") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f20214feff7df65dd_d20251114_m043430_c001_v0001102_t0043_u01763094870888") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f40214feff7df65d9_d20251114_m043430_c001_v7007000_t0000_u01763094870285") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f21096641a40a1137_d20251114_m043420_c001_v0001100_t0005_u01763094860110") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f41096641a40a1136_d20251114_m043419_c001_v7007000_t0000_u01763094859913") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f21096641a40a1131_d20251114_m043414_c001_v0001146_t0034_u01763094854624") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f41096641a40a1130_d20251114_m043413_c001_v7007000_t0000_u01763094853992") 2025/11/14 04:35:15 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f21096641a40a112a_d20251114_m043407_c001_v0001117_t0046_u01763094847840") 2025/11/14 04:35:15 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dcf4_d20251114_m043227_c001_v7007000_t0000_u01763094747420") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2196b5bd76bbaa83_d20251114_m043222_c001_v0001157_t0027_u01763094742880") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dcec_d20251114_m043218_c001_v7007000_t0000_u01763094738255") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dceb_d20251114_m043212_c001_v0001131_t0018_u01763094732962") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4196b5bd76bbaa81_d20251114_m043222_c001_v7007000_t0000_u01763094742472") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dced_d20251114_m043218_c001_v0001179_t0020_u01763094738451") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dcea_d20251114_m043212_c001_v7007000_t0000_u01763094732554") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2034dd4fe8a50311_d20251114_m043208_c001_v0001179_t0055_u01763094728387") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4034dd4fe8a50310_d20251114_m043208_c001_v7007000_t0000_u01763094728196") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dce5_d20251114_m043204_c001_v0001100_t0051_u01763094724574") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dce4_d20251114_m043204_c001_v7007000_t0000_u01763094724168") 2025/11/14 04:35:16 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2034dd4fe8a502fb_d20251114_m043200_c001_v0001146_t0025_u01763094720295") 2025/11/14 04:35:16 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa62f_d20251114_m043258_c001_v7007000_t0000_u01763094778718") 2025/11/14 04:35:16 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641821_d20251114_m043254_c001_v0001117_t0052_u01763094774288") 2025/11/14 04:35:16 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa62c_d20251114_m043249_c001_v7007000_t0000_u01763094769429") 2025/11/14 04:35:16 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa62a_d20251114_m043245_c001_v0001183_t0007_u01763094765466") 2025/11/14 04:35:16 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641820_d20251114_m043253_c001_v7007000_t0000_u01763094773889") 2025/11/14 04:35:16 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa62d_d20251114_m043249_c001_v0001184_t0031_u01763094769623") 2025/11/14 04:35:17 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa629_d20251114_m043245_c001_v7007000_t0000_u01763094765026") 2025/11/14 04:35:17 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dd04_d20251114_m043240_c001_v0001101_t0056_u01763094760605") 2025/11/14 04:35:17 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dd03_d20251114_m043240_c001_v7007000_t0000_u01763094760411") 2025/11/14 04:35:17 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2196b5bd76bbaa91_d20251114_m043231_c001_v0001161_t0022_u01763094751751") 2025/11/14 04:35:17 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4196b5bd76bbaa8e_d20251114_m043231_c001_v7007000_t0000_u01763094751345") 2025/11/14 04:35:17 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dcf7_d20251114_m043227_c001_v0001137_t0008_u01763094747611") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4034dd4fe8a502fa_d20251114_m043200_c001_v7007000_t0000_u01763094720099") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f214a76597f29dce2_d20251114_m043156_c001_v0001093_t0001_u01763094716055") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f414a76597f29dce1_d20251114_m043155_c001_v7007000_t0000_u01763094715658") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2034dd4fe8a502ec_d20251114_m043151_c001_v0001172_t0013_u01763094711370") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4034dd4fe8a502eb_d20251114_m043151_c001_v7007000_t0000_u01763094711169") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2034dd4fe8a502e1_d20251114_m043147_c001_v0001157_t0028_u01763094707023") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4034dd4fe8a502e0_d20251114_m043146_c001_v7007000_t0000_u01763094706595") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f20214feff7df63fe_d20251114_m043142_c001_v0001183_t0048_u01763094702552") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f40214feff7df63fd_d20251114_m043142_c001_v7007000_t0000_u01763094702353") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2034dd4fe8a502da_d20251114_m043138_c001_v0001176_t0056_u01763094698959") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4034dd4fe8a502d9_d20251114_m043138_c001_v7007000_t0000_u01763094698581") 2025/11/14 04:35:17 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f215744888f46171c_d20251114_m043133_c001_v0001104_t0041_u01763094693123") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d7280064185a_d20251114_m043326_c001_v7007000_t0000_u01763094806585") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f204ae298e5cb1bd7_d20251114_m043321_c001_v0001093_t0050_u01763094801968") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641845_d20251114_m043316_c001_v7007000_t0000_u01763094796874") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641839_d20251114_m043312_c001_v0001098_t0013_u01763094792532") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f404ae298e5cb1bd6_d20251114_m043321_c001_v7007000_t0000_u01763094801526") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641846_d20251114_m043317_c001_v0001176_t0016_u01763094797063") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641837_d20251114_m043311_c001_v7007000_t0000_u01763094791996") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d7280064182e_d20251114_m043307_c001_v0001176_t0012_u01763094787436") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d7280064182d_d20251114_m043307_c001_v7007000_t0000_u01763094787231") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa636_d20251114_m043303_c001_v0001172_t0055_u01763094783431") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f407579c9527fa635_d20251114_m043302_c001_v7007000_t0000_u01763094782947") 2025/11/14 04:35:18 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f207579c9527fa630_d20251114_m043258_c001_v0001145_t0027_u01763094778913") 2025/11/14 04:35:18 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f41096641a40a111c_d20251114_m043357_c001_v7007000_t0000_u01763094837540") 2025/11/14 04:35:18 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d7280064187a_d20251114_m043352_c001_v0001136_t0001_u01763094832587") 2025/11/14 04:35:18 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641878_d20251114_m043351_c001_v7007000_t0000_u01763094831872") 2025/11/14 04:35:18 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641873_d20251114_m043346_c001_v0001102_t0038_u01763094826565") 2025/11/14 04:35:18 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641870_d20251114_m043346_c001_v7007000_t0000_u01763094826367") 2025/11/14 04:35:18 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641868_d20251114_m043341_c001_v0001106_t0049_u01763094821136") 2025/11/14 04:35:19 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641867_d20251114_m043340_c001_v7007000_t0000_u01763094820626") 2025/11/14 04:35:19 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d72800641864_d20251114_m043335_c001_v0001183_t0057_u01763094815854") 2025/11/14 04:35:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4011d72800641863_d20251114_m043335_c001_v7007000_t0000_u01763094815657") 2025/11/14 04:35:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f204ae298e5cb1bde_d20251114_m043331_c001_v0001182_t0056_u01763094811899") 2025/11/14 04:35:19 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f404ae298e5cb1bdd_d20251114_m043331_c001_v7007000_t0000_u01763094811377") 2025/11/14 04:35:19 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2011d7280064185b_d20251114_m043326_c001_v0001032_t0013_u01763094806819") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f411f5bf7c30f93fd_d20251114_m043511_c001_v7007000_t0000_u01763094911884") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2123496e5c53ab7d_d20251114_m043506_c001_v0001180_t0050_u01763094906406") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53ab7a_d20251114_m043505_c001_v7007000_t0000_u01763094905746") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2123496e5c53ab6c_d20251114_m043457_c001_v0001115_t0020_u01763094897673") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53ab6a_d20251114_m043457_c001_v7007000_t0000_u01763094897066") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f2123496e5c53ab65_d20251114_m043451_c001_v0001171_t0025_u01763094891590") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53ab64_d20251114_m043450_c001_v7007000_t0000_u01763094890889") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b26ec_d20251114_m043440_c001_v0001178_t0045_u01763094880710") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f40214feff7df660f_d20251114_m043440_c001_v7007000_t0000_u01763094880317") 2025/11/14 04:35:19 DEBUG : chunked-copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b26d9_d20251114_m043437_c001_v0001178_t0021_u01763094877036") 2025/11/14 04:35:19 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f411f5bf7c30f93fc_d20251114_m043511_c001_v7007000_t0000_u01763094911676") 2025/11/14 04:35:19 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f211f5bf7c30f93fb_d20251114_m043509_c001_v0001131_t0017_u01763094909737") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53ab79_d20251114_m043505_c001_v7007000_t0000_u01763094905541") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f211f5bf7c30f93eb_d20251114_m043501_c001_v0001161_t0026_u01763094901969") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53ab68_d20251114_m043456_c001_v7007000_t0000_u01763094896875") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f211f5bf7c30f93e1_d20251114_m043455_c001_v0001179_t0030_u01763094895321") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f4123496e5c53ab63_d20251114_m043450_c001_v7007000_t0000_u01763094890702") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f20214feff7df6612_d20251114_m043442_c001_v0001154_t0008_u01763094882197") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f40214feff7df660d_d20251114_m043440_c001_v7007000_t0000_u01763094880105") 2025/11/14 04:35:20 DEBUG : chunked-copy.copy: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1072c0d11c8f8ef0_d20251114_m043438_c001_v0001044_t0059_u01763094878987") 2025/11/14 04:35:20 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1047b9682af5709c_d20251114_m042952_c001_v0001179_t0032_u01763094592454") 2025/11/14 04:35:20 DEBUG : unknown-size-put.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f411f5bf7c30f93fe_d20251114_m043512_c001_v7007000_t0000_u01763094912673") 2025/11/14 04:35:20 DEBUG : unknown-size-put.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b276e_d20251114_m043512_c001_v0001178_t0036_u01763094912454") 2025/11/14 04:35:20 DEBUG : unknown-size-update.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f411f5bf7c30f9400_d20251114_m043513_c001_v7007000_t0000_u01763094913691") 2025/11/14 04:35:20 DEBUG : unknown-size-update.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b2776_d20251114_m043513_c001_v0001178_t0043_u01763094913463") 2025/11/14 04:35:20 DEBUG : unknown-size-update.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f1035a1ecb42b2774_d20251114_m043512_c001_v0001178_t0003_u01763094912885") 2025/11/14 04:35:20 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f720d13a00d8b0b9fa80e1b_f415744888f461711_d20251114_m043129_c001_v7007000_t0000_u01763094689263") 2025/11/14 04:35:22 INFO : B2 bucket rclone-test-nibinos7xugu: cleaning bucket "rclone-test-nibinos7xugu" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (365.88s) --- 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 (1.46s) --- PASS: TestIntegration/FsMkdir (361.72s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.54s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding (19.95s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (2.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.95s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.97s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.13s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (5.89s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (101.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.37s) --- 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.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (1.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (8.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (4.87s) --- 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.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.21s) --- 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.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.56s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (9.13s) --- 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.56s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.59s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (44.71s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (19.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (0.97s) --- 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 (18.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (21.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (3.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.41s) --- 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.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (4.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.59s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (183.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (27.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.43s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.78s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.82s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (8.93s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.44s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (27.32s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (8.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (4.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (10.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (5.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (9.16s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.95s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (31.30s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (12.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (9.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (9.01s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.40s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (9.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.82s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (27.86s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.53s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.30s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (9.63s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (4.79s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (9.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.06s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (30.95s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (9.08s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (11.16s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (38.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (10.11s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (5.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (12.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.92s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (16.32s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.94s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (35.65s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.07s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (10.57s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (6.17s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (8.68s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (6.15s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (1.80s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.80s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.30s) --- 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 365.906s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 6m6.713866506s (try 1/5)