"go test -v -timeout 1h0m0s -remote TestQingStor: -verbose" - Starting (try 3/5) === RUN TestIntegration fstests.go:357: Using remote "TestQingStor:" 2020/11/03 08:21:52 DEBUG : Creating backend with remote "TestQingStor:rclone-test-gicusay1punuliv4yusiyag3" === RUN TestIntegration/FsCheckWrap fstests.go:394: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:422: No commands in this remote === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2020/11/03 08:22:16 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 0 2020/11/03 08:22:18 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 1 2020/11/03 08:22:19 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 2 2020/11/03 08:22:21 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 3 2020/11/03 08:22:22 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 4 2020/11/03 08:22:23 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 5 2020/11/03 08:22:25 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 6 2020/11/03 08:22:26 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 7 2020/11/03 08:22:28 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 8 2020/11/03 08:22:29 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 9 2020/11/03 08:22:31 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 10 2020/11/03 08:22:33 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 11 2020/11/03 08:22:34 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 12 2020/11/03 08:22:38 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 13 2020/11/03 08:22:39 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 14 2020/11/03 08:22:41 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 15 2020/11/03 08:22:42 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 16 2020/11/03 08:22:44 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 17 2020/11/03 08:22:45 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 18 2020/11/03 08:22:46 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 19 2020/11/03 08:22:48 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 20 2020/11/03 08:22:50 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 21 2020/11/03 08:22:52 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 22 2020/11/03 08:22:55 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 23 2020/11/03 08:22:56 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 24 2020/11/03 08:22:58 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 25 2020/11/03 08:23:00 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 26 2020/11/03 08:23:01 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 27 2020/11/03 08:23:02 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 28 2020/11/03 08:23:05 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 29 2020/11/03 08:23:06 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 30 2020/11/03 08:23:07 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 31 2020/11/03 08:23:09 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be deleted, retries: 32 2020/11/03 08:23:20 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be creatable, retries: 0 2020/11/03 08:23:27 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3: Wait for qingstor bucket to be creatable, retries: 1 === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2020/11/03 08:23:31 DEBUG : dir/subdir: Making directory fstest.go:247: Filtering empty directory "dir" fstest.go:247: Filtering empty directory "dir/subdir" 2020/11/03 08:23:32 DEBUG : dir/subdir: Removing directory fstest.go:247: Filtering empty directory "dir" 2020/11/03 08:23:33 DEBUG : 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:605: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2020/11/03 08:23:37 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:605: testing "." 2020/11/03 08:23:43 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ./.: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:605: testing ".." 2020/11/03 08:23:52 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ../..: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:605: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2020/11/03 08:23:59 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:605: testing " leading space" 2020/11/03 08:24:07 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key leading space/ leading space: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:605: testing "~leading tilde" 2020/11/03 08:24:13 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ~leading tilde/~leading tilde: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:605: testing "␍leading CR" 2020/11/03 08:24:23 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ␍leading CR/␍leading CR: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:605: testing "␊leading LF" 2020/11/03 08:24:31 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ␊leading LF/␊leading LF: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:605: testing "␉leading HT" 2020/11/03 08:24:38 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ␉leading HT/␉leading HT: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:605: testing "␋leading VT" 2020/11/03 08:24:52 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key ␋leading VT/␋leading VT: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:605: testing ".leading dot" 2020/11/03 08:24:57 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key .leading dot/.leading dot: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:605: testing "trailing space " 2020/11/03 08:25:05 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key trailing space /trailing space : Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:605: testing "trailing CR␍" 2020/11/03 08:25:17 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key trailing CR␍/trailing CR␍: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:605: testing "trailing LF␊" 2020/11/03 08:25:22 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key trailing LF␊/trailing LF␊: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:605: testing "trailing HT␉" 2020/11/03 08:25:30 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key trailing HT␉/trailing HT␉: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:605: testing "trailing VT␋" 2020/11/03 08:25:44 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key trailing VT␋/trailing VT␋: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:605: testing "trailing dot." 2020/11/03 08:25:52 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key trailing dot./trailing dot.: Upload single object finished === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:605: testing "invalid utf-8\xfe" 2020/11/03 08:26:00 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key invalid utf-8‛FE/invalid utf-8‛FE: Upload single object finished === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength 2020/11/03 08:26:13 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key zero-length-file: Upload single object finished === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:678: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:714: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2020/11/03 08:26:21 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key file name.txt: Upload single object finished 2020/11/03 08:26:24 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Upload single object finished 2020/11/03 08:26:28 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key file name.txt: Upload single object finished === 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 2020/11/03 08:26:40 DEBUG : Creating backend with remote "TestQingStor:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2020/11/03 08:26:51 DEBUG : Creating backend with remote "TestQingStor:" === 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/FsPurge fstests.go:985: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1056: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1127: 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/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 2020/11/03 08:27:37 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key file name.txt: Upload single object finished === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2020/11/03 08:27:39 DEBUG : Creating backend with remote "TestQingStor:rclone-test-gicusay1punuliv4yusiyag3/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2020/11/03 08:27:43 DEBUG : Creating backend with remote "TestQingStor:rclone-test-gicusay1punuliv4yusiyag3/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1411: Opening root remote "TestQingStor:" path "rclone-test-gicusay1punuliv4yusiyag3" from "TestQingStor:rclone-test-gicusay1punuliv4yusiyag3" 2020/11/03 08:27:44 DEBUG : Creating backend with remote "TestQingStor:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2020/11/03 08:27:58 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key created from root.txt: Upload single object finished === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:1504: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:331: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:1589: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:1618: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream fstests.go:1636: FS has no PutStream interface === RUN TestIntegration/FsMkdir/FsPutFiles/Internal fstests.go:1680: *qingstor.Fs does not implement InternalTester === RUN TestIntegration/FsMkdir/FsPutChunked === RUN TestIntegration/FsMkdir/FsPutChunked/4M === RUN TestIntegration/FsMkdir/FsPutChunked/4M/4194303 2020/11/03 08:44:52 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-4.000M.bin: Upload single object finished fstests.go:219: Error Trace: fstests.go:219 Error: Received unexpected error: read tcp 167.172.51.213:42502->139.198.7.171:443: read: connection reset by peer Test: TestIntegration/FsMkdir/FsPutChunked/4M/4194303 === RUN TestIntegration/FsMkdir/FsPutChunked/4M/4194304 2020/11/03 08:49:29 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-4M.bin: Uploading as multi-part object to QingStor 2020/11/03 08:49:29 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-4M.bin uploadID : Initiating a multi-part upload 2020/11/03 08:49:33 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-4M.bin uploadID 66e1db3904099bf: Uploading a part to QingStor with partNumber 0 and partSize 4194304 2020/11/03 08:52:30 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-4M.bin uploadID 66e1db3904099bf: Cancelling multipart upload: Put "https://pek3a.qingstor.com:443/rclone-test-gicusay1punuliv4yusiyag3/chunked-4M-4M.bin?part_number=0&upload_id=66e1db3904099bf": write tcp 167.172.51.213:48116->139.198.7.206:443: use of closed network connection 2020/11/03 08:52:30 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-4M.bin uploadID 66e1db3904099bf: Aborting multi-part object "66e1db3904099bf" fstests.go:153: Error Trace: fstests.go:153 fstests.go:195 Error: Received unexpected error: Put "https://pek3a.qingstor.com:443/rclone-test-gicusay1punuliv4yusiyag3/chunked-4M-4M.bin?part_number=0&upload_id=66e1db3904099bf": write tcp 167.172.51.213:48116->139.198.7.206:443: use of closed network connection Test: TestIntegration/FsMkdir/FsPutChunked/4M/4194304 Messages: PutLarge === RUN TestIntegration/FsMkdir/FsPutChunked/4M/8388609 2020/11/03 08:52:34 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin: Uploading as multi-part object to QingStor 2020/11/03 08:52:34 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID : Initiating a multi-part upload 2020/11/03 08:52:36 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Uploading a part to QingStor with partNumber 0 and partSize 4194304 2020/11/03 09:04:03 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Done uploading part partNumber 0 and partSize 4194304 2020/11/03 09:04:03 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Uploading a part to QingStor with partNumber 1 and partSize 4194304 2020/11/03 09:16:23 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Done uploading part partNumber 1 and partSize 4194304 2020/11/03 09:16:23 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Uploading a part to QingStor with partNumber 2 and partSize 1 2020/11/03 09:16:24 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Done uploading part partNumber 2 and partSize 1 2020/11/03 09:16:24 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Completing multi-part object 2020/11/03 09:16:24 DEBUG : QingStor bucket rclone-test-gicusay1punuliv4yusiyag3 key chunked-4M-8.000M.bin uploadID 66e1e6694808d73: Complete multi-part finished === RUN TestIntegration/FsMkdir/FsPutChunked/4.005M === RUN TestIntegration/FsMkdir/FsPutChunked/4.005M/4199999 panic: test timed out after 1h0m0s goroutine 312 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:1618 +0xe5 created by time.goFunc /usr/local/go/src/time/sleep.go:167 +0x45 goroutine 1 [chan receive, 59 minutes]: testing.(*T).Run(0xc0000fe480, 0xb82d31, 0xf, 0xbb9190, 0x4998a6) /usr/local/go/src/testing/testing.go:1169 +0x2da testing.runTests.func1(0xc0000fe300) /usr/local/go/src/testing/testing.go:1439 +0x78 testing.tRunner(0xc0000fe300, 0xc0000cbde0) /usr/local/go/src/testing/testing.go:1123 +0xef testing.runTests(0xc00000ffa0, 0xffe550, 0x1, 0x1, 0xbfe0662c0a80ef74, 0x346311b909d, 0x1013ae0, 0x40f630) /usr/local/go/src/testing/testing.go:1437 +0x2fe testing.(*M).Run(0xc0000d2900, 0x0) /usr/local/go/src/testing/testing.go:1345 +0x1eb main.main() _testmain.go:43 +0x138 goroutine 280 [chan receive, 6 minutes]: testing.(*T).Run(0xc00023c300, 0xc00037d330, 0x6, 0xc0002bc6e0, 0x1) /usr/local/go/src/testing/testing.go:1169 +0x2da github.com/rclone/rclone/fstest/fstests.Run.func13.14(0xc00023c900) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1766 +0x578 testing.tRunner(0xc00023c900, 0xc00007d800) /usr/local/go/src/testing/testing.go:1123 +0xef created by testing.(*T).Run /usr/local/go/src/testing/testing.go:1168 +0x2b3 goroutine 7 [chan receive, 59 minutes]: testing.(*T).Run(0xc00018ec00, 0xb7c549, 0x7, 0xc0000cf3b0, 0x1) /usr/local/go/src/testing/testing.go:1169 +0x2da github.com/rclone/rclone/fstest/fstests.Run(0xc0000fe480, 0xc000094370) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:489 +0xec5 github.com/rclone/rclone/backend/qingstor.TestIntegration(0xc0000fe480) /home/rclone/go/src/github.com/rclone/rclone/backend/qingstor/qingstor_test.go:16 +0x72 testing.tRunner(0xc0000fe480, 0xbb9190) /usr/local/go/src/testing/testing.go:1123 +0xef created by testing.(*T).Run /usr/local/go/src/testing/testing.go:1168 +0x2b3 goroutine 26 [chan receive, 54 minutes]: testing.(*T).Run(0xc00023c900, 0xb8095c, 0xc, 0xc00007d800, 0x1) /usr/local/go/src/testing/testing.go:1169 +0x2da github.com/rclone/rclone/fstest/fstests.Run.func13(0xc00018ec00) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1689 +0xb06 testing.tRunner(0xc00018ec00, 0xc0000cf3b0) /usr/local/go/src/testing/testing.go:1123 +0xef created by testing.(*T).Run /usr/local/go/src/testing/testing.go:1168 +0x2b3 goroutine 288 [chan receive, 32 minutes]: github.com/rclone/rclone/lib/atexit.Register.func1.1() /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:39 +0x45 created by github.com/rclone/rclone/lib/atexit.Register.func1 /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:38 +0x94 goroutine 304 [chan receive, 6 minutes]: testing.(*T).Run(0xc00023c480, 0xc00037d380, 0x7, 0xc00051ef30, 0x1) /usr/local/go/src/testing/testing.go:1169 +0x2da github.com/rclone/rclone/fstest/fstests.Run.func13.14.3(0xc00023c300) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1783 +0x198 testing.tRunner(0xc00023c300, 0xc0002bc6e0) /usr/local/go/src/testing/testing.go:1123 +0xef created by testing.(*T).Run /usr/local/go/src/testing/testing.go:1168 +0x2b3 goroutine 308 [IO wait, 6 minutes]: internal/poll.runtime_pollWait(0x7f8d30da6ee8, 0x72, 0xc508a0) /usr/local/go/src/runtime/netpoll.go:220 +0x55 internal/poll.(*pollDesc).wait(0xc000112718, 0x72, 0xc50800, 0xfa57b0, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:87 +0x45 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:92 internal/poll.(*FD).Read(0xc000112700, 0xc0004ee000, 0xd526, 0xd526, 0x0, 0x0, 0x0) /usr/local/go/src/internal/poll/fd_unix.go:159 +0x1a5 net.(*netFD).Read(0xc000112700, 0xc0004ee000, 0xd526, 0xd526, 0xd519, 0x93d4a7b69ca0b315, 0x7f568227445d8c43) /usr/local/go/src/net/fd_posix.go:55 +0x4f net.(*conn).Read(0xc0000f5120, 0xc0004ee000, 0xd526, 0xd526, 0x0, 0x0, 0x0) /usr/local/go/src/net/net.go:182 +0x8e github.com/rclone/rclone/fs/fshttp.(*timeoutConn).readOrWrite(0xc000378020, 0xc0000c7580, 0xc0004ee000, 0xd526, 0xd526, 0x203000, 0x6705bb, 0xc000213660) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:75 +0x48 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000378020, 0xc0004ee000, 0xd526, 0xd526, 0xc0002136a8, 0xd, 0x7f8d30da57d0) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:87 +0x8a crypto/tls.(*atLeastReader).Read(0xc00033f280, 0xc0004ee000, 0xd526, 0xd526, 0xc5, 0xd519, 0xc0000c7668) /usr/local/go/src/crypto/tls/conn.go:779 +0x62 bytes.(*Buffer).ReadFrom(0xc000213780, 0xc4ec80, 0xc00033f280, 0x40d345, 0xacdcc0, 0xb30a40) /usr/local/go/src/bytes/buffer.go:204 +0xb1 crypto/tls.(*Conn).readFromUntil(0xc000213500, 0x7f8d30daffd8, 0xc000378020, 0x5, 0xc000378020, 0xb5) /usr/local/go/src/crypto/tls/conn.go:801 +0xf3 crypto/tls.(*Conn).readRecordOrCCS(0xc000213500, 0x0, 0x0, 0xc000386ea0) /usr/local/go/src/crypto/tls/conn.go:608 +0x115 crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:576 crypto/tls.(*Conn).Read(0xc000213500, 0xc000174000, 0x1000, 0x1000, 0x0, 0x0, 0x0) /usr/local/go/src/crypto/tls/conn.go:1252 +0x15f net/http.(*persistConn).Read(0xc0002597a0, 0xc000174000, 0x1000, 0x1000, 0xc0000c7eb0, 0x46a240, 0xc0000c7eb0) /usr/local/go/src/net/http/transport.go:1887 +0x77 bufio.(*Reader).fill(0xc0003574a0) /usr/local/go/src/bufio/bufio.go:101 +0x105 bufio.(*Reader).Peek(0xc0003574a0, 0x1, 0x2, 0x0, 0x0, 0x0, 0xc000386e40) /usr/local/go/src/bufio/bufio.go:139 +0x4f net/http.(*persistConn).readLoop(0xc0002597a0) /usr/local/go/src/net/http/transport.go:2040 +0x1a8 created by net/http.(*Transport).dialConn /usr/local/go/src/net/http/transport.go:1708 +0xcb7 goroutine 305 [select, 6 minutes]: net/http.(*persistConn).roundTrip(0xc0002597a0, 0xc000254c00, 0x0, 0x0, 0x0) /usr/local/go/src/net/http/transport.go:2565 +0x779 net/http.(*Transport).roundTrip(0xc000218dc0, 0xc000084d00, 0xb7f5aa, 0xa, 0xc000137990) /usr/local/go/src/net/http/transport.go:582 +0xa65 net/http.(*Transport).RoundTrip(...) /usr/local/go/src/net/http/roundtrip.go:17 github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc000254b00, 0xc000084d00, 0xc000254b00, 0x0, 0x0) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:337 +0x393 net/http.send(0xc000084d00, 0xc4f040, 0xc000254b00, 0x0, 0x0, 0x0, 0xc0000f5248, 0xc0000318c8, 0x1, 0x0) /usr/local/go/src/net/http/client.go:252 +0x453 net/http.(*Client).send(0xc000211e00, 0xc000084d00, 0x0, 0x0, 0x0, 0xc0000f5248, 0x0, 0x1, 0x972854) /usr/local/go/src/net/http/client.go:176 +0xff net/http.(*Client).do(0xc000211e00, 0xc000084d00, 0x0, 0x0, 0x0) /usr/local/go/src/net/http/client.go:718 +0x45f net/http.(*Client).Do(...) /usr/local/go/src/net/http/client.go:586 github.com/yunify/qingstor-sdk-go/v3/request.(*Request).send(0xc00051ef90, 0xc00002ee94, 0x28) /home/rclone/go/pkg/mod/github.com/yunify/qingstor-sdk-go/v3@v3.2.0/request/request.go:222 +0x1db github.com/yunify/qingstor-sdk-go/v3/request.(*Request).Do(0xc00051ef90, 0x0, 0x0) /home/rclone/go/pkg/mod/github.com/yunify/qingstor-sdk-go/v3@v3.2.0/request/request.go:105 +0x2f github.com/yunify/qingstor-sdk-go/v3/request.(*Request).Send(0xc00051ef90, 0xc00043b1a5, 0x19) /home/rclone/go/pkg/mod/github.com/yunify/qingstor-sdk-go/v3@v3.2.0/request/request.go:78 +0x79 github.com/yunify/qingstor-sdk-go/v3/service.(*Bucket).PutObject(0xc0001c74d0, 0xc00043b1a5, 0x19, 0xc000552180, 0x5, 0xc0001c74d0, 0x0) /home/rclone/go/pkg/mod/github.com/yunify/qingstor-sdk-go/v3@v3.2.0/service/object.go:937 +0x89 github.com/rclone/rclone/backend/qingstor.(*uploader).singlePartUpload(0xc00033f420, 0xc4f560, 0xc00033f400, 0x40163f, 0xc0002e2570, 0x18) /home/rclone/go/src/github.com/rclone/rclone/backend/qingstor/upload.go:165 +0x145 github.com/rclone/rclone/backend/qingstor.(*Object).Update(0xc0000c4770, 0xc5c920, 0xc000024060, 0xc4f560, 0xc00033f400, 0xc61a60, 0xc0002bc780, 0x0, 0x0, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/qingstor/qingstor.go:1086 +0x365 github.com/rclone/rclone/backend/qingstor.(*Fs).Put(0xc0002700e0, 0xc5c920, 0xc000024060, 0xc4f560, 0xc00033f400, 0xc61a60, 0xc0002bc780, 0x0, 0x0, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/qingstor/qingstor.go:428 +0x11e github.com/rclone/rclone/fstest/fstests.TestPutLarge.func1(0xc000296000, 0x6) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:201 +0x262 github.com/rclone/rclone/fstest/fstests.retry(0xc00023c480, 0xb7d990, 0x8, 0xc0001a7e20) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:145 +0x10c github.com/rclone/rclone/fstest/fstests.TestPutLarge(0xc5c920, 0xc000024060, 0xc00023c480, 0xc638c0, 0xc0002700e0, 0xc0001a7f38) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:195 +0x13a github.com/rclone/rclone/fstest/fstests.Run.func13.14.3.1(0xc00023c480) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1784 +0x27f testing.tRunner(0xc00023c480, 0xc00051ef30) /usr/local/go/src/testing/testing.go:1123 +0xef created by testing.(*T).Run /usr/local/go/src/testing/testing.go:1168 +0x2b3 goroutine 297 [syscall, 32 minutes]: os/signal.signal_recv(0x0) /usr/local/go/src/runtime/sigqueue.go:147 +0x9d os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:23 +0x25 created by os/signal.Notify.func1.1 /usr/local/go/src/os/signal/signal.go:150 +0x45 goroutine 309 [IO wait]: internal/poll.runtime_pollWait(0x7f8d30da6ee8, 0x77, 0xc508a0) /usr/local/go/src/runtime/netpoll.go:220 +0x55 internal/poll.(*pollDesc).wait(0xc000112718, 0x77, 0xc50800, 0xfa57b0, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:87 +0x45 internal/poll.(*pollDesc).waitWrite(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:96 internal/poll.(*FD).Write(0xc000112700, 0xc000326800, 0x401d, 0x401d, 0x0, 0x0, 0x0) /usr/local/go/src/internal/poll/fd_unix.go:275 +0x2d0 net.(*netFD).Write(0xc000112700, 0xc000326800, 0x401d, 0x401d, 0x401d, 0xc000326805, 0x8) /usr/local/go/src/net/fd_posix.go:73 +0x4f net.(*conn).Write(0xc0000f5120, 0xc000326800, 0x401d, 0x401d, 0x0, 0x0, 0x0) /usr/local/go/src/net/net.go:194 +0x8e github.com/rclone/rclone/fs/fshttp.(*timeoutConn).readOrWrite(0xc000378020, 0xc0000c9808, 0xc000326800, 0x401d, 0x401d, 0xc5e460, 0x0, 0x0) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:75 +0x48 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Write(0xc000378020, 0xc000326800, 0x401d, 0x401d, 0x401d, 0x0, 0xc000379dc0) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:92 +0x8a crypto/tls.(*Conn).write(0xc000213500, 0xc000326800, 0x401d, 0x401d, 0xc0002f0000, 0x4000, 0x4000) /usr/local/go/src/crypto/tls/conn.go:914 +0x162 crypto/tls.(*Conn).writeRecordLocked(0xc000213500, 0x17, 0xc0002f0000, 0x4000, 0x4000, 0x8000, 0x0, 0xc0000c99b0) /usr/local/go/src/crypto/tls/conn.go:963 +0x2c5 crypto/tls.(*Conn).Write(0xc000213500, 0xc0002ec000, 0x8000, 0x8000, 0x0, 0x0, 0x0) /usr/local/go/src/crypto/tls/conn.go:1130 +0x19a io.copyBuffer(0x7f8d30a6a120, 0xc000213500, 0xc4f4c0, 0xc00033f600, 0xc0002ec000, 0x8000, 0x8000, 0xaf9040, 0xc000178601, 0x7f8d30a6a100) /usr/local/go/src/io/io.go:411 +0x206 io.Copy(...) /usr/local/go/src/io/io.go:368 net/http.persistConnWriter.ReadFrom(0xc0002597a0, 0xc4f4c0, 0xc00033f600, 0x7f8d30a6a100, 0xc0002597a0, 0x1) /usr/local/go/src/net/http/transport.go:1733 +0x85 bufio.(*Writer).ReadFrom(0xc000372540, 0xc4f4c0, 0xc00033f600, 0x7f8d30a6a0e0, 0xc000372540, 0x1) /usr/local/go/src/bufio/bufio.go:730 +0x370 io.copyBuffer(0xc4eb20, 0xc000372540, 0xc4f4c0, 0xc00033f600, 0x0, 0x0, 0x0, 0xc0000c9c48, 0x40ff98, 0x20) /usr/local/go/src/io/io.go:395 +0x2ff io.Copy(...) /usr/local/go/src/io/io.go:368 net/http.(*transferWriter).doBodyCopy(0xc00012f400, 0xc4eb20, 0xc000372540, 0xc4f4c0, 0xc00033f600, 0xc0000c9cc8, 0x747532, 0xc000213500) /usr/local/go/src/net/http/transfer.go:400 +0x6a net/http.(*transferWriter).writeBody(0xc00012f400, 0xc4eb20, 0xc000372540, 0x2, 0x2) /usr/local/go/src/net/http/transfer.go:359 +0x710 net/http.(*Request).write(0xc000084e00, 0xc4eb20, 0xc000372540, 0x0, 0xc00051f320, 0x0, 0x0, 0x0) /usr/local/go/src/net/http/request.go:682 +0x6e5 net/http.(*persistConn).writeLoop(0xc0002597a0) /usr/local/go/src/net/http/transport.go:2343 +0x1c5 created by net/http.(*Transport).dialConn /usr/local/go/src/net/http/transport.go:1709 +0xcdc exit status 2 FAIL github.com/rclone/rclone/backend/qingstor 3600.017s "go test -v -timeout 1h0m0s -remote TestQingStor: -verbose" - Finished ERROR in 1h0m1.454203723s (try 3/5): exit status 1: Failed []