"go test -v -timeout 30m0s -remote TestAzureBlob: -verbose" - Starting (try 1/5) === RUN TestIntegration === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2020/01/19 05:57:31 DEBUG : pacer: low level retry 1/10 (error -> github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob.newStorageError, /home/rclone/go/src/github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob/zc_storage_error.go:42 ===== RESPONSE ERROR (ServiceCode=ContainerBeingDeleted) ===== Description=The specified container is being deleted. Try operation later. RequestId:80423275-401e-0062-258d-ceddcc000000 Time:2020-01-19T05:57:25.9049481Z, Details: Code: ContainerBeingDeleted PUT https://rclone.blob.core.windows.net/rclone-test-huyuxaj8nizidid8galeseb4?restype=container&timeout=31536001 Authorization: REDACTED User-Agent: [rclone/v1.50.2-DEV] X-Ms-Client-Request-Id: [217da82d-b19b-4f5e-6394-d1d5315a2ec5] X-Ms-Date: [Sun, 19 Jan 2020 05:57:25 GMT] X-Ms-Version: [2018-11-09] -------------------------------------------------------------------------------- RESPONSE Status: 409 The specified container is being deleted. Try operation later. Content-Length: [252] Content-Type: [application/xml] Date: [Sun, 19 Jan 2020 05:57:25 GMT] Server: [Windows-Azure-Blob/1.0 Microsoft-HTTPAPI/2.0] X-Ms-Error-Code: [ContainerBeingDeleted] X-Ms-Request-Id: [80423275-401e-0062-258d-ceddcc000000] X-Ms-Version: [2018-11-09] ) 2020/01/19 05:57:31 DEBUG : pacer: Rate limited, increasing sleep to 10ms 2020/01/19 05:57:37 DEBUG : pacer: low level retry 2/10 (error -> github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob.newStorageError, /home/rclone/go/src/github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob/zc_storage_error.go:42 ===== RESPONSE ERROR (ServiceCode=ContainerBeingDeleted) ===== Description=The specified container is being deleted. Try operation later. RequestId:8042452c-401e-0062-0a8d-ceddcc000000 Time:2020-01-19T05:57:31.9167083Z, Details: Code: ContainerBeingDeleted PUT https://rclone.blob.core.windows.net/rclone-test-huyuxaj8nizidid8galeseb4?restype=container&timeout=31536001 Authorization: REDACTED User-Agent: [rclone/v1.50.2-DEV] X-Ms-Client-Request-Id: [11e773a4-5854-4619-43a8-c4d10fb6a230] X-Ms-Date: [Sun, 19 Jan 2020 05:57:31 GMT] X-Ms-Version: [2018-11-09] -------------------------------------------------------------------------------- RESPONSE Status: 409 The specified container is being deleted. Try operation later. Content-Length: [252] Content-Type: [application/xml] Date: [Sun, 19 Jan 2020 05:57:31 GMT] Server: [Windows-Azure-Blob/1.0 Microsoft-HTTPAPI/2.0] X-Ms-Error-Code: [ContainerBeingDeleted] X-Ms-Request-Id: [8042452c-401e-0062-0a8d-ceddcc000000] X-Ms-Version: [2018-11-09] ) 2020/01/19 05:57:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2020/01/19 05:57:43 DEBUG : pacer: low level retry 3/10 (error -> github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob.newStorageError, /home/rclone/go/src/github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob/zc_storage_error.go:42 ===== RESPONSE ERROR (ServiceCode=ContainerBeingDeleted) ===== Description=The specified container is being deleted. Try operation later. RequestId:804251aa-401e-0062-3d8d-ceddcc000000 Time:2020-01-19T05:57:37.9284694Z, Details: Code: ContainerBeingDeleted PUT https://rclone.blob.core.windows.net/rclone-test-huyuxaj8nizidid8galeseb4?restype=container&timeout=31536001 Authorization: REDACTED User-Agent: [rclone/v1.50.2-DEV] X-Ms-Client-Request-Id: [fb3a60ef-7e6e-4836-4ecd-9fbef23db364] X-Ms-Date: [Sun, 19 Jan 2020 05:57:37 GMT] X-Ms-Version: [2018-11-09] -------------------------------------------------------------------------------- RESPONSE Status: 409 The specified container is being deleted. Try operation later. Content-Length: [252] Content-Type: [application/xml] Date: [Sun, 19 Jan 2020 05:57:37 GMT] Server: [Windows-Azure-Blob/1.0 Microsoft-HTTPAPI/2.0] X-Ms-Error-Code: [ContainerBeingDeleted] X-Ms-Request-Id: [804251aa-401e-0062-3d8d-ceddcc000000] X-Ms-Version: [2018-11-09] ) 2020/01/19 05:57:43 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2020/01/19 05:57:49 DEBUG : pacer: low level retry 4/10 (error -> github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob.newStorageError, /home/rclone/go/src/github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob/zc_storage_error.go:42 ===== RESPONSE ERROR (ServiceCode=ContainerBeingDeleted) ===== Description=The specified container is being deleted. Try operation later. RequestId:80425f3d-401e-0062-218d-ceddcc000000 Time:2020-01-19T05:57:43.9422319Z, Details: Code: ContainerBeingDeleted PUT https://rclone.blob.core.windows.net/rclone-test-huyuxaj8nizidid8galeseb4?restype=container&timeout=31536001 Authorization: REDACTED User-Agent: [rclone/v1.50.2-DEV] X-Ms-Client-Request-Id: [7372ca7f-c9d9-410b-72e1-53f2ed475226] X-Ms-Date: [Sun, 19 Jan 2020 05:57:43 GMT] X-Ms-Version: [2018-11-09] -------------------------------------------------------------------------------- RESPONSE Status: 409 The specified container is being deleted. Try operation later. Content-Length: [252] Content-Type: [application/xml] Date: [Sun, 19 Jan 2020 05:57:43 GMT] Server: [Windows-Azure-Blob/1.0 Microsoft-HTTPAPI/2.0] X-Ms-Error-Code: [ContainerBeingDeleted] X-Ms-Request-Id: [80425f3d-401e-0062-218d-ceddcc000000] X-Ms-Version: [2018-11-09] ) 2020/01/19 05:57:49 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2020/01/19 05:57:55 DEBUG : pacer: low level retry 5/10 (error -> github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob.newStorageError, /home/rclone/go/src/github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob/zc_storage_error.go:42 ===== RESPONSE ERROR (ServiceCode=ContainerBeingDeleted) ===== Description=The specified container is being deleted. Try operation later. RequestId:804271b8-401e-0062-288d-ceddcc000000 Time:2020-01-19T05:57:49.9549931Z, Details: Code: ContainerBeingDeleted PUT https://rclone.blob.core.windows.net/rclone-test-huyuxaj8nizidid8galeseb4?restype=container&timeout=31536001 Authorization: REDACTED User-Agent: [rclone/v1.50.2-DEV] X-Ms-Client-Request-Id: [3b4eeafa-4672-4d95-5683-6e086875bbd5] X-Ms-Date: [Sun, 19 Jan 2020 05:57:49 GMT] X-Ms-Version: [2018-11-09] -------------------------------------------------------------------------------- RESPONSE Status: 409 The specified container is being deleted. Try operation later. Content-Length: [252] Content-Type: [application/xml] Date: [Sun, 19 Jan 2020 05:57:49 GMT] Server: [Windows-Azure-Blob/1.0 Microsoft-HTTPAPI/2.0] X-Ms-Error-Code: [ContainerBeingDeleted] X-Ms-Request-Id: [804271b8-401e-0062-288d-ceddcc000000] X-Ms-Version: [2018-11-09] ) 2020/01/19 05:57:55 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2020/01/19 05:58:01 DEBUG : pacer: low level retry 6/10 (error -> github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob.newStorageError, /home/rclone/go/src/github.com/rclone/rclone/vendor/github.com/Azure/azure-storage-blob-go/azblob/zc_storage_error.go:42 ===== RESPONSE ERROR (ServiceCode=ContainerBeingDeleted) ===== Description=The specified container is being deleted. Try operation later. RequestId:80428014-401e-0062-568d-ceddcc000000 Time:2020-01-19T05:57:55.9667537Z, Details: Code: ContainerBeingDeleted PUT https://rclone.blob.core.windows.net/rclone-test-huyuxaj8nizidid8galeseb4?restype=container&timeout=31536001 Authorization: REDACTED User-Agent: [rclone/v1.50.2-DEV] X-Ms-Client-Request-Id: [3511b07b-a9f7-437b-4c79-72cbdd2a0663] X-Ms-Date: [Sun, 19 Jan 2020 05:57:55 GMT] X-Ms-Version: [2018-11-09] -------------------------------------------------------------------------------- RESPONSE Status: 409 The specified container is being deleted. Try operation later. Content-Length: [252] Content-Type: [application/xml] Date: [Sun, 19 Jan 2020 05:57:55 GMT] Server: [Windows-Azure-Blob/1.0 Microsoft-HTTPAPI/2.0] X-Ms-Error-Code: [ContainerBeingDeleted] X-Ms-Request-Id: [80428014-401e-0062-568d-ceddcc000000] X-Ms-Version: [2018-11-09] ) 2020/01/19 05:58:01 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2020/01/19 05:58:01 DEBUG : pacer: Reducing sleep to 160ms 2020/01/19 05:58:02 DEBUG : pacer: Reducing sleep to 80ms === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2020/01/19 05:58:02 DEBUG : dir/subdir: Making directory 2020/01/19 05:58:02 DEBUG : pacer: Reducing sleep to 40ms 2020/01/19 05:58:02 DEBUG : dir/subdir: Removing directory 2020/01/19 05:58:02 DEBUG : pacer: Reducing sleep to 20ms 2020/01/19 05:58:02 DEBUG : dir: Removing directory 2020/01/19 05:58:02 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsListEmpty 2020/01/19 05:58:02 DEBUG : pacer: Reducing sleep to 0s === 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 === RUN TestIntegration/FsMkdir/FsEncoding/dot === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot === RUN TestIntegration/FsMkdir/FsEncoding/punctuation === RUN TestIntegration/FsMkdir/FsEncoding/leading_space === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt === RUN TestIntegration/FsMkdir/FsChangeNotify === 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 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot === 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/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove === 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/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot === 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 === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier 2020/01/19 05:58:04 DEBUG : file name.txt: Successfully changed object tier to Hot 2020/01/19 05:58:04 DEBUG : file name.txt: Successfully changed object tier to Cool === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/100 === RUN TestIntegration/FsMkdir/FsPutChunked/100/99 === RUN TestIntegration/FsMkdir/FsPutChunked/100/100 2020/01/19 05:58:04 DEBUG : chunked-100-100.bin: Setting multipart upload for file of chunk size (100) to work around SDK bug 2020/01/19 05:58:04 DEBUG : chunked-100-100.bin: Multipart upload session started for 1 parts of size 100 2020/01/19 05:58:04 DEBUG : chunked-100-100.bin: Uploading part 1/1 offset 0/100 part size 100 === RUN TestIntegration/FsMkdir/FsPutChunked/100/201 2020/01/19 05:58:04 DEBUG : chunked-100-201.bin: Multipart upload session started for 3 parts of size 100 2020/01/19 05:58:04 DEBUG : chunked-100-201.bin: Uploading part 3/3 offset 200/201 part size 100 2020/01/19 05:58:04 DEBUG : chunked-100-201.bin: Uploading part 2/3 offset 100/201 part size 100 2020/01/19 05:58:04 DEBUG : chunked-100-201.bin: Uploading part 1/3 offset 0/201 part size 100 === RUN TestIntegration/FsMkdir/FsPutChunked/128 === RUN TestIntegration/FsMkdir/FsPutChunked/128/127 === RUN TestIntegration/FsMkdir/FsPutChunked/128/128 2020/01/19 05:58:05 DEBUG : chunked-128-128.bin: Setting multipart upload for file of chunk size (128) to work around SDK bug 2020/01/19 05:58:05 DEBUG : chunked-128-128.bin: Multipart upload session started for 1 parts of size 128 2020/01/19 05:58:05 DEBUG : chunked-128-128.bin: Uploading part 1/1 offset 0/128 part size 128 === RUN TestIntegration/FsMkdir/FsPutChunked/128/257 2020/01/19 05:58:05 DEBUG : chunked-128-257.bin: Multipart upload session started for 3 parts of size 128 2020/01/19 05:58:05 DEBUG : chunked-128-257.bin: Uploading part 3/3 offset 256/257 part size 128 2020/01/19 05:58:05 DEBUG : chunked-128-257.bin: Uploading part 1/3 offset 0/257 part size 128 2020/01/19 05:58:05 DEBUG : chunked-128-257.bin: Uploading part 2/3 offset 128/257 part size 128 === RUN TestIntegration/FsMkdir/FsPutChunked/97.656k === RUN TestIntegration/FsMkdir/FsPutChunked/97.656k/99999 === RUN TestIntegration/FsMkdir/FsPutChunked/97.656k/100000 2020/01/19 05:58:05 DEBUG : chunked-97.656k-97.656k.bin: Setting multipart upload for file of chunk size (100000) to work around SDK bug 2020/01/19 05:58:05 DEBUG : chunked-97.656k-97.656k.bin: Multipart upload session started for 1 parts of size 97.656k 2020/01/19 05:58:05 DEBUG : chunked-97.656k-97.656k.bin: Uploading part 1/1 offset 0/97.656k part size 97.656k === RUN TestIntegration/FsMkdir/FsPutChunked/97.656k/200001 2020/01/19 05:58:05 DEBUG : chunked-97.656k-195.313k.bin: Multipart upload session started for 3 parts of size 97.656k 2020/01/19 05:58:05 DEBUG : chunked-97.656k-195.313k.bin: Uploading part 1/3 offset 0/195.313k part size 97.656k 2020/01/19 05:58:05 DEBUG : chunked-97.656k-195.313k.bin: Uploading part 3/3 offset 195.312k/195.313k part size 97.656k 2020/01/19 05:58:05 DEBUG : chunked-97.656k-195.313k.bin: Uploading part 2/3 offset 97.656k/195.313k part size 97.656k === RUN TestIntegration/FsMkdir/FsPutChunked/97.657k === RUN TestIntegration/FsMkdir/FsPutChunked/97.657k/100000 === RUN TestIntegration/FsMkdir/FsPutChunked/97.657k/100001 2020/01/19 05:58:05 DEBUG : chunked-97.657k-97.657k.bin: Setting multipart upload for file of chunk size (100001) to work around SDK bug 2020/01/19 05:58:05 DEBUG : chunked-97.657k-97.657k.bin: Multipart upload session started for 1 parts of size 97.657k 2020/01/19 05:58:05 DEBUG : chunked-97.657k-97.657k.bin: Uploading part 1/1 offset 0/97.657k part size 97.657k === RUN TestIntegration/FsMkdir/FsPutChunked/97.657k/200003 2020/01/19 05:58:05 DEBUG : chunked-97.657k-195.315k.bin: Multipart upload session started for 3 parts of size 97.657k 2020/01/19 05:58:05 DEBUG : chunked-97.657k-195.315k.bin: Uploading part 1/3 offset 0/195.315k part size 97.657k 2020/01/19 05:58:05 DEBUG : chunked-97.657k-195.315k.bin: Uploading part 3/3 offset 195.314k/195.315k part size 97.657k 2020/01/19 05:58:05 DEBUG : chunked-97.657k-195.315k.bin: Uploading part 2/3 offset 97.657k/195.315k part size 97.657k === RUN TestIntegration/FsMkdir/FsPutChunked/682.731k === RUN TestIntegration/FsMkdir/FsPutChunked/682.731k/699116 === RUN TestIntegration/FsMkdir/FsPutChunked/682.731k/699117 2020/01/19 05:58:05 DEBUG : chunked-682.731k-682.731k.bin: Setting multipart upload for file of chunk size (699117) to work around SDK bug 2020/01/19 05:58:05 DEBUG : chunked-682.731k-682.731k.bin: Multipart upload session started for 1 parts of size 682.731k 2020/01/19 05:58:05 DEBUG : chunked-682.731k-682.731k.bin: Uploading part 1/1 offset 0/682.731k part size 682.731k === RUN TestIntegration/FsMkdir/FsPutChunked/682.731k/1398235 2020/01/19 05:58:06 DEBUG : chunked-682.731k-1.333M.bin: Multipart upload session started for 3 parts of size 682.731k 2020/01/19 05:58:06 DEBUG : chunked-682.731k-1.333M.bin: Uploading part 1/3 offset 0/1.333M part size 682.731k 2020/01/19 05:58:06 DEBUG : chunked-682.731k-1.333M.bin: Uploading part 3/3 offset 1.333M/1.333M part size 682.731k 2020/01/19 05:58:06 DEBUG : chunked-682.731k-1.333M.bin: Uploading part 2/3 offset 682.731k/1.333M part size 682.731k === RUN TestIntegration/FsMkdir/FsPutChunked/2M === RUN TestIntegration/FsMkdir/FsPutChunked/2M/2097151 === RUN TestIntegration/FsMkdir/FsPutChunked/2M/2097152 2020/01/19 05:58:06 DEBUG : chunked-2M-2M.bin: Setting multipart upload for file of chunk size (2097152) to work around SDK bug 2020/01/19 05:58:06 DEBUG : chunked-2M-2M.bin: Multipart upload session started for 1 parts of size 2M 2020/01/19 05:58:06 DEBUG : chunked-2M-2M.bin: Uploading part 1/1 offset 0/2M part size 2M === RUN TestIntegration/FsMkdir/FsPutChunked/2M/4194305 2020/01/19 05:58:07 DEBUG : chunked-2M-4.000M.bin: Multipart upload session started for 3 parts of size 2M 2020/01/19 05:58:07 DEBUG : chunked-2M-4.000M.bin: Uploading part 1/3 offset 0/4.000M part size 2M 2020/01/19 05:58:07 DEBUG : chunked-2M-4.000M.bin: Uploading part 3/3 offset 4M/4.000M part size 2M 2020/01/19 05:58:07 DEBUG : chunked-2M-4.000M.bin: Uploading part 2/3 offset 2M/4.000M part size 2M === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize === RUN TestIntegration/FsMkdir/FsRootCollapse --- PASS: TestIntegration (42.13s) fstests.go:365: Using remote "TestAzureBlob:" --- SKIP: TestIntegration/FsCheckWrap (0.00s) fstests.go:402: Not a wrapping Fs --- PASS: TestIntegration/FsRmdirNotFound (0.10s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.02s) --- PASS: TestIntegration/FsMkdir (41.99s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.28s) fstest.go:241: Filtering empty directory "dir" fstest.go:241: Filtering empty directory "dir/subdir" fstest.go:241: Filtering empty directory "dir" --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.02s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.01s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.01s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding (1.14s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.21s) fstests.go:594: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.09s) fstests.go:594: testing "．" --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.05s) fstests.go:594: testing "．．" --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.05s) fstests.go:594: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.05s) fstests.go:594: testing " leading space" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.05s) fstests.go:594: testing "~leading tilde" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.06s) fstests.go:594: testing "␍leading CR" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.05s) fstests.go:594: testing "␊leading LF" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.06s) fstests.go:594: testing "␉leading HT" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.05s) fstests.go:594: testing "␋leading VT" --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.05s) fstests.go:594: testing ".leading dot" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.05s) fstests.go:594: testing "trailing space " --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.05s) fstests.go:594: testing "trailing CR␍" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.05s) fstests.go:594: testing "trailing LF␊" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.05s) fstests.go:594: testing "trailing HT␉" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.05s) fstests.go:594: testing "trailing VT␋" --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.05s) fstests.go:594: testing "trailing dot." --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.05s) fstests.go:594: testing "invalid utf-8\xfe" --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.04s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) fstests.go:667: FS has no OpenWriterAt interface --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) fstests.go:703: FS has no ChangeNotify interface --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) fstests.go:1008: FS has no Mover interface --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) fstests.go:1079: FS has no DirMover interface --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.30s) fstests.go:1363: Opening root remote "TestAzureBlob:" path "rclone-test-huyuxaj8nizidid8galeseb4" from "TestAzureBlob:rclone-test-huyuxaj8nizidid8galeseb4" --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) fstests.go:1456: FS has no PublicLinker interface --- PASS: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) fstests.go:1539: Not a wrapping Fs --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) fstests.go:1568: FS does not support About --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) fstests.go:1586: FS has no PutStream interface --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutChunked (2.84s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/100 (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/100/99 (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/100/100 (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/100/201 (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/128 (0.17s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/128/127 (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/128/128 (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/128/257 (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.656k (0.24s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.656k/99999 (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.656k/100000 (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.656k/200001 (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.657k (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.657k/100000 (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.657k/100001 (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/97.657k/200003 (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/682.731k (0.65s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/682.731k/699116 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/682.731k/699117 (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/682.731k/1398235 (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2M (1.39s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2M/2097151 (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2M/2097152 (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutChunked/2M/4194305 (0.65s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.14s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.05s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.09s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) PASS ok github.com/rclone/rclone/backend/azureblob 42.136s "go test -v -timeout 30m0s -remote TestAzureBlob: -verbose" - Finished OK in 44.311173309s (try 1/5)