"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/03/20 05:19:04 DEBUG : Creating backend with remote "TestB2:rclone-test-naqegas8ceni" 2025/03/20 05:19:04 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/03/20 05:19:08 INFO : dir/subdir: Making directory fstest.go:244: Filtering empty directory "dir" fstest.go:244: Filtering empty directory "dir/subdir" 2025/03/20 05:19:08 INFO : dir/subdir: Removing directory fstest.go:244: Filtering empty directory "dir" 2025/03/20 05:19:08 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/03/20 05:19:31 DEBUG : writer-at-subdir/writer-at-file: Streaming upload with --b2-chunk-size 96Mi allows uploads of up to 937.500Gi and will fail only when that limit is reached. 2025/03/20 05:19:31 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2025/03/20 05:19:34 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2025/03/20 05:19:34 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2025/03/20 05:19:35 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2025/03/20 05:19:35 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2025/03/20 05:19:36 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2025/03/20 05:19:36 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/03/20 05:19:44 DEBUG : Creating backend with remote "TestB2:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2025/03/20 05:19:45 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/03/20 05:19:50 INFO : B2 bucket rclone-test-naqegas8ceni: cleaning bucket "rclone-test-naqegas8ceni" of all files 2025/03/20 05:19:50 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc6d_d20250320_m051949_c001_v0001181_t0042_u01742447989689") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/03/20 05:19:51 DEBUG : Creating backend with remote "TestB2:rclone-test-naqegas8ceni/dirToPurgeFromRoot" 2025/03/20 05:19:52 INFO : B2 bucket rclone-test-naqegas8ceni path dirToPurgeFromRoot: cleaning bucket "rclone-test-naqegas8ceni" of all files 2025/03/20 05:19:53 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc77_d20250320_m051951_c001_v0001181_t0049_u01742447991208") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/20 05:19:53 DEBUG : Creating backend with remote "TestB2:rclone-test-naqegas8ceni/hello? sausage/êé" 2025/03/20 05:19:58 INFO : B2 bucket rclone-test-naqegas8ceni path hello? sausage/êé: cleaning bucket "rclone-test-naqegas8ceni" of all files 2025/03/20 05:19:58 DEBUG : a/b/c/d/e.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f103d8f2d74462426_d20250320_m051956_c001_v0001092_t0006_u01742447996518") === 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/03/20 05:20:09 DEBUG : Creating backend with remote "TestB2:rclone-test-naqegas8ceni/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/03/20 05:20:09 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/20 05:20:11 DEBUG : Creating backend with remote "TestB2:rclone-test-naqegas8ceni/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestB2:" path "rclone-test-naqegas8ceni" from "TestB2:rclone-test-naqegas8ceni" 2025/03/20 05:20:13 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/03/20 05:20:24 DEBUG : Creating backend with remote "TestB2:rclone-test-yotepat1zapa" 2025/03/20 05:20:27 DEBUG : B2 bucket rclone-test-yotepat1zapa: Purge remote 2025/03/20 05:20:27 INFO : B2 bucket rclone-test-yotepat1zapa: cleaning bucket "rclone-test-yotepat1zapa" of all files 2025/03/20 05:20:27 DEBUG : somefile: Deleting (id "4_z9f52ddf3f0edbb1b9f580e1b_f4002902460cfa1c2_d20250320_m052026_c001_v0001038_t0025_u01742448026538") === 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/03/20 05:20:28 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/03/20 05:20:29 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/03/20 05:20:32 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2025/03/20 05:20:32 DEBUG : test-metadata: Sending chunk 0 length 6291456 2025/03/20 05:20:32 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.855Ki offset 6Mi/6.106Mi 2025/03/20 05:20:32 DEBUG : test-metadata: Sending chunk 1 length 111468 2025/03/20 05:20:34 DEBUG : test-metadata: Done sending chunk 1 2025/03/20 05:20:35 DEBUG : test-metadata: Done sending chunk 0 2025/03/20 05:20:35 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/03/20 05:20:42 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_hide_file": EOF) 2025/03/20 05:20:42 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/20 05:20:43 DEBUG : pacer: Reducing sleep to 10ms 2025/03/20 05:20:45 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1181-08.backblaze.com/b2api/v1/b2_upload_file/af52adf3f0ddbb1b9f580e1b/c001_v0001181_t0007": EOF 2025/03/20 05:20:45 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1181-08.backblaze.com/b2api/v1/b2_upload_file/af52adf3f0ddbb1b9f580e1b/c001_v0001181_t0007": EOF) 2025/03/20 05:20:45 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:143: Put error: Post "https://pod-000-1181-08.backblaze.com/b2api/v1/b2_upload_file/af52adf3f0ddbb1b9f580e1b/c001_v0001181_t0007": EOF - low level retry 1/10 2025/03/20 05:20:47 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-03-20-052040-309.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/03/20 05:20:49 DEBUG : oldPath = "TestB2:rclone-test-naqegas8ceni/versions/test-versions-v2025-03-20-052040-309.txt" 2025/03/20 05:20:49 DEBUG : newPath = "TestB2,versions:rclone-test-naqegas8ceni/versions/test-versions-v2025-03-20-052040-309.txt" 2025/03/20 05:20:49 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-naqegas8ceni/versions/test-versions-v2025-03-20-052040-309.txt" 2025/03/20 05:20:49 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2025/03/20 05:20:51 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-naqegas8ceni/versions/test-versions-v2025-03-20-052040-309.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-naqegas8ceni/versions" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun 2025/03/20 05:20:52 INFO : B2 bucket rclone-test-naqegas8ceni: cleaning bucket "rclone-test-naqegas8ceni" of all hidden files 2025/03/20 05:20:52 DEBUG : leading space/ leading space: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68faf_d20250320_m051915_c001_v7007000_t0000_u01742447955455") as it is a hide marker 2025/03/20 05:20:52 NOTICE: leading space/ leading space: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : leading space/ leading space: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cba1_d20250320_m051914_c001_v0001181_t0018_u01742447954858") 2025/03/20 05:20:52 NOTICE: leading space/ leading space: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fa5_d20250320_m051914_c001_v7007000_t0000_u01742447954480") as it is a hide marker 2025/03/20 05:20:52 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb9c_d20250320_m051913_c001_v0001181_t0008_u01742447953877") 2025/03/20 05:20:52 NOTICE: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fda_d20250320_m051921_c001_v7007000_t0000_u01742447961551") as it is a hide marker 2025/03/20 05:20:52 NOTICE: .leading dot/.leading dot: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : .leading dot/.leading dot: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbc1_d20250320_m051920_c001_v0001181_t0001_u01742447960788") 2025/03/20 05:20:52 NOTICE: .leading dot/.leading dot: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : created from root.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f4126bda746cab3c9_d20250320_m052020_c001_v7007000_t0000_u01742448020455") as it is a hide marker 2025/03/20 05:20:52 NOTICE: created from root.txt: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : created from root.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f10257481fa804f64_d20250320_m052019_c001_v0001183_t0021_u01742448019508") 2025/03/20 05:20:52 NOTICE: created from root.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : file name.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e1c_d20250320_m052028_c001_v7007000_t0000_u01742448028664") as it is a hide marker 2025/03/20 05:20:52 NOTICE: file name.txt: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cce9_d20250320_m052008_c001_v0001181_t0041_u01742448008640") 2025/03/20 05:20:52 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1036c1318b9b1be6_d20250320_m052004_c001_v0001103_t0037_u01742448004949") 2025/03/20 05:20:52 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc3d_d20250320_m051941_c001_v0001181_t0046_u01742447981553") 2025/03/20 05:20:52 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc33_d20250320_m051940_c001_v0001181_t0030_u01742447980700") 2025/03/20 05:20:52 NOTICE: file name.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc37_d20250320_m051941_c001_v0001181_t0033_u01742447981116") "upload" dated 2025-03-20 05:19:41.116 +0000 UTC (1m11.669064708s ago) 2025/03/20 05:20:52 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f4126bda746cab375_d20250320_m052002_c001_v7007000_t0000_u01742448002642") as it is a hide marker 2025/03/20 05:20:52 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f112a789c943d9ec1_d20250320_m052002_c001_v0001183_t0020_u01742448002427") 2025/03/20 05:20:52 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1179fc58158846c1_d20250320_m052001_c001_v0001134_t0016_u01742448001511") 2025/03/20 05:20:52 NOTICE: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe4_d20250320_m051928_c001_v7007000_t0000_u01742447968508") as it is a hide marker 2025/03/20 05:20:52 NOTICE: invalid utf-8/invalid utf-8: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbf5_d20250320_m051927_c001_v0001181_t0059_u01742447967882") 2025/03/20 05:20:52 NOTICE: invalid utf-8/invalid utf-8: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : piped data.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e20_d20250320_m052030_c001_v7007000_t0000_u01742448030421") as it is a hide marker 2025/03/20 05:20:52 NOTICE: piped data.txt: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : piped data.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cd51_d20250320_m052029_c001_v0001181_t0057_u01742448029970") 2025/03/20 05:20:52 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : piped data.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e1f_d20250320_m052029_c001_v7007000_t0000_u01742448029784") 2025/03/20 05:20:52 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : piped data.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4086b0f94981cd4b_d20250320_m052029_c001_v0001181_t0007_u01742448029403") 2025/03/20 05:20:52 NOTICE: piped data.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe5_d20250320_m051929_c001_v7007000_t0000_u01742447969544") as it is a hide marker 2025/03/20 05:20:52 NOTICE: test%46.txt/test%46.txt: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbfd_d20250320_m051928_c001_v0001181_t0032_u01742447968883") 2025/03/20 05:20:52 NOTICE: test%46.txt/test%46.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : test-metadata: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a69041_d20250320_m052037_c001_v7007000_t0000_u01742448037753") as it is a hide marker 2025/03/20 05:20:52 NOTICE: test-metadata: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : test-metadata: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f217201493a684e25_d20250320_m052032_c001_v0001157_t0020_u01742448032386") 2025/03/20 05:20:52 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : test-metadata: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e22_d20250320_m052031_c001_v7007000_t0000_u01742448031460") 2025/03/20 05:20:52 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : test-metadata: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cd57_d20250320_m052030_c001_v0001181_t0036_u01742448030620") 2025/03/20 05:20:52 NOTICE: test-metadata: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdc_d20250320_m051923_c001_v7007000_t0000_u01742447963544") as it is a hide marker 2025/03/20 05:20:52 NOTICE: trailing CR␍/trailing CR␍: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbd3_d20250320_m051922_c001_v0001181_t0058_u01742447962907") 2025/03/20 05:20:52 NOTICE: trailing CR␍/trailing CR␍: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdf_d20250320_m051925_c001_v7007000_t0000_u01742447965541") as it is a hide marker 2025/03/20 05:20:52 NOTICE: trailing HT␉/trailing HT␉: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbdd_d20250320_m051924_c001_v0001181_t0034_u01742447964946") 2025/03/20 05:20:52 NOTICE: trailing HT␉/trailing HT␉: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdd_d20250320_m051924_c001_v7007000_t0000_u01742447964547") as it is a hide marker 2025/03/20 05:20:52 NOTICE: trailing LF␊/trailing LF␊: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbd9_d20250320_m051923_c001_v0001181_t0049_u01742447963916") 2025/03/20 05:20:52 NOTICE: trailing LF␊/trailing LF␊: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe1_d20250320_m051926_c001_v7007000_t0000_u01742447966522") as it is a hide marker 2025/03/20 05:20:52 NOTICE: trailing VT␋/trailing VT␋: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbe7_d20250320_m051925_c001_v0001181_t0009_u01742447965930") 2025/03/20 05:20:52 NOTICE: trailing VT␋/trailing VT␋: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe3_d20250320_m051927_c001_v7007000_t0000_u01742447967499") as it is a hide marker 2025/03/20 05:20:52 NOTICE: trailing dot./trailing dot.: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbeb_d20250320_m051926_c001_v0001181_t0026_u01742447966895") 2025/03/20 05:20:52 NOTICE: trailing dot./trailing dot.: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing space /trailing space : Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdb_d20250320_m051922_c001_v7007000_t0000_u01742447962520") as it is a hide marker 2025/03/20 05:20:52 NOTICE: trailing space /trailing space : Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : trailing space /trailing space : Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbcd_d20250320_m051921_c001_v0001181_t0058_u01742447961933") 2025/03/20 05:20:52 NOTICE: trailing space /trailing space : Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c920897_d20250320_m052048_c001_v0001182_t0008_u01742448048085") "upload" dated 2025-03-20 05:20:48.085 +0000 UTC (4.700673171s ago) 2025/03/20 05:20:52 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4061b707f12660e7_d20250320_m052043_c001_v7007000_t0000_u01742448043308") 2025/03/20 05:20:52 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cd7f_d20250320_m052040_c001_v0001181_t0010_u01742448040309") 2025/03/20 05:20:52 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68ff3_d20250320_m051940_c001_v7007000_t0000_u01742447980147") as it is a hide marker 2025/03/20 05:20:52 NOTICE: writer-at-subdir/writer-at-file: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f205e3d2a50a68fe9_d20250320_m051931_c001_v0001144_t0036_u01742447971790") 2025/03/20 05:20:52 NOTICE: writer-at-subdir/writer-at-file: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : zero-length-file: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe7_d20250320_m051931_c001_v7007000_t0000_u01742447971462") as it is a hide marker 2025/03/20 05:20:52 NOTICE: zero-length-file: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : zero-length-file: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4086b0f94981cc03_d20250320_m051930_c001_v0001181_t0007_u01742447970903") 2025/03/20 05:20:52 NOTICE: zero-length-file: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fb3_d20250320_m051916_c001_v7007000_t0000_u01742447956466") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ~leading tilde/~leading tilde: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cba7_d20250320_m051915_c001_v0001181_t0004_u01742447955854") 2025/03/20 05:20:52 NOTICE: ~leading tilde/~leading tilde: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68f82_d20250320_m051911_c001_v7007000_t0000_u01742447951513") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb8a_d20250320_m051910_c001_v0001181_t0024_u01742447950503") 2025/03/20 05:20:52 NOTICE: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fc4_d20250320_m051919_c001_v7007000_t0000_u01742447959414") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ␉leading HT/␉leading HT: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbb9_d20250320_m051918_c001_v0001181_t0038_u01742447958818") 2025/03/20 05:20:52 NOTICE: ␉leading HT/␉leading HT: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fc2_d20250320_m051918_c001_v7007000_t0000_u01742447958436") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ␊leading LF/␊leading LF: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbb7_d20250320_m051917_c001_v0001181_t0008_u01742447957817") 2025/03/20 05:20:52 NOTICE: ␊leading LF/␊leading LF: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fd4_d20250320_m051920_c001_v7007000_t0000_u01742447960401") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ␋leading VT/␋leading VT: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbbf_d20250320_m051919_c001_v0001181_t0055_u01742447959791") 2025/03/20 05:20:52 NOTICE: ␋leading VT/␋leading VT: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fb7_d20250320_m051917_c001_v7007000_t0000_u01742447957442") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ␍leading CR/␍leading CR: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbad_d20250320_m051916_c001_v0001181_t0010_u01742447956841") 2025/03/20 05:20:52 NOTICE: ␍leading CR/␍leading CR: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ．/．: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68f8c_d20250320_m051912_c001_v7007000_t0000_u01742447952501") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ．/．: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ．/．: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb90_d20250320_m051911_c001_v0001181_t0009_u01742447951891") 2025/03/20 05:20:52 NOTICE: ．/．: Skipped delete as --dry-run is set 2025/03/20 05:20:52 DEBUG : ．．/．．: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68f97_d20250320_m051913_c001_v7007000_t0000_u01742447953503") as it is a hide marker 2025/03/20 05:20:52 NOTICE: ．．/．．: Skipped remove hide marker as --dry-run is set 2025/03/20 05:20:52 DEBUG : ．．/．．: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb96_d20250320_m051912_c001_v0001181_t0040_u01742447952880") 2025/03/20 05:20:52 NOTICE: ．．/．．: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing 2025/03/20 05:20:52 INFO : B2 bucket rclone-test-naqegas8ceni: cleaning bucket "rclone-test-naqegas8ceni" of all hidden files 2025/03/20 05:20:53 DEBUG : leading space/ leading space: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68faf_d20250320_m051915_c001_v7007000_t0000_u01742447955455") as it is a hide marker 2025/03/20 05:20:53 DEBUG : leading space/ leading space: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cba1_d20250320_m051914_c001_v0001181_t0018_u01742447954858") 2025/03/20 05:20:53 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fa5_d20250320_m051914_c001_v7007000_t0000_u01742447954480") as it is a hide marker 2025/03/20 05:20:53 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb9c_d20250320_m051913_c001_v0001181_t0008_u01742447953877") 2025/03/20 05:20:53 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fda_d20250320_m051921_c001_v7007000_t0000_u01742447961551") as it is a hide marker 2025/03/20 05:20:53 DEBUG : .leading dot/.leading dot: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbc1_d20250320_m051920_c001_v0001181_t0001_u01742447960788") 2025/03/20 05:20:53 DEBUG : created from root.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f4126bda746cab3c9_d20250320_m052020_c001_v7007000_t0000_u01742448020455") as it is a hide marker 2025/03/20 05:20:53 DEBUG : created from root.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f10257481fa804f64_d20250320_m052019_c001_v0001183_t0021_u01742448019508") 2025/03/20 05:20:53 DEBUG : file name.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e1c_d20250320_m052028_c001_v7007000_t0000_u01742448028664") as it is a hide marker 2025/03/20 05:20:53 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cce9_d20250320_m052008_c001_v0001181_t0041_u01742448008640") 2025/03/20 05:20:53 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1036c1318b9b1be6_d20250320_m052004_c001_v0001103_t0037_u01742448004949") 2025/03/20 05:20:53 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc3d_d20250320_m051941_c001_v0001181_t0046_u01742447981553") 2025/03/20 05:20:53 DEBUG : file name.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc33_d20250320_m051940_c001_v0001181_t0030_u01742447980700") 2025/03/20 05:20:53 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc37_d20250320_m051941_c001_v0001181_t0033_u01742447981116") "upload" dated 2025-03-20 05:19:41.116 +0000 UTC (1m12.727804783s ago) 2025/03/20 05:20:53 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f4126bda746cab375_d20250320_m052002_c001_v7007000_t0000_u01742448002642") as it is a hide marker 2025/03/20 05:20:54 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f112a789c943d9ec1_d20250320_m052002_c001_v0001183_t0020_u01742448002427") 2025/03/20 05:20:54 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1179fc58158846c1_d20250320_m052001_c001_v0001134_t0016_u01742448001511") 2025/03/20 05:20:54 DEBUG : invalid utf-8/invalid utf-8: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe4_d20250320_m051928_c001_v7007000_t0000_u01742447968508") as it is a hide marker 2025/03/20 05:20:54 DEBUG : invalid utf-8/invalid utf-8: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbf5_d20250320_m051927_c001_v0001181_t0059_u01742447967882") 2025/03/20 05:20:54 DEBUG : piped data.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e20_d20250320_m052030_c001_v7007000_t0000_u01742448030421") as it is a hide marker 2025/03/20 05:20:54 DEBUG : piped data.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cd51_d20250320_m052029_c001_v0001181_t0057_u01742448029970") 2025/03/20 05:20:54 DEBUG : piped data.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e1f_d20250320_m052029_c001_v7007000_t0000_u01742448029784") 2025/03/20 05:20:54 DEBUG : piped data.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4086b0f94981cd4b_d20250320_m052029_c001_v0001181_t0007_u01742448029403") 2025/03/20 05:20:54 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe5_d20250320_m051929_c001_v7007000_t0000_u01742447969544") as it is a hide marker 2025/03/20 05:20:54 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbfd_d20250320_m051928_c001_v0001181_t0032_u01742447968883") 2025/03/20 05:20:54 DEBUG : test-metadata: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a69041_d20250320_m052037_c001_v7007000_t0000_u01742448037753") as it is a hide marker 2025/03/20 05:20:54 DEBUG : test-metadata: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f217201493a684e25_d20250320_m052032_c001_v0001157_t0020_u01742448032386") 2025/03/20 05:20:54 DEBUG : test-metadata: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f417201493a684e22_d20250320_m052031_c001_v7007000_t0000_u01742448031460") 2025/03/20 05:20:54 DEBUG : test-metadata: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cd57_d20250320_m052030_c001_v0001181_t0036_u01742448030620") 2025/03/20 05:20:54 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdc_d20250320_m051923_c001_v7007000_t0000_u01742447963544") as it is a hide marker 2025/03/20 05:20:54 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbd3_d20250320_m051922_c001_v0001181_t0058_u01742447962907") 2025/03/20 05:20:54 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdf_d20250320_m051925_c001_v7007000_t0000_u01742447965541") as it is a hide marker 2025/03/20 05:20:54 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbdd_d20250320_m051924_c001_v0001181_t0034_u01742447964946") 2025/03/20 05:20:54 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdd_d20250320_m051924_c001_v7007000_t0000_u01742447964547") as it is a hide marker 2025/03/20 05:20:54 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbd9_d20250320_m051923_c001_v0001181_t0049_u01742447963916") 2025/03/20 05:20:54 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe1_d20250320_m051926_c001_v7007000_t0000_u01742447966522") as it is a hide marker 2025/03/20 05:20:55 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbe7_d20250320_m051925_c001_v0001181_t0009_u01742447965930") 2025/03/20 05:20:55 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe3_d20250320_m051927_c001_v7007000_t0000_u01742447967499") as it is a hide marker 2025/03/20 05:20:55 DEBUG : trailing dot./trailing dot.: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbeb_d20250320_m051926_c001_v0001181_t0026_u01742447966895") 2025/03/20 05:20:55 DEBUG : trailing space /trailing space : Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fdb_d20250320_m051922_c001_v7007000_t0000_u01742447962520") as it is a hide marker 2025/03/20 05:20:55 DEBUG : trailing space /trailing space : Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbcd_d20250320_m051921_c001_v0001181_t0058_u01742447961933") 2025/03/20 05:20:55 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c920897_d20250320_m052048_c001_v0001182_t0008_u01742448048085") "upload" dated 2025-03-20 05:20:48.085 +0000 UTC (7.154811748s ago) 2025/03/20 05:20:55 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4061b707f12660e7_d20250320_m052043_c001_v7007000_t0000_u01742448043308") 2025/03/20 05:20:55 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cd7f_d20250320_m052040_c001_v0001181_t0010_u01742448040309") 2025/03/20 05:20:55 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68ff3_d20250320_m051940_c001_v7007000_t0000_u01742447980147") as it is a hide marker 2025/03/20 05:20:55 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f205e3d2a50a68fe9_d20250320_m051931_c001_v0001144_t0036_u01742447971790") 2025/03/20 05:20:55 DEBUG : zero-length-file: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fe7_d20250320_m051931_c001_v7007000_t0000_u01742447971462") as it is a hide marker 2025/03/20 05:20:55 DEBUG : zero-length-file: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4086b0f94981cc03_d20250320_m051930_c001_v0001181_t0007_u01742447970903") 2025/03/20 05:20:55 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fb3_d20250320_m051916_c001_v7007000_t0000_u01742447956466") as it is a hide marker 2025/03/20 05:20:55 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cba7_d20250320_m051915_c001_v0001181_t0004_u01742447955854") 2025/03/20 05:20:55 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68f82_d20250320_m051911_c001_v7007000_t0000_u01742447951513") as it is a hide marker 2025/03/20 05:20:55 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb8a_d20250320_m051910_c001_v0001181_t0024_u01742447950503") 2025/03/20 05:20:55 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fc4_d20250320_m051919_c001_v7007000_t0000_u01742447959414") as it is a hide marker 2025/03/20 05:20:55 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbb9_d20250320_m051918_c001_v0001181_t0038_u01742447958818") 2025/03/20 05:20:55 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fc2_d20250320_m051918_c001_v7007000_t0000_u01742447958436") as it is a hide marker 2025/03/20 05:20:55 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbb7_d20250320_m051917_c001_v0001181_t0008_u01742447957817") 2025/03/20 05:20:56 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fd4_d20250320_m051920_c001_v7007000_t0000_u01742447960401") as it is a hide marker 2025/03/20 05:20:56 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbbf_d20250320_m051919_c001_v0001181_t0055_u01742447959791") 2025/03/20 05:20:56 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68fb7_d20250320_m051917_c001_v7007000_t0000_u01742447957442") as it is a hide marker 2025/03/20 05:20:56 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cbad_d20250320_m051916_c001_v0001181_t0010_u01742447956841") 2025/03/20 05:20:56 DEBUG : ．/．: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68f8c_d20250320_m051912_c001_v7007000_t0000_u01742447952501") as it is a hide marker 2025/03/20 05:20:56 DEBUG : ．/．: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb90_d20250320_m051911_c001_v0001181_t0009_u01742447951891") 2025/03/20 05:20:56 DEBUG : ．．/．．: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f405e3d2a50a68f97_d20250320_m051913_c001_v7007000_t0000_u01742447953503") as it is a hide marker 2025/03/20 05:20:56 DEBUG : ．．/．．: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cb96_d20250320_m051912_c001_v0001181_t0040_u01742447952880") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished 2025/03/20 05:20:57 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/03/20 05:20:57 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/03/20 05:20:57 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/03/20 05:20:57 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/03/20 05:20:58 INFO : B2 bucket rclone-test-naqegas8ceni: cleaning bucket "rclone-test-naqegas8ceni" of pending multipart uploads older than 0s 2025/03/20 05:20:58 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc37_d20250320_m051941_c001_v0001181_t0033_u01742447981116") "upload" dated 2025-03-20 05:19:41.116 +0000 UTC (1m17.199071499s ago) 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f597_d20250320_m052057_c001_v0001154_t0003_u01742448057256") as it is a start marker (upload started at 2025-03-20 05:20:57.256 +0000 UTC) 2025/03/20 05:20:58 NOTICE: unfinished/unfinished-1: Skipped remove pending upload as --dry-run is set 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f598_d20250320_m052057_c001_v0001184_t0048_u01742448057451") as it is a start marker (upload started at 2025-03-20 05:20:57.451 +0000 UTC) 2025/03/20 05:20:58 NOTICE: unfinished/unfinished-2: Skipped remove pending upload as --dry-run is set 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f59a_d20250320_m052057_c001_v0001145_t0004_u01742448057636") as it is a start marker (upload started at 2025-03-20 05:20:57.636 +0000 UTC) 2025/03/20 05:20:58 NOTICE: unfinished/unfinished-3: Skipped remove pending upload as --dry-run is set 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f59c_d20250320_m052057_c001_v0001178_t0036_u01742448057837") as it is a start marker (upload started at 2025-03-20 05:20:57.837 +0000 UTC) 2025/03/20 05:20:58 NOTICE: unfinished/unfinished-4: Skipped remove pending upload as --dry-run is set 2025/03/20 05:20:58 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f40200070b217f596_d20250320_m052057_c001_v7007000_t0000_u01742448057070") "hide" dated 2025-03-20 05:20:57.07 +0000 UTC (1.245268649s ago) 2025/03/20 05:20:58 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c920897_d20250320_m052048_c001_v0001182_t0008_u01742448048085") 2025/03/20 05:20:58 NOTICE: versions/test-versions.txt: Skipped delete as --dry-run is set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing 2025/03/20 05:20:58 INFO : B2 bucket rclone-test-naqegas8ceni: cleaning bucket "rclone-test-naqegas8ceni" of pending multipart uploads older than 0s 2025/03/20 05:20:58 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc37_d20250320_m051941_c001_v0001181_t0033_u01742447981116") "upload" dated 2025-03-20 05:19:41.116 +0000 UTC (1m17.576212114s ago) 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-1: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f597_d20250320_m052057_c001_v0001154_t0003_u01742448057256") as it is a start marker (upload started at 2025-03-20 05:20:57.256 +0000 UTC) 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-2: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f598_d20250320_m052057_c001_v0001184_t0048_u01742448057451") as it is a start marker (upload started at 2025-03-20 05:20:57.451 +0000 UTC) 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-3: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f59a_d20250320_m052057_c001_v0001145_t0004_u01742448057636") as it is a start marker (upload started at 2025-03-20 05:20:57.636 +0000 UTC) 2025/03/20 05:20:58 DEBUG : unfinished/unfinished-4: Deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f59c_d20250320_m052057_c001_v0001178_t0036_u01742448057837") as it is a start marker (upload started at 2025-03-20 05:20:57.837 +0000 UTC) 2025/03/20 05:20:58 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_zaf52adf3f0ddbb1b9f580e1b_f40200070b217f596_d20250320_m052057_c001_v7007000_t0000_u01742448057070") "hide" dated 2025-03-20 05:20:57.07 +0000 UTC (1.622387583s ago) 2025/03/20 05:20:58 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c920897_d20250320_m052048_c001_v0001182_t0008_u01742448048085") === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun 2025/03/20 05:20:59 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/03/20 05:20:59 NOTICE: lifecycle: Skipped update lifecycle rules as --dry-run is set 2025/03/20 05:20:59 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/03/20 05:21:01 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2025/03/20 05:21:01 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2025/03/20 05:21:01 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2025/03/20 05:21:01 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2025/03/20 05:21:02 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2025/03/20 05:21:04 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2025/03/20 05:21:04 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2025/03/20 05:21:06 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:21:06 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/03/20 05:21:07 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac36d_d20250320_m052106_c001_v0001040_t0055_u01742448066978") 2025/03/20 05:21:07 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:21:07 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2025/03/20 05:21:07 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/03/20 05:21:08 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:21:09 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:21:09 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2025/03/20 05:21:11 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2025/03/20 05:21:11 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2025/03/20 05:21:11 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2025/03/20 05:21:11 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2025/03/20 05:21:13 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2025/03/20 05:21:13 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2025/03/20 05:21:13 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2025/03/20 05:21:15 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:21:15 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/03/20 05:21:15 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac370_d20250320_m052115_c001_v0001144_t0016_u01742448075657") 2025/03/20 05:21:15 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2025/03/20 05:21:15 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/20 05:21:15 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2025/03/20 05:21:18 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:21:19 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:21:19 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2025/03/20 05:21:21 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2025/03/20 05:21:21 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2025/03/20 05:21:21 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2025/03/20 05:21:21 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2025/03/20 05:21:21 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2025/03/20 05:21:21 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2025/03/20 05:21:22 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2025/03/20 05:21:23 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2025/03/20 05:21:23 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2025/03/20 05:21:23 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2025/03/20 05:21:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:21:25 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/03/20 05:21:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac377_d20250320_m052125_c001_v0001091_t0031_u01742448085584") 2025/03/20 05:21:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2025/03/20 05:21:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:21:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2025/03/20 05:21:25 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2025/03/20 05:21:26 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2025/03/20 05:21:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:21:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:21:28 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/03/20 05:21:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2025/03/20 05:21:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2025/03/20 05:21:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2025/03/20 05:21:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2025/03/20 05:21:31 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2025/03/20 05:21:32 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2025/03/20 05:21:32 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2025/03/20 05:21:34 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:21:34 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/03/20 05:21:34 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac37d_d20250320_m052134_c001_v0001183_t0028_u01742448094347") 2025/03/20 05:21:34 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:21:34 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2025/03/20 05:21:34 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2025/03/20 05:21:35 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:21:36 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:21:36 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2025/03/20 05:21:38 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/03/20 05:21:38 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/03/20 05:21:38 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/03/20 05:21:38 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/03/20 05:21:41 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/03/20 05:21:42 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/03/20 05:21:42 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2025/03/20 05:21:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:21:43 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/03/20 05:21:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac381_d20250320_m052143_c001_v0001184_t0027_u01742448103892") 2025/03/20 05:21:43 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/03/20 05:21:44 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/20 05:21:44 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/03/20 05:21:46 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:21:46 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:21:46 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2025/03/20 05:21:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2025/03/20 05:21:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2025/03/20 05:21:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/03/20 05:21:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/03/20 05:21:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2025/03/20 05:21:48 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2025/03/20 05:21:49 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2025/03/20 05:21:50 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2025/03/20 05:21:50 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2025/03/20 05:21:50 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2025/03/20 05:21:52 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:21:52 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/03/20 05:21:52 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac387_d20250320_m052152_c001_v0001113_t0011_u01742448112780") 2025/03/20 05:21:52 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2025/03/20 05:21:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:21:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/03/20 05:21:53 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2025/03/20 05:21:54 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/03/20 05:21:55 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:21:55 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:21:55 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/03/20 05:21:57 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2025/03/20 05:21:57 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2025/03/20 05:21:57 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2025/03/20 05:21:57 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2025/03/20 05:21:58 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2025/03/20 05:22:00 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2025/03/20 05:22:00 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2025/03/20 05:22:01 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:22:01 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/03/20 05:22:01 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac38c_d20250320_m052201_c001_v0001178_t0055_u01742448121507") 2025/03/20 05:22:01 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:22:01 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2025/03/20 05:22:01 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2025/03/20 05:22:02 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:22:04 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:22:04 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2025/03/20 05:22:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/03/20 05:22:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/03/20 05:22:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/03/20 05:22:05 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/03/20 05:22:08 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/03/20 05:22:08 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/03/20 05:22:08 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2025/03/20 05:22:09 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:22:09 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/03/20 05:22:10 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9acb5f_d20250320_m052210_c001_v0001103_t0056_u01742448130032") 2025/03/20 05:22:10 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/03/20 05:22:10 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/20 05:22:10 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/03/20 05:22:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:22:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:22:12 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2025/03/20 05:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2025/03/20 05:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2025/03/20 05:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2025/03/20 05:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2025/03/20 05:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2025/03/20 05:22:14 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2025/03/20 05:22:15 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2025/03/20 05:22:16 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2025/03/20 05:22:17 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2025/03/20 05:22:17 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2025/03/20 05:22:18 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:22:18 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/03/20 05:22:19 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9acf4d_d20250320_m052218_c001_v0001116_t0049_u01742448138904") 2025/03/20 05:22:19 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2025/03/20 05:22:19 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:22:19 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2025/03/20 05:22:19 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2025/03/20 05:22:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2025/03/20 05:22:21 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:22:21 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:22:21 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/03/20 05:22:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2025/03/20 05:22:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/03/20 05:22:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2025/03/20 05:22:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:24 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/03/20 05:22:24 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/20 05:22:24 DEBUG : pacer: Reducing sleep to 10ms 2025/03/20 05:22:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0000ca3c0), retryAfter:1000000000} 2025/03/20 05:22:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:24 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:24 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:24 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/03/20 05:22:25 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0000ca450), retryAfter:1000000000} 2025/03/20 05:22:25 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:25 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:26 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:26 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc00040d0b0), retryAfter:1000000000} 2025/03/20 05:22:26 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:26 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:26 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:26 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:27 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/03/20 05:22:29 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:29 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc00040d200), retryAfter:1000000000} 2025/03/20 05:22:29 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:29 DEBUG : pacer: low level retry 2/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:29 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:30 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:30 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0000cafc0), retryAfter:1000000000} 2025/03/20 05:22:30 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:30 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:30 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:30 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:31 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/03/20 05:22:33 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:33 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc00040d320), retryAfter:1000000000} 2025/03/20 05:22:33 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:33 DEBUG : pacer: low level retry 3/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:33 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:34 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:34 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0000cbbc0), retryAfter:1000000000} 2025/03/20 05:22:34 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:34 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:34 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:34 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:35 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/03/20 05:22:37 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:37 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc00040d380), retryAfter:1000000000} 2025/03/20 05:22:37 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:37 DEBUG : pacer: low level retry 4/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:37 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:38 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:38 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 1 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0000a0db0), retryAfter:1000000000} 2025/03/20 05:22:38 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:38 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:38 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:38 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:39 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2025/03/20 05:22:41 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:41 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0000a13b0), retryAfter:1000000000} 2025/03/20 05:22:41 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:41 DEBUG : pacer: low level retry 5/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:41 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:42 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:42 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:43 DEBUG : pacer: Reducing sleep to 250ms 2025/03/20 05:22:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2025/03/20 05:22:43 DEBUG : pacer: Reducing sleep to 125ms 2025/03/20 05:22:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000515980), retryAfter:1000000000} 2025/03/20 05:22:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2025/03/20 05:22:43 DEBUG : pacer: low level retry 6/10 (error no tomes available (503 service_unavailable)) 2025/03/20 05:22:43 DEBUG : pacer: Rate limited, increasing sleep to 1s 2025/03/20 05:22:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:49 DEBUG : pacer: Reducing sleep to 500ms 2025/03/20 05:22:49 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2025/03/20 05:22:49 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts 2025/03/20 05:22:49 DEBUG : pacer: Reducing sleep to 250ms 2025/03/20 05:22:50 DEBUG : pacer: Reducing sleep to 125ms 2025/03/20 05:22:50 DEBUG : pacer: Reducing sleep to 62.5ms 2025/03/20 05:22:52 DEBUG : pacer: Reducing sleep to 31.25ms === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2025/03/20 05:22:52 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:22:52 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/03/20 05:22:53 DEBUG : pacer: Reducing sleep to 15.625ms 2025/03/20 05:22:53 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f2195f78a02eaaba0_d20250320_m052252_c001_v0001172_t0048_u01742448172937") 2025/03/20 05:22:53 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:22:53 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:53 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2025/03/20 05:22:53 DEBUG : pacer: Reducing sleep to 10ms 2025/03/20 05:22:54 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:22:55 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:22:55 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2025/03/20 05:22:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/03/20 05:22:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:22:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/03/20 05:22:57 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/03/20 05:22:59 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/03/20 05:23:00 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/03/20 05:23:00 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2025/03/20 05:23:02 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:23:02 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/03/20 05:23:02 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b2181d77_d20250320_m052302_c001_v0001150_t0010_u01742448182392") 2025/03/20 05:23:02 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/03/20 05:23:02 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/20 05:23:02 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/03/20 05:23:04 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:23:05 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:23:05 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2025/03/20 05:23:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2025/03/20 05:23:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2025/03/20 05:23:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2025/03/20 05:23:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2025/03/20 05:23:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2025/03/20 05:23:07 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2025/03/20 05:23:08 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2025/03/20 05:23:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2025/03/20 05:23:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2025/03/20 05:23:10 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2025/03/20 05:23:12 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:23:12 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/03/20 05:23:13 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b2181e84_d20250320_m052313_c001_v0001113_t0040_u01742448193018") 2025/03/20 05:23:13 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2025/03/20 05:23:13 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:23:13 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2025/03/20 05:23:13 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2025/03/20 05:23:14 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2025/03/20 05:23:15 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:23:16 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:23:16 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/03/20 05:23:18 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2025/03/20 05:23:18 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2025/03/20 05:23:18 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2025/03/20 05:23:18 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2025/03/20 05:23:19 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2025/03/20 05:23:21 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2025/03/20 05:23:21 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2025/03/20 05:23:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:23:23 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/03/20 05:23:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f203c9dea2b89e17c_d20250320_m052323_c001_v0001184_t0054_u01742448203638") 2025/03/20 05:23:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:23:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2025/03/20 05:23:23 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/03/20 05:23:24 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:23:26 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:23:26 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2025/03/20 05:23:28 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2025/03/20 05:23:28 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2025/03/20 05:23:28 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2025/03/20 05:23:28 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2025/03/20 05:23:30 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2025/03/20 05:23:30 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2025/03/20 05:23:30 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2025/03/20 05:23:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:23:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Streaming upload with --b2-chunk-size 8Mi allows uploads of up to 78.125Gi and will fail only when that limit is reached. 2025/03/20 05:23:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61ae6_d20250320_m052333_c001_v0001182_t0051_u01742448213309") 2025/03/20 05:23:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2025/03/20 05:23:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/20 05:23:33 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2025/03/20 05:23:35 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:23:36 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:23:36 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2025/03/20 05:23:38 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2025/03/20 05:23:38 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2025/03/20 05:23:38 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2025/03/20 05:23:38 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2025/03/20 05:23:38 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2025/03/20 05:23:38 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2025/03/20 05:23:39 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2025/03/20 05:23:41 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2025/03/20 05:23:43 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2025/03/20 05:23:43 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2025/03/20 05:23:46 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:23:46 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/03/20 05:23:47 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61af0_d20250320_m052347_c001_v0001179_t0059_u01742448227078") 2025/03/20 05:23:47 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2025/03/20 05:23:47 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:23:47 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2025/03/20 05:23:47 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2025/03/20 05:23:48 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2025/03/20 05:23:49 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:23:49 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:23:49 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/03/20 05:23:52 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2025/03/20 05:23:52 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2025/03/20 05:23:52 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2025/03/20 05:23:52 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2025/03/20 05:23:52 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2025/03/20 05:23:52 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/20 05:23:52 DEBUG : pacer: Reducing sleep to 10ms 2025/03/20 05:23:53 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2025/03/20 05:23:55 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2025/03/20 05:23:55 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2025/03/20 05:23:57 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:23:57 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/03/20 05:23:57 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f20407bc8f827a498_d20250320_m052357_c001_v0001131_t0039_u01742448237327") 2025/03/20 05:23:57 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:23:57 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2025/03/20 05:23:57 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/03/20 05:23:58 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:24:01 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:24:01 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2025/03/20 05:24:05 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2025/03/20 05:24:05 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2025/03/20 05:24:05 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2025/03/20 05:24:05 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2025/03/20 05:24:07 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2025/03/20 05:24:08 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2025/03/20 05:24:08 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2025/03/20 05:24:11 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:24:11 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/03/20 05:24:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f211aa6e54aef76bb_d20250320_m052412_c001_v0001182_t0004_u01742448252087") 2025/03/20 05:24:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2025/03/20 05:24:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2025/03/20 05:24:12 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2025/03/20 05:24:14 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:24:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:24:15 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2025/03/20 05:24:18 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2025/03/20 05:24:18 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2025/03/20 05:24:18 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2025/03/20 05:24:18 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2025/03/20 05:24:18 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2025/03/20 05:24:18 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2025/03/20 05:24:19 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2025/03/20 05:24:20 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2025/03/20 05:24:21 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2025/03/20 05:24:21 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2025/03/20 05:24:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2025/03/20 05:24:24 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/03/20 05:24:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef3b_d20250320_m052424_c001_v0001183_t0006_u01742448264184") 2025/03/20 05:24:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2025/03/20 05:24:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2025/03/20 05:24:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2025/03/20 05:24:24 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2025/03/20 05:24:25 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2025/03/20 05:24:26 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2025/03/20 05:24:27 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2025/03/20 05:24:27 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsCopyChunked === RUN TestIntegration/FsMkdir/FsCopyChunked/5242880 === RUN TestIntegration/FsMkdir/FsCopyChunked/5242881 2025/03/20 05:24:35 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zaf52adf3f0ddbb1b9f580e1b_f2143dd8edcb88e24_d20250320_m052435_c001_v0001182_t0035_u01742448275632") 2025/03/20 05:24:35 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2025/03/20 05:24:35 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/20 05:24:36 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/20 05:24:36 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/20 05:24:36 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2025/03/20 05:24:38 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/03/20 05:24:38 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/03/20 05:24:38 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/03/20 05:24:38 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2025/03/20 05:24:40 DEBUG : chunked-copy: Done sending chunk 0 2025/03/20 05:24:41 DEBUG : chunked-copy: Done sending chunk 1 2025/03/20 05:24:41 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/03/20 05:24:41 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef4c_d20250320_m052441_c001_v0001161_t0008_u01742448281760") 2025/03/20 05:24:41 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2025/03/20 05:24:41 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/20 05:24:42 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/20 05:24:42 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/20 05:24:42 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2025/03/20 05:24:45 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2025/03/20 05:24:45 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/03/20 05:24:45 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2025/03/20 05:24:45 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2025/03/20 05:24:47 DEBUG : chunked-copy: Done sending chunk 0 2025/03/20 05:24:47 DEBUG : chunked-copy: Done sending chunk 1 2025/03/20 05:24:47 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/03/20 05:24:48 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef50_d20250320_m052448_c001_v0001115_t0045_u01742448288661") 2025/03/20 05:24:48 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/03/20 05:24:48 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/20 05:24:49 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/20 05:24:49 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/20 05:24:49 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2025/03/20 05:24:51 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2025/03/20 05:24:51 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2025/03/20 05:24:52 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2025/03/20 05:24:52 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2025/03/20 05:24:54 DEBUG : chunked-copy: Done sending chunk 0 2025/03/20 05:24:54 DEBUG : chunked-copy: Done sending chunk 1 2025/03/20 05:24:54 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef53_d20250320_m052455_c001_v0001103_t0004_u01742448295007") 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Done copying chunk 2 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Done copying chunk 0 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Done copying chunk 1 2025/03/20 05:24:55 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/03/20 05:24:57 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/03/20 05:24:59 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/03/20 05:24:59 DEBUG : Creating backend with remote "TestB2:rclone-test-naqegas8ceni/deeper/nonexisting/directory" 2025/03/20 05:24:59 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/03/20 05:25:00 INFO : B2 bucket rclone-test-naqegas8ceni: cleaning bucket "rclone-test-naqegas8ceni" of all files 2025/03/20 05:25:01 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f411aa6e54aef76b4_d20250320_m052404_c001_v7007000_t0000_u01742448244574") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20407bc8f827a498_d20250320_m052357_c001_v0001131_t0039_u01742448237327") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40407bc8f827a497_d20250320_m052356_c001_v7007000_t0000_u01742448236773") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f211aa6e54aef76b0_d20250320_m052352_c001_v0001184_t0048_u01742448232099") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e1d_d20250320_m052429_c001_v7007000_t0000_u01742448269597") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef3b_d20250320_m052424_c001_v0001183_t0006_u01742448264184") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f41772f004bffef3a_d20250320_m052423_c001_v7007000_t0000_u01742448263632") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f211aa6e54aef76cb_d20250320_m052417_c001_v0001177_t0011_u01742448257532") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f411aa6e54aef76c8_d20250320_m052417_c001_v7007000_t0000_u01742448257344") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f211aa6e54aef76bb_d20250320_m052412_c001_v0001182_t0004_u01742448252087") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f411aa6e54aef76ba_d20250320_m052411_c001_v7007000_t0000_u01742448251534") 2025/03/20 05:25:01 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f211aa6e54aef76b5_d20250320_m052404_c001_v0001182_t0045_u01742448244760") 2025/03/20 05:25:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40170399efc61944_d20250320_m052157_c001_v7007000_t0000_u01742448117028") 2025/03/20 05:25:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac387_d20250320_m052152_c001_v0001113_t0011_u01742448112780") 2025/03/20 05:25:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac382_d20250320_m052147_c001_v7007000_t0000_u01742448107844") 2025/03/20 05:25:01 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac381_d20250320_m052143_c001_v0001184_t0027_u01742448103892") 2025/03/20 05:25:01 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac386_d20250320_m052152_c001_v7007000_t0000_u01742448112416") 2025/03/20 05:25:01 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac383_d20250320_m052148_c001_v0001165_t0040_u01742448108030") 2025/03/20 05:25:02 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac380_d20250320_m052143_c001_v7007000_t0000_u01742448103498") 2025/03/20 05:25:02 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac37f_d20250320_m052137_c001_v0001106_t0024_u01742448097938") 2025/03/20 05:25:02 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac37e_d20250320_m052137_c001_v7007000_t0000_u01742448097754") 2025/03/20 05:25:02 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac37d_d20250320_m052134_c001_v0001183_t0028_u01742448094347") 2025/03/20 05:25:02 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac37c_d20250320_m052133_c001_v7007000_t0000_u01742448093947") 2025/03/20 05:25:02 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac379_d20250320_m052130_c001_v0001145_t0031_u01742448090044") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40998ec220c0fa25_d20250320_m052223_c001_v7007000_t0000_u01742448143663") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9acf4d_d20250320_m052218_c001_v0001116_t0049_u01742448138904") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9acb61_d20250320_m052214_c001_v7007000_t0000_u01742448134084") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9acb5f_d20250320_m052210_c001_v0001103_t0056_u01742448130032") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9acf4c_d20250320_m052218_c001_v7007000_t0000_u01742448138401") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9acb62_d20250320_m052214_c001_v0001183_t0052_u01742448134293") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9acb5e_d20250320_m052209_c001_v7007000_t0000_u01742448129632") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61965_d20250320_m052205_c001_v0001184_t0018_u01742448125479") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40170399efc61963_d20250320_m052205_c001_v7007000_t0000_u01742448125295") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac38c_d20250320_m052201_c001_v0001178_t0055_u01742448121507") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac38b_d20250320_m052201_c001_v7007000_t0000_u01742448121117") 2025/03/20 05:25:02 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61945_d20250320_m052157_c001_v0001153_t0004_u01742448117225") 2025/03/20 05:25:02 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac378_d20250320_m052129_c001_v7007000_t0000_u01742448089846") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac377_d20250320_m052125_c001_v0001091_t0031_u01742448085584") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac376_d20250320_m052125_c001_v7007000_t0000_u01742448085196") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac374_d20250320_m052120_c001_v0001184_t0007_u01742448080887") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac373_d20250320_m052120_c001_v7007000_t0000_u01742448080701") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac370_d20250320_m052115_c001_v0001144_t0016_u01742448075657") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac36f_d20250320_m052115_c001_v7007000_t0000_u01742448075266") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f2161da9c4120b8eb_d20250320_m052111_c001_v0001183_t0054_u01742448071160") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4161da9c4120b8ea_d20250320_m052110_c001_v7007000_t0000_u01742448070971") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f201c96a9eb9ac36d_d20250320_m052106_c001_v0001040_t0055_u01742448066978") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f401c96a9eb9ac36c_d20250320_m052106_c001_v7007000_t0000_u01742448066581") 2025/03/20 05:25:03 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b217f5a0_d20250320_m052101_c001_v0001109_t0042_u01742448061000") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40170399efc61ad9_d20250320_m052318_c001_v7007000_t0000_u01742448198061") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b2181e84_d20250320_m052313_c001_v0001113_t0040_u01742448193018") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40200070b2181dbe_d20250320_m052307_c001_v7007000_t0000_u01742448187069") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b2181d77_d20250320_m052302_c001_v0001150_t0010_u01742448182392") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40200070b2181e73_d20250320_m052312_c001_v7007000_t0000_u01742448192554") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b2181dc6_d20250320_m052307_c001_v0001184_t0054_u01742448187255") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40200070b2181d76_d20250320_m052301_c001_v7007000_t0000_u01742448181929") 2025/03/20 05:25:03 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20200070b2181d73_d20250320_m052257_c001_v0001182_t0047_u01742448177120") 2025/03/20 05:25:04 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40200070b2181d72_d20250320_m052256_c001_v7007000_t0000_u01742448176932") 2025/03/20 05:25:04 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f2195f78a02eaaba0_d20250320_m052252_c001_v0001172_t0048_u01742448172937") 2025/03/20 05:25:04 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4195f78a02eaab9f_d20250320_m052252_c001_v7007000_t0000_u01742448172466") 2025/03/20 05:25:04 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20998ec220c0fa26_d20250320_m052223_c001_v0001117_t0008_u01742448143849") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f411aa6e54aef76af_d20250320_m052351_c001_v7007000_t0000_u01742448231913") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61af0_d20250320_m052347_c001_v0001179_t0059_u01742448227078") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40170399efc61aef_d20250320_m052346_c001_v7007000_t0000_u01742448226600") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61aec_d20250320_m052338_c001_v0001157_t0009_u01742448218224") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40170399efc61aeb_d20250320_m052338_c001_v7007000_t0000_u01742448218032") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61ae6_d20250320_m052333_c001_v0001182_t0051_u01742448213309") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40170399efc61ae4_d20250320_m052332_c001_v7007000_t0000_u01742448212824") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61ae0_d20250320_m052327_c001_v0001182_t0044_u01742448207724") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40170399efc61adf_d20250320_m052327_c001_v7007000_t0000_u01742448207527") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f203c9dea2b89e17c_d20250320_m052323_c001_v0001184_t0054_u01742448203638") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f403c9dea2b89e179_d20250320_m052323_c001_v7007000_t0000_u01742448203137") 2025/03/20 05:25:04 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f20170399efc61adb_d20250320_m052318_c001_v0001098_t0044_u01742448198247") 2025/03/20 05:25:04 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f41772f004bffef55_d20250320_m052457_c001_v7007000_t0000_u01742448297650") 2025/03/20 05:25:04 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f2143dd8edcb88e35_d20250320_m052451_c001_v0001183_t0020_u01742448291678") 2025/03/20 05:25:04 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e34_d20250320_m052451_c001_v7007000_t0000_u01742448291127") 2025/03/20 05:25:05 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f2143dd8edcb88e30_d20250320_m052445_c001_v0001183_t0056_u01742448285340") 2025/03/20 05:25:05 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e2f_d20250320_m052444_c001_v7007000_t0000_u01742448284754") 2025/03/20 05:25:05 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f2143dd8edcb88e29_d20250320_m052438_c001_v0001101_t0053_u01742448278298") 2025/03/20 05:25:05 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e28_d20250320_m052437_c001_v7007000_t0000_u01742448277659") 2025/03/20 05:25:05 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c921df2_d20250320_m052434_c001_v0001182_t0024_u01742448274105") 2025/03/20 05:25:05 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e20_d20250320_m052433_c001_v7007000_t0000_u01742448273706") 2025/03/20 05:25:05 DEBUG : chunked-copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c921d8e_d20250320_m052430_c001_v0001182_t0041_u01742448270446") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f41772f004bffef54_d20250320_m052457_c001_v7007000_t0000_u01742448297466") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef53_d20250320_m052455_c001_v0001103_t0004_u01742448295007") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e33_d20250320_m052450_c001_v7007000_t0000_u01742448290943") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef50_d20250320_m052448_c001_v0001115_t0045_u01742448288661") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e2e_d20250320_m052444_c001_v7007000_t0000_u01742448284563") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f21772f004bffef4c_d20250320_m052441_c001_v0001161_t0008_u01742448281760") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e27_d20250320_m052437_c001_v7007000_t0000_u01742448277469") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f2143dd8edcb88e24_d20250320_m052435_c001_v0001182_t0035_u01742448275632") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f4143dd8edcb88e1f_d20250320_m052433_c001_v7007000_t0000_u01742448273522") 2025/03/20 05:25:05 DEBUG : chunked-copy.copy: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f101f1841511e45db_d20250320_m052432_c001_v0001113_t0024_u01742448272379") 2025/03/20 05:25:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f1086b0f94981cc37_d20250320_m051941_c001_v0001181_t0033_u01742447981116") 2025/03/20 05:25:05 DEBUG : unknown-size-put.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f41772f004bffef56_d20250320_m052458_c001_v7007000_t0000_u01742448298408") 2025/03/20 05:25:06 DEBUG : unknown-size-put.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c92205a_d20250320_m052458_c001_v0001182_t0029_u01742448298205") 2025/03/20 05:25:06 DEBUG : unknown-size-update.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f41772f004bffef58_d20250320_m052459_c001_v7007000_t0000_u01742448299365") 2025/03/20 05:25:06 DEBUG : unknown-size-update.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c922074_d20250320_m052459_c001_v0001182_t0055_u01742448299169") 2025/03/20 05:25:06 DEBUG : unknown-size-update.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f116988c97c922064_d20250320_m052458_c001_v0001182_t0008_u01742448298597") 2025/03/20 05:25:06 DEBUG : versions/test-versions.txt: Deleting (id "4_zaf52adf3f0ddbb1b9f580e1b_f40200070b217f596_d20250320_m052057_c001_v7007000_t0000_u01742448057070") 2025/03/20 05:25:07 INFO : B2 bucket rclone-test-naqegas8ceni: cleaning bucket "rclone-test-naqegas8ceni" of all files === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- PASS: TestIntegration (363.60s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.56s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.43s) --- PASS: TestIntegration/FsMkdir (360.22s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.55s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.19s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding (20.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (1.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (1.14s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.97s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.04s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.12s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (8.69s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (80.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.56s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (1.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (4.28s) --- 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.19s) --- 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.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (7.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (1.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.65s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.56s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (30.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize/GzipEncoding/NoDecompress (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB (6.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (19.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (1.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (1.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/DryRun (0.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup/RealThing (4.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished (2.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished (2.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/DryRun (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/CleanupUnfinished/CleanupUnfinished/RealThing (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules (1.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/InitState (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/DryRun (0.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/LifecycleRules/RealThing (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (208.79s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (29.05s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (10.16s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (4.38s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (9.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (5.44s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (9.15s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (27.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (7.90s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (10.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (9.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.61s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (26.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (8.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (4.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.46s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (9.57s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (5.19s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (54.40s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (33.28s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (10.13s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (5.14s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (10.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.50s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (33.86s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (9.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (4.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (10.50s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (5.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (13.88s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.32s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (37.68s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (12.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (7.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (12.77s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (5.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (12.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (5.96s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (28.05s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.11s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (3.95s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (7.09s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (6.37s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (6.53s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (1.72s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.76s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.96s) --- 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 363.625s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 6m4.439928561s (try 1/5)