"go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) === RUN TestUrlEncode --- PASS: TestUrlEncode (0.00s) === RUN TestTimeString --- PASS: TestTimeString (0.00s) === RUN TestParseTimeString b2_internal_test.go:183: potato: want error strconv.ParseInt: parsing "potato": invalid syntax got error --- PASS: TestParseTimeString (0.00s) === RUN TestIntegration fstests.go:438: Using remote "TestB2:" 2025/11/08 05:25:48 DEBUG : Creating backend with remote "TestB2:rclone-test-piweqaq5xoko" 2025/11/08 05:25:48 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/11/08 05:25:51 INFO : dir/subdir: Making directory fstest.go:250: Filtering empty directory "dir" fstest.go:250: Filtering empty directory "dir/subdir" 2025/11/08 05:25:51 INFO : dir/subdir: Removing directory fstest.go:250: Filtering empty directory "dir" 2025/11/08 05:25:51 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 "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/11/08 05:25:53 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Clearing upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:25:53 DEBUG : pacer: low level retry 1/1 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:25:53 DEBUG : pacer: Rate limited, increasing sleep to 1s fstests.go:143: Put error: no tomes available (503 service_unavailable): trying again in 1s - low level retry 1/10 2025/11/08 05:25:55 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:25:57 DEBUG : pacer: Reducing sleep to 250ms 2025/11/08 05:25:57 DEBUG : pacer: Reducing sleep to 125ms 2025/11/08 05:25:57 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/08 05:25:57 DEBUG : pacer: Reducing sleep to 31.25ms 2025/11/08 05:25:58 DEBUG : pacer: Reducing sleep to 15.625ms === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/11/08 05:25:58 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter 2025/11/08 05:26:17 DEBUG : writer-at-subdir/writer-at-file: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/11/08 05:26:17 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/11/08 05:26:20 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/11/08 05:26:20 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/11/08 05:26:20 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/11/08 05:26:20 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/11/08 05:26:21 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/11/08 05:26:21 DEBUG : writer-at-subdir/writer-at-file: Finishing large file upload with 0 parts === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/11/08 05:26:27 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/11/08 05:26:29 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2025/11/08 05:26:34 INFO : B2 bucket rclone-test-piweqaq5xoko: cleaning bucket "rclone-test-piweqaq5xoko" of all files 2025/11/08 05:26:34 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5f2e_d20251108_m052633_c001_v0001183_t0014_u01762579593245") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/11/08 05:26:35 DEBUG : Creating backend with remote "TestB2:rclone-test-piweqaq5xoko/dirToPurgeFromRoot" 2025/11/08 05:26:36 INFO : B2 bucket rclone-test-piweqaq5xoko path dirToPurgeFromRoot: cleaning bucket "rclone-test-piweqaq5xoko" of all files 2025/11/08 05:26:37 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5f35_d20251108_m052635_c001_v0001183_t0032_u01762579595022") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/11/08 05:26:38 DEBUG : Creating backend with remote "TestB2:rclone-test-piweqaq5xoko/hello? sausage/êé" 2025/11/08 05:26:43 INFO : B2 bucket rclone-test-piweqaq5xoko path hello? sausage/êé: cleaning bucket "rclone-test-piweqaq5xoko" of all files 2025/11/08 05:26:43 DEBUG : a/b/c/d/e.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f1179263265a8d2e1_d20251108_m052640_c001_v0001178_t0021_u01762579600731") === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1289: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1342: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1459: FS has no DirMover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/11/08 05:26:52 DEBUG : Creating backend with remote "TestB2:rclone-test-piweqaq5xoko/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/08 05:26:54 DEBUG : Creating backend with remote "TestB2:rclone-test-piweqaq5xoko/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-piweqaq5xoko" from "TestB2:rclone-test-piweqaq5xoko" 2025/11/08 05:26:56 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink 2025/11/08 05:27:08 DEBUG : Creating backend with remote "TestB2:rclone-test-jefeyak5tabu" 2025/11/08 05:27:11 DEBUG : B2 bucket rclone-test-jefeyak5tabu: Purge remote 2025/11/08 05:27:11 INFO : B2 bucket rclone-test-jefeyak5tabu: cleaning bucket "rclone-test-jefeyak5tabu" of all files 2025/11/08 05:27:11 DEBUG : somefile: Deleting (id "4_zbfc2cd43e0ed6b1b9fa80e1b_f411364b7ec1ef45e_d20251108_m052710_c001_v0001177_t0041_u01762579630265") === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2131: Can't have // in paths === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/11/08 05:27:12 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/08 05:27:13 DEBUG : piped data.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB 2025/11/08 05:27:16 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/11/08 05:27:16 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/11/08 05:27:16 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.896Ki offset 6Mi/6.106Mi 2025/11/08 05:27:16 DEBUG : test-metadata: Sending chunk 1 length 111510 2025/11/08 05:27:17 DEBUG : test-metadata: Done sending chunk 1 2025/11/08 05:27:18 DEBUG : test-metadata: Done sending chunk 0 2025/11/08 05:27:18 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 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent === NAME TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions-v2025-11-08-052723-752.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs 2025/11/08 05:27:31 DEBUG : oldPath = "TestB2:rclone-test-piweqaq5xoko/versions/test-versions-v2025-11-08-052723-752.txt" 2025/11/08 05:27:31 DEBUG : newPath = "TestB2,versions:rclone-test-piweqaq5xoko/versions/test-versions-v2025-11-08-052723-752.txt" 2025/11/08 05:27:31 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-piweqaq5xoko/versions/test-versions-v2025-11-08-052723-752.txt" 2025/11/08 05:27:31 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/11/08 05:27:32 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-piweqaq5xoko/versions/test-versions-v2025-11-08-052723-752.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-piweqaq5xoko/versions" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun 2025/11/08 05:27:35 INFO : B2 bucket rclone-test-piweqaq5xoko: cleaning bucket "rclone-test-piweqaq5xoko" of all hidden files 2025/11/08 05:27:35 DEBUG : leading space/ leading space: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff2_d20251108_m052601_c001_v7007000_t0000_u01762579561663") as it is a hide marker 2025/11/08 05:27:35 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : leading space/ leading space: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e62_d20251108_m052601_c001_v0001183_t0025_u01762579561096") 2025/11/08 05:27:35 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efef_d20251108_m052600_c001_v7007000_t0000_u01762579560718") as it is a hide marker 2025/11/08 05:27:35 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e5e_d20251108_m052600_c001_v0001183_t0015_u01762579560138") 2025/11/08 05:27:35 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f00a_d20251108_m052607_c001_v7007000_t0000_u01762579567740") as it is a hide marker 2025/11/08 05:27:35 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : .leading dot/.leading dot: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e92_d20251108_m052607_c001_v0001183_t0016_u01762579567159") 2025/11/08 05:27:35 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : created from root.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f422c1db689402237_d20251108_m052704_c001_v7007000_t0000_u01762579624116") as it is a hide marker 2025/11/08 05:27:35 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : created from root.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f119544f547115f0f_d20251108_m052702_c001_v0001098_t0053_u01762579622975") 2025/11/08 05:27:35 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : file name.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d165d_d20251108_m052712_c001_v7007000_t0000_u01762579632435") as it is a hide marker 2025/11/08 05:27:35 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5f75_d20251108_m052651_c001_v0001183_t0028_u01762579611800") 2025/11/08 05:27:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f106740701b4a7f4d_d20251108_m052647_c001_v0001153_t0008_u01762579607867") 2025/11/08 05:27:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5f04_d20251108_m052625_c001_v0001183_t0059_u01762579585234") 2025/11/08 05:27:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5efb_d20251108_m052624_c001_v0001183_t0046_u01762579584412") 2025/11/08 05:27:35 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5efe_d20251108_m052624_c001_v0001183_t0000_u01762579584816") "upload" dated 2025-11-08 05:26:24.816 +0000 UTC (1m11.049161822s ago) 2025/11/08 05:27:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f41587366531b86a5_d20251108_m052645_c001_v7007000_t0000_u01762579605575") as it is a hide marker 2025/11/08 05:27:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f105a0f847f1fc29a_d20251108_m052645_c001_v0001184_t0010_u01762579605370") 2025/11/08 05:27:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f119383b7b9cdc8dc_d20251108_m052644_c001_v0001184_t0016_u01762579604753") 2025/11/08 05:27:35 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f026_d20251108_m052614_c001_v7007000_t0000_u01762579574560") as it is a hide marker 2025/11/08 05:27:35 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ebf_d20251108_m052613_c001_v0001183_t0028_u01762579573962") 2025/11/08 05:27:35 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : piped data.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d1664_d20251108_m052714_c001_v7007000_t0000_u01762579634157") as it is a hide marker 2025/11/08 05:27:35 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : piped data.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5fdc_d20251108_m052713_c001_v0001183_t0057_u01762579633773") 2025/11/08 05:27:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : piped data.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d1662_d20251108_m052713_c001_v7007000_t0000_u01762579633586") 2025/11/08 05:27:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : piped data.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40426c5b832d5fd4_d20251108_m052713_c001_v0001183_t0007_u01762579633220") 2025/11/08 05:27:35 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f028_d20251108_m052615_c001_v7007000_t0000_u01762579575504") as it is a hide marker 2025/11/08 05:27:35 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ec7_d20251108_m052614_c001_v0001183_t0007_u01762579574926") 2025/11/08 05:27:35 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : test-metadata: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f404f8df6aab159fc_d20251108_m052721_c001_v7007000_t0000_u01762579641194") as it is a hide marker 2025/11/08 05:27:35 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : test-metadata: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f220ad3cb329d1668_d20251108_m052716_c001_v0001178_t0020_u01762579636093") 2025/11/08 05:27:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : test-metadata: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d1666_d20251108_m052715_c001_v7007000_t0000_u01762579635101") 2025/11/08 05:27:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : test-metadata: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5fe0_d20251108_m052714_c001_v0001183_t0048_u01762579634350") 2025/11/08 05:27:35 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f00f_d20251108_m052609_c001_v7007000_t0000_u01762579569637") as it is a hide marker 2025/11/08 05:27:35 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e9b_d20251108_m052609_c001_v0001183_t0023_u01762579569065") 2025/11/08 05:27:35 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f012_d20251108_m052611_c001_v7007000_t0000_u01762579571597") as it is a hide marker 2025/11/08 05:27:35 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ead_d20251108_m052611_c001_v0001183_t0022_u01762579571031") 2025/11/08 05:27:35 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f011_d20251108_m052610_c001_v7007000_t0000_u01762579570567") as it is a hide marker 2025/11/08 05:27:35 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ea5_d20251108_m052610_c001_v0001183_t0047_u01762579570001") 2025/11/08 05:27:35 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f01e_d20251108_m052612_c001_v7007000_t0000_u01762579572560") as it is a hide marker 2025/11/08 05:27:35 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5eb6_d20251108_m052611_c001_v0001183_t0054_u01762579571987") 2025/11/08 05:27:35 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f023_d20251108_m052613_c001_v7007000_t0000_u01762579573581") as it is a hide marker 2025/11/08 05:27:35 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5eb9_d20251108_m052612_c001_v0001183_t0051_u01762579572977") 2025/11/08 05:27:35 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing space /trailing space : Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f00d_d20251108_m052608_c001_v7007000_t0000_u01762579568696") as it is a hide marker 2025/11/08 05:27:35 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : trailing space /trailing space : Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e97_d20251108_m052608_c001_v0001183_t0011_u01762579568111") 2025/11/08 05:27:35 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6044_d20251108_m052729_c001_v0001183_t0020_u01762579649452") "upload" dated 2025-11-08 05:27:29.452 +0000 UTC (6.414174973s ago) 2025/11/08 05:27:35 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4162881cf41cd30b_d20251108_m052726_c001_v7007000_t0000_u01762579646898") 2025/11/08 05:27:35 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6027_d20251108_m052723_c001_v0001183_t0036_u01762579643752") 2025/11/08 05:27:35 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f03c_d20251108_m052623_c001_v7007000_t0000_u01762579583867") as it is a hide marker 2025/11/08 05:27:35 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f02d_d20251108_m052617_c001_v0001171_t0055_u01762579577736") 2025/11/08 05:27:35 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : zero-length-file: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f02c_d20251108_m052617_c001_v7007000_t0000_u01762579577393") as it is a hide marker 2025/11/08 05:27:35 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : zero-length-file: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40426c5b832d5ed3_d20251108_m052616_c001_v0001183_t0007_u01762579576816") 2025/11/08 05:27:35 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff4_d20251108_m052602_c001_v7007000_t0000_u01762579562785") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e6b_d20251108_m052602_c001_v0001183_t0005_u01762579562146") 2025/11/08 05:27:35 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efe5_d20251108_m052557_c001_v7007000_t0000_u01762579557848") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e4c_d20251108_m052556_c001_v0001183_t0036_u01762579556878") 2025/11/08 05:27:35 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16effb_d20251108_m052605_c001_v7007000_t0000_u01762579565716") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e86_d20251108_m052605_c001_v0001183_t0044_u01762579565127") 2025/11/08 05:27:35 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff7_d20251108_m052604_c001_v7007000_t0000_u01762579564750") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e7d_d20251108_m052604_c001_v0001183_t0034_u01762579564168") 2025/11/08 05:27:35 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f009_d20251108_m052606_c001_v7007000_t0000_u01762579566785") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e8a_d20251108_m052606_c001_v0001183_t0003_u01762579566160") 2025/11/08 05:27:35 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff6_d20251108_m052603_c001_v7007000_t0000_u01762579563785") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e75_d20251108_m052603_c001_v0001183_t0015_u01762579563171") 2025/11/08 05:27:35 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ．/．: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efe9_d20251108_m052558_c001_v7007000_t0000_u01762579558817") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ．/．: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ．/．: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e50_d20251108_m052558_c001_v0001183_t0051_u01762579558211") 2025/11/08 05:27:35 NOTICE: ．/．: Skipped delete as --dry-run is set 2025/11/08 05:27:35 DEBUG : ．．/．．: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efec_d20251108_m052559_c001_v7007000_t0000_u01762579559764") as it is a hide marker 2025/11/08 05:27:35 NOTICE: ．．/．．: Skipped remove hide marker as --dry-run is set 2025/11/08 05:27:35 DEBUG : ．．/．．: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e58_d20251108_m052559_c001_v0001183_t0007_u01762579559193") 2025/11/08 05:27:35 NOTICE: ．．/．．: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/11/08 05:27:36 INFO : B2 bucket rclone-test-piweqaq5xoko: cleaning bucket "rclone-test-piweqaq5xoko" of all hidden files 2025/11/08 05:27:36 DEBUG : leading space/ leading space: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff2_d20251108_m052601_c001_v7007000_t0000_u01762579561663") as it is a hide marker 2025/11/08 05:27:36 DEBUG : leading space/ leading space: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e62_d20251108_m052601_c001_v0001183_t0025_u01762579561096") 2025/11/08 05:27:36 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efef_d20251108_m052600_c001_v7007000_t0000_u01762579560718") as it is a hide marker 2025/11/08 05:27:36 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e5e_d20251108_m052600_c001_v0001183_t0015_u01762579560138") 2025/11/08 05:27:36 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f00a_d20251108_m052607_c001_v7007000_t0000_u01762579567740") as it is a hide marker 2025/11/08 05:27:36 DEBUG : .leading dot/.leading dot: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e92_d20251108_m052607_c001_v0001183_t0016_u01762579567159") 2025/11/08 05:27:36 DEBUG : created from root.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f422c1db689402237_d20251108_m052704_c001_v7007000_t0000_u01762579624116") as it is a hide marker 2025/11/08 05:27:36 DEBUG : created from root.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f119544f547115f0f_d20251108_m052702_c001_v0001098_t0053_u01762579622975") 2025/11/08 05:27:36 DEBUG : file name.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d165d_d20251108_m052712_c001_v7007000_t0000_u01762579632435") as it is a hide marker 2025/11/08 05:27:36 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5f75_d20251108_m052651_c001_v0001183_t0028_u01762579611800") 2025/11/08 05:27:36 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f106740701b4a7f4d_d20251108_m052647_c001_v0001153_t0008_u01762579607867") 2025/11/08 05:27:36 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5f04_d20251108_m052625_c001_v0001183_t0059_u01762579585234") 2025/11/08 05:27:36 DEBUG : file name.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5efb_d20251108_m052624_c001_v0001183_t0046_u01762579584412") 2025/11/08 05:27:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5efe_d20251108_m052624_c001_v0001183_t0000_u01762579584816") "upload" dated 2025-11-08 05:26:24.816 +0000 UTC (1m12.103188603s ago) 2025/11/08 05:27:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f41587366531b86a5_d20251108_m052645_c001_v7007000_t0000_u01762579605575") as it is a hide marker 2025/11/08 05:27:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f105a0f847f1fc29a_d20251108_m052645_c001_v0001184_t0010_u01762579605370") 2025/11/08 05:27:37 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f119383b7b9cdc8dc_d20251108_m052644_c001_v0001184_t0016_u01762579604753") 2025/11/08 05:27:37 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f026_d20251108_m052614_c001_v7007000_t0000_u01762579574560") as it is a hide marker 2025/11/08 05:27:37 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ebf_d20251108_m052613_c001_v0001183_t0028_u01762579573962") 2025/11/08 05:27:37 DEBUG : piped data.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d1664_d20251108_m052714_c001_v7007000_t0000_u01762579634157") as it is a hide marker 2025/11/08 05:27:37 DEBUG : piped data.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5fdc_d20251108_m052713_c001_v0001183_t0057_u01762579633773") 2025/11/08 05:27:37 DEBUG : piped data.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d1662_d20251108_m052713_c001_v7007000_t0000_u01762579633586") 2025/11/08 05:27:37 DEBUG : piped data.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40426c5b832d5fd4_d20251108_m052713_c001_v0001183_t0007_u01762579633220") 2025/11/08 05:27:37 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f028_d20251108_m052615_c001_v7007000_t0000_u01762579575504") as it is a hide marker 2025/11/08 05:27:37 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ec7_d20251108_m052614_c001_v0001183_t0007_u01762579574926") 2025/11/08 05:27:37 DEBUG : test-metadata: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f404f8df6aab159fc_d20251108_m052721_c001_v7007000_t0000_u01762579641194") as it is a hide marker 2025/11/08 05:27:37 DEBUG : test-metadata: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f220ad3cb329d1668_d20251108_m052716_c001_v0001178_t0020_u01762579636093") 2025/11/08 05:27:37 DEBUG : test-metadata: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f420ad3cb329d1666_d20251108_m052715_c001_v7007000_t0000_u01762579635101") 2025/11/08 05:27:37 DEBUG : test-metadata: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5fe0_d20251108_m052714_c001_v0001183_t0048_u01762579634350") 2025/11/08 05:27:37 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f00f_d20251108_m052609_c001_v7007000_t0000_u01762579569637") as it is a hide marker 2025/11/08 05:27:37 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e9b_d20251108_m052609_c001_v0001183_t0023_u01762579569065") 2025/11/08 05:27:37 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f012_d20251108_m052611_c001_v7007000_t0000_u01762579571597") as it is a hide marker 2025/11/08 05:27:37 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ead_d20251108_m052611_c001_v0001183_t0022_u01762579571031") 2025/11/08 05:27:37 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f011_d20251108_m052610_c001_v7007000_t0000_u01762579570567") as it is a hide marker 2025/11/08 05:27:38 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5ea5_d20251108_m052610_c001_v0001183_t0047_u01762579570001") 2025/11/08 05:27:38 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f01e_d20251108_m052612_c001_v7007000_t0000_u01762579572560") as it is a hide marker 2025/11/08 05:27:38 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5eb6_d20251108_m052611_c001_v0001183_t0054_u01762579571987") 2025/11/08 05:27:38 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f023_d20251108_m052613_c001_v7007000_t0000_u01762579573581") as it is a hide marker 2025/11/08 05:27:38 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5eb9_d20251108_m052612_c001_v0001183_t0051_u01762579572977") 2025/11/08 05:27:38 DEBUG : trailing space /trailing space : Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f00d_d20251108_m052608_c001_v7007000_t0000_u01762579568696") as it is a hide marker 2025/11/08 05:27:38 DEBUG : trailing space /trailing space : Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e97_d20251108_m052608_c001_v0001183_t0011_u01762579568111") 2025/11/08 05:27:38 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6044_d20251108_m052729_c001_v0001183_t0020_u01762579649452") "upload" dated 2025-11-08 05:27:29.452 +0000 UTC (8.900904332s ago) 2025/11/08 05:27:38 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4162881cf41cd30b_d20251108_m052726_c001_v7007000_t0000_u01762579646898") 2025/11/08 05:27:38 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6027_d20251108_m052723_c001_v0001183_t0036_u01762579643752") 2025/11/08 05:27:38 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f03c_d20251108_m052623_c001_v7007000_t0000_u01762579583867") as it is a hide marker 2025/11/08 05:27:38 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f02d_d20251108_m052617_c001_v0001171_t0055_u01762579577736") 2025/11/08 05:27:38 DEBUG : zero-length-file: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f02c_d20251108_m052617_c001_v7007000_t0000_u01762579577393") as it is a hide marker 2025/11/08 05:27:38 DEBUG : zero-length-file: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40426c5b832d5ed3_d20251108_m052616_c001_v0001183_t0007_u01762579576816") 2025/11/08 05:27:38 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff4_d20251108_m052602_c001_v7007000_t0000_u01762579562785") as it is a hide marker 2025/11/08 05:27:38 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e6b_d20251108_m052602_c001_v0001183_t0005_u01762579562146") 2025/11/08 05:27:38 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efe5_d20251108_m052557_c001_v7007000_t0000_u01762579557848") as it is a hide marker 2025/11/08 05:27:38 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e4c_d20251108_m052556_c001_v0001183_t0036_u01762579556878") 2025/11/08 05:27:38 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16effb_d20251108_m052605_c001_v7007000_t0000_u01762579565716") as it is a hide marker 2025/11/08 05:27:38 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e86_d20251108_m052605_c001_v0001183_t0044_u01762579565127") 2025/11/08 05:27:38 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff7_d20251108_m052604_c001_v7007000_t0000_u01762579564750") as it is a hide marker 2025/11/08 05:27:39 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e7d_d20251108_m052604_c001_v0001183_t0034_u01762579564168") 2025/11/08 05:27:39 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f009_d20251108_m052606_c001_v7007000_t0000_u01762579566785") as it is a hide marker 2025/11/08 05:27:39 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e8a_d20251108_m052606_c001_v0001183_t0003_u01762579566160") 2025/11/08 05:27:39 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16eff6_d20251108_m052603_c001_v7007000_t0000_u01762579563785") as it is a hide marker 2025/11/08 05:27:39 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e75_d20251108_m052603_c001_v0001183_t0015_u01762579563171") 2025/11/08 05:27:39 DEBUG : ．/．: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efe9_d20251108_m052558_c001_v7007000_t0000_u01762579558817") as it is a hide marker 2025/11/08 05:27:39 DEBUG : ．/．: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e50_d20251108_m052558_c001_v0001183_t0051_u01762579558211") 2025/11/08 05:27:39 DEBUG : ．．/．．: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16efec_d20251108_m052559_c001_v7007000_t0000_u01762579559764") as it is a hide marker 2025/11/08 05:27:39 DEBUG : ．．/．．: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5e58_d20251108_m052559_c001_v0001183_t0007_u01762579559193") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/11/08 05:27:40 DEBUG : unfinished/unfinished-1: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. 2025/11/08 05:27:41 DEBUG : unfinished/unfinished-2: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. 2025/11/08 05:27:41 DEBUG : unfinished/unfinished-3: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. 2025/11/08 05:27:42 DEBUG : unfinished/unfinished-4: Streaming upload with --b2-chunk-size 6Mi allows uploads of up to 58.594Gi and will fail only when that limit is reached. === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun 2025/11/08 05:27:42 INFO : B2 bucket rclone-test-piweqaq5xoko: cleaning bucket "rclone-test-piweqaq5xoko" of pending multipart uploads older than 0s 2025/11/08 05:27:42 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5efe_d20251108_m052624_c001_v0001183_t0000_u01762579584816") "upload" dated 2025-11-08 05:26:24.816 +0000 UTC (1m17.990559592s ago) 2025/11/08 05:27:42 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc0_d20251108_m052740_c001_v0001171_t0052_u01762579660471") as it is a start marker (upload started at 2025-11-08 05:27:40.471 +0000 UTC) 2025/11/08 05:27:42 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/11/08 05:27:42 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc1_d20251108_m052741_c001_v0001181_t0035_u01762579661298") as it is a start marker (upload started at 2025-11-08 05:27:41.298 +0000 UTC) 2025/11/08 05:27:42 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/11/08 05:27:42 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc2_d20251108_m052742_c001_v0001101_t0008_u01762579662040") as it is a start marker (upload started at 2025-11-08 05:27:42.04 +0000 UTC) 2025/11/08 05:27:42 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/11/08 05:27:42 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc5_d20251108_m052742_c001_v0001180_t0046_u01762579662256") as it is a start marker (upload started at 2025-11-08 05:27:42.256 +0000 UTC) 2025/11/08 05:27:42 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/11/08 05:27:42 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f4103e53acd0addbe_d20251108_m052740_c001_v7007000_t0000_u01762579660275") "hide" dated 2025-11-08 05:27:40.275 +0000 UTC (2.532147203s ago) 2025/11/08 05:27:42 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6044_d20251108_m052729_c001_v0001183_t0020_u01762579649452") 2025/11/08 05:27:42 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/11/08 05:27:42 INFO : B2 bucket rclone-test-piweqaq5xoko: cleaning bucket "rclone-test-piweqaq5xoko" of pending multipart uploads older than 0s 2025/11/08 05:27:43 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5efe_d20251108_m052624_c001_v0001183_t0000_u01762579584816") "upload" dated 2025-11-08 05:26:24.816 +0000 UTC (1m18.360615965s ago) 2025/11/08 05:27:43 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc0_d20251108_m052740_c001_v0001171_t0052_u01762579660471") as it is a start marker (upload started at 2025-11-08 05:27:40.471 +0000 UTC) 2025/11/08 05:27:43 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc1_d20251108_m052741_c001_v0001181_t0035_u01762579661298") as it is a start marker (upload started at 2025-11-08 05:27:41.298 +0000 UTC) 2025/11/08 05:27:43 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc2_d20251108_m052742_c001_v0001101_t0008_u01762579662040") as it is a start marker (upload started at 2025-11-08 05:27:42.04 +0000 UTC) 2025/11/08 05:27:43 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addc5_d20251108_m052742_c001_v0001180_t0046_u01762579662256") as it is a start marker (upload started at 2025-11-08 05:27:42.256 +0000 UTC) 2025/11/08 05:27:43 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf029d13e0dd6b1b9fa80e1b_f4103e53acd0addbe_d20251108_m052740_c001_v7007000_t0000_u01762579660275") "hide" dated 2025-11-08 05:27:40.275 +0000 UTC (2.901897102s ago) 2025/11/08 05:27:43 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6044_d20251108_m052729_c001_v0001183_t0020_u01762579649452") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/11/08 05:27:43 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/11/08 05:27:44 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/11/08 05:27:44 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 2025/11/08 05:27:45 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/11/08 05:27:45 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/11/08 05:27:45 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/11/08 05:27:45 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/11/08 05:27:46 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/11/08 05:27:47 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/11/08 05:27:47 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/11/08 05:27:50 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:27:50 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 5Mi allows uploads of up to 48.828Gi and will fail only when that limit is reached. 2025/11/08 05:27:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f0d3_d20251108_m052750_c001_v0001144_t0027_u01762579670892") 2025/11/08 05:27:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:27:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/08 05:27:51 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/08 05:27:52 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:27:53 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:27:53 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/11/08 05:27:55 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/11/08 05:27:55 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/11/08 05:27:55 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/11/08 05:27:55 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/11/08 05:27:57 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/11/08 05:27:57 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/11/08 05:27:57 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/11/08 05:27:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:27:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Streaming upload with --b2-chunk-size 5Mi allows uploads of up to 48.828Gi and will fail only when that limit is reached. 2025/11/08 05:27:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f0d9_d20251108_m052759_c001_v0001157_t0002_u01762579679488") 2025/11/08 05:27:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/08 05:27:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/08 05:27:59 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/11/08 05:28:01 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:28:02 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:28:02 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/11/08 05:28:04 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/11/08 05:28:04 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/11/08 05:28:04 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/11/08 05:28:04 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/11/08 05:28:04 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/11/08 05:28:04 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/11/08 05:28:05 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/11/08 05:28:06 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/11/08 05:28:06 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/11/08 05:28:06 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/11/08 05:28:08 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:28:08 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 5Mi allows uploads of up to 48.828Gi and will fail only when that limit is reached. 2025/11/08 05:28:08 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f218b07dcb4bfb2e9_d20251108_m052808_c001_v0001171_t0033_u01762579688705") 2025/11/08 05:28:08 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/11/08 05:28:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:28:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/08 05:28:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/11/08 05:28:10 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/11/08 05:28:11 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:28:11 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:28:11 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 2025/11/08 05:28:13 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/11/08 05:28:13 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/11/08 05:28:13 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/11/08 05:28:13 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:14 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/11/08 05:28:16 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/11/08 05:28:16 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/11/08 05:28:17 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:28:17 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/11/08 05:28:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f218b07dcb4bfb2f9_d20251108_m052818_c001_v0001117_t0056_u01762579698017") 2025/11/08 05:28:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:28:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/11/08 05:28:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000368cc0), retryAfter:1000000000} 2025/11/08 05:28:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/11/08 05:28:18 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:18 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:18 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:19 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:19 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:28:20 DEBUG : pacer: Reducing sleep to 250ms 2025/11/08 05:28:20 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00032cdb0), retryAfter:1000000000} 2025/11/08 05:28:20 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:20 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:20 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:20 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000338d80), retryAfter:1000000000} 2025/11/08 05:28:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:21 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:22 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:23 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0003692c0), retryAfter:1000000000} 2025/11/08 05:28:23 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:23 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:23 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:23 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:24 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:25 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00032def0), retryAfter:1000000000} 2025/11/08 05:28:25 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:25 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:25 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:25 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:26 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:27 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0000da6c0), retryAfter:1000000000} 2025/11/08 05:28:27 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:27 DEBUG : pacer: low level retry 6/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:27 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:27 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:28 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0000dae70), retryAfter:1000000000} 2025/11/08 05:28:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:29 DEBUG : pacer: low level retry 7/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:29 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:30 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0000dbd70), retryAfter:1000000000} 2025/11/08 05:28:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:31 DEBUG : pacer: low level retry 8/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:31 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:32 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:33 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0000e0d20), retryAfter:1000000000} 2025/11/08 05:28:33 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:33 DEBUG : pacer: low level retry 9/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:33 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:33 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:34 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:28:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0000e0f60), retryAfter:1000000000} 2025/11/08 05:28:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:35 DEBUG : pacer: low level retry 10/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:28:35 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:28:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Error sending chunk 0: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:28:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Cancelling large file upload 2025/11/08 05:28:36 DEBUG : pacer: Reducing sleep to 500ms fstests.go:143: PutLarge error: no tomes available (503 service_unavailable): trying again in 1s - low level retry 1/10 2025/11/08 05:28:38 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:28:38 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/11/08 05:28:38 DEBUG : pacer: Reducing sleep to 250ms 2025/11/08 05:28:38 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f11c_d20251108_m052838_c001_v0001146_t0041_u01762579718346") 2025/11/08 05:28:38 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:28:38 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/11/08 05:28:39 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:39 DEBUG : pacer: Reducing sleep to 125ms 2025/11/08 05:28:39 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/08 05:28:40 DEBUG : pacer: Reducing sleep to 31.25ms 2025/11/08 05:28:40 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:28:41 DEBUG : pacer: Reducing sleep to 15.625ms 2025/11/08 05:28:41 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:28:41 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts 2025/11/08 05:28:42 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/11/08 05:28:44 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/11/08 05:28:44 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:45 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/11/08 05:28:45 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/11/08 05:28:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/11/08 05:28:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/11/08 05:28:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/11/08 05:28:48 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:28:48 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/11/08 05:28:49 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e98023_d20251108_m052849_c001_v0001042_t0046_u01762579729081") 2025/11/08 05:28:49 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:49 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/08 05:28:49 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/11/08 05:28:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:28:52 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:28:52 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/11/08 05:28:53 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/11/08 05:28:53 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:54 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/11/08 05:28:54 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/11/08 05:28:54 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/11/08 05:28:54 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/11/08 05:28:55 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/11/08 05:28:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/11/08 05:28:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/11/08 05:28:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/11/08 05:28:58 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:28:58 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/11/08 05:28:58 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e9804d_d20251108_m052858_c001_v0001165_t0032_u01762579738753") 2025/11/08 05:28:58 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/11/08 05:28:59 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:28:59 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/11/08 05:28:59 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/11/08 05:28:59 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/11/08 05:28:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/11/08 05:28:59 DEBUG : pacer: Reducing sleep to 10ms 2025/11/08 05:28:59 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/11/08 05:29:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:29:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:29:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 2025/11/08 05:29:03 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/11/08 05:29:03 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/11/08 05:29:03 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/11/08 05:29:03 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/11/08 05:29:04 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/11/08 05:29:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/11/08 05:29:06 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/11/08 05:29:07 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:29:07 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/11/08 05:29:07 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e9807f_d20251108_m052907_c001_v0001032_t0039_u01762579747765") 2025/11/08 05:29:07 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:29:07 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/11/08 05:29:07 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/08 05:29:08 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:29:10 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:29:10 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/11/08 05:29:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/11/08 05:29:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/11/08 05:29:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/11/08 05:29:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/11/08 05:29:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/11/08 05:29:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/11/08 05:29:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/11/08 05:29:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:29:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/11/08 05:29:21 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e980a6_d20251108_m052921_c001_v0001042_t0026_u01762579761046") 2025/11/08 05:29:21 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/08 05:29:21 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/08 05:29:21 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/11/08 05:29:23 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:29:24 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:29:24 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/11/08 05:29:26 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/11/08 05:29:26 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/11/08 05:29:26 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/11/08 05:29:26 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/11/08 05:29:26 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/11/08 05:29:26 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/11/08 05:29:27 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/11/08 05:29:28 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/11/08 05:29:30 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/11/08 05:29:30 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/11/08 05:29:38 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:29:38 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/11/08 05:29:38 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e980c9_d20251108_m052938_c001_v0001183_t0003_u01762579778305") 2025/11/08 05:29:38 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/11/08 05:29:38 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:29:38 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/11/08 05:29:38 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/11/08 05:29:39 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/11/08 05:29:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:29:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:29:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 2025/11/08 05:29:44 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/11/08 05:29:44 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/11/08 05:29:44 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/11/08 05:29:44 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/11/08 05:29:45 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/11/08 05:29:47 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/11/08 05:29:47 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/11/08 05:29:49 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:29:49 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/11/08 05:29:49 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e981e6_d20251108_m052949_c001_v0001101_t0032_u01762579789313") 2025/11/08 05:29:49 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:29:49 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/11/08 05:29:49 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/08 05:29:50 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:29:52 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:29:52 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/11/08 05:29:54 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/11/08 05:29:54 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/11/08 05:29:54 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/11/08 05:29:54 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/11/08 05:29:56 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/11/08 05:29:56 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/11/08 05:29:56 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/11/08 05:29:58 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:29:58 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/11/08 05:29:59 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f2216311f448b0f60_d20251108_m052958_c001_v0001120_t0006_u01762579798929") 2025/11/08 05:29:59 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/08 05:29:59 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/08 05:29:59 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/11/08 05:30:01 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:30:01 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:30:01 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/11/08 05:30:04 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/11/08 05:30:04 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/11/08 05:30:04 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/11/08 05:30:04 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/11/08 05:30:04 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/11/08 05:30:04 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/11/08 05:30:05 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/11/08 05:30:06 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/11/08 05:30:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/11/08 05:30:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/11/08 05:30:09 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:30:09 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/11/08 05:30:09 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f202687500d7fa9d8_d20251108_m053009_c001_v0001137_t0007_u01762579809793") 2025/11/08 05:30:09 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/11/08 05:30:10 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:30:10 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/11/08 05:30:10 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/11/08 05:30:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/11/08 05:30:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:30:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:30:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 2025/11/08 05:30:15 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/11/08 05:30:15 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/11/08 05:30:15 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/11/08 05:30:15 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/11/08 05:30:15 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/11/08 05:30:17 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/11/08 05:30:17 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/11/08 05:30:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:30:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/11/08 05:30:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f202687500d7fa9e5_d20251108_m053019_c001_v0001182_t0057_u01762579819287") 2025/11/08 05:30:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:30:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/08 05:30:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/08 05:30:20 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000361740), retryAfter:1000000000} 2025/11/08 05:30:20 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/11/08 05:30:20 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/11/08 05:30:20 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/11/08 05:30:20 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/08 05:30:20 DEBUG : pacer: Reducing sleep to 500ms 2025/11/08 05:30:20 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:30:21 DEBUG : pacer: Reducing sleep to 250ms 2025/11/08 05:30:24 DEBUG : pacer: Reducing sleep to 125ms 2025/11/08 05:30:24 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:30:24 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts 2025/11/08 05:30:24 DEBUG : pacer: Reducing sleep to 62.5ms 2025/11/08 05:30:25 DEBUG : pacer: Reducing sleep to 31.25ms 2025/11/08 05:30:25 DEBUG : pacer: Reducing sleep to 15.625ms 2025/11/08 05:30:27 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/11/08 05:30:28 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/11/08 05:30:28 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/11/08 05:30:28 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/11/08 05:30:28 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/11/08 05:30:31 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/11/08 05:30:31 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/11/08 05:30:31 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/11/08 05:30:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:30:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/11/08 05:30:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f20108f13c6f9085b_d20251108_m053033_c001_v0001131_t0026_u01762579833732") 2025/11/08 05:30:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/08 05:30:34 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/11/08 05:30:34 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/08 05:30:36 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:30:36 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:30:36 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/11/08 05:30:39 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/11/08 05:30:39 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/11/08 05:30:39 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/11/08 05:30:39 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/11/08 05:30:39 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/11/08 05:30:39 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/11/08 05:30:41 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/11/08 05:30:41 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/11/08 05:30:42 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/11/08 05:30:42 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/11/08 05:30:44 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:30:44 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/11/08 05:30:44 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f2192668b7f9e4118_d20251108_m053044_c001_v0001146_t0015_u01762579844801") 2025/11/08 05:30:44 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/11/08 05:30:45 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:30:45 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/11/08 05:30:45 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/08 05:30:46 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/11/08 05:30:47 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:30:48 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:30:48 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 2025/11/08 05:30:50 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/11/08 05:30:50 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/11/08 05:30:50 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/11/08 05:30:50 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/11/08 05:30:51 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/11/08 05:30:53 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/11/08 05:30:53 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/11/08 05:30:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:30:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 10Mi allows uploads of up to 97.656Gi and will fail only when that limit is reached. 2025/11/08 05:30:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f214136f5a5603e3c_d20251108_m053055_c001_v0001171_t0010_u01762579855381") 2025/11/08 05:30:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:30:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/11/08 05:30:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/08 05:30:56 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:30:58 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:30:58 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/11/08 05:31:00 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/11/08 05:31:00 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/11/08 05:31:00 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/11/08 05:31:00 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/11/08 05:31:03 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/11/08 05:31:03 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/11/08 05:31:03 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/11/08 05:31:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:31:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Streaming upload with --b2-chunk-size 10Mi allows uploads of up to 97.656Gi and will fail only when that limit is reached. 2025/11/08 05:31:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f2192668b7f9e4133_d20251108_m053106_c001_v0001136_t0035_u01762579866151") 2025/11/08 05:31:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/08 05:31:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/11/08 05:31:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/11/08 05:31:08 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:31:09 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:31:09 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/11/08 05:31:12 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/11/08 05:31:12 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/11/08 05:31:12 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/11/08 05:31:12 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/11/08 05:31:12 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/11/08 05:31:12 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/11/08 05:31:13 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/11/08 05:31:14 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/11/08 05:31:15 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/11/08 05:31:15 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/11/08 05:31:20 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/11/08 05:31:20 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 10Mi allows uploads of up to 97.656Gi and will fail only when that limit is reached. 2025/11/08 05:31:20 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf029d13e0dd6b1b9fa80e1b_f2083fd133a1ea34d_d20251108_m053120_c001_v0001102_t0048_u01762579880525") 2025/11/08 05:31:20 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/11/08 05:31:21 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/11/08 05:31:21 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/11/08 05:31:21 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/11/08 05:31:22 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/11/08 05:31:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/11/08 05:31:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/11/08 05:31:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsCopyChunked === RUN TestIntegration/FsMkdir/FsCopyChunked/5242880 === RUN TestIntegration/FsMkdir/FsCopyChunked/5242881 2025/11/08 05:31:31 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e71_d20251108_m053131_c001_v0001180_t0029_u01762579891805") 2025/11/08 05:31:31 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/11/08 05:31:31 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/08 05:31:32 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/08 05:31:32 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/08 05:31:32 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/11/08 05:31:34 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/11/08 05:31:34 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/08 05:31:34 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/11/08 05:31:34 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/11/08 05:31:37 DEBUG : chunked-copy: Done sending chunk 0 2025/11/08 05:31:37 DEBUG : chunked-copy: Done sending chunk 1 2025/11/08 05:31:37 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/08 05:31:38 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e78_d20251108_m053138_c001_v0001145_t0027_u01762579898134") 2025/11/08 05:31:38 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/11/08 05:31:38 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/08 05:31:38 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/08 05:31:38 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/08 05:31:38 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/11/08 05:31:41 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/11/08 05:31:41 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/08 05:31:41 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/11/08 05:31:41 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/11/08 05:31:43 DEBUG : chunked-copy: Done sending chunk 0 2025/11/08 05:31:43 DEBUG : chunked-copy: Done sending chunk 1 2025/11/08 05:31:43 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/08 05:31:44 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e7b_d20251108_m053144_c001_v0001099_t0027_u01762579904323") 2025/11/08 05:31:44 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/11/08 05:31:44 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/08 05:31:45 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/08 05:31:45 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/08 05:31:45 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/11/08 05:31:47 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/11/08 05:31:47 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/11/08 05:31:47 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/11/08 05:31:47 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/11/08 05:31:50 DEBUG : chunked-copy: Done sending chunk 0 2025/11/08 05:31:50 DEBUG : chunked-copy: Done sending chunk 1 2025/11/08 05:31:50 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/11/08 05:31:59 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e7f_d20251108_m053154_c001_v0001105_t0035_u01762579914632") 2025/11/08 05:31:59 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/11/08 05:31:59 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/11/08 05:31:59 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/11/08 05:32:00 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/11/08 05:32:00 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/11/08 05:32:00 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/11/08 05:32:00 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/11/08 05:32:04 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/08 05:32:05 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/08 05:32:06 DEBUG : Creating backend with remote "TestB2:rclone-test-piweqaq5xoko/deeper/nonexisting/directory" 2025/11/08 05:32:06 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2717: Can't test if can't have empty directories 2025/11/08 05:32:07 INFO : B2 bucket rclone-test-piweqaq5xoko: cleaning bucket "rclone-test-piweqaq5xoko" of all files 2025/11/08 05:32:07 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4192668b7f9e412d_d20251108_m053059_c001_v7007000_t0000_u01762579859652") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f214136f5a5603e3c_d20251108_m053055_c001_v0001171_t0010_u01762579855381") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f414136f5a5603e39_d20251108_m053054_c001_v7007000_t0000_u01762579854776") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2192668b7f9e4120_d20251108_m053050_c001_v0001165_t0050_u01762579850283") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f417e20652b708e68_d20251108_m053125_c001_v7007000_t0000_u01762579885909") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2083fd133a1ea34d_d20251108_m053120_c001_v0001102_t0048_u01762579880525") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4083fd133a1ea34c_d20251108_m053119_c001_v7007000_t0000_u01762579879836") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2192668b7f9e413e_d20251108_m053111_c001_v0001184_t0010_u01762579871727") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4192668b7f9e413c_d20251108_m053111_c001_v7007000_t0000_u01762579871484") 2025/11/08 05:32:07 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2192668b7f9e4133_d20251108_m053106_c001_v0001136_t0035_u01762579866151") 2025/11/08 05:32:08 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4192668b7f9e4132_d20251108_m053105_c001_v7007000_t0000_u01762579865568") 2025/11/08 05:32:08 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2192668b7f9e412e_d20251108_m053059_c001_v0001161_t0027_u01762579859850") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e98065_d20251108_m052902_c001_v7007000_t0000_u01762579742828") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e9804d_d20251108_m052858_c001_v0001165_t0032_u01762579738753") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f1b5_d20251108_m052853_c001_v7007000_t0000_u01762579733359") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e98023_d20251108_m052849_c001_v0001042_t0046_u01762579729081") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e98046_d20251108_m052857_c001_v7007000_t0000_u01762579737951") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f1b6_d20251108_m052853_c001_v0001041_t0019_u01762579733542") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e98022_d20251108_m052848_c001_v7007000_t0000_u01762579728662") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f12b_d20251108_m052844_c001_v0001184_t0008_u01762579724594") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f12a_d20251108_m052844_c001_v7007000_t0000_u01762579724410") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f11c_d20251108_m052838_c001_v0001146_t0041_u01762579718346") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f418b07dcb4bfb2f7_d20251108_m052817_c001_v7007000_t0000_u01762579697611") 2025/11/08 05:32:08 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f0ee_d20251108_m052813_c001_v0001104_t0045_u01762579693222") 2025/11/08 05:32:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4216311f448b0f44_d20251108_m052943_c001_v7007000_t0000_u01762579783954") 2025/11/08 05:32:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e980c9_d20251108_m052938_c001_v0001183_t0003_u01762579778305") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e980b0_d20251108_m052925_c001_v7007000_t0000_u01762579765499") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e980a6_d20251108_m052921_c001_v0001042_t0026_u01762579761046") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e980c2_d20251108_m052933_c001_v7007000_t0000_u01762579773446") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e980b1_d20251108_m052925_c001_v0001044_t0003_u01762579765699") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e980a3_d20251108_m052920_c001_v7007000_t0000_u01762579760614") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2216311f448b0f1e_d20251108_m052912_c001_v0001184_t0009_u01762579752324") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4216311f448b0f1d_d20251108_m052912_c001_v7007000_t0000_u01762579752052") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e9807f_d20251108_m052907_c001_v0001032_t0039_u01762579747765") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e9807d_d20251108_m052907_c001_v7007000_t0000_u01762579747382") 2025/11/08 05:32:09 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e98069_d20251108_m052903_c001_v0001032_t0022_u01762579743037") 2025/11/08 05:32:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f0eb_d20251108_m052813_c001_v7007000_t0000_u01762579693021") 2025/11/08 05:32:09 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f218b07dcb4bfb2e9_d20251108_m052808_c001_v0001171_t0033_u01762579688705") 2025/11/08 05:32:09 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f418b07dcb4bfb2e7_d20251108_m052808_c001_v7007000_t0000_u01762579688330") 2025/11/08 05:32:09 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f0e2_d20251108_m052804_c001_v0001120_t0025_u01762579684099") 2025/11/08 05:32:09 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f0e0_d20251108_m052803_c001_v7007000_t0000_u01762579683912") 2025/11/08 05:32:09 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f0d9_d20251108_m052759_c001_v0001157_t0002_u01762579679488") 2025/11/08 05:32:10 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f0d8_d20251108_m052759_c001_v7007000_t0000_u01762579679101") 2025/11/08 05:32:10 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f214136f5a55f9c1d_d20251108_m052754_c001_v0001099_t0028_u01762579674808") 2025/11/08 05:32:10 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f414136f5a55f9c1c_d20251108_m052754_c001_v7007000_t0000_u01762579674623") 2025/11/08 05:32:10 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f203872197e16f0d3_d20251108_m052750_c001_v0001144_t0027_u01762579670892") 2025/11/08 05:32:10 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f403872197e16f0d2_d20251108_m052750_c001_v7007000_t0000_u01762579670503") 2025/11/08 05:32:10 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2103e53acd0addcb_d20251108_m052745_c001_v0001137_t0011_u01762579665322") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40108f13c6f90834_d20251108_m053014_c001_v7007000_t0000_u01762579814436") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f202687500d7fa9d8_d20251108_m053009_c001_v0001137_t0007_u01762579809793") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4216311f448b0f63_d20251108_m053003_c001_v7007000_t0000_u01762579803407") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2216311f448b0f60_d20251108_m052958_c001_v0001120_t0006_u01762579798929") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f402687500d7fa9d7_d20251108_m053009_c001_v7007000_t0000_u01762579809266") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2216311f448b0f64_d20251108_m053003_c001_v0001136_t0050_u01762579803623") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4216311f448b0f5d_d20251108_m052958_c001_v7007000_t0000_u01762579798417") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2216311f448b0f56_d20251108_m052953_c001_v0001180_t0058_u01762579793863") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4216311f448b0f54_d20251108_m052953_c001_v7007000_t0000_u01762579793680") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f207ae72636e981e6_d20251108_m052949_c001_v0001101_t0032_u01762579789313") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e981d7_d20251108_m052948_c001_v7007000_t0000_u01762579788863") 2025/11/08 05:32:10 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2216311f448b0f46_d20251108_m052944_c001_v0001090_t0006_u01762579784137") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4192668b7f9e411f_d20251108_m053050_c001_v7007000_t0000_u01762579850089") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f2192668b7f9e4118_d20251108_m053044_c001_v0001146_t0015_u01762579844801") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4192668b7f9e4117_d20251108_m053044_c001_v7007000_t0000_u01762579844281") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f20108f13c6f91033_d20251108_m053038_c001_v0001043_t0020_u01762579838990") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40108f13c6f91030_d20251108_m053038_c001_v7007000_t0000_u01762579838787") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f20108f13c6f9085b_d20251108_m053033_c001_v0001131_t0026_u01762579833732") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40108f13c6f90858_d20251108_m053033_c001_v7007000_t0000_u01762579833209") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f20108f13c6f90852_d20251108_m053027_c001_v0001106_t0032_u01762579827741") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f40108f13c6f90851_d20251108_m053027_c001_v7007000_t0000_u01762579827170") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f202687500d7fa9e5_d20251108_m053019_c001_v0001182_t0057_u01762579819287") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f402687500d7fa9e4_d20251108_m053018_c001_v7007000_t0000_u01762579818740") 2025/11/08 05:32:11 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f20108f13c6f90835_d20251108_m053014_c001_v0001178_t0051_u01762579814625") 2025/11/08 05:32:11 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e98560_d20251108_m053203_c001_v7007000_t0000_u01762579923924") 2025/11/08 05:32:11 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f205cd22c89222d2b_d20251108_m053147_c001_v0001038_t0052_u01762579907385") 2025/11/08 05:32:11 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f405cd22c89222d29_d20251108_m053146_c001_v7007000_t0000_u01762579906703") 2025/11/08 05:32:11 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f205cd22c89222d25_d20251108_m053140_c001_v0001146_t0015_u01762579900696") 2025/11/08 05:32:11 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f405cd22c89222d24_d20251108_m053140_c001_v7007000_t0000_u01762579900023") 2025/11/08 05:32:11 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e75_d20251108_m053134_c001_v0001044_t0024_u01762579894159") 2025/11/08 05:32:12 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f417e20652b708e74_d20251108_m053133_c001_v7007000_t0000_u01762579893505") 2025/11/08 05:32:12 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d68dd_d20251108_m053130_c001_v0001183_t0032_u01762579890320") 2025/11/08 05:32:12 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f417e20652b708e6f_d20251108_m053129_c001_v7007000_t0000_u01762579889924") 2025/11/08 05:32:12 DEBUG : chunked-copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d68bf_d20251108_m053126_c001_v0001183_t0036_u01762579886832") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e9855f_d20251108_m053203_c001_v7007000_t0000_u01762579923738") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e7f_d20251108_m053154_c001_v0001105_t0035_u01762579914632") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f405cd22c89222d28_d20251108_m053146_c001_v7007000_t0000_u01762579906519") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e7b_d20251108_m053144_c001_v0001099_t0027_u01762579904323") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f405cd22c89222d23_d20251108_m053139_c001_v7007000_t0000_u01762579899826") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e78_d20251108_m053138_c001_v0001145_t0027_u01762579898134") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f417e20652b708e73_d20251108_m053133_c001_v7007000_t0000_u01762579893311") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f217e20652b708e71_d20251108_m053131_c001_v0001180_t0029_u01762579891805") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f417e20652b708e6d_d20251108_m053129_c001_v7007000_t0000_u01762579889727") 2025/11/08 05:32:12 DEBUG : chunked-copy.copy: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f1007fc9e392d230e_d20251108_m053128_c001_v0001029_t0018_u01762579888744") 2025/11/08 05:32:12 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d5efe_d20251108_m052624_c001_v0001183_t0000_u01762579584816") 2025/11/08 05:32:12 DEBUG : unknown-size-put.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e98561_d20251108_m053204_c001_v7007000_t0000_u01762579924723") 2025/11/08 05:32:12 DEBUG : unknown-size-put.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6a06_d20251108_m053204_c001_v0001183_t0010_u01762579924468") 2025/11/08 05:32:12 DEBUG : unknown-size-update.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f407ae72636e98563_d20251108_m053205_c001_v7007000_t0000_u01762579925893") 2025/11/08 05:32:12 DEBUG : unknown-size-update.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6a14_d20251108_m053205_c001_v0001183_t0052_u01762579925638") 2025/11/08 05:32:13 DEBUG : unknown-size-update.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f10426c5b832d6a08_d20251108_m053204_c001_v0001183_t0018_u01762579924926") 2025/11/08 05:32:13 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf029d13e0dd6b1b9fa80e1b_f4103e53acd0addbe_d20251108_m052740_c001_v7007000_t0000_u01762579660275") 2025/11/08 05:32:14 INFO : B2 bucket rclone-test-piweqaq5xoko: cleaning bucket "rclone-test-piweqaq5xoko" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (386.03s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.57s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.39s) --- PASS: TestIntegration/FsMkdir (383.74s) --- 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 (23.30s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (5.43s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.98s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.12s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (6.47s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (81.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.19s) --- 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 (2.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (3.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (5.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.01s) --- 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.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.19s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.55s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.73s) --- 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.61s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (30.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (0.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (6.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (19.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (3.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject (0.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (4.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (3.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (3.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.56s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (220.93s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (27.91s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.49s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (4.12s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (9.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (9.12s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (49.82s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (31.37s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (26.79s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (8.95s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.68s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (9.50s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (41.11s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (9.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (4.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (13.42s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (18.44s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (6.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (30.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (9.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (9.76s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (4.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (11.00s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.15s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (35.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (13.12s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (8.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (11.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.59s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (11.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (35.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (9.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (4.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (11.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (14.52s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (6.14s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (37.87s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (3.87s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (3.61s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (6.52s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (6.68s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (17.19s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (1.98s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.82s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.17s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.29s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/b2 386.064s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 6m26.895497519s (try 1/5)