"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestSyncBackupDirWithSuffixKeepExtension|TestSyncIgnoreErrors)$'" - Starting (try 3/5)
2025/04/01 03:48:53 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-renakoj5tohu"
2025/04/01 03:48:53 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/01 03:48:53 DEBUG : Starting OpenDrive session with ID: d25bfa8c6cda711b1cd06898872f986655919b4512c9c9ea154e35f068c5007b
2025/04/01 03:48:53 DEBUG : Creating backend with remote "/tmp/rclone2958779063"
=== RUN   TestSyncIgnoreErrors
    run.go:180: Remote "OpenDrive root 'rclone-test-renakoj5tohu'", Local "Local file system at /tmp/rclone2958779063", Modify Window "1s"
2025/04/01 03:48:55 DEBUG : b/potato: Uploading chunk 0, size=21, remain=0
2025/04/01 03:48:57 DEBUG : c/non empty space: Uploading chunk 0, size=5, remain=0
2025/04/01 03:48:58 INFO  : d: Making directory
2025/04/01 03:48:59 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/04/01 03:48:59 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/04/01 03:48:59 DEBUG : c/non empty space: Unchanged skipping
2025/04/01 03:48:59 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu': Waiting for checks to finish
2025/04/01 03:48:59 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu': Waiting for transfers to finish
2025/04/01 03:49:00 DEBUG : a/potato2: Uploading chunk 0, size=60, remain=0
2025/04/01 03:49:01 DEBUG : a/potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK
2025/04/01 03:49:01 INFO  : a/potato2: Copied (new)
2025/04/01 03:49:01 DEBUG : Waiting for deletions to finish
2025/04/01 03:49:01 INFO  : b/potato: Deleted
2025/04/01 03:49:01 INFO  : d: Removing directory
2025/04/01 03:49:02 INFO  : b: Removing directory
2025/04/01 03:49:02 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu': deleted 2 directories
    run.go:180: Remote "OpenDrive root 'rclone-test-renakoj5tohu'", Local "Local file system at /tmp/rclone2958779063", Modify Window "1s"
--- PASS: TestSyncIgnoreErrors (10.85s)
=== RUN   TestSyncBackupDirWithSuffixKeepExtension
    run.go:180: Remote "OpenDrive root 'rclone-test-renakoj5tohu'", Local "Local file system at /tmp/rclone2958779063", Modify Window "1s"
2025/04/01 03:49:05 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/04/01 03:49:07 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2025/04/01 03:49:09 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2025/04/01 03:49:10 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-renakoj5tohu/dst"
2025/04/01 03:49:10 DEBUG : Starting OpenDrive session with ID: b60eac146ee8383a6aa0883f236919031681b98f177c437c18cb2c85ec5df25d
2025/04/01 03:49:11 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-renakoj5tohu/backup"
2025/04/01 03:49:11 DEBUG : Starting OpenDrive session with ID: c60057887cf512f42d4017414745a505f5a5d2503c1dcd73b6b856fa8002a4ca
2025/04/01 03:49:12 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/04/01 03:49:12 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/04/01 03:49:12 DEBUG : two: Unchanged skipping
2025/04/01 03:49:12 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu/dst': Waiting for checks to finish
2025/04/01 03:49:13 INFO  : one: Moved (server-side) to: one-2019-01-01
2025/04/01 03:49:13 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu/dst': Waiting for transfers to finish
2025/04/01 03:49:13 DEBUG : one: Uploading chunk 0, size=4, remain=0
2025/04/01 03:49:14 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/04/01 03:49:14 INFO  : one: Copied (new)
2025/04/01 03:49:14 DEBUG : Waiting for deletions to finish
2025/04/01 03:49:15 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2025/04/01 03:49:15 INFO  : three.txt: Moved into backup dir
2025/04/01 03:49:16 DEBUG : dst/three.txt: Uploading chunk 0, size=6, remain=0
2025/04/01 03:49:17 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/04/01 03:49:17 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/04/01 03:49:17 DEBUG : two: Unchanged skipping
2025/04/01 03:49:17 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu/dst': Waiting for checks to finish
2025/04/01 03:49:18 INFO  : one-2019-01-01: Deleted
2025/04/01 03:49:18 INFO  : one: Moved (server-side) to: one-2019-01-01
2025/04/01 03:49:18 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu/dst': Waiting for transfers to finish
2025/04/01 03:49:19 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/04/01 03:49:20 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/04/01 03:49:20 INFO  : one: Copied (new)
2025/04/01 03:49:20 DEBUG : Waiting for deletions to finish
2025/04/01 03:49:20 INFO  : three-2019-01-01.txt: Deleted
2025/04/01 03:49:20 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2025/04/01 03:49:20 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffixKeepExtension (18.24s)
PASS
2025/04/01 03:49:22 DEBUG : OpenDrive root 'rclone-test-renakoj5tohu': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestSyncBackupDirWithSuffixKeepExtension|TestSyncIgnoreErrors)$'" - Finished OK in 30.346468837s (try 3/5)