"go test -v -timeout 1h0m0s -remote TestS3: -verbose" - Starting (try 1/5) === RUN TestSignHTTP --- PASS: TestSignHTTP (0.00s) === RUN TestVersionLess --- PASS: TestVersionLess (0.00s) === RUN TestMergeDeleteMarkers --- PASS: TestMergeDeleteMarkers (0.00s) === RUN TestMergeDeleteMarkersWithURLEncodedKeys --- PASS: TestMergeDeleteMarkersWithURLEncodedKeys (0.00s) === RUN TestVersionsListStorageClass --- PASS: TestVersionsListStorageClass (0.00s) === RUN TestRemoveAWSChunked === RUN TestRemoveAWSChunked/nil === RUN TestRemoveAWSChunked/empty === RUN TestRemoveAWSChunked/only_aws === RUN TestRemoveAWSChunked/leading_aws === RUN TestRemoveAWSChunked/trailing_aws === RUN TestRemoveAWSChunked/middle_aws === RUN TestRemoveAWSChunked/case_insensitive === RUN TestRemoveAWSChunked/duplicates === RUN TestRemoveAWSChunked/no_aws_normalize_spaces === RUN TestRemoveAWSChunked/surrounding_spaces === RUN TestRemoveAWSChunked/no_change --- PASS: TestRemoveAWSChunked (0.00s) --- PASS: TestRemoveAWSChunked/nil (0.00s) --- PASS: TestRemoveAWSChunked/empty (0.00s) --- PASS: TestRemoveAWSChunked/only_aws (0.00s) --- PASS: TestRemoveAWSChunked/leading_aws (0.00s) --- PASS: TestRemoveAWSChunked/trailing_aws (0.00s) --- PASS: TestRemoveAWSChunked/middle_aws (0.00s) --- PASS: TestRemoveAWSChunked/case_insensitive (0.00s) --- PASS: TestRemoveAWSChunked/duplicates (0.00s) --- PASS: TestRemoveAWSChunked/no_aws_normalize_spaces (0.00s) --- PASS: TestRemoveAWSChunked/surrounding_spaces (0.00s) --- PASS: TestRemoveAWSChunked/no_change (0.00s) === RUN TestBufferForObjectLockMD5 === RUN TestBufferForObjectLockMD5/NoObjectLock === RUN TestBufferForObjectLockMD5/SourceMD5 === RUN TestBufferForObjectLockMD5/Buffered --- PASS: TestBufferForObjectLockMD5 (0.00s) --- PASS: TestBufferForObjectLockMD5/NoObjectLock (0.00s) --- PASS: TestBufferForObjectLockMD5/SourceMD5 (0.00s) --- PASS: TestBufferForObjectLockMD5/Buffered (0.00s) === RUN TestCommandLink === RUN TestCommandLink/Signed/response-content-disposition === RUN TestCommandLink/Signed/response-content-encoding === RUN TestCommandLink/Signed/response-content-language === RUN TestCommandLink/Signed/response-content-type === RUN TestCommandLink/Signed/response-expires === RUN TestCommandLink/Signed/response-cache-control --- PASS: TestCommandLink (0.00s) --- PASS: TestCommandLink/Signed/response-content-disposition (0.00s) --- PASS: TestCommandLink/Signed/response-content-encoding (0.00s) --- PASS: TestCommandLink/Signed/response-content-language (0.00s) --- PASS: TestCommandLink/Signed/response-content-type (0.00s) --- PASS: TestCommandLink/Signed/response-expires (0.00s) --- PASS: TestCommandLink/Signed/response-cache-control (0.00s) === RUN TestCommandLinkExpire === RUN TestCommandLinkExpire/Default === RUN TestCommandLinkExpire/Minimum === RUN TestCommandLinkExpire/Maximum === RUN TestCommandLinkExpire/Clamped 2026/10/18 01:02:40 NOTICE: S3 bucket bucket path prefix: Public Link: Reducing expiry to 1w as 1.1428571428571428w is greater than the max time allowed === RUN TestCommandLinkExpire/Off 2026/10/18 01:02:40 NOTICE: S3 bucket bucket path prefix: Public Link: Reducing expiry to 1w as off is greater than the max time allowed --- PASS: TestCommandLinkExpire (0.01s) --- PASS: TestCommandLinkExpire/Default (0.00s) --- PASS: TestCommandLinkExpire/Minimum (0.00s) --- PASS: TestCommandLinkExpire/Maximum (0.00s) --- PASS: TestCommandLinkExpire/Clamped (0.00s) --- PASS: TestCommandLinkExpire/Off (0.00s) === RUN TestCommandLinkErrors === RUN TestCommandLinkErrors/NoPath === RUN TestCommandLinkErrors/TooManyPaths === RUN TestCommandLinkErrors/EmptyPath === RUN TestCommandLinkErrors/Directory === RUN TestCommandLinkErrors/Missing === RUN TestCommandLinkErrors/UnknownOption === RUN TestCommandLinkErrors/InvalidDate === RUN TestCommandLinkErrors/InvalidExpire === RUN TestCommandLinkErrors/EmptyExpire === RUN TestCommandLinkErrors/ZeroExpire === RUN TestCommandLinkErrors/NegativeExpire === RUN TestCommandLinkErrors/SubsecondExpire --- PASS: TestCommandLinkErrors (0.00s) --- PASS: TestCommandLinkErrors/NoPath (0.00s) --- PASS: TestCommandLinkErrors/TooManyPaths (0.00s) --- PASS: TestCommandLinkErrors/EmptyPath (0.00s) --- PASS: TestCommandLinkErrors/Directory (0.00s) --- PASS: TestCommandLinkErrors/Missing (0.00s) --- PASS: TestCommandLinkErrors/UnknownOption (0.00s) --- PASS: TestCommandLinkErrors/InvalidDate (0.00s) --- PASS: TestCommandLinkErrors/InvalidExpire (0.00s) --- PASS: TestCommandLinkErrors/EmptyExpire (0.00s) --- PASS: TestCommandLinkErrors/ZeroExpire (0.00s) --- PASS: TestCommandLinkErrors/NegativeExpire (0.00s) --- PASS: TestCommandLinkErrors/SubsecondExpire (0.00s) === RUN TestCommandLinkVersionAt 2026/10/18 01:02:40 NOTICE: S3 bucket bucket path prefix: Public Link: Reducing expiry to 1w as off is greater than the max time allowed --- PASS: TestCommandLinkVersionAt (0.00s) === RUN TestPublicLink 2026/10/18 01:02:40 NOTICE: S3 bucket bucket path prefix: Public Link: Reducing expiry to 1w as off is greater than the max time allowed --- PASS: TestPublicLink (0.00s) === RUN TestRedirectSecretHeadersMatchTestList --- PASS: TestRedirectSecretHeadersMatchTestList (0.00s) === RUN TestClientRemovesSecretHeadersOnCrossHostRedirect --- PASS: TestClientRemovesSecretHeadersOnCrossHostRedirect (0.00s) === RUN TestClientDoesNotRestoreSecretHeadersAfterCrossHostRedirect --- PASS: TestClientDoesNotRestoreSecretHeadersAfterCrossHostRedirect (0.00s) === RUN TestClientKeepsSecretHeadersOnSameHostRedirect --- PASS: TestClientKeepsSecretHeadersOnSameHostRedirect (0.00s) === RUN TestClientRemovesGeneratedRefererOnCrossHostRedirect --- PASS: TestClientRemovesGeneratedRefererOnCrossHostRedirect (0.00s) === RUN TestS3CheckRedirectRejectsSchemeDowngrade === RUN TestS3CheckRedirectRejectsSchemeDowngrade/SameHostDowngrade === RUN TestS3CheckRedirectRejectsSchemeDowngrade/CrossHostDowngrade --- PASS: TestS3CheckRedirectRejectsSchemeDowngrade (0.00s) --- PASS: TestS3CheckRedirectRejectsSchemeDowngrade/SameHostDowngrade (0.00s) --- PASS: TestS3CheckRedirectRejectsSchemeDowngrade/CrossHostDowngrade (0.00s) === RUN TestClientStopsAfterTenRedirects --- PASS: TestClientStopsAfterTenRedirects (0.00s) === RUN TestObjectNotFoundMapping --- PASS: TestObjectNotFoundMapping (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestS3:" 2026/10/18 01:02:40 DEBUG : Creating backend with remote "TestS3:rclone-test-cutujuq6tulo" 2026/10/18 01:02:40 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand === RUN TestIntegration/FsRmdirNotFound 2026/10/18 01:02:41 INFO : S3 bucket rclone-test-cutujuq6tulo: Bucket "rclone-test-cutujuq6tulo" created with ACL "" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRootCannotChangeHost 2026/10/18 01:02:41 DEBUG : Creating backend with remote "TestS3://127.0.0.1:33709/" 2026/10/18 01:02:41 DEBUG : Creating backend with remote "TestS3://127.0.0.1:33709/rclone-test-cutujuq6tulo/" 2026/10/18 01:02:41 DEBUG : Creating backend with remote "TestS3://user:pass@127.0.0.1:33709/" === RUN TestIntegration/FsRmdirEmpty 2026/10/18 01:02:41 INFO : S3 bucket rclone-test-cutujuq6tulo: Bucket "rclone-test-cutujuq6tulo" deleted === RUN TestIntegration/FsMkdir 2026/10/18 01:02:42 INFO : S3 bucket rclone-test-cutujuq6tulo: Bucket "rclone-test-cutujuq6tulo" created with ACL "" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/10/18 01:02:42 INFO : dir/subdir: Making directory fstest.go:251: Filtering empty directory "dir" fstest.go:251: Filtering empty directory "dir/subdir" 2026/10/18 01:02:42 INFO : dir/subdir: Removing directory fstest.go:251: Filtering empty directory "dir" 2026/10/18 01:02:42 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:779: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:779: testing "．" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:779: testing "．．" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:779: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:779: testing " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:779: testing "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:779: testing "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:779: testing "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:779: testing "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:779: testing "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:779: testing ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:779: testing "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:779: testing "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:779: testing "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:779: testing "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:779: testing "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:779: testing "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:779: testing "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:779: testing "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:858: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter 2026/10/18 01:02:49 DEBUG : writer-at-subdir/writer-at-file: open chunk writer: started multipart upload: FviNy8yzuySBaKv.5oRkTIcPKLSUyLpJrfyGQGa1.J6dxqwdRQaJnvnL_pw3RcJyAyTpVcuh4WVPBOI68c7LO2KXKNbhjufow6JU2h_TJ5ynP2k6agobVC0vRMId4myz 2026/10/18 01:02:50 DEBUG : writer-at-subdir/writer-at-file: multipart upload wrote chunk 2 with 5242880 bytes, etag "2061b3ce504fcdf97e53159d8784f20e" and md5 2061b3ce504fcdf97e53159d8784f20e 2026/10/18 01:02:50 DEBUG : writer-at-subdir/writer-at-file: multipart upload wrote chunk 3 with 1048576 bytes, etag "f5d1a22682536471486b1ca692738543" and md5 f5d1a22682536471486b1ca692738543 2026/10/18 01:02:50 DEBUG : writer-at-subdir/writer-at-file: multipart upload wrote chunk 1 with 5242880 bytes, etag "19fc715eddc3c8de38a8cd2a2a647322" and md5 19fc715eddc3c8de38a8cd2a2a647322 2026/10/18 01:02:50 DEBUG : writer-at-subdir/writer-at-file: multipart upload "FviNy8yzuySBaKv.5oRkTIcPKLSUyLpJrfyGQGa1.J6dxqwdRQaJnvnL_pw3RcJyAyTpVcuh4WVPBOI68c7LO2KXKNbhjufow6JU2h_TJ5ynP2k6agobVC0vRMId4myz" finished === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:977: 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 2026/10/18 01:02:52 DEBUG : Creating backend with remote "TestS3:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2026/10/18 01:02:52 DEBUG : Creating backend with remote "TestS3:" === 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:1230: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2026/10/18 01:02:53 DEBUG : S3 bucket rclone-test-cutujuq6tulo: bucket is versioned: false 2026/10/18 01:02:53 DEBUG : Waiting for deletions to finish 2026/10/18 01:02:53 DEBUG : "dirToPurge/fileToPurge.txt" version false 2026/10/18 01:02:53 DEBUG : dirToPurge/fileToPurge.txt: Deleting (id "") 2026/10/18 01:02:53 INFO : dirToPurge/fileToPurge.txt: Deleted === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2026/10/18 01:02:54 DEBUG : Creating backend with remote "TestS3:rclone-test-cutujuq6tulo/dirToPurgeFromRoot" 2026/10/18 01:02:54 DEBUG : S3 bucket rclone-test-cutujuq6tulo path dirToPurgeFromRoot: bucket is versioned: false 2026/10/18 01:02:54 DEBUG : Waiting for deletions to finish 2026/10/18 01:02:54 DEBUG : "fileToPurgeFromRoot.txt" version false 2026/10/18 01:02:54 DEBUG : fileToPurgeFromRoot.txt: Deleting (id "") 2026/10/18 01:02:54 INFO : fileToPurgeFromRoot.txt: Deleted === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/10/18 01:02:54 DEBUG : Creating backend with remote "TestS3:rclone-test-cutujuq6tulo/hello? sausage/êé" 2026/10/18 01:02:55 DEBUG : S3 bucket rclone-test-cutujuq6tulo path hello? sausage/êé: bucket is versioned: false 2026/10/18 01:02:55 DEBUG : Waiting for deletions to finish 2026/10/18 01:02:55 DEBUG : "a/b/c/d/e.txt" version false 2026/10/18 01:02:55 DEBUG : a/b/c/d/e.txt: Deleting (id "") 2026/10/18 01:02:55 INFO : a/b/c/d/e.txt: Deleted === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1458: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1578: 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 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1813: 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/ObjectOpenFingerprint === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/10/18 01:03:00 DEBUG : Creating backend with remote "TestS3:rclone-test-cutujuq6tulo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/10/18 01:03:00 DEBUG : Creating backend with remote "TestS3:rclone-test-cutujuq6tulo/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:2072: Opening root remote "TestS3:" path "rclone-test-cutujuq6tulo" from "TestS3:rclone-test-cutujuq6tulo" 2026/10/18 01:03:00 DEBUG : Creating backend with remote "TestS3:" === 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 fstests.go:2216: skipping directory tests as not supported on this backend === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2273: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket 2026/10/18 01:03:07 DEBUG : Creating backend with remote "TestS3:rclone-test-cutujuq6tulo/dir" === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2445: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/10/18 01:03:08 NOTICE: S3 bucket rclone-test-cutujuq6tulo: Streaming uploads using chunk size 5Mi will have maximum file size of 48.828Gi 2026/10/18 01:03:08 DEBUG : piped data.txt: open chunk writer: started multipart upload: enDLHvg6bH84fLcjWliuB3qM4kW1qXqYFlo8nej3NIFo6qo8KzOUpffonIx54hubT9HTogLaqwUj93Suk.Js7fj3t_k7b4E8rG1pUvANEk14BoejhsxX60oqB9NdUAVf 2026/10/18 01:03:08 DEBUG : piped data.txt: multipart upload: starting chunk 0 size 0 offset 0/off 2026/10/18 01:03:08 DEBUG : piped data.txt: multipart upload wrote chunk 1 with 0 bytes, etag "d41d8cd98f00b204e9800998ecf8427e" and md5 d41d8cd98f00b204e9800998ecf8427e 2026/10/18 01:03:09 DEBUG : piped data.txt: multipart upload "enDLHvg6bH84fLcjWliuB3qM4kW1qXqYFlo8nej3NIFo6qo8KzOUpffonIx54hubT9HTogLaqwUj93Suk.Js7fj3t_k7b4E8rG1pUvANEk14BoejhsxX60oqB9NdUAVf" finished 2026/10/18 01:03:09 DEBUG : piped data.txt: Multipart upload Etag: 59adb24ef3cdbe0297f05b395827453f-1 OK === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/10/18 01:03:09 DEBUG : piped data.txt: open chunk writer: started multipart upload: arul6njDedUsvTOIimcLuMGFK1GYsunD1q02AX_.3FlH5msnNN06wbo9F6AKv_S_JuYGu8MXrUY3gXhIzszA7qsrYA2DufWp32BkdBTbQTbw0EuNbuYCOpa0QAc_G1w3 2026/10/18 01:03:09 DEBUG : piped data.txt: multipart upload: starting chunk 0 size 100 offset 0/off 2026/10/18 01:03:09 DEBUG : piped data.txt: multipart upload wrote chunk 1 with 100 bytes, etag "05461f5130337ceb87af788269cc7b1f" and md5 05461f5130337ceb87af788269cc7b1f 2026/10/18 01:03:09 DEBUG : piped data.txt: multipart upload "arul6njDedUsvTOIimcLuMGFK1GYsunD1q02AX_.3FlH5msnNN06wbo9F6AKv_S_JuYGu8MXrUY3gXhIzszA7qsrYA2DufWp32BkdBTbQTbw0EuNbuYCOpa0QAc_G1w3" finished 2026/10/18 01:03:09 DEBUG : piped data.txt: Multipart upload Etag: f2d45b6e2e1eee40812052cc454f0f1a-1 OK === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/GzipEncoding === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/GzipEncoding/NoDecompress 2026/10/18 01:03:09 NOTICE: test-metadata: Not decompressing 'Content-Encoding: gzip' compressed file. Use --s3-decompress to override === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/GzipEncoding/Decompress === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/NoHead === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/NoHeadObjectCopy === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/HasChildren === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions s3_internal_test.go:464: versions/test-versions.txt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent === NAME TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions s3_internal_test.go:464: versions/test-versions-v2026-10-18-010313-000.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 2026/10/18 01:03:17 DEBUG : oldPath = "TestS3:rclone-test-cutujuq6tulo/versions/test-versions-v2026-10-18-010313-000.txt" 2026/10/18 01:03:17 DEBUG : newPath = "TestS3,versions:rclone-test-cutujuq6tulo/versions/test-versions-v2026-10-18-010313-000.txt" 2026/10/18 01:03:17 DEBUG : Creating backend with remote "TestS3,versions:rclone-test-cutujuq6tulo/versions/test-versions-v2026-10-18-010313-000.txt" 2026/10/18 01:03:17 DEBUG : TestS3: detected overridden config - adding "{pO73u}" suffix to name 2026/10/18 01:03:17 DEBUG : fs cache: renaming child cache item "TestS3,versions:rclone-test-cutujuq6tulo/versions/test-versions-v2026-10-18-010313-000.txt" to be canonical for parent "TestS3{pO73u}:rclone-test-cutujuq6tulo/versions" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Mkdir s3_internal_test.go:591: Creating a bucket we already have created returned code: BucketAlreadyOwnedByYou === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup 2026/10/18 01:03:18 DEBUG : Waiting for deletions to finish 2026/10/18 01:03:18 DEBUG : "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" version false 2026/10/18 01:03:18 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Not deleting current version "null" 2026/10/18 01:03:18 DEBUG : "versions/test-versions.txt" version false 2026/10/18 01:03:18 DEBUG : versions/test-versions.txt: Not deleting current version "ZtFpNGKfHPjf5R2dh79tmg.Jt483z.Wg" 2026/10/18 01:03:18 DEBUG : "versions/test-versions-v2026-10-18-010316-000.txt" version true 2026/10/18 01:03:18 DEBUG : versions/test-versions-v2026-10-18-010316-000.txt: Deleting delete marker (id "5HWa8I6CLd2MbDn.6OKy.PLlSJbyewcK") 2026/10/18 01:03:18 DEBUG : "versions/test-versions-v2026-10-18-010313-000.txt" version true 2026/10/18 01:03:18 DEBUG : versions/test-versions-v2026-10-18-010313-000.txt: Deleting (id "DJJ1JVkhwjjRIc9cLsQKbzWYbo_aNO2o") 2026/10/18 01:03:18 INFO : versions/test-versions-v2026-10-18-010316-000.txt: Deleted 2026/10/18 01:03:18 INFO : versions/test-versions-v2026-10-18-010313-000.txt: Deleted === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/Retention === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/LegalHold === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/SetAfterUpload === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/Multipart 2026/10/18 01:03:21 DEBUG : test-object-lock-multipart: open chunk writer: started multipart upload: 4O0fCpdZtrpop0mh5RXIDgXO27ttRJFocbRZ.8QYTCC41vlatx71quqPg_PfuZ.1v3yc_Cdl5kMjy3yHsVQdOvRx7kPk88Mu5Y.ZytIxOirfsyRNdUC9r60LIANd9J7G 2026/10/18 01:03:21 DEBUG : test-object-lock-multipart: multipart upload: starting chunk 0 size 100 offset 0/100 2026/10/18 01:03:21 DEBUG : test-object-lock-multipart: multipart upload wrote chunk 1 with 100 bytes, etag "8da9963eec5ca7f4ffa4877fa7cede1a" and md5 8da9963eec5ca7f4ffa4877fa7cede1a 2026/10/18 01:03:21 DEBUG : test-object-lock-multipart: multipart upload "4O0fCpdZtrpop0mh5RXIDgXO27ttRJFocbRZ.8QYTCC41vlatx71quqPg_PfuZ.1v3yc_Cdl5kMjy3yHsVQdOvRx7kPk88Mu5Y.ZytIxOirfsyRNdUC9r60LIANd9J7G" finished 2026/10/18 01:03:21 DEBUG : test-object-lock-multipart: Multipart upload Etag: 76901dcbd8b09e16814083f5b433bd97-1 OK === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/Presigned === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242879 === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242879/Streamed 2026/10/18 01:03:23 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: open chunk writer: started multipart upload: moBtucly.vEe_ijYi6sJPd0SkObbE9VRazglT81uBQAqrtXGx2mC7PwfWBdoUPWfWqsl5IQStLTOcoarW4Rl8wFxIKGihGnvhklB38J.0NbHUA1udfsTqhF5uX2aGcZV 2026/10/18 01:03:23 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: multipart upload: starting chunk 0 size 5.000Mi offset 0/off 2026/10/18 01:03:24 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: multipart upload wrote chunk 1 with 5242879 bytes, etag "ff7aec5a89bdb0fd7d9cf4ff8c484545" and md5 ff7aec5a89bdb0fd7d9cf4ff8c484545 2026/10/18 01:03:24 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: multipart upload "moBtucly.vEe_ijYi6sJPd0SkObbE9VRazglT81uBQAqrtXGx2mC7PwfWBdoUPWfWqsl5IQStLTOcoarW4Rl8wFxIKGihGnvhklB38J.0NbHUA1udfsTqhF5uX2aGcZV" finished 2026/10/18 01:03:24 DEBUG : chunked-5Mi-5.000Mi-streamed.bin: Multipart upload Etag: ed4a32f2cde07f87d68a56ca08356e58-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242880 2026/10/18 01:03:24 DEBUG : chunked-5Mi-5Mi.bin: open chunk writer: started multipart upload: i4ffBRiWvRwghIkF__KZ0HnhLHwvyXP8OHoHzpZTkD1Egqj7NXK53RpT_G.7S70E.oWX_KJk3y.EE.izRM7D4GikBwOdLdPYU9lGVe1KdO88elXoFyBSp2MyRAOn5s_e 2026/10/18 01:03:24 DEBUG : chunked-5Mi-5Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/5Mi 2026/10/18 01:03:25 DEBUG : chunked-5Mi-5Mi.bin: multipart upload wrote chunk 1 with 5242880 bytes, etag "4c28640dc8df1933aaea192100d50ae0" and md5 4c28640dc8df1933aaea192100d50ae0 2026/10/18 01:03:25 DEBUG : chunked-5Mi-5Mi.bin: multipart upload "i4ffBRiWvRwghIkF__KZ0HnhLHwvyXP8OHoHzpZTkD1Egqj7NXK53RpT_G.7S70E.oWX_KJk3y.EE.izRM7D4GikBwOdLdPYU9lGVe1KdO88elXoFyBSp2MyRAOn5s_e" finished 2026/10/18 01:03:25 DEBUG : chunked-5Mi-5Mi.bin: Multipart upload Etag: 59a976105e80464acdcd6ee2a0678dfd-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/5242880/Streamed 2026/10/18 01:03:25 DEBUG : chunked-5Mi-5Mi-streamed.bin: open chunk writer: started multipart upload: H_AsPtServqC2pALIU_nt_aNVhyHmf.WjVGdMKKtVpXdOHu4eAiGxlymZARUUIyfP6qKzUT1.e2dLyqCoWGcXgB4ayhhkax5gayKp1uq8_ROiSnJWofxQ.LKq6Rnrc.R 2026/10/18 01:03:25 DEBUG : chunked-5Mi-5Mi-streamed.bin: multipart upload: starting chunk 0 size 5Mi offset 0/off 2026/10/18 01:03:25 DEBUG : chunked-5Mi-5Mi-streamed.bin: multipart upload wrote chunk 1 with 5242880 bytes, etag "4c28640dc8df1933aaea192100d50ae0" and md5 4c28640dc8df1933aaea192100d50ae0 2026/10/18 01:03:26 DEBUG : chunked-5Mi-5Mi-streamed.bin: multipart upload "H_AsPtServqC2pALIU_nt_aNVhyHmf.WjVGdMKKtVpXdOHu4eAiGxlymZARUUIyfP6qKzUT1.e2dLyqCoWGcXgB4ayhhkax5gayKp1uq8_ROiSnJWofxQ.LKq6Rnrc.R" finished 2026/10/18 01:03:26 DEBUG : chunked-5Mi-5Mi-streamed.bin: Multipart upload Etag: 59a976105e80464acdcd6ee2a0678dfd-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 2026/10/18 01:03:26 DEBUG : chunked-5Mi-10.000Mi.bin: open chunk writer: started multipart upload: cy6FqZTB2dvC8Z6yKBWIeGaQqn7IhyW_Tjwg7Saz9KAHHRzpsgjH8Gv6OxP3PY_cPnj12ROTlBRiJTtmWPhrpvrtpn_eoqnARgeKdPqhkTzr02wQ_kiLcDHQ647eDXer 2026/10/18 01:03:26 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2026/10/18 01:03:26 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2026/10/18 01:03:26 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2026/10/18 01:03:26 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload wrote chunk 1 with 5242880 bytes, etag "4c28640dc8df1933aaea192100d50ae0" and md5 4c28640dc8df1933aaea192100d50ae0 2026/10/18 01:03:26 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload wrote chunk 3 with 1 bytes, etag "ab95f1fa7da6a90274409b89562f3ffd" and md5 ab95f1fa7da6a90274409b89562f3ffd 2026/10/18 01:03:26 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload wrote chunk 2 with 5242880 bytes, etag "e264fa295ef081d5ad9bfaa7e5e130b6" and md5 e264fa295ef081d5ad9bfaa7e5e130b6 2026/10/18 01:03:27 DEBUG : chunked-5Mi-10.000Mi.bin: multipart upload "cy6FqZTB2dvC8Z6yKBWIeGaQqn7IhyW_Tjwg7Saz9KAHHRzpsgjH8Gv6OxP3PY_cPnj12ROTlBRiJTtmWPhrpvrtpn_eoqnARgeKdPqhkTzr02wQ_kiLcDHQ647eDXer" finished 2026/10/18 01:03:27 DEBUG : chunked-5Mi-10.000Mi.bin: Multipart upload Etag: b677d8f19ed57bf218653ea38827c920-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed 2026/10/18 01:03:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: open chunk writer: started multipart upload: BuPe6Uh0BcEz8MIN_gZjegSFXdUUbEv9Gq_zAPnmvT.e7lt9JADHvAx1ZjAHZHKLgtXSx7xDC6H4483GDIucAuq2MO5rj2r2Ec6NH2w4vqMNtXZ2sQNM5QxOW_HDf4NT 2026/10/18 01:03:27 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: multipart upload: starting chunk 0 size 5Mi offset 0/off 2026/10/18 01:03:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/off 2026/10/18 01:03:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/off 2026/10/18 01:03:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: multipart upload wrote chunk 1 with 5242880 bytes, etag "4c28640dc8df1933aaea192100d50ae0" and md5 4c28640dc8df1933aaea192100d50ae0 2026/10/18 01:03:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: multipart upload wrote chunk 3 with 1 bytes, etag "ab95f1fa7da6a90274409b89562f3ffd" and md5 ab95f1fa7da6a90274409b89562f3ffd 2026/10/18 01:03:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: multipart upload wrote chunk 2 with 5242880 bytes, etag "e264fa295ef081d5ad9bfaa7e5e130b6" and md5 e264fa295ef081d5ad9bfaa7e5e130b6 2026/10/18 01:03:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: multipart upload "BuPe6Uh0BcEz8MIN_gZjegSFXdUUbEv9Gq_zAPnmvT.e7lt9JADHvAx1ZjAHZHKLgtXSx7xDC6H4483GDIucAuq2MO5rj2r2Ec6NH2w4vqMNtXZ2sQNM5QxOW_HDf4NT" finished 2026/10/18 01:03:28 DEBUG : chunked-5Mi-10.000Mi-streamed.bin: Multipart upload Etag: b677d8f19ed57bf218653ea38827c920-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5299999 === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5299999/Streamed 2026/10/18 01:03:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: open chunk writer: started multipart upload: 8znFh3_9s993.ICH7cQN2hEdgg.3jiYRIl072f7fywMpHoxE4woDf982FMks5rL1UvKBIus3XpFtvPBs_MAZjUoMfO_RnOJteMbrhGgbRhmKY1QqAU4jjIe4Nsb6i7J9 2026/10/18 01:03:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/off 2026/10/18 01:03:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: multipart upload wrote chunk 1 with 5299999 bytes, etag "2aa9b1ba4a7866fe619f84267d862086" and md5 2aa9b1ba4a7866fe619f84267d862086 2026/10/18 01:03:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: multipart upload "8znFh3_9s993.ICH7cQN2hEdgg.3jiYRIl072f7fywMpHoxE4woDf982FMks5rL1UvKBIus3XpFtvPBs_MAZjUoMfO_RnOJteMbrhGgbRhmKY1QqAU4jjIe4Nsb6i7J9" finished 2026/10/18 01:03:29 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Multipart upload Etag: 070ae709b83078a0b79bf9a5d1dc765c-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300000 2026/10/18 01:03:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: open chunk writer: started multipart upload: rCM0pD.yb0ycdS7PKqIl1X1rTe13GMKXuvIBDvw1cibdU.tqq9Jy1gvTAy0_p27PxpgW37BkWHqCSkIoF8ictbPp6hr6_e70GfJSXUOjE5r1ljPKbiEIDu221CCAfwqc 2026/10/18 01:03:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/5.054Mi 2026/10/18 01:03:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload wrote chunk 1 with 5300000 bytes, etag "9618edfd251d9205c98f3f98bea76248" and md5 9618edfd251d9205c98f3f98bea76248 2026/10/18 01:03:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: multipart upload "rCM0pD.yb0ycdS7PKqIl1X1rTe13GMKXuvIBDvw1cibdU.tqq9Jy1gvTAy0_p27PxpgW37BkWHqCSkIoF8ictbPp6hr6_e70GfJSXUOjE5r1ljPKbiEIDu221CCAfwqc" finished 2026/10/18 01:03:30 DEBUG : chunked-5.054Mi-5.054Mi.bin: Multipart upload Etag: 3206ce1fe2872bce7fc98309c9c126a0-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300000/Streamed 2026/10/18 01:03:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: open chunk writer: started multipart upload: 04J4TR7qFUM76rKBVktJHLDQ2pCeuv8BymXOhf6iuGx3ekGKRIqw6Z5WD5DxhNhgh1LqV3PtsC45P6okx.hX8UgQ4TOfi2figrwKMFt4eSkCK9.Oy_gvDthoGmWEjzy7 2026/10/18 01:03:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/off 2026/10/18 01:03:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: multipart upload wrote chunk 1 with 5300000 bytes, etag "9618edfd251d9205c98f3f98bea76248" and md5 9618edfd251d9205c98f3f98bea76248 2026/10/18 01:03:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: multipart upload "04J4TR7qFUM76rKBVktJHLDQ2pCeuv8BymXOhf6iuGx3ekGKRIqw6Z5WD5DxhNhgh1LqV3PtsC45P6okx.hX8UgQ4TOfi2figrwKMFt4eSkCK9.Oy_gvDthoGmWEjzy7" finished 2026/10/18 01:03:31 DEBUG : chunked-5.054Mi-5.054Mi-streamed.bin: Multipart upload Etag: 3206ce1fe2872bce7fc98309c9c126a0-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: open chunk writer: started multipart upload: 7asJc_ZjJ8v5k.JtAPND3_jpg1FXhu65Fn3MaLqXSsMp9mVmb_7SrSNGGFqpX5NFP8n43Ikcc8sQllULJ1eI2k1TOVIz2JOpKD89pFsdz3yb0giB7pBbQ6N_lOf6HfOd 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/10.109Mi 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload wrote chunk 1 with 5300000 bytes, etag "9618edfd251d9205c98f3f98bea76248" and md5 9618edfd251d9205c98f3f98bea76248 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/10.109Mi 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload wrote chunk 3 with 1 bytes, etag "ffe51d3e7d8297237588704eeddc6ab2" and md5 ffe51d3e7d8297237588704eeddc6ab2 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload wrote chunk 2 with 5300000 bytes, etag "442123fe50ef82513b6b6ae0fdef48b5" and md5 442123fe50ef82513b6b6ae0fdef48b5 2026/10/18 01:03:32 DEBUG : chunked-5.054Mi-10.109Mi.bin: multipart upload "7asJc_ZjJ8v5k.JtAPND3_jpg1FXhu65Fn3MaLqXSsMp9mVmb_7SrSNGGFqpX5NFP8n43Ikcc8sQllULJ1eI2k1TOVIz2JOpKD89pFsdz3yb0giB7pBbQ6N_lOf6HfOd" finished 2026/10/18 01:03:33 DEBUG : chunked-5.054Mi-10.109Mi.bin: Multipart upload Etag: ca2015b20b6523be232378f6c43a655e-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: open chunk writer: started multipart upload: WHX7EcfW3S22R_oTaw4qobdlz98vAG6GMMYVXtFSL4yzzc70kd9oT.f5hJGVPg5qdf0XSvdcqcoe.U37Ip9hgYemEYmHtzH3driRCgkjJEZpPnEBaLzpttXM8xskQyjZ 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: multipart upload: starting chunk 0 size 5.054Mi offset 0/off 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/off 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: multipart upload: starting chunk 1 size 5.054Mi offset 5.054Mi/off 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: multipart upload wrote chunk 1 with 5300000 bytes, etag "9618edfd251d9205c98f3f98bea76248" and md5 9618edfd251d9205c98f3f98bea76248 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: multipart upload wrote chunk 3 with 1 bytes, etag "ffe51d3e7d8297237588704eeddc6ab2" and md5 ffe51d3e7d8297237588704eeddc6ab2 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: multipart upload wrote chunk 2 with 5300000 bytes, etag "442123fe50ef82513b6b6ae0fdef48b5" and md5 442123fe50ef82513b6b6ae0fdef48b5 2026/10/18 01:03:34 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: multipart upload "WHX7EcfW3S22R_oTaw4qobdlz98vAG6GMMYVXtFSL4yzzc70kd9oT.f5hJGVPg5qdf0XSvdcqcoe.U37Ip9hgYemEYmHtzH3driRCgkjJEZpPnEBaLzpttXM8xskQyjZ" finished 2026/10/18 01:03:35 DEBUG : chunked-5.054Mi-10.109Mi-streamed.bin: Multipart upload Etag: ca2015b20b6523be232378f6c43a655e-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300052 === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300052/Streamed 2026/10/18 01:03:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: open chunk writer: started multipart upload: 1lJ1z3zzncp2vfkzlGr7lkYb1MN6qy4FYpkfExVNIClFN8wTnZf12X_aK1pa7gZT_ATIKZtyqfLU.lCr73spRHgRKplZGBXv9a5lWotiwnIyx2NUV14CzxyhhL_wtwN5 2026/10/18 01:03:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/off 2026/10/18 01:03:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: multipart upload wrote chunk 1 with 5300052 bytes, etag "e5c2980c0cc5f4df179c21e20019663d" and md5 e5c2980c0cc5f4df179c21e20019663d 2026/10/18 01:03:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: multipart upload "1lJ1z3zzncp2vfkzlGr7lkYb1MN6qy4FYpkfExVNIClFN8wTnZf12X_aK1pa7gZT_ATIKZtyqfLU.lCr73spRHgRKplZGBXv9a5lWotiwnIyx2NUV14CzxyhhL_wtwN5" finished 2026/10/18 01:03:36 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Multipart upload Etag: 71944443394f5a6630c3e854be917d49-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300053 2026/10/18 01:03:37 DEBUG : chunked-5.055Mi-5.055Mi.bin: open chunk writer: started multipart upload: vONwLUx9TmxS24YK0fXppJXIKHhyZfYEbBgQytqhri4FP7cQUuF2sJebMEWclR1Slbc7Ieu9b.0jDbYmNAPCzZy.UH_VeeaLY0LuTXBC_cwyyrNMozmdiTtw1Sy6qdGs 2026/10/18 01:03:37 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/5.055Mi 2026/10/18 01:03:37 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload wrote chunk 1 with 5300053 bytes, etag "96c71725f4c229231bc16c79b1ff08fd" and md5 96c71725f4c229231bc16c79b1ff08fd 2026/10/18 01:03:37 DEBUG : chunked-5.055Mi-5.055Mi.bin: multipart upload "vONwLUx9TmxS24YK0fXppJXIKHhyZfYEbBgQytqhri4FP7cQUuF2sJebMEWclR1Slbc7Ieu9b.0jDbYmNAPCzZy.UH_VeeaLY0LuTXBC_cwyyrNMozmdiTtw1Sy6qdGs" finished 2026/10/18 01:03:37 DEBUG : chunked-5.055Mi-5.055Mi.bin: Multipart upload Etag: 2dd0af08a18bb9524235b819d990351b-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300053/Streamed 2026/10/18 01:03:37 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: open chunk writer: started multipart upload: CxjIcxScLoSf4.cTsU6msNc_d9OK0OjxbnJInaKzlXogql4GtIjG6SOVe1Mbol5AqcJRzWto29xZ6ei8wd6g0F9lC.t3KQt7o.o_855D4Jw9I3codBCKpQaAYrU76ci6 2026/10/18 01:03:38 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/off 2026/10/18 01:03:38 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: multipart upload wrote chunk 1 with 5300053 bytes, etag "96c71725f4c229231bc16c79b1ff08fd" and md5 96c71725f4c229231bc16c79b1ff08fd 2026/10/18 01:03:38 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: multipart upload "CxjIcxScLoSf4.cTsU6msNc_d9OK0OjxbnJInaKzlXogql4GtIjG6SOVe1Mbol5AqcJRzWto29xZ6ei8wd6g0F9lC.t3KQt7o.o_855D4Jw9I3codBCKpQaAYrU76ci6" finished 2026/10/18 01:03:38 DEBUG : chunked-5.055Mi-5.055Mi-streamed.bin: Multipart upload Etag: 2dd0af08a18bb9524235b819d990351b-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 2026/10/18 01:03:38 DEBUG : chunked-5.055Mi-10.109Mi.bin: open chunk writer: started multipart upload: 95OAO59pB_aoeEjo_QMWk08.ByuGqZ5I0nc8r5K0lrqbsB141W3AiqfpqA61Vg15P4Puqv2UEZsQgsJd.DjaiKF_VAqc5hzt.YBHn9byTPU0f3wKlfhHlESQlrjYRhRD 2026/10/18 01:03:38 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/10.109Mi 2026/10/18 01:03:39 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload wrote chunk 1 with 5300053 bytes, etag "96c71725f4c229231bc16c79b1ff08fd" and md5 96c71725f4c229231bc16c79b1ff08fd 2026/10/18 01:03:39 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/10.109Mi 2026/10/18 01:03:39 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/10.109Mi 2026/10/18 01:03:39 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload wrote chunk 3 with 1 bytes, etag "cbb184dd8e05c9709e5dcaedaa0495cf" and md5 cbb184dd8e05c9709e5dcaedaa0495cf 2026/10/18 01:03:39 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload wrote chunk 2 with 5300053 bytes, etag "ea93706a29454b4fd13cc395bea103bb" and md5 ea93706a29454b4fd13cc395bea103bb 2026/10/18 01:03:39 DEBUG : chunked-5.055Mi-10.109Mi.bin: multipart upload "95OAO59pB_aoeEjo_QMWk08.ByuGqZ5I0nc8r5K0lrqbsB141W3AiqfpqA61Vg15P4Puqv2UEZsQgsJd.DjaiKF_VAqc5hzt.YBHn9byTPU0f3wKlfhHlESQlrjYRhRD" finished 2026/10/18 01:03:39 DEBUG : chunked-5.055Mi-10.109Mi.bin: Multipart upload Etag: 65ca3f2f064ee118f2db3a528b303125-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: open chunk writer: started multipart upload: nF5MIUP3r.I_q.ybiUNmXBz4G_C1AoLLNJqCWDMS2Cl4umlDRUMNp0RwoIUBIFFgAnFPNqFqxkQmvpgLzuIwye1O5FwAM24EZL.hnxTmG39ulOb5W1qBMfhh.fn.nYFQ 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: multipart upload: starting chunk 0 size 5.055Mi offset 0/off 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: multipart upload wrote chunk 1 with 5300053 bytes, etag "96c71725f4c229231bc16c79b1ff08fd" and md5 96c71725f4c229231bc16c79b1ff08fd 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: multipart upload: starting chunk 2 size 1 offset 10.109Mi/off 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: multipart upload: starting chunk 1 size 5.055Mi offset 5.055Mi/off 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: multipart upload wrote chunk 3 with 1 bytes, etag "cbb184dd8e05c9709e5dcaedaa0495cf" and md5 cbb184dd8e05c9709e5dcaedaa0495cf 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: multipart upload wrote chunk 2 with 5300053 bytes, etag "ea93706a29454b4fd13cc395bea103bb" and md5 ea93706a29454b4fd13cc395bea103bb 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: multipart upload "nF5MIUP3r.I_q.ybiUNmXBz4G_C1AoLLNJqCWDMS2Cl4umlDRUMNp0RwoIUBIFFgAnFPNqFqxkQmvpgLzuIwye1O5FwAM24EZL.hnxTmG39ulOb5W1qBMfhh.fn.nYFQ" finished 2026/10/18 01:03:40 DEBUG : chunked-5.055Mi-10.109Mi-streamed.bin: Multipart upload Etag: 65ca3f2f064ee118f2db3a528b303125-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990505 === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990505/Streamed 2026/10/18 01:03:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: open chunk writer: started multipart upload: rpTVcXYiTD8h3MW3N2cT8CKqcklQyFy.1mfvw2DQFAobCjv4ZnCt2IUfQbBYHIyOfvWIo5lHxvGCoy7dR9lTBDiCmE2X8R27LA8x7mVyYboin7tsWjec84kA98g7.7vW 2026/10/18 01:03:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/off 2026/10/18 01:03:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: multipart upload wrote chunk 1 with 6990505 bytes, etag "e9548a82ce25f02a063ee0076122ee24" and md5 e9548a82ce25f02a063ee0076122ee24 2026/10/18 01:03:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: multipart upload "rpTVcXYiTD8h3MW3N2cT8CKqcklQyFy.1mfvw2DQFAobCjv4ZnCt2IUfQbBYHIyOfvWIo5lHxvGCoy7dR9lTBDiCmE2X8R27LA8x7mVyYboin7tsWjec84kA98g7.7vW" finished 2026/10/18 01:03:42 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Multipart upload Etag: 350df36975967a82a7468a62a63e0761-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990506 2026/10/18 01:03:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: open chunk writer: started multipart upload: GxzgfMQmfHX.V0nc.ufvkd57lEM9scVxIlcdikWEhvhJ52yNPP0Nb2nIJuTmA7gDpJ8ptXKaJF0VETy_Ss6_oc6n054ZTOZxAbaHOWRqofaULV3TIG45kUyu7zrZjIjA 2026/10/18 01:03:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/6.667Mi 2026/10/18 01:03:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload wrote chunk 1 with 6990506 bytes, etag "6d02ef9f797a6d2cac923531b40a7113" and md5 6d02ef9f797a6d2cac923531b40a7113 2026/10/18 01:03:43 DEBUG : chunked-6.667Mi-6.667Mi.bin: multipart upload "GxzgfMQmfHX.V0nc.ufvkd57lEM9scVxIlcdikWEhvhJ52yNPP0Nb2nIJuTmA7gDpJ8ptXKaJF0VETy_Ss6_oc6n054ZTOZxAbaHOWRqofaULV3TIG45kUyu7zrZjIjA" finished 2026/10/18 01:03:44 DEBUG : chunked-6.667Mi-6.667Mi.bin: Multipart upload Etag: d8a820173c91e166112e77c629504581-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990506/Streamed 2026/10/18 01:03:44 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: open chunk writer: started multipart upload: k0Zyh6wVL9QVt9x5StjGXWbIflizUGzJMJJJwEBhabceYdE2i5_npaKRZzbhGAO8WmVoZQpJjOcNw6R_A.R3625Zt6HwEXvsTIyCkkhMTXHTsG5nRZcaYrjmgObv6cJX 2026/10/18 01:03:44 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/off 2026/10/18 01:03:45 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: multipart upload wrote chunk 1 with 6990506 bytes, etag "6d02ef9f797a6d2cac923531b40a7113" and md5 6d02ef9f797a6d2cac923531b40a7113 2026/10/18 01:03:45 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: multipart upload "k0Zyh6wVL9QVt9x5StjGXWbIflizUGzJMJJJwEBhabceYdE2i5_npaKRZzbhGAO8WmVoZQpJjOcNw6R_A.R3625Zt6HwEXvsTIyCkkhMTXHTsG5nRZcaYrjmgObv6cJX" finished 2026/10/18 01:03:45 DEBUG : chunked-6.667Mi-6.667Mi-streamed.bin: Multipart upload Etag: d8a820173c91e166112e77c629504581-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 2026/10/18 01:03:45 DEBUG : chunked-6.667Mi-13.333Mi.bin: open chunk writer: started multipart upload: XNNldJ1BVxt7wteF4h4IKAN2A_O9hqCywoQ8AMrVr9R4LotiG7ld6ne.kcVtZzy6zwcjKfGY6MP1BjCuenVsp.ZJIruB_aA9z2A7VcMqJMX2RsJdEUvw5XCd.eDfz7HQ 2026/10/18 01:03:45 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/13.333Mi 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/13.333Mi 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/13.333Mi 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload wrote chunk 1 with 6990506 bytes, etag "6d02ef9f797a6d2cac923531b40a7113" and md5 6d02ef9f797a6d2cac923531b40a7113 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload wrote chunk 3 with 1 bytes, etag "43ec3e5dee6e706af7766fffea512721" and md5 43ec3e5dee6e706af7766fffea512721 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload wrote chunk 2 with 6990506 bytes, etag "d01a45d4e43a2541c997a15d557b0479" and md5 d01a45d4e43a2541c997a15d557b0479 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: multipart upload "XNNldJ1BVxt7wteF4h4IKAN2A_O9hqCywoQ8AMrVr9R4LotiG7ld6ne.kcVtZzy6zwcjKfGY6MP1BjCuenVsp.ZJIruB_aA9z2A7VcMqJMX2RsJdEUvw5XCd.eDfz7HQ" finished 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi.bin: Multipart upload Etag: 4544b41f053fa26e7f5f5e06ac981f9b-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed 2026/10/18 01:03:46 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: open chunk writer: started multipart upload: TVJCiaDH97NGD3zHfYF_WmDFz2gYFyedds9ac7z3Df7cvH_Yoz5gdNB0t4pDKAbluNo310tVvyysZ0THKmpxzurY9pN1mW30DajLyz_dGibPcCCcHzns61T2Pq5ZFIwM 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: multipart upload: starting chunk 0 size 6.667Mi offset 0/off 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: multipart upload wrote chunk 1 with 6990506 bytes, etag "6d02ef9f797a6d2cac923531b40a7113" and md5 6d02ef9f797a6d2cac923531b40a7113 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: multipart upload: starting chunk 2 size 1 offset 13.333Mi/off 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: multipart upload: starting chunk 1 size 6.667Mi offset 6.667Mi/off 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: multipart upload wrote chunk 3 with 1 bytes, etag "43ec3e5dee6e706af7766fffea512721" and md5 43ec3e5dee6e706af7766fffea512721 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: multipart upload wrote chunk 2 with 6990506 bytes, etag "d01a45d4e43a2541c997a15d557b0479" and md5 d01a45d4e43a2541c997a15d557b0479 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: multipart upload "TVJCiaDH97NGD3zHfYF_WmDFz2gYFyedds9ac7z3Df7cvH_Yoz5gdNB0t4pDKAbluNo310tVvyysZ0THKmpxzurY9pN1mW30DajLyz_dGibPcCCcHzns61T2Pq5ZFIwM" finished 2026/10/18 01:03:47 DEBUG : chunked-6.667Mi-13.333Mi-streamed.bin: Multipart upload Etag: 4544b41f053fa26e7f5f5e06ac981f9b-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388607 === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388607/Streamed 2026/10/18 01:03:49 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: open chunk writer: started multipart upload: pv_1O1.ErBrscWXCKbHHjSHyZEV8WzGHKyxsMgy4YuzkB64pF2wE51LhjSfQdL4umtmHWPr28YRhVXN_kEZVSHBfPSdmQK49mBKttBV5HhDRIAQtreMJiIMyAdnOjQU2 2026/10/18 01:03:49 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: multipart upload: starting chunk 0 size 8.000Mi offset 0/off 2026/10/18 01:03:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: multipart upload wrote chunk 1 with 8388607 bytes, etag "1acc725c3c7ab01db7fb5ab34863fb9a" and md5 1acc725c3c7ab01db7fb5ab34863fb9a 2026/10/18 01:03:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: multipart upload "pv_1O1.ErBrscWXCKbHHjSHyZEV8WzGHKyxsMgy4YuzkB64pF2wE51LhjSfQdL4umtmHWPr28YRhVXN_kEZVSHBfPSdmQK49mBKttBV5HhDRIAQtreMJiIMyAdnOjQU2" finished 2026/10/18 01:03:50 DEBUG : chunked-8Mi-8.000Mi-streamed.bin: Multipart upload Etag: 73257af479153e674253a5b4105cb323-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388608 2026/10/18 01:03:50 DEBUG : chunked-8Mi-8Mi.bin: open chunk writer: started multipart upload: Ah.ti2ewhY1CWEbNJlgpjc8bpyGeHd3PX.EegNK0eVp0Uf.6vhpOZZKBq.Fio55XViEDytlkCpNuOBj9CzFshzNWp363WWU7FcIA7LWFjqB00UzlkKRN3YvHXNKU94hj 2026/10/18 01:03:51 DEBUG : chunked-8Mi-8Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/8Mi 2026/10/18 01:03:51 DEBUG : chunked-8Mi-8Mi.bin: multipart upload wrote chunk 1 with 8388608 bytes, etag "727943cf3cd0ed31e7fbe1bab434d5eb" and md5 727943cf3cd0ed31e7fbe1bab434d5eb 2026/10/18 01:03:51 DEBUG : chunked-8Mi-8Mi.bin: multipart upload "Ah.ti2ewhY1CWEbNJlgpjc8bpyGeHd3PX.EegNK0eVp0Uf.6vhpOZZKBq.Fio55XViEDytlkCpNuOBj9CzFshzNWp363WWU7FcIA7LWFjqB00UzlkKRN3YvHXNKU94hj" finished 2026/10/18 01:03:51 DEBUG : chunked-8Mi-8Mi.bin: Multipart upload Etag: e039da9ee1fa336ed66c53824ac058a7-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/8388608/Streamed 2026/10/18 01:03:52 DEBUG : chunked-8Mi-8Mi-streamed.bin: open chunk writer: started multipart upload: 3s4bGKZ00YneGi4U.RVUpQ7EeFVlSmWxQ02EmoMRQTo0MzJJN0m3eNcg84sc.nu9jSBnJGcfi0PUKDZWUH1F88snue9aHTj0f2T86ZwdG1gegD4g2o8FPfEyjNxgGfGJ 2026/10/18 01:03:52 DEBUG : chunked-8Mi-8Mi-streamed.bin: multipart upload: starting chunk 0 size 8Mi offset 0/off 2026/10/18 01:03:52 DEBUG : chunked-8Mi-8Mi-streamed.bin: multipart upload wrote chunk 1 with 8388608 bytes, etag "727943cf3cd0ed31e7fbe1bab434d5eb" and md5 727943cf3cd0ed31e7fbe1bab434d5eb 2026/10/18 01:03:52 DEBUG : chunked-8Mi-8Mi-streamed.bin: multipart upload "3s4bGKZ00YneGi4U.RVUpQ7EeFVlSmWxQ02EmoMRQTo0MzJJN0m3eNcg84sc.nu9jSBnJGcfi0PUKDZWUH1F88snue9aHTj0f2T86ZwdG1gegD4g2o8FPfEyjNxgGfGJ" finished 2026/10/18 01:03:52 DEBUG : chunked-8Mi-8Mi-streamed.bin: Multipart upload Etag: e039da9ee1fa336ed66c53824ac058a7-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 2026/10/18 01:03:53 DEBUG : chunked-8Mi-16.000Mi.bin: open chunk writer: started multipart upload: 3DuPu8RatsybBr7ZoucMJtV8.ZFOuwAwHEWj1arbzs7WGZe_mq553dESVRK3Kj.eI3CXbEIPK.VM7NJiIFzZ0ZQ.ZPUwU1PnfcvVaf_65kipu5b8siibUs8q2BMCguHd 2026/10/18 01:03:53 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 0 size 8Mi offset 0/16.000Mi 2026/10/18 01:03:54 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/16.000Mi 2026/10/18 01:03:54 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/16.000Mi 2026/10/18 01:03:54 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload wrote chunk 1 with 8388608 bytes, etag "727943cf3cd0ed31e7fbe1bab434d5eb" and md5 727943cf3cd0ed31e7fbe1bab434d5eb 2026/10/18 01:03:54 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload wrote chunk 3 with 1 bytes, etag "cbb184dd8e05c9709e5dcaedaa0495cf" and md5 cbb184dd8e05c9709e5dcaedaa0495cf 2026/10/18 01:03:54 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload wrote chunk 2 with 8388608 bytes, etag "38534b90825e5f26ae16e6b15a14f9c0" and md5 38534b90825e5f26ae16e6b15a14f9c0 2026/10/18 01:03:54 DEBUG : chunked-8Mi-16.000Mi.bin: multipart upload "3DuPu8RatsybBr7ZoucMJtV8.ZFOuwAwHEWj1arbzs7WGZe_mq553dESVRK3Kj.eI3CXbEIPK.VM7NJiIFzZ0ZQ.ZPUwU1PnfcvVaf_65kipu5b8siibUs8q2BMCguHd" finished 2026/10/18 01:03:54 DEBUG : chunked-8Mi-16.000Mi.bin: Multipart upload Etag: 8159f92760ea8c075536ff3ae4c4cbe0-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed 2026/10/18 01:03:55 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: open chunk writer: started multipart upload: WLici7uEjLCm25NnTy6YiBWf_jqjm64POToodRq6MbWkw0VRd_x8V7nWqHZHeJVN6KBHh6E_k.DM..4tpYwW3FIeJm5Xto4l3TIzt5ZWkgblp.UN4rir361GL7Zm3Beq 2026/10/18 01:03:55 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: multipart upload: starting chunk 0 size 8Mi offset 0/off 2026/10/18 01:03:56 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: multipart upload: starting chunk 2 size 1 offset 16Mi/off 2026/10/18 01:03:56 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: multipart upload: starting chunk 1 size 8Mi offset 8Mi/off 2026/10/18 01:03:56 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: multipart upload wrote chunk 1 with 8388608 bytes, etag "727943cf3cd0ed31e7fbe1bab434d5eb" and md5 727943cf3cd0ed31e7fbe1bab434d5eb 2026/10/18 01:03:56 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: multipart upload wrote chunk 3 with 1 bytes, etag "cbb184dd8e05c9709e5dcaedaa0495cf" and md5 cbb184dd8e05c9709e5dcaedaa0495cf 2026/10/18 01:03:56 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: multipart upload wrote chunk 2 with 8388608 bytes, etag "38534b90825e5f26ae16e6b15a14f9c0" and md5 38534b90825e5f26ae16e6b15a14f9c0 2026/10/18 01:03:56 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: multipart upload "WLici7uEjLCm25NnTy6YiBWf_jqjm64POToodRq6MbWkw0VRd_x8V7nWqHZHeJVN6KBHh6E_k.DM..4tpYwW3FIeJm5Xto4l3TIzt5ZWkgblp.UN4rir361GL7Zm3Beq" finished 2026/10/18 01:03:56 DEBUG : chunked-8Mi-16.000Mi-streamed.bin: Multipart upload Etag: 8159f92760ea8c075536ff3ae4c4cbe0-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485759 === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485759/Streamed 2026/10/18 01:03:58 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: open chunk writer: started multipart upload: Sg3fvbU7L3bbF_kQN3EKunJsArdeqwDQRVE5pymUVZa2mlQoi19QpQxaa.fhc5thdBZWgk6qLDQpXCPlXRtLMcURQqylBijPbZ3Xy5HRz9vd2GmzDLE7OQ.gJUIgFctn 2026/10/18 01:03:58 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: multipart upload: starting chunk 0 size 10.000Mi offset 0/off 2026/10/18 01:03:59 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: multipart upload wrote chunk 1 with 10485759 bytes, etag "d369e67ba9c8841b6b568a7fed32459d" and md5 d369e67ba9c8841b6b568a7fed32459d 2026/10/18 01:03:59 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: multipart upload "Sg3fvbU7L3bbF_kQN3EKunJsArdeqwDQRVE5pymUVZa2mlQoi19QpQxaa.fhc5thdBZWgk6qLDQpXCPlXRtLMcURQqylBijPbZ3Xy5HRz9vd2GmzDLE7OQ.gJUIgFctn" finished 2026/10/18 01:03:59 DEBUG : chunked-10Mi-10.000Mi-streamed.bin: Multipart upload Etag: 589cafb3633e59e0f5a6ff05c8f082c4-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485760 2026/10/18 01:03:59 DEBUG : chunked-10Mi-10Mi.bin: open chunk writer: started multipart upload: 0ULplDkntKfxDbx7ZZnzhGsTY3DR8nB3xW6SmVsms7XwdcZgv3VOq_.9v66i1FJGvaGHu3Dbo4EU4tHdFSdxb9ZDNmYBOibEzopxKC0Pn.svFwyb5dWXwAY7MlrL3c7Z 2026/10/18 01:04:00 DEBUG : chunked-10Mi-10Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/10Mi 2026/10/18 01:04:00 DEBUG : chunked-10Mi-10Mi.bin: multipart upload wrote chunk 1 with 10485760 bytes, etag "d9a6fbf6e6dbdfe64365f218c62dbcd7" and md5 d9a6fbf6e6dbdfe64365f218c62dbcd7 2026/10/18 01:04:00 DEBUG : chunked-10Mi-10Mi.bin: multipart upload "0ULplDkntKfxDbx7ZZnzhGsTY3DR8nB3xW6SmVsms7XwdcZgv3VOq_.9v66i1FJGvaGHu3Dbo4EU4tHdFSdxb9ZDNmYBOibEzopxKC0Pn.svFwyb5dWXwAY7MlrL3c7Z" finished 2026/10/18 01:04:00 DEBUG : chunked-10Mi-10Mi.bin: Multipart upload Etag: 4fbc18713bfa7c8ba8c1bff45c2f75f7-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/10485760/Streamed 2026/10/18 01:04:01 DEBUG : chunked-10Mi-10Mi-streamed.bin: open chunk writer: started multipart upload: MO4DuQ5.i0szEdhDHAa37sFnCCZUnKa2iI_cOeapK9U3diRnmmCDhKSFREub8uCW6W2Xaw5ktIp5MeeJj5kBQsaBrjZ59pPXOOHX7JL5.Lnc1QtbxiVx0EX3gb4oimOT 2026/10/18 01:04:01 DEBUG : chunked-10Mi-10Mi-streamed.bin: multipart upload: starting chunk 0 size 10Mi offset 0/off 2026/10/18 01:04:01 DEBUG : chunked-10Mi-10Mi-streamed.bin: multipart upload wrote chunk 1 with 10485760 bytes, etag "d9a6fbf6e6dbdfe64365f218c62dbcd7" and md5 d9a6fbf6e6dbdfe64365f218c62dbcd7 2026/10/18 01:04:01 DEBUG : chunked-10Mi-10Mi-streamed.bin: multipart upload "MO4DuQ5.i0szEdhDHAa37sFnCCZUnKa2iI_cOeapK9U3diRnmmCDhKSFREub8uCW6W2Xaw5ktIp5MeeJj5kBQsaBrjZ59pPXOOHX7JL5.Lnc1QtbxiVx0EX3gb4oimOT" finished 2026/10/18 01:04:01 DEBUG : chunked-10Mi-10Mi-streamed.bin: Multipart upload Etag: 4fbc18713bfa7c8ba8c1bff45c2f75f7-1 OK === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 2026/10/18 01:04:02 DEBUG : chunked-10Mi-20.000Mi.bin: open chunk writer: started multipart upload: o9u5f6hpahaSgTL3XlfbCEpWQv7MzK5QXfNTGMnLY0Tt9Adc6L.XAO3Thm5odhKAOhw0gSS2KoKse28l6EeDleA1ymjmmHh2QJM2wze5nFiwYliO8qGcwvaaN4UJJyhp 2026/10/18 01:04:02 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 0 size 10Mi offset 0/20.000Mi 2026/10/18 01:04:03 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload wrote chunk 1 with 10485760 bytes, etag "d9a6fbf6e6dbdfe64365f218c62dbcd7" and md5 d9a6fbf6e6dbdfe64365f218c62dbcd7 2026/10/18 01:04:03 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/20.000Mi 2026/10/18 01:04:03 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/20.000Mi 2026/10/18 01:04:03 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload wrote chunk 3 with 1 bytes, etag "98fd00d788afe2a5fa5e4f8e1666638b" and md5 98fd00d788afe2a5fa5e4f8e1666638b 2026/10/18 01:04:03 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload wrote chunk 2 with 10485760 bytes, etag "35c36964fdb10f7e0083e6ce8fbabff1" and md5 35c36964fdb10f7e0083e6ce8fbabff1 2026/10/18 01:04:03 DEBUG : chunked-10Mi-20.000Mi.bin: multipart upload "o9u5f6hpahaSgTL3XlfbCEpWQv7MzK5QXfNTGMnLY0Tt9Adc6L.XAO3Thm5odhKAOhw0gSS2KoKse28l6EeDleA1ymjmmHh2QJM2wze5nFiwYliO8qGcwvaaN4UJJyhp" finished 2026/10/18 01:04:03 DEBUG : chunked-10Mi-20.000Mi.bin: Multipart upload Etag: a7011c69cf0e728d9aa35b0c69e31aa9-3 OK === RUN TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed 2026/10/18 01:04:04 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: open chunk writer: started multipart upload: 2pwMMdUvAgAElclfHIO6OINd5V6OmTJaEU2qtAb8GMJk5IVjrn3hpx1LggqVjDA6EdIvo6CJedwofk5PEjixgbp53oi22rdFwQcoPufc_aZ3Mk0ayq0rVtKRTmx1FTnz 2026/10/18 01:04:05 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: multipart upload: starting chunk 0 size 10Mi offset 0/off 2026/10/18 01:04:05 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: multipart upload wrote chunk 1 with 10485760 bytes, etag "d9a6fbf6e6dbdfe64365f218c62dbcd7" and md5 d9a6fbf6e6dbdfe64365f218c62dbcd7 2026/10/18 01:04:05 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: multipart upload: starting chunk 1 size 10Mi offset 10Mi/off 2026/10/18 01:04:05 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: multipart upload: starting chunk 2 size 1 offset 20Mi/off 2026/10/18 01:04:05 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: multipart upload wrote chunk 3 with 1 bytes, etag "98fd00d788afe2a5fa5e4f8e1666638b" and md5 98fd00d788afe2a5fa5e4f8e1666638b 2026/10/18 01:04:05 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: multipart upload wrote chunk 2 with 10485760 bytes, etag "35c36964fdb10f7e0083e6ce8fbabff1" and md5 35c36964fdb10f7e0083e6ce8fbabff1 2026/10/18 01:04:06 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: multipart upload "2pwMMdUvAgAElclfHIO6OINd5V6OmTJaEU2qtAb8GMJk5IVjrn3hpx1LggqVjDA6EdIvo6CJedwofk5PEjixgbp53oi22rdFwQcoPufc_aZ3Mk0ayq0rVtKRTmx1FTnz" finished 2026/10/18 01:04:06 DEBUG : chunked-10Mi-20.000Mi-streamed.bin: Multipart upload Etag: a7011c69cf0e728d9aa35b0c69e31aa9-3 OK === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/10/18 01:04:07 DEBUG : pacer: low level retry 1/1 (error operation error S3: PutObject, exceeded maximum number of attempts, 1, https response error StatusCode: 500, RequestID: , HostID: , api error InternalServerError: Internal Server Error) 2026/10/18 01:04:07 DEBUG : pacer: Rate limited, increasing sleep to 10ms fstests.go:2738: Put returned an error after the injected failure (acceptable): operation error S3: PutObject, exceeded maximum number of attempts, 1, https response error StatusCode: 500, RequestID: , HostID: , api error InternalServerError: Internal Server Error 2026/10/18 01:04:07 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/10/18 01:04:07 DEBUG : pacer: low level retry 1/1 (error operation error S3: PutObject, exceeded maximum number of attempts, 1, https response error StatusCode: 0, RequestID: , HostID: , request send failed, Put "https://rclone-test-cutujuq6tulo.s3.eu-west-2.amazonaws.com/retry-NetError.bin?x-id=PutObject": write tcp: unexpected EOF) 2026/10/18 01:04:07 DEBUG : pacer: Rate limited, increasing sleep to 10ms fstests.go:2738: Put returned an error after the injected failure (acceptable): operation error S3: PutObject, exceeded maximum number of attempts, 1, https response error StatusCode: 0, RequestID: , HostID: , request send failed, Put "https://rclone-test-cutujuq6tulo.s3.eu-west-2.amazonaws.com/retry-NetError.bin?x-id=PutObject": write tcp: unexpected EOF 2026/10/18 01:04:07 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked/Status500 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: open chunk writer: started multipart upload: JbzSgGZUShcDutH7A_swHXMFm6SIDxtcZRh5KZwEATizgRa26QbxFNmOZRSuU90SDePR5XxGJ772oiFD2E274Dbf5rXM0bmR5sNOV1tE7FV6yIFGy9pmhBHIghAL6Avz 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: multipart upload wrote chunk 1 with 5242880 bytes, etag "4c28640dc8df1933aaea192100d50ae0" and md5 4c28640dc8df1933aaea192100d50ae0 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: multipart upload wrote chunk 3 with 1 bytes, etag "ab95f1fa7da6a90274409b89562f3ffd" and md5 ab95f1fa7da6a90274409b89562f3ffd 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: multipart upload wrote chunk 2 with 5242880 bytes, etag "e264fa295ef081d5ad9bfaa7e5e130b6" and md5 e264fa295ef081d5ad9bfaa7e5e130b6 2026/10/18 01:04:07 DEBUG : retry-chunked-Status500.bin: multipart upload "JbzSgGZUShcDutH7A_swHXMFm6SIDxtcZRh5KZwEATizgRa26QbxFNmOZRSuU90SDePR5XxGJ772oiFD2E274Dbf5rXM0bmR5sNOV1tE7FV6yIFGy9pmhBHIghAL6Avz" finished 2026/10/18 01:04:08 DEBUG : retry-chunked-Status500.bin: Multipart upload Etag: b677d8f19ed57bf218653ea38827c920-3 OK === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked/NetError 2026/10/18 01:04:09 DEBUG : retry-chunked-NetError.bin: open chunk writer: started multipart upload: G6RUdT89UiZGF58X2G6_ReNM6mqxuEkHjJupt1CMFI_hfdZ7n2h.ikvrNrOCZVpFh4IRNHYy0IfkcPxBLRXPnYMD76coEnyP.1JFaLBno8jukyNHxP8345EqKsC8YiuD 2026/10/18 01:04:09 DEBUG : retry-chunked-NetError.bin: multipart upload: starting chunk 0 size 5Mi offset 0/10.000Mi 2026/10/18 01:04:09 DEBUG : retry-chunked-NetError.bin: multipart upload: starting chunk 2 size 1 offset 10Mi/10.000Mi 2026/10/18 01:04:09 DEBUG : retry-chunked-NetError.bin: multipart upload: starting chunk 1 size 5Mi offset 5Mi/10.000Mi 2026/10/18 01:04:09 DEBUG : retry-chunked-NetError.bin: multipart upload wrote chunk 1 with 5242880 bytes, etag "4c28640dc8df1933aaea192100d50ae0" and md5 4c28640dc8df1933aaea192100d50ae0 2026/10/18 01:04:09 DEBUG : retry-chunked-NetError.bin: multipart upload wrote chunk 3 with 1 bytes, etag "ab95f1fa7da6a90274409b89562f3ffd" and md5 ab95f1fa7da6a90274409b89562f3ffd 2026/10/18 01:04:09 DEBUG : retry-chunked-NetError.bin: multipart upload wrote chunk 2 with 5242880 bytes, etag "e264fa295ef081d5ad9bfaa7e5e130b6" and md5 e264fa295ef081d5ad9bfaa7e5e130b6 2026/10/18 01:04:10 DEBUG : retry-chunked-NetError.bin: multipart upload "G6RUdT89UiZGF58X2G6_ReNM6mqxuEkHjJupt1CMFI_hfdZ7n2h.ikvrNrOCZVpFh4IRNHYy0IfkcPxBLRXPnYMD76coEnyP.1JFaLBno8jukyNHxP8345EqKsC8YiuD" finished 2026/10/18 01:04:10 DEBUG : retry-chunked-NetError.bin: Multipart upload Etag: b677d8f19ed57bf218653ea38827c920-3 OK === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/10/18 01:04:10 DEBUG : pacer: low level retry 1/1 (error operation error S3: PutObject, exceeded maximum number of attempts, 1, https response error StatusCode: 0, RequestID: , HostID: , request send failed, Put "https://rclone-test-cutujuq6tulo.s3.eu-west-2.amazonaws.com/short-eof.bin?x-id=PutObject": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 5120) 2026/10/18 01:04:10 DEBUG : pacer: Rate limited, increasing sleep to 10ms fstests.go:2862: Put returned an error (acceptable): operation error S3: PutObject, exceeded maximum number of attempts, 1, https response error StatusCode: 0, RequestID: , HostID: , request send failed, Put "https://rclone-test-cutujuq6tulo.s3.eu-west-2.amazonaws.com/short-eof.bin?x-id=PutObject": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 5120 2026/10/18 01:04:10 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked 2026/10/18 01:04:10 DEBUG : short-eof-chunked.bin: open chunk writer: started multipart upload: m6XcMxKTSNV6HTTFPV8Lueauev8wP_DU.0n.LE2s409oYOVbDljqA7mlWDkwU9b34Y4foovNDHBE9b2IrQDe6XCzAOiatnFnJvrVRp6YsUjAOXZ6SH2hk58_2Jmlc3yj 2026/10/18 01:04:10 DEBUG : short-eof-chunked.bin: multipart upload: starting chunk 0 size 5Mi offset 0/20Mi 2026/10/18 01:04:10 DEBUG : short-eof-chunked.bin: multipart upload: starting chunk 1 size 2.500Mi offset 5Mi/20Mi 2026/10/18 01:04:11 DEBUG : short-eof-chunked.bin: multipart upload wrote chunk 1 with 5242880 bytes, etag "6442ea474de05eb2775fc657cb7dcbbe" and md5 6442ea474de05eb2775fc657cb7dcbbe 2026/10/18 01:04:11 DEBUG : short-eof-chunked.bin: multipart upload wrote chunk 2 with 2621440 bytes, etag "de1ede9fc2f3a1c02669e9ad8656a542" and md5 de1ede9fc2f3a1c02669e9ad8656a542 2026/10/18 01:04:11 DEBUG : short-eof-chunked.bin: Cancelling multipart upload 2026/10/18 01:04:11 DEBUG : short-eof-chunked.bin: multipart upload "m6XcMxKTSNV6HTTFPV8Lueauev8wP_DU.0n.LE2s409oYOVbDljqA7mlWDkwU9b34Y4foovNDHBE9b2IrQDe6XCzAOiatnFnJvrVRp6YsUjAOXZ6SH2hk58_2Jmlc3yj" aborted fstests.go:2862: Put returned an error (acceptable): multipart upload: expected 20971520 bytes in input, but got 7864320: unexpected EOF === RUN TestIntegration/FsMkdir/FsCopyChunked === RUN TestIntegration/FsMkdir/FsCopyChunked/5242880 2026/10/18 01:04:11 DEBUG : chunked-copy: Starting multipart copy with 1 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/5242881 2026/10/18 01:04:13 DEBUG : chunked-copy: Starting multipart copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485759 2026/10/18 01:04:15 DEBUG : chunked-copy: Starting multipart copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485760 2026/10/18 01:04:16 DEBUG : chunked-copy: Starting multipart copy with 2 parts === RUN TestIntegration/FsMkdir/FsCopyChunked/10485761 2026/10/18 01:04:18 DEBUG : chunked-copy: Starting multipart copy with 3 parts === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/10/18 01:04:19 DEBUG : unknown-size-put.txt: open chunk writer: started multipart upload: P.9jXsic50VUTJD7Ei.nPgrhkpj31tI4mJMwxZZTJZ6LwSaLXi2ES9_K3z8vzHOwEwOXR5eOQRWaKDYohlDHAZkgIRNp.DsSdQAWmw9FqalWVJ_B2WDWA4y8lXofFcnE 2026/10/18 01:04:19 DEBUG : unknown-size-put.txt: multipart upload: starting chunk 0 size 100 offset 0/off 2026/10/18 01:04:19 DEBUG : unknown-size-put.txt: multipart upload wrote chunk 1 with 100 bytes, etag "27c834717526383067de3d9d2c46217b" and md5 27c834717526383067de3d9d2c46217b 2026/10/18 01:04:19 DEBUG : unknown-size-put.txt: multipart upload "P.9jXsic50VUTJD7Ei.nPgrhkpj31tI4mJMwxZZTJZ6LwSaLXi2ES9_K3z8vzHOwEwOXR5eOQRWaKDYohlDHAZkgIRNp.DsSdQAWmw9FqalWVJ_B2WDWA4y8lXofFcnE" finished 2026/10/18 01:04:19 DEBUG : unknown-size-put.txt: Multipart upload Etag: 1965746680b43fc7376903adb8169818-1 OK === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/10/18 01:04:19 DEBUG : unknown-size-update.txt: open chunk writer: started multipart upload: pD9V2jElli5K9S99YUkEoR1fEzTGMOfhXVV4.a443TLsD9awC7fMHLXIqevssFXD7Ek6glsX5qkHDQ8fEbvfELYgq06Dka9Gc5D53PjOMF6EorOFsaQBalPXPW3Af2LB 2026/10/18 01:04:19 DEBUG : unknown-size-update.txt: multipart upload: starting chunk 0 size 200 offset 0/off 2026/10/18 01:04:19 DEBUG : unknown-size-update.txt: multipart upload wrote chunk 1 with 200 bytes, etag "e4530b09d651951f4eca68c4fe88c426" and md5 e4530b09d651951f4eca68c4fe88c426 2026/10/18 01:04:20 DEBUG : unknown-size-update.txt: multipart upload "pD9V2jElli5K9S99YUkEoR1fEzTGMOfhXVV4.a443TLsD9awC7fMHLXIqevssFXD7Ek6glsX5qkHDQ8fEbvfELYgq06Dka9Gc5D53PjOMF6EorOFsaQBalPXPW3Af2LB" finished 2026/10/18 01:04:20 DEBUG : unknown-size-update.txt: Multipart upload Etag: b99a4c1333d10b8e19252f9259e39e63-1 OK === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/10/18 01:04:20 DEBUG : Creating backend with remote "TestS3:rclone-test-cutujuq6tulo/deeper/nonexisting/directory" === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3097: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3140: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3189: Can't test if can't have empty directories 2026/10/18 01:04:20 DEBUG : Waiting for deletions to finish 2026/10/18 01:04:20 DEBUG : "chunked-10Mi-10.000Mi-streamed-v2026-10-18-010400-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-10Mi-10.000Mi-streamed-v2026-10-18-010400-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-10Mi-10.000Mi-v2026-10-18-010359-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-10Mi-10.000Mi-v2026-10-18-010359-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-10Mi-10Mi-streamed-v2026-10-18-010403-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-10Mi-10Mi-streamed-v2026-10-18-010403-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-10Mi-10Mi-v2026-10-18-010402-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-10Mi-10Mi-v2026-10-18-010402-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-10Mi-20.000Mi-streamed-v2026-10-18-010407-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-10Mi-20.000Mi-streamed-v2026-10-18-010407-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-10Mi-20.000Mi-v2026-10-18-010405-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-10Mi-20.000Mi-v2026-10-18-010405-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-5.054Mi-10.109Mi-streamed-v2026-10-18-010336-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.054Mi-10.109Mi-streamed-v2026-10-18-010336-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-5.054Mi-10.109Mi-v2026-10-18-010334-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.054Mi-10.109Mi-v2026-10-18-010334-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-5.054Mi-5.054Mi-streamed-v2026-10-18-010332-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.054Mi-5.054Mi-streamed-v2026-10-18-010332-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-5.054Mi-5.054Mi-v2026-10-18-010332-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.054Mi-5.054Mi-v2026-10-18-010332-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-5.055Mi-10.109Mi-streamed-v2026-10-18-010342-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.055Mi-10.109Mi-streamed-v2026-10-18-010342-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-5.055Mi-10.109Mi-v2026-10-18-010341-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.055Mi-10.109Mi-v2026-10-18-010341-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-5.055Mi-5.055Mi-streamed-v2026-10-18-010339-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.055Mi-5.055Mi-streamed-v2026-10-18-010339-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-10Mi-10.000Mi-streamed-v2026-10-18-010400-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-5.055Mi-5.055Mi-v2026-10-18-010338-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5.055Mi-5.055Mi-v2026-10-18-010338-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.054Mi-10.109Mi-v2026-10-18-010334-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-5Mi-10.000Mi-streamed-v2026-10-18-010329-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5Mi-10.000Mi-streamed-v2026-10-18-010329-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-10Mi-10Mi-v2026-10-18-010402-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-5Mi-10.000Mi-v2026-10-18-010328-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5Mi-10.000Mi-v2026-10-18-010328-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-10Mi-20.000Mi-v2026-10-18-010405-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-5Mi-5.000Mi-streamed-v2026-10-18-010325-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5Mi-5.000Mi-streamed-v2026-10-18-010325-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-10Mi-10.000Mi-v2026-10-18-010359-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-5Mi-5.000Mi-v2026-10-18-010324-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5Mi-5.000Mi-v2026-10-18-010324-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-10Mi-20.000Mi-streamed-v2026-10-18-010407-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-5Mi-5Mi-streamed-v2026-10-18-010327-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5Mi-5Mi-streamed-v2026-10-18-010327-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.055Mi-10.109Mi-streamed-v2026-10-18-010342-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-5Mi-5Mi-v2026-10-18-010326-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-5Mi-5Mi-v2026-10-18-010326-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-10Mi-10Mi-streamed-v2026-10-18-010403-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-6.667Mi-13.333Mi-streamed-v2026-10-18-010349-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-6.667Mi-13.333Mi-streamed-v2026-10-18-010349-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.054Mi-5.054Mi-streamed-v2026-10-18-010332-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-6.667Mi-13.333Mi-v2026-10-18-010347-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-6.667Mi-13.333Mi-v2026-10-18-010347-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.054Mi-5.054Mi-v2026-10-18-010332-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-6.667Mi-6.667Mi-streamed-v2026-10-18-010346-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-6.667Mi-6.667Mi-streamed-v2026-10-18-010346-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.055Mi-10.109Mi-v2026-10-18-010341-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-6.667Mi-6.667Mi-v2026-10-18-010345-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-6.667Mi-6.667Mi-v2026-10-18-010345-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.054Mi-10.109Mi-streamed-v2026-10-18-010336-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-8Mi-16.000Mi-streamed-v2026-10-18-010358-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-8Mi-16.000Mi-streamed-v2026-10-18-010358-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.055Mi-5.055Mi-streamed-v2026-10-18-010339-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-8Mi-16.000Mi-v2026-10-18-010356-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-8Mi-16.000Mi-v2026-10-18-010356-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5.055Mi-5.055Mi-v2026-10-18-010338-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-8Mi-8.000Mi-streamed-v2026-10-18-010351-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-8Mi-8.000Mi-streamed-v2026-10-18-010351-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5Mi-10.000Mi-streamed-v2026-10-18-010329-000.bin: Deleted 2026/10/18 01:04:20 INFO : chunked-5Mi-10.000Mi-v2026-10-18-010328-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-8Mi-8.000Mi-v2026-10-18-010350-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-8Mi-8.000Mi-v2026-10-18-010350-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 DEBUG : "chunked-8Mi-8Mi-streamed-v2026-10-18-010354-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-8Mi-8Mi-streamed-v2026-10-18-010354-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5Mi-5.000Mi-streamed-v2026-10-18-010325-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-8Mi-8Mi-v2026-10-18-010352-000.bin" version true 2026/10/18 01:04:20 DEBUG : chunked-8Mi-8Mi-v2026-10-18-010352-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5Mi-5Mi-streamed-v2026-10-18-010327-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-copy-v2026-10-18-010420-000" version true 2026/10/18 01:04:20 DEBUG : chunked-copy-v2026-10-18-010420-000: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5Mi-5.000Mi-v2026-10-18-010324-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "chunked-copy-v2026-10-18-010420-000.copy" version true 2026/10/18 01:04:20 DEBUG : chunked-copy-v2026-10-18-010420-000.copy: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-6.667Mi-13.333Mi-streamed-v2026-10-18-010349-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" version false 2026/10/18 01:04:20 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleting (id "null") 2026/10/18 01:04:20 INFO : chunked-6.667Mi-13.333Mi-v2026-10-18-010347-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "retry-chunked-NetError-v2026-10-18-010411-000.bin" version true 2026/10/18 01:04:20 DEBUG : retry-chunked-NetError-v2026-10-18-010411-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-5Mi-5Mi-v2026-10-18-010326-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "retry-chunked-Status500-v2026-10-18-010409-000.bin" version true 2026/10/18 01:04:20 DEBUG : retry-chunked-Status500-v2026-10-18-010409-000.bin: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-6.667Mi-6.667Mi-streamed-v2026-10-18-010346-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "unknown-size-put-v2026-10-18-010420-000.txt" version true 2026/10/18 01:04:20 DEBUG : unknown-size-put-v2026-10-18-010420-000.txt: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-8Mi-16.000Mi-streamed-v2026-10-18-010358-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "unknown-size-update-v2026-10-18-010421-000.txt" version true 2026/10/18 01:04:20 DEBUG : unknown-size-update-v2026-10-18-010421-000.txt: Deleting delete marker (id "null") 2026/10/18 01:04:20 INFO : chunked-8Mi-16.000Mi-v2026-10-18-010356-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "versions/test-versions-v2026-10-18-010319-000.txt" version true 2026/10/18 01:04:20 DEBUG : versions/test-versions-v2026-10-18-010319-000.txt: Deleting delete marker (id "2TEadoRJqEQfDK1G7ddszSqPD.TZYaQh") 2026/10/18 01:04:20 INFO : chunked-8Mi-8.000Mi-streamed-v2026-10-18-010351-000.bin: Deleted 2026/10/18 01:04:20 DEBUG : "versions/test-versions-v2026-10-18-010318-000.txt" version true 2026/10/18 01:04:20 DEBUG : versions/test-versions-v2026-10-18-010318-000.txt: Deleting (id "ZtFpNGKfHPjf5R2dh79tmg.Jt483z.Wg") 2026/10/18 01:04:20 INFO : chunked-8Mi-8.000Mi-v2026-10-18-010350-000.bin: Deleted 2026/10/18 01:04:20 INFO : chunked-8Mi-8Mi-streamed-v2026-10-18-010354-000.bin: Deleted 2026/10/18 01:04:20 INFO : chunked-6.667Mi-6.667Mi-v2026-10-18-010345-000.bin: Deleted 2026/10/18 01:04:20 INFO : chunked-8Mi-8Mi-v2026-10-18-010352-000.bin: Deleted 2026/10/18 01:04:20 INFO : chunked-copy-v2026-10-18-010420-000.copy: Deleted 2026/10/18 01:04:20 INFO : retry-chunked-NetError-v2026-10-18-010411-000.bin: Deleted 2026/10/18 01:04:20 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/10/18 01:04:20 INFO : unknown-size-put-v2026-10-18-010420-000.txt: Deleted 2026/10/18 01:04:20 INFO : chunked-copy-v2026-10-18-010420-000: Deleted 2026/10/18 01:04:20 INFO : unknown-size-update-v2026-10-18-010421-000.txt: Deleted 2026/10/18 01:04:20 INFO : versions/test-versions-v2026-10-18-010319-000.txt: Deleted 2026/10/18 01:04:20 INFO : retry-chunked-Status500-v2026-10-18-010409-000.bin: Deleted 2026/10/18 01:04:20 INFO : versions/test-versions-v2026-10-18-010318-000.txt: Deleted 2026/10/18 01:04:21 INFO : S3 bucket rclone-test-cutujuq6tulo: Bucket "rclone-test-cutujuq6tulo" deleted 2026/10/18 01:04:21 DEBUG : Waiting for deletions to finish === RUN TestIntegration/FsShutdown fstests.go:3303: Shutdown method not supported --- PASS: TestIntegration (100.72s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- PASS: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.14s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRootCannotChangeHost (0.31s) --- PASS: TestIntegration/FsRmdirEmpty (0.39s) --- PASS: TestIntegration/FsMkdir (99.31s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.15s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.04s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.04s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.04s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.04s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding (6.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.34s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.34s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.34s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.35s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.38s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.34s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.33s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.26s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- PASS: TestIntegration/FsMkdir/FsOpenChunkWriter (1.33s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (31.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (1.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (1.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime (0.41s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (4.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (4.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.20s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Bucket (2.93s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (13.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/GzipEncoding (0.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/GzipEncoding/NoDecompress (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Metadata/GzipEncoding/Decompress (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/NoHead (0.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/NoHeadObjectCopy (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/HasChildren (0.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions (8.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions (0.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadCurrent (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/ReadVersion (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewObject (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Versions/NewFs (0.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt (0.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before (0.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/List (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/Before/NewObject (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/List (0.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterOne/NewObject (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/List (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterDelete/NewObject (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/List (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/VersionAt/AfterTwo/NewObject (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Mkdir (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/Versions/Cleanup (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock (3.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/Retention (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/LegalHold (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/SetAfterUpload (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/Multipart (0.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ObjectLock/Presigned (0.25s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (44.27s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi (6.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242879 (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242879/Streamed (0.89s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242880 (1.79s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/5242880/Streamed (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761 (2.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5Mi/10485761/Streamed (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi (6.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5299999 (1.45s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5299999/Streamed (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300000 (1.70s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/5300000/Streamed (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001 (3.59s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.054Mi/10600001/Streamed (1.59s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi (5.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300052 (1.43s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300052/Streamed (0.85s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300053 (1.75s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/5300053/Streamed (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107 (2.69s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/5.055Mi/10600107/Streamed (1.31s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi (7.15s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990505 (1.71s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990505/Streamed (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990506 (2.37s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/6990506/Streamed (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013 (3.06s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/6.667Mi/13981013/Streamed (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi (8.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388607 (2.19s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388607/Streamed (1.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388608 (2.62s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/8388608/Streamed (1.46s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217 (4.03s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/8Mi/16777217/Streamed (1.85s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi (9.59s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485759 (2.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485759/Streamed (1.32s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485760 (2.83s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/10485760/Streamed (1.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521 (4.48s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/10Mi/20971521/Streamed (2.28s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (3.67s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.25s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.16s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Chunked (3.42s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Chunked/Status500 (1.78s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Chunked/NetError (1.64s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.64s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.59s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked (7.87s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242880 (1.36s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/5242881 (1.33s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485759 (1.61s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485760 (1.68s) --- PASS: TestIntegration/FsMkdir/FsCopyChunked/10485761 (1.90s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.89s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.34s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.54s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.18s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- SKIP: TestIntegration/FsShutdown (0.00s) === RUN TestIntegration2 s3_test.go:320: skipping as -remote is set --- SKIP: TestIntegration2 (0.00s) === RUN TestAWSDualStackOption 2026/10/18 01:04:21 DEBUG : Using anonymous credentials - did you mean to set env_auth=true? 2026/10/18 01:04:21 DEBUG : Using anonymous credentials - did you mean to set env_auth=true? --- PASS: TestAWSDualStackOption (0.00s) === RUN TestParseRetainUntilDate === RUN TestParseRetainUntilDate/RFC3339_date === RUN TestParseRetainUntilDate/RFC3339_date_with_timezone === RUN TestParseRetainUntilDate/duration_days === RUN TestParseRetainUntilDate/duration_hours === RUN TestParseRetainUntilDate/duration_minutes === RUN TestParseRetainUntilDate/invalid_input === RUN TestParseRetainUntilDate/empty_input --- PASS: TestParseRetainUntilDate (0.00s) --- PASS: TestParseRetainUntilDate/RFC3339_date (0.00s) --- PASS: TestParseRetainUntilDate/RFC3339_date_with_timezone (0.00s) --- PASS: TestParseRetainUntilDate/duration_days (0.00s) --- PASS: TestParseRetainUntilDate/duration_hours (0.00s) --- PASS: TestParseRetainUntilDate/duration_minutes (0.00s) --- PASS: TestParseRetainUntilDate/invalid_input (0.00s) --- PASS: TestParseRetainUntilDate/empty_input (0.00s) === RUN TestOpenRestoreFirstError === RUN TestOpenRestoreFirstError/DeepArchive === RUN TestOpenRestoreFirstError/IntelligentTiering === RUN TestOpenRestoreFirstError/FromObject === RUN TestOpenRestoreFirstError/Unknown --- PASS: TestOpenRestoreFirstError (0.00s) --- PASS: TestOpenRestoreFirstError/DeepArchive (0.00s) --- PASS: TestOpenRestoreFirstError/IntelligentTiering (0.00s) --- PASS: TestOpenRestoreFirstError/FromObject (0.00s) --- PASS: TestOpenRestoreFirstError/Unknown (0.00s) PASS ok github.com/rclone/rclone/backend/s3 100.797s "go test -v -timeout 1h0m0s -remote TestS3: -verbose" - Finished OK in 1m42.759066356s (try 1/5)