"./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncWithTrackRenames)$'" - Starting (try 2/5) 2024/11/03 02:16:58 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-deximim4seti" 2024/11/03 02:16:58 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/03 02:16:59 DEBUG : Creating backend with remote "/tmp/rclone1540853030" === RUN TestServerSideCopyOverSelf run.go:180: Remote "OneDrive root 'rclone-test-deximim4seti'", Local "Local file system at /tmp/rclone1540853030", Modify Window "1s" 2024/11/03 02:16:59 DEBUG : sub dir/hello world: Starting multipart upload 2024/11/03 02:16:59 DEBUG : sub dir/hello world: Uploading segment 0/11 size 11 2024/11/03 02:17:00 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-vilovag2toyi" sync_test.go:626: Server side copy (if possible) OneDrive root 'rclone-test-deximim4seti' -> OneDrive root 'rclone-test-vilovag2toyi' 2024/11/03 02:17:01 DEBUG : Added delayed dir = "sub dir", newDst= 2024/11/03 02:17:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/03 02:17:01 DEBUG : OneDrive root 'rclone-test-vilovag2toyi': Waiting for checks to finish 2024/11/03 02:17:01 DEBUG : OneDrive root 'rclone-test-vilovag2toyi': Waiting for transfers to finish 2024/11/03 02:17:02 DEBUG : sub dir/hello world: quickxor = 6828031bd8f00610dce10d726b03190000000000 OK 2024/11/03 02:17:02 INFO : sub dir/hello world: Copied (server-side copy) 2024/11/03 02:17:02 INFO : sub dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "OneDrive root 'rclone-test-deximim4seti'", Local "Local file system at /tmp/rclone1540853030", Modify Window "1s" 2024/11/03 02:17:02 DEBUG : sub dir/hello world: Starting multipart upload 2024/11/03 02:17:02 DEBUG : sub dir/hello world: Uploading segment 0/17 size 17 2024/11/03 02:17:03 DEBUG : sub dir: Directory modification time the same (differ by 0s, within tolerance 1s) 2024/11/03 02:17:03 DEBUG : Added delayed dir = "sub dir", newDst=sub dir 2024/11/03 02:17:03 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/03 02:17:03 DEBUG : OneDrive root 'rclone-test-vilovag2toyi': Waiting for checks to finish 2024/11/03 02:17:03 DEBUG : OneDrive root 'rclone-test-vilovag2toyi': Waiting for transfers to finish 2024/11/03 02:17:05 ERROR : sub dir/hello world: Failed to copy: sub dir/hello world: async operation returned "failed" 2024/11/03 02:17:05 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/03 02:17:05 DEBUG : OneDrive root 'rclone-test-vilovag2toyi': Purge remote --- FAIL: TestServerSideCopyOverSelf (7.99s) === RUN TestSyncWithTrackRenames run.go:180: Remote "OneDrive root 'rclone-test-deximim4seti'", Local "Local file system at /tmp/rclone1540853030", Modify Window "1s" sync_test.go:1538: Can track renames: true 2024/11/03 02:17:07 INFO : OneDrive root 'rclone-test-deximim4seti': Making map for --track-renames 2024/11/03 02:17:07 INFO : OneDrive root 'rclone-test-deximim4seti': Finished making map for --track-renames 2024/11/03 02:17:07 DEBUG : OneDrive root 'rclone-test-deximim4seti': Waiting for checks to finish 2024/11/03 02:17:07 DEBUG : OneDrive root 'rclone-test-deximim4seti': Waiting for renames to finish 2024/11/03 02:17:07 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/03 02:17:07 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/03 02:17:07 DEBUG : OneDrive root 'rclone-test-deximim4seti': Waiting for transfers to finish 2024/11/03 02:17:07 DEBUG : potato: Starting multipart upload 2024/11/03 02:17:07 DEBUG : yam: Starting multipart upload 2024/11/03 02:17:07 DEBUG : potato: Uploading segment 0/14 size 14 2024/11/03 02:17:07 DEBUG : yam: Uploading segment 0/11 size 11 2024/11/03 02:17:07 DEBUG : yam: quickxor = 5908431b40308437b8810e657b031d0000000000 OK 2024/11/03 02:17:07 INFO : yam: Copied (new) 2024/11/03 02:17:07 DEBUG : potato: quickxor = 5078031dc24087378060086f7e031dcae0063a00 OK 2024/11/03 02:17:07 INFO : potato: Copied (new) 2024/11/03 02:17:07 DEBUG : Waiting for deletions to finish run.go:180: Remote "OneDrive root 'rclone-test-deximim4seti'", Local "Local file system at /tmp/rclone1540853030", Modify Window "1s" 2024/11/03 02:17:07 DEBUG : potato: Size and modification time the same (differ by -999.999µs, within tolerance 1s) 2024/11/03 02:17:07 INFO : OneDrive root 'rclone-test-deximim4seti': Making map for --track-renames 2024/11/03 02:17:07 INFO : OneDrive root 'rclone-test-deximim4seti': Finished making map for --track-renames 2024/11/03 02:17:07 DEBUG : OneDrive root 'rclone-test-deximim4seti': Waiting for checks to finish 2024/11/03 02:17:07 DEBUG : potato: Unchanged skipping 2024/11/03 02:17:07 DEBUG : OneDrive root 'rclone-test-deximim4seti': Waiting for renames to finish 2024/11/03 02:17:08 INFO : yam: Moved (server-side) to: yaml 2024/11/03 02:17:08 INFO : yaml: Renamed from "yam" 2024/11/03 02:17:08 DEBUG : OneDrive root 'rclone-test-deximim4seti': Waiting for transfers to finish 2024/11/03 02:17:08 DEBUG : Waiting for deletions to finish 2024/11/03 02:17:08 INFO : There was nothing to transfer run.go:180: Remote "OneDrive root 'rclone-test-deximim4seti'", Local "Local file system at /tmp/rclone1540853030", Modify Window "1s" --- PASS: TestSyncWithTrackRenames (2.63s) FAIL 2024/11/03 02:17:09 DEBUG : OneDrive root 'rclone-test-deximim4seti': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncWithTrackRenames)$'" - Finished ERROR in 11.565415845s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf]