"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/10/26 04:59:41 NOTICE: TestB2: Stopped server 2025/10/26 04:59:41 NOTICE: TestB2: Starting server 2025/10/26 04:59:41 DEBUG : Creating backend with remote "TestB2:rclone-test-qujepub5goga" 2025/10/26 04:59:41 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/10/26 04:59:44 INFO : dir/subdir: Making directory fstest.go:250: Filtering empty directory "dir" fstest.go:250: Filtering empty directory "dir/subdir" 2025/10/26 04:59:44 INFO : dir/subdir: Removing directory fstest.go:250: Filtering empty directory "dir" 2025/10/26 04:59:44 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/10/26 05:00:11 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/10/26 05:00:11 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/10/26 05:00:13 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/10/26 05:00:13 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/10/26 05:00:14 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/10/26 05:00:14 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/10/26 05:00:14 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/10/26 05:00:14 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/10/26 05:00:21 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/10/26 05:00:23 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/10/26 05:00:28 INFO : B2 bucket rclone-test-qujepub5goga: cleaning bucket "rclone-test-qujepub5goga" of all files 2025/10/26 05:00:28 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b394_d20251026_m050027_c001_v0001161_t0033_u01761454827369") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/10/26 05:00:29 DEBUG : Creating backend with remote "TestB2:rclone-test-qujepub5goga/dirToPurgeFromRoot" 2025/10/26 05:00:30 INFO : B2 bucket rclone-test-qujepub5goga path dirToPurgeFromRoot: cleaning bucket "rclone-test-qujepub5goga" of all files 2025/10/26 05:00:31 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b39e_d20251026_m050029_c001_v0001161_t0010_u01761454829075") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/26 05:00:31 DEBUG : Creating backend with remote "TestB2:rclone-test-qujepub5goga/hello? sausage/êé" 2025/10/26 05:00:36 INFO : B2 bucket rclone-test-qujepub5goga path hello? sausage/êé: cleaning bucket "rclone-test-qujepub5goga" of all files 2025/10/26 05:00:36 DEBUG : a/b/c/d/e.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f11863177daa8b2f6_d20251026_m050034_c001_v0001106_t0014_u01761454834450") === 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/10/26 05:00:45 DEBUG : Creating backend with remote "TestB2:rclone-test-qujepub5goga/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/26 05:00:47 DEBUG : Creating backend with remote "TestB2:rclone-test-qujepub5goga/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-qujepub5goga" from "TestB2:rclone-test-qujepub5goga" 2025/10/26 05:00:49 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/10/26 05:01:01 DEBUG : Creating backend with remote "TestB2:rclone-test-qepetus1wiva" 2025/10/26 05:01:04 DEBUG : B2 bucket rclone-test-qepetus1wiva: Purge remote 2025/10/26 05:01:04 INFO : B2 bucket rclone-test-qepetus1wiva: cleaning bucket "rclone-test-qepetus1wiva" of all files 2025/10/26 05:01:04 DEBUG : somefile: Deleting (id "4_z8fb23d03e04d1beb9fa80e1b_f4186250c4c9b5f68_d20251026_m050103_c001_v0001105_t0005_u01761454863390") === 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/10/26 05:01:05 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/26 05:01:06 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/10/26 05:01:10 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/10/26 05:01:10 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/10/26 05:01:10 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.526Ki offset 6Mi/6.106Mi 2025/10/26 05:01:10 DEBUG : test-metadata: Sending chunk 1 length 111131 2025/10/26 05:01:11 DEBUG : test-metadata: Done sending chunk 1 2025/10/26 05:01:12 DEBUG : test-metadata: Done sending chunk 0 2025/10/26 05:01:12 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/10/26 05:01:22 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1161-06.backblaze.com/b2api/v1/b2_upload_file/bf02fdc3e02d1beb9fa80e1b/c001_v0001161_t0057": EOF 2025/10/26 05:01:22 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1161-06.backblaze.com/b2api/v1/b2_upload_file/bf02fdc3e02d1beb9fa80e1b/c001_v0001161_t0057": EOF) 2025/10/26 05:01:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1161-06.backblaze.com/b2api/v1/b2_upload_file/bf02fdc3e02d1beb9fa80e1b/c001_v0001161_t0057": EOF - low level retry 1/10 2025/10/26 05:01:24 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-10-26-050117-523.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/10/26 05:01:27 DEBUG : oldPath = "TestB2:rclone-test-qujepub5goga/versions/test-versions-v2025-10-26-050117-523.txt" 2025/10/26 05:01:27 DEBUG : newPath = "TestB2,versions:rclone-test-qujepub5goga/versions/test-versions-v2025-10-26-050117-523.txt" 2025/10/26 05:01:27 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-qujepub5goga/versions/test-versions-v2025-10-26-050117-523.txt" 2025/10/26 05:01:27 DEBUG : Config file has changed externally - reloading 2025/10/26 05:01:27 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/10/26 05:01:28 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-qujepub5goga/versions/test-versions-v2025-10-26-050117-523.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-qujepub5goga/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/10/26 05:01:31 INFO : B2 bucket rclone-test-qujepub5goga: cleaning bucket "rclone-test-qujepub5goga" of all hidden files 2025/10/26 05:01:31 DEBUG : leading space/ leading space: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c5_d20251026_m045952_c001_v7007000_t0000_u01761454792763") as it is a hide marker 2025/10/26 05:01:31 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : leading space/ leading space: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2b7_d20251026_m045952_c001_v0001161_t0036_u01761454792002") 2025/10/26 05:01:31 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c3_d20251026_m045951_c001_v7007000_t0000_u01761454791638") as it is a hide marker 2025/10/26 05:01:31 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2ad_d20251026_m045950_c001_v0001161_t0020_u01761454790883") 2025/10/26 05:01:31 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1ce_d20251026_m045959_c001_v7007000_t0000_u01761454799675") as it is a hide marker 2025/10/26 05:01:31 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : .leading dot/.leading dot: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2d9_d20251026_m045958_c001_v0001161_t0015_u01761454798935") 2025/10/26 05:01:31 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : created from root.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f404540c70597f7d8_d20251026_m050057_c001_v7007000_t0000_u01761454857470") as it is a hide marker 2025/10/26 05:01:31 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : created from root.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f101e26e4e70a5ccd_d20251026_m050056_c001_v0001183_t0052_u01761454856469") 2025/10/26 05:01:31 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : file name.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fdf_d20251026_m050105_c001_v7007000_t0000_u01761454865454") as it is a hide marker 2025/10/26 05:01:31 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b403_d20251026_m050044_c001_v0001161_t0016_u01761454844859") 2025/10/26 05:01:31 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f109d4cbac1ecb5cc_d20251026_m050041_c001_v0001040_t0051_u01761454841200") 2025/10/26 05:01:31 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b360_d20251026_m050019_c001_v0001161_t0052_u01761454819170") 2025/10/26 05:01:31 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b35c_d20251026_m050018_c001_v0001161_t0011_u01761454818000") 2025/10/26 05:01:31 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b35e_d20251026_m050018_c001_v0001161_t0005_u01761454818598") "upload" dated 2025-10-26 05:00:18.598 +0000 UTC (1m13.381126806s ago) 2025/10/26 05:01:31 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f407238d1374c11f5_d20251026_m050038_c001_v7007000_t0000_u01761454838890") as it is a hide marker 2025/10/26 05:01:31 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f112308021c4afcd2_d20251026_m050038_c001_v0001044_t0034_u01761454838349") 2025/10/26 05:01:31 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f11169ff6e9fd9f3d_d20251026_m050037_c001_v0001161_t0009_u01761454837608") 2025/10/26 05:01:31 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba222_d20251026_m050007_c001_v7007000_t0000_u01761454807844") as it is a hide marker 2025/10/26 05:01:31 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b30f_d20251026_m050007_c001_v0001161_t0001_u01761454807159") 2025/10/26 05:01:31 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : piped data.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fe4_d20251026_m050107_c001_v7007000_t0000_u01761454867649") as it is a hide marker 2025/10/26 05:01:31 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : piped data.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b497_d20251026_m050106_c001_v0001161_t0023_u01761454866742") 2025/10/26 05:01:31 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : piped data.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fe2_d20251026_m050106_c001_v7007000_t0000_u01761454866553") 2025/10/26 05:01:31 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : piped data.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f40604929f0a2b491_d20251026_m050106_c001_v0001161_t0057_u01761454866188") 2025/10/26 05:01:31 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba23a_d20251026_m050008_c001_v7007000_t0000_u01761454808892") as it is a hide marker 2025/10/26 05:01:31 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b321_d20251026_m050008_c001_v0001161_t0003_u01761454808207") 2025/10/26 05:01:31 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : test-metadata: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f412fb83cf447248b_d20251026_m050114_c001_v7007000_t0000_u01761454874970") as it is a hide marker 2025/10/26 05:01:31 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : test-metadata: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f201886b197160ffd_d20251026_m050109_c001_v0001157_t0047_u01761454869806") 2025/10/26 05:01:31 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : test-metadata: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fe7_d20251026_m050108_c001_v7007000_t0000_u01761454868862") 2025/10/26 05:01:31 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : test-metadata: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b49f_d20251026_m050107_c001_v0001161_t0053_u01761454867847") 2025/10/26 05:01:31 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1dc_d20251026_m050002_c001_v7007000_t0000_u01761454802226") as it is a hide marker 2025/10/26 05:01:31 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2e5_d20251026_m050001_c001_v0001161_t0043_u01761454801482") 2025/10/26 05:01:31 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1e2_d20251026_m050004_c001_v7007000_t0000_u01761454804349") as it is a hide marker 2025/10/26 05:01:31 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2f9_d20251026_m050003_c001_v0001161_t0025_u01761454803655") 2025/10/26 05:01:31 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1e0_d20251026_m050003_c001_v7007000_t0000_u01761454803291") as it is a hide marker 2025/10/26 05:01:31 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2ed_d20251026_m050002_c001_v0001161_t0026_u01761454802589") 2025/10/26 05:01:31 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1f6_d20251026_m050005_c001_v7007000_t0000_u01761454805372") as it is a hide marker 2025/10/26 05:01:31 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b303_d20251026_m050004_c001_v0001161_t0043_u01761454804716") 2025/10/26 05:01:31 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba20d_d20251026_m050006_c001_v7007000_t0000_u01761454806792") as it is a hide marker 2025/10/26 05:01:31 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b309_d20251026_m050005_c001_v0001161_t0023_u01761454805746") 2025/10/26 05:01:31 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing space /trailing space : Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1d1_d20251026_m050001_c001_v7007000_t0000_u01761454801119") as it is a hide marker 2025/10/26 05:01:31 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : trailing space /trailing space : Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2df_d20251026_m050000_c001_v0001161_t0004_u01761454800042") 2025/10/26 05:01:31 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a40f58_d20251026_m050125_c001_v0001040_t0028_u01761454885375") "upload" dated 2025-10-26 05:01:25.375 +0000 UTC (6.604963627s ago) 2025/10/26 05:01:31 DEBUG : versions/test-versions.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba7b5_d20251026_m050120_c001_v7007000_t0000_u01761454880559") 2025/10/26 05:01:31 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : versions/test-versions.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b4d1_d20251026_m050117_c001_v0001161_t0059_u01761454877523") 2025/10/26 05:01:31 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba316_d20251026_m050017_c001_v7007000_t0000_u01761454817455") as it is a hide marker 2025/10/26 05:01:31 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f223f3964a67ba264_d20251026_m050011_c001_v0001137_t0019_u01761454811160") 2025/10/26 05:01:31 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : zero-length-file: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba25e_d20251026_m050010_c001_v7007000_t0000_u01761454810822") as it is a hide marker 2025/10/26 05:01:31 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : zero-length-file: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f40604929f0a2b32d_d20251026_m050010_c001_v0001161_t0057_u01761454810180") 2025/10/26 05:01:31 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c6_d20251026_m045953_c001_v7007000_t0000_u01761454793840") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2bf_d20251026_m045953_c001_v0001161_t0043_u01761454793128") 2025/10/26 05:01:31 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1bc_d20251026_m045948_c001_v7007000_t0000_u01761454788053") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b292_d20251026_m045946_c001_v0001161_t0011_u01761454786407") 2025/10/26 05:01:31 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1cb_d20251026_m045957_c001_v7007000_t0000_u01761454797443") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2cf_d20251026_m045956_c001_v0001161_t0021_u01761454796612") 2025/10/26 05:01:31 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1ca_d20251026_m045956_c001_v7007000_t0000_u01761454796248") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2c9_d20251026_m045955_c001_v0001161_t0042_u01761454795609") 2025/10/26 05:01:31 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1cc_d20251026_m045958_c001_v7007000_t0000_u01761454798572") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2d3_d20251026_m045957_c001_v0001161_t0041_u01761454797807") 2025/10/26 05:01:31 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c9_d20251026_m045955_c001_v7007000_t0000_u01761454795246") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2c3_d20251026_m045954_c001_v0001161_t0050_u01761454794205") 2025/10/26 05:01:31 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ./.: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1bd_d20251026_m045949_c001_v7007000_t0000_u01761454789279") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ./.: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ./.: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b29c_d20251026_m045948_c001_v0001161_t0059_u01761454788416") 2025/10/26 05:01:31 NOTICE: ./.: Skipped delete as --dry-run is set 2025/10/26 05:01:31 DEBUG : ../..: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c0_d20251026_m045950_c001_v7007000_t0000_u01761454790520") as it is a hide marker 2025/10/26 05:01:31 NOTICE: ../..: Skipped remove hide marker as --dry-run is set 2025/10/26 05:01:31 DEBUG : ../..: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2a7_d20251026_m045949_c001_v0001161_t0014_u01761454789642") 2025/10/26 05:01:31 NOTICE: ../..: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/10/26 05:01:32 INFO : B2 bucket rclone-test-qujepub5goga: cleaning bucket "rclone-test-qujepub5goga" of all hidden files 2025/10/26 05:01:32 DEBUG : leading space/ leading space: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c5_d20251026_m045952_c001_v7007000_t0000_u01761454792763") as it is a hide marker 2025/10/26 05:01:32 DEBUG : leading space/ leading space: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2b7_d20251026_m045952_c001_v0001161_t0036_u01761454792002") 2025/10/26 05:01:32 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c3_d20251026_m045951_c001_v7007000_t0000_u01761454791638") as it is a hide marker 2025/10/26 05:01:32 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2ad_d20251026_m045950_c001_v0001161_t0020_u01761454790883") 2025/10/26 05:01:32 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1ce_d20251026_m045959_c001_v7007000_t0000_u01761454799675") as it is a hide marker 2025/10/26 05:01:32 DEBUG : .leading dot/.leading dot: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2d9_d20251026_m045958_c001_v0001161_t0015_u01761454798935") 2025/10/26 05:01:32 DEBUG : created from root.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f404540c70597f7d8_d20251026_m050057_c001_v7007000_t0000_u01761454857470") as it is a hide marker 2025/10/26 05:01:32 DEBUG : created from root.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f101e26e4e70a5ccd_d20251026_m050056_c001_v0001183_t0052_u01761454856469") 2025/10/26 05:01:32 DEBUG : file name.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fdf_d20251026_m050105_c001_v7007000_t0000_u01761454865454") as it is a hide marker 2025/10/26 05:01:32 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b403_d20251026_m050044_c001_v0001161_t0016_u01761454844859") 2025/10/26 05:01:32 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f109d4cbac1ecb5cc_d20251026_m050041_c001_v0001040_t0051_u01761454841200") 2025/10/26 05:01:32 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b360_d20251026_m050019_c001_v0001161_t0052_u01761454819170") 2025/10/26 05:01:32 DEBUG : file name.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b35c_d20251026_m050018_c001_v0001161_t0011_u01761454818000") 2025/10/26 05:01:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b35e_d20251026_m050018_c001_v0001161_t0005_u01761454818598") "upload" dated 2025-10-26 05:00:18.598 +0000 UTC (1m14.422255055s ago) 2025/10/26 05:01:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f407238d1374c11f5_d20251026_m050038_c001_v7007000_t0000_u01761454838890") as it is a hide marker 2025/10/26 05:01:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f112308021c4afcd2_d20251026_m050038_c001_v0001044_t0034_u01761454838349") 2025/10/26 05:01:33 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f11169ff6e9fd9f3d_d20251026_m050037_c001_v0001161_t0009_u01761454837608") 2025/10/26 05:01:33 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba222_d20251026_m050007_c001_v7007000_t0000_u01761454807844") as it is a hide marker 2025/10/26 05:01:33 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b30f_d20251026_m050007_c001_v0001161_t0001_u01761454807159") 2025/10/26 05:01:33 DEBUG : piped data.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fe4_d20251026_m050107_c001_v7007000_t0000_u01761454867649") as it is a hide marker 2025/10/26 05:01:33 DEBUG : piped data.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b497_d20251026_m050106_c001_v0001161_t0023_u01761454866742") 2025/10/26 05:01:33 DEBUG : piped data.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fe2_d20251026_m050106_c001_v7007000_t0000_u01761454866553") 2025/10/26 05:01:33 DEBUG : piped data.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f40604929f0a2b491_d20251026_m050106_c001_v0001161_t0057_u01761454866188") 2025/10/26 05:01:33 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba23a_d20251026_m050008_c001_v7007000_t0000_u01761454808892") as it is a hide marker 2025/10/26 05:01:33 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b321_d20251026_m050008_c001_v0001161_t0003_u01761454808207") 2025/10/26 05:01:33 DEBUG : test-metadata: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f412fb83cf447248b_d20251026_m050114_c001_v7007000_t0000_u01761454874970") as it is a hide marker 2025/10/26 05:01:33 DEBUG : test-metadata: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f201886b197160ffd_d20251026_m050109_c001_v0001157_t0047_u01761454869806") 2025/10/26 05:01:33 DEBUG : test-metadata: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f401886b197160fe7_d20251026_m050108_c001_v7007000_t0000_u01761454868862") 2025/10/26 05:01:33 DEBUG : test-metadata: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b49f_d20251026_m050107_c001_v0001161_t0053_u01761454867847") 2025/10/26 05:01:33 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1dc_d20251026_m050002_c001_v7007000_t0000_u01761454802226") as it is a hide marker 2025/10/26 05:01:33 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2e5_d20251026_m050001_c001_v0001161_t0043_u01761454801482") 2025/10/26 05:01:33 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1e2_d20251026_m050004_c001_v7007000_t0000_u01761454804349") as it is a hide marker 2025/10/26 05:01:33 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2f9_d20251026_m050003_c001_v0001161_t0025_u01761454803655") 2025/10/26 05:01:33 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1e0_d20251026_m050003_c001_v7007000_t0000_u01761454803291") as it is a hide marker 2025/10/26 05:01:33 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2ed_d20251026_m050002_c001_v0001161_t0026_u01761454802589") 2025/10/26 05:01:33 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1f6_d20251026_m050005_c001_v7007000_t0000_u01761454805372") as it is a hide marker 2025/10/26 05:01:34 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b303_d20251026_m050004_c001_v0001161_t0043_u01761454804716") 2025/10/26 05:01:34 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba20d_d20251026_m050006_c001_v7007000_t0000_u01761454806792") as it is a hide marker 2025/10/26 05:01:34 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b309_d20251026_m050005_c001_v0001161_t0023_u01761454805746") 2025/10/26 05:01:34 DEBUG : trailing space /trailing space : Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1d1_d20251026_m050001_c001_v7007000_t0000_u01761454801119") as it is a hide marker 2025/10/26 05:01:34 DEBUG : trailing space /trailing space : Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2df_d20251026_m050000_c001_v0001161_t0004_u01761454800042") 2025/10/26 05:01:34 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a40f58_d20251026_m050125_c001_v0001040_t0028_u01761454885375") "upload" dated 2025-10-26 05:01:25.375 +0000 UTC (8.93301731s ago) 2025/10/26 05:01:34 DEBUG : versions/test-versions.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba7b5_d20251026_m050120_c001_v7007000_t0000_u01761454880559") 2025/10/26 05:01:34 DEBUG : versions/test-versions.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b4d1_d20251026_m050117_c001_v0001161_t0059_u01761454877523") 2025/10/26 05:01:34 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba316_d20251026_m050017_c001_v7007000_t0000_u01761454817455") as it is a hide marker 2025/10/26 05:01:34 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f223f3964a67ba264_d20251026_m050011_c001_v0001137_t0019_u01761454811160") 2025/10/26 05:01:34 DEBUG : zero-length-file: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba25e_d20251026_m050010_c001_v7007000_t0000_u01761454810822") as it is a hide marker 2025/10/26 05:01:34 DEBUG : zero-length-file: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f40604929f0a2b32d_d20251026_m050010_c001_v0001161_t0057_u01761454810180") 2025/10/26 05:01:34 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c6_d20251026_m045953_c001_v7007000_t0000_u01761454793840") as it is a hide marker 2025/10/26 05:01:34 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2bf_d20251026_m045953_c001_v0001161_t0043_u01761454793128") 2025/10/26 05:01:34 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1bc_d20251026_m045948_c001_v7007000_t0000_u01761454788053") as it is a hide marker 2025/10/26 05:01:34 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b292_d20251026_m045946_c001_v0001161_t0011_u01761454786407") 2025/10/26 05:01:34 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1cb_d20251026_m045957_c001_v7007000_t0000_u01761454797443") as it is a hide marker 2025/10/26 05:01:34 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2cf_d20251026_m045956_c001_v0001161_t0021_u01761454796612") 2025/10/26 05:01:34 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1ca_d20251026_m045956_c001_v7007000_t0000_u01761454796248") as it is a hide marker 2025/10/26 05:01:34 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2c9_d20251026_m045955_c001_v0001161_t0042_u01761454795609") 2025/10/26 05:01:34 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1cc_d20251026_m045958_c001_v7007000_t0000_u01761454798572") as it is a hide marker 2025/10/26 05:01:35 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2d3_d20251026_m045957_c001_v0001161_t0041_u01761454797807") 2025/10/26 05:01:35 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c9_d20251026_m045955_c001_v7007000_t0000_u01761454795246") as it is a hide marker 2025/10/26 05:01:35 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2c3_d20251026_m045954_c001_v0001161_t0050_u01761454794205") 2025/10/26 05:01:35 DEBUG : ./.: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1bd_d20251026_m045949_c001_v7007000_t0000_u01761454789279") as it is a hide marker 2025/10/26 05:01:35 DEBUG : ./.: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b29c_d20251026_m045948_c001_v0001161_t0059_u01761454788416") 2025/10/26 05:01:35 DEBUG : ../..: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba1c0_d20251026_m045950_c001_v7007000_t0000_u01761454790520") as it is a hide marker 2025/10/26 05:01:35 DEBUG : ../..: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b2a7_d20251026_m045949_c001_v0001161_t0014_u01761454789642") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/10/26 05:01:36 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/10/26 05:01:36 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/10/26 05:01:36 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/10/26 05:01:36 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/10/26 05:01:37 INFO : B2 bucket rclone-test-qujepub5goga: cleaning bucket "rclone-test-qujepub5goga" of pending multipart uploads older than 0s 2025/10/26 05:01:37 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b35e_d20251026_m050018_c001_v0001161_t0005_u01761454818598") "upload" dated 2025-10-26 05:00:18.598 +0000 UTC (1m18.64832719s ago) 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee1789d_d20251026_m050136_c001_v0001181_t0055_u01761454896191") as it is a start marker (upload started at 2025-10-26 05:01:36.191 +0000 UTC) 2025/10/26 05:01:37 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee178a0_d20251026_m050136_c001_v0001134_t0053_u01761454896378") as it is a start marker (upload started at 2025-10-26 05:01:36.378 +0000 UTC) 2025/10/26 05:01:37 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee178a2_d20251026_m050136_c001_v0001184_t0002_u01761454896561") as it is a start marker (upload started at 2025-10-26 05:01:36.561 +0000 UTC) 2025/10/26 05:01:37 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee178a6_d20251026_m050136_c001_v0001130_t0050_u01761454896767") as it is a start marker (upload started at 2025-10-26 05:01:36.767 +0000 UTC) 2025/10/26 05:01:37 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/10/26 05:01:37 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f4190ef62bee17898_d20251026_m050136_c001_v7007000_t0000_u01761454896005") "hide" dated 2025-10-26 05:01:36.005 +0000 UTC (1.241863086s ago) 2025/10/26 05:01:37 DEBUG : versions/test-versions.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a40f58_d20251026_m050125_c001_v0001040_t0028_u01761454885375") 2025/10/26 05:01:37 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/10/26 05:01:37 INFO : B2 bucket rclone-test-qujepub5goga: cleaning bucket "rclone-test-qujepub5goga" of pending multipart uploads older than 0s 2025/10/26 05:01:37 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b35e_d20251026_m050018_c001_v0001161_t0005_u01761454818598") "upload" dated 2025-10-26 05:00:18.598 +0000 UTC (1m19.019122572s ago) 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee1789d_d20251026_m050136_c001_v0001181_t0055_u01761454896191") as it is a start marker (upload started at 2025-10-26 05:01:36.191 +0000 UTC) 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee178a0_d20251026_m050136_c001_v0001134_t0053_u01761454896378") as it is a start marker (upload started at 2025-10-26 05:01:36.378 +0000 UTC) 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee178a2_d20251026_m050136_c001_v0001184_t0002_u01761454896561") as it is a start marker (upload started at 2025-10-26 05:01:36.561 +0000 UTC) 2025/10/26 05:01:37 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee178a6_d20251026_m050136_c001_v0001130_t0050_u01761454896767") as it is a start marker (upload started at 2025-10-26 05:01:36.767 +0000 UTC) 2025/10/26 05:01:37 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zbf02fdc3e02d1beb9fa80e1b_f4190ef62bee17898_d20251026_m050136_c001_v7007000_t0000_u01761454896005") "hide" dated 2025-10-26 05:01:36.005 +0000 UTC (1.612495682s ago) 2025/10/26 05:01:37 DEBUG : versions/test-versions.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a40f58_d20251026_m050125_c001_v0001040_t0028_u01761454885375") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/10/26 05:01:38 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/10/26 05:01:38 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/10/26 05:01:38 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/10/26 05:01:40 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/10/26 05:01:40 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/10/26 05:01:40 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/10/26 05:01:40 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/10/26 05:01:41 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/10/26 05:01:42 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/10/26 05:01:42 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/10/26 05:01:45 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:01:45 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/10/26 05:01:45 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f223f3964a67ba8cf_d20251026_m050145_c001_v0001093_t0039_u01761454905448") 2025/10/26 05:01:45 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:01:45 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/26 05:01:45 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/26 05:01:47 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:01:48 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:01:48 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/10/26 05:01:49 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/10/26 05:01:49 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/10/26 05:01:49 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/10/26 05:01:49 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/10/26 05:01:52 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/10/26 05:01:52 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/10/26 05:01:52 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/10/26 05:01:53 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:01:53 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/10/26 05:01:54 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d22b_d20251026_m050153_c001_v0001179_t0029_u01761454913966") 2025/10/26 05:01:54 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/26 05:01:54 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/26 05:01:54 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/10/26 05:01:56 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:01:56 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:01:56 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/10/26 05:01:58 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/10/26 05:01:58 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/10/26 05:01:58 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/10/26 05:01:58 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/10/26 05:01:58 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/10/26 05:01:58 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/10/26 05:01:59 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/10/26 05:02:00 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/10/26 05:02:00 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/10/26 05:02:00 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/10/26 05:02:02 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:02:02 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/10/26 05:02:02 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f215ef40f70f18066_d20251026_m050202_c001_v0001130_t0052_u01761454922472") 2025/10/26 05:02:02 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/26 05:02:02 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:02:02 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/10/26 05:02:02 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/26 05:02:03 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/10/26 05:02:04 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:02:05 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:02:05 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/10/26 05:02:06 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/10/26 05:02:06 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/10/26 05:02:06 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/10/26 05:02:06 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/10/26 05:02:08 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/10/26 05:02:09 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/10/26 05:02:09 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/10/26 05:02:10 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:02:10 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/10/26 05:02:11 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f215ef40f70f180c8_d20251026_m050210_c001_v0001044_t0016_u01761454930998") 2025/10/26 05:02:11 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:02:11 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/10/26 05:02:11 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/26 05:02:12 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:02:13 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:02:13 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/10/26 05:02:15 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/10/26 05:02:15 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/10/26 05:02:15 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/10/26 05:02:15 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/10/26 05:02:17 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/10/26 05:02:17 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/10/26 05:02:17 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/10/26 05:02:19 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:02:19 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/10/26 05:02:19 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d250_d20251026_m050219_c001_v0001171_t0024_u01761454939748") 2025/10/26 05:02:19 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/26 05:02:20 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/26 05:02:20 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/10/26 05:02:22 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:02:22 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:02:22 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/10/26 05:02:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/10/26 05:02:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/10/26 05:02:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/10/26 05:02:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/10/26 05:02:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/10/26 05:02:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/10/26 05:02:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/10/26 05:02:26 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/10/26 05:02:26 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/10/26 05:02:26 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/10/26 05:02:28 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:02:28 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/10/26 05:02:28 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98848_d20251026_m050228_c001_v0001099_t0038_u01761454948366") 2025/10/26 05:02:28 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/26 05:02:28 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:02:28 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/10/26 05:02:28 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/10/26 05:02:29 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/10/26 05:02:30 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:02:31 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:02:31 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/10/26 05:02:32 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/10/26 05:02:32 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/10/26 05:02:32 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/10/26 05:02:32 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/10/26 05:02:33 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/10/26 05:02:35 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/10/26 05:02:35 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/10/26 05:02:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:02:36 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/10/26 05:02:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98869_d20251026_m050236_c001_v0001099_t0029_u01761454956417") 2025/10/26 05:02:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:02:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/10/26 05:02:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/26 05:02:37 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:02:38 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:02:38 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/10/26 05:02:40 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/10/26 05:02:40 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/10/26 05:02:40 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/10/26 05:02:40 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/10/26 05:02:42 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/10/26 05:02:43 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/10/26 05:02:43 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/10/26 05:02:44 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:02:44 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/10/26 05:02:44 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98877_d20251026_m050244_c001_v0001182_t0027_u01761454964733") 2025/10/26 05:02:44 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/26 05:02:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/26 05:02:45 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/10/26 05:02:47 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:02:47 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:02:47 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/10/26 05:02:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/10/26 05:02:48 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/10/26 05:02:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/10/26 05:02:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/10/26 05:02:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/10/26 05:02:49 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/10/26 05:02:50 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/10/26 05:02:51 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/10/26 05:02:51 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/10/26 05:02:51 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/10/26 05:02:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:02:53 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/10/26 05:02:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d368ae_d20251026_m050253_c001_v0001182_t0029_u01761454973327") 2025/10/26 05:02:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/26 05:02:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:02:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/10/26 05:02:53 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/10/26 05:02:54 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/10/26 05:02:55 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:02:55 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:02:55 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/10/26 05:02:57 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/10/26 05:02:57 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/10/26 05:02:57 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/10/26 05:02:57 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/10/26 05:02:58 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/10/26 05:03:00 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/10/26 05:03:00 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/10/26 05:03:02 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:03:02 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/10/26 05:03:02 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d36953_d20251026_m050302_c001_v0001134_t0007_u01761454982273") 2025/10/26 05:03:02 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:03:02 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/10/26 05:03:02 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/26 05:03:03 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:03:04 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:03:04 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/10/26 05:03:06 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/10/26 05:03:06 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/10/26 05:03:06 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/10/26 05:03:06 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/10/26 05:03:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/10/26 05:03:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/10/26 05:03:09 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/10/26 05:03:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:03:11 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/10/26 05:03:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98916_d20251026_m050311_c001_v0001157_t0050_u01761454991311") 2025/10/26 05:03:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/26 05:03:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/26 05:03:11 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/10/26 05:03:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:03:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:03:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/10/26 05:03:16 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/10/26 05:03:16 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/10/26 05:03:16 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/10/26 05:03:16 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/10/26 05:03:16 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/10/26 05:03:16 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/10/26 05:03:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/10/26 05:03:19 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/10/26 05:03:19 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/10/26 05:03:19 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/10/26 05:03:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:03:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Streaming upload with --b2-chunk-size 6.667Mi allows uploads of up to 65.104Gi and will fail only when that limit is reached. 2025/10/26 05:03:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98969_d20251026_m050321_c001_v0001117_t0023_u01761455001342") 2025/10/26 05:03:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/26 05:03:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:03:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/10/26 05:03:21 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/10/26 05:03:23 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/10/26 05:03:24 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:03:24 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:03:24 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/10/26 05:03:27 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/10/26 05:03:27 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/10/26 05:03:27 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/10/26 05:03:27 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/10/26 05:03:28 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/10/26 05:03:29 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/10/26 05:03:29 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/10/26 05:03:31 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:03:31 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/10/26 05:03:31 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f2211a8d8969339c9_d20251026_m050331_c001_v0001161_t0023_u01761455011119") 2025/10/26 05:03:31 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:03:31 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/26 05:03:31 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/26 05:03:32 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:03:33 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:03:33 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/10/26 05:03:35 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/10/26 05:03:35 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/10/26 05:03:35 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/10/26 05:03:35 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/10/26 05:03:37 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/10/26 05:03:38 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/10/26 05:03:38 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/10/26 05:03:40 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:03:40 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/10/26 05:03:40 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f205638df903db6c0_d20251026_m050340_c001_v0001029_t0012_u01761455020451") 2025/10/26 05:03:40 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/26 05:03:40 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/26 05:03:40 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/10/26 05:03:43 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:03:43 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:03:43 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/10/26 05:03:45 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/10/26 05:03:45 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/10/26 05:03:46 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/10/26 05:03:46 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/10/26 05:03:46 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/10/26 05:03:46 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/10/26 05:03:47 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/10/26 05:03:48 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/10/26 05:03:48 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/10/26 05:03:48 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/10/26 05:03:50 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:03:50 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/10/26 05:03:51 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f215e79b3fd859f41_d20251026_m050351_c001_v0001040_t0021_u01761455031031") 2025/10/26 05:03:51 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/26 05:03:51 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:03:51 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/26 05:03:51 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/10/26 05:03:51 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/10/26 05:03:51 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/26 05:03:51 DEBUG : pacer: Reducing sleep to 10ms 2025/10/26 05:03:52 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/10/26 05:03:53 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:03:54 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:03:54 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/10/26 05:03:56 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/10/26 05:03:56 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/10/26 05:03:56 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/10/26 05:03:56 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/10/26 05:03:56 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/10/26 05:03:56 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/26 05:03:56 DEBUG : pacer: Reducing sleep to 10ms 2025/10/26 05:03:57 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/10/26 05:03:59 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/10/26 05:03:59 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/10/26 05:04:01 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:04:01 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/10/26 05:04:02 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f21448d3fddc80f6c_d20251026_m050401_c001_v0001137_t0003_u01761455041937") 2025/10/26 05:04:02 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:04:02 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/26 05:04:02 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/26 05:04:02 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/10/26 05:04:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/26 05:04:02 DEBUG : pacer: Reducing sleep to 10ms 2025/10/26 05:04:02 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:04:05 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:04:05 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/10/26 05:04:07 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/10/26 05:04:07 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/10/26 05:04:07 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/10/26 05:04:07 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/10/26 05:04:09 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/10/26 05:04:10 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/10/26 05:04:10 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/10/26 05:04:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:04:12 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/10/26 05:04:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d36b19_d20251026_m050412_c001_v0001178_t0059_u01761455052644") 2025/10/26 05:04:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/26 05:04:13 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/26 05:04:13 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/10/26 05:04:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:04:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:04:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/10/26 05:04:18 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/10/26 05:04:18 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/10/26 05:04:18 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/10/26 05:04:18 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/10/26 05:04:18 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/10/26 05:04:18 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/10/26 05:04:19 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/10/26 05:04:20 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/10/26 05:04:21 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/10/26 05:04:21 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/10/26 05:04:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/26 05:04:23 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/10/26 05:04:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_zbf02fdc3e02d1beb9fa80e1b_f207238d1374c1819_d20251026_m050423_c001_v0001044_t0017_u01761455063835") 2025/10/26 05:04:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/26 05:04:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/10/26 05:04:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/26 05:04:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/26 05:04:25 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/10/26 05:04:26 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/10/26 05:04:27 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/10/26 05:04:27 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/10/26 05:04:35 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zbf02fdc3e02d1beb9fa80e1b_f21448d3fddc8105d_d20251026_m050435_c001_v0001137_t0054_u01761455075694") 2025/10/26 05:04:35 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/10/26 05:04:35 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/26 05:04:36 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/26 05:04:36 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/26 05:04:36 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/10/26 05:04:38 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/10/26 05:04:38 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:04:39 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/10/26 05:04:39 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/10/26 05:04:41 DEBUG : chunked-copy: Done sending chunk 0 2025/10/26 05:04:41 DEBUG : chunked-copy: Done sending chunk 1 2025/10/26 05:04:41 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/26 05:04:42 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zbf02fdc3e02d1beb9fa80e1b_f217c043bd45dc6d0_d20251026_m050441_c001_v0001182_t0005_u01761455081995") 2025/10/26 05:04:42 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/10/26 05:04:42 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/26 05:04:42 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/26 05:04:42 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/26 05:04:42 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/10/26 05:04:44 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/10/26 05:04:44 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:04:44 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/10/26 05:04:44 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/26 05:04:45 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00028c720), retryAfter:1000000000} 2025/10/26 05:04:45 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:45 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:45 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:45 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:04:45 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00035ba70), retryAfter:1000000000} 2025/10/26 05:04:45 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:45 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:46 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:04:47 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00028cbd0), retryAfter:1000000000} 2025/10/26 05:04:47 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:47 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:47 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:47 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/26 05:04:48 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:04:49 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:04:50 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0002065a0), retryAfter:1000000000} 2025/10/26 05:04:50 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:50 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:50 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:50 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:04:51 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0003206c0), retryAfter:1000000000} 2025/10/26 05:04:51 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:51 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:51 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:51 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/26 05:04:52 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:04:53 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:04:54 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0000db260), retryAfter:1000000000} 2025/10/26 05:04:54 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:54 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:54 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:54 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:04:55 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000321230), retryAfter:1000000000} 2025/10/26 05:04:55 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:55 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:55 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:55 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/26 05:04:56 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:04:57 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:04:58 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000230570), retryAfter:1000000000} 2025/10/26 05:04:58 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:58 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:58 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:58 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:04:59 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc00026dda0), retryAfter:1000000000} 2025/10/26 05:04:59 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:04:59 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:04:59 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:04:59 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/26 05:05:00 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:05:01 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:05:02 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000358e40), retryAfter:1000000000} 2025/10/26 05:05:02 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:05:02 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:05:02 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:05:02 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:05:03 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/26 05:05:04 DEBUG : pacer: Reducing sleep to 250ms 2025/10/26 05:05:04 DEBUG : chunked-copy: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000235800), retryAfter:1000000000} 2025/10/26 05:05:04 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable): trying again in 1s 2025/10/26 05:05:04 DEBUG : pacer: low level retry 6/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/26 05:05:04 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/26 05:05:04 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/26 05:05:05 DEBUG : pacer: Reducing sleep to 500ms 2025/10/26 05:05:05 DEBUG : chunked-copy: Done sending chunk 0 2025/10/26 05:05:06 DEBUG : pacer: Reducing sleep to 250ms 2025/10/26 05:05:08 DEBUG : pacer: Reducing sleep to 125ms 2025/10/26 05:05:08 DEBUG : chunked-copy: Done sending chunk 1 2025/10/26 05:05:08 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/26 05:05:08 DEBUG : pacer: Reducing sleep to 62.5ms 2025/10/26 05:05:08 DEBUG : pacer: Reducing sleep to 31.25ms 2025/10/26 05:05:09 DEBUG : pacer: Reducing sleep to 15.625ms 2025/10/26 05:05:09 DEBUG : pacer: Reducing sleep to 10ms 2025/10/26 05:05:09 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zbf02fdc3e02d1beb9fa80e1b_f217c043bd45dc754_d20251026_m050509_c001_v0001176_t0008_u01761455109181") 2025/10/26 05:05:09 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/10/26 05:05:09 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/26 05:05:09 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/26 05:05:10 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/26 05:05:10 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/10/26 05:05:13 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/10/26 05:05:13 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/26 05:05:13 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/10/26 05:05:13 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/10/26 05:05:15 DEBUG : chunked-copy: Done sending chunk 0 2025/10/26 05:05:16 DEBUG : chunked-copy: Done sending chunk 1 2025/10/26 05:05:16 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/26 05:05:16 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_zbf02fdc3e02d1beb9fa80e1b_f217c043bd45dc78c_d20251026_m050516_c001_v0001115_t0039_u01761455116734") 2025/10/26 05:05:16 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/10/26 05:05:16 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/26 05:05:16 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/10/26 05:05:17 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/26 05:05:17 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/10/26 05:05:17 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/26 05:05:17 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/26 05:05:19 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/26 05:05:21 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/26 05:05:21 DEBUG : Creating backend with remote "TestB2:rclone-test-qujepub5goga/deeper/nonexisting/directory" 2025/10/26 05:05:21 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/10/26 05:05:22 INFO : B2 bucket rclone-test-qujepub5goga: cleaning bucket "rclone-test-qujepub5goga" of all files 2025/10/26 05:05:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f418e418520d36b0a_d20251026_m050406_c001_v7007000_t0000_u01761455046446") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f21448d3fddc80f6c_d20251026_m050401_c001_v0001137_t0003_u01761455041937") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc80f5e_d20251026_m050401_c001_v7007000_t0000_u01761455041395") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f21308852a45bd97c_d20251026_m050356_c001_v0001182_t0057_u01761455036276") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc81026_d20251026_m050429_c001_v7007000_t0000_u01761455069442") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f207238d1374c1819_d20251026_m050423_c001_v0001044_t0017_u01761455063835") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f407238d1374c1818_d20251026_m050423_c001_v7007000_t0000_u01761455063253") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d36b6d_d20251026_m050417_c001_v0001183_t0001_u01761455057857") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f418e418520d36b6a_d20251026_m050417_c001_v7007000_t0000_u01761455057672") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d36b19_d20251026_m050412_c001_v0001178_t0059_u01761455052644") 2025/10/26 05:05:23 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f418e418520d36b18_d20251026_m050412_c001_v7007000_t0000_u01761455052065") 2025/10/26 05:05:24 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d36b0b_d20251026_m050406_c001_v0001181_t0054_u01761455046629") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d25a_d20251026_m050232_c001_v7007000_t0000_u01761454952218") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98848_d20251026_m050228_c001_v0001099_t0038_u01761454948366") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d254_d20251026_m050223_c001_v7007000_t0000_u01761454943691") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d250_d20251026_m050219_c001_v0001171_t0024_u01761454939748") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f98846_d20251026_m050227_c001_v7007000_t0000_u01761454947976") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d256_d20251026_m050223_c001_v0001136_t0004_u01761454943873") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d24f_d20251026_m050219_c001_v7007000_t0000_u01761454939348") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d24b_d20251026_m050214_c001_v0001144_t0031_u01761454934755") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d24a_d20251026_m050214_c001_v7007000_t0000_u01761454934573") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f215ef40f70f180c8_d20251026_m050210_c001_v0001044_t0016_u01761454930998") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f415ef40f70f180c2_d20251026_m050210_c001_v7007000_t0000_u01761454930608") 2025/10/26 05:05:24 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d246_d20251026_m050206_c001_v0001036_t0015_u01761454926649") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f988b1_d20251026_m050257_c001_v7007000_t0000_u01761454977197") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d368ae_d20251026_m050253_c001_v0001182_t0029_u01761454973327") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f98879_d20251026_m050248_c001_v7007000_t0000_u01761454968445") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98877_d20251026_m050244_c001_v0001182_t0027_u01761454964733") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f418e418520d368a2_d20251026_m050252_c001_v7007000_t0000_u01761454972818") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f9887a_d20251026_m050248_c001_v0001150_t0059_u01761454968630") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f98876_d20251026_m050244_c001_v7007000_t0000_u01761454964306") 2025/10/26 05:05:24 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d260_d20251026_m050239_c001_v0001115_t0031_u01761454959992") 2025/10/26 05:05:25 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d25f_d20251026_m050239_c001_v7007000_t0000_u01761454959809") 2025/10/26 05:05:25 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98869_d20251026_m050236_c001_v0001099_t0029_u01761454956417") 2025/10/26 05:05:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f98867_d20251026_m050235_c001_v7007000_t0000_u01761454955984") 2025/10/26 05:05:25 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d25b_d20251026_m050232_c001_v0001184_t0040_u01761454952401") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d245_d20251026_m050206_c001_v7007000_t0000_u01761454926465") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f215ef40f70f18066_d20251026_m050202_c001_v0001130_t0052_u01761454922472") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f415ef40f70f18058_d20251026_m050202_c001_v7007000_t0000_u01761454922090") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d240_d20251026_m050158_c001_v0001184_t0038_u01761454918005") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d23f_d20251026_m050157_c001_v7007000_t0000_u01761454917820") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d22b_d20251026_m050153_c001_v0001179_t0029_u01761454913966") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d22a_d20251026_m050153_c001_v7007000_t0000_u01761454913590") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d228_d20251026_m050149_c001_v0001104_t0026_u01761454909194") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d227_d20251026_m050149_c001_v7007000_t0000_u01761454909010") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f223f3964a67ba8cf_d20251026_m050145_c001_v0001093_t0039_u01761454905448") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f423f3964a67ba8ce_d20251026_m050145_c001_v7007000_t0000_u01761454905071") 2025/10/26 05:05:25 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f2190ef62bee178cb_d20251026_m050139_c001_v0001098_t0052_u01761454899689") 2025/10/26 05:05:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405638df903db572_d20251026_m050326_c001_v7007000_t0000_u01761455006407") 2025/10/26 05:05:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98969_d20251026_m050321_c001_v0001117_t0023_u01761455001342") 2025/10/26 05:05:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f98939_d20251026_m050315_c001_v7007000_t0000_u01761454995738") 2025/10/26 05:05:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f98916_d20251026_m050311_c001_v0001157_t0050_u01761454991311") 2025/10/26 05:05:25 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f98966_d20251026_m050320_c001_v7007000_t0000_u01761455000840") 2025/10/26 05:05:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f9893a_d20251026_m050315_c001_v0001093_t0013_u01761454995934") 2025/10/26 05:05:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f98914_d20251026_m050310_c001_v7007000_t0000_u01761454990824") 2025/10/26 05:05:26 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f988e5_d20251026_m050306_c001_v0001120_t0016_u01761454986295") 2025/10/26 05:05:26 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f408d91f059f988e4_d20251026_m050306_c001_v7007000_t0000_u01761454986111") 2025/10/26 05:05:26 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f218e418520d36953_d20251026_m050302_c001_v0001134_t0007_u01761454982273") 2025/10/26 05:05:26 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f418e418520d3694b_d20251026_m050301_c001_v7007000_t0000_u01761454981777") 2025/10/26 05:05:26 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f208d91f059f988b3_d20251026_m050257_c001_v0001134_t0011_u01761454977381") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41308852a45bd97a_d20251026_m050356_c001_v7007000_t0000_u01761455036093") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f215e79b3fd859f41_d20251026_m050351_c001_v0001040_t0021_u01761455031031") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f415e79b3fd859f3f_d20251026_m050350_c001_v7007000_t0000_u01761455030525") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205638df903db6f1_d20251026_m050345_c001_v0001171_t0024_u01761455025582") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405638df903db6ee_d20251026_m050345_c001_v7007000_t0000_u01761455025398") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205638df903db6c0_d20251026_m050340_c001_v0001029_t0012_u01761455020451") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405638df903db6b4_d20251026_m050339_c001_v7007000_t0000_u01761455019954") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205638df903db680_d20251026_m050335_c001_v0001145_t0009_u01761455015036") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405638df903db67d_d20251026_m050334_c001_v7007000_t0000_u01761455014853") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f2211a8d8969339c9_d20251026_m050331_c001_v0001161_t0023_u01761455011119") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f4211a8d8969339c8_d20251026_m050330_c001_v7007000_t0000_u01761455010637") 2025/10/26 05:05:26 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205638df903db573_d20251026_m050326_c001_v0001113_t0009_u01761455006591") 2025/10/26 05:05:26 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f4190ef62bee17e9a_d20251026_m050519_c001_v7007000_t0000_u01761455119153") 2025/10/26 05:05:26 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f205135ade5e7d30e_d20251026_m050513_c001_v0001099_t0028_u01761455113164") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d30d_d20251026_m050512_c001_v7007000_t0000_u01761455112507") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f21448d3fddc8109d_d20251026_m050444_c001_v0001042_t0049_u01761455084368") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc8108d_d20251026_m050443_c001_v7007000_t0000_u01761455083738") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f21448d3fddc81064_d20251026_m050438_c001_v0001171_t0034_u01761455078558") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc81061_d20251026_m050437_c001_v7007000_t0000_u01761455077911") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a4113e_d20251026_m050434_c001_v0001040_t0006_u01761455074014") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc81057_d20251026_m050433_c001_v7007000_t0000_u01761455073581") 2025/10/26 05:05:27 DEBUG : chunked-copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a4112e_d20251026_m050430_c001_v0001040_t0028_u01761455070242") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f4190ef62bee17e99_d20251026_m050518_c001_v7007000_t0000_u01761455118969") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f217c043bd45dc78c_d20251026_m050516_c001_v0001115_t0039_u01761455116734") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f405135ade5e7d30c_d20251026_m050512_c001_v7007000_t0000_u01761455112320") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f217c043bd45dc754_d20251026_m050509_c001_v0001176_t0008_u01761455109181") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc81088_d20251026_m050443_c001_v7007000_t0000_u01761455083557") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f217c043bd45dc6d0_d20251026_m050441_c001_v0001182_t0005_u01761455081995") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc8105f_d20251026_m050437_c001_v7007000_t0000_u01761455077730") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f21448d3fddc8105d_d20251026_m050435_c001_v0001137_t0054_u01761455075694") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f41448d3fddc81056_d20251026_m050433_c001_v7007000_t0000_u01761455073399") 2025/10/26 05:05:27 DEBUG : chunked-copy.copy: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f113796b5a0e5a747_d20251026_m050432_c001_v0001137_t0058_u01761455072377") 2025/10/26 05:05:27 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f10604929f0a2b35e_d20251026_m050018_c001_v0001161_t0005_u01761454818598") 2025/10/26 05:05:27 DEBUG : unknown-size-put.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f4190ef62bee17eab_d20251026_m050520_c001_v7007000_t0000_u01761455120302") 2025/10/26 05:05:28 DEBUG : unknown-size-put.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a411d6_d20251026_m050519_c001_v0001040_t0048_u01761455119709") 2025/10/26 05:05:28 DEBUG : unknown-size-update.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f4190ef62bee17ec5_d20251026_m050521_c001_v7007000_t0000_u01761455121636") 2025/10/26 05:05:28 DEBUG : unknown-size-update.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a411dc_d20251026_m050521_c001_v0001040_t0048_u01761455121291") 2025/10/26 05:05:28 DEBUG : unknown-size-update.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f1163de4083a411da_d20251026_m050520_c001_v0001040_t0024_u01761455120488") 2025/10/26 05:05:28 DEBUG : versions/test-versions.txt: Deleting (id "4_zbf02fdc3e02d1beb9fa80e1b_f4190ef62bee17898_d20251026_m050136_c001_v7007000_t0000_u01761454896005") 2025/10/26 05:05:29 INFO : B2 bucket rclone-test-qujepub5goga: cleaning bucket "rclone-test-qujepub5goga" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (348.20s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.54s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.39s) --- PASS: TestIntegration/FsMkdir (345.99s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.53s) --- 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.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding (23.57s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (2.55s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (1.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (1.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.13s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.08s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.40s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (1.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.13s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (1.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.44s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.07s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.06s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.41s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.05s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.20s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.19s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (6.63s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (82.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.96s) --- 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.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.36s) --- 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.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.40s) --- 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.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.71s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (1.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.44s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.55s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (2.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (1.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (31.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (6.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (21.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (3.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject (0.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.75s) --- 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.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (169.94s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (26.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.51s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.94s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.23s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (8.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.37s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (25.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (8.11s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.96s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (9.12s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.34s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (8.53s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.23s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (24.98s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (7.59s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (3.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (8.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.32s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (29.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.91s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.34s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (9.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (4.93s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (10.65s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.56s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (29.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (8.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.55s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.44s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (10.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (33.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (10.36s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (5.05s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (11.23s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.61s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (11.77s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (6.19s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (49.71s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.14s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (4.33s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (5.83s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (28.77s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (6.65s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (2.48s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.15s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.33s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.27s) --- 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 348.231s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 5m49.422297259s (try 1/5)