"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncWithTrackRenames)$'" - Starting (try 2/5) 2024/11/07 02:38:08 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-risabem1rela" 2024/11/07 02:38:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/07 02:38:09 DEBUG : Creating backend with remote "/tmp/rclone1917961503" === RUN TestServerSideCopyOverSelf run.go:180: Remote "OneDrive root 'rclone-test-risabem1rela'", Local "Local file system at /tmp/rclone1917961503", Modify Window "1s" 2024/11/07 02:38:09 DEBUG : sub dir/hello world: Starting multipart upload 2024/11/07 02:38:09 DEBUG : sub dir/hello world: Uploading segment 0/11 size 11 2024/11/07 02:38:10 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-minoguv7wocu" sync_test.go:626: Server side copy (if possible) OneDrive root 'rclone-test-risabem1rela' -> OneDrive root 'rclone-test-minoguv7wocu' 2024/11/07 02:38:11 DEBUG : Added delayed dir = "sub dir", newDst= 2024/11/07 02:38:11 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/07 02:38:11 DEBUG : OneDrive root 'rclone-test-minoguv7wocu': Waiting for checks to finish 2024/11/07 02:38:11 DEBUG : OneDrive root 'rclone-test-minoguv7wocu': Waiting for transfers to finish 2024/11/07 02:38:12 DEBUG : sub dir/hello world: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2024/11/07 02:38:12 INFO : sub dir/hello world: Copied (server-side copy) 2024/11/07 02:38:12 INFO : sub dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "OneDrive root 'rclone-test-risabem1rela'", Local "Local file system at /tmp/rclone1917961503", Modify Window "1s" 2024/11/07 02:38:13 DEBUG : sub dir/hello world: Starting multipart upload 2024/11/07 02:38:13 DEBUG : sub dir/hello world: Uploading segment 0/17 size 17 2024/11/07 02:38:13 DEBUG : sub dir: Directory modification time the same (differ by 0s, within tolerance 1s) 2024/11/07 02:38:13 DEBUG : Added delayed dir = "sub dir", newDst=sub dir 2024/11/07 02:38:13 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/07 02:38:13 DEBUG : OneDrive root 'rclone-test-minoguv7wocu': Waiting for checks to finish 2024/11/07 02:38:13 DEBUG : OneDrive root 'rclone-test-minoguv7wocu': Waiting for transfers to finish 2024/11/07 02:38:17 ERROR : sub dir/hello world: Failed to copy: sub dir/hello world: async operation returned "failed" 2024/11/07 02:38:17 INFO : sub dir: Set directory modification time (using SetModTime) sync_test.go:639: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:639 Error: Received unexpected error: sub dir/hello world: async operation returned "failed" Test: TestServerSideCopyOverSelf 2024/11/07 02:38:17 DEBUG : OneDrive root 'rclone-test-minoguv7wocu': Purge remote --- FAIL: TestServerSideCopyOverSelf (9.81s) === RUN TestSyncWithTrackRenames run.go:180: Remote "OneDrive root 'rclone-test-risabem1rela'", Local "Local file system at /tmp/rclone1917961503", Modify Window "1s" sync_test.go:1538: Can track renames: true 2024/11/07 02:38:19 INFO : OneDrive root 'rclone-test-risabem1rela': Making map for --track-renames 2024/11/07 02:38:19 INFO : OneDrive root 'rclone-test-risabem1rela': Finished making map for --track-renames 2024/11/07 02:38:19 DEBUG : OneDrive root 'rclone-test-risabem1rela': Waiting for checks to finish 2024/11/07 02:38:19 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/07 02:38:19 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/07 02:38:19 DEBUG : potato: Starting multipart upload 2024/11/07 02:38:19 DEBUG : OneDrive root 'rclone-test-risabem1rela': Waiting for renames to finish 2024/11/07 02:38:19 DEBUG : yam: Starting multipart upload 2024/11/07 02:38:19 DEBUG : OneDrive root 'rclone-test-risabem1rela': Waiting for transfers to finish 2024/11/07 02:38:19 DEBUG : potato: Uploading segment 0/14 size 14 2024/11/07 02:38:19 DEBUG : yam: Uploading segment 0/11 size 11 2024/11/07 02:38:19 DEBUG : potato: quickxor = 5078031dc24087378060086f7e031dcae0063a00 OK 2024/11/07 02:38:19 INFO : potato: Copied (new) 2024/11/07 02:38:19 DEBUG : yam: quickxor = 5908431b40308437b8810e657b031d0000000000 OK 2024/11/07 02:38:19 INFO : yam: Copied (new) 2024/11/07 02:38:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "OneDrive root 'rclone-test-risabem1rela'", Local "Local file system at /tmp/rclone1917961503", Modify Window "1s" 2024/11/07 02:38:19 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1s) 2024/11/07 02:38:19 INFO : OneDrive root 'rclone-test-risabem1rela': Making map for --track-renames 2024/11/07 02:38:19 INFO : OneDrive root 'rclone-test-risabem1rela': Finished making map for --track-renames 2024/11/07 02:38:19 DEBUG : OneDrive root 'rclone-test-risabem1rela': Waiting for checks to finish 2024/11/07 02:38:19 DEBUG : potato: Unchanged skipping 2024/11/07 02:38:19 DEBUG : OneDrive root 'rclone-test-risabem1rela': Waiting for renames to finish 2024/11/07 02:38:20 INFO : yam: Moved (server-side) to: yaml 2024/11/07 02:38:20 INFO : yaml: Renamed from "yam" 2024/11/07 02:38:20 DEBUG : OneDrive root 'rclone-test-risabem1rela': Waiting for transfers to finish 2024/11/07 02:38:20 DEBUG : Waiting for deletions to finish 2024/11/07 02:38:20 INFO : There was nothing to transfer run.go:180: Remote "OneDrive root 'rclone-test-risabem1rela'", Local "Local file system at /tmp/rclone1917961503", Modify Window "1s" --- PASS: TestSyncWithTrackRenames (2.34s) FAIL 2024/11/07 02:38:21 DEBUG : OneDrive root 'rclone-test-risabem1rela': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncWithTrackRenames)$'" - Finished ERROR in 12.774235872s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf]