"./operations.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose -test.run '^(TestCheckSumDownload|TestRmdirsLeaveRoot|TestRmdirsWithFilter)$'" - Starting (try 2/5) 2026/09/21 05:03:24 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-lohutek4kuki" 2026/09/21 05:03:24 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/21 05:03:24 DEBUG : Creating backend with remote "/tmp/rclone1416870758" === RUN TestCheckSumDownload run.go:198: Remote "premiumize.me root 'rclone-test-lohutek4kuki'", Local "Local file system at /tmp/rclone1416870758", Modify Window "876000h0m0s" 2026/09/21 05:03:24 DEBUG : Creating backend with remote "TestPremiumizeMe:rclone-test-lohutek4kuki/data" === RUN TestCheckSumDownload/subtest1 2026/09/21 05:03:27 DEBUG : test.sum: Moving old file out the way to "test.sum.yogixes0" 2026/09/21 05:03:28 DEBUG : test.sum: Removing old file === RUN TestCheckSumDownload/subtest2 2026/09/21 05:03:28 DEBUG : test.sum: Moving old file out the way to "test.sum.tuxicus3" 2026/09/21 05:03:29 DEBUG : test.sum: Removing old file === RUN TestCheckSumDownload/subtest3 2026/09/21 05:03:30 DEBUG : test.sum: Moving old file out the way to "test.sum.wemaqad1" 2026/09/21 05:03:30 DEBUG : test.sum: Removing old file === RUN TestCheckSumDownload/subtest4 2026/09/21 05:03:31 DEBUG : test.sum: Moving old file out the way to "test.sum.xifacar1" 2026/09/21 05:03:31 DEBUG : test.sum: Removing old file === RUN TestCheckSumDownload/subtest5 2026/09/21 05:03:32 DEBUG : test.sum: Moving old file out the way to "test.sum.tatutub4" 2026/09/21 05:03:32 DEBUG : test.sum: Removing old file === RUN TestCheckSumDownload/subtest6 === NAME TestCheckSumDownload 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:432 Error: Not equal: expected: 2 actual : 4 Test: TestCheckSumDownload Messages: wrong error count in run 6 check_test.go:417: Error Trace: /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:432 Error: "2026/09/21 05:03:38 ERROR : error listing: couldn't list files: error: Rate limit exceeded. Please slow down.\n2026/09/21 05:03:38 ERROR : banana: file not in premiumize.me root 'rclone-test-lohutek4kuki/data'\n2026/09/21 05:03:38 ERROR : orange: file not in premiumize.me root 'rclone-test-lohutek4kuki/data'\n2026/09/21 05:03:38 ERROR : potato: file not in premiumize.me root 'rclone-test-lohutek4kuki/data'\n2026/09/21 05:03:38 NOTICE: premiumize.me root 'rclone-test-lohutek4kuki/data': 3 files missing\n2026/09/21 05:03:38 NOTICE: premiumize.me root 'rclone-test-lohutek4kuki/data': 0 differences found\n2026/09/21 05:03:38 NOTICE: premiumize.me root 'rclone-test-lohutek4kuki/data': 4 errors while checking\n" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 6 check_test.go:419: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:419 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: 2 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /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:432 Error: Not equal: expected: []string{"", "* potato", "+ orange", "= banana"} actual : []string{"", "+ banana", "+ orange", "+ potato"} Diff: --- Expected +++ Actual @@ -2,5 +2,5 @@ (string) "", - (string) (len=8) "* potato", + (string) (len=8) "+ banana", (string) (len=8) "+ orange", - (string) (len=8) "= banana" + (string) (len=8) "+ potato" } Test: TestCheckSumDownload Messages: wrong combined result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:423 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 Error: Not equal: expected: []string{"", "orange"} actual : []string{"", "banana", "orange", "potato"} Diff: --- Expected +++ Actual @@ -1,4 +1,6 @@ -([]string) (len=2) { +([]string) (len=4) { (string) "", - (string) (len=6) "orange" + (string) (len=6) "banana", + (string) (len=6) "orange", + (string) (len=6) "potato" } Test: TestCheckSumDownload Messages: wrong missingondst result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:424 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 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 match result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432 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 differ result in run 6 2026/09/21 05:03:38 DEBUG : pacer: low level retry 1/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/09/21 05:03:38 DEBUG : pacer: low level retry 2/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/09/21 05:03:38 DEBUG : pacer: low level retry 3/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/09/21 05:03:38 DEBUG : pacer: low level retry 4/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/09/21 05:03:38 DEBUG : pacer: low level retry 5/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/09/21 05:03:38 DEBUG : pacer: low level retry 6/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/09/21 05:03:38 DEBUG : pacer: low level retry 7/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/09/21 05:03:39 DEBUG : pacer: low level retry 8/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:39 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/21 05:03:40 DEBUG : pacer: low level retry 9/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:42 DEBUG : pacer: low level retry 10/10 (error error: Rate limit exceeded. Please slow down.) run.go:299: Retry Put of "data/banana" to premiumize.me root 'rclone-test-lohutek4kuki': 1/10 (couldn't list files: error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:44 DEBUG : pacer: low level retry 1/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:46 DEBUG : pacer: low level retry 2/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:48 DEBUG : pacer: low level retry 3/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:50 DEBUG : pacer: low level retry 4/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:52 DEBUG : pacer: low level retry 5/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:54 DEBUG : pacer: low level retry 6/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:56 DEBUG : pacer: low level retry 7/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:03:58 DEBUG : pacer: low level retry 8/10 (error error: Rate limit exceeded. Please slow down.) 2026/09/21 05:04:00 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/21 05:04:02 DEBUG : pacer: Reducing sleep to 1.125s 2026/09/21 05:04:02 DEBUG : data/banana: Moving old file out the way to "banana.jifujus0" 2026/09/21 05:04:04 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/21 05:04:05 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/21 05:04:05 DEBUG : data/banana: Removing old file 2026/09/21 05:04:06 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/21 05:04:07 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/21 05:04:07 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/21 05:04:07 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/21 05:04:07 DEBUG : data/potato: Moving old file out the way to "potato.ruwunox8" 2026/09/21 05:04:08 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/09/21 05:04:08 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/09/21 05:04:08 DEBUG : data/potato: Removing old file 2026/09/21 05:04:08 DEBUG : pacer: Reducing sleep to 84.470271ms 2026/09/21 05:04:08 DEBUG : pacer: Reducing sleep to 63.352703ms 2026/09/21 05:04:08 DEBUG : pacer: Reducing sleep to 47.514527ms 2026/09/21 05:04:09 DEBUG : pacer: Reducing sleep to 35.635895ms 2026/09/21 05:04:09 DEBUG : test.sum: Moving old file out the way to "test.sum.cotavum8" 2026/09/21 05:04:09 DEBUG : pacer: Reducing sleep to 26.726921ms 2026/09/21 05:04:09 DEBUG : pacer: Reducing sleep to 20.04519ms 2026/09/21 05:04:09 DEBUG : test.sum: Removing old file 2026/09/21 05:04:09 DEBUG : pacer: Reducing sleep to 15.033892ms 2026/09/21 05:04:09 DEBUG : pacer: Reducing sleep to 11.275419ms 2026/09/21 05:04:09 DEBUG : pacer: Reducing sleep to 10ms === RUN TestCheckSumDownload/subtest7 --- FAIL: TestCheckSumDownload (49.41s) --- PASS: TestCheckSumDownload/subtest1 (0.59s) --- PASS: TestCheckSumDownload/subtest2 (0.27s) --- PASS: TestCheckSumDownload/subtest3 (0.36s) --- PASS: TestCheckSumDownload/subtest4 (0.34s) --- PASS: TestCheckSumDownload/subtest5 (0.27s) --- PASS: TestCheckSumDownload/subtest6 (5.00s) --- PASS: TestCheckSumDownload/subtest7 (3.72s) === RUN TestRmdirsLeaveRoot run.go:198: Remote "premiumize.me root 'rclone-test-lohutek4kuki'", Local "Local file system at /tmp/rclone1416870758", Modify Window "876000h0m0s" 2026/09/21 05:04:14 INFO : A1: Making directory 2026/09/21 05:04:14 INFO : A1/B1: Making directory 2026/09/21 05:04:14 INFO : A1/B1/C1: Making directory 2026/09/21 05:04:14 DEBUG : removing 1 level 3 directories 2026/09/21 05:04:14 INFO : A1/B1/C1: Removing directory 2026/09/21 05:04:15 DEBUG : removing 1 level 2 directories 2026/09/21 05:04:15 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (1.63s) === RUN TestRmdirsWithFilter run.go:198: Remote "premiumize.me root 'rclone-test-lohutek4kuki'", Local "Local file system at /tmp/rclone1416870758", Modify Window "876000h0m0s" 2026/09/21 05:04:15 INFO : A1: Making directory 2026/09/21 05:04:15 INFO : A1/B1: Making directory 2026/09/21 05:04:15 INFO : A1/B1/C1: Making directory 2026/09/21 05:04:16 DEBUG : removing 1 level 3 directories 2026/09/21 05:04:16 INFO : A1/B1/C1: Removing directory 2026/09/21 05:04:16 DEBUG : removing 1 level 2 directories 2026/09/21 05:04:16 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (1.69s) FAIL 2026/09/21 05:04:17 DEBUG : premiumize.me root 'rclone-test-lohutek4kuki': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose -test.run '^(TestCheckSumDownload|TestRmdirsLeaveRoot|TestRmdirsWithFilter)$'" - Finished ERROR in 53.106537442s (try 2/5): exit status 1: Failed [TestCheckSumDownload]