"./operations.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestCheckSum|TestDeduplicateNewestByHash|TestRmdirsNoLeaveRoot)$|^TestHashSums$/^Md5$'" - Starting (try 2/5)
2025/03/02 03:20:12 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-giwaruk4fazo"
2025/03/02 03:20:12 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/02 03:20:12 DEBUG : Creating backend with remote "/tmp/rclone3134854290"
=== RUN TestCheckSum
run.go:180: Remote "files root 'rclone-test-giwaruk4fazo'", Local "Local file system at /tmp/rclone3134854290", Modify Window "1s"
2025/03/02 03:20:12 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-giwaruk4fazo/data"
=== RUN TestCheckSum/subtest1
=== RUN TestCheckSum/subtest2
=== RUN TestCheckSum/subtest3
=== RUN TestCheckSum/subtest4
=== NAME TestCheckSum
check_test.go:411:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:411
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:432
Error: An error is expected but got nil.
Test: TestCheckSum
Messages: no expected error 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:432
Error: Not equal:
expected: 1
actual : 0
Test: TestCheckSum
Messages: wrong error count in run 4
check_test.go:387:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:387
/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{"", "* 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: TestCheckSum
Messages: wrong combined result in run 4
check_test.go:387:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:387
/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{"", "potato"}
actual : []string{"", "banana", "potato"}
Diff:
--- Expected
+++ Actual
@@ -1,3 +1,4 @@
-([]string) (len=2) {
+([]string) (len=3) {
(string) "",
+ (string) (len=6) "banana",
(string) (len=6) "potato"
Test: TestCheckSum
Messages: wrong match result in run 4
check_test.go:387:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:387
/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{"", "banana"}
actual : []string{}
Diff:
--- Expected
+++ Actual
@@ -1,4 +1,2 @@
-([]string) (len=2) {
- (string) "",
- (string) (len=6) "banana"
+([]string) {
}
Test: TestCheckSum
Messages: wrong differ result in run 4
=== RUN TestCheckSum/subtest5
=== RUN TestCheckSum/subtest6
=== NAME TestCheckSum
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 : 1
Test: TestCheckSum
Messages: wrong error count in run 6
check_test.go:387:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:387
/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{"", "+ orange", "= banana", "= potato"}
Diff:
--- Expected
+++ Actual
@@ -2,5 +2,5 @@
(string) "",
- (string) (len=8) "* potato",
(string) (len=8) "+ orange",
- (string) (len=8) "= banana"
+ (string) (len=8) "= banana",
+ (string) (len=8) "= potato"
}
Test: TestCheckSum
Messages: wrong combined result in run 6
check_test.go:387:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:387
/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{"", "banana", "potato"}
Diff:
--- Expected
+++ Actual
@@ -1,4 +1,5 @@
-([]string) (len=2) {
+([]string) (len=3) {
(string) "",
- (string) (len=6) "banana"
+ (string) (len=6) "banana",
+ (string) (len=6) "potato"
}
Test: TestCheckSum
Messages: wrong match result in run 6
check_test.go:387:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:387
/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: TestCheckSum
Messages: wrong differ result in run 6
=== RUN TestCheckSum/subtest7
--- FAIL: TestCheckSum (16.92s)
--- PASS: TestCheckSum/subtest1 (0.67s)
--- PASS: TestCheckSum/subtest2 (0.68s)
--- PASS: TestCheckSum/subtest3 (0.53s)
--- PASS: TestCheckSum/subtest4 (0.51s)
--- PASS: TestCheckSum/subtest5 (0.51s)
--- PASS: TestCheckSum/subtest6 (0.51s)
--- PASS: TestCheckSum/subtest7 (0.52s)
=== RUN TestDeduplicateNewestByHash
run.go:180: Remote "files root 'rclone-test-giwaruk4fazo'", Local "Local file system at /tmp/rclone3134854290", Modify Window "1s"
2025/03/02 03:20:32 INFO : files root 'rclone-test-giwaruk4fazo': Looking for duplicate md5 hashes using newest mode.
fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:299:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/dedupe_test.go:164
Error: Should be true
Test: TestDeduplicateNewestByHash
Messages: listing wrong, want
another (100), not-one (5) got
also/one (100), another (100), not-one (5), one (100)
fstest.go:185:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/dedupe_test.go:164
Error: Should be true
Test: TestDeduplicateNewestByHash
Messages: Unexpected file "one"
fstest.go:185:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/dedupe_test.go:164
Error: Should be true
Test: TestDeduplicateNewestByHash
Messages: Unexpected file "also/one"
--- FAIL: TestDeduplicateNewestByHash (12.39s)
=== RUN TestHashSums
run.go:180: Remote "files root 'rclone-test-giwaruk4fazo'", Local "Local file system at /tmp/rclone3134854290", Modify Window "1s"
=== RUN TestHashSums/Md5
operations_test.go:280:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:280
Error: " empty space\n potato2\n" does not contain "336d5ebc5436534e61d16e63ddfca327 empty space\n"
Test: TestHashSums/Md5
operations_test.go:280:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:280
Error: " empty space\n potato2\n" does not contain "d6548b156ea68a4e003e786df99eee76 potato2\n"
Test: TestHashSums/Md5
--- FAIL: TestHashSums (2.49s)
--- FAIL: TestHashSums/Md5 (0.12s)
=== RUN TestRmdirsNoLeaveRoot
run.go:180: Remote "files root 'rclone-test-giwaruk4fazo'", Local "Local file system at /tmp/rclone3134854290", Modify Window "1s"
2025/03/02 03:20:45 INFO : A2: Making directory
2025/03/02 03:20:45 INFO : A1/B2: Making directory
2025/03/02 03:20:46 INFO : A1/B2/C2: Making directory
2025/03/02 03:20:46 INFO : A1/B1/C3: Making directory
2025/03/02 03:20:46 INFO : A3: Making directory
2025/03/02 03:20:46 INFO : A3/B3: Making directory
2025/03/02 03:20:46 INFO : A3/B3/C4: Making directory
2025/03/02 03:20:48 DEBUG : removing 1 level 3 directories
2025/03/02 03:20:48 INFO : A3/B3/C4: Removing directory
2025/03/02 03:20:49 DEBUG : removing 2 level 3 directories
2025/03/02 03:20:49 INFO : A1/B2/C2: Removing directory
2025/03/02 03:20:49 INFO : A1/B1/C3: Removing directory
2025/03/02 03:20:49 DEBUG : removing 2 level 2 directories
2025/03/02 03:20:49 INFO : A3/B3: Removing directory
2025/03/02 03:20:49 INFO : A1/B2: Removing directory
2025/03/02 03:20:50 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-giwaruk4fazo/A1/B2 not empty`)
2025/03/02 03:20:50 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/03/02 03:20:50 DEBUG : pacer: Reducing sleep to 15ms
2025/03/02 03:20:50 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-giwaruk4fazo/A1/B2 not empty`)
2025/03/02 03:20:50 DEBUG : pacer: Rate limited, increasing sleep to 30ms
2025/03/02 03:20:50 DEBUG : pacer: Reducing sleep to 22.5ms
2025/03/02 03:20:50 DEBUG : removing 2 level 1 directories
2025/03/02 03:20:50 INFO : A3: Removing directory
2025/03/02 03:20:50 INFO : A2: Removing directory
2025/03/02 03:20:50 DEBUG : pacer: Reducing sleep to 16.875ms
2025/03/02 03:20:50 DEBUG : pacer: Reducing sleep to 12.65625ms
2025/03/02 03:20:50 DEBUG : pacer: Reducing sleep to 10ms
2025/03/02 03:20:52 DEBUG : removing 1 level 3 directories
2025/03/02 03:20:52 INFO : A1/B1/C1: Removing directory
2025/03/02 03:20:52 DEBUG : removing 1 level 2 directories
2025/03/02 03:20:52 INFO : A1/B1: Removing directory
2025/03/02 03:20:52 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-giwaruk4fazo/A1/B1 not empty`)
2025/03/02 03:20:52 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/03/02 03:20:52 DEBUG : pacer: Reducing sleep to 15ms
2025/03/02 03:20:52 DEBUG : removing 1 level 1 directories
2025/03/02 03:20:52 INFO : A1: Removing directory
2025/03/02 03:20:53 DEBUG : pacer: Reducing sleep to 11.25ms
2025/03/02 03:20:53 DEBUG : removing 1 level 0 directories
2025/03/02 03:20:53 INFO : files root 'rclone-test-giwaruk4fazo': Removing directory
2025/03/02 03:20:53 DEBUG : pacer: Reducing sleep to 10ms
2025/03/02 03:20:53 ERROR : : error listing: directory not found
2025/03/02 03:20:53 ERROR : : error listing: directory not found
--- PASS: TestRmdirsNoLeaveRoot (8.81s)
FAIL
2025/03/02 03:20:53 DEBUG : files root 'rclone-test-giwaruk4fazo': Purge remote
2025/03/02 03:20:53 NOTICE: purge failed: directory not found
"./operations.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestCheckSum|TestDeduplicateNewestByHash|TestRmdirsNoLeaveRoot)$|^TestHashSums$/^Md5$'" - Finished ERROR in 41.526515959s (try 2/5): exit status 1: Failed [TestCheckSum TestDeduplicateNewestByHash TestHashSums/Md5]