"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestSyncConcurrentDelete$'" - Starting (try 2/5)
2022/06/17 07:11:26 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kelaxop7bigolaj2dejenas4"
2022/06/17 07:11:26 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/06/17 07:11:27 DEBUG : Starting OpenDrive session with ID: 7d532acfb05f366dd3f9a7948157c88047c668a52a2bc7efb3c6460592ff9ab3
2022/06/17 07:11:28 DEBUG : Creating backend with remote "/tmp/rclone4173894053"
=== RUN   TestSyncConcurrentDelete
    run.go:181: Remote "OpenDrive root 'rclone-test-kelaxop7bigolaj2dejenas4'", Local "Local file system at /tmp/rclone4173894053", Modify Window "1s"
2022/06/17 07:11:32 DEBUG : both0: Uploading chunk 0, size=6, remain=0
2022/06/17 07:11:38 DEBUG : only0: Uploading chunk 0, size=6, remain=0
2022/06/17 07:11:45 DEBUG : both1: Uploading chunk 0, size=6, remain=0
2022/06/17 07:11:53 DEBUG : only1: Uploading chunk 0, size=6, remain=0
2022/06/17 07:12:11 DEBUG : both2: Uploading chunk 0, size=6, remain=0
2022/06/17 07:12:17 DEBUG : only2: Uploading chunk 0, size=6, remain=0
2022/06/17 07:12:27 DEBUG : both3: Uploading chunk 0, size=6, remain=0
2022/06/17 07:12:34 DEBUG : only3: Uploading chunk 0, size=6, remain=0
2022/06/17 07:12:39 DEBUG : both4: Uploading chunk 0, size=6, remain=0
2022/06/17 07:12:45 DEBUG : only4: Uploading chunk 0, size=6, remain=0
2022/06/17 07:12:55 DEBUG : both5: Uploading chunk 0, size=6, remain=0
2022/06/17 07:13:01 DEBUG : only5: Uploading chunk 0, size=6, remain=0
2022/06/17 07:13:07 DEBUG : both6: Uploading chunk 0, size=6, remain=0
2022/06/17 07:13:13 DEBUG : only6: Uploading chunk 0, size=6, remain=0
2022/06/17 07:13:22 DEBUG : both7: Uploading chunk 0, size=6, remain=0
2022/06/17 07:13:37 DEBUG : only7: Uploading chunk 0, size=6, remain=0
2022/06/17 07:13:44 DEBUG : both8: Uploading chunk 0, size=6, remain=0
2022/06/17 07:13:53 DEBUG : only8: Uploading chunk 0, size=6, remain=0
2022/06/17 07:14:01 DEBUG : both9: Uploading chunk 0, size=6, remain=0
2022/06/17 07:14:07 DEBUG : only9: Uploading chunk 0, size=6, remain=0
2022/06/17 07:14:14 DEBUG : both10: Uploading chunk 0, size=6, remain=0
2022/06/17 07:14:21 DEBUG : only10: Uploading chunk 0, size=6, remain=0
2022/06/17 07:14:28 DEBUG : both11: Uploading chunk 0, size=6, remain=0
2022/06/17 07:14:36 DEBUG : only11: Uploading chunk 0, size=6, remain=0
2022/06/17 07:14:56 DEBUG : both12: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:04 DEBUG : only12: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:11 DEBUG : both13: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:17 DEBUG : only13: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:26 DEBUG : both14: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:34 DEBUG : only14: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:42 DEBUG : both15: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:49 DEBUG : only15: Uploading chunk 0, size=6, remain=0
2022/06/17 07:15:57 DEBUG : both16: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:05 DEBUG : only16: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:14 DEBUG : both17: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:23 DEBUG : only17: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:32 DEBUG : both18: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:39 DEBUG : only18: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:45 DEBUG : both19: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:53 DEBUG : only19: Uploading chunk 0, size=6, remain=0
2022/06/17 07:16:59 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both0: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both1: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both10: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both11: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both12: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both13: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both14: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both15: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both16: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both17: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both18: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both19: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both2: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both3: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both4: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both5: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both6: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both7: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both8: Unchanged skipping
2022/06/17 07:16:59 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2022/06/17 07:16:59 DEBUG : both9: Unchanged skipping
2022/06/17 07:16:59 DEBUG : OpenDrive root 'rclone-test-kelaxop7bigolaj2dejenas4': Waiting for checks to finish
2022/06/17 07:16:59 DEBUG : OpenDrive root 'rclone-test-kelaxop7bigolaj2dejenas4': Waiting for transfers to finish
2022/06/17 07:16:59 DEBUG : Waiting for deletions to finish
2022/06/17 07:17:00 INFO  : only11: Deleted
2022/06/17 07:17:00 INFO  : only14: Deleted
2022/06/17 07:17:01 INFO  : only2: Deleted
2022/06/17 07:17:01 INFO  : only10: Deleted
2022/06/17 07:17:01 INFO  : only5: Deleted
2022/06/17 07:17:01 INFO  : only6: Deleted
2022/06/17 07:17:01 INFO  : only7: Deleted
2022/06/17 07:17:01 INFO  : only0: Deleted
2022/06/17 07:17:01 INFO  : only17: Deleted
2022/06/17 07:17:01 INFO  : only18: Deleted
2022/06/17 07:17:02 INFO  : only4: Deleted
2022/06/17 07:17:02 INFO  : only1: Deleted
2022/06/17 07:17:02 INFO  : only15: Deleted
2022/06/17 07:17:02 INFO  : only13: Deleted
2022/06/17 07:17:03 INFO  : only3: Deleted
2022/06/17 07:17:03 INFO  : only16: Deleted
2022/06/17 07:17:03 INFO  : only12: Deleted
2022/06/17 07:17:03 INFO  : only19: Deleted
2022/06/17 07:17:04 INFO  : only8: Deleted
2022/06/17 07:17:04 INFO  : only9: Deleted
2022/06/17 07:17:04 INFO  : There was nothing to transfer
--- PASS: TestSyncConcurrentDelete (352.75s)
PASS
2022/06/17 07:17:21 DEBUG : OpenDrive root 'rclone-test-kelaxop7bigolaj2dejenas4': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestSyncConcurrentDelete$'" - Finished OK in 5m56.243158571s (try 2/5)