"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestServerSideCopy|TestSyncBackupDir|TestSyncBackupDirSuffixOnly)$'" - Starting (try 2/5)
2025/05/17 02:37:28 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-siriwew6coro"
2025/05/17 02:37:28 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/17 02:37:29 DEBUG : Starting OpenDrive session with ID: 051d9a2910385a1b1c5b32b4b820b611329fc32f42dc65b13b6fe95502f2a1a1
2025/05/17 02:37:29 DEBUG : Creating backend with remote "/tmp/rclone497671117"
=== RUN   TestServerSideCopy
    run.go:180: Remote "OpenDrive root 'rclone-test-siriwew6coro'", Local "Local file system at /tmp/rclone497671117", Modify Window "1s"
2025/05/17 02:37:31 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0
2025/05/17 02:37:32 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-demifux6hivo"
2025/05/17 02:37:32 DEBUG : Starting OpenDrive session with ID: 6f8ec738c2e4eacc99edb27cc24f01120481516dcc36e8cef758866815fe06c6
    sync_test.go:590: Server side copy (if possible) OpenDrive root 'rclone-test-siriwew6coro' -> OpenDrive root 'rclone-test-demifux6hivo'
2025/05/17 02:37:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/05/17 02:37:33 DEBUG : OpenDrive root 'rclone-test-demifux6hivo': Waiting for checks to finish
2025/05/17 02:37:33 DEBUG : OpenDrive root 'rclone-test-demifux6hivo': Waiting for transfers to finish
2025/05/17 02:37:34 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check
2025/05/17 02:37:34 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "OpenDrive root 'rclone-test-siriwew6coro'", Local "Local file system at /tmp/rclone497671117", Modify Window "1s"
2025/05/17 02:37:34 DEBUG : OpenDrive root 'rclone-test-demifux6hivo': Purge remote
    run.go:125: removing dir "sub dir" failed - try 1/3: folder not empty
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:286: Sleeping for 6s just to make sure
--- PASS: TestServerSideCopy (15.53s)
=== RUN   TestSyncBackupDir
    run.go:180: Remote "OpenDrive root 'rclone-test-siriwew6coro'", Local "Local file system at /tmp/rclone497671117", Modify Window "1s"
2025/05/17 02:37:46 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/05/17 02:37:47 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0
2025/05/17 02:37:49 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0
2025/05/17 02:37:50 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-siriwew6coro/dst"
2025/05/17 02:37:51 DEBUG : Starting OpenDrive session with ID: d4856fab6bc8e733a7885847571a0281037ad4d2af93316fd83e96cbd0d21c52
2025/05/17 02:37:51 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-siriwew6coro/backup"
2025/05/17 02:37:51 DEBUG : Starting OpenDrive session with ID: 0fb332b3882635c8abf90b7c37d9bc1927700f09ae6d29aa56aef500d7c8bcc2
2025/05/17 02:37:52 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/05/17 02:37:52 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/05/17 02:37:52 DEBUG : two: Unchanged skipping
2025/05/17 02:37:52 DEBUG : OpenDrive root 'rclone-test-siriwew6coro/dst': Waiting for checks to finish
2025/05/17 02:37:53 INFO  : one: Moved (server-side)
2025/05/17 02:37:53 DEBUG : OpenDrive root 'rclone-test-siriwew6coro/dst': Waiting for transfers to finish
2025/05/17 02:37:54 DEBUG : one: Uploading chunk 0, size=4, remain=0
2025/05/17 02:37:55 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/05/17 02:37:55 INFO  : one: Copied (new)
2025/05/17 02:37:55 DEBUG : Waiting for deletions to finish
2025/05/17 02:37:55 INFO  : three.txt: Moved (server-side)
2025/05/17 02:37:55 INFO  : three.txt: Moved into backup dir
2025/05/17 02:37:57 DEBUG : dst/three.txt: Uploading chunk 0, size=6, remain=0
2025/05/17 02:37:58 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/05/17 02:37:58 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/05/17 02:37:58 DEBUG : two: Unchanged skipping
2025/05/17 02:37:58 DEBUG : OpenDrive root 'rclone-test-siriwew6coro/dst': Waiting for checks to finish
2025/05/17 02:37:58 INFO  : one: Deleted
2025/05/17 02:37:59 INFO  : one: Moved (server-side)
2025/05/17 02:37:59 DEBUG : OpenDrive root 'rclone-test-siriwew6coro/dst': Waiting for transfers to finish
2025/05/17 02:38:00 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/05/17 02:38:00 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/05/17 02:38:00 INFO  : one: Copied (new)
2025/05/17 02:38:00 DEBUG : Waiting for deletions to finish
2025/05/17 02:38:01 INFO  : three.txt: Deleted
2025/05/17 02:38:01 INFO  : three.txt: Moved (server-side)
2025/05/17 02:38:01 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (18.52s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:180: Remote "OpenDrive root 'rclone-test-siriwew6coro'", Local "Local file system at /tmp/rclone497671117", Modify Window "1s"
    run.go:285: Failed to put "dst/one" to "OpenDrive root 'rclone-test-siriwew6coro'": failed to create file: Parent folder is trashed (Error 403)
--- FAIL: TestSyncBackupDirSuffixOnly (0.82s)
FAIL
2025/05/17 02:38:04 DEBUG : OpenDrive root 'rclone-test-siriwew6coro': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestServerSideCopy|TestSyncBackupDir|TestSyncBackupDirSuffixOnly)$'" - Finished ERROR in 36.202005841s (try 2/5): exit status 1: Failed [TestSyncBackupDirSuffixOnly]