"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/12/09 03:10:17 DEBUG : Creating backend with remote "TestB2:rclone-test-qogulap3gixo" 2025/12/09 03:10:17 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/12/09 03:10:20 INFO : dir/subdir: Making directory fstest.go:250: Filtering empty directory "dir" fstest.go:250: Filtering empty directory "dir/subdir" 2025/12/09 03:10:20 INFO : dir/subdir: Removing directory fstest.go:250: Filtering empty directory "dir" 2025/12/09 03:10:20 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty === RUN TestIntegration/FsMkdir/FsListDirNotFound === RUN TestIntegration/FsMkdir/FsListRDirNotFound === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter 2025/12/09 03:10:44 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/12/09 03:10:44 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/12/09 03:10:46 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/12/09 03:10:46 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/12/09 03:10:47 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/12/09 03:10:47 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/12/09 03:10:47 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/12/09 03:10:47 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/12/09 03:10:54 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/12/09 03:10:55 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/12/09 03:11:00 INFO : B2 bucket rclone-test-qogulap3gixo: cleaning bucket "rclone-test-qogulap3gixo" of all files 2025/12/09 03:11:00 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6208_d20251209_m031059_c001_v0001185_t0026_u01765249859850") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/12/09 03:11:01 DEBUG : Creating backend with remote "TestB2:rclone-test-qogulap3gixo/dirToPurgeFromRoot" 2025/12/09 03:11:03 INFO : B2 bucket rclone-test-qogulap3gixo path dirToPurgeFromRoot: cleaning bucket "rclone-test-qogulap3gixo" of all files 2025/12/09 03:11:03 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6275_d20251209_m031101_c001_v0001185_t0009_u01765249861393") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/12/09 03:11:04 DEBUG : Creating backend with remote "TestB2:rclone-test-qogulap3gixo/hello? sausage/êé" 2025/12/09 03:11:08 INFO : B2 bucket rclone-test-qogulap3gixo path hello? sausage/êé: cleaning bucket "rclone-test-qogulap3gixo" of all files 2025/12/09 03:11:08 DEBUG : a/b/c/d/e.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1135e6675455cc5f_d20251209_m031106_c001_v0001102_t0017_u01765249866712") === 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/12/09 03:11:18 DEBUG : Creating backend with remote "TestB2:rclone-test-qogulap3gixo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/12/09 03:11:20 DEBUG : Creating backend with remote "TestB2:rclone-test-qogulap3gixo/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-qogulap3gixo" from "TestB2:rclone-test-qogulap3gixo" 2025/12/09 03:11:21 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/12/09 03:11:33 DEBUG : Creating backend with remote "TestB2:rclone-test-wofasat4zoha" 2025/12/09 03:11:36 DEBUG : B2 bucket rclone-test-wofasat4zoha: Purge remote 2025/12/09 03:11:36 INFO : B2 bucket rclone-test-wofasat4zoha: cleaning bucket "rclone-test-wofasat4zoha" of all files 2025/12/09 03:11:36 DEBUG : somefile: Deleting (id "4_z3f32cd93107d0b1b9fb80e1b_f408bd337af4a7188_d20251209_m031135_c001_v0001176_t0018_u01765249895780") === 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/12/09 03:11:38 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/12/09 03:11:39 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/12/09 03:11:42 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/12/09 03:11:42 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/12/09 03:11:42 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.867Ki offset 6Mi/6.106Mi 2025/12/09 03:11:42 DEBUG : test-metadata: Sending chunk 1 length 111480 2025/12/09 03:11:44 DEBUG : test-metadata: Done sending chunk 1 2025/12/09 03:11:44 DEBUG : test-metadata: Done sending chunk 0 2025/12/09 03:11:44 DEBUG : test-metadata: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions 2025/12/09 03:11:52 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_hide_file": EOF) 2025/12/09 03:11:52 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/12/09 03:11:52 DEBUG : pacer: Reducing sleep to 10ms 2025/12/09 03:11:54 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1185-06.backblaze.com/b2api/v1/b2_upload_file/ef02ad33106d0b1b9fb80e1b/c001_v0001185_t0032": EOF 2025/12/09 03:11:54 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1185-06.backblaze.com/b2api/v1/b2_upload_file/ef02ad33106d0b1b9fb80e1b/c001_v0001185_t0032": EOF) 2025/12/09 03:11:54 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1185-06.backblaze.com/b2api/v1/b2_upload_file/ef02ad33106d0b1b9fb80e1b/c001_v0001185_t0032": EOF - low level retry 1/10 2025/12/09 03:11:57 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent === NAME TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:357: versions/test-versions-v2025-12-09-031149-775.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/12/09 03:11:59 DEBUG : oldPath = "TestB2:rclone-test-qogulap3gixo/versions/test-versions-v2025-12-09-031149-775.txt" 2025/12/09 03:11:59 DEBUG : newPath = "TestB2,versions:rclone-test-qogulap3gixo/versions/test-versions-v2025-12-09-031149-775.txt" 2025/12/09 03:11:59 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-qogulap3gixo/versions/test-versions-v2025-12-09-031149-775.txt" 2025/12/09 03:11:59 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/12/09 03:12:00 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-qogulap3gixo/versions/test-versions-v2025-12-09-031149-775.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-qogulap3gixo/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/12/09 03:12:03 INFO : B2 bucket rclone-test-qogulap3gixo: cleaning bucket "rclone-test-qogulap3gixo" of all hidden files 2025/12/09 03:12:04 DEBUG : leading space/ leading space: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65f_d20251209_m031027_c001_v7007000_t0000_u01765249827756") as it is a hide marker 2025/12/09 03:12:04 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : leading space/ leading space: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5782_d20251209_m031026_c001_v0001185_t0056_u01765249826856") 2025/12/09 03:12:04 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65e_d20251209_m031026_c001_v7007000_t0000_u01765249826484") as it is a hide marker 2025/12/09 03:12:04 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5732_d20251209_m031025_c001_v0001185_t0033_u01765249825897") 2025/12/09 03:12:04 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f670_d20251209_m031033_c001_v7007000_t0000_u01765249833763") as it is a hide marker 2025/12/09 03:12:04 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : .leading dot/.leading dot: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5997_d20251209_m031033_c001_v0001185_t0032_u01765249833220") 2025/12/09 03:12:04 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : created from root.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f414adc52d14a15d4_d20251209_m031129_c001_v7007000_t0000_u01765249889819") as it is a hide marker 2025/12/09 03:12:04 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : created from root.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f112b26e4cd664392_d20251209_m031128_c001_v0001157_t0039_u01765249888473") 2025/12/09 03:12:04 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1df1_d20251209_m031138_c001_v7007000_t0000_u01765249898269") as it is a hide marker 2025/12/09 03:12:04 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6750_d20251209_m031117_c001_v0001185_t0001_u01765249877541") 2025/12/09 03:12:04 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f102516dd8beb394c_d20251209_m031113_c001_v0001036_t0032_u01765249873477") 2025/12/09 03:12:04 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f72_d20251209_m031051_c001_v0001185_t0030_u01765249851674") 2025/12/09 03:12:04 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f30_d20251209_m031050_c001_v0001185_t0058_u01765249850875") 2025/12/09 03:12:04 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f54_d20251209_m031051_c001_v0001185_t0029_u01765249851257") "upload" dated 2025-12-09 03:10:51.257 +0000 UTC (1m12.884244302s ago) 2025/12/09 03:12:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f4163e4d632a43eb0_d20251209_m031111_c001_v7007000_t0000_u01765249871247") as it is a hide marker 2025/12/09 03:12:04 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1108b7638eabd57a_d20251209_m031110_c001_v0001144_t0015_u01765249870669") 2025/12/09 03:12:04 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f106f3b249d5b0d88_d20251209_m031109_c001_v0001171_t0004_u01765249869928") 2025/12/09 03:12:04 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f682_d20251209_m031041_c001_v7007000_t0000_u01765249841518") as it is a hide marker 2025/12/09 03:12:04 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5c18_d20251209_m031040_c001_v0001185_t0008_u01765249840560") 2025/12/09 03:12:04 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : piped data.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1e0d_d20251209_m031140_c001_v7007000_t0000_u01765249900061") as it is a hide marker 2025/12/09 03:12:04 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : piped data.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6eac_d20251209_m031139_c001_v0001185_t0053_u01765249899664") 2025/12/09 03:12:04 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : piped data.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1e06_d20251209_m031139_c001_v7007000_t0000_u01765249899417") 2025/12/09 03:12:04 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : piped data.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4068ef01282a6e70_d20251209_m031139_c001_v0001185_t0032_u01765249899024") 2025/12/09 03:12:04 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f685_d20251209_m031042_c001_v7007000_t0000_u01765249842469") as it is a hide marker 2025/12/09 03:12:04 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5ca2_d20251209_m031041_c001_v0001185_t0026_u01765249841892") 2025/12/09 03:12:04 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : test-metadata: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f4002c7bf6c63c6d2_d20251209_m031147_c001_v7007000_t0000_u01765249907225") as it is a hide marker 2025/12/09 03:12:04 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : test-metadata: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1e14_d20251209_m031141_c001_v0001093_t0002_u01765249901931") 2025/12/09 03:12:04 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : test-metadata: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1e11_d20251209_m031141_c001_v7007000_t0000_u01765249901030") 2025/12/09 03:12:04 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : test-metadata: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6edd_d20251209_m031140_c001_v0001185_t0039_u01765249900250") 2025/12/09 03:12:04 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f676_d20251209_m031035_c001_v7007000_t0000_u01765249835787") as it is a hide marker 2025/12/09 03:12:04 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5a48_d20251209_m031035_c001_v0001185_t0009_u01765249835106") 2025/12/09 03:12:04 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f67b_d20251209_m031037_c001_v7007000_t0000_u01765249837861") as it is a hide marker 2025/12/09 03:12:04 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5af7_d20251209_m031037_c001_v0001185_t0033_u01765249837095") 2025/12/09 03:12:04 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f678_d20251209_m031036_c001_v7007000_t0000_u01765249836724") as it is a hide marker 2025/12/09 03:12:04 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5a9e_d20251209_m031036_c001_v0001185_t0053_u01765249836169") 2025/12/09 03:12:04 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f67e_d20251209_m031039_c001_v7007000_t0000_u01765249839010") as it is a hide marker 2025/12/09 03:12:04 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5b4f_d20251209_m031038_c001_v0001185_t0001_u01765249838409") 2025/12/09 03:12:04 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f680_d20251209_m031040_c001_v7007000_t0000_u01765249840142") as it is a hide marker 2025/12/09 03:12:04 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5ba2_d20251209_m031039_c001_v0001185_t0031_u01765249839383") 2025/12/09 03:12:04 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing space /trailing space : Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f674_d20251209_m031034_c001_v7007000_t0000_u01765249834694") as it is a hide marker 2025/12/09 03:12:04 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : trailing space /trailing space : Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a59f4_d20251209_m031034_c001_v0001185_t0042_u01765249834136") 2025/12/09 03:12:04 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a4d0c_d20251209_m031157_c001_v0001185_t0014_u01765249917579") "upload" dated 2025-12-09 03:11:57.579 +0000 UTC (6.562969048s ago) 2025/12/09 03:12:04 DEBUG : versions/test-versions.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4002c7bf6c63c6e0_d20251209_m031152_c001_v7007000_t0000_u01765249912776") 2025/12/09 03:12:04 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : versions/test-versions.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a7240_d20251209_m031149_c001_v0001185_t0044_u01765249909775") 2025/12/09 03:12:04 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f6a3_d20251209_m031050_c001_v7007000_t0000_u01765249850244") as it is a hide marker 2025/12/09 03:12:04 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f201ca9359780f692_d20251209_m031044_c001_v0001179_t0054_u01765249844634") 2025/12/09 03:12:04 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : zero-length-file: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f690_d20251209_m031044_c001_v7007000_t0000_u01765249844348") as it is a hide marker 2025/12/09 03:12:04 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : zero-length-file: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4068ef01282a5d31_d20251209_m031043_c001_v0001185_t0032_u01765249843784") 2025/12/09 03:12:04 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f662_d20251209_m031028_c001_v7007000_t0000_u01765249828748") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a57e6_d20251209_m031028_c001_v0001185_t0035_u01765249828129") 2025/12/09 03:12:04 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f656_d20251209_m031023_c001_v7007000_t0000_u01765249823338") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5628_d20251209_m031022_c001_v0001185_t0039_u01765249822362") 2025/12/09 03:12:04 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f66a_d20251209_m031031_c001_v7007000_t0000_u01765249831657") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a58df_d20251209_m031031_c001_v0001185_t0004_u01765249831062") 2025/12/09 03:12:04 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f666_d20251209_m031030_c001_v7007000_t0000_u01765249830680") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a587a_d20251209_m031030_c001_v0001185_t0041_u01765249830121") 2025/12/09 03:12:04 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f66d_d20251209_m031032_c001_v7007000_t0000_u01765249832841") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5939_d20251209_m031032_c001_v0001185_t0030_u01765249832029") 2025/12/09 03:12:04 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f665_d20251209_m031029_c001_v7007000_t0000_u01765249829749") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5833_d20251209_m031029_c001_v0001185_t0055_u01765249829120") 2025/12/09 03:12:04 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ./.: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65c_d20251209_m031024_c001_v7007000_t0000_u01765249824365") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ./.: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ./.: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5699_d20251209_m031023_c001_v0001185_t0006_u01765249823813") 2025/12/09 03:12:04 NOTICE: ./.: Skipped delete as --dry-run is set 2025/12/09 03:12:04 DEBUG : ../..: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65d_d20251209_m031025_c001_v7007000_t0000_u01765249825500") as it is a hide marker 2025/12/09 03:12:04 NOTICE: ../..: Skipped remove hide marker as --dry-run is set 2025/12/09 03:12:04 DEBUG : ../..: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a56ea_d20251209_m031024_c001_v0001185_t0040_u01765249824818") 2025/12/09 03:12:04 NOTICE: ../..: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/12/09 03:12:04 INFO : B2 bucket rclone-test-qogulap3gixo: cleaning bucket "rclone-test-qogulap3gixo" of all hidden files 2025/12/09 03:12:04 DEBUG : leading space/ leading space: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65f_d20251209_m031027_c001_v7007000_t0000_u01765249827756") as it is a hide marker 2025/12/09 03:12:04 DEBUG : leading space/ leading space: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5782_d20251209_m031026_c001_v0001185_t0056_u01765249826856") 2025/12/09 03:12:04 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65e_d20251209_m031026_c001_v7007000_t0000_u01765249826484") as it is a hide marker 2025/12/09 03:12:04 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5732_d20251209_m031025_c001_v0001185_t0033_u01765249825897") 2025/12/09 03:12:04 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f670_d20251209_m031033_c001_v7007000_t0000_u01765249833763") as it is a hide marker 2025/12/09 03:12:04 DEBUG : .leading dot/.leading dot: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5997_d20251209_m031033_c001_v0001185_t0032_u01765249833220") 2025/12/09 03:12:04 DEBUG : created from root.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f414adc52d14a15d4_d20251209_m031129_c001_v7007000_t0000_u01765249889819") as it is a hide marker 2025/12/09 03:12:04 DEBUG : created from root.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f112b26e4cd664392_d20251209_m031128_c001_v0001157_t0039_u01765249888473") 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1df1_d20251209_m031138_c001_v7007000_t0000_u01765249898269") as it is a hide marker 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6750_d20251209_m031117_c001_v0001185_t0001_u01765249877541") 2025/12/09 03:12:04 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f102516dd8beb394c_d20251209_m031113_c001_v0001036_t0032_u01765249873477") 2025/12/09 03:12:05 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f72_d20251209_m031051_c001_v0001185_t0030_u01765249851674") 2025/12/09 03:12:05 DEBUG : file name.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f30_d20251209_m031050_c001_v0001185_t0058_u01765249850875") 2025/12/09 03:12:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f54_d20251209_m031051_c001_v0001185_t0029_u01765249851257") "upload" dated 2025-12-09 03:10:51.257 +0000 UTC (1m13.917680665s ago) 2025/12/09 03:12:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f4163e4d632a43eb0_d20251209_m031111_c001_v7007000_t0000_u01765249871247") as it is a hide marker 2025/12/09 03:12:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1108b7638eabd57a_d20251209_m031110_c001_v0001144_t0015_u01765249870669") 2025/12/09 03:12:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f106f3b249d5b0d88_d20251209_m031109_c001_v0001171_t0004_u01765249869928") 2025/12/09 03:12:05 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f682_d20251209_m031041_c001_v7007000_t0000_u01765249841518") as it is a hide marker 2025/12/09 03:12:05 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5c18_d20251209_m031040_c001_v0001185_t0008_u01765249840560") 2025/12/09 03:12:05 DEBUG : piped data.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1e0d_d20251209_m031140_c001_v7007000_t0000_u01765249900061") as it is a hide marker 2025/12/09 03:12:05 DEBUG : piped data.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6eac_d20251209_m031139_c001_v0001185_t0053_u01765249899664") 2025/12/09 03:12:05 DEBUG : piped data.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1e06_d20251209_m031139_c001_v7007000_t0000_u01765249899417") 2025/12/09 03:12:05 DEBUG : piped data.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4068ef01282a6e70_d20251209_m031139_c001_v0001185_t0032_u01765249899024") 2025/12/09 03:12:05 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f685_d20251209_m031042_c001_v7007000_t0000_u01765249842469") as it is a hide marker 2025/12/09 03:12:05 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5ca2_d20251209_m031041_c001_v0001185_t0026_u01765249841892") 2025/12/09 03:12:05 DEBUG : test-metadata: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f4002c7bf6c63c6d2_d20251209_m031147_c001_v7007000_t0000_u01765249907225") as it is a hide marker 2025/12/09 03:12:05 DEBUG : test-metadata: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1e14_d20251209_m031141_c001_v0001093_t0002_u01765249901931") 2025/12/09 03:12:05 DEBUG : test-metadata: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1e11_d20251209_m031141_c001_v7007000_t0000_u01765249901030") 2025/12/09 03:12:05 DEBUG : test-metadata: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a6edd_d20251209_m031140_c001_v0001185_t0039_u01765249900250") 2025/12/09 03:12:05 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f676_d20251209_m031035_c001_v7007000_t0000_u01765249835787") as it is a hide marker 2025/12/09 03:12:05 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5a48_d20251209_m031035_c001_v0001185_t0009_u01765249835106") 2025/12/09 03:12:06 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f67b_d20251209_m031037_c001_v7007000_t0000_u01765249837861") as it is a hide marker 2025/12/09 03:12:06 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5af7_d20251209_m031037_c001_v0001185_t0033_u01765249837095") 2025/12/09 03:12:06 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f678_d20251209_m031036_c001_v7007000_t0000_u01765249836724") as it is a hide marker 2025/12/09 03:12:06 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5a9e_d20251209_m031036_c001_v0001185_t0053_u01765249836169") 2025/12/09 03:12:06 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f67e_d20251209_m031039_c001_v7007000_t0000_u01765249839010") as it is a hide marker 2025/12/09 03:12:06 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5b4f_d20251209_m031038_c001_v0001185_t0001_u01765249838409") 2025/12/09 03:12:06 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f680_d20251209_m031040_c001_v7007000_t0000_u01765249840142") as it is a hide marker 2025/12/09 03:12:06 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5ba2_d20251209_m031039_c001_v0001185_t0031_u01765249839383") 2025/12/09 03:12:06 DEBUG : trailing space /trailing space : Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f674_d20251209_m031034_c001_v7007000_t0000_u01765249834694") as it is a hide marker 2025/12/09 03:12:06 DEBUG : trailing space /trailing space : Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a59f4_d20251209_m031034_c001_v0001185_t0042_u01765249834136") 2025/12/09 03:12:06 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a4d0c_d20251209_m031157_c001_v0001185_t0014_u01765249917579") "upload" dated 2025-12-09 03:11:57.579 +0000 UTC (9.016717938s ago) 2025/12/09 03:12:06 DEBUG : versions/test-versions.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4002c7bf6c63c6e0_d20251209_m031152_c001_v7007000_t0000_u01765249912776") 2025/12/09 03:12:06 DEBUG : versions/test-versions.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a7240_d20251209_m031149_c001_v0001185_t0044_u01765249909775") 2025/12/09 03:12:06 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f6a3_d20251209_m031050_c001_v7007000_t0000_u01765249850244") as it is a hide marker 2025/12/09 03:12:06 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f201ca9359780f692_d20251209_m031044_c001_v0001179_t0054_u01765249844634") 2025/12/09 03:12:06 DEBUG : zero-length-file: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f690_d20251209_m031044_c001_v7007000_t0000_u01765249844348") as it is a hide marker 2025/12/09 03:12:06 DEBUG : zero-length-file: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4068ef01282a5d31_d20251209_m031043_c001_v0001185_t0032_u01765249843784") 2025/12/09 03:12:06 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f662_d20251209_m031028_c001_v7007000_t0000_u01765249828748") as it is a hide marker 2025/12/09 03:12:06 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a57e6_d20251209_m031028_c001_v0001185_t0035_u01765249828129") 2025/12/09 03:12:06 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f656_d20251209_m031023_c001_v7007000_t0000_u01765249823338") as it is a hide marker 2025/12/09 03:12:07 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5628_d20251209_m031022_c001_v0001185_t0039_u01765249822362") 2025/12/09 03:12:07 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f66a_d20251209_m031031_c001_v7007000_t0000_u01765249831657") as it is a hide marker 2025/12/09 03:12:07 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a58df_d20251209_m031031_c001_v0001185_t0004_u01765249831062") 2025/12/09 03:12:07 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f666_d20251209_m031030_c001_v7007000_t0000_u01765249830680") as it is a hide marker 2025/12/09 03:12:07 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a587a_d20251209_m031030_c001_v0001185_t0041_u01765249830121") 2025/12/09 03:12:07 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f66d_d20251209_m031032_c001_v7007000_t0000_u01765249832841") as it is a hide marker 2025/12/09 03:12:07 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5939_d20251209_m031032_c001_v0001185_t0030_u01765249832029") 2025/12/09 03:12:07 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f665_d20251209_m031029_c001_v7007000_t0000_u01765249829749") as it is a hide marker 2025/12/09 03:12:07 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5833_d20251209_m031029_c001_v0001185_t0055_u01765249829120") 2025/12/09 03:12:07 DEBUG : ./.: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65c_d20251209_m031024_c001_v7007000_t0000_u01765249824365") as it is a hide marker 2025/12/09 03:12:07 DEBUG : ./.: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5699_d20251209_m031023_c001_v0001185_t0006_u01765249823813") 2025/12/09 03:12:07 DEBUG : ../..: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f401ca9359780f65d_d20251209_m031025_c001_v7007000_t0000_u01765249825500") as it is a hide marker 2025/12/09 03:12:07 DEBUG : ../..: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a56ea_d20251209_m031024_c001_v0001185_t0040_u01765249824818") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/12/09 03:12:08 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/12/09 03:12:08 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/12/09 03:12:08 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/12/09 03:12:08 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/12/09 03:12:09 INFO : B2 bucket rclone-test-qogulap3gixo: cleaning bucket "rclone-test-qogulap3gixo" of pending multipart uploads older than 0s 2025/12/09 03:12:09 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f54_d20251209_m031051_c001_v0001185_t0029_u01765249851257") "upload" dated 2025-12-09 03:10:51.257 +0000 UTC (1m18.271364121s ago) 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1ed8_d20251209_m031208_c001_v0001185_t0051_u01765249928483") as it is a start marker (upload started at 2025-12-09 03:12:08.483 +0000 UTC) 2025/12/09 03:12:09 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1ed9_d20251209_m031208_c001_v0001181_t0021_u01765249928665") as it is a start marker (upload started at 2025-12-09 03:12:08.665 +0000 UTC) 2025/12/09 03:12:09 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1eda_d20251209_m031208_c001_v0001185_t0027_u01765249928848") as it is a start marker (upload started at 2025-12-09 03:12:08.848 +0000 UTC) 2025/12/09 03:12:09 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1edb_d20251209_m031209_c001_v0001036_t0007_u01765249929030") as it is a start marker (upload started at 2025-12-09 03:12:09.03 +0000 UTC) 2025/12/09 03:12:09 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/12/09 03:12:09 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1ed7_d20251209_m031208_c001_v7007000_t0000_u01765249928302") "hide" dated 2025-12-09 03:12:08.302 +0000 UTC (1.226638126s ago) 2025/12/09 03:12:09 DEBUG : versions/test-versions.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a4d0c_d20251209_m031157_c001_v0001185_t0014_u01765249917579") 2025/12/09 03:12:09 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/12/09 03:12:09 INFO : B2 bucket rclone-test-qogulap3gixo: cleaning bucket "rclone-test-qogulap3gixo" of pending multipart uploads older than 0s 2025/12/09 03:12:09 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f54_d20251209_m031051_c001_v0001185_t0029_u01765249851257") "upload" dated 2025-12-09 03:10:51.257 +0000 UTC (1m18.636654889s ago) 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1ed8_d20251209_m031208_c001_v0001185_t0051_u01765249928483") as it is a start marker (upload started at 2025-12-09 03:12:08.483 +0000 UTC) 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1ed9_d20251209_m031208_c001_v0001181_t0021_u01765249928665") as it is a start marker (upload started at 2025-12-09 03:12:08.665 +0000 UTC) 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1eda_d20251209_m031208_c001_v0001185_t0027_u01765249928848") as it is a start marker (upload started at 2025-12-09 03:12:08.848 +0000 UTC) 2025/12/09 03:12:09 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1edb_d20251209_m031209_c001_v0001036_t0007_u01765249929030") as it is a start marker (upload started at 2025-12-09 03:12:09.03 +0000 UTC) 2025/12/09 03:12:09 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1ed7_d20251209_m031208_c001_v7007000_t0000_u01765249928302") "hide" dated 2025-12-09 03:12:08.302 +0000 UTC (1.591782119s ago) 2025/12/09 03:12:09 DEBUG : versions/test-versions.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a4d0c_d20251209_m031157_c001_v0001185_t0014_u01765249917579") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/12/09 03:12:10 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/12/09 03:12:10 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/12/09 03:12:11 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/12/09 03:12:12 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/12/09 03:12:12 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/12/09 03:12:12 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/12/09 03:12:12 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/12/09 03:12:13 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/12/09 03:12:14 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/12/09 03:12:14 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/12/09 03:12:17 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:12:17 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/12/09 03:12:17 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f22149530a4cf0464_d20251209_m031217_c001_v0001177_t0027_u01765249937618") 2025/12/09 03:12:17 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:12:17 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/12/09 03:12:17 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/12/09 03:12:18 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:12:19 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:12:19 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/12/09 03:12:21 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/12/09 03:12:21 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/12/09 03:12:21 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/12/09 03:12:21 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/12/09 03:12:23 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/12/09 03:12:23 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/12/09 03:12:23 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/12/09 03:12:25 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:12:25 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/12/09 03:12:25 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f22149530a4cf046a_d20251209_m031225_c001_v0001165_t0040_u01765249945629") 2025/12/09 03:12:25 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/12/09 03:12:25 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/12/09 03:12:25 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/12/09 03:12:28 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:12:28 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:12:28 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/12/09 03:12:29 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/12/09 03:12:29 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/12/09 03:12:30 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/12/09 03:12:30 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/12/09 03:12:30 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/12/09 03:12:30 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/12/09 03:12:30 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/12/09 03:12:32 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/12/09 03:12:32 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/12/09 03:12:32 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/12/09 03:12:33 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:12:33 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/12/09 03:12:34 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb23e_d20251209_m031234_c001_v0001153_t0005_u01765249954063") 2025/12/09 03:12:34 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/12/09 03:12:34 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:12:34 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/12/09 03:12:34 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/12/09 03:12:35 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/12/09 03:12:36 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:12:36 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:12:36 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/12/09 03:12:38 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/12/09 03:12:38 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/12/09 03:12:38 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/12/09 03:12:38 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/12/09 03:12:39 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/12/09 03:12:41 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/12/09 03:12:41 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/12/09 03:12:42 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:12:42 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/12/09 03:12:42 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb245_d20251209_m031242_c001_v0001171_t0037_u01765249962415") 2025/12/09 03:12:42 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:12:42 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/12/09 03:12:42 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/12/09 03:12:43 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:12:44 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:12:44 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/12/09 03:12:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/12/09 03:12:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/12/09 03:12:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/12/09 03:12:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/12/09 03:12:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/12/09 03:12:49 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/12/09 03:12:49 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/12/09 03:12:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:12:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/12/09 03:12:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb249_d20251209_m031250_c001_v0001185_t0051_u01765249970985") 2025/12/09 03:12:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/12/09 03:12:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/12/09 03:12:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/12/09 03:12:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:12:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:12:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/12/09 03:12:55 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/12/09 03:12:55 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/12/09 03:12:55 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/12/09 03:12:55 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/12/09 03:12:55 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/12/09 03:12:55 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/12/09 03:12:56 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/12/09 03:12:57 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/12/09 03:12:58 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/12/09 03:12:58 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/12/09 03:13:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:13:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/12/09 03:13:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb25f_d20251209_m031300_c001_v0001178_t0011_u01765249980413") 2025/12/09 03:13:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/12/09 03:13:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:13:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/12/09 03:13:00 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/12/09 03:13:00 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/12/09 03:13:00 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/12/09 03:13:00 DEBUG : pacer: Reducing sleep to 10ms 2025/12/09 03:13:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/12/09 03:13:02 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:13:02 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:13:02 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/12/09 03:13:04 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/12/09 03:13:04 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/12/09 03:13:04 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/12/09 03:13:04 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/12/09 03:13:05 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/12/09 03:13:07 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/12/09 03:13:07 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/12/09 03:13:08 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:13:08 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/12/09 03:13:08 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb26b_d20251209_m031308_c001_v0001185_t0038_u01765249988604") 2025/12/09 03:13:08 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:13:08 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/12/09 03:13:08 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/12/09 03:13:09 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:13:11 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:13:11 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/12/09 03:13:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/12/09 03:13:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/12/09 03:13:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/12/09 03:13:12 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/12/09 03:13:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/12/09 03:13:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/12/09 03:13:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/12/09 03:13:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:13:17 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/12/09 03:13:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb283_d20251209_m031317_c001_v0001116_t0004_u01765249997353") 2025/12/09 03:13:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/12/09 03:13:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/12/09 03:13:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/12/09 03:13:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:13:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:13:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/12/09 03:13:22 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/12/09 03:13:22 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/12/09 03:13:22 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/12/09 03:13:22 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/12/09 03:13:22 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/12/09 03:13:22 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/12/09 03:13:23 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/12/09 03:13:24 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/12/09 03:13:24 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/12/09 03:13:24 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/12/09 03:13:26 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:13:26 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/12/09 03:13:26 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb293_d20251209_m031326_c001_v0001041_t0059_u01765250006166") 2025/12/09 03:13:26 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/12/09 03:13:26 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/12/09 03:13:26 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:13:26 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/12/09 03:13:27 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/12/09 03:13:28 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:13:28 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:13:28 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/12/09 03:13:30 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/12/09 03:13:30 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/12/09 03:13:30 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/12/09 03:13:30 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/12/09 03:13:31 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/12/09 03:13:39 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/12/09 03:13:39 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/12/09 03:13:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:13:42 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/12/09 03:13:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f213251a2443a129b_d20251209_m031342_c001_v0001185_t0035_u01765250022841") 2025/12/09 03:13:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:13:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/12/09 03:13:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/12/09 03:13:43 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:13:45 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:13:45 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/12/09 03:13:47 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/12/09 03:13:47 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/12/09 03:13:47 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/12/09 03:13:47 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/12/09 03:13:49 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/12/09 03:13:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/12/09 03:13:50 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/12/09 03:13:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:13:51 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/12/09 03:13:52 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2029f09e09914696_d20251209_m031352_c001_v0001101_t0024_u01765250032002") 2025/12/09 03:13:52 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/12/09 03:13:52 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/12/09 03:13:52 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/12/09 03:13:54 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:13:54 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:13:54 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/12/09 03:13:56 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/12/09 03:13:56 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc001243860), retryAfter:1000000000} 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/12/09 03:13:57 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/12/09 03:13:57 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00011eed0), retryAfter:1000000000} 2025/12/09 03:13:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/12/09 03:13:57 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/12/09 03:13:58 DEBUG : chunked-6.667Mi-13.333Mi.bin: Error sending chunk 2 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc001243a40), retryAfter:1000000000} 2025/12/09 03:13:58 DEBUG : chunked-6.667Mi-13.333Mi.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/12/09 03:13:58 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/12/09 03:13:58 DEBUG : pacer: Reducing sleep to 500ms 2025/12/09 03:13:59 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/12/09 03:14:00 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/12/09 03:14:00 DEBUG : pacer: Reducing sleep to 250ms 2025/12/09 03:14:01 DEBUG : pacer: Reducing sleep to 125ms 2025/12/09 03:14:01 DEBUG : pacer: Reducing sleep to 62.5ms 2025/12/09 03:14:01 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/12/09 03:14:02 DEBUG : pacer: Reducing sleep to 31.25ms 2025/12/09 03:14:02 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/12/09 03:14:03 DEBUG : pacer: Reducing sleep to 15.625ms 2025/12/09 03:14:03 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/12/09 03:14:03 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts 2025/12/09 03:14:03 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/12/09 03:14:06 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:14:06 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/12/09 03:14:06 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f219e0d9df10e9822_d20251209_m031406_c001_v0001185_t0012_u01765250046740") 2025/12/09 03:14:06 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/12/09 03:14:07 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:14:07 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/12/09 03:14:07 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/12/09 03:14:07 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/12/09 03:14:09 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:14:09 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:14:09 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/12/09 03:14:12 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/12/09 03:14:12 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/12/09 03:14:12 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/12/09 03:14:12 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/12/09 03:14:13 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/12/09 03:14:15 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/12/09 03:14:15 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/12/09 03:14:16 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:14:16 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/12/09 03:14:16 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f219e0d9df10e9827_d20251209_m031416_c001_v0001185_t0024_u01765250056791") 2025/12/09 03:14:16 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:14:16 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/12/09 03:14:16 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/12/09 03:14:17 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:14:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:14:19 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/12/09 03:14:21 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/12/09 03:14:21 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/12/09 03:14:21 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/12/09 03:14:21 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/12/09 03:14:23 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/12/09 03:14:24 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/12/09 03:14:24 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/12/09 03:14:26 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:14:26 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/12/09 03:14:26 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb2d4_d20251209_m031426_c001_v0001105_t0057_u01765250066377") 2025/12/09 03:14:26 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/12/09 03:14:26 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/12/09 03:14:26 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/12/09 03:14:29 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:14:29 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:14:29 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/12/09 03:14:31 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/12/09 03:14:31 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/12/09 03:14:32 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/12/09 03:14:32 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/12/09 03:14:32 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/12/09 03:14:32 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/12/09 03:14:33 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/12/09 03:14:34 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/12/09 03:14:34 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/12/09 03:14:34 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/12/09 03:14:36 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:14:36 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/12/09 03:14:36 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb2e9_d20251209_m031436_c001_v0001104_t0035_u01765250076747") 2025/12/09 03:14:36 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/12/09 03:14:37 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:14:37 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/12/09 03:14:37 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/12/09 03:14:38 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/12/09 03:14:39 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:14:40 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:14:40 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/12/09 03:14:42 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/12/09 03:14:42 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/12/09 03:14:42 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/12/09 03:14:42 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/12/09 03:14:43 DEBUG : chunked-10Mi-10.000Mi.bin: Error sending chunk 0 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00033f890), retryAfter:1000000000} 2025/12/09 03:14:43 DEBUG : chunked-10Mi-10.000Mi.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/12/09 03:14:43 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/12/09 03:14:43 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/12/09 03:14:43 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/12/09 03:14:43 DEBUG : chunked-10Mi-10.000Mi.bin: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000315140), retryAfter:1000000000} 2025/12/09 03:14:43 DEBUG : chunked-10Mi-10.000Mi.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/12/09 03:14:43 DEBUG : pacer: low level retry 1/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/12/09 03:14:44 DEBUG : pacer: Reducing sleep to 500ms 2025/12/09 03:14:45 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/12/09 03:14:46 DEBUG : pacer: Reducing sleep to 250ms 2025/12/09 03:14:46 DEBUG : chunked-10Mi-10.000Mi.bin: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0000a4b70), retryAfter:1000000000} 2025/12/09 03:14:46 DEBUG : chunked-10Mi-10.000Mi.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/12/09 03:14:46 DEBUG : pacer: low level retry 2/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/12/09 03:14:46 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/12/09 03:14:46 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/12/09 03:14:47 DEBUG : pacer: Reducing sleep to 500ms 2025/12/09 03:14:47 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/12/09 03:14:47 DEBUG : pacer: Reducing sleep to 250ms 2025/12/09 03:14:48 DEBUG : chunked-10Mi-10.000Mi.bin: Error sending chunk 1 (retry=true): CPU too busy (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00033c4b0), retryAfter:1000000000} 2025/12/09 03:14:48 DEBUG : chunked-10Mi-10.000Mi.bin: Clearing part upload URL because of error: CPU too busy (503 service_unavailable): trying again in 1s 2025/12/09 03:14:48 DEBUG : pacer: low level retry 3/10 (error CPU too busy (503 service_unavailable): trying again in 1s) 2025/12/09 03:14:48 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/12/09 03:14:48 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/12/09 03:14:48 DEBUG : pacer: Reducing sleep to 500ms 2025/12/09 03:14:48 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/12/09 03:14:48 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts 2025/12/09 03:14:49 DEBUG : pacer: Reducing sleep to 250ms 2025/12/09 03:14:50 DEBUG : pacer: Reducing sleep to 125ms 2025/12/09 03:14:50 DEBUG : pacer: Reducing sleep to 62.5ms 2025/12/09 03:14:52 DEBUG : pacer: Reducing sleep to 31.25ms === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/12/09 03:14:52 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:14:52 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/12/09 03:14:52 DEBUG : pacer: Reducing sleep to 15.625ms 2025/12/09 03:14:52 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f211d6bcae61c2afe_d20251209_m031452_c001_v0001172_t0025_u01765250092843") 2025/12/09 03:14:52 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:14:52 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/12/09 03:14:52 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/12/09 03:14:53 DEBUG : pacer: Reducing sleep to 10ms 2025/12/09 03:14:53 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:14:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:14:55 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/12/09 03:14:57 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/12/09 03:14:57 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/12/09 03:14:58 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/12/09 03:14:58 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/12/09 03:15:00 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/12/09 03:15:01 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/12/09 03:15:01 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/12/09 03:15:03 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:15:03 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/12/09 03:15:03 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f210b51fce7cec0a6_d20251209_m031503_c001_v0001165_t0053_u01765250103668") 2025/12/09 03:15:03 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/12/09 03:15:04 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/12/09 03:15:04 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/12/09 03:15:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:15:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:15:06 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/12/09 03:15:09 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/12/09 03:15:09 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/12/09 03:15:09 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/12/09 03:15:09 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/12/09 03:15:09 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/12/09 03:15:09 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/12/09 03:15:10 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/12/09 03:15:11 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/12/09 03:15:12 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/12/09 03:15:12 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/12/09 03:15:14 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/12/09 03:15:14 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/12/09 03:15:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_zef02ad33106d0b1b9fb80e1b_f214adc52d14a1708_d20251209_m031515_c001_v0001137_t0000_u01765250115076") 2025/12/09 03:15:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/12/09 03:15:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/12/09 03:15:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/12/09 03:15:15 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/12/09 03:15:16 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/12/09 03:15:17 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/12/09 03:15:18 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/12/09 03:15:18 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/12/09 03:15:26 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zef02ad33106d0b1b9fb80e1b_f223f0114e4030f7a_d20251209_m031526_c001_v0001177_t0000_u01765250126292") 2025/12/09 03:15:26 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/12/09 03:15:26 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/12/09 03:15:26 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/12/09 03:15:27 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/12/09 03:15:27 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/12/09 03:15:28 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/12/09 03:15:28 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/12/09 03:15:29 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/12/09 03:15:29 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/12/09 03:15:31 DEBUG : chunked-copy: Done sending chunk 1 2025/12/09 03:15:31 DEBUG : chunked-copy: Done sending chunk 0 2025/12/09 03:15:31 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/12/09 03:15:32 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zef02ad33106d0b1b9fb80e1b_f2185d126b5ccdfac_d20251209_m031532_c001_v0001185_t0009_u01765250132221") 2025/12/09 03:15:32 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/12/09 03:15:32 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/12/09 03:15:32 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/12/09 03:15:32 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/12/09 03:15:32 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/12/09 03:15:34 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/12/09 03:15:34 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/12/09 03:15:35 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/12/09 03:15:35 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/12/09 03:15:37 DEBUG : chunked-copy: Done sending chunk 0 2025/12/09 03:15:37 DEBUG : chunked-copy: Done sending chunk 1 2025/12/09 03:15:37 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/12/09 03:15:38 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zef02ad33106d0b1b9fb80e1b_f223f0114e4030fbe_d20251209_m031537_c001_v0001146_t0029_u01765250137997") 2025/12/09 03:15:38 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/12/09 03:15:38 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/12/09 03:15:38 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/12/09 03:15:38 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/12/09 03:15:38 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/12/09 03:15:41 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/12/09 03:15:41 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/12/09 03:15:41 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/12/09 03:15:41 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/12/09 03:15:43 DEBUG : chunked-copy: Done sending chunk 0 2025/12/09 03:15:43 DEBUG : chunked-copy: Done sending chunk 1 2025/12/09 03:15:43 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/12/09 03:15:44 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_zef02ad33106d0b1b9fb80e1b_f223f0114e4030fc3_d20251209_m031544_c001_v0001102_t0049_u01765250144097") 2025/12/09 03:15:44 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/12/09 03:15:44 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/12/09 03:15:44 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/12/09 03:15:44 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/12/09 03:15:44 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/12/09 03:15:45 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/12/09 03:15:45 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/12/09 03:15:46 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/12/09 03:15:48 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/12/09 03:15:48 DEBUG : Creating backend with remote "TestB2:rclone-test-qogulap3gixo/deeper/nonexisting/directory" 2025/12/09 03:15:48 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/12/09 03:15:50 INFO : B2 bucket rclone-test-qogulap3gixo: cleaning bucket "rclone-test-qogulap3gixo" of all files 2025/12/09 03:15:50 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f410b51fce7cec09d_d20251209_m031457_c001_v7007000_t0000_u01765250097157") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f211d6bcae61c2afe_d20251209_m031452_c001_v0001172_t0025_u01765250092843") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f411d6bcae61c2af8_d20251209_m031452_c001_v7007000_t0000_u01765250092253") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f21795ddcf21236a2_d20251209_m031441_c001_v0001165_t0032_u01765250081927") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f423f0114e4030f53_d20251209_m031520_c001_v7007000_t0000_u01765250120483") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f214adc52d14a1708_d20251209_m031515_c001_v0001137_t0000_u01765250115076") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f414adc52d14a1702_d20251209_m031514_c001_v7007000_t0000_u01765250114539") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f210b51fce7cec0ac_d20251209_m031508_c001_v0001185_t0044_u01765250108881") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f410b51fce7cec0ab_d20251209_m031508_c001_v7007000_t0000_u01765250108660") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f210b51fce7cec0a6_d20251209_m031503_c001_v0001165_t0053_u01765250103668") 2025/12/09 03:15:50 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f410b51fce7cec0a4_d20251209_m031503_c001_v7007000_t0000_u01765250103118") 2025/12/09 03:15:51 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f210b51fce7cec09e_d20251209_m031457_c001_v0001038_t0007_u01765250097340") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4002c7bf6c63c776_d20251209_m031304_c001_v7007000_t0000_u01765249984235") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb25f_d20251209_m031300_c001_v0001178_t0011_u01765249980413") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb24c_d20251209_m031254_c001_v7007000_t0000_u01765249974934") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb249_d20251209_m031250_c001_v0001185_t0051_u01765249970985") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb25d_d20251209_m031300_c001_v7007000_t0000_u01765249980052") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb24d_d20251209_m031255_c001_v0001109_t0034_u01765249975118") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb248_d20251209_m031250_c001_v7007000_t0000_u01765249970602") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f22149530a4cf0481_d20251209_m031246_c001_v0001093_t0003_u01765249966124") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f42149530a4cf0480_d20251209_m031245_c001_v7007000_t0000_u01765249965942") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb245_d20251209_m031242_c001_v0001171_t0037_u01765249962415") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb242_d20251209_m031242_c001_v7007000_t0000_u01765249962033") 2025/12/09 03:15:51 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f22149530a4cf0477_d20251209_m031238_c001_v0001092_t0049_u01765249958351") 2025/12/09 03:15:51 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4182380f6e32b4b6_d20251209_m031330_c001_v7007000_t0000_u01765250010273") 2025/12/09 03:15:51 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb293_d20251209_m031326_c001_v0001041_t0059_u01765250006166") 2025/12/09 03:15:51 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb28c_d20251209_m031321_c001_v7007000_t0000_u01765250001585") 2025/12/09 03:15:51 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb283_d20251209_m031317_c001_v0001116_t0004_u01765249997353") 2025/12/09 03:15:51 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb292_d20251209_m031325_c001_v7007000_t0000_u01765250005779") 2025/12/09 03:15:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb28d_d20251209_m031321_c001_v0001185_t0044_u01765250001776") 2025/12/09 03:15:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb281_d20251209_m031316_c001_v7007000_t0000_u01765249996945") 2025/12/09 03:15:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2002c7bf6c63c783_d20251209_m031312_c001_v0001102_t0000_u01765249992292") 2025/12/09 03:15:52 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4002c7bf6c63c782_d20251209_m031312_c001_v7007000_t0000_u01765249992111") 2025/12/09 03:15:52 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb26b_d20251209_m031308_c001_v0001185_t0038_u01765249988604") 2025/12/09 03:15:52 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb26a_d20251209_m031308_c001_v7007000_t0000_u01765249988218") 2025/12/09 03:15:52 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2002c7bf6c63c777_d20251209_m031304_c001_v0001101_t0055_u01765249984417") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f42149530a4cf0476_d20251209_m031238_c001_v7007000_t0000_u01765249958109") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb23e_d20251209_m031234_c001_v0001153_t0005_u01765249954063") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb23d_d20251209_m031233_c001_v7007000_t0000_u01765249953657") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f22149530a4cf046e_d20251209_m031229_c001_v0001185_t0005_u01765249949528") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f42149530a4cf046d_d20251209_m031229_c001_v7007000_t0000_u01765249949346") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f22149530a4cf046a_d20251209_m031225_c001_v0001165_t0040_u01765249945629") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f42149530a4cf0469_d20251209_m031225_c001_v7007000_t0000_u01765249945245") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb214_d20251209_m031221_c001_v0001185_t0033_u01765249941099") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb212_d20251209_m031220_c001_v7007000_t0000_u01765249940919") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f22149530a4cf0464_d20251209_m031217_c001_v0001177_t0027_u01765249937618") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f42149530a4cf0462_d20251209_m031217_c001_v7007000_t0000_u01765249937222") 2025/12/09 03:15:52 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f20388797d1ab1edf_d20251209_m031211_c001_v0001134_t0013_u01765249931982") 2025/12/09 03:15:52 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb2af_d20251209_m031411_c001_v7007000_t0000_u01765250051388") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f219e0d9df10e9822_d20251209_m031406_c001_v0001185_t0012_u01765250046740") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4029f09e0991469b_d20251209_m031356_c001_v7007000_t0000_u01765250036373") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2029f09e09914696_d20251209_m031352_c001_v0001101_t0024_u01765250032002") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f419e0d9df10e9821_d20251209_m031406_c001_v7007000_t0000_u01765250046294") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2029f09e0991469c_d20251209_m031356_c001_v0001165_t0048_u01765250036554") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4029f09e09914695_d20251209_m031351_c001_v7007000_t0000_u01765250031574") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2029f09e09914690_d20251209_m031346_c001_v0001042_t0049_u01765250026786") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4029f09e0991468f_d20251209_m031346_c001_v7007000_t0000_u01765250026603") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f213251a2443a129b_d20251209_m031342_c001_v0001185_t0035_u01765250022841") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f413251a2443a129a_d20251209_m031342_c001_v7007000_t0000_u01765250022402") 2025/12/09 03:15:53 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2182380f6e32b4b7_d20251209_m031330_c001_v0001184_t0052_u01765250010456") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f41795ddcf21236a1_d20251209_m031441_c001_v7007000_t0000_u01765250081737") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb2e9_d20251209_m031436_c001_v0001104_t0035_u01765250076747") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb2e8_d20251209_m031436_c001_v7007000_t0000_u01765250076266") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb2e6_d20251209_m031431_c001_v0001101_t0007_u01765250071364") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb2e5_d20251209_m031431_c001_v7007000_t0000_u01765250071180") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb2d4_d20251209_m031426_c001_v0001105_t0057_u01765250066377") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb2d3_d20251209_m031425_c001_v7007000_t0000_u01765250065867") 2025/12/09 03:15:53 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb2c1_d20251209_m031420_c001_v0001185_t0022_u01765250060764") 2025/12/09 03:15:54 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4153395f9facb2c0_d20251209_m031420_c001_v7007000_t0000_u01765250060552") 2025/12/09 03:15:54 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f219e0d9df10e9827_d20251209_m031416_c001_v0001185_t0024_u01765250056791") 2025/12/09 03:15:54 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f419e0d9df10e9826_d20251209_m031416_c001_v7007000_t0000_u01765250056308") 2025/12/09 03:15:54 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2153395f9facb2b1_d20251209_m031411_c001_v0001038_t0008_u01765250051710") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f41765bd29f844a91_d20251209_m031546_c001_v7007000_t0000_u01765250146531") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2185d126b5ccdfcd_d20251209_m031540_c001_v0001171_t0029_u01765250140654") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4185d126b5ccdfcb_d20251209_m031540_c001_v7007000_t0000_u01765250140107") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2185d126b5ccdfc0_d20251209_m031534_c001_v0001181_t0032_u01765250134629") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4185d126b5ccdfbb_d20251209_m031534_c001_v7007000_t0000_u01765250134065") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f223f0114e4030f8d_d20251209_m031528_c001_v0001116_t0010_u01765250128631") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f423f0114e4030f87_d20251209_m031528_c001_v7007000_t0000_u01765250128063") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a8df9_d20251209_m031524_c001_v0001185_t0015_u01765250124619") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f423f0114e4030f6b_d20251209_m031524_c001_v7007000_t0000_u01765250124243") 2025/12/09 03:15:54 DEBUG : chunked-copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a8caa_d20251209_m031521_c001_v0001185_t0059_u01765250121221") 2025/12/09 03:15:54 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f41765bd29f844a8e_d20251209_m031546_c001_v7007000_t0000_u01765250146349") 2025/12/09 03:15:54 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f223f0114e4030fc3_d20251209_m031544_c001_v0001102_t0049_u01765250144097") 2025/12/09 03:15:54 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4185d126b5ccdfc9_d20251209_m031539_c001_v7007000_t0000_u01765250139904") 2025/12/09 03:15:54 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f223f0114e4030fbe_d20251209_m031537_c001_v0001146_t0029_u01765250137997") 2025/12/09 03:15:54 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f4185d126b5ccdfb9_d20251209_m031533_c001_v7007000_t0000_u01765250133880") 2025/12/09 03:15:54 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f2185d126b5ccdfac_d20251209_m031532_c001_v0001185_t0009_u01765250132221") 2025/12/09 03:15:55 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f423f0114e4030f85_d20251209_m031527_c001_v7007000_t0000_u01765250127879") 2025/12/09 03:15:55 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f223f0114e4030f7a_d20251209_m031526_c001_v0001177_t0000_u01765250126292") 2025/12/09 03:15:55 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f423f0114e4030f69_d20251209_m031524_c001_v7007000_t0000_u01765250124058") 2025/12/09 03:15:55 DEBUG : chunked-copy.copy: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10604d073962392f_d20251209_m031523_c001_v0001183_t0012_u01765250123271") 2025/12/09 03:15:55 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f1068ef01282a5f54_d20251209_m031051_c001_v0001185_t0029_u01765249851257") 2025/12/09 03:15:55 DEBUG : unknown-size-put.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f41765bd29f844a98_d20251209_m031547_c001_v7007000_t0000_u01765250147423") 2025/12/09 03:15:55 DEBUG : unknown-size-put.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a94bb_d20251209_m031547_c001_v0001185_t0026_u01765250147089") 2025/12/09 03:15:55 DEBUG : unknown-size-update.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f41765bd29f844a9e_d20251209_m031548_c001_v7007000_t0000_u01765250148692") 2025/12/09 03:15:55 DEBUG : unknown-size-update.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a9514_d20251209_m031548_c001_v0001185_t0011_u01765250148358") 2025/12/09 03:15:55 DEBUG : unknown-size-update.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f10450daea31a94de_d20251209_m031547_c001_v0001185_t0030_u01765250147617") 2025/12/09 03:15:55 DEBUG : versions/test-versions.txt: Deleting (id "4_zef02ad33106d0b1b9fb80e1b_f40388797d1ab1ed7_d20251209_m031208_c001_v7007000_t0000_u01765249928302") 2025/12/09 03:15:56 INFO : B2 bucket rclone-test-qogulap3gixo: cleaning bucket "rclone-test-qogulap3gixo" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (339.56s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.56s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.54s) --- PASS: TestIntegration/FsMkdir (337.19s) --- 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 (21.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (1.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (1.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.08s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.96s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.92s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.06s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.95s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.15s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (5.91s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (81.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.66s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (1.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.51s) --- 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.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.43s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.90s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.59s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (31.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.01s) --- 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.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (21.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (3.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.65s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (188.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (26.37s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.12s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.43s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.10s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (8.82s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.52s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (26.06s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (7.77s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.91s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (8.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.33s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (9.30s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (26.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (7.88s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (3.89s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (9.47s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (8.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.50s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (41.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (16.33s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (9.77s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (4.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (15.16s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (30.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (9.03s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.63s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (10.56s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.47s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (38.74s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (15.41s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (4.89s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (11.54s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (11.79s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.95s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (26.05s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (3.76s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (3.82s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (6.02s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (6.03s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (6.42s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (2.16s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.89s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.27s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.34s) --- 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 339.591s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 5m40.676741694s (try 1/5)