"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestSyncBackupDirWithSuffix$'" - Starting (try 4/5)
2025/08/12 04:06:34 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qihuwal0sasi"
2025/08/12 04:06:34 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/12 04:06:35 DEBUG : Starting OpenDrive session with ID: 8c5a52f88058f1b7ab3514949f6d194b0ee3f89846125ce76be640b95b80ed08
2025/08/12 04:06:35 DEBUG : Creating backend with remote "/tmp/rclone860990724"
=== RUN   TestSyncBackupDirWithSuffix
    run.go:180: Remote "OpenDrive root 'rclone-test-qihuwal0sasi'", Local "Local file system at /tmp/rclone860990724", Modify Window "1s"
2025/08/12 04:06:36 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/08/12 04:06:38 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2025/08/12 04:06:40 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2025/08/12 04:06:41 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qihuwal0sasi/dst"
2025/08/12 04:06:42 DEBUG : Starting OpenDrive session with ID: 7d0ab9dc34c734c01ed755bc0f015058e7560d6a1db7d0d9d4b74265b4bbdea2
2025/08/12 04:06:42 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qihuwal0sasi/backup"
2025/08/12 04:06:43 DEBUG : Starting OpenDrive session with ID: 8daa9214f2d783b3d1630f604869ae58cc2ae690505241551527566acfce09fc
2025/08/12 04:06:44 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/08/12 04:06:44 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/08/12 04:06:44 DEBUG : two: Unchanged skipping
2025/08/12 04:06:44 DEBUG : OpenDrive root 'rclone-test-qihuwal0sasi/dst': Waiting for checks to finish
2025/08/12 04:06:45 INFO  : one: Moved (server-side) to: one.bak
2025/08/12 04:06:45 DEBUG : OpenDrive root 'rclone-test-qihuwal0sasi/dst': Waiting for transfers to finish
2025/08/12 04:06:45 DEBUG : one: Uploading chunk 0, size=4, remain=0
2025/08/12 04:06:46 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/08/12 04:06:46 INFO  : one: Copied (new)
2025/08/12 04:06:46 DEBUG : Waiting for deletions to finish
2025/08/12 04:06:47 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/08/12 04:06:47 INFO  : three.txt: Moved into backup dir
2025/08/12 04:06:49 DEBUG : dst/three.txt: Uploading chunk 0, size=6, remain=0
2025/08/12 04:06:50 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/08/12 04:06:50 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/08/12 04:06:50 DEBUG : two: Unchanged skipping
2025/08/12 04:06:50 DEBUG : OpenDrive root 'rclone-test-qihuwal0sasi/dst': Waiting for checks to finish
2025/08/12 04:06:51 INFO  : one.bak: Deleted
2025/08/12 04:06:51 INFO  : one: Moved (server-side) to: one.bak
2025/08/12 04:06:51 DEBUG : OpenDrive root 'rclone-test-qihuwal0sasi/dst': Waiting for transfers to finish
2025/08/12 04:06:52 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/08/12 04:06:53 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/08/12 04:06:53 INFO  : one: Copied (new)
2025/08/12 04:06:53 DEBUG : Waiting for deletions to finish
2025/08/12 04:06:54 INFO  : three.txt.bak: Deleted
2025/08/12 04:06:54 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/08/12 04:06:54 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffix (21.41s)
PASS
2025/08/12 04:06:56 DEBUG : OpenDrive root 'rclone-test-qihuwal0sasi': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestSyncBackupDirWithSuffix$'" - Finished OK in 22.708374288s (try 4/5)