"./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncCopyDest)$'" - Starting (try 2/5) 2024/11/04 01:33:52 DEBUG : Creating backend with remote "TestDropbox:rclone-test-qijipoy5kewi" 2024/11/04 01:33:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/04 01:33:52 DEBUG : Creating backend with remote "/tmp/rclone676792708" === RUN TestServerSideCopyOverSelf run.go:180: Remote "Dropbox root 'rclone-test-qijipoy5kewi'", Local "Local file system at /tmp/rclone676792708", Modify Window "1s" 2024/11/04 01:33:53 DEBUG : sub dir/hello world: Uploading chunk 1/1 2024/11/04 01:33:54 DEBUG : sub dir/hello world: Uploading chunk 2/1 2024/11/04 01:33:55 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Adding "sub dir/hello world" to batch 2024/11/04 01:33:55 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Batch idle for 500ms so committing 2024/11/04 01:33:55 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committing sync batch length 1 starting with: sub dir/hello world 2024/11/04 01:33:56 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committed sync batch length 1 starting with: sub dir/hello world 2024/11/04 01:33:56 DEBUG : Creating backend with remote "TestDropbox:rclone-test-konasun2zate" sync_test.go:626: Server side copy (if possible) Dropbox root 'rclone-test-qijipoy5kewi' -> Dropbox root 'rclone-test-konasun2zate' 2024/11/04 01:33:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/04 01:33:58 DEBUG : Dropbox root 'rclone-test-konasun2zate': Waiting for checks to finish 2024/11/04 01:33:58 DEBUG : Dropbox root 'rclone-test-konasun2zate': Waiting for transfers to finish 2024/11/04 01:33:59 DEBUG : sub dir/hello world: dropbox = bc62d4b80d9e36da29c16c5d4d9f11731f36052c72401a76c23c0fb5a9b74423 OK 2024/11/04 01:33:59 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Dropbox root 'rclone-test-qijipoy5kewi'", Local "Local file system at /tmp/rclone676792708", Modify Window "1s" 2024/11/04 01:34:01 DEBUG : sub dir/hello world: Uploading chunk 1/1 2024/11/04 01:34:01 DEBUG : sub dir/hello world: Uploading chunk 2/1 2024/11/04 01:34:02 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Adding "sub dir/hello world" to batch 2024/11/04 01:34:02 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Batch idle for 500ms so committing 2024/11/04 01:34:02 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committing sync batch length 1 starting with: sub dir/hello world 2024/11/04 01:34:03 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committed sync batch length 1 starting with: sub dir/hello world 2024/11/04 01:34:04 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/04 01:34:04 DEBUG : Dropbox root 'rclone-test-konasun2zate': Waiting for checks to finish 2024/11/04 01:34:04 DEBUG : Dropbox root 'rclone-test-konasun2zate': Waiting for transfers to finish 2024/11/04 01:34:04 ERROR : sub dir/hello world: Failed to copy: copy failed: to/conflict/file/.. sync_test.go:639: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:639 Error: Received unexpected error: copy failed: to/conflict/file/.. Test: TestServerSideCopyOverSelf 2024/11/04 01:34:04 DEBUG : Dropbox root 'rclone-test-konasun2zate': Purge remote --- FAIL: TestServerSideCopyOverSelf (16.76s) === RUN TestSyncCopyDest run.go:180: Remote "Dropbox root 'rclone-test-qijipoy5kewi'", Local "Local file system at /tmp/rclone676792708", Modify Window "1s" 2024/11/04 01:34:09 DEBUG : Creating backend with remote "TestDropbox:rclone-test-qijipoy5kewi/dst" 2024/11/04 01:34:09 DEBUG : Creating backend with remote "TestDropbox:rclone-test-qijipoy5kewi/CopyDest" 2024/11/04 01:34:09 DEBUG : one: Need to transfer - File not found at Destination 2024/11/04 01:34:09 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for checks to finish 2024/11/04 01:34:09 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for transfers to finish 2024/11/04 01:34:10 DEBUG : one: Uploading chunk 1/1 2024/11/04 01:34:10 DEBUG : one: Uploading chunk 2/1 2024/11/04 01:34:10 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Adding "one" to batch 2024/11/04 01:34:11 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Batch idle for 500ms so committing 2024/11/04 01:34:11 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Committing sync batch length 1 starting with: one 2024/11/04 01:34:11 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Committed sync batch length 1 starting with: one 2024/11/04 01:34:11 DEBUG : one: dropbox = fe8d7a873dc48961a6af334c996b2cb3ce37149d5ce9c9253952a54c6a92c1ad OK 2024/11/04 01:34:11 INFO : one: Copied (new) 2024/11/04 01:34:11 DEBUG : Waiting for deletions to finish 2024/11/04 01:34:13 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for checks to finish 2024/11/04 01:34:13 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/04 01:34:13 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for transfers to finish 2024/11/04 01:34:14 DEBUG : one: Uploading chunk 1/1 2024/11/04 01:34:14 DEBUG : one: Uploading chunk 2/1 2024/11/04 01:34:14 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Adding "one" to batch 2024/11/04 01:34:15 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Batch idle for 500ms so committing 2024/11/04 01:34:15 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Committing sync batch length 1 starting with: one 2024/11/04 01:34:16 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Committed sync batch length 1 starting with: one 2024/11/04 01:34:16 DEBUG : one: dropbox = 7da8d117f9fb226817d81adc15c72720c9879c8b7fb821d27f217d198bd79d0d OK 2024/11/04 01:34:16 INFO : one: Copied (replaced existing) 2024/11/04 01:34:16 DEBUG : Waiting for deletions to finish 2024/11/04 01:34:17 DEBUG : dst/one: Uploading chunk 1/1 2024/11/04 01:34:17 DEBUG : dst/one: Uploading chunk 2/1 2024/11/04 01:34:18 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Adding "dst/one" to batch 2024/11/04 01:34:18 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Batch idle for 500ms so committing 2024/11/04 01:34:18 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committing sync batch length 1 starting with: dst/one 2024/11/04 01:34:19 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committed sync batch length 1 starting with: dst/one 2024/11/04 01:34:19 DEBUG : CopyDest/one: Uploading chunk 1/1 2024/11/04 01:34:20 DEBUG : CopyDest/one: Uploading chunk 2/1 2024/11/04 01:34:20 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Adding "CopyDest/one" to batch 2024/11/04 01:34:21 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Batch idle for 500ms so committing 2024/11/04 01:34:21 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committing sync batch length 1 starting with: CopyDest/one 2024/11/04 01:34:22 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committed sync batch length 1 starting with: CopyDest/one 2024/11/04 01:34:22 DEBUG : Creating backend with remote "TestDropbox:rclone-test-qijipoy5kewi/BackupDir" 2024/11/04 01:34:22 DEBUG : Config file has changed externally - reloading 2024/11/04 01:34:23 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/04 01:34:23 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for checks to finish 2024/11/04 01:34:24 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/04 01:34:24 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/04 01:34:25 INFO : one: Moved (server-side) 2024/11/04 01:34:26 DEBUG : one: dropbox = 7da8d117f9fb226817d81adc15c72720c9879c8b7fb821d27f217d198bd79d0d OK 2024/11/04 01:34:26 INFO : one: Copied (server-side copy) 2024/11/04 01:34:26 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/11/04 01:34:26 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for transfers to finish 2024/11/04 01:34:26 DEBUG : Waiting for deletions to finish 2024/11/04 01:34:27 DEBUG : CopyDest/two: Uploading chunk 1/1 2024/11/04 01:34:28 DEBUG : CopyDest/two: Uploading chunk 2/1 2024/11/04 01:34:28 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Adding "CopyDest/two" to batch 2024/11/04 01:34:29 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Batch idle for 500ms so committing 2024/11/04 01:34:29 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committing sync batch length 1 starting with: CopyDest/two 2024/11/04 01:34:29 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committed sync batch length 1 starting with: CopyDest/two 2024/11/04 01:34:30 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/04 01:34:31 DEBUG : two: dropbox = 313db63e0283ab2a9bc72e9a0ac749da1d3acf708fcd1a7848767244dd2f17e8 OK 2024/11/04 01:34:31 INFO : two: Copied (server-side copy) 2024/11/04 01:34:31 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/11/04 01:34:31 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/04 01:34:31 DEBUG : one: Unchanged skipping 2024/11/04 01:34:31 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for checks to finish 2024/11/04 01:34:31 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for transfers to finish 2024/11/04 01:34:31 DEBUG : Waiting for deletions to finish 2024/11/04 01:34:32 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/04 01:34:32 DEBUG : one: Unchanged skipping 2024/11/04 01:34:32 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/04 01:34:32 DEBUG : two: Unchanged skipping 2024/11/04 01:34:32 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for checks to finish 2024/11/04 01:34:32 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for transfers to finish 2024/11/04 01:34:32 DEBUG : Waiting for deletions to finish 2024/11/04 01:34:32 INFO : There was nothing to transfer 2024/11/04 01:34:33 DEBUG : CopyDest/three: Uploading chunk 1/1 2024/11/04 01:34:33 DEBUG : CopyDest/three: Uploading chunk 2/1 2024/11/04 01:34:34 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Adding "CopyDest/three" to batch 2024/11/04 01:34:34 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Batch idle for 500ms so committing 2024/11/04 01:34:34 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committing sync batch length 1 starting with: CopyDest/three 2024/11/04 01:34:35 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Committed sync batch length 1 starting with: CopyDest/three 2024/11/04 01:34:36 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/11/04 01:34:36 DEBUG : three: Destination not found in --copy-dest 2024/11/04 01:34:36 DEBUG : three: Need to transfer - File not found at Destination 2024/11/04 01:34:36 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/04 01:34:36 DEBUG : one: Unchanged skipping 2024/11/04 01:34:36 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2024/11/04 01:34:36 DEBUG : two: Unchanged skipping 2024/11/04 01:34:36 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for checks to finish 2024/11/04 01:34:36 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Waiting for transfers to finish 2024/11/04 01:34:36 DEBUG : three: Uploading chunk 1/1 2024/11/04 01:34:37 DEBUG : three: Uploading chunk 2/1 2024/11/04 01:34:37 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Adding "three" to batch 2024/11/04 01:34:38 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Batch idle for 500ms so committing 2024/11/04 01:34:38 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Committing sync batch length 1 starting with: three 2024/11/04 01:34:39 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi/dst': Committed sync batch length 1 starting with: three 2024/11/04 01:34:39 DEBUG : three: dropbox = 78af7ad260025156e50fd9648fd9a36509cd3541c9a8d02597e9b3c598937cbd OK 2024/11/04 01:34:39 INFO : three: Copied (new) 2024/11/04 01:34:39 DEBUG : Waiting for deletions to finish 2024/11/04 01:34:49 INFO : Dropbox root 'rclone-test-qijipoy5kewi/CopyDest': Committing uploads - please wait... 2024/11/04 01:34:49 INFO : Dropbox root 'rclone-test-qijipoy5kewi/BackupDir': Committing uploads - please wait... --- PASS: TestSyncCopyDest (39.99s) FAIL 2024/11/04 01:34:49 DEBUG : Dropbox root 'rclone-test-qijipoy5kewi': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestServerSideCopyOverSelf|TestSyncCopyDest)$'" - Finished ERROR in 57.725527488s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf]