"./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCheckDownload$/^(4|5|6|7)$|^TestCheckSumDownload$|^TestHashSums$/^Md5Download$'" - Starting (try 2/5) 2024/04/25 02:48:20 DEBUG : Creating backend with remote "TestPikPak:rclone-test-sibupuw5kuxedah2modayiv7" 2024/04/25 02:48:20 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/04/25 02:48:22 DEBUG : Creating backend with remote "/tmp/rclone1704739584" === RUN TestCheckDownload run.go:180: Remote "PikPak root 'rclone-test-sibupuw5kuxedah2modayiv7'", Local "Local file system at /tmp/rclone1704739584", Modify Window "876000h0m0s" === RUN TestCheckDownload/4 check_test.go:89: 4: Expecting 1 errors but got 2 === NAME TestCheckDownload check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:57 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "- empty space", "= potato2", "= rutabaga"} actual : []string{"", "* potato2", "- empty space", "= rutabaga"} Diff: --- Expected +++ Actual @@ -2,4 +2,4 @@ (string) "", + (string) (len=9) "* potato2", (string) (len=13) "- empty space", - (string) (len=9) "= potato2", (string) (len=10) "= rutabaga" Test: TestCheckDownload Messages: combined check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:60 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "potato2", "rutabaga"} actual : []string{"", "rutabaga"} Diff: --- Expected +++ Actual @@ -1,4 +1,3 @@ -([]string) (len=3) { +([]string) (len=2) { (string) "", - (string) (len=7) "potato2", (string) (len=8) "rutabaga" Test: TestCheckDownload Messages: match check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:61 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{} actual : []string{"", "potato2"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) "", + (string) (len=7) "potato2" } Test: TestCheckDownload Messages: differ === RUN TestCheckDownload/5 check_test.go:89: 5: Expecting 1 errors but got 2 === NAME TestCheckDownload check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:57 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "* empty space", "= potato2", "= rutabaga"} actual : []string{"", "* empty space", "* potato2", "= rutabaga"} Diff: --- Expected +++ Actual @@ -3,3 +3,3 @@ (string) (len=13) "* empty space", - (string) (len=9) "= potato2", + (string) (len=9) "* potato2", (string) (len=10) "= rutabaga" Test: TestCheckDownload Messages: combined check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:60 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "potato2", "rutabaga"} actual : []string{"", "rutabaga"} Diff: --- Expected +++ Actual @@ -1,4 +1,3 @@ -([]string) (len=3) { +([]string) (len=2) { (string) "", - (string) (len=7) "potato2", (string) (len=8) "rutabaga" Test: TestCheckDownload Messages: match check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:61 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "empty space"} actual : []string{"", "empty space", "potato2"} Diff: --- Expected +++ Actual @@ -1,4 +1,5 @@ -([]string) (len=2) { +([]string) (len=3) { (string) "", - (string) (len=11) "empty space" + (string) (len=11) "empty space", + (string) (len=7) "potato2" } Test: TestCheckDownload Messages: differ === RUN TestCheckDownload/6 check_test.go:89: 6: Expecting 2 errors but got 3 === NAME TestCheckDownload check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:57 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "* empty space", "- remotepotato", "= potato2", "= rutabaga"} actual : []string{"", "* empty space", "* potato2", "- remotepotato", "= rutabaga"} Diff: --- Expected +++ Actual @@ -3,4 +3,4 @@ (string) (len=13) "* empty space", + (string) (len=9) "* potato2", (string) (len=14) "- remotepotato", - (string) (len=9) "= potato2", (string) (len=10) "= rutabaga" Test: TestCheckDownload Messages: combined check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:60 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "potato2", "rutabaga"} actual : []string{"", "rutabaga"} Diff: --- Expected +++ Actual @@ -1,4 +1,3 @@ -([]string) (len=3) { +([]string) (len=2) { (string) "", - (string) (len=7) "potato2", (string) (len=8) "rutabaga" Test: TestCheckDownload Messages: match check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:61 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "empty space"} actual : []string{"", "empty space", "potato2"} Diff: --- Expected +++ Actual @@ -1,4 +1,5 @@ -([]string) (len=2) { +([]string) (len=3) { (string) "", - (string) (len=11) "empty space" + (string) (len=11) "empty space", + (string) (len=7) "potato2" } Test: TestCheckDownload Messages: differ === RUN TestCheckDownload/7 check_test.go:89: 7: Expecting 1 errors but got 2 === NAME TestCheckDownload check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:57 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "* empty space", "= potato2", "= rutabaga"} actual : []string{"", "* empty space", "* potato2", "= rutabaga"} Diff: --- Expected +++ Actual @@ -3,3 +3,3 @@ (string) (len=13) "* empty space", - (string) (len=9) "= potato2", + (string) (len=9) "* potato2", (string) (len=10) "= rutabaga" Test: TestCheckDownload Messages: combined check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:60 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "potato2", "rutabaga"} actual : []string{"", "rutabaga"} Diff: --- Expected +++ Actual @@ -1,4 +1,3 @@ -([]string) (len=3) { +([]string) (len=2) { (string) "", - (string) (len=7) "potato2", (string) (len=8) "rutabaga" Test: TestCheckDownload Messages: match check_test.go:53: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:53 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:61 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:97 Error: Not equal: expected: []string{"", "empty space"} actual : []string{"", "empty space", "potato2"} Diff: --- Expected +++ Actual @@ -1,4 +1,5 @@ -([]string) (len=2) { +([]string) (len=3) { (string) "", - (string) (len=11) "empty space" + (string) (len=11) "empty space", + (string) (len=7) "potato2" } Test: TestCheckDownload Messages: differ --- FAIL: TestCheckDownload (18.74s) --- FAIL: TestCheckDownload/4 (2.70s) --- FAIL: TestCheckDownload/5 (3.22s) --- FAIL: TestCheckDownload/6 (2.03s) --- FAIL: TestCheckDownload/7 (2.10s) === RUN TestCheckSumDownload run.go:180: Remote "PikPak root 'rclone-test-sibupuw5kuxedah2modayiv7'", Local "Local file system at /tmp/rclone1704739584", Modify Window "876000h0m0s" 2024/04/25 02:48:40 DEBUG : Creating backend with remote "TestPikPak:rclone-test-sibupuw5kuxedah2modayiv7/data" === RUN TestCheckSumDownload/subtest1 === RUN TestCheckSumDownload/subtest2 2024/04/25 02:48:58 DEBUG : pacer: low level retry 1/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:48:58 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/04/25 02:48:58 DEBUG : pacer: low level retry 2/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:48:58 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2024/04/25 02:48:58 DEBUG : pacer: low level retry 3/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:48:58 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2024/04/25 02:48:58 DEBUG : pacer: low level retry 4/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:48:58 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2024/04/25 02:48:59 DEBUG : pacer: low level retry 5/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:48:59 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2024/04/25 02:48:59 DEBUG : pacer: low level retry 6/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:48:59 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2024/04/25 02:48:59 DEBUG : pacer: low level retry 7/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:48:59 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2024/04/25 02:49:00 DEBUG : pacer: low level retry 8/10 (error not PHASE_TYPE_COMPLETE) 2024/04/25 02:49:00 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/04/25 02:49:01 DEBUG : pacer: Reducing sleep to 1.5s 2024/04/25 02:49:03 DEBUG : pacer: Reducing sleep to 1.125s 2024/04/25 02:49:05 DEBUG : pacer: Reducing sleep to 843.75ms 2024/04/25 02:49:06 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/04/25 02:49:06 DEBUG : pacer: Reducing sleep to 474.609375ms === RUN TestCheckSumDownload/subtest3 2024/04/25 02:49:12 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/04/25 02:49:13 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/04/25 02:49:13 DEBUG : pacer: Reducing sleep to 84.470271ms 2024/04/25 02:49:14 DEBUG : pacer: Reducing sleep to 63.352703ms 2024/04/25 02:49:14 DEBUG : pacer: Reducing sleep to 47.514527ms 2024/04/25 02:49:14 DEBUG : pacer: Reducing sleep to 35.635895ms 2024/04/25 02:49:14 DEBUG : pacer: Reducing sleep to 26.726921ms 2024/04/25 02:49:15 DEBUG : pacer: Reducing sleep to 20.04519ms === RUN TestCheckSumDownload/subtest4 === RUN TestCheckSumDownload/subtest5 === RUN TestCheckSumDownload/subtest6 === RUN TestCheckSumDownload/subtest7 2024/04/25 02:49:42 DEBUG : data: Rmdir: contains trashed file: "potato" 2024/04/25 02:49:42 DEBUG : data: Rmdir: contains trashed file: "banana" 2024/04/25 02:49:42 DEBUG : data: Rmdir: contains trashed file: "potato" 2024/04/25 02:49:42 DEBUG : data: Rmdir: contains trashed file: "banana" --- PASS: TestCheckSumDownload (61.83s) --- PASS: TestCheckSumDownload/subtest1 (4.44s) --- PASS: TestCheckSumDownload/subtest2 (1.95s) --- PASS: TestCheckSumDownload/subtest3 (5.45s) --- PASS: TestCheckSumDownload/subtest4 (4.11s) --- PASS: TestCheckSumDownload/subtest5 (4.57s) --- PASS: TestCheckSumDownload/subtest6 (3.49s) --- PASS: TestCheckSumDownload/subtest7 (3.01s) === RUN TestHashSums run.go:180: Remote "PikPak root 'rclone-test-sibupuw5kuxedah2modayiv7'", Local "Local file system at /tmp/rclone1704739584", Modify Window "876000h0m0s" === RUN TestHashSums/Md5Download operations_test.go:279: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:279 Error: "336d5ebc5436534e61d16e63ddfca327 empty space\nd41d8cd98f00b204e9800998ecf8427e potato2\n" does not contain "d6548b156ea68a4e003e786df99eee76 potato2\n" Test: TestHashSums/Md5Download --- FAIL: TestHashSums (4.41s) --- FAIL: TestHashSums/Md5Download (1.03s) FAIL 2024/04/25 02:49:47 DEBUG : PikPak root 'rclone-test-sibupuw5kuxedah2modayiv7': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCheckDownload$/^(4|5|6|7)$|^TestCheckSumDownload$|^TestHashSums$/^Md5Download$'" - Finished ERROR in 1m27.350511976s (try 2/5): exit status 1: Failed [TestCheckDownload/4 TestCheckDownload/5 TestCheckDownload/6 TestCheckDownload/7 TestHashSums/Md5Download]