"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/05/20 02:06:51 DEBUG : Creating backend with remote "TestB2:rclone-test-lociqil8yolu" 2025/05/20 02:06:51 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/05/20 02:06:54 INFO : dir/subdir: Making directory fstest.go:244: Filtering empty directory "dir" fstest.go:244: Filtering empty directory "dir/subdir" 2025/05/20 02:06:54 INFO : dir/subdir: Removing directory fstest.go:244: Filtering empty directory "dir" 2025/05/20 02:06:54 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/05/20 02:07:16 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/05/20 02:07:17 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/05/20 02:07:19 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/05/20 02:07:19 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/05/20 02:07:20 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/05/20 02:07:20 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/05/20 02:07:20 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/05/20 02:07:20 DEBUG : writer-at-subdir/writer-at-file: Finishing large file upload with 0 parts === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/05/20 02:07:27 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/05/20 02:07:28 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/05/20 02:07:33 INFO : B2 bucket rclone-test-lociqil8yolu: cleaning bucket "rclone-test-lociqil8yolu" of all files 2025/05/20 02:07:34 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e82_d20250520_m020733_c001_v0001178_t0035_u01747706853229") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/05/20 02:07:35 DEBUG : Creating backend with remote "TestB2:rclone-test-lociqil8yolu/dirToPurgeFromRoot" 2025/05/20 02:07:36 INFO : B2 bucket rclone-test-lociqil8yolu path dirToPurgeFromRoot: cleaning bucket "rclone-test-lociqil8yolu" of all files 2025/05/20 02:07:37 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e98_d20250520_m020734_c001_v0001178_t0023_u01747706854724") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/05/20 02:07:37 DEBUG : Creating backend with remote "TestB2:rclone-test-lociqil8yolu/hello? sausage/êé" 2025/05/20 02:07:41 INFO : B2 bucket rclone-test-lociqil8yolu path hello? sausage/êé: cleaning bucket "rclone-test-lociqil8yolu" of all files 2025/05/20 02:07:42 DEBUG : a/b/c/d/e.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f111b0f6c649cc18b_d20250520_m020739_c001_v0001115_t0055_u01747706859970") === 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/05/20 02:07:50 DEBUG : Creating backend with remote "TestB2:rclone-test-lociqil8yolu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/05/20 02:07:52 DEBUG : Creating backend with remote "TestB2:rclone-test-lociqil8yolu/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-lociqil8yolu" from "TestB2:rclone-test-lociqil8yolu" 2025/05/20 02:07:54 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink 2025/05/20 02:08:06 DEBUG : Creating backend with remote "TestB2:rclone-test-mocutek3nafa" 2025/05/20 02:08:09 DEBUG : B2 bucket rclone-test-mocutek3nafa: Purge remote 2025/05/20 02:08:09 INFO : B2 bucket rclone-test-mocutek3nafa: cleaning bucket "rclone-test-mocutek3nafa" of all files 2025/05/20 02:08:09 DEBUG : somefile: Deleting (id "4_zcf02bdb3702debbb9f680e1b_f415e7ac6d2df2040_d20250520_m020808_c001_v0001184_t0011_u01747706888142") === 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/05/20 02:08:10 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/05/20 02:08:11 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/05/20 02:08:14 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/05/20 02:08:14 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/05/20 02:08:14 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.562Ki offset 6Mi/6.106Mi 2025/05/20 02:08:14 DEBUG : test-metadata: Sending chunk 1 length 111168 2025/05/20 02:08:15 DEBUG : test-metadata: Done sending chunk 1 2025/05/20 02:08:16 DEBUG : test-metadata: Done sending chunk 0 2025/05/20 02:08: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/05/20 02:08:24 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_hide_file": EOF) 2025/05/20 02:08:24 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/05/20 02:08:24 DEBUG : pacer: Reducing sleep to 10ms 2025/05/20 02:08:26 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1178-14.backblaze.com/b2api/v1/b2_upload_file/8fd29dd3701debbb9f680e1b/c001_v0001178_t0029": EOF 2025/05/20 02:08:26 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1178-14.backblaze.com/b2api/v1/b2_upload_file/8fd29dd3701debbb9f680e1b/c001_v0001178_t0029": EOF) 2025/05/20 02:08:26 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1178-14.backblaze.com/b2api/v1/b2_upload_file/8fd29dd3701debbb9f680e1b/c001_v0001178_t0029": EOF - low level retry 1/10 2025/05/20 02:08: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-05-20-020821-458.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/05/20 02:08:30 DEBUG : oldPath = "TestB2:rclone-test-lociqil8yolu/versions/test-versions-v2025-05-20-020821-458.txt" 2025/05/20 02:08:30 DEBUG : newPath = "TestB2,versions:rclone-test-lociqil8yolu/versions/test-versions-v2025-05-20-020821-458.txt" 2025/05/20 02:08:30 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-lociqil8yolu/versions/test-versions-v2025-05-20-020821-458.txt" 2025/05/20 02:08:30 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/05/20 02:08:32 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-lociqil8yolu/versions/test-versions-v2025-05-20-020821-458.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-lociqil8yolu/versions" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun 2025/05/20 02:08:33 INFO : B2 bucket rclone-test-lociqil8yolu: cleaning bucket "rclone-test-lociqil8yolu" of all hidden files 2025/05/20 02:08:33 DEBUG : leading space/ leading space: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2f_d20250520_m020701_c001_v7007000_t0000_u01747706821379") as it is a hide marker 2025/05/20 02:08:33 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : leading space/ leading space: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d46_d20250520_m020700_c001_v0001178_t0003_u01747706820788") 2025/05/20 02:08:33 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2e_d20250520_m020700_c001_v7007000_t0000_u01747706820423") as it is a hide marker 2025/05/20 02:08:33 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d36_d20250520_m020659_c001_v0001178_t0038_u01747706819851") 2025/05/20 02:08:33 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b38_d20250520_m020707_c001_v7007000_t0000_u01747706827179") as it is a hide marker 2025/05/20 02:08:33 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d7c_d20250520_m020706_c001_v0001178_t0007_u01747706826601") 2025/05/20 02:08:33 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : created from root.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4196cd743a56e8f0_d20250520_m020802_c001_v7007000_t0000_u01747706882166") as it is a hide marker 2025/05/20 02:08:33 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : created from root.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f1009d331cb95ab8d_d20250520_m020800_c001_v0001106_t0039_u01747706880805") 2025/05/20 02:08:33 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : file name.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1cf_d20250520_m020810_c001_v7007000_t0000_u01747706890374") as it is a hide marker 2025/05/20 02:08:33 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75f20_d20250520_m020750_c001_v0001178_t0024_u01747706870059") 2025/05/20 02:08:33 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f1078fb9b07871060_d20250520_m020746_c001_v0001183_t0033_u01747706866527") 2025/05/20 02:08:33 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e32_d20250520_m020724_c001_v0001178_t0033_u01747706844778") 2025/05/20 02:08:33 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e26_d20250520_m020723_c001_v0001178_t0049_u01747706843995") 2025/05/20 02:08:33 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e28_d20250520_m020724_c001_v0001178_t0033_u01747706844388") "upload" dated 2025-05-20 02:07:24.388 +0000 UTC (1m9.36848514s ago) 2025/05/20 02:08:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4102eeb48b2d65aa_d20250520_m020744_c001_v7007000_t0000_u01747706864255") as it is a hide marker 2025/05/20 02:08:33 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f1046beb0cafabb4c_d20250520_m020743_c001_v0001101_t0054_u01747706863956") 2025/05/20 02:08:33 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f114690ff5c03e260_d20250520_m020743_c001_v0001172_t0052_u01747706863301") 2025/05/20 02:08:33 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b44_d20250520_m020713_c001_v7007000_t0000_u01747706833964") as it is a hide marker 2025/05/20 02:08:33 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75dc0_d20250520_m020713_c001_v0001178_t0054_u01747706833385") 2025/05/20 02:08:33 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : piped data.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1d1_d20250520_m020812_c001_v7007000_t0000_u01747706892038") as it is a hide marker 2025/05/20 02:08:33 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : piped data.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75faa_d20250520_m020811_c001_v0001178_t0058_u01747706891655") 2025/05/20 02:08:33 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : piped data.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1d0_d20250520_m020811_c001_v7007000_t0000_u01747706891469") 2025/05/20 02:08:33 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : piped data.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41430ccb9ba75fa6_d20250520_m020811_c001_v0001178_t0029_u01747706891107") 2025/05/20 02:08:33 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b46_d20250520_m020714_c001_v7007000_t0000_u01747706834921") as it is a hide marker 2025/05/20 02:08:33 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75dca_d20250520_m020714_c001_v0001178_t0015_u01747706834340") 2025/05/20 02:08:33 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : test-metadata: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4207bb77646bb298_d20250520_m020818_c001_v7007000_t0000_u01747706898907") as it is a hide marker 2025/05/20 02:08:33 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : test-metadata: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f21662f034916f1d4_d20250520_m020813_c001_v0001103_t0027_u01747706893869") 2025/05/20 02:08:33 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : test-metadata: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1d3_d20250520_m020812_c001_v7007000_t0000_u01747706892998") 2025/05/20 02:08:33 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : test-metadata: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75fb0_d20250520_m020812_c001_v0001178_t0021_u01747706892234") 2025/05/20 02:08:33 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3c_d20250520_m020709_c001_v7007000_t0000_u01747706829148") as it is a hide marker 2025/05/20 02:08:33 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d8c_d20250520_m020708_c001_v0001178_t0041_u01747706828536") 2025/05/20 02:08:33 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3e_d20250520_m020711_c001_v7007000_t0000_u01747706831073") as it is a hide marker 2025/05/20 02:08:33 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d9e_d20250520_m020710_c001_v0001178_t0051_u01747706830459") 2025/05/20 02:08:33 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3d_d20250520_m020710_c001_v7007000_t0000_u01747706830092") as it is a hide marker 2025/05/20 02:08:33 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d9a_d20250520_m020709_c001_v0001178_t0022_u01747706829515") 2025/05/20 02:08:33 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3f_d20250520_m020712_c001_v7007000_t0000_u01747706832058") as it is a hide marker 2025/05/20 02:08:33 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75da4_d20250520_m020711_c001_v0001178_t0029_u01747706831483") 2025/05/20 02:08:33 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b41_d20250520_m020713_c001_v7007000_t0000_u01747706833020") as it is a hide marker 2025/05/20 02:08:33 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75db4_d20250520_m020712_c001_v0001178_t0020_u01747706832422") 2025/05/20 02:08:33 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing space /trailing space : Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b39_d20250520_m020708_c001_v7007000_t0000_u01747706828171") as it is a hide marker 2025/05/20 02:08:33 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : trailing space /trailing space : Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d80_d20250520_m020707_c001_v0001178_t0008_u01747706827543") 2025/05/20 02:08:33 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c0f04_d20250520_m020829_c001_v0001177_t0046_u01747706909200") "upload" dated 2025-05-20 02:08:29.2 +0000 UTC (4.556925807s ago) 2025/05/20 02:08:33 DEBUG : versions/test-versions.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f408284495154cf17_d20250520_m020824_c001_v7007000_t0000_u01747706904449") 2025/05/20 02:08:33 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : versions/test-versions.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75fe8_d20250520_m020821_c001_v0001178_t0010_u01747706901458") 2025/05/20 02:08:33 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b4e_d20250520_m020723_c001_v7007000_t0000_u01747706843444") as it is a hide marker 2025/05/20 02:08:33 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f217ffa8e1f420b49_d20250520_m020717_c001_v0001093_t0041_u01747706837088") 2025/05/20 02:08:33 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : zero-length-file: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b48_d20250520_m020716_c001_v7007000_t0000_u01747706836763") as it is a hide marker 2025/05/20 02:08:33 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : zero-length-file: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41430ccb9ba75de6_d20250520_m020716_c001_v0001178_t0029_u01747706836215") 2025/05/20 02:08:33 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b30_d20250520_m020702_c001_v7007000_t0000_u01747706822360") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d4e_d20250520_m020701_c001_v0001178_t0047_u01747706821785") 2025/05/20 02:08:33 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b29_d20250520_m020657_c001_v7007000_t0000_u01747706817539") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d14_d20250520_m020656_c001_v0001178_t0038_u01747706816553") 2025/05/20 02:08:33 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b35_d20250520_m020705_c001_v7007000_t0000_u01747706825297") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d6a_d20250520_m020704_c001_v0001178_t0045_u01747706824722") 2025/05/20 02:08:33 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b33_d20250520_m020704_c001_v7007000_t0000_u01747706824341") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d62_d20250520_m020703_c001_v0001178_t0033_u01747706823761") 2025/05/20 02:08:33 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b37_d20250520_m020706_c001_v7007000_t0000_u01747706826234") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d78_d20250520_m020705_c001_v0001178_t0051_u01747706825661") 2025/05/20 02:08:33 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b31_d20250520_m020703_c001_v7007000_t0000_u01747706823394") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d56_d20250520_m020702_c001_v0001178_t0003_u01747706822725") 2025/05/20 02:08:33 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ．/．: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2b_d20250520_m020658_c001_v7007000_t0000_u01747706818493") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ．/．: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ．/．: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d1c_d20250520_m020657_c001_v0001178_t0013_u01747706817914") 2025/05/20 02:08:33 NOTICE: ．/．: Skipped delete as --dry-run is set 2025/05/20 02:08:33 DEBUG : ．．/．．: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2c_d20250520_m020659_c001_v7007000_t0000_u01747706819443") as it is a hide marker 2025/05/20 02:08:33 NOTICE: ．．/．．: Skipped remove hide marker as --dry-run is set 2025/05/20 02:08:33 DEBUG : ．．/．．: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d2e_d20250520_m020658_c001_v0001178_t0002_u01747706818859") 2025/05/20 02:08:33 NOTICE: ．．/．．: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/05/20 02:08:33 INFO : B2 bucket rclone-test-lociqil8yolu: cleaning bucket "rclone-test-lociqil8yolu" of all hidden files 2025/05/20 02:08:34 DEBUG : leading space/ leading space: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2f_d20250520_m020701_c001_v7007000_t0000_u01747706821379") as it is a hide marker 2025/05/20 02:08:34 DEBUG : leading space/ leading space: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d46_d20250520_m020700_c001_v0001178_t0003_u01747706820788") 2025/05/20 02:08:34 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2e_d20250520_m020700_c001_v7007000_t0000_u01747706820423") as it is a hide marker 2025/05/20 02:08:34 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d36_d20250520_m020659_c001_v0001178_t0038_u01747706819851") 2025/05/20 02:08:34 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b38_d20250520_m020707_c001_v7007000_t0000_u01747706827179") as it is a hide marker 2025/05/20 02:08:34 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d7c_d20250520_m020706_c001_v0001178_t0007_u01747706826601") 2025/05/20 02:08:34 DEBUG : created from root.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4196cd743a56e8f0_d20250520_m020802_c001_v7007000_t0000_u01747706882166") as it is a hide marker 2025/05/20 02:08:34 DEBUG : created from root.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f1009d331cb95ab8d_d20250520_m020800_c001_v0001106_t0039_u01747706880805") 2025/05/20 02:08:34 DEBUG : file name.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1cf_d20250520_m020810_c001_v7007000_t0000_u01747706890374") as it is a hide marker 2025/05/20 02:08:34 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75f20_d20250520_m020750_c001_v0001178_t0024_u01747706870059") 2025/05/20 02:08:34 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f1078fb9b07871060_d20250520_m020746_c001_v0001183_t0033_u01747706866527") 2025/05/20 02:08:34 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e32_d20250520_m020724_c001_v0001178_t0033_u01747706844778") 2025/05/20 02:08:34 DEBUG : file name.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e26_d20250520_m020723_c001_v0001178_t0049_u01747706843995") 2025/05/20 02:08:34 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e28_d20250520_m020724_c001_v0001178_t0033_u01747706844388") "upload" dated 2025-05-20 02:07:24.388 +0000 UTC (1m10.447616359s ago) 2025/05/20 02:08:34 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4102eeb48b2d65aa_d20250520_m020744_c001_v7007000_t0000_u01747706864255") as it is a hide marker 2025/05/20 02:08:34 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f1046beb0cafabb4c_d20250520_m020743_c001_v0001101_t0054_u01747706863956") 2025/05/20 02:08:34 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f114690ff5c03e260_d20250520_m020743_c001_v0001172_t0052_u01747706863301") 2025/05/20 02:08:34 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b44_d20250520_m020713_c001_v7007000_t0000_u01747706833964") as it is a hide marker 2025/05/20 02:08:35 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75dc0_d20250520_m020713_c001_v0001178_t0054_u01747706833385") 2025/05/20 02:08:35 DEBUG : piped data.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1d1_d20250520_m020812_c001_v7007000_t0000_u01747706892038") as it is a hide marker 2025/05/20 02:08:35 DEBUG : piped data.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75faa_d20250520_m020811_c001_v0001178_t0058_u01747706891655") 2025/05/20 02:08:35 DEBUG : piped data.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1d0_d20250520_m020811_c001_v7007000_t0000_u01747706891469") 2025/05/20 02:08:35 DEBUG : piped data.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41430ccb9ba75fa6_d20250520_m020811_c001_v0001178_t0029_u01747706891107") 2025/05/20 02:08:35 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b46_d20250520_m020714_c001_v7007000_t0000_u01747706834921") as it is a hide marker 2025/05/20 02:08:35 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75dca_d20250520_m020714_c001_v0001178_t0015_u01747706834340") 2025/05/20 02:08:35 DEBUG : test-metadata: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4207bb77646bb298_d20250520_m020818_c001_v7007000_t0000_u01747706898907") as it is a hide marker 2025/05/20 02:08:35 DEBUG : test-metadata: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f21662f034916f1d4_d20250520_m020813_c001_v0001103_t0027_u01747706893869") 2025/05/20 02:08:35 DEBUG : test-metadata: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41662f034916f1d3_d20250520_m020812_c001_v7007000_t0000_u01747706892998") 2025/05/20 02:08:35 DEBUG : test-metadata: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75fb0_d20250520_m020812_c001_v0001178_t0021_u01747706892234") 2025/05/20 02:08:35 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3c_d20250520_m020709_c001_v7007000_t0000_u01747706829148") as it is a hide marker 2025/05/20 02:08:35 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d8c_d20250520_m020708_c001_v0001178_t0041_u01747706828536") 2025/05/20 02:08:35 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3e_d20250520_m020711_c001_v7007000_t0000_u01747706831073") as it is a hide marker 2025/05/20 02:08:35 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d9e_d20250520_m020710_c001_v0001178_t0051_u01747706830459") 2025/05/20 02:08:35 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3d_d20250520_m020710_c001_v7007000_t0000_u01747706830092") as it is a hide marker 2025/05/20 02:08:35 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d9a_d20250520_m020709_c001_v0001178_t0022_u01747706829515") 2025/05/20 02:08:35 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b3f_d20250520_m020712_c001_v7007000_t0000_u01747706832058") as it is a hide marker 2025/05/20 02:08:35 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75da4_d20250520_m020711_c001_v0001178_t0029_u01747706831483") 2025/05/20 02:08:36 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b41_d20250520_m020713_c001_v7007000_t0000_u01747706833020") as it is a hide marker 2025/05/20 02:08:36 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75db4_d20250520_m020712_c001_v0001178_t0020_u01747706832422") 2025/05/20 02:08:36 DEBUG : trailing space /trailing space : Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b39_d20250520_m020708_c001_v7007000_t0000_u01747706828171") as it is a hide marker 2025/05/20 02:08:36 DEBUG : trailing space /trailing space : Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d80_d20250520_m020707_c001_v0001178_t0008_u01747706827543") 2025/05/20 02:08:36 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c0f04_d20250520_m020829_c001_v0001177_t0046_u01747706909200") "upload" dated 2025-05-20 02:08:29.2 +0000 UTC (7.004122632s ago) 2025/05/20 02:08:36 DEBUG : versions/test-versions.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f408284495154cf17_d20250520_m020824_c001_v7007000_t0000_u01747706904449") 2025/05/20 02:08:36 DEBUG : versions/test-versions.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75fe8_d20250520_m020821_c001_v0001178_t0010_u01747706901458") 2025/05/20 02:08:36 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b4e_d20250520_m020723_c001_v7007000_t0000_u01747706843444") as it is a hide marker 2025/05/20 02:08:36 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f217ffa8e1f420b49_d20250520_m020717_c001_v0001093_t0041_u01747706837088") 2025/05/20 02:08:36 DEBUG : zero-length-file: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b48_d20250520_m020716_c001_v7007000_t0000_u01747706836763") as it is a hide marker 2025/05/20 02:08:36 DEBUG : zero-length-file: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f41430ccb9ba75de6_d20250520_m020716_c001_v0001178_t0029_u01747706836215") 2025/05/20 02:08:36 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b30_d20250520_m020702_c001_v7007000_t0000_u01747706822360") as it is a hide marker 2025/05/20 02:08:36 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d4e_d20250520_m020701_c001_v0001178_t0047_u01747706821785") 2025/05/20 02:08:36 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b29_d20250520_m020657_c001_v7007000_t0000_u01747706817539") as it is a hide marker 2025/05/20 02:08:36 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d14_d20250520_m020656_c001_v0001178_t0038_u01747706816553") 2025/05/20 02:08:36 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b35_d20250520_m020705_c001_v7007000_t0000_u01747706825297") as it is a hide marker 2025/05/20 02:08:36 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d6a_d20250520_m020704_c001_v0001178_t0045_u01747706824722") 2025/05/20 02:08:36 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b33_d20250520_m020704_c001_v7007000_t0000_u01747706824341") as it is a hide marker 2025/05/20 02:08:36 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d62_d20250520_m020703_c001_v0001178_t0033_u01747706823761") 2025/05/20 02:08:36 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b37_d20250520_m020706_c001_v7007000_t0000_u01747706826234") as it is a hide marker 2025/05/20 02:08:36 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d78_d20250520_m020705_c001_v0001178_t0051_u01747706825661") 2025/05/20 02:08:37 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b31_d20250520_m020703_c001_v7007000_t0000_u01747706823394") as it is a hide marker 2025/05/20 02:08:37 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d56_d20250520_m020702_c001_v0001178_t0003_u01747706822725") 2025/05/20 02:08:37 DEBUG : ．/．: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2b_d20250520_m020658_c001_v7007000_t0000_u01747706818493") as it is a hide marker 2025/05/20 02:08:37 DEBUG : ．/．: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d1c_d20250520_m020657_c001_v0001178_t0013_u01747706817914") 2025/05/20 02:08:37 DEBUG : ．．/．．: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f417ffa8e1f420b2c_d20250520_m020659_c001_v7007000_t0000_u01747706819443") as it is a hide marker 2025/05/20 02:08:37 DEBUG : ．．/．．: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75d2e_d20250520_m020658_c001_v0001178_t0002_u01747706818859") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/05/20 02:08:38 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/05/20 02:08:38 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/05/20 02:08:38 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/05/20 02:08:38 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/05/20 02:08:38 INFO : B2 bucket rclone-test-lociqil8yolu: cleaning bucket "rclone-test-lociqil8yolu" of pending multipart uploads older than 0s 2025/05/20 02:08:39 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e28_d20250520_m020724_c001_v0001178_t0033_u01747706844388") "upload" dated 2025-05-20 02:07:24.388 +0000 UTC (1m14.765063846s ago) 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dc9_d20250520_m020838_c001_v0001136_t0045_u01747706918103") as it is a start marker (upload started at 2025-05-20 02:08:38.103 +0000 UTC) 2025/05/20 02:08:39 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dca_d20250520_m020838_c001_v0001184_t0006_u01747706918309") as it is a start marker (upload started at 2025-05-20 02:08:38.309 +0000 UTC) 2025/05/20 02:08:39 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dcb_d20250520_m020838_c001_v0001116_t0002_u01747706918497") as it is a start marker (upload started at 2025-05-20 02:08:38.497 +0000 UTC) 2025/05/20 02:08:39 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dcd_d20250520_m020838_c001_v0001136_t0045_u01747706918685") as it is a start marker (upload started at 2025-05-20 02:08:38.685 +0000 UTC) 2025/05/20 02:08:39 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/05/20 02:08:39 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4157637f91454dc8_d20250520_m020837_c001_v7007000_t0000_u01747706917920") "hide" dated 2025-05-20 02:08:37.92 +0000 UTC (1.233226842s ago) 2025/05/20 02:08:39 DEBUG : versions/test-versions.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c0f04_d20250520_m020829_c001_v0001177_t0046_u01747706909200") 2025/05/20 02:08:39 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/05/20 02:08:39 INFO : B2 bucket rclone-test-lociqil8yolu: cleaning bucket "rclone-test-lociqil8yolu" of pending multipart uploads older than 0s 2025/05/20 02:08:39 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e28_d20250520_m020724_c001_v0001178_t0033_u01747706844388") "upload" dated 2025-05-20 02:07:24.388 +0000 UTC (1m15.132438827s ago) 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dc9_d20250520_m020838_c001_v0001136_t0045_u01747706918103") as it is a start marker (upload started at 2025-05-20 02:08:38.103 +0000 UTC) 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dca_d20250520_m020838_c001_v0001184_t0006_u01747706918309") as it is a start marker (upload started at 2025-05-20 02:08:38.309 +0000 UTC) 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dcb_d20250520_m020838_c001_v0001116_t0002_u01747706918497") as it is a start marker (upload started at 2025-05-20 02:08:38.497 +0000 UTC) 2025/05/20 02:08:39 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454dcd_d20250520_m020838_c001_v0001136_t0045_u01747706918685") as it is a start marker (upload started at 2025-05-20 02:08:38.685 +0000 UTC) 2025/05/20 02:08:39 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8fd29dd3701debbb9f680e1b_f4157637f91454dc8_d20250520_m020837_c001_v7007000_t0000_u01747706917920") "hide" dated 2025-05-20 02:08:37.92 +0000 UTC (1.600608555s ago) 2025/05/20 02:08:39 DEBUG : versions/test-versions.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c0f04_d20250520_m020829_c001_v0001177_t0046_u01747706909200") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/05/20 02:08:40 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/05/20 02:08:40 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/05/20 02:08:40 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/05/20 02:08:41 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/05/20 02:08:41 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:08:41 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/05/20 02:08:41 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/05/20 02:08:42 DEBUG : chunked-5Mi-5.000Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000535530), retryAfter:1000000000} 2025/05/20 02:08:42 DEBUG : chunked-5Mi-5.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/05/20 02:08:42 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable)) 2025/05/20 02:08:42 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:08:42 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:08:42 DEBUG : chunked-5Mi-5.000Mi.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000e26540), retryAfter:1000000000} 2025/05/20 02:08:42 DEBUG : chunked-5Mi-5.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/05/20 02:08:42 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable)) 2025/05/20 02:08:43 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:08:44 DEBUG : chunked-5Mi-5.000Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000535860), retryAfter:1000000000} 2025/05/20 02:08:44 DEBUG : chunked-5Mi-5.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/05/20 02:08:44 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable)) 2025/05/20 02:08:44 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:08:44 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/05/20 02:08:45 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:08:46 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:08:47 DEBUG : pacer: Reducing sleep to 250ms 2025/05/20 02:08:48 DEBUG : chunked-5Mi-5.000Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000535d70), retryAfter:1000000000} 2025/05/20 02:08:48 DEBUG : chunked-5Mi-5.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/05/20 02:08:48 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable)) 2025/05/20 02:08:48 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:08:48 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:08:49 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:08:49 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/05/20 02:08:49 DEBUG : pacer: Reducing sleep to 250ms 2025/05/20 02:08:50 DEBUG : chunked-5Mi-5.000Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000e8f3e0), retryAfter:1000000000} 2025/05/20 02:08:50 DEBUG : chunked-5Mi-5.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/05/20 02:08:50 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable)) 2025/05/20 02:08:50 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:08:50 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:08:50 DEBUG : chunked-5Mi-5.000Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000e27620), retryAfter:1000000000} 2025/05/20 02:08:50 DEBUG : chunked-5Mi-5.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/05/20 02:08:50 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable)) 2025/05/20 02:08:51 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:08:52 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:08:53 DEBUG : pacer: Reducing sleep to 250ms 2025/05/20 02:08:53 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/05/20 02:08:53 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts 2025/05/20 02:08:53 DEBUG : pacer: Reducing sleep to 125ms 2025/05/20 02:08:54 DEBUG : pacer: Reducing sleep to 62.5ms 2025/05/20 02:08:54 DEBUG : pacer: Reducing sleep to 31.25ms 2025/05/20 02:08:55 DEBUG : pacer: Reducing sleep to 15.625ms === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/05/20 02:08:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:08:56 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/05/20 02:08:56 DEBUG : pacer: Reducing sleep to 10ms 2025/05/20 02:08:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2196cd743a56e920_d20250520_m020856_c001_v0001130_t0022_u01747706936233") 2025/05/20 02:08:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:08:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/05/20 02:08:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/05/20 02:08:57 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:08:58 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:08:58 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/05/20 02:09:00 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/05/20 02:09:00 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/05/20 02:09:00 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/05/20 02:09:00 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/05/20 02:09:02 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/05/20 02:09:02 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/05/20 02:09:02 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/05/20 02:09:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:09:04 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/05/20 02:09:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35866_d20250520_m020904_c001_v0001042_t0042_u01747706944428") 2025/05/20 02:09:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/05/20 02:09:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/05/20 02:09:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/05/20 02:09:07 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:09:07 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:09:07 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/05/20 02:09:09 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/05/20 02:09:09 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/05/20 02:09:09 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/05/20 02:09:09 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/05/20 02:09:09 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/05/20 02:09:09 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/05/20 02:09:10 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/05/20 02:09:11 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/05/20 02:09:11 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/05/20 02:09:11 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/05/20 02:09:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:09:13 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/05/20 02:09:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f203c67d4cfdd859a_d20250520_m020913_c001_v0001103_t0033_u01747706953763") 2025/05/20 02:09:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/05/20 02:09:14 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:09:14 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/05/20 02:09:14 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/05/20 02:09:15 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/05/20 02:09:16 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:09:16 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:09:16 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/05/20 02:09:18 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/05/20 02:09:18 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/05/20 02:09:18 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/05/20 02:09:18 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/05/20 02:09:19 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/05/20 02:09:21 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/05/20 02:09:21 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/05/20 02:09:22 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:09:22 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/05/20 02:09:23 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f203c67d4cfdd85a0_d20250520_m020923_c001_v0001032_t0002_u01747706963065") 2025/05/20 02:09:23 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:09:23 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/05/20 02:09:23 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/05/20 02:09:24 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:09:25 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:09:25 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/05/20 02:09:27 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/05/20 02:09:27 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/05/20 02:09:27 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/05/20 02:09:27 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/05/20 02:09:29 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/05/20 02:09:29 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/05/20 02:09:29 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/05/20 02:09:31 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:09:31 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/05/20 02:09:31 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35899_d20250520_m020931_c001_v0001109_t0013_u01747706971419") 2025/05/20 02:09:31 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/05/20 02:09:31 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/05/20 02:09:31 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/05/20 02:09:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:09:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:09:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/05/20 02:09:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/05/20 02:09:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/05/20 02:09:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/05/20 02:09:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/05/20 02:09:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/05/20 02:09:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/05/20 02:09:37 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/05/20 02:09:38 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/05/20 02:09:38 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/05/20 02:09:38 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/05/20 02:09:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:09:40 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/05/20 02:09:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d3589f_d20250520_m020940_c001_v0001161_t0045_u01747706980400") 2025/05/20 02:09:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/05/20 02:09:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:09:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/05/20 02:09:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/05/20 02:09:41 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/05/20 02:09:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:09:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:09:43 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/05/20 02:09:45 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/05/20 02:09:45 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/05/20 02:09:45 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/05/20 02:09:45 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/05/20 02:09:45 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/05/20 02:09:47 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/05/20 02:09:47 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/05/20 02:09:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:09:48 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/05/20 02:09:49 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358b9_d20250520_m020948_c001_v0001044_t0040_u01747706988933") 2025/05/20 02:09:49 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:09:49 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/05/20 02:09:49 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/05/20 02:09:50 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:09:51 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:09:51 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/05/20 02:09:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/05/20 02:09:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/05/20 02:09:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/05/20 02:09:53 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/05/20 02:09:55 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/05/20 02:09:55 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/05/20 02:09:55 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/05/20 02:09:57 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:09:57 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/05/20 02:09:57 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358c1_d20250520_m020957_c001_v0001183_t0050_u01747706997252") 2025/05/20 02:09:57 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/05/20 02:09:57 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/05/20 02:09:57 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/05/20 02:09:59 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:09:59 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:09:59 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/05/20 02:10:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/05/20 02:10:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/05/20 02:10:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/05/20 02:10:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/05/20 02:10:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/05/20 02:10:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/05/20 02:10:02 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/05/20 02:10:03 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/05/20 02:10:04 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/05/20 02:10:04 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/05/20 02:10:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:10:05 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/05/20 02:10:06 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358cd_d20250520_m021005_c001_v0001116_t0029_u01747707005948") 2025/05/20 02:10:06 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/05/20 02:10:06 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:10:06 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/05/20 02:10:06 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/05/20 02:10:07 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/05/20 02:10:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:10:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:10:09 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/05/20 02:10:11 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/05/20 02:10:11 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/05/20 02:10:11 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/05/20 02:10:11 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/05/20 02:10:11 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/05/20 02:10:13 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/05/20 02:10:13 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/05/20 02:10:14 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:10:14 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/05/20 02:10:15 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358d5_d20250520_m021015_c001_v0001040_t0046_u01747707015078") 2025/05/20 02:10:15 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/05/20 02:10:15 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:10:15 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/05/20 02:10:16 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:10:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:10:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/05/20 02:10:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/05/20 02:10:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/05/20 02:10:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/05/20 02:10:24 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/05/20 02:10:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/05/20 02:10:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/05/20 02:10:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/05/20 02:10:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:10:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/05/20 02:10:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2095f195752d7f7a_d20250520_m021029_c001_v0001157_t0002_u01747707029485") 2025/05/20 02:10:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/05/20 02:10:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/05/20 02:10:29 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/05/20 02:10:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:10:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:10:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/05/20 02:10:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/05/20 02:10:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/05/20 02:10:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/05/20 02:10:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/05/20 02:10:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/05/20 02:10:35 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/05/20 02:10:36 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/05/20 02:10:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/05/20 02:10:38 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/05/20 02:10:38 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/05/20 02:10:40 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:10:40 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/05/20 02:10:40 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f218b40bfaf346fa0_d20250520_m021040_c001_v0001176_t0004_u01747707040673") 2025/05/20 02:10:40 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/05/20 02:10:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:10:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/05/20 02:10:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/05/20 02:10:41 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/05/20 02:10:43 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:10:43 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:10:43 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/05/20 02:10:45 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/05/20 02:10:45 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/05/20 02:10:45 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/05/20 02:10:46 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:10:46 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/05/20 02:10:48 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/05/20 02:10:48 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/05/20 02:10:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:10:50 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/05/20 02:10:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f218b40bfaf347014_d20250520_m021050_c001_v0001091_t0038_u01747707050185") 2025/05/20 02:10:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:10:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/05/20 02:10:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/05/20 02:10:51 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:10:52 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:10:52 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/05/20 02:10:54 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/05/20 02:10:54 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/05/20 02:10:55 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/05/20 02:10:55 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/05/20 02:10:57 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/05/20 02:10:57 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/05/20 02:10:57 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/05/20 02:10:59 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:10:59 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/05/20 02:10:59 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f208284495154d05b_d20250520_m021059_c001_v0001029_t0011_u01747707059789") 2025/05/20 02:10:59 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/05/20 02:11:00 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/05/20 02:11:00 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/05/20 02:11:02 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:11:03 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:11:03 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/05/20 02:11:06 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/05/20 02:11:06 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/05/20 02:11:06 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/05/20 02:11:06 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/05/20 02:11:06 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/05/20 02:11:06 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/05/20 02:11:07 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/05/20 02:11:08 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/05/20 02:11:09 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/05/20 02:11:09 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/05/20 02:11:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:11:11 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/05/20 02:11:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f216b270b5cd726f4_d20250520_m021111_c001_v0001137_t0042_u01747707071725") 2025/05/20 02:11:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/05/20 02:11:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:11:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/05/20 02:11:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/05/20 02:11:13 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/05/20 02:11:14 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:11:14 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:11:14 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/05/20 02:11:17 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/05/20 02:11:17 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/05/20 02:11:17 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/05/20 02:11:17 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/05/20 02:11:18 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/05/20 02:11:20 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/05/20 02:11:20 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/05/20 02:11:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:11:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 10Mi allows uploads of up to 97.656Gi and will fail only when that limit is reached. 2025/05/20 02:11:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f216b270b5cd7273e_d20250520_m021122_c001_v0001183_t0024_u01747707082249") 2025/05/20 02:11:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:11:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/05/20 02:11:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/05/20 02:11:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:11:24 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:11:24 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/05/20 02:11:27 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/05/20 02:11:27 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/05/20 02:11:27 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/05/20 02:11:27 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/05/20 02:11:30 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/05/20 02:11:30 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/05/20 02:11:30 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/05/20 02:11:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:11:32 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/05/20 02:11:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91455292_d20250520_m021132_c001_v0001134_t0047_u01747707092675") 2025/05/20 02:11:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/05/20 02:11:33 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/05/20 02:11:33 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/05/20 02:11:33 DEBUG : chunked-10Mi-20Mi-streamed.bin: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0003ee300), retryAfter:1000000000} 2025/05/20 02:11:33 DEBUG : chunked-10Mi-20Mi-streamed.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable) 2025/05/20 02:11:33 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable)) 2025/05/20 02:11:33 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:11:33 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/05/20 02:11:35 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:11:37 DEBUG : pacer: Reducing sleep to 250ms 2025/05/20 02:11:37 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:11:38 DEBUG : pacer: Reducing sleep to 125ms 2025/05/20 02:11:38 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:11:38 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts 2025/05/20 02:11:38 DEBUG : pacer: Reducing sleep to 62.5ms 2025/05/20 02:11:38 DEBUG : pacer: Reducing sleep to 31.25ms 2025/05/20 02:11:39 DEBUG : pacer: Reducing sleep to 15.625ms 2025/05/20 02:11:41 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/05/20 02:11:42 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/05/20 02:11:42 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/05/20 02:11:42 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/05/20 02:11:42 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/05/20 02:11:42 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/05/20 02:11:42 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/05/20 02:11:43 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/05/20 02:11:45 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/05/20 02:11:45 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/05/20 02:11:45 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/05/20 02:11:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/05/20 02:11:48 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/05/20 02:11:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35b3c_d20250520_m021148_c001_v0001182_t0031_u01747707108477") 2025/05/20 02:11:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/05/20 02:11:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/05/20 02:11:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/05/20 02:11:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/05/20 02:11:49 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/05/20 02:11:51 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/05/20 02:11:51 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/05/20 02:11:51 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/05/20 02:12:00 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35b48_d20250520_m021200_c001_v0001181_t0000_u01747707120074") 2025/05/20 02:12:00 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/05/20 02:12:00 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/05/20 02:12:00 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/05/20 02:12:00 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/05/20 02:12:00 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/05/20 02:12:02 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/05/20 02:12:02 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/05/20 02:12:02 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/05/20 02:12:02 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/05/20 02:12:03 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc00153c570), retryAfter:1000000000} 2025/05/20 02:12:03 DEBUG : chunked-copy: Clearing part upload URL because of error: CPU too busy (503 service_unavailable) 2025/05/20 02:12:03 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable)) 2025/05/20 02:12:03 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:12:03 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/05/20 02:12:03 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000207e60), retryAfter:1000000000} 2025/05/20 02:12:03 DEBUG : chunked-copy: Clearing part upload URL because of error: CPU too busy (503 service_unavailable) 2025/05/20 02:12:03 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable)) 2025/05/20 02:12:04 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:12:05 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0013902a0), retryAfter:1000000000} 2025/05/20 02:12:05 DEBUG : chunked-copy: Clearing part upload URL because of error: CPU too busy (503 service_unavailable) 2025/05/20 02:12:05 DEBUG : pacer: low level retry 2/10 (error CPU too busy (503 service_unavailable)) 2025/05/20 02:12:05 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:12:05 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/05/20 02:12:06 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/05/20 02:12:07 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:12:08 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0013905a0), retryAfter:1000000000} 2025/05/20 02:12:08 DEBUG : chunked-copy: Clearing part upload URL because of error: CPU too busy (503 service_unavailable) 2025/05/20 02:12:08 DEBUG : pacer: low level retry 2/10 (error CPU too busy (503 service_unavailable)) 2025/05/20 02:12:08 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:12:08 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:12:09 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/05/20 02:12:10 DEBUG : pacer: Reducing sleep to 250ms 2025/05/20 02:12:10 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc00153d0b0), retryAfter:1000000000} 2025/05/20 02:12:10 DEBUG : chunked-copy: Clearing part upload URL because of error: CPU too busy (503 service_unavailable) 2025/05/20 02:12:10 DEBUG : pacer: low level retry 3/10 (error CPU too busy (503 service_unavailable)) 2025/05/20 02:12:10 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:12:10 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/05/20 02:12:11 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:12:11 DEBUG : chunked-copy: Done sending chunk 0 2025/05/20 02:12:12 DEBUG : pacer: Reducing sleep to 250ms 2025/05/20 02:12:12 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc001391110), retryAfter:1000000000} 2025/05/20 02:12:12 DEBUG : chunked-copy: Clearing part upload URL because of error: CPU too busy (503 service_unavailable) 2025/05/20 02:12:12 DEBUG : pacer: low level retry 4/10 (error CPU too busy (503 service_unavailable)) 2025/05/20 02:12:12 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/05/20 02:12:12 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/05/20 02:12:13 DEBUG : pacer: Reducing sleep to 500ms 2025/05/20 02:12:13 DEBUG : chunked-copy: Done sending chunk 1 2025/05/20 02:12:13 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/05/20 02:12:14 DEBUG : pacer: Reducing sleep to 250ms 2025/05/20 02:12:15 DEBUG : pacer: Reducing sleep to 125ms 2025/05/20 02:12:15 DEBUG : pacer: Reducing sleep to 62.5ms 2025/05/20 02:12:15 DEBUG : pacer: Reducing sleep to 31.25ms 2025/05/20 02:12:15 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8fd29dd3701debbb9f680e1b_f222d1dd26ae85eaf_d20250520_m021215_c001_v0001171_t0047_u01747707135301") 2025/05/20 02:12:15 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/05/20 02:12:15 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/05/20 02:12:15 DEBUG : pacer: Reducing sleep to 15.625ms 2025/05/20 02:12:15 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/05/20 02:12:16 DEBUG : pacer: Reducing sleep to 10ms 2025/05/20 02:12:16 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/05/20 02:12:16 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/05/20 02:12:19 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/05/20 02:12:19 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/05/20 02:12:20 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/05/20 02:12:20 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/05/20 02:12:22 DEBUG : chunked-copy: Done sending chunk 0 2025/05/20 02:12:22 DEBUG : chunked-copy: Done sending chunk 1 2025/05/20 02:12:22 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/05/20 02:12:23 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8fd29dd3701debbb9f680e1b_f222d1dd26ae85eb2_d20250520_m021223_c001_v0001177_t0057_u01747707143132") 2025/05/20 02:12:23 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/05/20 02:12:23 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/05/20 02:12:23 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/05/20 02:12:23 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/05/20 02:12:23 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/05/20 02:12:25 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/05/20 02:12:25 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/05/20 02:12:25 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/05/20 02:12:25 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/05/20 02:12:28 DEBUG : chunked-copy: Done sending chunk 1 2025/05/20 02:12:28 DEBUG : chunked-copy: Done sending chunk 0 2025/05/20 02:12:28 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/05/20 02:12:29 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_z8fd29dd3701debbb9f680e1b_f200a0c0f6b01845f_d20250520_m021228_c001_v0001137_t0056_u01747707148981") 2025/05/20 02:12:29 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/05/20 02:12:29 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/05/20 02:12:29 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/05/20 02:12:29 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/05/20 02:12:30 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/05/20 02:12:30 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/05/20 02:12:30 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/05/20 02:12:31 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/05/20 02:12:32 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/05/20 02:12:33 DEBUG : Creating backend with remote "TestB2:rclone-test-lociqil8yolu/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/05/20 02:12:34 INFO : B2 bucket rclone-test-lociqil8yolu: cleaning bucket "rclone-test-lociqil8yolu" of all files 2025/05/20 02:12:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4157637f91455286_d20250520_m021126_c001_v7007000_t0000_u01747707086286") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f216b270b5cd7273e_d20250520_m021122_c001_v0001183_t0024_u01747707082249") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f416b270b5cd72737_d20250520_m021121_c001_v7007000_t0000_u01747707081677") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91454e93_d20250520_m021116_c001_v0001116_t0013_u01747707076902") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35b43_d20250520_m021153_c001_v7007000_t0000_u01747707113740") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35b3c_d20250520_m021148_c001_v0001182_t0031_u01747707108477") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35b3b_d20250520_m021147_c001_v7007000_t0000_u01747707107880") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2157637f9145529b_d20250520_m021141_c001_v0001116_t0001_u01747707101726") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4157637f9145529a_d20250520_m021141_c001_v7007000_t0000_u01747707101531") 2025/05/20 02:12:35 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_delete_file_version": EOF) 2025/05/20 02:12:35 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/05/20 02:12:35 DEBUG : pacer: Reducing sleep to 10ms 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91455292_d20250520_m021132_c001_v0001134_t0047_u01747707092675") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4157637f9145528f_d20250520_m021132_c001_v7007000_t0000_u01747707092120") 2025/05/20 02:12:35 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2157637f91455287_d20250520_m021126_c001_v0001157_t0027_u01747707086474") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f419fb0570cff2e3f_d20250520_m020944_c001_v7007000_t0000_u01747706984528") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d3589f_d20250520_m020940_c001_v0001161_t0045_u01747706980400") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d3589a_d20250520_m020935_c001_v7007000_t0000_u01747706975632") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35899_d20250520_m020931_c001_v0001109_t0013_u01747706971419") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d3589d_d20250520_m020939_c001_v7007000_t0000_u01747706979983") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d3589b_d20250520_m020935_c001_v0001134_t0009_u01747706975816") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35898_d20250520_m020931_c001_v7007000_t0000_u01747706971017") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35894_d20250520_m020926_c001_v0001099_t0026_u01747706966734") 2025/05/20 02:12:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35893_d20250520_m020926_c001_v7007000_t0000_u01747706966552") 2025/05/20 02:12:36 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f203c67d4cfdd85a0_d20250520_m020923_c001_v0001032_t0002_u01747706963065") 2025/05/20 02:12:36 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f403c67d4cfdd859f_d20250520_m020922_c001_v7007000_t0000_u01747706962668") 2025/05/20 02:12:36 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35885_d20250520_m020918_c001_v0001099_t0043_u01747706958093") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f419fb0570cff2e6b_d20250520_m021010_c001_v7007000_t0000_u01747707010553") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358cd_d20250520_m021005_c001_v0001116_t0029_u01747707005948") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f419fb0570cff2e62_d20250520_m021001_c001_v7007000_t0000_u01747707001150") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358c1_d20250520_m020957_c001_v0001183_t0050_u01747706997252") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d358cc_d20250520_m021005_c001_v7007000_t0000_u01747707005528") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f219fb0570cff2e63_d20250520_m021001_c001_v0001178_t0044_u01747707001347") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d358bf_d20250520_m020956_c001_v7007000_t0000_u01747706996804") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f219fb0570cff2e5c_d20250520_m020952_c001_v0001184_t0037_u01747706992713") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f419fb0570cff2e5b_d20250520_m020952_c001_v7007000_t0000_u01747706992526") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358b9_d20250520_m020948_c001_v0001044_t0040_u01747706988933") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d358b8_d20250520_m020948_c001_v7007000_t0000_u01747706988536") 2025/05/20 02:12:36 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f219fb0570cff2e41_d20250520_m020944_c001_v0001171_t0033_u01747706984716") 2025/05/20 02:12:36 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35884_d20250520_m020917_c001_v7007000_t0000_u01747706957911") 2025/05/20 02:12:36 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f203c67d4cfdd859a_d20250520_m020913_c001_v0001103_t0033_u01747706953763") 2025/05/20 02:12:36 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f403c67d4cfdd8598_d20250520_m020913_c001_v7007000_t0000_u01747706953364") 2025/05/20 02:12:36 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d3586a_d20250520_m020908_c001_v0001098_t0004_u01747706948887") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35869_d20250520_m020908_c001_v7007000_t0000_u01747706948699") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35866_d20250520_m020904_c001_v0001042_t0042_u01747706944428") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35865_d20250520_m020904_c001_v7007000_t0000_u01747706944017") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35861_d20250520_m020859_c001_v0001183_t0015_u01747706939861") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35860_d20250520_m020859_c001_v7007000_t0000_u01747706939679") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2196cd743a56e920_d20250520_m020856_c001_v0001130_t0022_u01747706936233") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4196cd743a56e91d_d20250520_m020855_c001_v7007000_t0000_u01747706935823") 2025/05/20 02:12:37 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f211ba370416a30e5_d20250520_m020841_c001_v0001161_t0033_u01747706921617") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f408284495154d01f_d20250520_m021045_c001_v7007000_t0000_u01747707045308") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f218b40bfaf346fa0_d20250520_m021040_c001_v0001176_t0004_u01747707040673") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4095f195752d7fd0_d20250520_m021034_c001_v7007000_t0000_u01747707034570") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2095f195752d7f7a_d20250520_m021029_c001_v0001157_t0002_u01747707029485") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f418b40bfaf346f9e_d20250520_m021040_c001_v7007000_t0000_u01747707040127") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2095f195752d7fd5_d20250520_m021034_c001_v0001171_t0048_u01747707034784") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4095f195752d7f77_d20250520_m021029_c001_v7007000_t0000_u01747707029007") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2095f195752d7f5f_d20250520_m021024_c001_v0001120_t0052_u01747707024094") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4095f195752d7f5e_d20250520_m021023_c001_v7007000_t0000_u01747707023896") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d358d5_d20250520_m021015_c001_v0001040_t0046_u01747707015078") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d358d4_d20250520_m021014_c001_v7007000_t0000_u01747707014614") 2025/05/20 02:12:37 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f219fb0570cff2e6c_d20250520_m021010_c001_v0001184_t0049_u01747707010737") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4157637f91454e92_d20250520_m021116_c001_v7007000_t0000_u01747707076707") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f216b270b5cd726f4_d20250520_m021111_c001_v0001137_t0042_u01747707071725") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f416b270b5cd726f3_d20250520_m021111_c001_v7007000_t0000_u01747707071203") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f208284495154d07d_d20250520_m021105_c001_v0001109_t0014_u01747707065614") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f408284495154d07c_d20250520_m021105_c001_v7007000_t0000_u01747707065428") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f208284495154d05b_d20250520_m021059_c001_v0001029_t0011_u01747707059789") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f408284495154d05a_d20250520_m021059_c001_v7007000_t0000_u01747707059294") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f208284495154d050_d20250520_m021054_c001_v0001183_t0022_u01747707054418") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f408284495154d04f_d20250520_m021054_c001_v7007000_t0000_u01747707054231") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f218b40bfaf347014_d20250520_m021050_c001_v0001091_t0038_u01747707050185") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f418b40bfaf347013_d20250520_m021049_c001_v7007000_t0000_u01747707049673") 2025/05/20 02:12:38 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f208284495154d023_d20250520_m021045_c001_v0001179_t0051_u01747707045528") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f422d1dd26ae85ebd_d20250520_m021231_c001_v7007000_t0000_u01747707151436") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f222d1dd26ae85eb7_d20250520_m021225_c001_v0001041_t0001_u01747707145545") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f422d1dd26ae85eb6_d20250520_m021224_c001_v7007000_t0000_u01747707144916") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f200a0c0f6b018459_d20250520_m021219_c001_v0001099_t0056_u01747707139630") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f400a0c0f6b018458_d20250520_m021219_c001_v7007000_t0000_u01747707139013") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35b4e_d20250520_m021202_c001_v0001144_t0051_u01747707122551") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35b4d_d20250520_m021201_c001_v7007000_t0000_u01747707121931") 2025/05/20 02:12:38 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c120b_d20250520_m021158_c001_v0001177_t0034_u01747707118330") 2025/05/20 02:12:39 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35b46_d20250520_m021157_c001_v7007000_t0000_u01747707117825") 2025/05/20 02:12:39 DEBUG : chunked-copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c1201_d20250520_m021154_c001_v0001177_t0006_u01747707114484") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f422d1dd26ae85ebc_d20250520_m021231_c001_v7007000_t0000_u01747707151251") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f200a0c0f6b01845f_d20250520_m021228_c001_v0001137_t0056_u01747707148981") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f422d1dd26ae85eb5_d20250520_m021224_c001_v7007000_t0000_u01747707144721") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f222d1dd26ae85eb2_d20250520_m021223_c001_v0001177_t0057_u01747707143132") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f400a0c0f6b018457_d20250520_m021218_c001_v7007000_t0000_u01747707138826") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f222d1dd26ae85eaf_d20250520_m021215_c001_v0001171_t0047_u01747707135301") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35b4c_d20250520_m021201_c001_v7007000_t0000_u01747707121746") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f2045875df6d35b48_d20250520_m021200_c001_v0001181_t0000_u01747707120074") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4045875df6d35b45_d20250520_m021157_c001_v7007000_t0000_u01747707117626") 2025/05/20 02:12:39 DEBUG : chunked-copy.copy: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f1190e883657ef1a4_d20250520_m021156_c001_v0001043_t0003_u01747707116431") 2025/05/20 02:12:39 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11430ccb9ba75e28_d20250520_m020724_c001_v0001178_t0033_u01747706844388") 2025/05/20 02:12:39 DEBUG : unknown-size-put.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f422d1dd26ae85ebf_d20250520_m021232_c001_v7007000_t0000_u01747707152221") 2025/05/20 02:12:39 DEBUG : unknown-size-put.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c1299_d20250520_m021231_c001_v0001177_t0011_u01747707151989") 2025/05/20 02:12:39 DEBUG : unknown-size-update.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f422d1dd26ae85ec2_d20250520_m021233_c001_v7007000_t0000_u01747707153252") 2025/05/20 02:12:39 DEBUG : unknown-size-update.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c129f_d20250520_m021233_c001_v0001177_t0007_u01747707153009") 2025/05/20 02:12:39 DEBUG : unknown-size-update.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f11524331573c129b_d20250520_m021232_c001_v0001177_t0027_u01747707152406") 2025/05/20 02:12:39 DEBUG : versions/test-versions.txt: Deleting (id "4_z8fd29dd3701debbb9f680e1b_f4157637f91454dc8_d20250520_m020837_c001_v7007000_t0000_u01747706917920") 2025/05/20 02:12:41 INFO : B2 bucket rclone-test-lociqil8yolu: cleaning bucket "rclone-test-lociqil8yolu" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (349.71s) --- 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 (347.61s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.54s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding (19.46s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (1.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.95s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.95s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.95s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.11s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (6.67s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (77.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.81s) --- 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.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (1.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.23s) --- 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.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.65s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (29.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (6.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (0.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (5.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (19.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.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.68s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (192.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (36.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (18.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.85s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (9.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (9.21s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.54s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (26.62s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (8.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.88s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (9.08s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.61s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (8.90s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (26.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (8.00s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (3.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.63s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.34s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (9.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (5.03s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (34.79s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (13.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (9.28s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (10.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (5.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (10.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.21s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (31.37s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (8.89s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (11.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (6.13s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (11.28s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.49s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (37.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (9.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (4.61s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (15.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (9.42s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (12.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.83s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (37.69s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.10s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (4.09s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (17.10s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (5.89s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (6.51s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (1.82s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.78s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.03s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.28s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/b2 349.732s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 5m50.535431793s (try 1/5)