"./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestFixCase|TestSyncConcurrentDelete|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 2/5)
2025/07/04 01:48:10 DEBUG : Creating backend with remote "TestDropbox:rclone-test-bijebux7rove"
2025/07/04 01:48:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/07/04 01:48:11 DEBUG : Creating backend with remote "/tmp/rclone1772162333"
=== RUN   TestSyncWithTrackRenamesStrategyModtime
    run.go:180: Remote "Dropbox root 'rclone-test-bijebux7rove'", Local "Local file system at /tmp/rclone1772162333", Modify Window "1s"
    sync_test.go:1611: Can track renames: true
2025/07/04 01:48:11 INFO  : Dropbox root 'rclone-test-bijebux7rove': Making map for --track-renames
2025/07/04 01:48:11 INFO  : Dropbox root 'rclone-test-bijebux7rove': Finished making map for --track-renames
2025/07/04 01:48:11 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for checks to finish
2025/07/04 01:48:11 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for renames to finish
2025/07/04 01:48:11 DEBUG : potato: Need to transfer - No matching file found at Destination
2025/07/04 01:48:11 DEBUG : yam: Need to transfer - No matching file found at Destination
2025/07/04 01:48:11 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for transfers to finish
2025/07/04 01:48:11 DEBUG : yam: Uploading chunk 1/1
2025/07/04 01:48:11 DEBUG : potato: Uploading chunk 1/1
2025/07/04 01:48:12 DEBUG : potato: Uploading chunk 2/1
2025/07/04 01:48:12 DEBUG : yam: Uploading chunk 2/1
2025/07/04 01:48:12 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "yam" to batch
2025/07/04 01:48:12 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "potato" to batch
2025/07/04 01:48:13 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:48:13 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 2 starting with: yam
2025/07/04 01:48:14 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 2 starting with: yam
2025/07/04 01:48:14 DEBUG : potato: dropbox = e2a782c8e3fdb845bdf7f9eae43136f1b81491ce2100e4b0219038e199dafeaa OK
2025/07/04 01:48:14 INFO  : potato: Copied (new)
2025/07/04 01:48:14 DEBUG : yam: dropbox = aaa23b433e10f702f28ca0d47ad306687a85fc06d82a1cca09332379ae4d702a OK
2025/07/04 01:48:14 INFO  : yam: Copied (new)
2025/07/04 01:48:14 DEBUG : Waiting for deletions to finish
2025/07/04 01:48:14 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:48:14 INFO  : Dropbox root 'rclone-test-bijebux7rove': Making map for --track-renames
2025/07/04 01:48:14 INFO  : Dropbox root 'rclone-test-bijebux7rove': Finished making map for --track-renames
2025/07/04 01:48:14 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for checks to finish
2025/07/04 01:48:14 DEBUG : potato: Unchanged skipping
2025/07/04 01:48:14 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for renames to finish
2025/07/04 01:48:15 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2025/07/04 01:48:15 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/07/04 01:48:15 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/..)
2025/07/04 01:48:15 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2025/07/04 01:48:17 DEBUG : pacer: Reducing sleep to 30ms
2025/07/04 01:48:17 INFO  : yam: Moved (server-side) to: yaml
2025/07/04 01:48:17 INFO  : yaml: Renamed from "yam"
2025/07/04 01:48:17 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for transfers to finish
2025/07/04 01:48:17 DEBUG : Waiting for deletions to finish
2025/07/04 01:48:17 INFO  : There was nothing to transfer
2025/07/04 01:48:17 DEBUG : pacer: Reducing sleep to 22.5ms
2025/07/04 01:48:17 DEBUG : pacer: Reducing sleep to 16.875ms
2025/07/04 01:48:18 DEBUG : pacer: Reducing sleep to 12.65625ms
2025/07/04 01:48:20 DEBUG : pacer: Reducing sleep to 10ms
--- PASS: TestSyncWithTrackRenamesStrategyModtime (9.78s)
=== RUN   TestFixCase
    run.go:180: Remote "Dropbox root 'rclone-test-bijebux7rove'", Local "Local file system at /tmp/rclone1772162333", Modify Window "1s"
2025/07/04 01:48:21 DEBUG : EXISTING: Uploading chunk 1/1
2025/07/04 01:48:22 DEBUG : EXISTING: Uploading chunk 2/1
2025/07/04 01:48:22 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "EXISTING" to batch
2025/07/04 01:48:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:48:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: EXISTING
2025/07/04 01:48:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: EXISTING
2025/07/04 01:48:24 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 1/1
2025/07/04 01:48:24 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 2/1
2025/07/04 01:48:24 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "EXISTINGBUTDIFFERENT" to batch
2025/07/04 01:48:25 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:48:25 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: EXISTINGBUTDIFFERENT
2025/07/04 01:48:26 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: EXISTINGBUTDIFFERENT
2025/07/04 01:48:26 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 1/1
2025/07/04 01:48:26 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 2/1
2025/07/04 01:48:27 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "SUBDIRA/subdirb/SUBDIRC/HELLO" to batch
2025/07/04 01:48:27 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:48:27 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/HELLO
2025/07/04 01:48:29 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/HELLO
2025/07/04 01:48:29 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 1/1
2025/07/04 01:48:29 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 2/1
2025/07/04 01:48:30 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences" to batch
2025/07/04 01:48:30 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:48:30 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences
2025/07/04 01:48:31 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences
2025/07/04 01:48:32 DEBUG : existingbutdifferent: Sizes differ (src 5 vs dst 8)
2025/07/04 01:48:32 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:48:32 DEBUG : existing: Unchanged skipping
2025/07/04 01:48:32 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-kijuvij2
2025/07/04 01:48:32 DEBUG : EXISTING: moving to existing-rclone-move-wokupeh0
2025/07/04 01:48:33 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/...)
2025/07/04 01:48:33 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/07/04 01:48:33 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/)
2025/07/04 01:48:33 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2025/07/04 01:48:34 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/)
2025/07/04 01:48:34 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2025/07/04 01:48:34 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/..)
2025/07/04 01:48:34 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2025/07/04 01:48:34 DEBUG : pacer: Reducing sleep to 120ms
2025/07/04 01:48:34 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-kijuvij2
2025/07/04 01:48:34 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent
2025/07/04 01:48:34 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/..)
2025/07/04 01:48:34 DEBUG : pacer: Rate limited, increasing sleep to 240ms
2025/07/04 01:48:34 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/..)
2025/07/04 01:48:34 DEBUG : pacer: Rate limited, increasing sleep to 480ms
2025/07/04 01:48:35 DEBUG : pacer: low level retry 4/10 (error too_many_write_operations/.)
2025/07/04 01:48:35 DEBUG : pacer: Rate limited, increasing sleep to 960ms
2025/07/04 01:48:35 DEBUG : pacer: low level retry 4/10 (error too_many_write_operations/...)
2025/07/04 01:48:35 DEBUG : pacer: Rate limited, increasing sleep to 1.92s
2025/07/04 01:48:35 DEBUG : pacer: low level retry 5/10 (error too_many_write_operations/...)
2025/07/04 01:48:35 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/07/04 01:48:35 DEBUG : pacer: Reducing sleep to 1.5s
2025/07/04 01:48:35 INFO  : existingbutdifferent-rclone-move-kijuvij2: Moved (server-side) to: existingbutdifferent
2025/07/04 01:48:35 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent
2025/07/04 01:48:35 INFO  : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent
2025/07/04 01:48:37 DEBUG : pacer: Reducing sleep to 1.125s
2025/07/04 01:48:39 DEBUG : pacer: Reducing sleep to 843.75ms
2025/07/04 01:48:39 INFO  : EXISTING: Moved (server-side) to: existing-rclone-move-wokupeh0
2025/07/04 01:48:39 DEBUG : EXISTING: moving to existing
2025/07/04 01:48:39 DEBUG : pacer: Reducing sleep to 632.8125ms
2025/07/04 01:48:39 DEBUG : existingbutdifferent: Uploading chunk 1/1
2025/07/04 01:48:40 DEBUG : pacer: Reducing sleep to 474.609375ms
2025/07/04 01:48:41 DEBUG : pacer: Reducing sleep to 355.957031ms
2025/07/04 01:48:41 DEBUG : existingbutdifferent: Uploading chunk 2/1
2025/07/04 01:48:41 DEBUG : pacer: Reducing sleep to 266.967773ms
2025/07/04 01:48:41 INFO  : existing-rclone-move-wokupeh0: Moved (server-side) to: existing
2025/07/04 01:48:41 INFO  : EXISTING: Moved (server-side) to: existing
2025/07/04 01:48:41 INFO  : EXISTING: Fixed case by renaming to: existing
2025/07/04 01:48:42 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/.)
2025/07/04 01:48:42 DEBUG : pacer: Rate limited, increasing sleep to 533.935546ms
2025/07/04 01:48:42 DEBUG : pacer: Reducing sleep to 400.451659ms
2025/07/04 01:48:42 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "existingbutdifferent" to batch
2025/07/04 01:48:42 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/..)
2025/07/04 01:48:42 DEBUG : pacer: Rate limited, increasing sleep to 800.903318ms
2025/07/04 01:48:42 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:48:42 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: existingbutdifferent
2025/07/04 01:48:43 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/)
2025/07/04 01:48:43 DEBUG : pacer: Rate limited, increasing sleep to 1.601806636s
2025/07/04 01:48:44 DEBUG : pacer: Reducing sleep to 1.201354977s
2025/07/04 01:48:44 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: existingbutdifferent
2025/07/04 01:48:44 DEBUG : existingbutdifferent: dropbox = 876764f8f7cb4581b40dd4a7a1be217b2c58ae386ca01c86ea0b30bba6d050ed OK
2025/07/04 01:48:44 INFO  : existingbutdifferent: Copied (replaced existing)
2025/07/04 01:48:45 DEBUG : pacer: low level retry 4/10 (error too_many_write_operations/.)
2025/07/04 01:48:45 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/07/04 01:48:46 DEBUG : pacer: low level retry 5/10 (error too_many_write_operations/.)
2025/07/04 01:48:49 DEBUG : pacer: low level retry 6/10 (error too_many_write_operations/..)
2025/07/04 01:48:51 DEBUG : pacer: Reducing sleep to 1.5s
2025/07/04 01:48:51 INFO  : SUBDIRA: Fixed case by renaming to: subdira
2025/07/04 01:48:52 DEBUG : pacer: Reducing sleep to 1.125s
2025/07/04 01:48:54 DEBUG : pacer: Reducing sleep to 843.75ms
2025/07/04 01:48:56 DEBUG : pacer: Reducing sleep to 632.8125ms
2025/07/04 01:48:56 DEBUG : pacer: Reducing sleep to 474.609375ms
2025/07/04 01:48:57 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2025/07/04 01:48:57 DEBUG : pacer: Rate limited, increasing sleep to 949.21875ms
2025/07/04 01:48:58 DEBUG : pacer: Reducing sleep to 711.914062ms
2025/07/04 01:48:58 INFO  : SUBDIRA/subdirb: Fixed case by renaming to: subdira/subdirb
2025/07/04 01:48:59 DEBUG : pacer: Reducing sleep to 533.935546ms
2025/07/04 01:48:59 DEBUG : pacer: Reducing sleep to 400.451659ms
2025/07/04 01:49:00 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/...)
2025/07/04 01:49:00 DEBUG : pacer: Rate limited, increasing sleep to 800.903318ms
2025/07/04 01:49:02 DEBUG : pacer: Reducing sleep to 600.677488ms
2025/07/04 01:49:02 DEBUG : pacer: Reducing sleep to 450.508116ms
2025/07/04 01:49:04 DEBUG : pacer: Reducing sleep to 337.881087ms
2025/07/04 01:49:04 INFO  : SUBDIRA/subdirb/SUBDIRC: Fixed case by renaming to: subdira/subdirb/subdirc
2025/07/04 01:49:04 DEBUG : pacer: Reducing sleep to 253.410815ms
2025/07/04 01:49:04 DEBUG : subdira/subdirb/subdirc/hello: Sizes differ (src 5 vs dst 8)
2025/07/04 01:49:04 DEBUG : pacer: Reducing sleep to 190.058111ms
2025/07/04 01:49:05 DEBUG : pacer: Reducing sleep to 142.543583ms
2025/07/04 01:49:05 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello-rclone-move-hixumoc5
2025/07/04 01:49:05 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/...)
2025/07/04 01:49:05 DEBUG : pacer: Rate limited, increasing sleep to 285.087166ms
2025/07/04 01:49:06 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/)
2025/07/04 01:49:06 DEBUG : pacer: Rate limited, increasing sleep to 570.174332ms
2025/07/04 01:49:06 DEBUG : pacer: Reducing sleep to 427.630749ms
2025/07/04 01:49:07 DEBUG : pacer: Reducing sleep to 320.723061ms
2025/07/04 01:49:07 DEBUG : pacer: Reducing sleep to 240.542295ms
2025/07/04 01:49:07 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello-rclone-move-hixumoc5
2025/07/04 01:49:07 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello
2025/07/04 01:49:08 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/)
2025/07/04 01:49:08 DEBUG : pacer: Rate limited, increasing sleep to 481.08459ms
2025/07/04 01:49:08 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/.)
2025/07/04 01:49:08 DEBUG : pacer: Rate limited, increasing sleep to 962.16918ms
2025/07/04 01:49:09 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.)
2025/07/04 01:49:09 DEBUG : pacer: Rate limited, increasing sleep to 1.92433836s
2025/07/04 01:49:09 DEBUG : pacer: Reducing sleep to 1.44325377s
2025/07/04 01:49:09 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird: Fixed case by renaming to: subdira/subdirb/subdirc/subdird
2025/07/04 01:49:09 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/...)
2025/07/04 01:49:09 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/07/04 01:49:11 DEBUG : pacer: Reducing sleep to 1.5s
2025/07/04 01:49:11 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Sizes differ (src 5 vs dst 8)
2025/07/04 01:49:11 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for checks to finish
2025/07/04 01:49:14 DEBUG : pacer: Reducing sleep to 1.125s
2025/07/04 01:49:14 INFO  : subdira/subdirb/subdirc/hello-rclone-move-hixumoc5: Moved (server-side) to: subdira/subdirb/subdirc/hello
2025/07/04 01:49:14 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello
2025/07/04 01:49:14 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Fixed case by renaming to: subdira/subdirb/subdirc/hello
2025/07/04 01:49:14 DEBUG : pacer: Reducing sleep to 843.75ms
2025/07/04 01:49:14 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-femuhob4
2025/07/04 01:49:15 DEBUG : pacer: Reducing sleep to 632.8125ms
2025/07/04 01:49:15 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 1/1
2025/07/04 01:49:16 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2025/07/04 01:49:16 DEBUG : pacer: Rate limited, increasing sleep to 1.265625s
2025/07/04 01:49:17 DEBUG : pacer: Reducing sleep to 949.21875ms
2025/07/04 01:49:17 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 2/1
2025/07/04 01:49:18 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/..)
2025/07/04 01:49:18 DEBUG : pacer: Rate limited, increasing sleep to 1.8984375s
2025/07/04 01:49:19 DEBUG : pacer: Reducing sleep to 1.423828125s
2025/07/04 01:49:19 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "subdira/subdirb/subdirc/hello" to batch
2025/07/04 01:49:20 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:20 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: subdira/subdirb/subdirc/hello
2025/07/04 01:49:22 DEBUG : pacer: Reducing sleep to 1.067871093s
2025/07/04 01:49:22 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-femuhob4
2025/07/04 01:49:22 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2025/07/04 01:49:24 DEBUG : pacer: Reducing sleep to 800.903319ms
2025/07/04 01:49:24 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: subdira/subdirb/subdirc/hello
2025/07/04 01:49:24 DEBUG : subdira/subdirb/subdirc/hello: dropbox = 876764f8f7cb4581b40dd4a7a1be217b2c58ae386ca01c86ea0b30bba6d050ed OK
2025/07/04 01:49:24 INFO  : subdira/subdirb/subdirc/hello: Copied (replaced existing)
2025/07/04 01:49:24 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/...)
2025/07/04 01:49:24 DEBUG : pacer: Rate limited, increasing sleep to 1.601806638s
2025/07/04 01:49:25 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.)
2025/07/04 01:49:25 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/07/04 01:49:27 DEBUG : pacer: Reducing sleep to 1.5s
2025/07/04 01:49:27 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-femuhob4: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2025/07/04 01:49:27 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2025/07/04 01:49:27 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Fixed case by renaming to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2025/07/04 01:49:27 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for transfers to finish
2025/07/04 01:49:28 DEBUG : pacer: Reducing sleep to 1.125s
2025/07/04 01:49:28 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 1/1
2025/07/04 01:49:30 DEBUG : pacer: Reducing sleep to 843.75ms
2025/07/04 01:49:30 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 2/1
2025/07/04 01:49:31 DEBUG : pacer: Reducing sleep to 632.8125ms
2025/07/04 01:49:31 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "subdira/subdirb/subdirc/subdird/filewithoutcasedifferences" to batch
2025/07/04 01:49:32 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:32 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2025/07/04 01:49:34 DEBUG : pacer: Reducing sleep to 474.609375ms
2025/07/04 01:49:34 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2025/07/04 01:49:34 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: dropbox = 876764f8f7cb4581b40dd4a7a1be217b2c58ae386ca01c86ea0b30bba6d050ed OK
2025/07/04 01:49:34 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (replaced existing)
2025/07/04 01:49:34 DEBUG : Waiting for deletions to finish
2025/07/04 01:49:34 DEBUG : pacer: Reducing sleep to 355.957031ms
2025/07/04 01:49:35 DEBUG : pacer: Reducing sleep to 266.967773ms
2025/07/04 01:49:35 DEBUG : pacer: Reducing sleep to 200.225829ms
2025/07/04 01:49:36 DEBUG : pacer: Reducing sleep to 150.169371ms
2025/07/04 01:49:36 DEBUG : pacer: Reducing sleep to 112.627028ms
2025/07/04 01:49:36 DEBUG : pacer: Reducing sleep to 84.470271ms
2025/07/04 01:49:37 DEBUG : pacer: Reducing sleep to 63.352703ms
2025/07/04 01:49:37 DEBUG : pacer: Reducing sleep to 47.514527ms
2025/07/04 01:49:38 DEBUG : pacer: Reducing sleep to 35.635895ms
2025/07/04 01:49:38 DEBUG : pacer: Reducing sleep to 26.726921ms
2025/07/04 01:49:38 DEBUG : pacer: Reducing sleep to 20.04519ms
2025/07/04 01:49:39 DEBUG : pacer: Reducing sleep to 15.033892ms
2025/07/04 01:49:39 DEBUG : pacer: Reducing sleep to 11.275419ms
2025/07/04 01:49:40 DEBUG : pacer: Reducing sleep to 10ms
--- PASS: TestFixCase (84.33s)
=== RUN   TestSyncConcurrentDelete
    run.go:180: Remote "Dropbox root 'rclone-test-bijebux7rove'", Local "Local file system at /tmp/rclone1772162333", Modify Window "1s"
2025/07/04 01:49:45 DEBUG : both0: Uploading chunk 1/1
2025/07/04 01:49:45 DEBUG : both0: Uploading chunk 2/1
2025/07/04 01:49:46 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both0" to batch
2025/07/04 01:49:46 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:46 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both0
2025/07/04 01:49:48 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both0
2025/07/04 01:49:48 DEBUG : only0: Uploading chunk 1/1
2025/07/04 01:49:48 DEBUG : only0: Uploading chunk 2/1
2025/07/04 01:49:49 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only0" to batch
2025/07/04 01:49:49 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:49 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only0
2025/07/04 01:49:50 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only0
2025/07/04 01:49:51 DEBUG : both1: Uploading chunk 1/1
2025/07/04 01:49:51 DEBUG : both1: Uploading chunk 2/1
2025/07/04 01:49:51 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both1" to batch
2025/07/04 01:49:52 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:52 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both1
2025/07/04 01:49:52 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both1
2025/07/04 01:49:53 DEBUG : only1: Uploading chunk 1/1
2025/07/04 01:49:53 DEBUG : only1: Uploading chunk 2/1
2025/07/04 01:49:54 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only1" to batch
2025/07/04 01:49:54 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:54 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only1
2025/07/04 01:49:55 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only1
2025/07/04 01:49:55 DEBUG : both2: Uploading chunk 1/1
2025/07/04 01:49:55 DEBUG : both2: Uploading chunk 2/1
2025/07/04 01:49:56 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both2" to batch
2025/07/04 01:49:56 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:56 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both2
2025/07/04 01:49:57 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both2
2025/07/04 01:49:58 DEBUG : only2: Uploading chunk 1/1
2025/07/04 01:49:58 DEBUG : only2: Uploading chunk 2/1
2025/07/04 01:49:58 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only2" to batch
2025/07/04 01:49:59 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:49:59 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only2
2025/07/04 01:49:59 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only2
2025/07/04 01:50:00 DEBUG : both3: Uploading chunk 1/1
2025/07/04 01:50:00 DEBUG : both3: Uploading chunk 2/1
2025/07/04 01:50:01 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both3" to batch
2025/07/04 01:50:01 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:01 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both3
2025/07/04 01:50:02 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both3
2025/07/04 01:50:02 DEBUG : only3: Uploading chunk 1/1
2025/07/04 01:50:03 DEBUG : only3: Uploading chunk 2/1
2025/07/04 01:50:03 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only3" to batch
2025/07/04 01:50:04 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:04 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only3
2025/07/04 01:50:04 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only3
2025/07/04 01:50:05 DEBUG : both4: Uploading chunk 1/1
2025/07/04 01:50:05 DEBUG : both4: Uploading chunk 2/1
2025/07/04 01:50:05 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both4" to batch
2025/07/04 01:50:06 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:06 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both4
2025/07/04 01:50:07 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both4
2025/07/04 01:50:07 DEBUG : only4: Uploading chunk 1/1
2025/07/04 01:50:07 DEBUG : only4: Uploading chunk 2/1
2025/07/04 01:50:07 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only4" to batch
2025/07/04 01:50:08 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:08 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only4
2025/07/04 01:50:09 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only4
2025/07/04 01:50:09 DEBUG : both5: Uploading chunk 1/1
2025/07/04 01:50:09 DEBUG : both5: Uploading chunk 2/1
2025/07/04 01:50:10 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both5" to batch
2025/07/04 01:50:10 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:10 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both5
2025/07/04 01:50:11 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both5
2025/07/04 01:50:11 DEBUG : only5: Uploading chunk 1/1
2025/07/04 01:50:12 DEBUG : only5: Uploading chunk 2/1
2025/07/04 01:50:12 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only5" to batch
2025/07/04 01:50:12 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:12 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only5
2025/07/04 01:50:13 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only5
2025/07/04 01:50:14 DEBUG : both6: Uploading chunk 1/1
2025/07/04 01:50:14 DEBUG : both6: Uploading chunk 2/1
2025/07/04 01:50:14 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both6" to batch
2025/07/04 01:50:15 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:15 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both6
2025/07/04 01:50:15 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both6
2025/07/04 01:50:16 DEBUG : only6: Uploading chunk 1/1
2025/07/04 01:50:16 DEBUG : only6: Uploading chunk 2/1
2025/07/04 01:50:16 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only6" to batch
2025/07/04 01:50:17 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:17 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only6
2025/07/04 01:50:17 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only6
2025/07/04 01:50:18 DEBUG : both7: Uploading chunk 1/1
2025/07/04 01:50:18 DEBUG : both7: Uploading chunk 2/1
2025/07/04 01:50:19 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both7" to batch
2025/07/04 01:50:19 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:19 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both7
2025/07/04 01:50:20 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both7
2025/07/04 01:50:20 DEBUG : only7: Uploading chunk 1/1
2025/07/04 01:50:20 DEBUG : only7: Uploading chunk 2/1
2025/07/04 01:50:20 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only7" to batch
2025/07/04 01:50:21 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:21 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only7
2025/07/04 01:50:22 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only7
2025/07/04 01:50:22 DEBUG : both8: Uploading chunk 1/1
2025/07/04 01:50:22 DEBUG : both8: Uploading chunk 2/1
2025/07/04 01:50:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both8" to batch
2025/07/04 01:50:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both8
2025/07/04 01:50:24 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both8
2025/07/04 01:50:24 DEBUG : only8: Uploading chunk 1/1
2025/07/04 01:50:25 DEBUG : only8: Uploading chunk 2/1
2025/07/04 01:50:25 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only8" to batch
2025/07/04 01:50:26 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:26 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only8
2025/07/04 01:50:26 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only8
2025/07/04 01:50:26 DEBUG : both9: Uploading chunk 1/1
2025/07/04 01:50:27 DEBUG : both9: Uploading chunk 2/1
2025/07/04 01:50:27 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both9" to batch
2025/07/04 01:50:28 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:28 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both9
2025/07/04 01:50:29 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both9
2025/07/04 01:50:29 DEBUG : only9: Uploading chunk 1/1
2025/07/04 01:50:29 DEBUG : only9: Uploading chunk 2/1
2025/07/04 01:50:30 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only9" to batch
2025/07/04 01:50:30 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:30 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only9
2025/07/04 01:50:32 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only9
2025/07/04 01:50:32 DEBUG : both10: Uploading chunk 1/1
2025/07/04 01:50:32 DEBUG : both10: Uploading chunk 2/1
2025/07/04 01:50:32 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both10" to batch
2025/07/04 01:50:33 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:33 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both10
2025/07/04 01:50:34 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both10
2025/07/04 01:50:35 DEBUG : only10: Uploading chunk 1/1
2025/07/04 01:50:35 DEBUG : only10: Uploading chunk 2/1
2025/07/04 01:50:35 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only10" to batch
2025/07/04 01:50:36 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:36 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only10
2025/07/04 01:50:37 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only10
2025/07/04 01:50:37 DEBUG : both11: Uploading chunk 1/1
2025/07/04 01:50:37 DEBUG : both11: Uploading chunk 2/1
2025/07/04 01:50:38 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both11" to batch
2025/07/04 01:50:38 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:38 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both11
2025/07/04 01:50:39 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both11
2025/07/04 01:50:39 DEBUG : only11: Uploading chunk 1/1
2025/07/04 01:50:39 DEBUG : only11: Uploading chunk 2/1
2025/07/04 01:50:40 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only11" to batch
2025/07/04 01:50:40 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:40 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only11
2025/07/04 01:50:41 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only11
2025/07/04 01:50:41 DEBUG : both12: Uploading chunk 1/1
2025/07/04 01:50:41 DEBUG : both12: Uploading chunk 2/1
2025/07/04 01:50:42 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both12" to batch
2025/07/04 01:50:42 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:42 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both12
2025/07/04 01:50:43 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both12
2025/07/04 01:50:44 DEBUG : only12: Uploading chunk 1/1
2025/07/04 01:50:44 DEBUG : only12: Uploading chunk 2/1
2025/07/04 01:50:44 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only12" to batch
2025/07/04 01:50:45 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:45 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only12
2025/07/04 01:50:46 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only12
2025/07/04 01:50:46 DEBUG : both13: Uploading chunk 1/1
2025/07/04 01:50:47 DEBUG : both13: Uploading chunk 2/1
2025/07/04 01:50:47 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both13" to batch
2025/07/04 01:50:48 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:48 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both13
2025/07/04 01:50:49 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both13
2025/07/04 01:50:49 DEBUG : only13: Uploading chunk 1/1
2025/07/04 01:50:49 DEBUG : only13: Uploading chunk 2/1
2025/07/04 01:50:50 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only13" to batch
2025/07/04 01:50:51 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:51 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only13
2025/07/04 01:50:51 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only13
2025/07/04 01:50:52 DEBUG : both14: Uploading chunk 1/1
2025/07/04 01:50:52 DEBUG : both14: Uploading chunk 2/1
2025/07/04 01:50:53 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both14" to batch
2025/07/04 01:50:53 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:53 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both14
2025/07/04 01:50:54 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both14
2025/07/04 01:50:54 DEBUG : only14: Uploading chunk 1/1
2025/07/04 01:50:55 DEBUG : only14: Uploading chunk 2/1
2025/07/04 01:50:55 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only14" to batch
2025/07/04 01:50:56 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:56 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only14
2025/07/04 01:50:57 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only14
2025/07/04 01:50:57 DEBUG : both15: Uploading chunk 1/1
2025/07/04 01:50:57 DEBUG : both15: Uploading chunk 2/1
2025/07/04 01:50:58 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both15" to batch
2025/07/04 01:50:58 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:50:58 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both15
2025/07/04 01:50:59 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both15
2025/07/04 01:50:59 DEBUG : only15: Uploading chunk 1/1
2025/07/04 01:51:00 DEBUG : only15: Uploading chunk 2/1
2025/07/04 01:51:00 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only15" to batch
2025/07/04 01:51:01 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:01 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only15
2025/07/04 01:51:02 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only15
2025/07/04 01:51:02 DEBUG : both16: Uploading chunk 1/1
2025/07/04 01:51:02 DEBUG : both16: Uploading chunk 2/1
2025/07/04 01:51:03 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both16" to batch
2025/07/04 01:51:03 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:03 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both16
2025/07/04 01:51:04 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both16
2025/07/04 01:51:04 DEBUG : only16: Uploading chunk 1/1
2025/07/04 01:51:05 DEBUG : only16: Uploading chunk 2/1
2025/07/04 01:51:05 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only16" to batch
2025/07/04 01:51:06 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:06 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only16
2025/07/04 01:51:06 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only16
2025/07/04 01:51:07 DEBUG : both17: Uploading chunk 1/1
2025/07/04 01:51:07 DEBUG : both17: Uploading chunk 2/1
2025/07/04 01:51:08 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both17" to batch
2025/07/04 01:51:08 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:08 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both17
2025/07/04 01:51:09 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both17
2025/07/04 01:51:09 DEBUG : only17: Uploading chunk 1/1
2025/07/04 01:51:09 DEBUG : only17: Uploading chunk 2/1
2025/07/04 01:51:10 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only17" to batch
2025/07/04 01:51:10 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:10 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only17
2025/07/04 01:51:12 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only17
2025/07/04 01:51:12 DEBUG : both18: Uploading chunk 1/1
2025/07/04 01:51:12 DEBUG : both18: Uploading chunk 2/1
2025/07/04 01:51:13 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both18" to batch
2025/07/04 01:51:13 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:13 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both18
2025/07/04 01:51:15 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both18
2025/07/04 01:51:15 DEBUG : only18: Uploading chunk 1/1
2025/07/04 01:51:15 DEBUG : only18: Uploading chunk 2/1
2025/07/04 01:51:16 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only18" to batch
2025/07/04 01:51:16 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:16 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only18
2025/07/04 01:51:18 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only18
2025/07/04 01:51:18 DEBUG : both19: Uploading chunk 1/1
2025/07/04 01:51:18 DEBUG : both19: Uploading chunk 2/1
2025/07/04 01:51:19 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "both19" to batch
2025/07/04 01:51:19 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:19 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: both19
2025/07/04 01:51:20 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: both19
2025/07/04 01:51:20 DEBUG : only19: Uploading chunk 1/1
2025/07/04 01:51:20 DEBUG : only19: Uploading chunk 2/1
2025/07/04 01:51:21 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Adding "only19" to batch
2025/07/04 01:51:21 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Batch idle for 500ms so committing
2025/07/04 01:51:21 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committing sync batch length 1 starting with: only19
2025/07/04 01:51:22 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Committed sync batch length 1 starting with: only19
2025/07/04 01:51:23 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for checks to finish
2025/07/04 01:51:23 DEBUG : both10: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both0: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both14: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both15: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both16: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both17: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both12: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both11: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both13: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both18: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both3: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both19: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both5: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both6: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both7: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both8: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2025/07/04 01:51:23 DEBUG : both9: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both1: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both2: Unchanged skipping
2025/07/04 01:51:23 DEBUG : both4: Unchanged skipping
2025/07/04 01:51:23 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Waiting for transfers to finish
2025/07/04 01:51:23 DEBUG : Waiting for deletions to finish
2025/07/04 01:51:24 INFO  : only16: Deleted
2025/07/04 01:51:24 INFO  : only0: Deleted
2025/07/04 01:51:24 INFO  : only18: Deleted
2025/07/04 01:51:24 INFO  : only10: Deleted
2025/07/04 01:51:24 INFO  : only11: Deleted
2025/07/04 01:51:25 INFO  : only13: Deleted
2025/07/04 01:51:25 INFO  : only17: Deleted
2025/07/04 01:51:25 INFO  : only15: Deleted
2025/07/04 01:51:25 INFO  : only19: Deleted
2025/07/04 01:51:26 INFO  : only14: Deleted
2025/07/04 01:51:26 INFO  : only5: Deleted
2025/07/04 01:51:26 INFO  : only8: Deleted
2025/07/04 01:51:27 INFO  : only6: Deleted
2025/07/04 01:51:27 INFO  : only2: Deleted
2025/07/04 01:51:27 INFO  : only7: Deleted
2025/07/04 01:51:27 INFO  : only9: Deleted
2025/07/04 01:51:27 INFO  : only3: Deleted
2025/07/04 01:51:28 INFO  : only12: Deleted
2025/07/04 01:51:28 INFO  : only4: Deleted
2025/07/04 01:51:28 INFO  : only1: Deleted
--- PASS: TestSyncConcurrentDelete (117.18s)
PASS
2025/07/04 01:51:42 DEBUG : Dropbox root 'rclone-test-bijebux7rove': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestFixCase|TestSyncConcurrentDelete|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished OK in 3m32.304935893s (try 2/5)