"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/28 04:23:55 NOTICE: TestB2: Stopped server 2025/10/28 04:23:55 NOTICE: TestB2: Starting server 2025/10/28 04:23:55 DEBUG : Creating backend with remote "TestB2:rclone-test-wucuxek6hare" 2025/10/28 04:23:55 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/28 04:23:58 INFO : dir/subdir: Making directory fstest.go:250: Filtering empty directory "dir" fstest.go:250: Filtering empty directory "dir/subdir" 2025/10/28 04:23:58 INFO : dir/subdir: Removing directory fstest.go:250: Filtering empty directory "dir" 2025/10/28 04:23:58 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/28 04:24:28 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/28 04:24:28 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/10/28 04:24:31 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/10/28 04:24:31 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/10/28 04:24:31 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/10/28 04:24:31 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/10/28 04:24:31 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/10/28 04:24:31 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/28 04:24:39 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/10/28 04:24:40 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/28 04:24:45 INFO : B2 bucket rclone-test-wucuxek6hare: cleaning bucket "rclone-test-wucuxek6hare" of all files 2025/10/28 04:24:46 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697375c_d20251028_m042444_c001_v0001116_t0009_u01761625484727") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/10/28 04:24:47 DEBUG : Creating backend with remote "TestB2:rclone-test-wucuxek6hare/dirToPurgeFromRoot" 2025/10/28 04:24:48 INFO : B2 bucket rclone-test-wucuxek6hare path dirToPurgeFromRoot: cleaning bucket "rclone-test-wucuxek6hare" of all files 2025/10/28 04:24:49 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973766_d20251028_m042446_c001_v0001116_t0000_u01761625486576") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/28 04:24:49 DEBUG : Creating backend with remote "TestB2:rclone-test-wucuxek6hare/hello? sausage/êé" 2025/10/28 04:24:49 DEBUG : Config file has changed externally - reloading 2025/10/28 04:24:54 INFO : B2 bucket rclone-test-wucuxek6hare path hello? sausage/êé: cleaning bucket "rclone-test-wucuxek6hare" of all files 2025/10/28 04:24:54 DEBUG : a/b/c/d/e.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f112e5df9717d69a2_d20251028_m042451_c001_v0001029_t0017_u01761625491977") === 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/28 04:25:03 DEBUG : Creating backend with remote "TestB2:rclone-test-wucuxek6hare/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/28 04:25:05 DEBUG : Creating backend with remote "TestB2:rclone-test-wucuxek6hare/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-wucuxek6hare" from "TestB2:rclone-test-wucuxek6hare" 2025/10/28 04:25:07 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/28 04:25:18 DEBUG : Creating backend with remote "TestB2:rclone-test-keyixak4leqi" 2025/10/28 04:25:21 DEBUG : B2 bucket rclone-test-keyixak4leqi: Purge remote 2025/10/28 04:25:21 INFO : B2 bucket rclone-test-keyixak4leqi: cleaning bucket "rclone-test-keyixak4leqi" of all files 2025/10/28 04:25:21 DEBUG : somefile: Deleting (id "4_z8f423d63100d2b9b9fa80e1b_f406f388c3afb20f6_d20251028_m042520_c001_v0001177_t0012_u01761625520708") === 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/28 04:25:23 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/28 04:25:24 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/28 04:25:27 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.105Mi 2025/10/28 04:25:27 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/10/28 04:25:27 DEBUG : test-metadata: multipart upload: starting chunk 1 size 107.973Ki offset 6Mi/6.105Mi 2025/10/28 04:25:27 DEBUG : test-metadata: Sending chunk 1 length 110564 2025/10/28 04:25:29 DEBUG : test-metadata: Done sending chunk 1 2025/10/28 04:25:30 DEBUG : test-metadata: Done sending chunk 0 2025/10/28 04:25:30 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/28 04:25:40 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1116-10.backblaze.com/b2api/v1/b2_upload_file/8f42fd7300ed2b9b9fa80e1b/c001_v0001116_t0039": EOF 2025/10/28 04:25:40 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1116-10.backblaze.com/b2api/v1/b2_upload_file/8f42fd7300ed2b9b9fa80e1b/c001_v0001116_t0039": EOF) 2025/10/28 04:25:40 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1116-10.backblaze.com/b2api/v1/b2_upload_file/8f42fd7300ed2b9b9fa80e1b/c001_v0001116_t0039": EOF - low level retry 1/10 2025/10/28 04:25:42 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-28-042534-928.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/28 04:25:45 DEBUG : oldPath = "TestB2:rclone-test-wucuxek6hare/versions/test-versions-v2025-10-28-042534-928.txt" 2025/10/28 04:25:45 DEBUG : newPath = "TestB2,versions:rclone-test-wucuxek6hare/versions/test-versions-v2025-10-28-042534-928.txt" 2025/10/28 04:25:45 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-wucuxek6hare/versions/test-versions-v2025-10-28-042534-928.txt" 2025/10/28 04:25:45 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/10/28 04:25:46 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-wucuxek6hare/versions/test-versions-v2025-10-28-042534-928.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-wucuxek6hare/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/28 04:25:49 INFO : B2 bucket rclone-test-wucuxek6hare: cleaning bucket "rclone-test-wucuxek6hare" of all hidden files 2025/10/28 04:25:49 DEBUG : leading space/ leading space: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b61b_d20251028_m042407_c001_v7007000_t0000_u01761625447633") as it is a hide marker 2025/10/28 04:25:49 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : leading space/ leading space: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973695_d20251028_m042406_c001_v0001116_t0030_u01761625446742") 2025/10/28 04:25:49 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b616_d20251028_m042406_c001_v7007000_t0000_u01761625446374") as it is a hide marker 2025/10/28 04:25:49 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973686_d20251028_m042405_c001_v0001116_t0022_u01761625445181") 2025/10/28 04:25:49 NOTICE: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b63e_d20251028_m042415_c001_v7007000_t0000_u01761625455588") as it is a hide marker 2025/10/28 04:25:49 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736c2_d20251028_m042414_c001_v0001116_t0031_u01761625454541") 2025/10/28 04:25:49 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : created from root.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f4036d880aac27ef6_d20251028_m042514_c001_v7007000_t0000_u01761625514818") as it is a hide marker 2025/10/28 04:25:49 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : created from root.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f105e5f5689e86589_d20251028_m042513_c001_v0001106_t0008_u01761625513561") 2025/10/28 04:25:49 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : file name.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6f0_d20251028_m042522_c001_v7007000_t0000_u01761625522858") as it is a hide marker 2025/10/28 04:25:49 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697379f_d20251028_m042502_c001_v0001116_t0049_u01761625502327") 2025/10/28 04:25:49 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f1118186f5cce6999_d20251028_m042458_c001_v0001032_t0048_u01761625498665") 2025/10/28 04:25:49 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973739_d20251028_m042436_c001_v0001116_t0054_u01761625476508") 2025/10/28 04:25:49 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697372a_d20251028_m042434_c001_v0001116_t0032_u01761625474787") 2025/10/28 04:25:49 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973732_d20251028_m042435_c001_v0001116_t0039_u01761625475433") "upload" dated 2025-10-28 04:24:35.433 +0000 UTC (1m14.338638481s ago) 2025/10/28 04:25:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f4073ea3d8fe2246c_d20251028_m042456_c001_v7007000_t0000_u01761625496445") as it is a hide marker 2025/10/28 04:25:49 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f10452c3505bd9eba_d20251028_m042456_c001_v0001179_t0033_u01761625496235") 2025/10/28 04:25:49 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f106395d54d551787_d20251028_m042455_c001_v0001136_t0007_u01761625495399") 2025/10/28 04:25:49 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b667_d20251028_m042425_c001_v7007000_t0000_u01761625465190") as it is a hide marker 2025/10/28 04:25:49 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736f0_d20251028_m042424_c001_v0001116_t0030_u01761625464295") 2025/10/28 04:25:49 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : piped data.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6f5_d20251028_m042524_c001_v7007000_t0000_u01761625524865") as it is a hide marker 2025/10/28 04:25:49 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : piped data.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69737e4_d20251028_m042524_c001_v0001116_t0029_u01761625524157") 2025/10/28 04:25:49 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : piped data.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6f3_d20251028_m042523_c001_v7007000_t0000_u01761625523968") 2025/10/28 04:25:49 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : piped data.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f410891ecc69737dd_d20251028_m042523_c001_v0001116_t0039_u01761625523606") 2025/10/28 04:25:49 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b66a_d20251028_m042426_c001_v7007000_t0000_u01761625466588") as it is a hide marker 2025/10/28 04:25:49 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736fc_d20251028_m042425_c001_v0001116_t0000_u01761625465555") 2025/10/28 04:25:49 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : test-metadata: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f411eabb0cdc41e21_d20251028_m042532_c001_v7007000_t0000_u01761625532386") as it is a hide marker 2025/10/28 04:25:49 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : test-metadata: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f201886b19728b6ff_d20251028_m042527_c001_v0001117_t0030_u01761625527083") 2025/10/28 04:25:49 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : test-metadata: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6fc_d20251028_m042526_c001_v7007000_t0000_u01761625526137") 2025/10/28 04:25:49 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : test-metadata: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69737ed_d20251028_m042525_c001_v0001116_t0024_u01761625525057") 2025/10/28 04:25:49 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b649_d20251028_m042418_c001_v7007000_t0000_u01761625458352") as it is a hide marker 2025/10/28 04:25:49 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736d6_d20251028_m042417_c001_v0001116_t0046_u01761625457545") 2025/10/28 04:25:49 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b656_d20251028_m042421_c001_v7007000_t0000_u01761625461285") as it is a hide marker 2025/10/28 04:25:49 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736e2_d20251028_m042419_c001_v0001116_t0054_u01761625459979") 2025/10/28 04:25:49 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b650_d20251028_m042419_c001_v7007000_t0000_u01761625459614") as it is a hide marker 2025/10/28 04:25:49 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736dc_d20251028_m042418_c001_v0001116_t0036_u01761625458716") 2025/10/28 04:25:49 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b65e_d20251028_m042422_c001_v7007000_t0000_u01761625462567") as it is a hide marker 2025/10/28 04:25:49 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736e6_d20251028_m042421_c001_v0001116_t0002_u01761625461649") 2025/10/28 04:25:49 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b663_d20251028_m042423_c001_v7007000_t0000_u01761625463930") as it is a hide marker 2025/10/28 04:25:49 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736ec_d20251028_m042422_c001_v0001116_t0006_u01761625462979") 2025/10/28 04:25:49 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing space /trailing space : Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b643_d20251028_m042417_c001_v7007000_t0000_u01761625457182") as it is a hide marker 2025/10/28 04:25:49 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : trailing space /trailing space : Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736cc_d20251028_m042415_c001_v0001116_t0036_u01761625455952") 2025/10/28 04:25:49 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396ec1b_d20251028_m042543_c001_v0001183_t0050_u01761625543448") "upload" dated 2025-10-28 04:25:43.448 +0000 UTC (6.323978109s ago) 2025/10/28 04:25:49 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f417489b595d1fee2_d20251028_m042538_c001_v7007000_t0000_u01761625538636") 2025/10/28 04:25:49 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973806_d20251028_m042534_c001_v0001116_t0055_u01761625534928") 2025/10/28 04:25:49 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b681_d20251028_m042434_c001_v7007000_t0000_u01761625474241") as it is a hide marker 2025/10/28 04:25:49 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f201886b19728b674_d20251028_m042428_c001_v0001177_t0042_u01761625468755") 2025/10/28 04:25:49 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : zero-length-file: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b673_d20251028_m042428_c001_v7007000_t0000_u01761625468453") as it is a hide marker 2025/10/28 04:25:49 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : zero-length-file: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f410891ecc697370c_d20251028_m042427_c001_v0001116_t0039_u01761625467905") 2025/10/28 04:25:49 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b620_d20251028_m042408_c001_v7007000_t0000_u01761625448867") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697369d_d20251028_m042407_c001_v0001116_t0019_u01761625447997") 2025/10/28 04:25:49 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b60e_d20251028_m042402_c001_v7007000_t0000_u01761625442242") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697366e_d20251028_m042400_c001_v0001116_t0019_u01761625440907") 2025/10/28 04:25:49 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b634_d20251028_m042412_c001_v7007000_t0000_u01761625452946") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736b6_d20251028_m042412_c001_v0001116_t0049_u01761625452118") 2025/10/28 04:25:49 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b62d_d20251028_m042411_c001_v7007000_t0000_u01761625451753") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736ae_d20251028_m042410_c001_v0001116_t0003_u01761625450487") 2025/10/28 04:25:49 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b638_d20251028_m042414_c001_v7007000_t0000_u01761625454179") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736c0_d20251028_m042413_c001_v0001116_t0018_u01761625453310") 2025/10/28 04:25:49 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b626_d20251028_m042410_c001_v7007000_t0000_u01761625450124") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736a5_d20251028_m042409_c001_v0001116_t0004_u01761625449231") 2025/10/28 04:25:49 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ./.: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b60f_d20251028_m042403_c001_v7007000_t0000_u01761625443439") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ./.: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ./.: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973676_d20251028_m042402_c001_v0001116_t0010_u01761625442607") 2025/10/28 04:25:49 NOTICE: ./.: Skipped delete as --dry-run is set 2025/10/28 04:25:49 DEBUG : ../..: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b611_d20251028_m042404_c001_v7007000_t0000_u01761625444819") as it is a hide marker 2025/10/28 04:25:49 NOTICE: ../..: Skipped remove hide marker as --dry-run is set 2025/10/28 04:25:49 DEBUG : ../..: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697367c_d20251028_m042403_c001_v0001116_t0021_u01761625443802") 2025/10/28 04:25:49 NOTICE: ../..: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/10/28 04:25:49 INFO : B2 bucket rclone-test-wucuxek6hare: cleaning bucket "rclone-test-wucuxek6hare" of all hidden files 2025/10/28 04:25:50 DEBUG : leading space/ leading space: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b61b_d20251028_m042407_c001_v7007000_t0000_u01761625447633") as it is a hide marker 2025/10/28 04:25:50 DEBUG : leading space/ leading space: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973695_d20251028_m042406_c001_v0001116_t0030_u01761625446742") 2025/10/28 04:25:50 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b616_d20251028_m042406_c001_v7007000_t0000_u01761625446374") as it is a hide marker 2025/10/28 04:25:50 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973686_d20251028_m042405_c001_v0001116_t0022_u01761625445181") 2025/10/28 04:25:50 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b63e_d20251028_m042415_c001_v7007000_t0000_u01761625455588") as it is a hide marker 2025/10/28 04:25:50 DEBUG : .leading dot/.leading dot: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736c2_d20251028_m042414_c001_v0001116_t0031_u01761625454541") 2025/10/28 04:25:50 DEBUG : created from root.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f4036d880aac27ef6_d20251028_m042514_c001_v7007000_t0000_u01761625514818") as it is a hide marker 2025/10/28 04:25:50 DEBUG : created from root.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f105e5f5689e86589_d20251028_m042513_c001_v0001106_t0008_u01761625513561") 2025/10/28 04:25:50 DEBUG : file name.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6f0_d20251028_m042522_c001_v7007000_t0000_u01761625522858") as it is a hide marker 2025/10/28 04:25:50 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697379f_d20251028_m042502_c001_v0001116_t0049_u01761625502327") 2025/10/28 04:25:50 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f1118186f5cce6999_d20251028_m042458_c001_v0001032_t0048_u01761625498665") 2025/10/28 04:25:50 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973739_d20251028_m042436_c001_v0001116_t0054_u01761625476508") 2025/10/28 04:25:50 DEBUG : file name.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697372a_d20251028_m042434_c001_v0001116_t0032_u01761625474787") 2025/10/28 04:25:50 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973732_d20251028_m042435_c001_v0001116_t0039_u01761625475433") "upload" dated 2025-10-28 04:24:35.433 +0000 UTC (1m15.371219899s ago) 2025/10/28 04:25:50 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f4073ea3d8fe2246c_d20251028_m042456_c001_v7007000_t0000_u01761625496445") as it is a hide marker 2025/10/28 04:25:50 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f10452c3505bd9eba_d20251028_m042456_c001_v0001179_t0033_u01761625496235") 2025/10/28 04:25:50 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f106395d54d551787_d20251028_m042455_c001_v0001136_t0007_u01761625495399") 2025/10/28 04:25:50 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b667_d20251028_m042425_c001_v7007000_t0000_u01761625465190") as it is a hide marker 2025/10/28 04:25:51 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736f0_d20251028_m042424_c001_v0001116_t0030_u01761625464295") 2025/10/28 04:25:51 DEBUG : piped data.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6f5_d20251028_m042524_c001_v7007000_t0000_u01761625524865") as it is a hide marker 2025/10/28 04:25:51 DEBUG : piped data.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69737e4_d20251028_m042524_c001_v0001116_t0029_u01761625524157") 2025/10/28 04:25:51 DEBUG : piped data.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6f3_d20251028_m042523_c001_v7007000_t0000_u01761625523968") 2025/10/28 04:25:51 DEBUG : piped data.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f410891ecc69737dd_d20251028_m042523_c001_v0001116_t0039_u01761625523606") 2025/10/28 04:25:51 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b66a_d20251028_m042426_c001_v7007000_t0000_u01761625466588") as it is a hide marker 2025/10/28 04:25:51 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736fc_d20251028_m042425_c001_v0001116_t0000_u01761625465555") 2025/10/28 04:25:51 DEBUG : test-metadata: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f411eabb0cdc41e21_d20251028_m042532_c001_v7007000_t0000_u01761625532386") as it is a hide marker 2025/10/28 04:25:51 DEBUG : test-metadata: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f201886b19728b6ff_d20251028_m042527_c001_v0001117_t0030_u01761625527083") 2025/10/28 04:25:51 DEBUG : test-metadata: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b6fc_d20251028_m042526_c001_v7007000_t0000_u01761625526137") 2025/10/28 04:25:51 DEBUG : test-metadata: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69737ed_d20251028_m042525_c001_v0001116_t0024_u01761625525057") 2025/10/28 04:25:51 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b649_d20251028_m042418_c001_v7007000_t0000_u01761625458352") as it is a hide marker 2025/10/28 04:25:51 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736d6_d20251028_m042417_c001_v0001116_t0046_u01761625457545") 2025/10/28 04:25:51 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b656_d20251028_m042421_c001_v7007000_t0000_u01761625461285") as it is a hide marker 2025/10/28 04:25:51 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736e2_d20251028_m042419_c001_v0001116_t0054_u01761625459979") 2025/10/28 04:25:51 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b650_d20251028_m042419_c001_v7007000_t0000_u01761625459614") as it is a hide marker 2025/10/28 04:25:51 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736dc_d20251028_m042418_c001_v0001116_t0036_u01761625458716") 2025/10/28 04:25:51 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b65e_d20251028_m042422_c001_v7007000_t0000_u01761625462567") as it is a hide marker 2025/10/28 04:25:51 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736e6_d20251028_m042421_c001_v0001116_t0002_u01761625461649") 2025/10/28 04:25:51 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b663_d20251028_m042423_c001_v7007000_t0000_u01761625463930") as it is a hide marker 2025/10/28 04:25:51 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736ec_d20251028_m042422_c001_v0001116_t0006_u01761625462979") 2025/10/28 04:25:51 DEBUG : trailing space /trailing space : Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b643_d20251028_m042417_c001_v7007000_t0000_u01761625457182") as it is a hide marker 2025/10/28 04:25:52 DEBUG : trailing space /trailing space : Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736cc_d20251028_m042415_c001_v0001116_t0036_u01761625455952") 2025/10/28 04:25:52 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396ec1b_d20251028_m042543_c001_v0001183_t0050_u01761625543448") "upload" dated 2025-10-28 04:25:43.448 +0000 UTC (8.658487775s ago) 2025/10/28 04:25:52 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f417489b595d1fee2_d20251028_m042538_c001_v7007000_t0000_u01761625538636") 2025/10/28 04:25:52 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973806_d20251028_m042534_c001_v0001116_t0055_u01761625534928") 2025/10/28 04:25:52 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b681_d20251028_m042434_c001_v7007000_t0000_u01761625474241") as it is a hide marker 2025/10/28 04:25:52 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f201886b19728b674_d20251028_m042428_c001_v0001177_t0042_u01761625468755") 2025/10/28 04:25:52 DEBUG : zero-length-file: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b673_d20251028_m042428_c001_v7007000_t0000_u01761625468453") as it is a hide marker 2025/10/28 04:25:52 DEBUG : zero-length-file: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f410891ecc697370c_d20251028_m042427_c001_v0001116_t0039_u01761625467905") 2025/10/28 04:25:52 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b620_d20251028_m042408_c001_v7007000_t0000_u01761625448867") as it is a hide marker 2025/10/28 04:25:52 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697369d_d20251028_m042407_c001_v0001116_t0019_u01761625447997") 2025/10/28 04:25:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b60e_d20251028_m042402_c001_v7007000_t0000_u01761625442242") as it is a hide marker 2025/10/28 04:25:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697366e_d20251028_m042400_c001_v0001116_t0019_u01761625440907") 2025/10/28 04:25:52 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b634_d20251028_m042412_c001_v7007000_t0000_u01761625452946") as it is a hide marker 2025/10/28 04:25:52 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736b6_d20251028_m042412_c001_v0001116_t0049_u01761625452118") 2025/10/28 04:25:52 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b62d_d20251028_m042411_c001_v7007000_t0000_u01761625451753") as it is a hide marker 2025/10/28 04:25:52 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736ae_d20251028_m042410_c001_v0001116_t0003_u01761625450487") 2025/10/28 04:25:52 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b638_d20251028_m042414_c001_v7007000_t0000_u01761625454179") as it is a hide marker 2025/10/28 04:25:52 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736c0_d20251028_m042413_c001_v0001116_t0018_u01761625453310") 2025/10/28 04:25:52 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b626_d20251028_m042410_c001_v7007000_t0000_u01761625450124") as it is a hide marker 2025/10/28 04:25:52 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc69736a5_d20251028_m042409_c001_v0001116_t0004_u01761625449231") 2025/10/28 04:25:52 DEBUG : ./.: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b60f_d20251028_m042403_c001_v7007000_t0000_u01761625443439") as it is a hide marker 2025/10/28 04:25:53 DEBUG : ./.: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973676_d20251028_m042402_c001_v0001116_t0010_u01761625442607") 2025/10/28 04:25:53 DEBUG : ../..: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f401886b19728b611_d20251028_m042404_c001_v7007000_t0000_u01761625444819") as it is a hide marker 2025/10/28 04:25:53 DEBUG : ../..: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc697367c_d20251028_m042403_c001_v0001116_t0021_u01761625443802") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/10/28 04:25:53 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/28 04:25:54 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/28 04:25:54 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/28 04:25:54 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/28 04:25:54 INFO : B2 bucket rclone-test-wucuxek6hare: cleaning bucket "rclone-test-wucuxek6hare" of pending multipart uploads older than 0s 2025/10/28 04:25:55 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973732_d20251028_m042435_c001_v0001116_t0039_u01761625475433") "upload" dated 2025-10-28 04:24:35.433 +0000 UTC (1m19.663756313s ago) 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d4369_d20251028_m042553_c001_v0001157_t0004_u01761625553968") as it is a start marker (upload started at 2025-10-28 04:25:53.968 +0000 UTC) 2025/10/28 04:25:55 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d436a_d20251028_m042554_c001_v0001098_t0054_u01761625554152") as it is a start marker (upload started at 2025-10-28 04:25:54.152 +0000 UTC) 2025/10/28 04:25:55 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d436b_d20251028_m042554_c001_v0001146_t0004_u01761625554442") as it is a start marker (upload started at 2025-10-28 04:25:54.442 +0000 UTC) 2025/10/28 04:25:55 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d436d_d20251028_m042554_c001_v0001176_t0012_u01761625554629") as it is a start marker (upload started at 2025-10-28 04:25:54.629 +0000 UTC) 2025/10/28 04:25:55 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/10/28 04:25:55 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f416dece3f62d4368_d20251028_m042553_c001_v7007000_t0000_u01761625553785") "hide" dated 2025-10-28 04:25:53.785 +0000 UTC (1.312315404s ago) 2025/10/28 04:25:55 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396ec1b_d20251028_m042543_c001_v0001183_t0050_u01761625543448") 2025/10/28 04:25:55 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/10/28 04:25:55 INFO : B2 bucket rclone-test-wucuxek6hare: cleaning bucket "rclone-test-wucuxek6hare" of pending multipart uploads older than 0s 2025/10/28 04:25:55 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973732_d20251028_m042435_c001_v0001116_t0039_u01761625475433") "upload" dated 2025-10-28 04:24:35.433 +0000 UTC (1m20.032336103s ago) 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d4369_d20251028_m042553_c001_v0001157_t0004_u01761625553968") as it is a start marker (upload started at 2025-10-28 04:25:53.968 +0000 UTC) 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d436a_d20251028_m042554_c001_v0001098_t0054_u01761625554152") as it is a start marker (upload started at 2025-10-28 04:25:54.152 +0000 UTC) 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d436b_d20251028_m042554_c001_v0001146_t0004_u01761625554442") as it is a start marker (upload started at 2025-10-28 04:25:54.442 +0000 UTC) 2025/10/28 04:25:55 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d436d_d20251028_m042554_c001_v0001176_t0012_u01761625554629") as it is a start marker (upload started at 2025-10-28 04:25:54.629 +0000 UTC) 2025/10/28 04:25:55 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z8f42fd7300ed2b9b9fa80e1b_f416dece3f62d4368_d20251028_m042553_c001_v7007000_t0000_u01761625553785") "hide" dated 2025-10-28 04:25:53.785 +0000 UTC (1.680483902s ago) 2025/10/28 04:25:55 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396ec1b_d20251028_m042543_c001_v0001183_t0050_u01761625543448") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/10/28 04:25:56 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/10/28 04:25:56 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/10/28 04:25:56 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/28 04:25:57 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/10/28 04:25:57 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/10/28 04:25:57 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/10/28 04:25:57 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/10/28 04:25:58 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/10/28 04:26:00 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/10/28 04:26:00 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/10/28 04:26:03 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:26:03 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/28 04:26:03 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4903_d20251028_m042603_c001_v0001101_t0054_u01761625563195") 2025/10/28 04:26:03 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:26:03 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/28 04:26:03 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/28 04:26:04 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:26:05 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:26:05 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/10/28 04:26:07 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/10/28 04:26:07 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/10/28 04:26:07 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/10/28 04:26:07 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/10/28 04:26:09 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/10/28 04:26:09 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/10/28 04:26:09 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/10/28 04:26:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:26:11 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/28 04:26:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4917_d20251028_m042611_c001_v0001146_t0029_u01761625571499") 2025/10/28 04:26:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/28 04:26:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/28 04:26:11 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/10/28 04:26:14 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:26:14 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:26:14 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/10/28 04:26:16 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/10/28 04:26:16 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/10/28 04:26:16 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/10/28 04:26:16 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/10/28 04:26:16 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/10/28 04:26:16 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/10/28 04:26:17 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/10/28 04:26:18 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/10/28 04:26:19 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/10/28 04:26:19 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/10/28 04:26:20 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:26:20 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/28 04:26:20 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2205eaf028626644_d20251028_m042620_c001_v0001093_t0056_u01761625580715") 2025/10/28 04:26:20 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/10/28 04:26:21 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:26:21 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/28 04:26:21 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/10/28 04:26:21 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/10/28 04:26:23 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:26:23 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:26:23 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/28 04:26:25 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/10/28 04:26:25 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/10/28 04:26:25 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/10/28 04:26:25 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/10/28 04:26:26 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/10/28 04:26:28 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/10/28 04:26:28 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/10/28 04:26:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:26:29 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/28 04:26:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2205eaf028626667_d20251028_m042629_c001_v0001117_t0019_u01761625589708") 2025/10/28 04:26:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:26:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/10/28 04:26:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/28 04:26:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:26:32 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:26:32 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/10/28 04:26:33 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/10/28 04:26:33 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/10/28 04:26:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/10/28 04:26:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/10/28 04:26:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/10/28 04:26:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/10/28 04:26:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/10/28 04:26:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:26:38 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/28 04:26:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e499b_d20251028_m042638_c001_v0001093_t0029_u01761625598299") 2025/10/28 04:26:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/28 04:26:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/28 04:26:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/10/28 04:26:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:26:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:26:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/10/28 04:26:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/10/28 04:26:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/10/28 04:26:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/10/28 04:26:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/10/28 04:26:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/10/28 04:26:46 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/10/28 04:26:47 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/10/28 04:26:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/10/28 04:26:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/10/28 04:26:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/10/28 04:26:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:26:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2025/10/28 04:26:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e49bc_d20251028_m042650_c001_v0001180_t0001_u01761625610685") 2025/10/28 04:26:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/10/28 04:26:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:26:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/10/28 04:26:50 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/10/28 04:26:51 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/10/28 04:26:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:26:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:26:53 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/28 04:26:55 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/10/28 04:26:55 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/10/28 04:26:55 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/10/28 04:26:55 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/10/28 04:26:56 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/10/28 04:26:58 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/10/28 04:26:58 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/10/28 04:27:00 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:27:00 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/28 04:27:00 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e49e9_d20251028_m042700_c001_v0001106_t0007_u01761625620130") 2025/10/28 04:27:00 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:27:00 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/10/28 04:27:00 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/28 04:27:01 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:27:02 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:27:02 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/10/28 04:27:04 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/10/28 04:27:04 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/10/28 04:27:04 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/10/28 04:27:04 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/10/28 04:27:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/10/28 04:27:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/10/28 04:27:06 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/10/28 04:27:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:27:08 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/28 04:27:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4a05_d20251028_m042708_c001_v0001130_t0042_u01761625628296") 2025/10/28 04:27:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/28 04:27:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/28 04:27:08 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/10/28 04:27:10 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:27:11 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:27:11 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/10/28 04:27:13 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/10/28 04:27:13 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/10/28 04:27:13 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/10/28 04:27:13 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/10/28 04:27:13 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/10/28 04:27:13 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/10/28 04:27:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/10/28 04:27:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/10/28 04:27:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/10/28 04:27:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/10/28 04:27:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:27:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.055Mi allows uploads of up to 49.361Gi and will fail only when that limit is reached. 2025/10/28 04:27:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703d33_d20251028_m042717_c001_v0001179_t0055_u01761625637491") 2025/10/28 04:27:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/10/28 04:27:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:27:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/10/28 04:27:17 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/10/28 04:27:18 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/10/28 04:27:19 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:27:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:27:20 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/28 04:27:21 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/10/28 04:27:21 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/10/28 04:27:21 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/10/28 04:27:22 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/10/28 04:27:23 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/10/28 04:27:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/10/28 04:27:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/10/28 04:27:26 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:27:26 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/28 04:27:26 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703d52_d20251028_m042726_c001_v0001131_t0003_u01761625646277") 2025/10/28 04:27:26 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:27:26 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/10/28 04:27:26 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/28 04:27:27 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:27:29 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:27:29 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/10/28 04:27:30 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/10/28 04:27:30 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/10/28 04:27:31 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/10/28 04:27:31 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/10/28 04:27:33 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/10/28 04:27:33 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/10/28 04:27:33 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/10/28 04:27:35 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:27:35 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/28 04:27:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4aab_d20251028_m042735_c001_v0001101_t0008_u01761625655909") 2025/10/28 04:27:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/28 04:27:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/28 04:27:36 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/10/28 04:27:38 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:27:38 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:27:38 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/10/28 04:27:41 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/10/28 04:27:41 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/10/28 04:27:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/10/28 04:27:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/10/28 04:27:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/10/28 04:27:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/10/28 04:27:43 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/10/28 04:27:44 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/10/28 04:27:44 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/10/28 04:27:44 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/10/28 04:27:46 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:27:46 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/28 04:27:46 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f2036d880aac28119_d20251028_m042746_c001_v0001116_t0036_u01761625666593") 2025/10/28 04:27:46 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/10/28 04:27:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:27:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/10/28 04:27:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/10/28 04:27:48 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/10/28 04:27:49 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:27:49 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:27:49 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/28 04:27:52 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/10/28 04:27:52 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/10/28 04:27:52 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/10/28 04:27:52 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/10/28 04:27:53 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/10/28 04:27:55 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/10/28 04:27:55 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/10/28 04:27:57 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:27:57 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/28 04:27:57 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f212fb83cf45da794_d20251028_m042757_c001_v0001184_t0055_u01761625677199") 2025/10/28 04:27:57 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:27:57 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/28 04:27:57 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/28 04:27:57 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/10/28 04:27:57 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/28 04:27:57 DEBUG : pacer: Reducing sleep to 10ms 2025/10/28 04:27:58 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:27:59 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:27:59 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/10/28 04:28:01 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/10/28 04:28:01 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/10/28 04:28:01 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/10/28 04:28:01 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/10/28 04:28:04 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/10/28 04:28:05 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/10/28 04:28:05 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/10/28 04:28:07 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:28:07 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/28 04:28:07 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d44b4_d20251028_m042807_c001_v0001098_t0027_u01761625687300") 2025/10/28 04:28:07 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/28 04:28:07 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/28 04:28:07 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/10/28 04:28:10 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:28:10 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:28:10 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/10/28 04:28:12 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/10/28 04:28:12 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/10/28 04:28:13 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/10/28 04:28:13 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/10/28 04:28:13 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/10/28 04:28:13 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/10/28 04:28:13 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/10/28 04:28:15 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/10/28 04:28:15 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/10/28 04:28:15 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/10/28 04:28:17 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:28:17 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/28 04:28:17 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703e18_d20251028_m042817_c001_v0001183_t0014_u01761625697874") 2025/10/28 04:28:17 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/10/28 04:28:18 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:28:18 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/28 04:28:18 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/10/28 04:28:18 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/10/28 04:28:18 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/10/28 04:28:18 DEBUG : pacer: Reducing sleep to 10ms 2025/10/28 04:28:19 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/10/28 04:28:20 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:28:20 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:28:20 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/28 04:28:23 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/10/28 04:28:23 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/10/28 04:28:23 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/10/28 04:28:23 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/10/28 04:28:24 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/10/28 04:28:25 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/10/28 04:28:25 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/10/28 04:28:27 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:28:27 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/28 04:28:27 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703e66_d20251028_m042827_c001_v0001177_t0012_u01761625707876") 2025/10/28 04:28:27 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:28:27 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/10/28 04:28:27 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/28 04:28:28 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:28:30 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:28:30 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/10/28 04:28:32 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/10/28 04:28:32 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/10/28 04:28:32 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/10/28 04:28:32 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/10/28 04:28:35 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/10/28 04:28:35 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/10/28 04:28:35 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/10/28 04:28:38 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:28:38 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/28 04:28:38 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f223f3964a68d2b24_d20251028_m042838_c001_v0001178_t0032_u01761625718859") 2025/10/28 04:28:38 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/28 04:28:39 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/10/28 04:28:39 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/10/28 04:28:41 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:28:41 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:28:41 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/10/28 04:28:44 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/10/28 04:28:44 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/10/28 04:28:45 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/10/28 04:28:45 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/10/28 04:28:45 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/10/28 04:28:45 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/10/28 04:28:45 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/10/28 04:28:46 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/10/28 04:28:47 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/10/28 04:28:47 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/10/28 04:28:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/10/28 04:28:50 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/28 04:28:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_z8f42fd7300ed2b9b9fa80e1b_f212fb83cf45da800_d20251028_m042850_c001_v0001184_t0048_u01761625730280") 2025/10/28 04:28:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/10/28 04:28:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/10/28 04:28:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/10/28 04:28:50 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/10/28 04:28:51 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/10/28 04:28:52 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/10/28 04:28:53 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/10/28 04:28:53 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/28 04:29:01 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8f42fd7300ed2b9b9fa80e1b_f207238d1376098e8_d20251028_m042901_c001_v0001037_t0042_u01761625741531") 2025/10/28 04:29:01 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/10/28 04:29:01 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/28 04:29:02 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/28 04:29:02 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/28 04:29:02 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/10/28 04:29:04 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/10/28 04:29:04 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/28 04:29:04 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/10/28 04:29:04 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/10/28 04:29:07 DEBUG : chunked-copy: Done sending chunk 1 2025/10/28 04:29:07 DEBUG : chunked-copy: Done sending chunk 0 2025/10/28 04:29:07 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/28 04:29:08 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8f42fd7300ed2b9b9fa80e1b_f207238d137609903_d20251028_m042908_c001_v0001136_t0016_u01761625748077") 2025/10/28 04:29:08 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/10/28 04:29:08 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/28 04:29:08 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/28 04:29:08 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/28 04:29:08 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/10/28 04:29:10 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/10/28 04:29:10 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/28 04:29:11 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/10/28 04:29:11 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/10/28 04:29:13 DEBUG : chunked-copy: Done sending chunk 0 2025/10/28 04:29:13 DEBUG : chunked-copy: Done sending chunk 1 2025/10/28 04:29:13 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/28 04:29:14 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z8f42fd7300ed2b9b9fa80e1b_f218e418520e34f67_d20251028_m042914_c001_v0001137_t0025_u01761625754113") 2025/10/28 04:29:14 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/10/28 04:29:14 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/28 04:29:14 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/28 04:29:14 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/28 04:29:14 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/10/28 04:29:17 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/10/28 04:29:17 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/10/28 04:29:17 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/10/28 04:29:17 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/10/28 04:29:19 DEBUG : chunked-copy: Done sending chunk 0 2025/10/28 04:29:19 DEBUG : chunked-copy: Done sending chunk 1 2025/10/28 04:29:19 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/10/28 04:29:20 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_z8f42fd7300ed2b9b9fa80e1b_f207238d137609932_d20251028_m042920_c001_v0001100_t0036_u01761625760063") 2025/10/28 04:29:20 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/10/28 04:29:20 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/28 04:29:20 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/10/28 04:31:27 DEBUG : chunked-copy.copy: Error copying chunk 2 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0002f8120), retryAfter:1000000000} 2025/10/28 04:31:27 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/28 04:31:27 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/10/28 04:31:27 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/10/28 04:31:27 DEBUG : chunked-copy.copy: Error copying chunk 0 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc000284150), retryAfter:1000000000} 2025/10/28 04:31:27 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/28 04:31:27 DEBUG : chunked-copy.copy: Error copying chunk 1 (retry=true): no tomes available (503 service_unavailable): trying again in 1s: &pacer.retryAfterError{error:(*api.Error)(0xc0002f88a0), retryAfter:1000000000} 2025/10/28 04:31:27 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable): trying again in 1s) 2025/10/28 04:31:28 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/10/28 04:31:29 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/10/28 04:31:58 DEBUG : pacer: Reducing sleep to 500ms 2025/10/28 04:31:58 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/10/28 04:32:00 DEBUG : pacer: Reducing sleep to 250ms 2025/10/28 04:32:00 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/10/28 04:32:33 DEBUG : pacer: Reducing sleep to 125ms 2025/10/28 04:32:33 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/10/28 04:32:33 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts 2025/10/28 04:32:33 DEBUG : pacer: Reducing sleep to 62.5ms 2025/10/28 04:32:34 DEBUG : pacer: Reducing sleep to 31.25ms 2025/10/28 04:32:36 DEBUG : pacer: Reducing sleep to 15.625ms 2025/10/28 04:32:36 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/28 04:32:36 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/28 04:32:37 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/28 04:32:38 DEBUG : Creating backend with remote "TestB2:rclone-test-wucuxek6hare/deeper/nonexisting/directory" 2025/10/28 04:32:38 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/28 04:32:39 INFO : B2 bucket rclone-test-wucuxek6hare: cleaning bucket "rclone-test-wucuxek6hare" of all files 2025/10/28 04:32:39 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f423f3964a68d2b18_d20251028_m042831_c001_v7007000_t0000_u01761625711871") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703e66_d20251028_m042827_c001_v0001177_t0012_u01761625707876") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f417c043bd4703e62_d20251028_m042827_c001_v7007000_t0000_u01761625707063") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f223f3964a68d2b01_d20251028_m042822_c001_v0001184_t0029_u01761625702758") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f407238d1376098d0_d20251028_m042855_c001_v7007000_t0000_u01761625735497") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f212fb83cf45da800_d20251028_m042850_c001_v0001184_t0048_u01761625730280") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f412fb83cf45da7fe_d20251028_m042849_c001_v7007000_t0000_u01761625729625") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f223f3964a68d2b50_d20251028_m042844_c001_v0001178_t0044_u01761625724078") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f423f3964a68d2b4c_d20251028_m042843_c001_v7007000_t0000_u01761625723893") 2025/10/28 04:32:39 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f223f3964a68d2b24_d20251028_m042838_c001_v0001178_t0032_u01761625718859") 2025/10/28 04:32:40 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f423f3964a68d2b23_d20251028_m042838_c001_v7007000_t0000_u01761625718244") 2025/10/28 04:32:40 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f223f3964a68d2b19_d20251028_m042832_c001_v0001145_t0015_u01761625712060") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e49d3_d20251028_m042655_c001_v7007000_t0000_u01761625615155") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e49bc_d20251028_m042650_c001_v0001180_t0001_u01761625610685") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e49a9_d20251028_m042645_c001_v7007000_t0000_u01761625605911") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e499b_d20251028_m042638_c001_v0001093_t0029_u01761625598299") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e49b9_d20251028_m042650_c001_v7007000_t0000_u01761625610286") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e49ac_d20251028_m042646_c001_v0001161_t0004_u01761625606093") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e499a_d20251028_m042637_c001_v7007000_t0000_u01761625597875") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4991_d20251028_m042633_c001_v0001145_t0038_u01761625593637") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4990_d20251028_m042633_c001_v7007000_t0000_u01761625593456") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2205eaf028626667_d20251028_m042629_c001_v0001117_t0019_u01761625589708") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4205eaf028626664_d20251028_m042629_c001_v7007000_t0000_u01761625589313") 2025/10/28 04:32:40 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4987_d20251028_m042624_c001_v0001131_t0044_u01761625584980") 2025/10/28 04:32:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4a26_d20251028_m042721_c001_v7007000_t0000_u01761625641408") 2025/10/28 04:32:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703d33_d20251028_m042717_c001_v0001179_t0055_u01761625637491") 2025/10/28 04:32:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4a10_d20251028_m042712_c001_v7007000_t0000_u01761625632504") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4a05_d20251028_m042708_c001_v0001130_t0042_u01761625628296") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f417c043bd4703d30_d20251028_m042717_c001_v7007000_t0000_u01761625637049") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4a11_d20251028_m042712_c001_v0001171_t0024_u01761625632690") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4a04_d20251028_m042707_c001_v7007000_t0000_u01761625627915") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e49fa_d20251028_m042703_c001_v0001183_t0053_u01761625623945") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e49f8_d20251028_m042703_c001_v7007000_t0000_u01761625623761") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e49e9_d20251028_m042700_c001_v0001106_t0007_u01761625620130") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e49e6_d20251028_m042659_c001_v7007000_t0000_u01761625619724") 2025/10/28 04:32:41 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e49d4_d20251028_m042655_c001_v0001154_t0003_u01761625615340") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4986_d20251028_m042624_c001_v7007000_t0000_u01761625584799") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2205eaf028626644_d20251028_m042620_c001_v0001093_t0056_u01761625580715") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4205eaf028626642_d20251028_m042620_c001_v7007000_t0000_u01761625580329") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e494f_d20251028_m042615_c001_v0001130_t0000_u01761625575838") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e494b_d20251028_m042615_c001_v7007000_t0000_u01761625575656") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4917_d20251028_m042611_c001_v0001146_t0029_u01761625571499") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4916_d20251028_m042611_c001_v7007000_t0000_u01761625571046") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f218b68eadce0a72c_d20251028_m042606_c001_v0001181_t0020_u01761625566988") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418b68eadce0a72b_d20251028_m042606_c001_v7007000_t0000_u01761625566805") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4903_d20251028_m042603_c001_v0001101_t0054_u01761625563195") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e48ff_d20251028_m042602_c001_v7007000_t0000_u01761625562812") 2025/10/28 04:32:41 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d4372_d20251028_m042557_c001_v0001098_t0025_u01761625557631") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4036d880aac28127_d20251028_m042751_c001_v7007000_t0000_u01761625671376") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2036d880aac28119_d20251028_m042746_c001_v0001116_t0036_u01761625666593") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4ab8_d20251028_m042741_c001_v7007000_t0000_u01761625661365") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4aab_d20251028_m042735_c001_v0001101_t0008_u01761625655909") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4036d880aac28116_d20251028_m042746_c001_v7007000_t0000_u01761625666036") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4ab9_d20251028_m042741_c001_v0001181_t0003_u01761625661550") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4aaa_d20251028_m042735_c001_v7007000_t0000_u01761625655458") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4a9d_d20251028_m042730_c001_v0001120_t0033_u01761625650309") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f4009d428879e4a99_d20251028_m042730_c001_v7007000_t0000_u01761625650124") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703d52_d20251028_m042726_c001_v0001131_t0003_u01761625646277") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f417c043bd4703d50_d20251028_m042725_c001_v7007000_t0000_u01761625645825") 2025/10/28 04:32:42 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2009d428879e4a27_d20251028_m042721_c001_v0001120_t0007_u01761625641600") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f423f3964a68d2b00_d20251028_m042822_c001_v7007000_t0000_u01761625702573") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f217c043bd4703e18_d20251028_m042817_c001_v0001183_t0014_u01761625697874") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f417c043bd4703e15_d20251028_m042817_c001_v7007000_t0000_u01761625697376") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d44c2_d20251028_m042812_c001_v0001099_t0016_u01761625692222") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f416dece3f62d44c1_d20251028_m042812_c001_v7007000_t0000_u01761625692037") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d44b4_d20251028_m042807_c001_v0001098_t0027_u01761625687300") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f416dece3f62d44b3_d20251028_m042806_c001_v7007000_t0000_u01761625686809") 2025/10/28 04:32:42 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f216dece3f62d44aa_d20251028_m042801_c001_v0001104_t0001_u01761625681230") 2025/10/28 04:32:43 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f416dece3f62d44a8_d20251028_m042801_c001_v7007000_t0000_u01761625681014") 2025/10/28 04:32:43 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f212fb83cf45da794_d20251028_m042757_c001_v0001184_t0055_u01761625677199") 2025/10/28 04:32:43 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f412fb83cf45da790_d20251028_m042756_c001_v7007000_t0000_u01761625676701") 2025/10/28 04:32:43 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f2036d880aac28128_d20251028_m042751_c001_v0001043_t0010_u01761625671566") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e35231_d20251028_m043236_c001_v7007000_t0000_u01761625956130") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f218e418520e34f95_d20251028_m042916_c001_v0001184_t0036_u01761625756799") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e34f8f_d20251028_m042916_c001_v7007000_t0000_u01761625756172") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f207238d137609911_d20251028_m042910_c001_v0001137_t0021_u01761625750716") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f407238d13760990f_d20251028_m042910_c001_v7007000_t0000_u01761625750086") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f218e418520e34e3d_d20251028_m042904_c001_v0001037_t0026_u01761625744418") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e34e36_d20251028_m042903_c001_v7007000_t0000_u01761625743818") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396f1cb_d20251028_m042859_c001_v0001183_t0057_u01761625739938") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f407238d1376098e1_d20251028_m042859_c001_v7007000_t0000_u01761625739522") 2025/10/28 04:32:43 DEBUG : chunked-copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396f1b3_d20251028_m042856_c001_v0001183_t0017_u01761625736256") 2025/10/28 04:32:43 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e35230_d20251028_m043235_c001_v7007000_t0000_u01761625955948") 2025/10/28 04:32:43 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f207238d137609932_d20251028_m042920_c001_v0001100_t0036_u01761625760063") 2025/10/28 04:32:43 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e34f8c_d20251028_m042915_c001_v7007000_t0000_u01761625755988") 2025/10/28 04:32:43 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f218e418520e34f67_d20251028_m042914_c001_v0001137_t0025_u01761625754113") 2025/10/28 04:32:43 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f407238d13760990d_d20251028_m042909_c001_v7007000_t0000_u01761625749904") 2025/10/28 04:32:43 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f207238d137609903_d20251028_m042908_c001_v0001136_t0016_u01761625748077") 2025/10/28 04:32:43 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e34e33_d20251028_m042903_c001_v7007000_t0000_u01761625743633") 2025/10/28 04:32:44 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f207238d1376098e8_d20251028_m042901_c001_v0001037_t0042_u01761625741531") 2025/10/28 04:32:44 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f407238d1376098de_d20251028_m042859_c001_v7007000_t0000_u01761625739325") 2025/10/28 04:32:44 DEBUG : chunked-copy.copy: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f100a44b920850b6c_d20251028_m042858_c001_v0001042_t0020_u01761625738115") 2025/10/28 04:32:44 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110891ecc6973732_d20251028_m042435_c001_v0001116_t0039_u01761625475433") 2025/10/28 04:32:44 DEBUG : unknown-size-put.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e35233_d20251028_m043236_c001_v7007000_t0000_u01761625956904") 2025/10/28 04:32:44 DEBUG : unknown-size-put.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396f9b2_d20251028_m043236_c001_v0001183_t0041_u01761625956712") 2025/10/28 04:32:44 DEBUG : unknown-size-update.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f418e418520e35236_d20251028_m043237_c001_v7007000_t0000_u01761625957914") 2025/10/28 04:32:44 DEBUG : unknown-size-update.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396f9c0_d20251028_m043237_c001_v0001183_t0031_u01761625957696") 2025/10/28 04:32:44 DEBUG : unknown-size-update.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f110bdf37d396f9b8_d20251028_m043237_c001_v0001183_t0036_u01761625957091") 2025/10/28 04:32:44 DEBUG : versions/test-versions.txt: Deleting (id "4_z8f42fd7300ed2b9b9fa80e1b_f416dece3f62d4368_d20251028_m042553_c001_v7007000_t0000_u01761625553785") 2025/10/28 04:32:45 INFO : B2 bucket rclone-test-wucuxek6hare: cleaning bucket "rclone-test-wucuxek6hare" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (530.19s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.55s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.42s) --- PASS: TestIntegration/FsMkdir (527.64s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.54s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding (26.86s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (2.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (1.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.38s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (1.56s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.25s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.63s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (1.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (1.41s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.59s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.67s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.40s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.13s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (5.79s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (83.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.27s) --- 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.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (3.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.16s) --- 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.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (2.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (7.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.50s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.55s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (32.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (6.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (21.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.18s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject (0.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.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.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (3.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.15s) --- 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.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.56s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (178.05s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (27.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.36s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.85s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.61s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (9.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.47s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (30.36s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (8.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (4.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (12.46s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (8.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (9.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (26.26s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (8.61s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (4.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.74s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.59s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (8.91s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.37s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (29.97s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.30s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (11.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (5.90s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (10.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (31.19s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (9.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.34s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.23s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (10.54s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.20s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (32.92s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (9.30s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (4.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (12.02s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (11.60s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.87s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (220.63s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.02s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (4.30s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (6.26s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (6.09s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (199.95s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (1.78s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.77s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.28s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- SKIP: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/b2 530.229s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 8m51.503181586s (try 1/5)