"./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestFixCase$'" - Starting (try 2/5) 2025/05/14 06:23:07 DEBUG : Creating backend with remote "TestDropbox:rclone-test-yejilub0yoge" 2025/05/14 06:23:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/14 06:23:08 DEBUG : Creating backend with remote "/tmp/rclone3815948709" === RUN TestFixCase run.go:180: Remote "Dropbox root 'rclone-test-yejilub0yoge'", Local "Local file system at /tmp/rclone3815948709", Modify Window "1s" 2025/05/14 06:23:09 DEBUG : EXISTING: Uploading chunk 1/1 2025/05/14 06:23:09 DEBUG : EXISTING: Uploading chunk 2/1 2025/05/14 06:23:10 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Adding "EXISTING" to batch 2025/05/14 06:23:11 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Batch idle for 500ms so committing 2025/05/14 06:23:11 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committing sync batch length 1 starting with: EXISTING 2025/05/14 06:23:11 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committed sync batch length 1 starting with: EXISTING 2025/05/14 06:23:12 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 1/1 2025/05/14 06:23:12 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 2/1 2025/05/14 06:23:13 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Adding "EXISTINGBUTDIFFERENT" to batch 2025/05/14 06:23:13 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Batch idle for 500ms so committing 2025/05/14 06:23:13 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committing sync batch length 1 starting with: EXISTINGBUTDIFFERENT 2025/05/14 06:23:14 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committed sync batch length 1 starting with: EXISTINGBUTDIFFERENT 2025/05/14 06:23:15 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 1/1 2025/05/14 06:23:15 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 2/1 2025/05/14 06:23:16 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Adding "SUBDIRA/subdirb/SUBDIRC/HELLO" to batch 2025/05/14 06:23:16 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Batch idle for 500ms so committing 2025/05/14 06:23:16 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committing sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/HELLO 2025/05/14 06:23:17 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committed sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/HELLO 2025/05/14 06:23:18 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 1/1 2025/05/14 06:23:18 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 2/1 2025/05/14 06:23:19 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Adding "SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences" to batch 2025/05/14 06:23:19 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Batch idle for 500ms so committing 2025/05/14 06:23:19 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committing sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences 2025/05/14 06:23:20 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committed sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences 2025/05/14 06:23:22 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/05/14 06:23:22 DEBUG : existing: Unchanged skipping 2025/05/14 06:23:22 DEBUG : existingbutdifferent: Sizes differ (src 5 vs dst 8) 2025/05/14 06:23:22 DEBUG : EXISTING: moving to existing-rclone-move-yesojuz7 2025/05/14 06:23:22 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-mubemum6 2025/05/14 06:23:23 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/.) 2025/05/14 06:23:23 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/05/14 06:23:23 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/) 2025/05/14 06:23:23 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2025/05/14 06:23:23 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/..) 2025/05/14 06:23:23 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2025/05/14 06:23:23 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/...) 2025/05/14 06:23:23 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2025/05/14 06:23:24 DEBUG : pacer: Reducing sleep to 120ms 2025/05/14 06:23:24 INFO : EXISTING: Moved (server-side) to: existing-rclone-move-yesojuz7 2025/05/14 06:23:24 DEBUG : EXISTING: moving to existing 2025/05/14 06:23:24 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/...) 2025/05/14 06:23:24 DEBUG : pacer: Rate limited, increasing sleep to 240ms 2025/05/14 06:23:24 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..) 2025/05/14 06:23:24 DEBUG : pacer: Rate limited, increasing sleep to 480ms 2025/05/14 06:23:24 DEBUG : pacer: low level retry 4/10 (error too_many_write_operations/...) 2025/05/14 06:23:24 DEBUG : pacer: Rate limited, increasing sleep to 960ms 2025/05/14 06:23:25 DEBUG : pacer: Reducing sleep to 720ms 2025/05/14 06:23:26 DEBUG : pacer: Reducing sleep to 540ms 2025/05/14 06:23:26 DEBUG : pacer: Reducing sleep to 405ms 2025/05/14 06:23:26 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-mubemum6 2025/05/14 06:23:26 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent 2025/05/14 06:23:27 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/) 2025/05/14 06:23:27 DEBUG : pacer: Rate limited, increasing sleep to 810ms 2025/05/14 06:23:28 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.) 2025/05/14 06:23:28 DEBUG : pacer: Rate limited, increasing sleep to 1.62s 2025/05/14 06:23:28 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/) 2025/05/14 06:23:28 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/05/14 06:23:28 DEBUG : pacer: Reducing sleep to 1.5s 2025/05/14 06:23:28 INFO : SUBDIRA: Fixed case by renaming to: subdira 2025/05/14 06:23:30 DEBUG : pacer: Reducing sleep to 1.125s 2025/05/14 06:23:30 INFO : existing-rclone-move-yesojuz7: Moved (server-side) to: existing 2025/05/14 06:23:30 INFO : EXISTING: Moved (server-side) to: existing 2025/05/14 06:23:30 INFO : EXISTING: Fixed case by renaming to: existing 2025/05/14 06:23:32 DEBUG : pacer: Reducing sleep to 843.75ms 2025/05/14 06:23:32 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/05/14 06:23:32 INFO : existingbutdifferent-rclone-move-mubemum6: Moved (server-side) to: existingbutdifferent 2025/05/14 06:23:32 INFO : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent 2025/05/14 06:23:32 INFO : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent 2025/05/14 06:23:33 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/05/14 06:23:33 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/05/14 06:23:33 DEBUG : existingbutdifferent: Uploading chunk 1/1 2025/05/14 06:23:34 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/05/14 06:23:34 DEBUG : existingbutdifferent: Uploading chunk 2/1 2025/05/14 06:23:35 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/05/14 06:23:35 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Adding "existingbutdifferent" to batch 2025/05/14 06:23:35 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/05/14 06:23:36 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Batch idle for 500ms so committing 2025/05/14 06:23:36 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committing sync batch length 1 starting with: existingbutdifferent 2025/05/14 06:23:36 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/05/14 06:23:36 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/.) 2025/05/14 06:23:36 DEBUG : pacer: Rate limited, increasing sleep to 225.254056ms 2025/05/14 06:23:37 DEBUG : pacer: Reducing sleep to 168.940542ms 2025/05/14 06:23:37 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committed sync batch length 1 starting with: existingbutdifferent 2025/05/14 06:23:37 DEBUG : existingbutdifferent: dropbox = 876764f8f7cb4581b40dd4a7a1be217b2c58ae386ca01c86ea0b30bba6d050ed OK 2025/05/14 06:23:37 INFO : existingbutdifferent: Copied (replaced existing) 2025/05/14 06:23:38 DEBUG : pacer: Reducing sleep to 126.705406ms 2025/05/14 06:23:38 INFO : SUBDIRA/subdirb: Fixed case by renaming to: subdira/subdirb 2025/05/14 06:23:39 DEBUG : pacer: Reducing sleep to 95.029054ms 2025/05/14 06:23:39 DEBUG : pacer: Reducing sleep to 71.27179ms 2025/05/14 06:23:41 DEBUG : pacer: Reducing sleep to 53.453842ms 2025/05/14 06:23:41 DEBUG : pacer: Reducing sleep to 40.090381ms 2025/05/14 06:23:43 DEBUG : pacer: Reducing sleep to 30.067785ms 2025/05/14 06:23:43 INFO : SUBDIRA/subdirb/SUBDIRC: Fixed case by renaming to: subdira/subdirb/subdirc 2025/05/14 06:23:43 DEBUG : pacer: Reducing sleep to 22.550838ms 2025/05/14 06:23:43 DEBUG : subdira/subdirb/subdirc/hello: Sizes differ (src 5 vs dst 8) 2025/05/14 06:23:43 DEBUG : pacer: Reducing sleep to 16.913128ms 2025/05/14 06:23:43 DEBUG : pacer: Reducing sleep to 12.684846ms 2025/05/14 06:23:43 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello-rclone-move-carolez9 2025/05/14 06:23:45 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/.) 2025/05/14 06:23:45 DEBUG : pacer: Rate limited, increasing sleep to 25.369692ms 2025/05/14 06:23:45 DEBUG : pacer: Reducing sleep to 19.027269ms 2025/05/14 06:23:45 INFO : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello-rclone-move-carolez9 2025/05/14 06:23:45 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello 2025/05/14 06:23:46 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/.) 2025/05/14 06:23:46 DEBUG : pacer: Rate limited, increasing sleep to 38.054538ms 2025/05/14 06:23:46 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/) 2025/05/14 06:23:46 DEBUG : pacer: Rate limited, increasing sleep to 76.109076ms 2025/05/14 06:23:46 DEBUG : pacer: Reducing sleep to 57.081807ms 2025/05/14 06:23:46 DEBUG : pacer: Reducing sleep to 42.811355ms 2025/05/14 06:23:47 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/...) 2025/05/14 06:23:47 DEBUG : pacer: Rate limited, increasing sleep to 85.62271ms 2025/05/14 06:23:47 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.) 2025/05/14 06:23:47 DEBUG : pacer: Rate limited, increasing sleep to 171.24542ms 2025/05/14 06:23:48 DEBUG : pacer: Reducing sleep to 128.434065ms 2025/05/14 06:23:48 INFO : subdira/subdirb/subdirc/hello-rclone-move-carolez9: Moved (server-side) to: subdira/subdirb/subdirc/hello 2025/05/14 06:23:48 INFO : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello 2025/05/14 06:23:48 INFO : SUBDIRA/subdirb/SUBDIRC/HELLO: Fixed case by renaming to: subdira/subdirb/subdirc/hello 2025/05/14 06:23:48 DEBUG : pacer: Reducing sleep to 96.325548ms 2025/05/14 06:23:48 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 1/1 2025/05/14 06:23:49 DEBUG : pacer: Reducing sleep to 72.244161ms 2025/05/14 06:23:49 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 2/1 2025/05/14 06:23:49 DEBUG : pacer: Reducing sleep to 54.18312ms 2025/05/14 06:23:49 INFO : SUBDIRA/subdirb/SUBDIRC/subdird: Fixed case by renaming to: subdira/subdirb/subdirc/subdird 2025/05/14 06:23:49 DEBUG : pacer: Reducing sleep to 40.63734ms 2025/05/14 06:23:49 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Adding "subdira/subdirb/subdirc/hello" to batch 2025/05/14 06:23:49 DEBUG : pacer: Reducing sleep to 30.478005ms 2025/05/14 06:23:49 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Sizes differ (src 5 vs dst 8) 2025/05/14 06:23:49 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Waiting for checks to finish 2025/05/14 06:23:50 DEBUG : pacer: Reducing sleep to 22.858503ms 2025/05/14 06:23:50 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-kurulaq0 2025/05/14 06:23:50 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Batch idle for 500ms so committing 2025/05/14 06:23:50 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committing sync batch length 1 starting with: subdira/subdirb/subdirc/hello 2025/05/14 06:23:51 DEBUG : pacer: Reducing sleep to 17.143877ms 2025/05/14 06:23:51 INFO : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-kurulaq0 2025/05/14 06:23:51 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences 2025/05/14 06:23:52 DEBUG : pacer: Reducing sleep to 12.857907ms 2025/05/14 06:23:52 ERROR : Dropbox root 'rclone-test-yejilub0yoge': sync batch commit: failed to commit batch length 1: batch had 1 errors: last error: upload failed: too_many_write_operations 2025/05/14 06:23:52 ERROR : subdira/subdirb/subdirc/hello: Failed to copy: upload failed: batch upload failed: upload failed: too_many_write_operations 2025/05/14 06:23:53 DEBUG : pacer: Reducing sleep to 10ms 2025/05/14 06:23:53 INFO : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-kurulaq0: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences 2025/05/14 06:23:53 INFO : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences 2025/05/14 06:23:53 INFO : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Fixed case by renaming to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences 2025/05/14 06:23:53 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Waiting for transfers to finish 2025/05/14 06:23:54 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 1/1 2025/05/14 06:23:54 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 2/1 2025/05/14 06:23:55 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Adding "subdira/subdirb/subdirc/subdird/filewithoutcasedifferences" to batch 2025/05/14 06:23:55 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Batch idle for 500ms so committing 2025/05/14 06:23:55 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committing sync batch length 1 starting with: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences 2025/05/14 06:23:56 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Committed sync batch length 1 starting with: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences 2025/05/14 06:23:56 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: dropbox = 876764f8f7cb4581b40dd4a7a1be217b2c58ae386ca01c86ea0b30bba6d050ed OK 2025/05/14 06:23:56 INFO : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (replaced existing) 2025/05/14 06:23:56 ERROR : Dropbox root 'rclone-test-yejilub0yoge': not deleting files as there were IO errors 2025/05/14 06:23:56 ERROR : Dropbox root 'rclone-test-yejilub0yoge': not deleting directories as there were IO errors sync_test.go:2655: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2655 Error: Received unexpected error: upload failed: batch upload failed: upload failed: too_many_write_operations Test: TestFixCase --- FAIL: TestFixCase (59.73s) FAIL 2025/05/14 06:24:07 DEBUG : Dropbox root 'rclone-test-yejilub0yoge': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestFixCase$'" - Finished ERROR in 1m1.062039625s (try 2/5): exit status 1: Failed [TestFixCase]