"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^TestSyncBackupDir$'" - Starting (try 2/5)
2025/01/21 01:19:09 DEBUG : Creating backend with remote "TestGoFile:rclone-test-motocoy1bake"
2025/01/21 01:19:09 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/21 01:19:10 DEBUG : Creating backend with remote "/tmp/rclone3078453808"
=== RUN   TestSyncBackupDir
    run.go:180: Remote "gofile root 'rclone-test-motocoy1bake'", Local "Local file system at /tmp/rclone3078453808", Modify Window "1s"
2025/01/21 01:19:11 DEBUG : Upload server store-eu-par-2 (eu) responded in 125.823977ms
2025/01/21 01:19:11 DEBUG : Upload server store-eu-par-3 (eu) responded in 125.914858ms
2025/01/21 01:19:11 DEBUG : dst/one: Using upload server store-eu-par-2 (eu)
2025/01/21 01:19:12 DEBUG : dst/two: Using upload server store-eu-par-2 (eu)
2025/01/21 01:19:12 DEBUG : dst/three.txt: Using upload server store-eu-par-3 (eu)
2025/01/21 01:19:13 DEBUG : Creating backend with remote "TestGoFile:rclone-test-motocoy1bake/dst"
2025/01/21 01:19:13 DEBUG : Creating backend with remote "TestGoFile:rclone-test-motocoy1bake/backup"
2025/01/21 01:19:15 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/01/21 01:19:15 DEBUG : gofile root 'rclone-test-motocoy1bake/dst': Waiting for checks to finish
2025/01/21 01:19:15 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/01/21 01:19:15 DEBUG : two: Unchanged skipping
2025/01/21 01:19:16 INFO  : one: Moved (server-side)
2025/01/21 01:19:16 DEBUG : gofile root 'rclone-test-motocoy1bake/dst': Waiting for transfers to finish
2025/01/21 01:19:16 DEBUG : Upload server store-eu-par-5 (eu) responded in 123.89551ms
2025/01/21 01:19:16 DEBUG : Upload server store-eu-par-4 (eu) responded in 122.467019ms
2025/01/21 01:19:16 DEBUG : one: Using upload server store-eu-par-5 (eu)
2025/01/21 01:19:16 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/01/21 01:19:16 INFO  : one: Copied (new)
2025/01/21 01:19:16 DEBUG : Waiting for deletions to finish
2025/01/21 01:19:17 INFO  : three.txt: Moved (server-side)
2025/01/21 01:19:17 INFO  : three.txt: Moved into backup dir
2025/01/21 01:19:17 DEBUG : dst/three.txt: Using upload server store-eu-par-2 (eu)
2025/01/21 01:19:22 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/01/21 01:19:22 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/01/21 01:19:22 DEBUG : two: Unchanged skipping
2025/01/21 01:19:22 DEBUG : gofile root 'rclone-test-motocoy1bake/dst': Waiting for checks to finish
2025/01/21 01:19:22 INFO  : one: Deleted
2025/01/21 01:19:23 INFO  : one: Moved (server-side)
2025/01/21 01:19:23 DEBUG : gofile root 'rclone-test-motocoy1bake/dst': Waiting for transfers to finish
2025/01/21 01:19:23 DEBUG : one: Using upload server store-eu-par-4 (eu)
2025/01/21 01:19:23 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/01/21 01:19:23 INFO  : one: Copied (new)
2025/01/21 01:19:23 DEBUG : Waiting for deletions to finish
2025/01/21 01:19:23 INFO  : three.txt: Deleted
2025/01/21 01:19:23 DEBUG : Rate limited, sleep for 5s
2025/01/21 01:19:28 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2025/01/21 01:19:28 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/01/21 01:19:29 DEBUG : pacer: Reducing sleep to 10ms
2025/01/21 01:19:29 INFO  : three.txt: Moved (server-side)
2025/01/21 01:19:29 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (21.22s)
PASS
2025/01/21 01:19:31 DEBUG : gofile root 'rclone-test-motocoy1bake': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^TestSyncBackupDir$'" - Finished OK in 21.950308988s (try 2/5)