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