"./operations.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -fast-list -test.run '^TestDirMove$'" - Starting (try 2/5)
2026/02/05 01:08:38 DEBUG : Creating backend with remote "TestGoFile:rclone-test-gomulir9bado"
2026/02/05 01:08:38 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/05 01:08:38 DEBUG : Creating backend with remote "/tmp/rclone4157404396"
=== RUN   TestDirMove
    run.go:185: Remote "gofile root 'rclone-test-gomulir9bado'", Local "Local file system at /tmp/rclone4157404396", Modify Window "1s"
2026/02/05 01:08:42 INFO  : A1/B2: Making directory
2026/02/05 01:08:42 INFO  : A1/B1/C3: Making directory
2026/02/05 01:08:45 INFO  : A2/two: Moved (server-side) to: A3/two
2026/02/05 01:08:45 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:08:45 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:08:45 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2026/02/05 01:08:45 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2026/02/05 01:08:50 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/05 01:08:50 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/05 01:08:50 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/05 01:08:50 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/05 01:08:50 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:08:50 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:08:55 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/05 01:08:55 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/05 01:08:55 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/05 01:08:55 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/05 01:08:55 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:08:55 DEBUG : pacer: Reducing sleep to 80ms
2026/02/05 01:08:55 INFO  : A2/one: Moved (server-side) to: A3/one
2026/02/05 01:09:00 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2026/02/05 01:09:00 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/05 01:09:00 DEBUG : pacer: Reducing sleep to 80ms
2026/02/05 01:09:00 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2026/02/05 01:09:00 DEBUG : pacer: Reducing sleep to 40ms
2026/02/05 01:09:00 DEBUG : pacer: Reducing sleep to 20ms
2026/02/05 01:09:01 DEBUG : pacer: Reducing sleep to 10ms
2026/02/05 01:09:02 INFO  : gofile root 'rclone-test-gomulir9bado': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2026/02/05 01:09:04 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:04 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:04 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:04 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:04 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:09 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/05 01:09:09 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/05 01:09:09 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/05 01:09:09 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/05 01:09:09 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/05 01:09:09 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/05 01:09:09 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/05 01:09:09 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/05 01:09:09 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/05 01:09:09 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/02/05 01:09:09 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:09 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:09 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:09 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:10 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:14 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/05 01:09:14 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/02/05 01:09:14 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/05 01:09:14 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/02/05 01:09:14 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:14 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/05 01:09:14 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/02/05 01:09:14 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/05 01:09:14 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/02/05 01:09:15 DEBUG : Rate limited, sleep for 5s
2026/02/05 01:09:15 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/05 01:09:15 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
2026/02/05 01:09:19 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2026/02/05 01:09:19 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/02/05 01:09:20 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2026/02/05 01:09:20 DEBUG : pacer: Reducing sleep to 10s
2026/02/05 01:09:20 INFO  : A3/two: Moved (server-side) to: A4/two
2026/02/05 01:09:40 DEBUG : pacer: Reducing sleep to 5s
2026/02/05 01:09:40 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
2026/02/05 01:09:50 DEBUG : pacer: Reducing sleep to 2.5s
2026/02/05 01:09:50 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
2026/02/05 01:09:56 DEBUG : pacer: Reducing sleep to 1.25s
2026/02/05 01:09:56 INFO  : A3/one: Moved (server-side) to: A4/one
2026/02/05 01:09:57 DEBUG : pacer: Reducing sleep to 625ms
2026/02/05 01:09:57 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2026/02/05 01:09:59 DEBUG : pacer: Reducing sleep to 312.5ms
2026/02/05 01:09:59 DEBUG : pacer: Reducing sleep to 156.25ms
2026/02/05 01:10:00 DEBUG : pacer: Reducing sleep to 78.125ms
2026/02/05 01:10:00 DEBUG : pacer: Reducing sleep to 39.0625ms
2026/02/05 01:10:00 DEBUG : pacer: Reducing sleep to 19.53125ms
2026/02/05 01:10:00 DEBUG : pacer: Reducing sleep to 10ms
--- PASS: TestDirMove (85.28s)
PASS
2026/02/05 01:10:04 DEBUG : gofile root 'rclone-test-gomulir9bado': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -fast-list -test.run '^TestDirMove$'" - Finished OK in 1m25.951761751s (try 2/5)