"./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCheckSumDownload$'" - Starting (try 4/5) 2025/09/13 02:46:41 DEBUG : Creating backend with remote "TestPikPak:rclone-test-gitatuw9cono" 2025/09/13 02:46:41 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/13 02:46:43 DEBUG : Creating backend with remote "/tmp/rclone1334787072" === RUN TestCheckSumDownload run.go:180: Remote "PikPak root 'rclone-test-gitatuw9cono'", Local "Local file system at /tmp/rclone1334787072", Modify Window "876000h0m0s" 2025/09/13 02:46:43 DEBUG : Creating backend with remote "TestPikPak:rclone-test-gitatuw9cono/data" 2025/09/13 02:46:45 DEBUG : data/banana: calculating gcid: failed to unwrap object from src: data/banana 2025/09/13 02:46:45 DEBUG : data/banana: gcid = 5a20dd2421f633d21da85b8911f9f37677f212d5 2025/09/13 02:46:47 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2025/09/13 02:46:47 DEBUG : test.sum: gcid = a5968cd7981dde739b5ed764a5ed354ef42c42b2 === RUN TestCheckSumDownload/subtest1 2025/09/13 02:47:33 DEBUG : pacer: Reducing sleep to 843.75ms 2025/09/13 02:47:33 DEBUG : data/potato: calculating gcid: failed to unwrap object from src: data/potato 2025/09/13 02:47:33 DEBUG : data/potato: gcid = 7a3c15f717358c93392def5ff0639db84c0d363b 2025/09/13 02:47:35 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/09/13 02:47:36 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/09/13 02:47:36 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2025/09/13 02:47:36 DEBUG : test.sum: gcid = a5968cd7981dde739b5ed764a5ed354ef42c42b2 2025/09/13 02:47:39 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/09/13 02:47:39 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/09/13 02:47:40 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/09/13 02:47:40 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/09/13 02:47:41 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/09/13 02:47:41 DEBUG : pacer: Reducing sleep to 100ms === RUN TestCheckSumDownload/subtest2 2025/09/13 02:48:37 DEBUG : pacer: Reducing sleep to 100ms 2025/09/13 02:48:37 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2025/09/13 02:48:37 DEBUG : test.sum: gcid = f3a0ff69df1baee079fa197e53142fe40231e82b === RUN TestCheckSumDownload/subtest3 === NAME TestCheckSumDownload check_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:409 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: 0 actual : 2 Test: TestCheckSumDownload Messages: wrong error count in run 3 check_test.go:413: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:413 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: "2025/09/13 02:50:19 ERROR : banana: Failed to calculate hash: can't download: no link\n2025/09/13 02:50:21 ERROR : potato: Failed to calculate hash: can't download: no link\n2025/09/13 02:50:21 NOTICE: PikPak root 'rclone-test-gitatuw9cono/data': 0 differences found\n2025/09/13 02:50:21 NOTICE: PikPak root 'rclone-test-gitatuw9cono/data': 2 errors while checking\n" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 3 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:417 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "= banana", "= potato"} actual : []string{"", "! banana", "! potato"} Diff: --- Expected +++ Actual @@ -2,4 +2,4 @@ (string) "", - (string) (len=8) "= banana", - (string) (len=8) "= potato" + (string) (len=8) "! banana", + (string) (len=8) "! potato" } Test: TestCheckSumDownload Messages: wrong combined result in run 3 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "banana", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=6) "banana", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 3 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{} actual : []string{"", "banana", "potato"} Diff: --- Expected +++ Actual @@ -1,2 +1,5 @@ -([]string) { +([]string) (len=3) { + (string) "", + (string) (len=6) "banana", + (string) (len=6) "potato" } Test: TestCheckSumDownload Messages: wrong error result in run 3 2025/09/13 02:50:22 DEBUG : Saving config "captcha_token" in section "TestPikPak" of the config file 2025/09/13 02:50:23 DEBUG : pacer: Reducing sleep to 843.75ms 2025/09/13 02:50:23 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2025/09/13 02:50:23 DEBUG : test.sum: gcid = 4432a75a15f9e866fc8b0361de0580e4ab920bea 2025/09/13 02:50:24 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/09/13 02:50:25 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/09/13 02:50:26 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/09/13 02:50:26 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/09/13 02:50:26 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/09/13 02:50:27 DEBUG : pacer: Reducing sleep to 150.169371ms === RUN TestCheckSumDownload/subtest4 === NAME TestCheckSumDownload check_test.go:407: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:407 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: An error is expected but got nil. Test: TestCheckSumDownload Messages: no expected error in run 4 check_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:409 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: 1 actual : 2 Test: TestCheckSumDownload Messages: wrong error count in run 4 check_test.go:413: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:413 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: "2025/09/13 02:52:26 ERROR : banana: Failed to calculate hash: can't download: no link\n2025/09/13 02:52:29 ERROR : potato: Failed to calculate hash: can't download: no link\n2025/09/13 02:52:29 NOTICE: PikPak root 'rclone-test-gitatuw9cono/data': 0 differences found\n2025/09/13 02:52:29 NOTICE: PikPak root 'rclone-test-gitatuw9cono/data': 2 errors while checking\n" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 4 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:417 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "* banana", "= potato"} actual : []string{"", "! banana", "! potato"} Diff: --- Expected +++ Actual @@ -2,4 +2,4 @@ (string) "", - (string) (len=8) "* banana", - (string) (len=8) "= potato" + (string) (len=8) "! banana", + (string) (len=8) "! potato" } Test: TestCheckSumDownload Messages: wrong combined result in run 4 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 4 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:421 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong differ result in run 4 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{} actual : []string{"", "banana", "potato"} Diff: --- Expected +++ Actual @@ -1,2 +1,5 @@ -([]string) { +([]string) (len=3) { + (string) "", + (string) (len=6) "banana", + (string) (len=6) "potato" } Test: TestCheckSumDownload Messages: wrong error result in run 4 2025/09/13 02:52:30 DEBUG : pacer: Reducing sleep to 843.75ms 2025/09/13 02:52:30 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2025/09/13 02:52:30 DEBUG : test.sum: gcid = c2c6d29ce2f4e1f6e3e830802ef4a15c32af89c4 2025/09/13 02:52:32 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/09/13 02:52:32 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/09/13 02:52:33 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/09/13 02:52:33 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/09/13 02:52:34 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/09/13 02:52:34 DEBUG : pacer: Reducing sleep to 150.169371ms === RUN TestCheckSumDownload/subtest5 === NAME TestCheckSumDownload check_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:409 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: 1 actual : 2 Test: TestCheckSumDownload Messages: wrong error count in run 5 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:417 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "+ orange", "= banana", "= potato"} actual : []string{"", "! potato", "+ orange", "= banana"} Diff: --- Expected +++ Actual @@ -2,5 +2,5 @@ (string) "", + (string) (len=8) "! potato", (string) (len=8) "+ orange", - (string) (len=8) "= banana", - (string) (len=8) "= potato" + (string) (len=8) "= banana" } Test: TestCheckSumDownload Messages: wrong combined result in run 5 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "banana", "potato"} actual : []string{"", "banana"} Diff: --- Expected +++ Actual @@ -1,5 +1,4 @@ -([]string) (len=3) { +([]string) (len=2) { (string) "", - (string) (len=6) "banana", - (string) (len=6) "potato" + (string) (len=6) "banana" } Test: TestCheckSumDownload Messages: wrong match result in run 5 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{} actual : []string{"", "potato"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) "", + (string) (len=6) "potato" } Test: TestCheckSumDownload Messages: wrong error result in run 5 2025/09/13 02:54:43 DEBUG : pacer: Reducing sleep to 843.75ms 2025/09/13 02:54:43 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2025/09/13 02:54:43 DEBUG : test.sum: gcid = 903d92580da389428c3eace6c6dce692463e75e8 2025/09/13 02:54:44 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/09/13 02:54:44 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/09/13 02:54:45 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/09/13 02:54:46 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/09/13 02:54:46 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/09/13 02:54:46 DEBUG : pacer: Reducing sleep to 150.169371ms === RUN TestCheckSumDownload/subtest6 2025/09/13 02:55:49 DEBUG : Saving config "captcha_token" in section "TestPikPak" of the config file 2025/09/13 02:55:49 DEBUG : Config file has changed externally - reloading 2025/09/13 02:55:49 DEBUG : pacer: Reducing sleep to 100ms 2025/09/13 02:55:49 DEBUG : data/banana: calculating gcid: failed to unwrap object from src: data/banana 2025/09/13 02:55:49 DEBUG : data/banana: gcid = 5a20dd2421f633d21da85b8911f9f37677f212d5 2025/09/13 02:55:51 DEBUG : data/potato: calculating gcid: failed to unwrap object from src: data/potato 2025/09/13 02:55:51 DEBUG : data/potato: gcid = 7a3c15f717358c93392def5ff0639db84c0d363b 2025/09/13 02:55:54 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2025/09/13 02:55:54 DEBUG : test.sum: gcid = 551b7ddca65803810ea668343a66646180a0c0b7 === RUN TestCheckSumDownload/subtest7 === NAME TestCheckSumDownload check_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:409 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: 0 actual : 1 Test: TestCheckSumDownload Messages: wrong error count in run 7 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:417 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "= banana", "= potato"} actual : []string{"", "! banana", "= potato"} Diff: --- Expected +++ Actual @@ -2,3 +2,3 @@ (string) "", - (string) (len=8) "= banana", + (string) (len=8) "! banana", (string) (len=8) "= potato" Test: TestCheckSumDownload Messages: wrong combined result in run 7 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{"", "banana", "potato"} actual : []string{"", "potato"} Diff: --- Expected +++ Actual @@ -1,4 +1,3 @@ -([]string) (len=3) { +([]string) (len=2) { (string) "", - (string) (len=6) "banana", (string) (len=6) "potato" Test: TestCheckSumDownload Messages: wrong match result in run 7 check_test.go:384: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:384 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:428 Error: Not equal: expected: []string{} actual : []string{"", "banana"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) "", + (string) (len=6) "banana" } Test: TestCheckSumDownload Messages: wrong error result in run 7 2025/09/13 02:57:54 DEBUG : pacer: Reducing sleep to 843.75ms 2025/09/13 02:57:55 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/09/13 02:57:55 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/09/13 02:57:56 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/09/13 02:57:57 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/09/13 02:57:57 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/09/13 02:57:58 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/09/13 02:57:58 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/09/13 02:57:59 DEBUG : pacer: Reducing sleep to 100ms 2025/09/13 02:57:59 DEBUG : data: Rmdir: contains trashed file: "potato" 2025/09/13 02:57:59 DEBUG : data: Rmdir: contains trashed file: "banana" 2025/09/13 02:57:59 DEBUG : data: Rmdir: contains trashed file: "potato" 2025/09/13 02:57:59 DEBUG : data: Rmdir: contains trashed file: "banana" --- FAIL: TestCheckSumDownload (677.37s) --- PASS: TestCheckSumDownload/subtest1 (43.87s) --- PASS: TestCheckSumDownload/subtest2 (55.82s) --- PASS: TestCheckSumDownload/subtest3 (101.42s) --- PASS: TestCheckSumDownload/subtest4 (122.38s) --- PASS: TestCheckSumDownload/subtest5 (127.88s) --- PASS: TestCheckSumDownload/subtest6 (61.33s) --- PASS: TestCheckSumDownload/subtest7 (113.47s) FAIL 2025/09/13 02:58:00 DEBUG : PikPak root 'rclone-test-gitatuw9cono': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCheckSumDownload$'" - Finished ERROR in 11m19.827198191s (try 4/5): exit status 1: Failed [TestCheckSumDownload]