"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestSyncSuffix|TestSyncWithExclude)$'" - Starting (try 2/5)
2026/04/22 03:44:11 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-maxekev5saca"
2026/04/22 03:44:11 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/04/22 03:44:12 DEBUG : Starting OpenDrive session with ID: ef80d25a1dd0945a703d8ff7bf1f74995893fde46981a634c628da872cde4885
2026/04/22 03:44:12 DEBUG : Creating backend with remote "/tmp/rclone2630143895"
=== RUN   TestSyncWithExclude
    run.go:185: Remote "OpenDrive root 'rclone-test-maxekev5saca'", Local "Local file system at /tmp/rclone2630143895", Modify Window "1s"
2026/04/22 03:44:13 DEBUG : potato2: Uploading chunk 0, size=60, remain=0
2026/04/22 03:44:15 DEBUG : empty space: Uploading chunk 0, size=1, remain=0
2026/04/22 03:44:16 DEBUG : enormous: Excluded (Size Filter)
2026/04/22 03:44:16 DEBUG : enormous: Excluded
2026/04/22 03:44:16 DEBUG : potato2: Excluded (Size Filter)
2026/04/22 03:44:16 DEBUG : potato2: Excluded
2026/04/22 03:44:16 DEBUG : potato2: Excluded (Size Filter)
2026/04/22 03:44:16 DEBUG : potato2: Excluded
2026/04/22 03:44:16 DEBUG : empty space: size = 1 OK
2026/04/22 03:44:16 DEBUG : empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/04/22 03:44:16 DEBUG : empty space: Unchanged skipping
2026/04/22 03:44:16 DEBUG : OpenDrive root 'rclone-test-maxekev5saca': Waiting for checks to finish
2026/04/22 03:44:16 DEBUG : OpenDrive root 'rclone-test-maxekev5saca': Waiting for transfers to finish
2026/04/22 03:44:16 DEBUG : Waiting for deletions to finish
2026/04/22 03:44:16 INFO  : There was nothing to transfer
2026/04/22 03:44:16 DEBUG : enormous: Excluded (Size Filter)
2026/04/22 03:44:16 DEBUG : enormous: Excluded
2026/04/22 03:44:16 DEBUG : potato2: Excluded (Size Filter)
2026/04/22 03:44:16 DEBUG : potato2: Excluded
2026/04/22 03:44:16 DEBUG : potato2: Excluded (Size Filter)
2026/04/22 03:44:16 DEBUG : potato2: Excluded
2026/04/22 03:44:16 DEBUG : Local file system at /tmp/rclone2630143895: Waiting for checks to finish
2026/04/22 03:44:16 DEBUG : empty space: size = 1 OK
2026/04/22 03:44:16 DEBUG : empty space: Size and modification time the same (differ by 123.456789ms, within tolerance 1s)
2026/04/22 03:44:16 DEBUG : empty space: Unchanged skipping
2026/04/22 03:44:16 DEBUG : Local file system at /tmp/rclone2630143895: Waiting for transfers to finish
2026/04/22 03:44:16 DEBUG : Waiting for deletions to finish
2026/04/22 03:44:16 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExclude (4.99s)
=== RUN   TestSyncSuffix
    run.go:185: Remote "OpenDrive root 'rclone-test-maxekev5saca'", Local "Local file system at /tmp/rclone2630143895", Modify Window "1s"
2026/04/22 03:44:18 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2026/04/22 03:44:20 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2026/04/22 03:44:22 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2026/04/22 03:44:23 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-maxekev5saca/dst"
2026/04/22 03:44:23 DEBUG : Starting OpenDrive session with ID: 101b2229f23878719b056a15d3212b8dfa9750ca7ab4b31eb17895e9de95b7be
2026/04/22 03:44:24 DEBUG : one: size = 4 (Local file system at /tmp/rclone2630143895)
2026/04/22 03:44:24 DEBUG : one: size = 3 (OpenDrive root 'rclone-test-maxekev5saca/dst')
2026/04/22 03:44:24 DEBUG : one: Sizes differ
2026/04/22 03:44:24 DEBUG : one: same parent dir (ODFfMTE3MzQwMzRfOHRvOXg) - using file/rename instead of move_copy for one.bak
2026/04/22 03:44:24 INFO  : one: Moved (server-side) to: one.bak
2026/04/22 03:44:25 DEBUG : one: Uploading chunk 0, size=4, remain=0
2026/04/22 03:44:26 DEBUG : one: size = 4 OK
2026/04/22 03:44:26 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2026/04/22 03:44:26 INFO  : one: Copied (new)
2026/04/22 03:44:26 DEBUG : two: size = 3 OK
2026/04/22 03:44:26 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/04/22 03:44:26 DEBUG : two: Unchanged skipping
2026/04/22 03:44:26 DEBUG : three.txt: size = 6 (Local file system at /tmp/rclone2630143895)
2026/04/22 03:44:26 DEBUG : three.txt: size = 5 (OpenDrive root 'rclone-test-maxekev5saca/dst')
2026/04/22 03:44:26 DEBUG : three.txt: Sizes differ
2026/04/22 03:44:27 DEBUG : three.txt: same parent dir (ODFfMTE3MzQwMzRfOHRvOXg) - using file/rename instead of move_copy for three.txt.bak
2026/04/22 03:44:27 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/04/22 03:44:28 DEBUG : three.txt: Uploading chunk 0, size=6, remain=0
2026/04/22 03:44:29 DEBUG : three.txt: size = 6 OK
2026/04/22 03:44:29 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK
2026/04/22 03:44:29 INFO  : three.txt: Copied (new)
2026/04/22 03:44:29 DEBUG : one: size = 5 (Local file system at /tmp/rclone2630143895)
2026/04/22 03:44:29 DEBUG : one: size = 4 (OpenDrive root 'rclone-test-maxekev5saca/dst')
2026/04/22 03:44:29 DEBUG : one: Sizes differ
2026/04/22 03:44:30 INFO  : one.bak: Deleted
2026/04/22 03:44:30 DEBUG : one: same parent dir (ODFfMTE3MzQwMzRfOHRvOXg) - using file/rename instead of move_copy for one.bak
2026/04/22 03:44:30 INFO  : one: Moved (server-side) to: one.bak
2026/04/22 03:44:31 DEBUG : one: Uploading chunk 0, size=5, remain=0
2026/04/22 03:44:32 DEBUG : one: size = 5 OK
2026/04/22 03:44:32 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2026/04/22 03:44:32 INFO  : one: Copied (new)
2026/04/22 03:44:32 DEBUG : two: size = 3 OK
2026/04/22 03:44:32 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2026/04/22 03:44:32 DEBUG : two: Unchanged skipping
2026/04/22 03:44:32 DEBUG : three.txt: size = 19 (Local file system at /tmp/rclone2630143895)
2026/04/22 03:44:32 DEBUG : three.txt: size = 6 (OpenDrive root 'rclone-test-maxekev5saca/dst')
2026/04/22 03:44:32 DEBUG : three.txt: Sizes differ
2026/04/22 03:44:32 INFO  : three.txt.bak: Deleted
2026/04/22 03:44:33 DEBUG : three.txt: same parent dir (ODFfMTE3MzQwMzRfOHRvOXg) - using file/rename instead of move_copy for three.txt.bak
2026/04/22 03:44:33 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2026/04/22 03:44:33 DEBUG : three.txt: Uploading chunk 0, size=19, remain=0
2026/04/22 03:44:34 DEBUG : three.txt: size = 19 OK
2026/04/22 03:44:34 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK
2026/04/22 03:44:34 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffix (19.37s)
PASS
2026/04/22 03:44:36 DEBUG : OpenDrive root 'rclone-test-maxekev5saca': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestSyncSuffix|TestSyncWithExclude)$'" - Finished OK in 25.63534183s (try 2/5)