"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestSyncWithUpdateOlder$'" - Starting (try 3/5)
2022/03/15 06:28:52 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-jurijof7ticuwov7pifutoh2"
2022/03/15 06:28:52 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/03/15 06:28:52 DEBUG : Starting OpenDrive session with ID: 1717a813e734363f4dc5e5ddd952fbf01b019a8000d0de3f5c32e608d01e5c14
2022/03/15 06:28:53 DEBUG : Creating backend with remote "/tmp/rclone3100556766"
=== RUN   TestSyncWithUpdateOlder
    run.go:181: Remote "OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2'", Local "Local file system at /tmp/rclone3100556766", Modify Window "1s"
2022/03/15 06:28:57 DEBUG : one: Uploading chunk 0, size=3, remain=0
2022/03/15 06:29:05 DEBUG : two: Uploading chunk 0, size=3, remain=0
2022/03/15 06:29:11 DEBUG : three: Uploading chunk 0, size=5, remain=0
2022/03/15 06:29:17 DEBUG : four: Uploading chunk 0, size=8, remain=0
2022/03/15 06:29:23 DEBUG : OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2': Waiting for checks to finish
2022/03/15 06:29:23 DEBUG : four: Sizes differ (src 4 vs dst 8)
2022/03/15 06:29:23 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2022/03/15 06:29:23 DEBUG : one: Destination is newer than source, skipping
2022/03/15 06:29:23 DEBUG : three: Sizes identical
2022/03/15 06:29:23 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2022/03/15 06:29:23 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 (Local file system at /tmp/rclone3100556766)
2022/03/15 06:29:23 DEBUG : two: md5 = 0f82d86afa0f5dc965c5c15aca58dcfb (OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2')
2022/03/15 06:29:23 DEBUG : two: md5 differ
2022/03/15 06:29:23 DEBUG : OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2': Waiting for transfers to finish
2022/03/15 06:29:24 DEBUG : four: Uploading chunk 0, size=4, remain=0
2022/03/15 06:29:24 DEBUG : two: Uploading chunk 0, size=3, remain=0
2022/03/15 06:29:25 DEBUG : five: Uploading chunk 0, size=4, remain=0
2022/03/15 06:29:28 INFO  : four: Copied (replaced existing)
2022/03/15 06:29:29 INFO  : two: Copied (replaced existing)
2022/03/15 06:29:30 INFO  : five: Copied (new)
2022/03/15 06:29:30 DEBUG : Waiting for deletions to finish
2022/03/15 06:29:31 DEBUG : one: Destination is newer than source, skipping
2022/03/15 06:29:31 DEBUG : OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2': Waiting for checks to finish
2022/03/15 06:29:31 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2022/03/15 06:29:31 DEBUG : two: Size and md5 of src and dst objects identical
2022/03/15 06:29:31 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping
2022/03/15 06:29:31 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK
2022/03/15 06:29:31 DEBUG : five: Size and md5 of src and dst objects identical
2022/03/15 06:29:31 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 (Local file system at /tmp/rclone3100556766)
2022/03/15 06:29:31 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping
2022/03/15 06:29:31 DEBUG : three: md5 = 413af0de1f97a2155acf2b8b26ab36e2 (OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2')
2022/03/15 06:29:31 DEBUG : three: md5 differ
2022/03/15 06:29:31 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring
2022/03/15 06:29:31 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK
2022/03/15 06:29:31 DEBUG : four: Size and md5 of src and dst objects identical
2022/03/15 06:29:31 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping
2022/03/15 06:29:31 DEBUG : OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2': Waiting for transfers to finish
2022/03/15 06:29:32 DEBUG : three: Uploading chunk 0, size=5, remain=0
2022/03/15 06:29:37 INFO  : three: Copied (replaced existing)
2022/03/15 06:29:37 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithUpdateOlder (51.63s)
PASS
2022/03/15 06:29:45 DEBUG : OpenDrive root 'rclone-test-jurijof7ticuwov7pifutoh2': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestSyncWithUpdateOlder$'" - Finished OK in 55.013728219s (try 3/5)