"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/07/19 04:02:45 NOTICE: TestB2: Starting server 2025/07/19 04:02:45 DEBUG : Creating backend with remote "TestB2:rclone-test-soranug5jiri" 2025/07/19 04:02:45 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/07/19 04:02:47 INFO : dir/subdir: Making directory fstest.go:247: Filtering empty directory "dir" fstest.go:247: Filtering empty directory "dir/subdir" 2025/07/19 04:02:48 INFO : dir/subdir: Removing directory fstest.go:247: Filtering empty directory "dir" 2025/07/19 04:02:48 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/07/19 04:03:15 DEBUG : writer-at-subdir/writer-at-file: Streaming upload with --b2-chunk-size 96Mi allows uploads of up to 937.500Gi and will fail only when that limit is reached. 2025/07/19 04:03:15 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/07/19 04:03:18 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/07/19 04:03:18 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/07/19 04:03:18 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/07/19 04:03:18 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/07/19 04:03:19 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/07/19 04:03:19 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/07/19 04:03:26 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/07/19 04:03:27 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/07/19 04:03:32 INFO : B2 bucket rclone-test-soranug5jiri: cleaning bucket "rclone-test-soranug5jiri" of all files 2025/07/19 04:03:33 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad2f_d20250719_m040331_c001_v0001029_t0033_u01752897811908") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/07/19 04:03:34 DEBUG : Creating backend with remote "TestB2:rclone-test-soranug5jiri/dirToPurgeFromRoot" 2025/07/19 04:03:35 INFO : B2 bucket rclone-test-soranug5jiri path dirToPurgeFromRoot: cleaning bucket "rclone-test-soranug5jiri" of all files 2025/07/19 04:03:36 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad39_d20250719_m040333_c001_v0001029_t0028_u01752897813618") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/07/19 04:03:36 DEBUG : Creating backend with remote "TestB2:rclone-test-soranug5jiri/hello? sausage/êé" 2025/07/19 04:03:40 INFO : B2 bucket rclone-test-soranug5jiri path hello? sausage/êé: cleaning bucket "rclone-test-soranug5jiri" of all files 2025/07/19 04:03:41 DEBUG : a/b/c/d/e.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f115272731ce65b52_d20250719_m040339_c001_v0001171_t0023_u01752897819183") === 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/07/19 04:03:50 DEBUG : Creating backend with remote "TestB2:rclone-test-soranug5jiri/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/19 04:03:52 DEBUG : Creating backend with remote "TestB2:rclone-test-soranug5jiri/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-soranug5jiri" from "TestB2:rclone-test-soranug5jiri" 2025/07/19 04:03:53 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/07/19 04:04:05 DEBUG : Creating backend with remote "TestB2:rclone-test-hikebop3yimu" 2025/07/19 04:04:05 DEBUG : Config file has changed externally - reloading 2025/07/19 04:04:08 DEBUG : B2 bucket rclone-test-hikebop3yimu: Purge remote 2025/07/19 04:04:08 INFO : B2 bucket rclone-test-hikebop3yimu: cleaning bucket "rclone-test-hikebop3yimu" of all files 2025/07/19 04:04:08 DEBUG : somefile: Deleting (id "4_z3ff27db3d0ad2b0b9f880e1b_f403c5924dec4092b_d20250719_m040407_c001_v0001117_t0023_u01752897847104") === 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/07/19 04:04:09 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/19 04:04:10 DEBUG : piped data.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB 2025/07/19 04:04:13 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/07/19 04:04:13 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/07/19 04:04:13 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.798Ki offset 6Mi/6.106Mi 2025/07/19 04:04:13 DEBUG : test-metadata: Sending chunk 1 length 111409 2025/07/19 04:04:15 DEBUG : test-metadata: Done sending chunk 1 2025/07/19 04:04:16 DEBUG : test-metadata: Done sending chunk 0 2025/07/19 04:04:16 DEBUG : test-metadata: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions 2025/07/19 04:04:26 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1029-09.backblaze.com/b2api/v1/b2_upload_file/0ff24d83d09d2b0b9f880e1b/c001_v0001029_t0025": EOF 2025/07/19 04:04:26 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1029-09.backblaze.com/b2api/v1/b2_upload_file/0ff24d83d09d2b0b9f880e1b/c001_v0001029_t0025": EOF) 2025/07/19 04:04:26 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1029-09.backblaze.com/b2api/v1/b2_upload_file/0ff24d83d09d2b0b9f880e1b/c001_v0001029_t0025": EOF - low level retry 1/10 2025/07/19 04:04:28 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent === NAME TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions-v2025-07-19-040421-007.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/07/19 04:04:30 DEBUG : oldPath = "TestB2:rclone-test-soranug5jiri/versions/test-versions-v2025-07-19-040421-007.txt" 2025/07/19 04:04:30 DEBUG : newPath = "TestB2,versions:rclone-test-soranug5jiri/versions/test-versions-v2025-07-19-040421-007.txt" 2025/07/19 04:04:30 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-soranug5jiri/versions/test-versions-v2025-07-19-040421-007.txt" 2025/07/19 04:04:30 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/07/19 04:04:32 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-soranug5jiri/versions/test-versions-v2025-07-19-040421-007.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-soranug5jiri/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/07/19 04:04:35 INFO : B2 bucket rclone-test-soranug5jiri: cleaning bucket "rclone-test-soranug5jiri" of all hidden files 2025/07/19 04:04:35 DEBUG : leading space/ leading space: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c06d_d20250719_m040256_c001_v7007000_t0000_u01752897776493") as it is a hide marker 2025/07/19 04:04:35 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : leading space/ leading space: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac97_d20250719_m040255_c001_v0001029_t0033_u01752897775754") 2025/07/19 04:04:35 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c069_d20250719_m040255_c001_v7007000_t0000_u01752897775392") as it is a hide marker 2025/07/19 04:04:35 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac93_d20250719_m040254_c001_v0001029_t0009_u01752897774147") 2025/07/19 04:04:35 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c094_d20250719_m040303_c001_v7007000_t0000_u01752897783583") as it is a hide marker 2025/07/19 04:04:35 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : .leading dot/.leading dot: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acb7_d20250719_m040302_c001_v0001029_t0042_u01752897782767") 2025/07/19 04:04:35 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : created from root.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c101_d20250719_m040401_c001_v7007000_t0000_u01752897841147") as it is a hide marker 2025/07/19 04:04:35 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : created from root.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f10511dba61cbff08_d20250719_m040400_c001_v0001130_t0025_u01752897840152") 2025/07/19 04:04:35 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : file name.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d74_d20250719_m040409_c001_v7007000_t0000_u01752897849138") as it is a hide marker 2025/07/19 04:04:35 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad5f_d20250719_m040349_c001_v0001029_t0003_u01752897829175") 2025/07/19 04:04:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11038a7b64f27c64_d20250719_m040345_c001_v0001157_t0031_u01752897825522") 2025/07/19 04:04:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad05_d20250719_m040323_c001_v0001029_t0034_u01752897803890") 2025/07/19 04:04:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acff_d20250719_m040322_c001_v0001029_t0034_u01752897802565") 2025/07/19 04:04:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad01_d20250719_m040323_c001_v0001029_t0032_u01752897803191") "upload" dated 2025-07-19 04:03:23.191 +0000 UTC (1m12.321041302s ago) 2025/07/19 04:04:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4038bbaa9dc2669e_d20250719_m040343_c001_v7007000_t0000_u01752897823263") as it is a hide marker 2025/07/19 04:04:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f1065b80bbe152ee3_d20250719_m040343_c001_v0001177_t0053_u01752897823053") 2025/07/19 04:04:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f1145651017afbe2e_d20250719_m040342_c001_v0001131_t0023_u01752897822227") 2025/07/19 04:04:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09e_d20250719_m040312_c001_v7007000_t0000_u01752897792286") as it is a hide marker 2025/07/19 04:04:35 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acd9_d20250719_m040311_c001_v0001029_t0011_u01752897791368") 2025/07/19 04:04:35 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : piped data.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d77_d20250719_m040411_c001_v7007000_t0000_u01752897851116") as it is a hide marker 2025/07/19 04:04:35 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : piped data.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad83_d20250719_m040410_c001_v0001029_t0000_u01752897850425") 2025/07/19 04:04:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : piped data.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d76_d20250719_m040410_c001_v7007000_t0000_u01752897850243") 2025/07/19 04:04:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : piped data.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f409226aa0f83ad7f_d20250719_m040409_c001_v0001029_t0025_u01752897849874") 2025/07/19 04:04:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09f_d20250719_m040313_c001_v7007000_t0000_u01752897793648") as it is a hide marker 2025/07/19 04:04:35 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acdd_d20250719_m040312_c001_v0001029_t0027_u01752897792648") 2025/07/19 04:04:35 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : test-metadata: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f400b9fa7d85ba3c4_d20250719_m040418_c001_v7007000_t0000_u01752897858458") as it is a hide marker 2025/07/19 04:04:35 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : test-metadata: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f213da27b02fd0d79_d20250719_m040413_c001_v0001176_t0014_u01752897853502") 2025/07/19 04:04:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : test-metadata: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d78_d20250719_m040412_c001_v7007000_t0000_u01752897852450") 2025/07/19 04:04:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : test-metadata: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad89_d20250719_m040411_c001_v0001029_t0031_u01752897851302") 2025/07/19 04:04:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c096_d20250719_m040305_c001_v7007000_t0000_u01752897785869") as it is a hide marker 2025/07/19 04:04:35 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acc1_d20250719_m040305_c001_v0001029_t0009_u01752897785043") 2025/07/19 04:04:35 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c099_d20250719_m040308_c001_v7007000_t0000_u01752897788724") as it is a hide marker 2025/07/19 04:04:35 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acc9_d20250719_m040307_c001_v0001029_t0035_u01752897787945") 2025/07/19 04:04:35 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c098_d20250719_m040307_c001_v7007000_t0000_u01752897787531") as it is a hide marker 2025/07/19 04:04:35 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acc5_d20250719_m040306_c001_v0001029_t0013_u01752897786232") 2025/07/19 04:04:35 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09a_d20250719_m040309_c001_v7007000_t0000_u01752897789889") as it is a hide marker 2025/07/19 04:04:35 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83accf_d20250719_m040309_c001_v0001029_t0028_u01752897789085") 2025/07/19 04:04:35 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09c_d20250719_m040311_c001_v7007000_t0000_u01752897791006") as it is a hide marker 2025/07/19 04:04:35 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acd5_d20250719_m040310_c001_v0001029_t0022_u01752897790251") 2025/07/19 04:04:35 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing space /trailing space : Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c095_d20250719_m040304_c001_v7007000_t0000_u01752897784680") as it is a hide marker 2025/07/19 04:04:35 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : trailing space /trailing space : Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acbf_d20250719_m040303_c001_v0001029_t0020_u01752897783945") 2025/07/19 04:04:35 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa6122f_d20250719_m040429_c001_v0001134_t0032_u01752897869050") "upload" dated 2025-07-19 04:04:29.05 +0000 UTC (6.462890767s ago) 2025/07/19 04:04:35 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f42277695e0665ce2_d20250719_m040424_c001_v7007000_t0000_u01752897864261") 2025/07/19 04:04:35 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad9b_d20250719_m040421_c001_v0001029_t0025_u01752897861007") 2025/07/19 04:04:35 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c0a9_d20250719_m040322_c001_v7007000_t0000_u01752897802020") as it is a hide marker 2025/07/19 04:04:35 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2082a78421d8c0a1_d20250719_m040315_c001_v0001137_t0015_u01752897795829") 2025/07/19 04:04:35 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : zero-length-file: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c0a0_d20250719_m040315_c001_v7007000_t0000_u01752897795485") as it is a hide marker 2025/07/19 04:04:35 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : zero-length-file: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f409226aa0f83ace9_d20250719_m040314_c001_v0001029_t0025_u01752897794931") 2025/07/19 04:04:35 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c073_d20250719_m040257_c001_v7007000_t0000_u01752897777764") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac9b_d20250719_m040256_c001_v0001029_t0042_u01752897776855") 2025/07/19 04:04:35 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c04f_d20250719_m040251_c001_v7007000_t0000_u01752897771391") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac7f_d20250719_m040250_c001_v0001029_t0035_u01752897770206") 2025/07/19 04:04:35 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c086_d20250719_m040301_c001_v7007000_t0000_u01752897781306") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acab_d20250719_m040300_c001_v0001029_t0030_u01752897780447") 2025/07/19 04:04:35 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c082_d20250719_m040300_c001_v7007000_t0000_u01752897780082") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83aca3_d20250719_m040259_c001_v0001029_t0024_u01752897779298") 2025/07/19 04:04:35 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c08d_d20250719_m040302_c001_v7007000_t0000_u01752897782404") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acb3_d20250719_m040301_c001_v0001029_t0031_u01752897781668") 2025/07/19 04:04:35 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c07b_d20250719_m040258_c001_v7007000_t0000_u01752897778937") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac9f_d20250719_m040258_c001_v0001029_t0035_u01752897778125") 2025/07/19 04:04:35 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ./.: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c05d_d20250719_m040252_c001_v7007000_t0000_u01752897772632") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ./.: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ./.: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac87_d20250719_m040251_c001_v0001029_t0014_u01752897771752") 2025/07/19 04:04:35 NOTICE: ./.: Skipped delete as --dry-run is set 2025/07/19 04:04:35 DEBUG : ../..: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c062_d20250719_m040253_c001_v7007000_t0000_u01752897773786") as it is a hide marker 2025/07/19 04:04:35 NOTICE: ../..: Skipped remove hide marker as --dry-run is set 2025/07/19 04:04:35 DEBUG : ../..: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac8b_d20250719_m040252_c001_v0001029_t0022_u01752897772992") 2025/07/19 04:04:35 NOTICE: ../..: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/07/19 04:04:35 INFO : B2 bucket rclone-test-soranug5jiri: cleaning bucket "rclone-test-soranug5jiri" of all hidden files 2025/07/19 04:04:35 DEBUG : leading space/ leading space: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c06d_d20250719_m040256_c001_v7007000_t0000_u01752897776493") as it is a hide marker 2025/07/19 04:04:35 DEBUG : leading space/ leading space: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac97_d20250719_m040255_c001_v0001029_t0033_u01752897775754") 2025/07/19 04:04:35 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c069_d20250719_m040255_c001_v7007000_t0000_u01752897775392") as it is a hide marker 2025/07/19 04:04:35 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac93_d20250719_m040254_c001_v0001029_t0009_u01752897774147") 2025/07/19 04:04:35 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c094_d20250719_m040303_c001_v7007000_t0000_u01752897783583") as it is a hide marker 2025/07/19 04:04:35 DEBUG : .leading dot/.leading dot: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acb7_d20250719_m040302_c001_v0001029_t0042_u01752897782767") 2025/07/19 04:04:35 DEBUG : created from root.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c101_d20250719_m040401_c001_v7007000_t0000_u01752897841147") as it is a hide marker 2025/07/19 04:04:35 DEBUG : created from root.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f10511dba61cbff08_d20250719_m040400_c001_v0001130_t0025_u01752897840152") 2025/07/19 04:04:35 DEBUG : file name.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d74_d20250719_m040409_c001_v7007000_t0000_u01752897849138") as it is a hide marker 2025/07/19 04:04:36 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad5f_d20250719_m040349_c001_v0001029_t0003_u01752897829175") 2025/07/19 04:04:36 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11038a7b64f27c64_d20250719_m040345_c001_v0001157_t0031_u01752897825522") 2025/07/19 04:04:36 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad05_d20250719_m040323_c001_v0001029_t0034_u01752897803890") 2025/07/19 04:04:36 DEBUG : file name.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acff_d20250719_m040322_c001_v0001029_t0034_u01752897802565") 2025/07/19 04:04:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad01_d20250719_m040323_c001_v0001029_t0032_u01752897803191") "upload" dated 2025-07-19 04:03:23.191 +0000 UTC (1m13.348985749s ago) 2025/07/19 04:04:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4038bbaa9dc2669e_d20250719_m040343_c001_v7007000_t0000_u01752897823263") as it is a hide marker 2025/07/19 04:04:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f1065b80bbe152ee3_d20250719_m040343_c001_v0001177_t0053_u01752897823053") 2025/07/19 04:04:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f1145651017afbe2e_d20250719_m040342_c001_v0001131_t0023_u01752897822227") 2025/07/19 04:04:36 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09e_d20250719_m040312_c001_v7007000_t0000_u01752897792286") as it is a hide marker 2025/07/19 04:04:36 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acd9_d20250719_m040311_c001_v0001029_t0011_u01752897791368") 2025/07/19 04:04:36 DEBUG : piped data.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d77_d20250719_m040411_c001_v7007000_t0000_u01752897851116") as it is a hide marker 2025/07/19 04:04:36 DEBUG : piped data.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad83_d20250719_m040410_c001_v0001029_t0000_u01752897850425") 2025/07/19 04:04:36 DEBUG : piped data.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d76_d20250719_m040410_c001_v7007000_t0000_u01752897850243") 2025/07/19 04:04:36 DEBUG : piped data.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f409226aa0f83ad7f_d20250719_m040409_c001_v0001029_t0025_u01752897849874") 2025/07/19 04:04:36 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09f_d20250719_m040313_c001_v7007000_t0000_u01752897793648") as it is a hide marker 2025/07/19 04:04:37 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acdd_d20250719_m040312_c001_v0001029_t0027_u01752897792648") 2025/07/19 04:04:37 DEBUG : test-metadata: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f400b9fa7d85ba3c4_d20250719_m040418_c001_v7007000_t0000_u01752897858458") as it is a hide marker 2025/07/19 04:04:37 DEBUG : test-metadata: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f213da27b02fd0d79_d20250719_m040413_c001_v0001176_t0014_u01752897853502") 2025/07/19 04:04:37 DEBUG : test-metadata: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f413da27b02fd0d78_d20250719_m040412_c001_v7007000_t0000_u01752897852450") 2025/07/19 04:04:37 DEBUG : test-metadata: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad89_d20250719_m040411_c001_v0001029_t0031_u01752897851302") 2025/07/19 04:04:37 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c096_d20250719_m040305_c001_v7007000_t0000_u01752897785869") as it is a hide marker 2025/07/19 04:04:37 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acc1_d20250719_m040305_c001_v0001029_t0009_u01752897785043") 2025/07/19 04:04:37 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c099_d20250719_m040308_c001_v7007000_t0000_u01752897788724") as it is a hide marker 2025/07/19 04:04:37 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acc9_d20250719_m040307_c001_v0001029_t0035_u01752897787945") 2025/07/19 04:04:37 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c098_d20250719_m040307_c001_v7007000_t0000_u01752897787531") as it is a hide marker 2025/07/19 04:04:37 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acc5_d20250719_m040306_c001_v0001029_t0013_u01752897786232") 2025/07/19 04:04:37 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09a_d20250719_m040309_c001_v7007000_t0000_u01752897789889") as it is a hide marker 2025/07/19 04:04:37 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83accf_d20250719_m040309_c001_v0001029_t0028_u01752897789085") 2025/07/19 04:04:37 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c09c_d20250719_m040311_c001_v7007000_t0000_u01752897791006") as it is a hide marker 2025/07/19 04:04:37 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acd5_d20250719_m040310_c001_v0001029_t0022_u01752897790251") 2025/07/19 04:04:37 DEBUG : trailing space /trailing space : Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c095_d20250719_m040304_c001_v7007000_t0000_u01752897784680") as it is a hide marker 2025/07/19 04:04:37 DEBUG : trailing space /trailing space : Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acbf_d20250719_m040303_c001_v0001029_t0020_u01752897783945") 2025/07/19 04:04:37 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa6122f_d20250719_m040429_c001_v0001134_t0032_u01752897869050") "upload" dated 2025-07-19 04:04:29.05 +0000 UTC (8.795567949s ago) 2025/07/19 04:04:37 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f42277695e0665ce2_d20250719_m040424_c001_v7007000_t0000_u01752897864261") 2025/07/19 04:04:37 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad9b_d20250719_m040421_c001_v0001029_t0025_u01752897861007") 2025/07/19 04:04:37 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c0a9_d20250719_m040322_c001_v7007000_t0000_u01752897802020") as it is a hide marker 2025/07/19 04:04:38 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2082a78421d8c0a1_d20250719_m040315_c001_v0001137_t0015_u01752897795829") 2025/07/19 04:04:38 DEBUG : zero-length-file: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c0a0_d20250719_m040315_c001_v7007000_t0000_u01752897795485") as it is a hide marker 2025/07/19 04:04:38 DEBUG : zero-length-file: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f409226aa0f83ace9_d20250719_m040314_c001_v0001029_t0025_u01752897794931") 2025/07/19 04:04:38 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c073_d20250719_m040257_c001_v7007000_t0000_u01752897777764") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac9b_d20250719_m040256_c001_v0001029_t0042_u01752897776855") 2025/07/19 04:04:38 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c04f_d20250719_m040251_c001_v7007000_t0000_u01752897771391") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac7f_d20250719_m040250_c001_v0001029_t0035_u01752897770206") 2025/07/19 04:04:38 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c086_d20250719_m040301_c001_v7007000_t0000_u01752897781306") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acab_d20250719_m040300_c001_v0001029_t0030_u01752897780447") 2025/07/19 04:04:38 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c082_d20250719_m040300_c001_v7007000_t0000_u01752897780082") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83aca3_d20250719_m040259_c001_v0001029_t0024_u01752897779298") 2025/07/19 04:04:38 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c08d_d20250719_m040302_c001_v7007000_t0000_u01752897782404") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83acb3_d20250719_m040301_c001_v0001029_t0031_u01752897781668") 2025/07/19 04:04:38 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c07b_d20250719_m040258_c001_v7007000_t0000_u01752897778937") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac9f_d20250719_m040258_c001_v0001029_t0035_u01752897778125") 2025/07/19 04:04:38 DEBUG : ./.: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c05d_d20250719_m040252_c001_v7007000_t0000_u01752897772632") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ./.: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac87_d20250719_m040251_c001_v0001029_t0014_u01752897771752") 2025/07/19 04:04:38 DEBUG : ../..: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f4082a78421d8c062_d20250719_m040253_c001_v7007000_t0000_u01752897773786") as it is a hide marker 2025/07/19 04:04:38 DEBUG : ../..: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ac8b_d20250719_m040252_c001_v0001029_t0022_u01752897772992") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/07/19 04:04:39 DEBUG : unfinished/unfinished-1: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. 2025/07/19 04:04:39 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/07/19 04:04:39 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/07/19 04:04:40 DEBUG : unfinished/unfinished-4: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun 2025/07/19 04:04:40 INFO : B2 bucket rclone-test-soranug5jiri: cleaning bucket "rclone-test-soranug5jiri" of pending multipart uploads older than 0s 2025/07/19 04:04:40 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad01_d20250719_m040323_c001_v0001029_t0032_u01752897803191") "upload" dated 2025-07-19 04:03:23.191 +0000 UTC (1m17.487881182s ago) 2025/07/19 04:04:40 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819852_d20250719_m040439_c001_v0001153_t0024_u01752897879655") as it is a start marker (upload started at 2025-07-19 04:04:39.655 +0000 UTC) 2025/07/19 04:04:40 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/07/19 04:04:40 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819853_d20250719_m040439_c001_v0001120_t0036_u01752897879839") as it is a start marker (upload started at 2025-07-19 04:04:39.839 +0000 UTC) 2025/07/19 04:04:40 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/07/19 04:04:40 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819854_d20250719_m040440_c001_v0001109_t0019_u01752897880025") as it is a start marker (upload started at 2025-07-19 04:04:40.025 +0000 UTC) 2025/07/19 04:04:40 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/07/19 04:04:40 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819855_d20250719_m040440_c001_v0001120_t0034_u01752897880209") as it is a start marker (upload started at 2025-07-19 04:04:40.209 +0000 UTC) 2025/07/19 04:04:40 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/07/19 04:04:40 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f401de7017e819851_d20250719_m040439_c001_v7007000_t0000_u01752897879472") "hide" dated 2025-07-19 04:04:39.472 +0000 UTC (1.207294969s ago) 2025/07/19 04:04:40 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa6122f_d20250719_m040429_c001_v0001134_t0032_u01752897869050") 2025/07/19 04:04:40 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/07/19 04:04:40 INFO : B2 bucket rclone-test-soranug5jiri: cleaning bucket "rclone-test-soranug5jiri" of pending multipart uploads older than 0s 2025/07/19 04:04:41 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad01_d20250719_m040323_c001_v0001029_t0032_u01752897803191") "upload" dated 2025-07-19 04:03:23.191 +0000 UTC (1m17.861803358s ago) 2025/07/19 04:04:41 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819852_d20250719_m040439_c001_v0001153_t0024_u01752897879655") as it is a start marker (upload started at 2025-07-19 04:04:39.655 +0000 UTC) 2025/07/19 04:04:41 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819853_d20250719_m040439_c001_v0001120_t0036_u01752897879839") as it is a start marker (upload started at 2025-07-19 04:04:39.839 +0000 UTC) 2025/07/19 04:04:41 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819854_d20250719_m040440_c001_v0001109_t0019_u01752897880025") as it is a start marker (upload started at 2025-07-19 04:04:40.025 +0000 UTC) 2025/07/19 04:04:41 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819855_d20250719_m040440_c001_v0001120_t0034_u01752897880209") as it is a start marker (upload started at 2025-07-19 04:04:40.209 +0000 UTC) 2025/07/19 04:04:41 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z0ff24d83d09d2b0b9f880e1b_f401de7017e819851_d20250719_m040439_c001_v7007000_t0000_u01752897879472") "hide" dated 2025-07-19 04:04:39.472 +0000 UTC (1.580991481s ago) 2025/07/19 04:04:41 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa6122f_d20250719_m040429_c001_v0001134_t0032_u01752897869050") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/07/19 04:04:41 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/07/19 04:04:41 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/07/19 04:04:42 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 2025/07/19 04:04:43 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/07/19 04:04:43 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/07/19 04:04:43 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/07/19 04:04:43 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/07/19 04:04:44 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/07/19 04:04:45 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/07/19 04:04:45 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/07/19 04:04:48 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:04:48 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/07/19 04:04:48 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f2051ed0cc8feecf2_d20250719_m040448_c001_v0001115_t0012_u01752897888681") 2025/07/19 04:04:48 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:04:48 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/07/19 04:04:48 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/07/19 04:04:48 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/07/19 04:04:48 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/07/19 04:04:48 DEBUG : pacer: Reducing sleep to 10ms 2025/07/19 04:04:49 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:04:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:04:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/07/19 04:04:53 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/07/19 04:04:53 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/07/19 04:04:53 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/07/19 04:04:53 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/07/19 04:04:55 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/07/19 04:04:55 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/07/19 04:04:55 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/07/19 04:04:57 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:04:57 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/07/19 04:04:57 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f214051681056cd99_d20250719_m040457_c001_v0001165_t0011_u01752897897437") 2025/07/19 04:04:57 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/07/19 04:04:57 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/07/19 04:04:57 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/07/19 04:04:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:04:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:04:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/07/19 04:05:01 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/07/19 04:05:01 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/07/19 04:05:01 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/07/19 04:05:01 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/07/19 04:05:01 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/07/19 04:05:01 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/07/19 04:05:02 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/07/19 04:05:04 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/07/19 04:05:06 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/07/19 04:05:06 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/07/19 04:05:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:05:09 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/07/19 04:05:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f2194e83287b946c3_d20250719_m040509_c001_v0001044_t0013_u01752897909546") 2025/07/19 04:05:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/07/19 04:05:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:05:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/07/19 04:05:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/07/19 04:05:10 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/07/19 04:05:12 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:05:12 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:05:12 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/07/19 04:05:14 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/07/19 04:05:14 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/07/19 04:05:14 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/07/19 04:05:14 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/07/19 04:05:16 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/07/19 04:05:17 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/07/19 04:05:17 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/07/19 04:05:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:05:18 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/07/19 04:05:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f2194e83287b94765_d20250719_m040518_c001_v0001157_t0027_u01752897918373") 2025/07/19 04:05:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:05:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/07/19 04:05:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/07/19 04:05:19 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:05:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:05:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/07/19 04:05:22 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/07/19 04:05:22 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/07/19 04:05:22 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/07/19 04:05:22 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/07/19 04:05:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/07/19 04:05:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/07/19 04:05:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/07/19 04:05:26 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:05:26 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/07/19 04:05:26 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8d46_d20250719_m040526_c001_v0001106_t0055_u01752897926785") 2025/07/19 04:05:26 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/07/19 04:05:27 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/07/19 04:05:27 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/07/19 04:05:29 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:05:30 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:05:30 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/07/19 04:05:31 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/07/19 04:05:31 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/07/19 04:05:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/07/19 04:05:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/07/19 04:05:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/07/19 04:05:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/07/19 04:05:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/07/19 04:05:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/07/19 04:05:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/07/19 04:05:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/07/19 04:05:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:05:35 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/07/19 04:05:36 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8ddc_d20250719_m040535_c001_v0001038_t0048_u01752897935967") 2025/07/19 04:05:36 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/07/19 04:05:36 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:05:36 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/07/19 04:05:36 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/07/19 04:05:37 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/07/19 04:05:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:05:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:05:38 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/07/19 04:05:40 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/07/19 04:05:40 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/07/19 04:05:40 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/07/19 04:05:40 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/07/19 04:05:42 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/07/19 04:05:42 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/07/19 04:05:42 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/07/19 04:05:44 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:05:44 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/07/19 04:05:44 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8ea1_d20250719_m040544_c001_v0001100_t0001_u01752897944315") 2025/07/19 04:05:44 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:05:44 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/07/19 04:05:44 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/07/19 04:05:45 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:05:46 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:05:46 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/07/19 04:05:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/07/19 04:05:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/07/19 04:05:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/07/19 04:05:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/07/19 04:05:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/07/19 04:05:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/07/19 04:05:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/07/19 04:05:52 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:05:52 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/07/19 04:05:52 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f2108a2f0e59947f2_d20250719_m040552_c001_v0001093_t0050_u01752897952365") 2025/07/19 04:05:52 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/07/19 04:05:52 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/07/19 04:05:52 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/07/19 04:05:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00024b320), retryAfter:1000000000} 2025/07/19 04:05:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/07/19 04:05:54 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/07/19 04:05:54 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/07/19 04:05:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/07/19 04:05:55 DEBUG : pacer: Reducing sleep to 500ms 2025/07/19 04:06:01 DEBUG : pacer: Reducing sleep to 250ms 2025/07/19 04:06:01 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:06:03 DEBUG : pacer: Reducing sleep to 125ms 2025/07/19 04:06:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:06:03 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts 2025/07/19 04:06:04 DEBUG : pacer: Reducing sleep to 62.5ms 2025/07/19 04:06:05 DEBUG : pacer: Reducing sleep to 31.25ms 2025/07/19 04:06:05 DEBUG : pacer: Reducing sleep to 15.625ms 2025/07/19 04:06:07 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/07/19 04:06:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/07/19 04:06:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/07/19 04:06:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/07/19 04:06:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/07/19 04:06:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/07/19 04:06:07 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/07/19 04:06:08 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/07/19 04:06:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/07/19 04:06:10 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/07/19 04:06:10 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/07/19 04:06:11 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:06:11 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/07/19 04:06:11 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f202cfeb28c0dfd99_d20250719_m040611_c001_v0001178_t0005_u01752897971838") 2025/07/19 04:06:11 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/07/19 04:06:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:06:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/07/19 04:06:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/07/19 04:06:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/07/19 04:06:14 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:06:14 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:06:14 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/07/19 04:06:16 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/07/19 04:06:16 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/07/19 04:06:16 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/07/19 04:06:16 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/07/19 04:06:17 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/07/19 04:06:18 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/07/19 04:06:18 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/07/19 04:06:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:06:20 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/07/19 04:06:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f202cfeb28c0dfdac_d20250719_m040620_c001_v0001183_t0030_u01752897980287") 2025/07/19 04:06:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:06:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/07/19 04:06:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/07/19 04:06:21 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:06:22 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:06:22 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/07/19 04:06:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/07/19 04:06:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/07/19 04:06:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/07/19 04:06:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/07/19 04:06:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/07/19 04:06:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/07/19 04:06:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/07/19 04:06:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:06:41 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/07/19 04:06:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769df5_d20250719_m040641_c001_v0001117_t0044_u01752898001218") 2025/07/19 04:06:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/07/19 04:06:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/07/19 04:06:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/07/19 04:06:44 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:06:44 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:06:44 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/07/19 04:06:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/07/19 04:06:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/07/19 04:06:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/07/19 04:06:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/07/19 04:06:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/07/19 04:06:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/07/19 04:06:47 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/07/19 04:06:48 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/07/19 04:06:49 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/07/19 04:06:49 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/07/19 04:06:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:06:51 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/07/19 04:06:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f2051ed0cc8fef851_d20250719_m040651_c001_v0001041_t0052_u01752898011389") 2025/07/19 04:06:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/07/19 04:06:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:06:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/07/19 04:06:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/07/19 04:06:52 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/07/19 04:06:54 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:06:56 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:06:56 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/07/19 04:07:00 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/07/19 04:07:00 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/07/19 04:07:00 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/07/19 04:07:00 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/07/19 04:07:02 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/07/19 04:07:03 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/07/19 04:07:03 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/07/19 04:07:04 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:07:04 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/07/19 04:07:04 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f219b0467b22999aa_d20250719_m040704_c001_v0001098_t0034_u01752898024744") 2025/07/19 04:07:04 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:07:04 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/07/19 04:07:04 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/07/19 04:07:06 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:07:07 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:07:07 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/07/19 04:07:09 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/07/19 04:07:09 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/07/19 04:07:09 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/07/19 04:07:09 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/07/19 04:07:11 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/07/19 04:07:12 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/07/19 04:07:12 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/07/19 04:07:14 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:07:14 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/07/19 04:07:14 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769ed0_d20250719_m040714_c001_v0001184_t0052_u01752898034171") 2025/07/19 04:07:14 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/07/19 04:07:14 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/07/19 04:07:14 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/07/19 04:07:16 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:07:16 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:07:16 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/07/19 04:07:19 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/07/19 04:07:19 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/07/19 04:07:19 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/07/19 04:07:19 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/07/19 04:07:19 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/07/19 04:07:19 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/07/19 04:07:20 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/07/19 04:07:21 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/07/19 04:07:22 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/07/19 04:07:22 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/07/19 04:07:24 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:07:24 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/07/19 04:07:24 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f22277695e0666393_d20250719_m040724_c001_v0001171_t0057_u01752898044558") 2025/07/19 04:07:24 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/07/19 04:07:24 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:07:24 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/07/19 04:07:24 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/07/19 04:07:25 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/07/19 04:07:27 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:07:28 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:07:28 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/07/19 04:07:30 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/07/19 04:07:30 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/07/19 04:07:30 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/07/19 04:07:30 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/07/19 04:07:32 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/07/19 04:07:33 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/07/19 04:07:33 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/07/19 04:07:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:07:35 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/07/19 04:07:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f206b16a998363688_d20250719_m040735_c001_v0001178_t0002_u01752898055782") 2025/07/19 04:07:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:07:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/07/19 04:07:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/07/19 04:07:36 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/07/19 04:07:36 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/07/19 04:07:36 DEBUG : pacer: Reducing sleep to 10ms 2025/07/19 04:07:36 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:07:38 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:07:38 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/07/19 04:07:40 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/07/19 04:07:40 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/07/19 04:07:40 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/07/19 04:07:40 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/07/19 04:07:43 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/07/19 04:07:43 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/07/19 04:07:43 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/07/19 04:07:46 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:07:46 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/07/19 04:07:46 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f217d3dc9e7c0f5ac_d20250719_m040746_c001_v0001184_t0043_u01752898066314") 2025/07/19 04:07:46 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/07/19 04:07:46 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/07/19 04:07:46 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/07/19 04:07:48 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:07:49 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:07:49 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/07/19 04:07:51 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/07/19 04:07:51 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/07/19 04:07:52 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/07/19 04:07:52 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/07/19 04:07:52 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/07/19 04:07:52 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/07/19 04:07:53 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/07/19 04:07:54 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/07/19 04:07:55 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/07/19 04:07:55 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/07/19 04:07:57 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/07/19 04:07:57 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/07/19 04:07:57 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_z0ff24d83d09d2b0b9f880e1b_f21885b8a7e2c1753_d20250719_m040757_c001_v0001184_t0034_u01752898077549") 2025/07/19 04:07:57 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/07/19 04:07:58 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/07/19 04:07:58 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/07/19 04:07:58 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/07/19 04:07:58 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/07/19 04:08:00 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/07/19 04:08:00 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/07/19 04:08:00 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/07/19 04:08:08 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf882b_d20250719_m040808_c001_v0001102_t0027_u01752898088538") 2025/07/19 04:08:08 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/07/19 04:08:08 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/07/19 04:08:09 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/07/19 04:08:09 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/07/19 04:08:09 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/07/19 04:08:11 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/07/19 04:08:11 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/07/19 04:08:11 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/07/19 04:08:11 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/07/19 04:08:13 DEBUG : chunked-copy: Done sending chunk 0 2025/07/19 04:08:13 DEBUG : chunked-copy: Done sending chunk 1 2025/07/19 04:08:13 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/07/19 04:08:14 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf8840_d20250719_m040814_c001_v0001032_t0037_u01752898094494") 2025/07/19 04:08:14 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/07/19 04:08:14 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/07/19 04:08:15 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/07/19 04:08:15 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/07/19 04:08:15 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/07/19 04:08:17 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/07/19 04:08:17 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/07/19 04:08:17 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/07/19 04:08:17 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/07/19 04:08:19 DEBUG : chunked-copy: Done sending chunk 0 2025/07/19 04:08:19 DEBUG : chunked-copy: Done sending chunk 1 2025/07/19 04:08:19 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/07/19 04:08:20 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf8844_d20250719_m040820_c001_v0001041_t0051_u01752898100334") 2025/07/19 04:08:20 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/07/19 04:08:20 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/07/19 04:08:20 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/07/19 04:08:21 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/07/19 04:08:21 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/07/19 04:08:23 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/07/19 04:08:23 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/07/19 04:08:23 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/07/19 04:08:23 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/07/19 04:08:25 DEBUG : chunked-copy: Done sending chunk 0 2025/07/19 04:08:26 DEBUG : chunked-copy: Done sending chunk 1 2025/07/19 04:08:26 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/07/19 04:08:26 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf8847_d20250719_m040826_c001_v0001116_t0034_u01752898106777") 2025/07/19 04:08:26 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/07/19 04:08:26 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/07/19 04:08:26 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/07/19 04:08:27 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/07/19 04:08:27 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/07/19 04:08:28 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/07/19 04:08:28 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/07/19 04:08:29 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/19 04:08:31 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/19 04:08:32 DEBUG : Creating backend with remote "TestB2:rclone-test-soranug5jiri/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/07/19 04:08:33 INFO : B2 bucket rclone-test-soranug5jiri: cleaning bucket "rclone-test-soranug5jiri" of all files 2025/07/19 04:08:34 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f417d3dc9e7c0f5a1_d20250719_m040739_c001_v7007000_t0000_u01752898059912") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f206b16a998363688_d20250719_m040735_c001_v0001178_t0002_u01752898055782") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f406b16a998363686_d20250719_m040735_c001_v7007000_t0000_u01752898055182") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f20549ea035de9440_d20250719_m040730_c001_v0001042_t0041_u01752898050139") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416115fae5bf8827_d20250719_m040802_c001_v7007000_t0000_u01752898082714") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21885b8a7e2c1753_d20250719_m040757_c001_v0001184_t0034_u01752898077549") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41885b8a7e2c174f_d20250719_m040756_c001_v7007000_t0000_u01752898076983") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f217d3dc9e7c0f5b4_d20250719_m040751_c001_v0001180_t0056_u01752898071441") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f417d3dc9e7c0f5b3_d20250719_m040751_c001_v7007000_t0000_u01752898071258") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f217d3dc9e7c0f5ac_d20250719_m040746_c001_v0001184_t0043_u01752898066314") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f417d3dc9e7c0f5a8_d20250719_m040745_c001_v7007000_t0000_u01752898065728") 2025/07/19 04:08:34 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f217d3dc9e7c0f5a2_d20250719_m040740_c001_v0001098_t0001_u01752898060094") 2025/07/19 04:08:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4108a2f0e59944dd_d20250719_m040540_c001_v7007000_t0000_u01752897940044") 2025/07/19 04:08:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8ddc_d20250719_m040535_c001_v0001038_t0048_u01752897935967") 2025/07/19 04:08:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4108a2f0e59943ea_d20250719_m040531_c001_v7007000_t0000_u01752897931325") 2025/07/19 04:08:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8d46_d20250719_m040526_c001_v0001106_t0055_u01752897926785") 2025/07/19 04:08:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41838196eadb8dd6_d20250719_m040535_c001_v7007000_t0000_u01752897935577") 2025/07/19 04:08:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2108a2f0e59943f2_d20250719_m040531_c001_v0001182_t0029_u01752897931510") 2025/07/19 04:08:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41838196eadb8d3e_d20250719_m040526_c001_v7007000_t0000_u01752897926369") 2025/07/19 04:08:35 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8cf9_d20250719_m040522_c001_v0001172_t0050_u01752897922261") 2025/07/19 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41838196eadb8cf6_d20250719_m040522_c001_v7007000_t0000_u01752897922077") 2025/07/19 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2194e83287b94765_d20250719_m040518_c001_v0001157_t0027_u01752897918373") 2025/07/19 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4194e83287b9475f_d20250719_m040517_c001_v7007000_t0000_u01752897917988") 2025/07/19 04:08:35 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8c81_d20250719_m040514_c001_v0001117_t0043_u01752897914127") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f42277695e0666199_d20250719_m040615_c001_v7007000_t0000_u01752897975766") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f202cfeb28c0dfd99_d20250719_m040611_c001_v0001178_t0005_u01752897971838") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f42277695e066612a_d20250719_m040607_c001_v7007000_t0000_u01752897967248") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2108a2f0e59947f2_d20250719_m040552_c001_v0001093_t0050_u01752897952365") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f402cfeb28c0dfd98_d20250719_m040611_c001_v7007000_t0000_u01752897971440") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f22277695e066612d_d20250719_m040607_c001_v0001184_t0050_u01752897967438") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4108a2f0e59947ec_d20250719_m040551_c001_v7007000_t0000_u01752897951938") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2108a2f0e599475b_d20250719_m040547_c001_v0001181_t0012_u01752897947941") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4108a2f0e599475a_d20250719_m040547_c001_v7007000_t0000_u01752897947752") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21838196eadb8ea1_d20250719_m040544_c001_v0001100_t0001_u01752897944315") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41838196eadb8e92_d20250719_m040543_c001_v7007000_t0000_u01752897943912") 2025/07/19 04:08:35 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2108a2f0e59944e2_d20250719_m040540_c001_v0001153_t0025_u01752897940229") 2025/07/19 04:08:35 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41838196eadb8c7e_d20250719_m040513_c001_v7007000_t0000_u01752897913937") 2025/07/19 04:08:35 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2194e83287b946c3_d20250719_m040509_c001_v0001044_t0013_u01752897909546") 2025/07/19 04:08:35 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4194e83287b946bb_d20250719_m040509_c001_v7007000_t0000_u01752897909158") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f214051681056cde9_d20250719_m040501_c001_v0001092_t0005_u01752897901456") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f414051681056cde1_d20250719_m040501_c001_v7007000_t0000_u01752897901261") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f214051681056cd99_d20250719_m040457_c001_v0001165_t0011_u01752897897437") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f414051681056cd91_d20250719_m040457_c001_v7007000_t0000_u01752897897024") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f214051681056cd87_d20250719_m040452_c001_v0001105_t0048_u01752897892863") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f414051681056cd86_d20250719_m040452_c001_v7007000_t0000_u01752897892676") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2051ed0cc8feecf2_d20250719_m040448_c001_v0001115_t0012_u01752897888681") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4051ed0cc8feecf1_d20250719_m040448_c001_v7007000_t0000_u01752897888298") 2025/07/19 04:08:36 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f201de7017e819858_d20250719_m040443_c001_v0001184_t0015_u01752897883328") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41219a62b3769ec4_d20250719_m040659_c001_v7007000_t0000_u01752898019686") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f2051ed0cc8fef851_d20250719_m040651_c001_v0001041_t0052_u01752898011389") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41219a62b3769e8a_d20250719_m040645_c001_v7007000_t0000_u01752898005990") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769df5_d20250719_m040641_c001_v0001117_t0044_u01752898001218") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f4051ed0cc8fef84c_d20250719_m040650_c001_v7007000_t0000_u01752898010910") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769e90_d20250719_m040646_c001_v0001183_t0020_u01752898006172") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41219a62b3769de2_d20250719_m040640_c001_v7007000_t0000_u01752898000769") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f22277695e06661e7_d20250719_m040624_c001_v0001044_t0042_u01752897984011") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f42277695e06661e6_d20250719_m040623_c001_v7007000_t0000_u01752897983829") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f202cfeb28c0dfdac_d20250719_m040620_c001_v0001183_t0030_u01752897980287") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f402cfeb28c0dfda9_d20250719_m040619_c001_v7007000_t0000_u01752897979810") 2025/07/19 04:08:36 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f22277695e066619b_d20250719_m040615_c001_v0001180_t0014_u01752897975958") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f40549ea035de943f_d20250719_m040729_c001_v7007000_t0000_u01752898049953") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f22277695e0666393_d20250719_m040724_c001_v0001171_t0057_u01752898044558") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f42277695e0666392_d20250719_m040724_c001_v7007000_t0000_u01752898044014") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769ed4_d20250719_m040718_c001_v0001102_t0056_u01752898038731") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41219a62b3769ed3_d20250719_m040718_c001_v7007000_t0000_u01752898038547") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769ed0_d20250719_m040714_c001_v0001184_t0052_u01752898034171") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41219a62b3769ece_d20250719_m040713_c001_v7007000_t0000_u01752898033665") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769ecc_d20250719_m040708_c001_v0001091_t0043_u01752898028679") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f41219a62b3769ecb_d20250719_m040708_c001_v7007000_t0000_u01752898028496") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f219b0467b22999aa_d20250719_m040704_c001_v0001098_t0034_u01752898024744") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f419b0467b22999a8_d20250719_m040704_c001_v7007000_t0000_u01752898024252") 2025/07/19 04:08:37 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f21219a62b3769ec6_d20250719_m040659_c001_v0001137_t0025_u01752898019869") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f401de7017e81abb1_d20250719_m040829_c001_v7007000_t0000_u01752898109449") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f216dc2b30c5da723_d20250719_m040822_c001_v0001042_t0051_u01752898102851") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416dc2b30c5da722_d20250719_m040822_c001_v7007000_t0000_u01752898102155") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f216dc2b30c5da71b_d20250719_m040817_c001_v0001181_t0029_u01752898097034") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416dc2b30c5da71a_d20250719_m040816_c001_v7007000_t0000_u01752898096415") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f216dc2b30c5da713_d20250719_m040811_c001_v0001178_t0036_u01752898091173") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416dc2b30c5da712_d20250719_m040810_c001_v7007000_t0000_u01752898090528") 2025/07/19 04:08:37 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa61602_d20250719_m040806_c001_v0001134_t0058_u01752898086874") 2025/07/19 04:08:38 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416115fae5bf8829_d20250719_m040806_c001_v7007000_t0000_u01752898086452") 2025/07/19 04:08:38 DEBUG : chunked-copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa615f4_d20250719_m040803_c001_v0001134_t0035_u01752898083477") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f401de7017e81abb0_d20250719_m040829_c001_v7007000_t0000_u01752898109262") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf8847_d20250719_m040826_c001_v0001116_t0034_u01752898106777") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416dc2b30c5da721_d20250719_m040821_c001_v7007000_t0000_u01752898101968") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf8844_d20250719_m040820_c001_v0001041_t0051_u01752898100334") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416dc2b30c5da719_d20250719_m040816_c001_v7007000_t0000_u01752898096232") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf8840_d20250719_m040814_c001_v0001032_t0037_u01752898094494") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416dc2b30c5da711_d20250719_m040810_c001_v7007000_t0000_u01752898090344") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f216115fae5bf882b_d20250719_m040808_c001_v0001102_t0027_u01752898088538") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f416115fae5bf8828_d20250719_m040806_c001_v7007000_t0000_u01752898086270") 2025/07/19 04:08:38 DEBUG : chunked-copy.copy: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f101f3476288081bf_d20250719_m040805_c001_v0001184_t0038_u01752898085547") 2025/07/19 04:08:38 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f109226aa0f83ad01_d20250719_m040323_c001_v0001029_t0032_u01752897803191") 2025/07/19 04:08:38 DEBUG : unknown-size-put.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f401de7017e81abb8_d20250719_m040830_c001_v7007000_t0000_u01752898110496") 2025/07/19 04:08:38 DEBUG : unknown-size-put.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa6167c_d20250719_m040830_c001_v0001134_t0057_u01752898110002") 2025/07/19 04:08:38 DEBUG : unknown-size-update.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f401de7017e81abc5_d20250719_m040832_c001_v7007000_t0000_u01752898112215") 2025/07/19 04:08:38 DEBUG : unknown-size-update.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa61680_d20250719_m040831_c001_v0001134_t0016_u01752898111547") 2025/07/19 04:08:38 DEBUG : unknown-size-update.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f11804c374fa6167e_d20250719_m040830_c001_v0001134_t0032_u01752898110715") 2025/07/19 04:08:39 DEBUG : versions/test-versions.txt: Deleting (id "4_z0ff24d83d09d2b0b9f880e1b_f401de7017e819851_d20250719_m040439_c001_v7007000_t0000_u01752897879472") 2025/07/19 04:08:40 INFO : B2 bucket rclone-test-soranug5jiri: cleaning bucket "rclone-test-soranug5jiri" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (355.18s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.55s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.40s) --- PASS: TestIntegration/FsMkdir (353.03s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.54s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.20s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.19s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding (24.53s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (2.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (1.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (1.61s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.10s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (1.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.10s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (1.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.10s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.71s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.14s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.36s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.10s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (6.53s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (81.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.92s) --- 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.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.55s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (3.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.18s) --- 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.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (7.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (1.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.44s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.55s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (32.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (6.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (21.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (3.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject (0.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.56s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (199.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (30.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.54s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (4.38s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.23s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (12.68s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.78s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (26.10s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (8.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (4.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (9.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (8.72s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.47s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (35.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (7.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (3.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (19.49s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (15.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (8.52s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.33s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (43.91s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.05s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.01s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (22.16s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (5.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (13.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (8.78s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (30.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (8.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.05s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (4.88s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (11.41s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.94s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (32.76s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (9.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (4.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (11.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.53s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (11.46s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.73s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (26.73s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (3.74s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (4.08s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (5.88s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (5.74s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (7.29s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (2.78s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.08s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.70s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.35s) --- 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 355.220s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 5m56.15180517s (try 1/5)