"./operations.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestDirMove|TestRmdirsLeaveRoot|TestRmdirsWithFilter)$|^TestHashSums$/^Md5$'" - Starting (try 2/5)
2025/09/02 03:03:07 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-cugurey0nuwu"
2025/09/02 03:03:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/09/02 03:03:08 DEBUG : Creating backend with remote "/tmp/rclone3571917631"
=== RUN   TestHashSums
    run.go:180: Remote "files root 'rclone-test-cugurey0nuwu'", Local "Local file system at /tmp/rclone3571917631", Modify Window "1s"
=== RUN   TestHashSums/Md5
--- PASS: TestHashSums (4.11s)
    --- PASS: TestHashSums/Md5 (0.13s)
=== RUN   TestRmdirsLeaveRoot
    run.go:180: Remote "files root 'rclone-test-cugurey0nuwu'", Local "Local file system at /tmp/rclone3571917631", Modify Window "1s"
2025/09/02 03:03:13 INFO  : A1: Making directory
2025/09/02 03:03:13 INFO  : A1/B1: Making directory
2025/09/02 03:03:13 INFO  : A1/B1/C1: Making directory
2025/09/02 03:03:14 DEBUG : removing 1 level 3 directories
2025/09/02 03:03:14 INFO  : A1/B1/C1: Removing directory
2025/09/02 03:03:14 DEBUG : removing 1 level 2 directories
2025/09/02 03:03:14 INFO  : A1/B1: Removing directory
2025/09/02 03:03:14 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-cugurey0nuwu/A1/B1 not empty`)
2025/09/02 03:03:14 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/09/02 03:03:15 DEBUG : pacer: Reducing sleep to 15ms
2025/09/02 03:03:15 DEBUG : pacer: Reducing sleep to 11.25ms
2025/09/02 03:03:15 DEBUG : pacer: Reducing sleep to 10ms
--- PASS: TestRmdirsLeaveRoot (3.01s)
=== RUN   TestRmdirsWithFilter
    run.go:180: Remote "files root 'rclone-test-cugurey0nuwu'", Local "Local file system at /tmp/rclone3571917631", Modify Window "1s"
2025/09/02 03:03:16 INFO  : A1: Making directory
2025/09/02 03:03:16 INFO  : A1/B1: Making directory
2025/09/02 03:03:16 INFO  : A1/B1/C1: Making directory
2025/09/02 03:03:17 DEBUG : removing 1 level 3 directories
2025/09/02 03:03:17 INFO  : A1/B1/C1: Removing directory
2025/09/02 03:03:18 DEBUG : removing 1 level 2 directories
2025/09/02 03:03:18 INFO  : A1/B1: Removing directory
2025/09/02 03:03:18 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-cugurey0nuwu/A1/B1 not empty`)
2025/09/02 03:03:18 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/09/02 03:03:18 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-cugurey0nuwu/A1/B1 not empty`)
2025/09/02 03:03:18 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2025/09/02 03:03:18 DEBUG : pacer: Reducing sleep to 30ms
2025/09/02 03:03:18 DEBUG : pacer: Reducing sleep to 22.5ms
2025/09/02 03:03:18 DEBUG : pacer: Reducing sleep to 16.875ms
2025/09/02 03:03:18 DEBUG : pacer: Reducing sleep to 12.65625ms
2025/09/02 03:03:18 DEBUG : pacer: Reducing sleep to 10ms
--- PASS: TestRmdirsWithFilter (3.39s)
=== RUN   TestDirMove
    run.go:180: Remote "files root 'rclone-test-cugurey0nuwu'", Local "Local file system at /tmp/rclone3571917631", Modify Window "1s"
2025/09/02 03:03:23 INFO  : A1/B2: Making directory
2025/09/02 03:03:24 INFO  : A1/B1/C3: Making directory
2025/09/02 03:03:28 INFO  : A2/one: Moved (server-side) to: A3/one
2025/09/02 03:03:28 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2025/09/02 03:03:28 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2025/09/02 03:03:28 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2025/09/02 03:03:28 INFO  : A2/two: Moved (server-side) to: A3/two
2025/09/02 03:03:29 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-cugurey0nuwu/A2/B1 not empty`)
2025/09/02 03:03:29 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/09/02 03:03:29 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-cugurey0nuwu/A2/B1 not empty`)
2025/09/02 03:03:29 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2025/09/02 03:03:29 DEBUG : pacer: Reducing sleep to 30ms
2025/09/02 03:03:29 DEBUG : pacer: Reducing sleep to 22.5ms
2025/09/02 03:03:29 DEBUG : pacer: Reducing sleep to 16.875ms
2025/09/02 03:03:29 DEBUG : pacer: Reducing sleep to 12.65625ms
2025/09/02 03:03:30 DEBUG : pacer: Reducing sleep to 10ms
2025/09/02 03:03:30 INFO  : files root 'rclone-test-cugurey0nuwu': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2025/09/02 03:03:33 INFO  : A3/two: Moved (server-side) to: A4/two
2025/09/02 03:03:33 INFO  : A3/one: Moved (server-side) to: A4/one
2025/09/02 03:03:33 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2025/09/02 03:03:33 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
2025/09/02 03:03:33 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
2025/09/02 03:03:33 DEBUG : pacer: low level retry 1/10 (error Folder Not Empty - `Folder rclone-test-cugurey0nuwu/A3/B1 not empty`)
2025/09/02 03:03:33 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/09/02 03:03:34 DEBUG : pacer: low level retry 2/10 (error Folder Not Empty - `Folder rclone-test-cugurey0nuwu/A3/B1 not empty`)
2025/09/02 03:03:34 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2025/09/02 03:03:34 DEBUG : pacer: Reducing sleep to 30ms
2025/09/02 03:03:34 DEBUG : pacer: Reducing sleep to 22.5ms
2025/09/02 03:03:34 DEBUG : pacer: Reducing sleep to 16.875ms
2025/09/02 03:03:34 DEBUG : pacer: Reducing sleep to 12.65625ms
2025/09/02 03:03:34 DEBUG : pacer: Reducing sleep to 10ms
--- PASS: TestDirMove (18.11s)
PASS
2025/09/02 03:03:37 DEBUG : files root 'rclone-test-cugurey0nuwu': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^(TestDirMove|TestRmdirsLeaveRoot|TestRmdirsWithFilter)$|^TestHashSums$/^Md5$'" - Finished OK in 29.887095757s (try 2/5)