"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:181: potato: want error strconv.ParseInt: parsing "potato": invalid syntax got error --- PASS: TestParseTimeString (0.00s) === RUN TestIntegration fstests.go:442: Using remote "TestB2:" 2024/12/19 05:08:50 DEBUG : Creating backend with remote "TestB2:rclone-test-dazitaw0beci" 2024/12/19 05:08:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap fstests.go:483: 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 2024/12/19 05:08:53 DEBUG : dir/subdir: Making directory fstest.go:244: Filtering empty directory "dir" fstest.go:244: Filtering empty directory "dir/subdir" 2024/12/19 05:08:53 INFO : dir/subdir: Removing directory fstest.go:244: Filtering empty directory "dir" 2024/12/19 05:08:53 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:711: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:711: testing "." === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:711: testing ".." === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:711: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:711: testing " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:711: testing "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:711: testing "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:711: testing "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:711: testing "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:711: testing "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:711: testing ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:711: testing "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:711: testing "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:711: testing "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:711: testing "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:711: testing "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:711: testing "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:711: testing "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:711: testing "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:790: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter 2024/12/19 05:09:24 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. 2024/12/19 05:09:24 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 1 length 5242880 2024/12/19 05:09:27 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 1 2024/12/19 05:09:27 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 2 length 1048576 2024/12/19 05:09:28 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 2 2024/12/19 05:09:28 DEBUG : writer-at-subdir/writer-at-file: Sending chunk 0 length 5242880 2024/12/19 05:09:29 DEBUG : writer-at-subdir/writer-at-file: Done sending chunk 0 2024/12/19 05:09:29 DEBUG : writer-at-subdir/writer-at-file: Finishing large file upload with 0 parts === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:872: 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 2024/12/19 05:09:37 DEBUG : Creating backend with remote "TestB2:" 2024/12/19 05:09:37 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2024/12/19 05:09:38 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:1125: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2024/12/19 05:09:43 INFO : B2 bucket rclone-test-dazitaw0beci: cleaning bucket "rclone-test-dazitaw0beci" of all files 2024/12/19 05:09:43 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca90_d20241219_m050942_c001_v0001109_t0037_u01734584982453") === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2024/12/19 05:09:45 DEBUG : Creating backend with remote "TestB2:rclone-test-dazitaw0beci/dirToPurgeFromRoot" 2024/12/19 05:09:46 INFO : B2 bucket rclone-test-dazitaw0beci path dirToPurgeFromRoot: cleaning bucket "rclone-test-dazitaw0beci" of all files 2024/12/19 05:09:47 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca9e_d20241219_m050944_c001_v0001109_t0058_u01734584984448") === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2024/12/19 05:09:47 DEBUG : Creating backend with remote "TestB2:rclone-test-dazitaw0beci/hello? sausage/êé" 2024/12/19 05:09:51 INFO : B2 bucket rclone-test-dazitaw0beci path hello? sausage/êé: cleaning bucket "rclone-test-dazitaw0beci" of all files 2024/12/19 05:09:52 DEBUG : a/b/c/d/e.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f10722e185ac36409_d20241219_m050950_c001_v0001103_t0020_u01734584990253") === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1293: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1346: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1463: 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:1627: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1698: 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 2024/12/19 05:10:01 DEBUG : Creating backend with remote "TestB2:rclone-test-dazitaw0beci/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2024/12/19 05:10:01 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2024/12/19 05:10:03 DEBUG : Creating backend with remote "TestB2:rclone-test-dazitaw0beci/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1915: Opening root remote "TestB2:" path "rclone-test-dazitaw0beci" from "TestB2:rclone-test-dazitaw0beci" 2024/12/19 05:10:04 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 2024/12/19 05:10:16 DEBUG : Creating backend with remote "TestB2:rclone-test-xazihub1hodi" 2024/12/19 05:10:19 DEBUG : B2 bucket rclone-test-xazihub1hodi: Purge remote 2024/12/19 05:10:19 INFO : B2 bucket rclone-test-xazihub1hodi: cleaning bucket "rclone-test-xazihub1hodi" of all files 2024/12/19 05:10:20 DEBUG : somefile: Deleting (id "4_z3f12ed53502ddbdb9f380e1b_f4172b27c42a1abb6_d20241219_m051018_c001_v0001182_t0040_u01734585018893") === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:416: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2113: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2147: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2024/12/19 05:10:21 DEBUG : piped data.txt: File has 0 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2024/12/19 05:10:22 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 2024/12/19 05:10:25 DEBUG : test-metadata: multipart upload: starting chunk 0 size 6Mi offset 0/6.106Mi 2024/12/19 05:10:25 DEBUG : test-metadata: Sending chunk 0 length 6291456 2024/12/19 05:10:25 DEBUG : test-metadata: multipart upload: starting chunk 1 size 108.904Ki offset 6Mi/6.106Mi 2024/12/19 05:10:25 DEBUG : test-metadata: Sending chunk 1 length 111518 2024/12/19 05:10:27 DEBUG : test-metadata: Done sending chunk 1 2024/12/19 05:10:27 DEBUG : test-metadata: Done sending chunk 0 2024/12/19 05:10:27 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 2024/12/19 05:10:38 DEBUG : versions/test-versions.txt: Clearing upload URL because of error: Post "https://pod-000-1109-02.backblaze.com/b2api/v1/b2_upload_file/5f929d93501ddbdb9f380e1b/c001_v0001109_t0007": EOF 2024/12/19 05:10:38 DEBUG : pacer: low level retry 1/1 (error Post "https://pod-000-1109-02.backblaze.com/b2api/v1/b2_upload_file/5f929d93501ddbdb9f380e1b/c001_v0001109_t0007": EOF) 2024/12/19 05:10:38 DEBUG : pacer: Rate limited, increasing sleep to 20ms fstests.go:142: Put error: Post "https://pod-000-1109-02.backblaze.com/b2api/v1/b2_upload_file/5f929d93501ddbdb9f380e1b/c001_v0001109_t0007": EOF - low level retry 1/10 2024/12/19 05:10:40 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:361: versions/test-versions.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent === NAME TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions b2_internal_test.go:361: versions/test-versions-v2024-12-19-051033-101.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 2024/12/19 05:10:43 DEBUG : oldPath = "TestB2:rclone-test-dazitaw0beci/versions/test-versions-v2024-12-19-051033-101.txt" 2024/12/19 05:10:43 DEBUG : newPath = "TestB2,versions:rclone-test-dazitaw0beci/versions/test-versions-v2024-12-19-051033-101.txt" 2024/12/19 05:10:43 DEBUG : Creating backend with remote "TestB2,versions:rclone-test-dazitaw0beci/versions/test-versions-v2024-12-19-051033-101.txt" 2024/12/19 05:10:43 DEBUG : Config file has changed externally - reloading 2024/12/19 05:10:43 DEBUG : TestB2: detected overridden config - adding "{pO73u}" suffix to name 2024/12/19 05:10:45 DEBUG : fs cache: renaming child cache item "TestB2,versions:rclone-test-dazitaw0beci/versions/test-versions-v2024-12-19-051033-101.txt" to be canonical for parent "TestB2{pO73u}:rclone-test-dazitaw0beci/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 2024/12/19 05:10:46 INFO : B2 bucket rclone-test-dazitaw0beci: cleaning bucket "rclone-test-dazitaw0beci" of all hidden files 2024/12/19 05:10:46 DEBUG : leading space/ leading space: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732424c_d20241219_m050902_c001_v7007000_t0000_u01734584942747") as it is a hide marker 2024/12/19 05:10:46 DEBUG : leading space/ leading space: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9ab_d20241219_m050901_c001_v0001109_t0019_u01734584941526") 2024/12/19 05:10:46 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732424b_d20241219_m050901_c001_v7007000_t0000_u01734584941164") as it is a hide marker 2024/12/19 05:10:46 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c99d_d20241219_m050859_c001_v0001109_t0048_u01734584939988") 2024/12/19 05:10:46 DEBUG : .leading dot/.leading dot: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732425b_d20241219_m050911_c001_v7007000_t0000_u01734584951207") as it is a hide marker 2024/12/19 05:10:46 DEBUG : .leading dot/.leading dot: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9df_d20241219_m050910_c001_v0001109_t0046_u01734584950071") 2024/12/19 05:10:46 DEBUG : created from root.txt: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f40556f170dff20f0_d20241219_m051012_c001_v7007000_t0000_u01734585012679") as it is a hide marker 2024/12/19 05:10:46 DEBUG : created from root.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f105654ef30c22b63_d20241219_m051011_c001_v0001120_t0037_u01734585011198") 2024/12/19 05:10:46 DEBUG : file name.txt: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f41963de4df0c60fa_d20241219_m051021_c001_v7007000_t0000_u01734585021082") as it is a hide marker 2024/12/19 05:10:46 DEBUG : file name.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1cadb_d20241219_m051000_c001_v0001109_t0041_u01734585000005") 2024/12/19 05:10:46 DEBUG : file name.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f111ab3b714a9190f_d20241219_m050956_c001_v0001183_t0010_u01734584996460") 2024/12/19 05:10:47 DEBUG : file name.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca61_d20241219_m050934_c001_v0001109_t0056_u01734584974384") 2024/12/19 05:10:47 DEBUG : file name.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca57_d20241219_m050932_c001_v0001109_t0052_u01734584972943") 2024/12/19 05:10:47 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca59_d20241219_m050933_c001_v0001109_t0028_u01734584973686") "upload" dated 2024-12-19 05:09:33.686 +0000 UTC (1m13.426876106s ago) 2024/12/19 05:10:47 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f407f961c8252cd08_d20241219_m050954_c001_v7007000_t0000_u01734584994242") as it is a hide marker 2024/12/19 05:10:47 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1015f7324a4b84e5_d20241219_m050953_c001_v0001182_t0046_u01734584993991") 2024/12/19 05:10:47 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f104e0a9b8c8bee5e_d20241219_m050953_c001_v0001103_t0019_u01734584993298") 2024/12/19 05:10:47 DEBUG : invalid utf-8�/invalid utf-8�: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324263_d20241219_m050921_c001_v7007000_t0000_u01734584961442") as it is a hide marker 2024/12/19 05:10:47 DEBUG : invalid utf-8�/invalid utf-8�: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca11_d20241219_m050920_c001_v0001109_t0004_u01734584960240") 2024/12/19 05:10:47 DEBUG : piped data.txt: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f41963de4df0c6101_d20241219_m051023_c001_v7007000_t0000_u01734585023134") as it is a hide marker 2024/12/19 05:10:47 DEBUG : piped data.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1cb45_d20241219_m051022_c001_v0001109_t0003_u01734585022417") 2024/12/19 05:10:47 DEBUG : piped data.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f41963de4df0c60fe_d20241219_m051022_c001_v7007000_t0000_u01734585022218") 2024/12/19 05:10:47 DEBUG : piped data.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4022590c50a1cb43_d20241219_m051021_c001_v0001109_t0007_u01734585021836") 2024/12/19 05:10:47 DEBUG : test%46.txt/test%46.txt: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324264_d20241219_m050922_c001_v7007000_t0000_u01734584962739") as it is a hide marker 2024/12/19 05:10:47 DEBUG : test%46.txt/test%46.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca1d_d20241219_m050921_c001_v0001109_t0026_u01734584961805") 2024/12/19 05:10:47 DEBUG : test-metadata: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f401c0328946e4081_d20241219_m051030_c001_v7007000_t0000_u01734585030553") as it is a hide marker 2024/12/19 05:10:47 DEBUG : test-metadata: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f21963de4df0c610a_d20241219_m051025_c001_v0001183_t0057_u01734585025299") 2024/12/19 05:10:47 DEBUG : test-metadata: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f41963de4df0c6104_d20241219_m051024_c001_v7007000_t0000_u01734585024504") 2024/12/19 05:10:47 DEBUG : test-metadata: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1cb4b_d20241219_m051023_c001_v0001109_t0048_u01734585023318") 2024/12/19 05:10:47 DEBUG : trailing CR␍/trailing CR␍: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732425d_d20241219_m050914_c001_v7007000_t0000_u01734584954005") as it is a hide marker 2024/12/19 05:10:47 DEBUG : trailing CR␍/trailing CR␍: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9e7_d20241219_m050913_c001_v0001109_t0006_u01734584953054") 2024/12/19 05:10:47 DEBUG : trailing HT␉/trailing HT␉: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324260_d20241219_m050917_c001_v7007000_t0000_u01734584957149") as it is a hide marker 2024/12/19 05:10:48 DEBUG : trailing HT␉/trailing HT␉: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9f7_d20241219_m050916_c001_v0001109_t0029_u01734584956307") 2024/12/19 05:10:48 DEBUG : trailing LF␊/trailing LF␊: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732425f_d20241219_m050915_c001_v7007000_t0000_u01734584955943") as it is a hide marker 2024/12/19 05:10:48 DEBUG : trailing LF␊/trailing LF␊: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9ed_d20241219_m050914_c001_v0001109_t0051_u01734584954370") 2024/12/19 05:10:48 DEBUG : trailing VT␋/trailing VT␋: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324261_d20241219_m050918_c001_v7007000_t0000_u01734584958459") as it is a hide marker 2024/12/19 05:10:48 DEBUG : trailing VT␋/trailing VT␋: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9ff_d20241219_m050917_c001_v0001109_t0053_u01734584957511") 2024/12/19 05:10:48 DEBUG : trailing dot./trailing dot.: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324262_d20241219_m050919_c001_v7007000_t0000_u01734584959877") as it is a hide marker 2024/12/19 05:10:48 DEBUG : trailing dot./trailing dot.: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca05_d20241219_m050918_c001_v0001109_t0028_u01734584958916") 2024/12/19 05:10:48 DEBUG : trailing space /trailing space : Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732425c_d20241219_m050912_c001_v7007000_t0000_u01734584952692") as it is a hide marker 2024/12/19 05:10:48 DEBUG : trailing space /trailing space : Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9e1_d20241219_m050911_c001_v0001109_t0019_u01734584951569") 2024/12/19 05:10:48 DEBUG : versions/test-versions.txt: Not deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f1195bb722760b64d_d20241219_m051041_c001_v0001104_t0005_u01734585041347") "upload" dated 2024-12-19 05:10:41.347 +0000 UTC (7.161486833s ago) 2024/12/19 05:10:48 DEBUG : versions/test-versions.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f408de58c6774d3f7_d20241219_m051036_c001_v7007000_t0000_u01734585036528") 2024/12/19 05:10:48 DEBUG : versions/test-versions.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1cb7d_d20241219_m051033_c001_v0001109_t0025_u01734585033101") 2024/12/19 05:10:48 DEBUG : writer-at-subdir/writer-at-file: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324277_d20241219_m050932_c001_v7007000_t0000_u01734584972396") as it is a hide marker 2024/12/19 05:10:48 DEBUG : writer-at-subdir/writer-at-file: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f211502e0f7324268_d20241219_m050924_c001_v0001104_t0008_u01734584964837") 2024/12/19 05:10:48 DEBUG : zero-length-file: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324266_d20241219_m050924_c001_v7007000_t0000_u01734584964583") as it is a hide marker 2024/12/19 05:10:48 DEBUG : zero-length-file: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4022590c50a1ca2d_d20241219_m050924_c001_v0001109_t0007_u01734584964034") 2024/12/19 05:10:48 DEBUG : ~leading tilde/~leading tilde: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732424d_d20241219_m050903_c001_v7007000_t0000_u01734584943956") as it is a hide marker 2024/12/19 05:10:48 DEBUG : ~leading tilde/~leading tilde: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9af_d20241219_m050903_c001_v0001109_t0042_u01734584943112") 2024/12/19 05:10:48 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324244_d20241219_m050857_c001_v7007000_t0000_u01734584937101") as it is a hide marker 2024/12/19 05:10:49 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c975_d20241219_m050855_c001_v0001109_t0006_u01734584935504") 2024/12/19 05:10:49 DEBUG : ␉leading HT/␉leading HT: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324257_d20241219_m050908_c001_v7007000_t0000_u01734584948392") as it is a hide marker 2024/12/19 05:10:49 DEBUG : ␉leading HT/␉leading HT: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9d3_d20241219_m050907_c001_v0001109_t0004_u01734584947486") 2024/12/19 05:10:49 DEBUG : ␊leading LF/␊leading LF: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324254_d20241219_m050907_c001_v7007000_t0000_u01734584947124") as it is a hide marker 2024/12/19 05:10:49 DEBUG : ␊leading LF/␊leading LF: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9c7_d20241219_m050905_c001_v0001109_t0000_u01734584945716") 2024/12/19 05:10:49 DEBUG : ␋leading VT/␋leading VT: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732425a_d20241219_m050909_c001_v7007000_t0000_u01734584949708") as it is a hide marker 2024/12/19 05:10:49 DEBUG : ␋leading VT/␋leading VT: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9db_d20241219_m050908_c001_v0001109_t0020_u01734584948754") 2024/12/19 05:10:49 DEBUG : ␍leading CR/␍leading CR: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f732424f_d20241219_m050905_c001_v7007000_t0000_u01734584945354") as it is a hide marker 2024/12/19 05:10:49 DEBUG : ␍leading CR/␍leading CR: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c9bd_d20241219_m050904_c001_v0001109_t0024_u01734584944321") 2024/12/19 05:10:49 DEBUG : ./.: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324246_d20241219_m050858_c001_v7007000_t0000_u01734584938358") as it is a hide marker 2024/12/19 05:10:49 DEBUG : ./.: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c97f_d20241219_m050857_c001_v0001109_t0035_u01734584937464") 2024/12/19 05:10:49 DEBUG : ../..: Deleting current version (id "4_z5f929d93501ddbdb9f380e1b_f411502e0f7324248_d20241219_m050859_c001_v7007000_t0000_u01734584939624") as it is a hide marker 2024/12/19 05:10:49 DEBUG : ../..: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1c98d_d20241219_m050858_c001_v0001109_t0058_u01734584938719") === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 2024/12/19 05:10:50 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5.000Mi 2024/12/19 05:10:50 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 0 length 5242880 2024/12/19 05:10:50 DEBUG : chunked-5Mi-5.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 5Mi/5.000Mi 2024/12/19 05:10:51 DEBUG : chunked-5Mi-5.000Mi.bin: Sending chunk 1 length 1 2024/12/19 05:10:51 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 1 2024/12/19 05:10:53 DEBUG : chunked-5Mi-5.000Mi.bin: Done sending chunk 0 2024/12/19 05:10:53 DEBUG : chunked-5Mi-5.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed 2024/12/19 05:10:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:10:56 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. 2024/12/19 05:10:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d82f0_d20241219_m051056_c001_v0001181_t0009_u01734585056280") 2024/12/19 05:10:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:10:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 1 length 1 2024/12/19 05:10:56 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Sending chunk 0 length 5242880 2024/12/19 05:10:57 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:10:58 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:10:58 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 2024/12/19 05:11:00 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10Mi 2024/12/19 05:11:00 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 0 length 5242880 2024/12/19 05:11:00 DEBUG : chunked-5Mi-10Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10Mi 2024/12/19 05:11:00 DEBUG : chunked-5Mi-10Mi.bin: Sending chunk 1 length 5242880 2024/12/19 05:11:02 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 0 2024/12/19 05:11:02 DEBUG : chunked-5Mi-10Mi.bin: Done sending chunk 1 2024/12/19 05:11:02 DEBUG : chunked-5Mi-10Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed 2024/12/19 05:11:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:11:04 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. 2024/12/19 05:11:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d831b_d20241219_m051104_c001_v0001165_t0056_u01734585064467") 2024/12/19 05:11:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 0 length 5242880 2024/12/19 05:11:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2024/12/19 05:11:04 DEBUG : chunked-5Mi-10Mi-streamed.bin: Sending chunk 1 length 5242880 2024/12/19 05:11:06 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:11:06 DEBUG : chunked-5Mi-10Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:11:06 DEBUG : chunked-5Mi-10Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2024/12/19 05:11:08 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2024/12/19 05:11:08 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 0 length 5242880 2024/12/19 05:11:08 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2024/12/19 05:11:08 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 2 length 1 2024/12/19 05:11:08 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2024/12/19 05:11:08 DEBUG : chunked-5Mi-10.000Mi.bin: Sending chunk 1 length 5242880 2024/12/19 05:11:10 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 2 2024/12/19 05:11:11 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 0 2024/12/19 05:11:11 DEBUG : chunked-5Mi-10.000Mi.bin: Done sending chunk 1 2024/12/19 05:11:11 DEBUG : chunked-5Mi-10.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2024/12/19 05:11:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:11:13 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. 2024/12/19 05:11:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee84eb_d20241219_m051113_c001_v0001165_t0020_u01734585073451") 2024/12/19 05:11:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 0 length 5242880 2024/12/19 05:11:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:11:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 2 length 1 2024/12/19 05:11:13 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Sending chunk 1 length 5242880 2024/12/19 05:11:14 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 2 2024/12/19 05:11:16 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:11:16 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:11:16 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 2024/12/19 05:11:17 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.054Mi/5.054Mi 2024/12/19 05:11:17 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2024/12/19 05:11:17 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 1 length 1 2024/12/19 05:11:17 DEBUG : chunked-5.054Mi-5.054Mi.bin: Sending chunk 0 length 5300000 2024/12/19 05:11:18 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 1 2024/12/19 05:11:20 DEBUG : chunked-5.054Mi-5.054Mi.bin: Done sending chunk 0 2024/12/19 05:11:20 DEBUG : chunked-5.054Mi-5.054Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed 2024/12/19 05:11:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:11:21 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. 2024/12/19 05:11:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83a9_d20241219_m051121_c001_v0001128_t0023_u01734585081877") 2024/12/19 05:11:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:11:21 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 1 length 1 2024/12/19 05:11:22 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Sending chunk 0 length 5300000 2024/12/19 05:11:22 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:11:24 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:11:24 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 2024/12/19 05:11:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2024/12/19 05:11:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2024/12/19 05:11:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2024/12/19 05:11:25 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2024/12/19 05:11:28 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2024/12/19 05:11:28 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2024/12/19 05:11:28 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed 2024/12/19 05:11:29 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:11:29 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. 2024/12/19 05:11:30 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83b5_d20241219_m051129_c001_v0001036_t0035_u01734585089994") 2024/12/19 05:11:30 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2024/12/19 05:11:30 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2024/12/19 05:11:30 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2024/12/19 05:11:32 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:11:32 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:11:32 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2024/12/19 05:11:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2024/12/19 05:11:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 0 length 5300000 2024/12/19 05:11:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2024/12/19 05:11:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 2 length 1 2024/12/19 05:11:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2024/12/19 05:11:34 DEBUG : chunked-5.054Mi-10.109Mi.bin: Sending chunk 1 length 5300000 2024/12/19 05:11:35 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 2 2024/12/19 05:11:36 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 0 2024/12/19 05:11:37 DEBUG : chunked-5.054Mi-10.109Mi.bin: Done sending chunk 1 2024/12/19 05:11:37 DEBUG : chunked-5.054Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2024/12/19 05:11:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:11:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Streaming upload with --b2-chunk-size 5.054Mi allows uploads of up to 49.360Gi and will fail only when that limit is reached. 2024/12/19 05:11:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83c1_d20241219_m051138_c001_v0001092_t0030_u01734585098881") 2024/12/19 05:11:38 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300000 2024/12/19 05:11:39 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:11:39 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2024/12/19 05:11:39 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300000 2024/12/19 05:11:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 2 2024/12/19 05:11:41 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:11:41 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:11:41 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 2024/12/19 05:11:43 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2024/12/19 05:11:43 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 0 length 5300053 2024/12/19 05:11:43 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 1 size 1 offset 5.055Mi/5.055Mi 2024/12/19 05:11:43 DEBUG : chunked-5.055Mi-5.055Mi.bin: Sending chunk 1 length 1 2024/12/19 05:11:44 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 1 2024/12/19 05:11:46 DEBUG : chunked-5.055Mi-5.055Mi.bin: Done sending chunk 0 2024/12/19 05:11:46 DEBUG : chunked-5.055Mi-5.055Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed 2024/12/19 05:11:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:11:48 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. 2024/12/19 05:11:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee851f_d20241219_m051148_c001_v0001183_t0056_u01734585108128") 2024/12/19 05:11:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:11:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 1 length 1 2024/12/19 05:11:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Sending chunk 0 length 5300053 2024/12/19 05:11:48 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:11:50 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:11:50 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 2024/12/19 05:11:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2024/12/19 05:11:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2024/12/19 05:11:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2024/12/19 05:11:52 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2024/12/19 05:11:54 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2024/12/19 05:11:54 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2024/12/19 05:11:54 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed 2024/12/19 05:11:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:11:56 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. 2024/12/19 05:11:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee8529_d20241219_m051156_c001_v0001102_t0014_u01734585116405") 2024/12/19 05:11:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2024/12/19 05:11:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2024/12/19 05:11:56 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2024/12/19 05:11:58 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:11:59 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:11:59 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2024/12/19 05:12:00 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2024/12/19 05:12:00 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 0 length 5300053 2024/12/19 05:12:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2024/12/19 05:12:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2024/12/19 05:12:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 2 length 1 2024/12/19 05:12:01 DEBUG : chunked-5.055Mi-10.109Mi.bin: Sending chunk 1 length 5300053 2024/12/19 05:12:02 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 2 2024/12/19 05:12:03 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 0 2024/12/19 05:12:03 DEBUG : chunked-5.055Mi-10.109Mi.bin: Done sending chunk 1 2024/12/19 05:12:03 DEBUG : chunked-5.055Mi-10.109Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2024/12/19 05:12:04 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:12:04 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. 2024/12/19 05:12:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f2053fe083c317706_d20241219_m051205_c001_v0001157_t0031_u01734585125053") 2024/12/19 05:12:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 0 length 5300053 2024/12/19 05:12:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:12:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 2 length 1 2024/12/19 05:12:05 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Sending chunk 1 length 5300053 2024/12/19 05:12:06 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 2 2024/12/19 05:12:07 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:12:07 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:12:07 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 2024/12/19 05:12:09 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 1 size 1 offset 6.667Mi/6.667Mi 2024/12/19 05:12:09 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 1 length 1 2024/12/19 05:12:09 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2024/12/19 05:12:09 DEBUG : chunked-6.667Mi-6.667Mi.bin: Sending chunk 0 length 6990506 2024/12/19 05:12:10 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 1 2024/12/19 05:12:12 DEBUG : chunked-6.667Mi-6.667Mi.bin: Done sending chunk 0 2024/12/19 05:12:12 DEBUG : chunked-6.667Mi-6.667Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed 2024/12/19 05:12:13 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:12:13 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. 2024/12/19 05:12:13 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d840a_d20241219_m051213_c001_v0001183_t0005_u01734585133576") 2024/12/19 05:12:13 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:12:13 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 1 length 1 2024/12/19 05:12:13 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Sending chunk 0 length 6990506 2024/12/19 05:12:14 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:12:16 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:12:16 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 2024/12/19 05:12:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2024/12/19 05:12:17 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2024/12/19 05:12:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2024/12/19 05:12:18 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2024/12/19 05:12:20 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2024/12/19 05:12:20 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2024/12/19 05:12:20 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed 2024/12/19 05:12:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:12:22 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. 2024/12/19 05:12:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f2053fe083c31777c_d20241219_m051222_c001_v0001104_t0002_u01734585142433") 2024/12/19 05:12:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2024/12/19 05:12:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2024/12/19 05:12:22 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2024/12/19 05:12:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:12:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:12:25 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2024/12/19 05:12:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2024/12/19 05:12:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 0 length 6990506 2024/12/19 05:12:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2024/12/19 05:12:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 2 length 1 2024/12/19 05:12:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2024/12/19 05:12:27 DEBUG : chunked-6.667Mi-13.333Mi.bin: Sending chunk 1 length 6990506 2024/12/19 05:12:28 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 2 2024/12/19 05:12:30 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 0 2024/12/19 05:12:30 DEBUG : chunked-6.667Mi-13.333Mi.bin: Done sending chunk 1 2024/12/19 05:12:30 DEBUG : chunked-6.667Mi-13.333Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2024/12/19 05:12:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:12:32 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. 2024/12/19 05:12:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f201c0328946e40ba_d20241219_m051232_c001_v0001101_t0018_u01734585152791") 2024/12/19 05:12:32 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 0 length 6990506 2024/12/19 05:12:33 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:12:33 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 2 length 1 2024/12/19 05:12:33 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Sending chunk 1 length 6990506 2024/12/19 05:12:33 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2024/12/19 05:12:33 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/12/19 05:12:33 DEBUG : pacer: Reducing sleep to 10ms 2024/12/19 05:12:34 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 2 2024/12/19 05:12:35 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:12:35 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:12:35 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 2024/12/19 05:12:38 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 8Mi/8.000Mi 2024/12/19 05:12:38 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 1 length 1 2024/12/19 05:12:38 DEBUG : chunked-8Mi-8.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8.000Mi 2024/12/19 05:12:38 DEBUG : chunked-8Mi-8.000Mi.bin: Sending chunk 0 length 8388608 2024/12/19 05:12:38 DEBUG : pacer: low level retry 1/10 (error Post "https://api001.backblazeb2.com/b2api/v1/b2_get_upload_part_url": EOF) 2024/12/19 05:12:38 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/12/19 05:12:38 DEBUG : pacer: Reducing sleep to 10ms 2024/12/19 05:12:39 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 1 2024/12/19 05:12:41 DEBUG : chunked-8Mi-8.000Mi.bin: Done sending chunk 0 2024/12/19 05:12:41 DEBUG : chunked-8Mi-8.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed 2024/12/19 05:12:42 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:12:42 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. 2024/12/19 05:12:42 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f2037a3d80d710369_d20241219_m051242_c001_v0001104_t0029_u01734585162871") 2024/12/19 05:12:42 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:12:42 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 1 length 1 2024/12/19 05:12:42 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Sending chunk 0 length 8388608 2024/12/19 05:12:44 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:12:46 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:12:46 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 2024/12/19 05:12:50 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16Mi 2024/12/19 05:12:50 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 0 length 8388608 2024/12/19 05:12:50 DEBUG : chunked-8Mi-16Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16Mi 2024/12/19 05:12:50 DEBUG : chunked-8Mi-16Mi.bin: Sending chunk 1 length 8388608 2024/12/19 05:12:53 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 1 2024/12/19 05:12:56 DEBUG : chunked-8Mi-16Mi.bin: Done sending chunk 0 2024/12/19 05:12:56 DEBUG : chunked-8Mi-16Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed 2024/12/19 05:13:00 DEBUG : chunked-8Mi-16Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:13:00 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. 2024/12/19 05:13:00 DEBUG : chunked-8Mi-16Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f204a251e7ef90288_d20241219_m051300_c001_v0001178_t0032_u01734585180633") 2024/12/19 05:13:00 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 0 length 8388608 2024/12/19 05:13:00 DEBUG : chunked-8Mi-16Mi-streamed.bin: Sending chunk 1 length 8388608 2024/12/19 05:13:00 DEBUG : chunked-8Mi-16Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2024/12/19 05:13:03 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:13:03 DEBUG : chunked-8Mi-16Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:13:03 DEBUG : chunked-8Mi-16Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2024/12/19 05:13:05 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2024/12/19 05:13:05 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 0 length 8388608 2024/12/19 05:13:05 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2024/12/19 05:13:05 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 2 length 1 2024/12/19 05:13:05 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2024/12/19 05:13:05 DEBUG : chunked-8Mi-16.000Mi.bin: Sending chunk 1 length 8388608 2024/12/19 05:13:06 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 2 2024/12/19 05:13:08 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 0 2024/12/19 05:13:08 DEBUG : chunked-8Mi-16.000Mi.bin: Done sending chunk 1 2024/12/19 05:13:08 DEBUG : chunked-8Mi-16.000Mi.bin: Finishing large file upload with 3 parts === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2024/12/19 05:13:10 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:13:10 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. 2024/12/19 05:13:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f2024221b764d0b83_d20241219_m051310_c001_v0001145_t0045_u01734585190956") 2024/12/19 05:13:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 0 length 8388608 2024/12/19 05:13:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:13:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2024/12/19 05:13:11 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 1 length 8388608 2024/12/19 05:13:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Error sending chunk 2 (retry=true): connection interrupted, retry request (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000351ad0), retryAfter:1000000000} 2024/12/19 05:13:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Clearing part upload URL because of error: connection interrupted, retry request (503 service_unavailable) 2024/12/19 05:13:12 DEBUG : pacer: low level retry 1/10 (error connection interrupted, retry request (503 service_unavailable)) 2024/12/19 05:13:12 DEBUG : pacer: Rate limited, increasing sleep to 1s 2024/12/19 05:13:12 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Sending chunk 2 length 1 2024/12/19 05:13:13 DEBUG : pacer: Reducing sleep to 500ms 2024/12/19 05:13:13 DEBUG : pacer: Reducing sleep to 250ms 2024/12/19 05:13:13 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:13:13 DEBUG : pacer: Reducing sleep to 125ms 2024/12/19 05:13:13 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 2 2024/12/19 05:13:14 DEBUG : pacer: Reducing sleep to 62.5ms 2024/12/19 05:13:14 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:13:14 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Finishing large file upload with 3 parts 2024/12/19 05:13:14 DEBUG : pacer: Reducing sleep to 31.25ms 2024/12/19 05:13:14 DEBUG : pacer: Reducing sleep to 15.625ms 2024/12/19 05:13:14 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 2024/12/19 05:13:16 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 1 offset 10Mi/10.000Mi 2024/12/19 05:13:16 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 1 length 1 2024/12/19 05:13:16 DEBUG : chunked-10Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10.000Mi 2024/12/19 05:13:16 DEBUG : chunked-10Mi-10.000Mi.bin: Sending chunk 0 length 10485760 2024/12/19 05:13:17 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 1 2024/12/19 05:13:19 DEBUG : chunked-10Mi-10.000Mi.bin: Done sending chunk 0 2024/12/19 05:13:19 DEBUG : chunked-10Mi-10.000Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed 2024/12/19 05:13:20 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:13:20 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. 2024/12/19 05:13:21 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f2024221b764d0b93_d20241219_m051321_c001_v0001137_t0001_u01734585201049") 2024/12/19 05:13:21 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:13:21 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 1 length 1 2024/12/19 05:13:21 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Sending chunk 0 length 10485760 2024/12/19 05:13:22 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:13:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:13:23 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 2024/12/19 05:13:25 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20Mi 2024/12/19 05:13:25 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 0 length 10485760 2024/12/19 05:13:26 DEBUG : chunked-10Mi-20Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20Mi 2024/12/19 05:13:26 DEBUG : chunked-10Mi-20Mi.bin: Sending chunk 1 length 10485760 2024/12/19 05:13:28 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 0 2024/12/19 05:13:29 DEBUG : chunked-10Mi-20Mi.bin: Done sending chunk 1 2024/12/19 05:13:29 DEBUG : chunked-10Mi-20Mi.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed 2024/12/19 05:13:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:13:32 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. 2024/12/19 05:13:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f201c0328946e40fe_d20241219_m051332_c001_v0001144_t0014_u01734585212247") 2024/12/19 05:13:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 0 length 10485760 2024/12/19 05:13:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: Not sending empty chunk after EOF - ending. 2024/12/19 05:13:32 DEBUG : chunked-10Mi-20Mi-streamed.bin: Sending chunk 1 length 10485760 2024/12/19 05:13:35 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:13:36 DEBUG : chunked-10Mi-20Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:13:36 DEBUG : chunked-10Mi-20Mi-streamed.bin: Finishing large file upload with 2 parts === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2024/12/19 05:13:38 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2024/12/19 05:13:38 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 0 length 10485760 2024/12/19 05:13:39 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2024/12/19 05:13:39 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2024/12/19 05:13:39 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2024/12/19 05:13:39 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 1 length 10485760 2024/12/19 05:13:39 DEBUG : chunked-10Mi-20.000Mi.bin: Error sending chunk 2 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc0001ffdd0), retryAfter:1000000000} 2024/12/19 05:13:39 DEBUG : chunked-10Mi-20.000Mi.bin: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2024/12/19 05:13:39 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable)) 2024/12/19 05:13:39 DEBUG : pacer: Rate limited, increasing sleep to 1s 2024/12/19 05:13:39 DEBUG : chunked-10Mi-20.000Mi.bin: Sending chunk 2 length 1 2024/12/19 05:13:40 DEBUG : pacer: Reducing sleep to 500ms 2024/12/19 05:13:41 DEBUG : pacer: Reducing sleep to 250ms 2024/12/19 05:13:41 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 0 2024/12/19 05:13:41 DEBUG : pacer: Reducing sleep to 125ms 2024/12/19 05:13:41 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 2 2024/12/19 05:13:41 DEBUG : pacer: Reducing sleep to 62.5ms 2024/12/19 05:13:41 DEBUG : chunked-10Mi-20.000Mi.bin: Done sending chunk 1 2024/12/19 05:13:41 DEBUG : chunked-10Mi-20.000Mi.bin: Finishing large file upload with 3 parts 2024/12/19 05:13:42 DEBUG : pacer: Reducing sleep to 31.25ms 2024/12/19 05:13:42 DEBUG : pacer: Reducing sleep to 15.625ms 2024/12/19 05:13:42 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2024/12/19 05:13:44 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: File is big enough for chunked streaming 2024/12/19 05:13:44 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. 2024/12/19 05:13:45 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Starting streaming of large file (id "4_z5f929d93501ddbdb9f380e1b_f218e7f21d74aba8e_d20241219_m051345_c001_v0001182_t0034_u01734585225305") 2024/12/19 05:13:45 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 0 length 10485760 2024/12/19 05:13:45 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Read less than a full chunk 1, making this the last one. 2024/12/19 05:13:45 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 2 length 1 2024/12/19 05:13:45 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Sending chunk 1 length 10485760 2024/12/19 05:13:46 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 2 2024/12/19 05:13:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 0 2024/12/19 05:13:48 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Done sending chunk 1 2024/12/19 05:13:48 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 2024/12/19 05:14:02 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z5f929d93501ddbdb9f380e1b_f218e7f21d74abab0_d20241219_m051402_c001_v0001183_t0007_u01734585242817") 2024/12/19 05:14:02 DEBUG : chunked-copy.copy: Copying chunk 1 length 1 2024/12/19 05:14:02 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2024/12/19 05:14:03 DEBUG : chunked-copy.copy: Done copying chunk 1 2024/12/19 05:14:03 DEBUG : chunked-copy.copy: Done copying chunk 0 2024/12/19 05:14:03 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2024/12/19 05:14:05 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2024/12/19 05:14:05 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2024/12/19 05:14:05 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2024/12/19 05:14:05 DEBUG : chunked-copy: Sending chunk 1 length 4194303 2024/12/19 05:14:06 DEBUG : chunked-copy: Error sending chunk 0 (retry=true): no tomes available (503 service_unavailable): &pacer.retryAfterError{error:(*api.Error)(0xc000417710), retryAfter:1000000000} 2024/12/19 05:14:06 DEBUG : chunked-copy: Clearing part upload URL because of error: no tomes available (503 service_unavailable) 2024/12/19 05:14:06 DEBUG : pacer: low level retry 1/10 (error no tomes available (503 service_unavailable)) 2024/12/19 05:14:06 DEBUG : pacer: Rate limited, increasing sleep to 1s 2024/12/19 05:14:06 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2024/12/19 05:14:07 DEBUG : pacer: Reducing sleep to 500ms 2024/12/19 05:14:07 DEBUG : pacer: Reducing sleep to 250ms 2024/12/19 05:14:07 DEBUG : chunked-copy: Done sending chunk 1 2024/12/19 05:14:10 DEBUG : pacer: Reducing sleep to 125ms 2024/12/19 05:14:10 DEBUG : chunked-copy: Done sending chunk 0 2024/12/19 05:14:10 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2024/12/19 05:14:10 DEBUG : pacer: Reducing sleep to 62.5ms 2024/12/19 05:14:10 DEBUG : pacer: Reducing sleep to 31.25ms 2024/12/19 05:14:11 DEBUG : pacer: Reducing sleep to 15.625ms 2024/12/19 05:14:11 DEBUG : pacer: Reducing sleep to 10ms 2024/12/19 05:14:11 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z5f929d93501ddbdb9f380e1b_f217f823df868b9e5_d20241219_m051411_c001_v0001182_t0033_u01734585251094") 2024/12/19 05:14:11 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242879 2024/12/19 05:14:11 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2024/12/19 05:14:11 DEBUG : chunked-copy.copy: Done copying chunk 1 2024/12/19 05:14:14 DEBUG : chunked-copy.copy: Done copying chunk 0 2024/12/19 05:14:14 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2024/12/19 05:14:21 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10Mi 2024/12/19 05:14:21 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2024/12/19 05:14:21 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4Mi offset 6Mi/10Mi 2024/12/19 05:14:21 DEBUG : chunked-copy: Sending chunk 1 length 4194304 2024/12/19 05:14:23 DEBUG : chunked-copy: Done sending chunk 0 2024/12/19 05:14:23 DEBUG : chunked-copy: Done sending chunk 1 2024/12/19 05:14:23 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2024/12/19 05:14:24 DEBUG : chunked-copy.copy: Starting copy of large file in 2 chunks (id "4_z5f929d93501ddbdb9f380e1b_f21963de4df0c6402_d20241219_m051424_c001_v0001144_t0032_u01734585264510") 2024/12/19 05:14:24 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2024/12/19 05:14:24 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2024/12/19 05:14:25 DEBUG : chunked-copy.copy: Done copying chunk 1 2024/12/19 05:14:25 DEBUG : chunked-copy.copy: Done copying chunk 0 2024/12/19 05:14:25 DEBUG : chunked-copy.copy: Finishing large file copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2024/12/19 05:14:27 DEBUG : chunked-copy: multipart upload: starting chunk 0 size 6Mi offset 0/10.000Mi 2024/12/19 05:14:27 DEBUG : chunked-copy: Sending chunk 0 length 6291456 2024/12/19 05:14:27 DEBUG : chunked-copy: multipart upload: starting chunk 1 size 4.000Mi offset 6Mi/10.000Mi 2024/12/19 05:14:27 DEBUG : chunked-copy: Sending chunk 1 length 4194305 2024/12/19 05:14:29 DEBUG : chunked-copy: Done sending chunk 1 2024/12/19 05:14:29 DEBUG : chunked-copy: Done sending chunk 0 2024/12/19 05:14:29 DEBUG : chunked-copy: Finishing large file upload with 2 parts 2024/12/19 05:14:30 DEBUG : chunked-copy.copy: Starting copy of large file in 3 chunks (id "4_z5f929d93501ddbdb9f380e1b_f21963de4df0c6442_d20241219_m051430_c001_v0001099_t0032_u01734585270756") 2024/12/19 05:14:30 DEBUG : chunked-copy.copy: Copying chunk 2 length 1 2024/12/19 05:14:30 DEBUG : chunked-copy.copy: Copying chunk 0 length 5242880 2024/12/19 05:14:30 DEBUG : chunked-copy.copy: Copying chunk 1 length 5242880 2024/12/19 05:14:31 DEBUG : chunked-copy.copy: Done copying chunk 2 2024/12/19 05:14:33 DEBUG : chunked-copy.copy: Done copying chunk 0 2024/12/19 05:14:33 DEBUG : chunked-copy.copy: Done copying chunk 1 2024/12/19 05:14:33 DEBUG : chunked-copy.copy: Finishing large file copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2024/12/19 05:14:35 DEBUG : unknown-size-put.txt: File has 100 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2024/12/19 05:14:37 DEBUG : unknown-size-update.txt: File has 200 bytes, which makes only one chunk. Using direct upload. === RUN TestIntegration/FsMkdir/FsRootCollapse 2024/12/19 05:14:38 DEBUG : Creating backend with remote "TestB2:rclone-test-dazitaw0beci/deeper/nonexisting/directory" 2024/12/19 05:14:38 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2500: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2543: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2592: Can't test if can't have empty directories 2024/12/19 05:14:39 INFO : B2 bucket rclone-test-dazitaw0beci: cleaning bucket "rclone-test-dazitaw0beci" of all files 2024/12/19 05:14:39 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f401c0328946e40e9_d20241219_m051325_c001_v7007000_t0000_u01734585205321") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2024221b764d0b93_d20241219_m051321_c001_v0001137_t0001_u01734585201049") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4024221b764d0b92_d20241219_m051320_c001_v7007000_t0000_u01734585200513") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-10.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f201c0328946e40c7_d20241219_m051316_c001_v0001172_t0040_u01734585196052") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abaa5_d20241219_m051355_c001_v7007000_t0000_u01734585235768") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f218e7f21d74aba8e_d20241219_m051345_c001_v0001182_t0034_u01734585225305") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74aba8a_d20241219_m051343_c001_v7007000_t0000_u01734585223984") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-20.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f201c0328946e4104_d20241219_m051338_c001_v0001182_t0006_u01734585218294") 2024/12/19 05:14:39 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f401c0328946e4103_d20241219_m051338_c001_v7007000_t0000_u01734585218110") 2024/12/19 05:14:40 DEBUG : chunked-10Mi-20Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f201c0328946e40fe_d20241219_m051332_c001_v0001144_t0014_u01734585212247") 2024/12/19 05:14:40 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f401c0328946e40fd_d20241219_m051331_c001_v7007000_t0000_u01734585211716") 2024/12/19 05:14:40 DEBUG : chunked-10Mi-20Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f201c0328946e40eb_d20241219_m051325_c001_v0001099_t0046_u01734585205524") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d83c7_d20241219_m051143_c001_v7007000_t0000_u01734585103261") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83c1_d20241219_m051138_c001_v0001092_t0030_u01734585098881") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee850d_d20241219_m051134_c001_v7007000_t0000_u01734585094227") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83b5_d20241219_m051129_c001_v0001036_t0035_u01734585089994") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d83c0_d20241219_m051138_c001_v7007000_t0000_u01734585098528") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee850e_d20241219_m051134_c001_v0001183_t0037_u01734585094413") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d83b4_d20241219_m051129_c001_v7007000_t0000_u01734585089635") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee84fc_d20241219_m051125_c001_v0001102_t0031_u01734585085542") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee84fb_d20241219_m051125_c001_v7007000_t0000_u01734585085351") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83a9_d20241219_m051121_c001_v0001128_t0023_u01734585081877") 2024/12/19 05:14:40 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d83a7_d20241219_m051121_c001_v7007000_t0000_u01734585081524") 2024/12/19 05:14:41 DEBUG : chunked-5.054Mi-5.054Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee84f0_d20241219_m051117_c001_v0001183_t0059_u01734585077562") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4053fe083c317729_d20241219_m051209_c001_v7007000_t0000_u01734585129057") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2053fe083c317706_d20241219_m051205_c001_v0001157_t0031_u01734585125053") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d83e2_d20241219_m051200_c001_v7007000_t0000_u01734585120480") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee8529_d20241219_m051156_c001_v0001102_t0014_u01734585116405") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4053fe083c317702_d20241219_m051204_c001_v7007000_t0000_u01734585124710") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83e3_d20241219_m051200_c001_v0001150_t0022_u01734585120669") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee8528_d20241219_m051156_c001_v7007000_t0000_u01734585116038") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-10.109Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83d2_d20241219_m051151_c001_v0001172_t0050_u01734585111823") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d83d1_d20241219_m051151_c001_v7007000_t0000_u01734585111636") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee851f_d20241219_m051148_c001_v0001183_t0056_u01734585108128") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee851e_d20241219_m051147_c001_v7007000_t0000_u01734585107775") 2024/12/19 05:14:41 DEBUG : chunked-5.055Mi-5.055Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d83c9_d20241219_m051143_c001_v0001182_t0018_u01734585103447") 2024/12/19 05:14:41 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee84ee_d20241219_m051117_c001_v7007000_t0000_u01734585077376") 2024/12/19 05:14:41 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee84eb_d20241219_m051113_c001_v0001165_t0020_u01734585073451") 2024/12/19 05:14:41 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee84e9_d20241219_m051113_c001_v7007000_t0000_u01734585073109") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-10.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee84dc_d20241219_m051108_c001_v0001090_t0017_u01734585068526") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee84db_d20241219_m051108_c001_v7007000_t0000_u01734585068337") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-10Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d831b_d20241219_m051104_c001_v0001165_t0056_u01734585064467") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d8319_d20241219_m051104_c001_v7007000_t0000_u01734585064109") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-10Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f202f2ad1fbee84d7_d20241219_m051059_c001_v0001182_t0013_u01734585059879") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f402f2ad1fbee84d6_d20241219_m051059_c001_v7007000_t0000_u01734585059693") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d82f0_d20241219_m051056_c001_v0001181_t0009_u01734585056280") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d82ec_d20241219_m051055_c001_v7007000_t0000_u01734585055907") 2024/12/19 05:14:42 DEBUG : chunked-5Mi-5.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f20556f170dff2102_d20241219_m051050_c001_v0001183_t0047_u01734585050745") 2024/12/19 05:14:42 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4024221b764d0b11_d20241219_m051237_c001_v7007000_t0000_u01734585157842") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f201c0328946e40ba_d20241219_m051232_c001_v0001101_t0018_u01734585152791") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4053fe083c317784_d20241219_m051227_c001_v7007000_t0000_u01734585147183") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2053fe083c31777c_d20241219_m051222_c001_v0001104_t0002_u01734585142433") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f401c0328946e40b9_d20241219_m051232_c001_v7007000_t0000_u01734585152401") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2053fe083c317785_d20241219_m051227_c001_v0001104_t0032_u01734585147374") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4053fe083c317779_d20241219_m051222_c001_v7007000_t0000_u01734585142023") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-13.333Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2053fe083c31776c_d20241219_m051217_c001_v0001176_t0031_u01734585137483") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4053fe083c31776b_d20241219_m051217_c001_v7007000_t0000_u01734585137279") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f209c812ec02d840a_d20241219_m051213_c001_v0001183_t0005_u01734585133576") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f409c812ec02d8409_d20241219_m051213_c001_v7007000_t0000_u01734585133159") 2024/12/19 05:14:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2053fe083c31772a_d20241219_m051209_c001_v0001181_t0004_u01734585129245") 2024/12/19 05:14:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f401c0328946e40c5_d20241219_m051315_c001_v7007000_t0000_u01734585195866") 2024/12/19 05:14:43 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2024221b764d0b83_d20241219_m051310_c001_v0001145_t0045_u01734585190956") 2024/12/19 05:14:43 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4024221b764d0b82_d20241219_m051310_c001_v7007000_t0000_u01734585190494") 2024/12/19 05:14:43 DEBUG : chunked-8Mi-16.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f204a251e7ef902a6_d20241219_m051305_c001_v0001113_t0028_u01734585185230") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f404a251e7ef902a2_d20241219_m051305_c001_v7007000_t0000_u01734585185046") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-16Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f204a251e7ef90288_d20241219_m051300_c001_v0001178_t0032_u01734585180633") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f404a251e7ef90287_d20241219_m051300_c001_v7007000_t0000_u01734585180206") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-16Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2024221b764d0b53_d20241219_m051249_c001_v0001036_t0003_u01734585169962") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4024221b764d0b52_d20241219_m051249_c001_v7007000_t0000_u01734585169776") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2037a3d80d710369_d20241219_m051242_c001_v0001104_t0029_u01734585162871") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f4037a3d80d710363_d20241219_m051242_c001_v7007000_t0000_u01734585162417") 2024/12/19 05:14:44 DEBUG : chunked-8Mi-8.000Mi.bin: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f2024221b764d0b17_d20241219_m051238_c001_v0001117_t0007_u01734585158056") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f407f961c8252d100_d20241219_m051434_c001_v7007000_t0000_u01734585274945") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f218e7f21d74abb16_d20241219_m051427_c001_v0001183_t0049_u01734585267484") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abb14_d20241219_m051426_c001_v7007000_t0000_u01734585266990") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f218e7f21d74abb00_d20241219_m051421_c001_v0001183_t0036_u01734585261107") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abafd_d20241219_m051420_c001_v7007000_t0000_u01734585260614") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f218e7f21d74abab9_d20241219_m051405_c001_v0001182_t0040_u01734585245221") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abab6_d20241219_m051404_c001_v7007000_t0000_u01734585244685") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1195bb722760b912_d20241219_m051400_c001_v0001104_t0008_u01734585240425") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abaaa_d20241219_m051400_c001_v7007000_t0000_u01734585240074") 2024/12/19 05:14:44 DEBUG : chunked-copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1195bb722760b8fc_d20241219_m051356_c001_v0001104_t0047_u01734585236518") 2024/12/19 05:14:44 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f407f961c8252d0ff_d20241219_m051434_c001_v7007000_t0000_u01734585274760") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f21963de4df0c6442_d20241219_m051430_c001_v0001099_t0032_u01734585270756") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abb12_d20241219_m051426_c001_v7007000_t0000_u01734585266798") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f21963de4df0c6402_d20241219_m051424_c001_v0001144_t0032_u01734585264510") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abaf9_d20241219_m051420_c001_v7007000_t0000_u01734585260431") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f217f823df868b9e5_d20241219_m051411_c001_v0001182_t0033_u01734585251094") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abab5_d20241219_m051404_c001_v7007000_t0000_u01734585244501") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f218e7f21d74abab0_d20241219_m051402_c001_v0001183_t0007_u01734585242817") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f418e7f21d74abaa9_d20241219_m051359_c001_v7007000_t0000_u01734585239885") 2024/12/19 05:14:45 DEBUG : chunked-copy.copy: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1095a57a62f5d247_d20241219_m051358_c001_v0001090_t0023_u01734585238829") 2024/12/19 05:14:45 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1022590c50a1ca59_d20241219_m050933_c001_v0001109_t0028_u01734584973686") 2024/12/19 05:14:45 DEBUG : unknown-size-put.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f407f961c8252d109_d20241219_m051436_c001_v7007000_t0000_u01734585276247") 2024/12/19 05:14:45 DEBUG : unknown-size-put.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1195bb722760b98c_d20241219_m051435_c001_v0001104_t0015_u01734585275496") 2024/12/19 05:14:45 DEBUG : unknown-size-update.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f407f961c8252d10e_d20241219_m051437_c001_v7007000_t0000_u01734585277961") 2024/12/19 05:14:45 DEBUG : unknown-size-update.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1195bb722760b997_d20241219_m051437_c001_v0001104_t0039_u01734585277496") 2024/12/19 05:14:45 DEBUG : unknown-size-update.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1195bb722760b990_d20241219_m051436_c001_v0001104_t0048_u01734585276435") 2024/12/19 05:14:45 DEBUG : versions/test-versions.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f40556f170dff2101_d20241219_m051050_c001_v7007000_t0000_u01734585050562") 2024/12/19 05:14:45 DEBUG : versions/test-versions.txt: Deleting (id "4_z5f929d93501ddbdb9f380e1b_f1195bb722760b64d_d20241219_m051041_c001_v0001104_t0005_u01734585041347") 2024/12/19 05:14:47 INFO : B2 bucket rclone-test-dazitaw0beci: cleaning bucket "rclone-test-dazitaw0beci" of all files === RUN TestIntegration/FsShutdown fstests.go:2706: Shutdown method not supported --- PASS: TestIntegration (357.33s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.61s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.55s) --- PASS: TestIntegration/FsMkdir (354.81s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.54s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.18s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding (28.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (2.50s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (1.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (1.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (1.54s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (1.59s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.21s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.39s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (1.77s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (1.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (1.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (1.50s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.48s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (1.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.94s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.40s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (1.57s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.30s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.19s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.10s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (7.81s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (78.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.56s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (3.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (2.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.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.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.92s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (1.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (8.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (2.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (7.86s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.58s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (27.43s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (7.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size1kiB/UploadCutoff/ChunkSize (1.38s) --- 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.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding (1.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/Size10MiB/UploadCutoff6MiB/ChunkSize6MiB/GzipEncoding/NoDecompress (1.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (20.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (2.09s) --- 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.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.27s) --- 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.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (4.22s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (185.21s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (26.81s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881 (9.13s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242881/Streamed (3.78s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760 (8.64s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485760/Streamed (4.23s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (9.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (4.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (25.89s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001 (7.98s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300001/Streamed (3.83s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000 (8.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600000/Streamed (4.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (9.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (4.73s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (25.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054 (8.38s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300054/Streamed (3.86s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106 (8.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600106/Streamed (4.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (8.58s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (4.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (28.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507 (8.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990507/Streamed (4.12s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012 (9.90s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981012/Streamed (5.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (10.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (5.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (38.01s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609 (11.92s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388609/Streamed (7.36s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216 (15.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777216/Streamed (4.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (10.82s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (5.35s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (39.90s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761 (9.47s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485761/Streamed (4.80s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520 (12.77s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971520/Streamed (6.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (17.66s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (11.77s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (39.18s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (4.31s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (4.61s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (15.93s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (6.38s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (7.96s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (3.02s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.30s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.72s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.30s) --- 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 357.344s "go test -v -timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 5m57.869100026s (try 1/5)