"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -fast-list -test.run '^TestSyncBackupDir$'" - Starting (try 2/5)
2025/01/21 01:25:44 DEBUG : Creating backend with remote "TestGoFile:rclone-test-sowafuq5muvu"
2025/01/21 01:25:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/21 01:25:45 DEBUG : Creating backend with remote "/tmp/rclone2511557489"
=== RUN   TestSyncBackupDir
    run.go:180: Remote "gofile root 'rclone-test-sowafuq5muvu'", Local "Local file system at /tmp/rclone2511557489", Modify Window "1s"
2025/01/21 01:25:46 DEBUG : Upload server store-eu-par-2 (eu) responded in 123.058422ms
2025/01/21 01:25:46 DEBUG : Upload server store7 (eu) responded in 124.620553ms
2025/01/21 01:25:46 DEBUG : dst/one: Using upload server store7 (eu)
2025/01/21 01:25:47 DEBUG : dst/two: Using upload server store7 (eu)
2025/01/21 01:25:47 DEBUG : dst/three.txt: Using upload server store7 (eu)
2025/01/21 01:25:48 DEBUG : Creating backend with remote "TestGoFile:rclone-test-sowafuq5muvu/dst"
2025/01/21 01:25:48 DEBUG : Creating backend with remote "TestGoFile:rclone-test-sowafuq5muvu/backup"
2025/01/21 01:25:49 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/01/21 01:25:49 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/01/21 01:25:49 DEBUG : two: Unchanged skipping
2025/01/21 01:25:49 DEBUG : gofile root 'rclone-test-sowafuq5muvu/dst': Waiting for checks to finish
2025/01/21 01:25:51 INFO  : one: Moved (server-side)
2025/01/21 01:25:51 DEBUG : gofile root 'rclone-test-sowafuq5muvu/dst': Waiting for transfers to finish
2025/01/21 01:25:52 DEBUG : Upload server store-eu-par-5 (eu) responded in 132.777175ms
2025/01/21 01:25:52 DEBUG : Upload server store6 (eu) responded in 137.316884ms
2025/01/21 01:25:52 DEBUG : one: Using upload server store-eu-par-5 (eu)
2025/01/21 01:25:52 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/01/21 01:25:52 INFO  : one: Copied (new)
2025/01/21 01:25:52 DEBUG : Waiting for deletions to finish
2025/01/21 01:25:53 INFO  : three.txt: Moved (server-side)
2025/01/21 01:25:53 INFO  : three.txt: Moved into backup dir
2025/01/21 01:25:55 DEBUG : dst/three.txt: Using upload server store7 (eu)
2025/01/21 01:25:56 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/01/21 01:25:56 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/01/21 01:25:56 DEBUG : two: Unchanged skipping
2025/01/21 01:25:56 DEBUG : gofile root 'rclone-test-sowafuq5muvu/dst': Waiting for checks to finish
2025/01/21 01:25:57 INFO  : one: Deleted
2025/01/21 01:25:57 INFO  : one: Moved (server-side)
2025/01/21 01:25:57 DEBUG : gofile root 'rclone-test-sowafuq5muvu/dst': Waiting for transfers to finish
2025/01/21 01:25:57 DEBUG : one: Using upload server store6 (eu)
2025/01/21 01:25:57 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/01/21 01:25:57 INFO  : one: Copied (new)
2025/01/21 01:25:57 DEBUG : Waiting for deletions to finish
2025/01/21 01:25:57 INFO  : three.txt: Deleted
2025/01/21 01:25:57 DEBUG : Rate limited, sleep for 5s
2025/01/21 01:26:02 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2025/01/21 01:26:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/01/21 01:26:02 DEBUG : Rate limited, sleep for 5s
2025/01/21 01:26:07 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2025/01/21 01:26:07 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2025/01/21 01:26:08 DEBUG : pacer: Reducing sleep to 20ms
2025/01/21 01:26:08 INFO  : three.txt: Moved (server-side)
2025/01/21 01:26:08 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (26.65s)
PASS
2025/01/21 01:26:11 DEBUG : gofile root 'rclone-test-sowafuq5muvu': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -fast-list -test.run '^TestSyncBackupDir$'" - Finished OK in 27.687467254s (try 2/5)