"./vfs.test -test.v -test.timeout 1h0m0s -remote TestCompressDrive: -verbose -test.run '^TestVFSStat$'" - Starting (try 2/5) 2022/01/13 06:18:34 DEBUG : Creating backend with remote "TestCompressDrive:rclone-test-bofotel7fuvakak8rokitis5" 2022/01/13 06:18:34 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/01/13 06:18:35 DEBUG : Creating backend with remote "/tmp/rclone2868864315" === RUN TestVFSStat run.go:181: Remote "Compressed: TestCompressDrive:rclone-test-bofotel7fuvakak8rokitis5", Local "Local file system at /tmp/rclone2868864315", Modify Window "1ms" 2022/01/13 06:18:35 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) 2022/01/13 06:18:35 DEBUG : pacer: Rate limited, increasing sleep to 1.706948947s 2022/01/13 06:18:35 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) 2022/01/13 06:18:35 DEBUG : pacer: Rate limited, increasing sleep to 2.069938545s 2022/01/13 06:18:37 DEBUG : pacer: Reducing sleep to 0s 2022/01/13 06:18:41 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) 2022/01/13 06:18:41 DEBUG : pacer: Rate limited, increasing sleep to 1.188931105s 2022/01/13 06:18:41 DEBUG : WaitForWriters: timeout=30s 2022/01/13 06:18:41 DEBUG : : Looking for writers 2022/01/13 06:18:41 DEBUG : >WaitForWriters: 2022/01/13 06:18:42 DEBUG : pacer: Reducing sleep to 0s run.go:126: removing file "file1" failed - try 1/3: object not found run.go:126: removing file "file1" failed - try 2/3: object not found run.go:126: removing file "file1" failed - try 3/3: object not found run.go:129: removing file "file1" failed: object not found fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:174 run.go:376 vfs_test.go:54 panic.go:1038 panic.go:221 signal_unix.go:735 compress.go:629 compress.go:658 compress.go:687 run.go:277 run.go:294 vfs_test.go:195 Error: Should be true Test: TestVFSStat Messages: listing wrong, want got file1 (14) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:174 run.go:376 vfs_test.go:54 panic.go:1038 panic.go:221 signal_unix.go:735 compress.go:629 compress.go:658 compress.go:687 run.go:277 run.go:294 vfs_test.go:195 Error: Should be true Test: TestVFSStat Messages: Unexpected file "file1" --- FAIL: TestVFSStat (19.88s) 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=0xb9e646] goroutine 41 [running]: testing.tRunner.func1.2({0x16a2000, 0x29deb20}) /usr/local/go/src/testing/testing.go:1209 +0x24e testing.tRunner.func1() /usr/local/go/src/testing/testing.go:1212 +0x218 panic({0x16a2000, 0x29deb20}) /usr/local/go/src/runtime/panic.go:1038 +0x215 github.com/rclone/rclone/backend/compress.(*Fs).putMetadata(0xc0003a0c00, {0x1d20e48, 0xc000138000}, 0x1d20e48, {0x1d3a180, 0xc0000943c0}, {0x0, 0x0, 0x0}, 0xc0009f7af8) /home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:629 +0x226 github.com/rclone/rclone/backend/compress.(*Fs).putWithCustomFunctions(0xc0003a0c00, {0x1d20e48, 0xc000138000}, {0x1ceb220, 0xc000950468}, {0x1d3a180, 0xc0000943c0}, {0x0, 0x0, 0x0}, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:658 +0x166 github.com/rclone/rclone/backend/compress.(*Fs).Put(0xc0003a0c00, {0x1d20e48, 0xc000138000}, {0x1ce65c0, 0xc0003bda40}, {0x1d3a180, 0xc0000943c0}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:687 +0x2bd github.com/rclone/rclone/fstest.(*Run).WriteObjectTo(0xc000268d20, {0x1d20e48, 0xc000138000}, {0x1d513b8, 0xc0003a0c00}, {0x19542dd, 0x5}, {0x19630ec, 0xe}, {0x1dcd64ff, ...}, ...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:277 +0x432 github.com/rclone/rclone/fstest.(*Run).WriteObject(...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:294 github.com/rclone/rclone/vfs.TestVFSStat(0xc000061faf) /home/rclone/go/src/github.com/rclone/rclone/vfs/vfs_test.go:195 +0xcd testing.tRunner(0xc000001a00, 0x1a18760) /usr/local/go/src/testing/testing.go:1259 +0x102 created by testing.(*T).Run /usr/local/go/src/testing/testing.go:1306 +0x35a "./vfs.test -test.v -test.timeout 1h0m0s -remote TestCompressDrive: -verbose -test.run '^TestVFSStat$'" - Finished ERROR in 20.861153129s (try 2/5): exit status 2: Failed [TestVFSStat]