"./operations.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Starting (try 1/5)
2022/03/24 06:10:36 DEBUG : Creating backend with remote "TestPcloud:rclone-test-linotez4xerocig8fimakac6"
2022/03/24 06:10:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/03/24 06:10:36 DEBUG : Creating backend with remote "/tmp/rclone4086150468"
=== RUN   TestDoMultiThreadCopy
--- PASS: TestDoMultiThreadCopy (0.00s)
=== RUN   TestMultithreadCalculateChunks
=== RUN   TestMultithreadCalculateChunks/{size:1_streams:10_wantPartSize:65536_wantStreams:1}
=== RUN   TestMultithreadCalculateChunks/{size:1048576_streams:1_wantPartSize:1048576_wantStreams:1}
=== RUN   TestMultithreadCalculateChunks/{size:1048576_streams:2_wantPartSize:524288_wantStreams:2}
=== RUN   TestMultithreadCalculateChunks/{size:1048577_streams:2_wantPartSize:589824_wantStreams:2}
=== RUN   TestMultithreadCalculateChunks/{size:1048575_streams:2_wantPartSize:524288_wantStreams:2}
--- PASS: TestMultithreadCalculateChunks (0.00s)
    --- PASS: TestMultithreadCalculateChunks/{size:1_streams:10_wantPartSize:65536_wantStreams:1} (0.00s)
    --- PASS: TestMultithreadCalculateChunks/{size:1048576_streams:1_wantPartSize:1048576_wantStreams:1} (0.00s)
    --- PASS: TestMultithreadCalculateChunks/{size:1048576_streams:2_wantPartSize:524288_wantStreams:2} (0.00s)
    --- PASS: TestMultithreadCalculateChunks/{size:1048577_streams:2_wantPartSize:589824_wantStreams:2} (0.00s)
    --- PASS: TestMultithreadCalculateChunks/{size:1048575_streams:2_wantPartSize:524288_wantStreams:2} (0.00s)
=== RUN   TestMultithreadCopy
    run.go:181: Remote "pcloud root 'rclone-test-linotez4xerocig8fimakac6'", Local "Local file system at /tmp/rclone4086150468", Modify Window "1s"
=== RUN   TestMultithreadCopy/{size:131071_streams:2}
2022/03/24 06:10:38 DEBUG : file1: Starting multi-thread copy with 2 parts of size 64Ki
2022/03/24 06:10:38 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131071) size 63.999Ki starting
2022/03/24 06:10:38 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64Ki starting
2022/03/24 06:10:38 DEBUG : Couldn't parse Date: from server evc210.pcloud.com: "Thu, 24 Mar 2022 06:10:38 +0000": parsing time "Thu, 24 Mar 2022 06:10:38 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Mar 2022 06:10:38 +0000" as " "
2022/03/24 06:10:38 DEBUG : Couldn't parse Date: from server evc210.pcloud.com: "Thu, 24 Mar 2022 06:10:38 +0000": parsing time "Thu, 24 Mar 2022 06:10:38 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Mar 2022 06:10:38 +0000" as " "
2022/03/24 06:10:38 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64Ki finished
2022/03/24 06:10:38 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131071) size 63.999Ki finished
2022/03/24 06:10:38 DEBUG : file1: Finished multi-thread copy with 2 parts of size 64Ki
=== RUN   TestMultithreadCopy/{size:131072_streams:2}
2022/03/24 06:10:39 DEBUG : file1: Starting multi-thread copy with 2 parts of size 64Ki
2022/03/24 06:10:39 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131072) size 64Ki starting
2022/03/24 06:10:39 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64Ki starting
2022/03/24 06:10:39 DEBUG : Couldn't parse Date: from server evc250.pcloud.com: "Thu, 24 Mar 2022 06:10:39 +0000": parsing time "Thu, 24 Mar 2022 06:10:39 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Mar 2022 06:10:39 +0000" as " "
2022/03/24 06:10:39 DEBUG : Couldn't parse Date: from server evc250.pcloud.com: "Thu, 24 Mar 2022 06:10:39 +0000": parsing time "Thu, 24 Mar 2022 06:10:39 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Mar 2022 06:10:39 +0000" as " "
2022/03/24 06:10:40 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131072) size 64Ki finished
2022/03/24 06:10:40 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64Ki finished
2022/03/24 06:10:40 DEBUG : file1: Finished multi-thread copy with 2 parts of size 64Ki
=== RUN   TestMultithreadCopy/{size:131073_streams:2}
2022/03/24 06:10:40 DEBUG : file1: Starting multi-thread copy with 2 parts of size 128Ki
2022/03/24 06:10:40 DEBUG : file1: multi-thread copy: stream 2/2 (131072-131073) size 1 starting
2022/03/24 06:10:40 DEBUG : file1: multi-thread copy: stream 1/2 (0-131072) size 128Ki starting
2022/03/24 06:10:41 DEBUG : Couldn't parse Date: from server evc197.pcloud.com: "Thu, 24 Mar 2022 06:10:41 +0000": parsing time "Thu, 24 Mar 2022 06:10:41 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Mar 2022 06:10:41 +0000" as " "
2022/03/24 06:10:41 DEBUG : file1: multi-thread copy: stream 2/2 (131072-131073) size 1 finished
2022/03/24 06:10:41 DEBUG : Couldn't parse Date: from server evc197.pcloud.com: "Thu, 24 Mar 2022 06:10:41 +0000": parsing time "Thu, 24 Mar 2022 06:10:41 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Mar 2022 06:10:41 +0000" as " "
2022/03/24 06:10:41 DEBUG : file1: multi-thread copy: stream 1/2 (0-131072) size 128Ki finished
2022/03/24 06:10:41 DEBUG : file1: Finished multi-thread copy with 2 parts of size 128Ki
--- PASS: TestMultithreadCopy (5.12s)
    --- PASS: TestMultithreadCopy/{size:131071_streams:2} (1.82s)
    --- PASS: TestMultithreadCopy/{size:131072_streams:2} (1.41s)
    --- PASS: TestMultithreadCopy/{size:131073_streams:2} (1.39s)
=== RUN   TestSizeDiffers
--- PASS: TestSizeDiffers (0.00s)
=== RUN   TestReOpen
=== RUN   TestReOpen/Seek
=== RUN   TestReOpen/Seek/Basics
=== RUN   TestReOpen/Seek/ErrorAtStart
=== RUN   TestReOpen/Seek/WithErrors
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/Seek/TooManyErrors
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error
2022/03/24 06:10:41 DEBUG : potato: Reopen failed after 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/Range
=== RUN   TestReOpen/Range/Basics
=== RUN   TestReOpen/Range/ErrorAtStart
=== RUN   TestReOpen/Range/WithErrors
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/Range/TooManyErrors
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error
2022/03/24 06:10:41 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error
2022/03/24 06:10:41 DEBUG : potato: Reopen failed after 6 bytes read: failed to reopen: too many retries
--- PASS: TestReOpen (0.00s)
    --- PASS: TestReOpen/Seek (0.00s)
        --- PASS: TestReOpen/Seek/Basics (0.00s)
        --- PASS: TestReOpen/Seek/ErrorAtStart (0.00s)
        --- PASS: TestReOpen/Seek/WithErrors (0.00s)
        --- PASS: TestReOpen/Seek/TooManyErrors (0.00s)
    --- PASS: TestReOpen/Range (0.00s)
        --- PASS: TestReOpen/Range/Basics (0.00s)
        --- PASS: TestReOpen/Range/ErrorAtStart (0.00s)
        --- PASS: TestReOpen/Range/WithErrors (0.00s)
        --- PASS: TestReOpen/Range/TooManyErrors (0.00s)
=== RUN   TestCheck
    run.go:181: Remote "pcloud root 'rclone-test-linotez4xerocig8fimakac6'", Local "Local file system at /tmp/rclone4086150468", Modify Window "1s"
=== RUN   TestCheck/1
=== RUN   TestCheck/2
=== RUN   TestCheck/3
=== RUN   TestCheck/4
=== RUN   TestCheck/5
=== RUN   TestCheck/6
=== RUN   TestCheck/7
--- PASS: TestCheck (6.49s)
    --- PASS: TestCheck/1 (0.34s)
    --- PASS: TestCheck/2 (0.33s)
    --- PASS: TestCheck/3 (0.33s)
    --- PASS: TestCheck/4 (0.35s)
    --- PASS: TestCheck/5 (0.34s)
    --- PASS: TestCheck/6 (0.35s)
    --- PASS: TestCheck/7 (0.40s)
=== RUN   TestCheckFsError
2022/03/24 06:10:48 DEBUG : Creating backend with remote "non-existent"
2022/03/24 06:10:48 DEBUG : Creating backend with remote "non-existent"
2022/03/24 06:10:48 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: Waiting for checks to finish
2022/03/24 06:10:48 ERROR : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: error reading source root directory: directory not found
2022/03/24 06:10:48 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: 2 differences found
2022/03/24 06:10:48 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: 2 errors while checking
--- PASS: TestCheckFsError (0.00s)
=== RUN   TestCheckDownload
    run.go:181: Remote "pcloud root 'rclone-test-linotez4xerocig8fimakac6'", Local "Local file system at /tmp/rclone4086150468", Modify Window "1s"
=== RUN   TestCheckDownload/1
=== RUN   TestCheckDownload/2
=== RUN   TestCheckDownload/3
=== RUN   TestCheckDownload/4
=== RUN   TestCheckDownload/5
=== RUN   TestCheckDownload/6
=== RUN   TestCheckDownload/7
--- PASS: TestCheckDownload (7.79s)
    --- PASS: TestCheckDownload/1 (0.60s)
    --- PASS: TestCheckDownload/2 (0.57s)
    --- PASS: TestCheckDownload/3 (0.49s)
    --- PASS: TestCheckDownload/4 (0.57s)
    --- PASS: TestCheckDownload/5 (0.51s)
    --- PASS: TestCheckDownload/6 (0.50s)
    --- PASS: TestCheckDownload/7 (0.50s)
=== RUN   TestCheckSizeOnly
    run.go:181: Remote "pcloud root 'rclone-test-linotez4xerocig8fimakac6'", Local "Local file system at /tmp/rclone4086150468", Modify Window "1s"
=== RUN   TestCheckSizeOnly/1
=== RUN   TestCheckSizeOnly/2
=== RUN   TestCheckSizeOnly/3
=== RUN   TestCheckSizeOnly/4
=== RUN   TestCheckSizeOnly/5
=== RUN   TestCheckSizeOnly/6
=== RUN   TestCheckSizeOnly/7
--- PASS: TestCheckSizeOnly (5.21s)
    --- PASS: TestCheckSizeOnly/1 (0.16s)
    --- PASS: TestCheckSizeOnly/2 (0.17s)
    --- PASS: TestCheckSizeOnly/3 (0.17s)
    --- PASS: TestCheckSizeOnly/4 (0.17s)
    --- PASS: TestCheckSizeOnly/5 (0.17s)
    --- PASS: TestCheckSizeOnly/6 (0.17s)
    --- PASS: TestCheckSizeOnly/7 (0.16s)
=== RUN   TestCheckEqualReaders
--- PASS: TestCheckEqualReaders (0.00s)
=== RUN   TestParseSumFile
    run.go:181: Remote "pcloud root 'rclone-test-linotez4xerocig8fimakac6'", Local "Local file system at /tmp/rclone4086150468", Modify Window "1s"
    check_test.go:314: 
        	Error Trace:	check_test.go:314
        	Error:      	Received unexpected error:
        	            	object not found
        	Test:       	TestParseSumFile
--- FAIL: TestParseSumFile (0.84s)
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=0x30 pc=0x93cf89]

goroutine 2005 [running]:
testing.tRunner.func1.2({0x1632820, 0x28d81b0})
	/usr/local/go/src/testing/testing.go:1209 +0x24e
testing.tRunner.func1()
	/usr/local/go/src/testing/testing.go:1212 +0x218
panic({0x1632820, 0x28d81b0})
	/usr/local/go/src/runtime/panic.go:1038 +0x215
github.com/rclone/rclone/fs/operations.ParseSumFile({0x1c8cb30, 0xc000138000}, {0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/check.go:539 +0x49
github.com/rclone/rclone/fs/operations_test.TestParseSumFile(0xc00062bc00)
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:315 +0x2e9
testing.tRunner(0xc0008fa4e0, 0x19897c8)
	/usr/local/go/src/testing/testing.go:1259 +0x102
created by testing.(*T).Run
	/usr/local/go/src/testing/testing.go:1306 +0x35a
"./operations.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Finished ERROR in 26.18145873s (try 1/5): exit status 2: Failed [TestParseSumFile]