"go test -v -timeout 1h0m0s -remote TestCompressDrive: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:418: Using remote "TestCompressDrive:" 2021/06/01 06:00:34 DEBUG : Creating backend with remote "TestCompressDrive:rclone-test-tovipur6galujiw9qiluzeh1" 2021/06/01 06:00:34 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:483: No commands in this remote === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2021/06/01 06:00:38 DEBUG : dir/subdir: Making directory 2021/06/01 06:00:41 DEBUG : dir/subdir: Removing directory 2021/06/01 06:00:42 DEBUG : dir: Removing directory 2021/06/01 06:00:42 DEBUG : dir: Rmdir: contains trashed file: "subdir" === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty === RUN TestIntegration/FsMkdir/FsListDirNotFound 2021/06/01 06:00:44 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound 2021/06/01 06:00:44 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:669: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2021/06/01 06:00:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Rmdir: contains trashed file: "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.ZAAAAAAAAAA.gz" 2021/06/01 06:00:52 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡: Rmdir: contains trashed file: "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.json" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:669: testing "." 2021/06/01 06:01:01 DEBUG : .: Rmdir: contains trashed file: "..ZAAAAAAAAAA.gz" 2021/06/01 06:01:01 DEBUG : .: Rmdir: contains trashed file: "..json" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:669: testing ".." 2021/06/01 06:01:09 DEBUG : ..: Rmdir: contains trashed file: "...ZAAAAAAAAAA.gz" 2021/06/01 06:01:09 DEBUG : ..: Rmdir: contains trashed file: "...json" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:669: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2021/06/01 06:01:17 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Rmdir: contains trashed file: "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~.ZAAAAAAAAAA.gz" 2021/06/01 06:01:17 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: Rmdir: contains trashed file: "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~.json" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:669: testing " leading space" 2021/06/01 06:01:25 DEBUG : leading space: Rmdir: contains trashed file: " leading space.json" 2021/06/01 06:01:25 DEBUG : leading space: Rmdir: contains trashed file: " leading space.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:669: testing "~leading tilde" 2021/06/01 06:01:33 DEBUG : ~leading tilde: Rmdir: contains trashed file: "~leading tilde.json" 2021/06/01 06:01:33 DEBUG : ~leading tilde: Rmdir: contains trashed file: "~leading tilde.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:669: testing "␍leading CR" 2021/06/01 06:01:41 DEBUG : ␍leading CR: Rmdir: contains trashed file: "␍leading CR.json" 2021/06/01 06:01:41 DEBUG : ␍leading CR: Rmdir: contains trashed file: "␍leading CR.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:669: testing "␊leading LF" 2021/06/01 06:01:49 DEBUG : ␊leading LF: Rmdir: contains trashed file: "␊leading LF.ZAAAAAAAAAA.gz" 2021/06/01 06:01:49 DEBUG : ␊leading LF: Rmdir: contains trashed file: "␊leading LF.json" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:669: testing "␉leading HT" 2021/06/01 06:01:57 DEBUG : ␉leading HT: Rmdir: contains trashed file: "␉leading HT.json" 2021/06/01 06:01:57 DEBUG : ␉leading HT: Rmdir: contains trashed file: "␉leading HT.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:669: testing "␋leading VT" 2021/06/01 06:02:04 DEBUG : ␋leading VT: Rmdir: contains trashed file: "␋leading VT.ZAAAAAAAAAA.gz" 2021/06/01 06:02:04 DEBUG : ␋leading VT: Rmdir: contains trashed file: "␋leading VT.json" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:669: testing ".leading dot" 2021/06/01 06:02:11 DEBUG : .leading dot: Rmdir: contains trashed file: ".leading dot.json" 2021/06/01 06:02:11 DEBUG : .leading dot: Rmdir: contains trashed file: ".leading dot.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:669: testing "trailing space " 2021/06/01 06:02:19 DEBUG : trailing space : Rmdir: contains trashed file: "trailing space .json" 2021/06/01 06:02:19 DEBUG : trailing space : Rmdir: contains trashed file: "trailing space .ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:669: testing "trailing CR␍" 2021/06/01 06:02:28 DEBUG : trailing CR␍: Rmdir: contains trashed file: "trailing CR␍.json" 2021/06/01 06:02:28 DEBUG : trailing CR␍: Rmdir: contains trashed file: "trailing CR␍.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:669: testing "trailing LF␊" 2021/06/01 06:02:35 DEBUG : trailing LF␊: Rmdir: contains trashed file: "trailing LF␊.ZAAAAAAAAAA.gz" 2021/06/01 06:02:35 DEBUG : trailing LF␊: Rmdir: contains trashed file: "trailing LF␊.json" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:669: testing "trailing HT␉" 2021/06/01 06:02:36 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2021/06/01 06:02:36 DEBUG : pacer: Rate limited, increasing sleep to 1.120091145s 2021/06/01 06:02:37 DEBUG : pacer: Reducing sleep to 0s 2021/06/01 06:02:44 DEBUG : trailing HT␉: Rmdir: contains trashed file: "trailing HT␉.ZAAAAAAAAAA.gz" 2021/06/01 06:02:44 DEBUG : trailing HT␉: Rmdir: contains trashed file: "trailing HT␉.json" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:669: testing "trailing VT␋" 2021/06/01 06:02:52 DEBUG : trailing VT␋: Rmdir: contains trashed file: "trailing VT␋.json" 2021/06/01 06:02:52 DEBUG : trailing VT␋: Rmdir: contains trashed file: "trailing VT␋.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:669: testing "trailing dot." 2021/06/01 06:03:00 DEBUG : trailing dot.: Rmdir: contains trashed file: "trailing dot..json" 2021/06/01 06:03:00 DEBUG : trailing dot.: Rmdir: contains trashed file: "trailing dot..ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:669: testing "invalid utf-8\xfe" 2021/06/01 06:03:06 DEBUG : pacer: low level retry 1/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2021/06/01 06:03:06 DEBUG : pacer: Rate limited, increasing sleep to 1.973136059s 2021/06/01 06:03:07 DEBUG : pacer: low level retry 2/10 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2021/06/01 06:03:07 DEBUG : pacer: Rate limited, increasing sleep to 2.315190485s 2021/06/01 06:03:09 DEBUG : pacer: Reducing sleep to 0s 2021/06/01 06:03:12 DEBUG : invalid utf-8: Rmdir: contains trashed file: "invalid utf-8\xfe.json" 2021/06/01 06:03:12 DEBUG : invalid utf-8: Rmdir: contains trashed file: "invalid utf-8\xfe.ZAAAAAAAAAA.gz" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength 2021/06/01 06:03:20 DEBUG : pacer: low level retry 1/1 (error googleapi: Error 403: User Rate Limit Exceeded. Rate of requests for user exceed configured project quota. You may consider re-evaluating expected per-user traffic to the API and adjust project quota limits accordingly. You may monitor aggregate quota usage and adjust limits in the API Console: https://console.developers.google.com/apis/api/drive.googleapis.com/quotas?project=847840889997, userRateLimitExceeded) 2021/06/01 06:03:20 DEBUG : pacer: Rate limited, increasing sleep to 1.84057879s --- FAIL: TestIntegration (165.54s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.25s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.79s) --- FAIL: TestIntegration/FsMkdir (162.41s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (4.95s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.23s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.22s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.18s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.22s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.21s) --- PASS: TestIntegration/FsMkdir/FsEncoding (148.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (8.67s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (8.48s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (8.58s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (7.10s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (7.88s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (8.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (8.30s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (7.67s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (7.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (7.40s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (7.38s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (8.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (8.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (7.86s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (8.78s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (7.91s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (8.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (11.56s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutError (5.12s) --- FAIL: TestIntegration/FsMkdir/FsPutZeroLength (1.63s) panic: runtime error: invalid memory address or nil pointer dereference [recovered] panic: runtime error: invalid memory address or nil pointer dereference [signal SIGSEGV: segmentation violation code=0x1 addr=0x40 pc=0xf03a2f] goroutine 990 [running]: testing.tRunner.func1.1(0x1025f80, 0x19b5d50) /usr/local/go/src/testing/testing.go:1072 +0x30d testing.tRunner.func1(0xc00062e480) /usr/local/go/src/testing/testing.go:1075 +0x41a panic(0x1025f80, 0x19b5d50) /usr/local/go/src/runtime/panic.go:969 +0x1b9 github.com/rclone/rclone/backend/compress.(*Fs).putMetadata(0xc000572500, 0x1383a00, 0xc0000a8010, 0xc00053ede0, 0x138d080, 0xc00038e2d0, 0x0, 0x0, 0x0, 0xc000151bd8, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:629 +0x24f github.com/rclone/rclone/backend/compress.(*Fs).putWithCustomFunctions(0xc000572500, 0x1383a00, 0xc0000a8010, 0x136d3e0, 0xc00064ad40, 0x138d080, 0xc00038e2d0, 0x0, 0x0, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:658 +0x19f github.com/rclone/rclone/backend/compress.(*Fs).Put(0xc000572500, 0x1383a00, 0xc0000a8010, 0x136d420, 0xc00064aba0, 0x138d080, 0xc00038e2d0, 0x0, 0x0, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:687 +0x38d github.com/rclone/rclone/fstest/fstests.TestPutLarge.func1(0x6, 0x0) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:238 +0x262 github.com/rclone/rclone/fstest/fstests.retry(0xc00062e480, 0x1195ccd, 0x8, 0xc000151e70) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:145 +0x10c github.com/rclone/rclone/fstest/fstests.TestPutLarge(0x1383a00, 0xc0000a8010, 0xc00062e480, 0x1390320, 0xc000572500, 0xc000151f38) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:232 +0x13a github.com/rclone/rclone/fstest/fstests.Run.func13.10(0xc00062e480) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:731 +0x172 testing.tRunner(0xc00062e480, 0xc000694600) /usr/local/go/src/testing/testing.go:1123 +0xef created by testing.(*T).Run /usr/local/go/src/testing/testing.go:1168 +0x2b3 exit status 2 FAIL github.com/rclone/rclone/backend/compress 165.575s "go test -v -timeout 1h0m0s -remote TestCompressDrive: -verbose" - Finished ERROR in 2m48.172009063s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutZeroLength]