"./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestFixCase|TestSyncConcurrentTruncate)$'" - Starting (try 2/5)
2024/11/18 03:56:49 DEBUG : Creating backend with remote "TestDropbox:rclone-test-sorozay0reva"
2024/11/18 03:56:49 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/18 03:56:50 DEBUG : Creating backend with remote "/tmp/rclone3760835199"
=== RUN   TestFixCase
    run.go:180: Remote "Dropbox root 'rclone-test-sorozay0reva'", Local "Local file system at /tmp/rclone3760835199", Modify Window "1s"
2024/11/18 03:56:51 DEBUG : EXISTING: Uploading chunk 1/1
2024/11/18 03:56:51 DEBUG : EXISTING: Uploading chunk 2/1
2024/11/18 03:56:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "EXISTING" to batch
2024/11/18 03:56:52 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:56:52 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: EXISTING
2024/11/18 03:56:53 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: EXISTING
2024/11/18 03:56:53 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 1/1
2024/11/18 03:56:53 DEBUG : EXISTINGBUTDIFFERENT: Uploading chunk 2/1
2024/11/18 03:56:54 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "EXISTINGBUTDIFFERENT" to batch
2024/11/18 03:56:54 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:56:54 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: EXISTINGBUTDIFFERENT
2024/11/18 03:56:55 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: EXISTINGBUTDIFFERENT
2024/11/18 03:56:55 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 1/1
2024/11/18 03:56:56 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: Uploading chunk 2/1
2024/11/18 03:56:56 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "SUBDIRA/subdirb/SUBDIRC/HELLO" to batch
2024/11/18 03:56:57 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:56:57 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/HELLO
2024/11/18 03:56:58 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/HELLO
2024/11/18 03:56:59 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 1/1
2024/11/18 03:56:59 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Uploading chunk 2/1
2024/11/18 03:57:00 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences" to batch
2024/11/18 03:57:00 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:57:00 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences
2024/11/18 03:57:02 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences
2024/11/18 03:57:04 DEBUG : existing: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:57:04 DEBUG : existing: Unchanged skipping
2024/11/18 03:57:04 DEBUG : existingbutdifferent: Sizes differ (src 5 vs dst 8)
2024/11/18 03:57:04 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent-rclone-move-nikumal9
2024/11/18 03:57:04 DEBUG : EXISTING: moving to existing-rclone-move-firokaf2
2024/11/18 03:57:04 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/)
2024/11/18 03:57:04 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2024/11/18 03:57:04 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/)
2024/11/18 03:57:04 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2024/11/18 03:57:05 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/)
2024/11/18 03:57:05 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2024/11/18 03:57:05 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/)
2024/11/18 03:57:05 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2024/11/18 03:57:06 DEBUG : pacer: Reducing sleep to 120ms
2024/11/18 03:57:06 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/...)
2024/11/18 03:57:06 DEBUG : pacer: Rate limited, increasing sleep to 240ms
2024/11/18 03:57:06 DEBUG : pacer: Reducing sleep to 180ms
2024/11/18 03:57:06 DEBUG : pacer: low level retry 4/10 (error too_many_write_operations/..)
2024/11/18 03:57:06 DEBUG : pacer: Rate limited, increasing sleep to 360ms
2024/11/18 03:57:06 DEBUG : pacer: Reducing sleep to 270ms
2024/11/18 03:57:06 INFO  : EXISTING: Moved (server-side) to: existing-rclone-move-firokaf2
2024/11/18 03:57:06 DEBUG : EXISTING: moving to existing
2024/11/18 03:57:06 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/)
2024/11/18 03:57:06 DEBUG : pacer: Rate limited, increasing sleep to 540ms
2024/11/18 03:57:07 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/...)
2024/11/18 03:57:07 DEBUG : pacer: Rate limited, increasing sleep to 1.08s
2024/11/18 03:57:08 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.)
2024/11/18 03:57:08 DEBUG : pacer: Rate limited, increasing sleep to 2s
2024/11/18 03:57:08 DEBUG : pacer: Reducing sleep to 1.5s
2024/11/18 03:57:08 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent-rclone-move-nikumal9
2024/11/18 03:57:08 DEBUG : EXISTINGBUTDIFFERENT: moving to existingbutdifferent
2024/11/18 03:57:09 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/)
2024/11/18 03:57:09 DEBUG : pacer: Rate limited, increasing sleep to 2s
2024/11/18 03:57:10 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/..)
2024/11/18 03:57:12 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2024/11/18 03:57:14 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/.)
2024/11/18 03:57:17 DEBUG : pacer: Reducing sleep to 1.5s
2024/11/18 03:57:17 INFO  : SUBDIRA: Fixed case by renaming to: subdira
2024/11/18 03:57:18 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.)
2024/11/18 03:57:18 DEBUG : pacer: Rate limited, increasing sleep to 2s
2024/11/18 03:57:20 DEBUG : pacer: low level retry 4/10 (error too_many_write_operations/...)
2024/11/18 03:57:21 DEBUG : pacer: Reducing sleep to 1.5s
2024/11/18 03:57:24 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/...)
2024/11/18 03:57:24 DEBUG : pacer: Rate limited, increasing sleep to 2s
2024/11/18 03:57:26 DEBUG : pacer: Reducing sleep to 1.5s
2024/11/18 03:57:26 INFO  : existing-rclone-move-firokaf2: Moved (server-side) to: existing
2024/11/18 03:57:26 INFO  : EXISTING: Moved (server-side) to: existing
2024/11/18 03:57:26 INFO  : EXISTING: Fixed case by renaming to: existing
2024/11/18 03:57:27 DEBUG : pacer: Reducing sleep to 1.125s
2024/11/18 03:57:30 DEBUG : pacer: Reducing sleep to 843.75ms
2024/11/18 03:57:30 INFO  : existingbutdifferent-rclone-move-nikumal9: Moved (server-side) to: existingbutdifferent
2024/11/18 03:57:30 INFO  : EXISTINGBUTDIFFERENT: Moved (server-side) to: existingbutdifferent
2024/11/18 03:57:30 INFO  : EXISTINGBUTDIFFERENT: Fixed case by renaming to: existingbutdifferent
2024/11/18 03:57:31 DEBUG : pacer: Reducing sleep to 632.8125ms
2024/11/18 03:57:31 DEBUG : existingbutdifferent: Uploading chunk 1/1
2024/11/18 03:57:31 DEBUG : pacer: Reducing sleep to 474.609375ms
2024/11/18 03:57:32 DEBUG : pacer: Reducing sleep to 355.957031ms
2024/11/18 03:57:32 DEBUG : existingbutdifferent: Uploading chunk 2/1
2024/11/18 03:57:32 DEBUG : pacer: Reducing sleep to 266.967773ms
2024/11/18 03:57:33 DEBUG : pacer: Reducing sleep to 200.225829ms
2024/11/18 03:57:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "existingbutdifferent" to batch
2024/11/18 03:57:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:57:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: existingbutdifferent
2024/11/18 03:57:34 DEBUG : pacer: Reducing sleep to 150.169371ms
2024/11/18 03:57:34 INFO  : SUBDIRA/subdirb: Fixed case by renaming to: subdira/subdirb
2024/11/18 03:57:34 DEBUG : pacer: Reducing sleep to 112.627028ms
2024/11/18 03:57:34 DEBUG : pacer: Reducing sleep to 84.470271ms
2024/11/18 03:57:35 DEBUG : pacer: Reducing sleep to 63.352703ms
2024/11/18 03:57:35 ERROR : Dropbox root 'rclone-test-sorozay0reva': sync batch commit: failed to commit batch length 1: batch had 1 errors: last error: upload failed: too_many_write_operations
2024/11/18 03:57:35 ERROR : existingbutdifferent: Failed to copy: upload failed: batch upload failed: upload failed: too_many_write_operations
2024/11/18 03:57:35 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2024/11/18 03:57:35 DEBUG : pacer: Rate limited, increasing sleep to 126.705406ms
2024/11/18 03:57:36 DEBUG : pacer: Reducing sleep to 95.029054ms
2024/11/18 03:57:36 DEBUG : pacer: Reducing sleep to 71.27179ms
2024/11/18 03:57:38 DEBUG : pacer: Reducing sleep to 53.453842ms
2024/11/18 03:57:38 INFO  : SUBDIRA/subdirb/SUBDIRC: Fixed case by renaming to: subdira/subdirb/subdirc
2024/11/18 03:57:38 DEBUG : pacer: Reducing sleep to 40.090381ms
2024/11/18 03:57:38 DEBUG : subdira/subdirb/subdirc/hello: Sizes differ (src 5 vs dst 8)
2024/11/18 03:57:39 DEBUG : pacer: Reducing sleep to 30.067785ms
2024/11/18 03:57:39 DEBUG : pacer: Reducing sleep to 22.550838ms
2024/11/18 03:57:39 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello-rclone-move-kuqeliw2
2024/11/18 03:57:39 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/)
2024/11/18 03:57:39 DEBUG : pacer: Rate limited, increasing sleep to 45.101676ms
2024/11/18 03:57:40 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.)
2024/11/18 03:57:40 DEBUG : pacer: Rate limited, increasing sleep to 90.203352ms
2024/11/18 03:57:40 DEBUG : pacer: Reducing sleep to 67.652514ms
2024/11/18 03:57:40 DEBUG : pacer: Reducing sleep to 50.739385ms
2024/11/18 03:57:41 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2024/11/18 03:57:41 DEBUG : pacer: Rate limited, increasing sleep to 101.47877ms
2024/11/18 03:57:41 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/...)
2024/11/18 03:57:41 DEBUG : pacer: Rate limited, increasing sleep to 202.95754ms
2024/11/18 03:57:41 DEBUG : pacer: Reducing sleep to 152.218155ms
2024/11/18 03:57:41 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello-rclone-move-kuqeliw2
2024/11/18 03:57:41 DEBUG : SUBDIRA/subdirb/SUBDIRC/HELLO: moving to subdira/subdirb/subdirc/hello
2024/11/18 03:57:42 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2024/11/18 03:57:42 DEBUG : pacer: Rate limited, increasing sleep to 304.43631ms
2024/11/18 03:57:43 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/...)
2024/11/18 03:57:43 DEBUG : pacer: Rate limited, increasing sleep to 608.87262ms
2024/11/18 03:57:43 DEBUG : pacer: Reducing sleep to 456.654465ms
2024/11/18 03:57:43 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird: Fixed case by renaming to: subdira/subdirb/subdirc/subdird
2024/11/18 03:57:43 DEBUG : pacer: Reducing sleep to 342.490848ms
2024/11/18 03:57:43 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Sizes differ (src 5 vs dst 8)
2024/11/18 03:57:43 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Waiting for checks to finish
2024/11/18 03:57:44 DEBUG : pacer: Reducing sleep to 256.868136ms
2024/11/18 03:57:44 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-bogafit3
2024/11/18 03:57:44 DEBUG : pacer: Reducing sleep to 192.651102ms
2024/11/18 03:57:44 INFO  : subdira/subdirb/subdirc/hello-rclone-move-kuqeliw2: Moved (server-side) to: subdira/subdirb/subdirc/hello
2024/11/18 03:57:44 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Moved (server-side) to: subdira/subdirb/subdirc/hello
2024/11/18 03:57:44 INFO  : SUBDIRA/subdirb/SUBDIRC/HELLO: Fixed case by renaming to: subdira/subdirb/subdirc/hello
2024/11/18 03:57:44 DEBUG : pacer: Reducing sleep to 144.488326ms
2024/11/18 03:57:44 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 1/1
2024/11/18 03:57:44 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/)
2024/11/18 03:57:44 DEBUG : pacer: Rate limited, increasing sleep to 288.976652ms
2024/11/18 03:57:45 DEBUG : pacer: Reducing sleep to 216.732489ms
2024/11/18 03:57:45 DEBUG : subdira/subdirb/subdirc/hello: Uploading chunk 2/1
2024/11/18 03:57:45 DEBUG : pacer: Reducing sleep to 162.549366ms
2024/11/18 03:57:45 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "subdira/subdirb/subdirc/hello" to batch
2024/11/18 03:57:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:57:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: subdira/subdirb/subdirc/hello
2024/11/18 03:57:46 DEBUG : pacer: Reducing sleep to 121.912024ms
2024/11/18 03:57:46 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-bogafit3
2024/11/18 03:57:46 DEBUG : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: moving to subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/11/18 03:57:46 DEBUG : pacer: Reducing sleep to 91.434018ms
2024/11/18 03:57:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: subdira/subdirb/subdirc/hello
2024/11/18 03:57:46 DEBUG : subdira/subdirb/subdirc/hello: dropbox = 876764f8f7cb4581b40dd4a7a1be217b2c58ae386ca01c86ea0b30bba6d050ed OK
2024/11/18 03:57:46 INFO  : subdira/subdirb/subdirc/hello: Copied (replaced existing)
2024/11/18 03:57:47 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/..)
2024/11/18 03:57:47 DEBUG : pacer: Rate limited, increasing sleep to 182.868036ms
2024/11/18 03:57:47 DEBUG : pacer: low level retry 2/10 (error too_many_write_operations/.)
2024/11/18 03:57:47 DEBUG : pacer: Rate limited, increasing sleep to 365.736072ms
2024/11/18 03:57:48 DEBUG : pacer: low level retry 3/10 (error too_many_write_operations/...)
2024/11/18 03:57:48 DEBUG : pacer: Rate limited, increasing sleep to 731.472144ms
2024/11/18 03:57:49 DEBUG : pacer: Reducing sleep to 548.604108ms
2024/11/18 03:57:49 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences-rclone-move-bogafit3: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/11/18 03:57:49 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Moved (server-side) to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/11/18 03:57:49 INFO  : SUBDIRA/subdirb/SUBDIRC/subdird/filewithoutcasedifferences: Fixed case by renaming to: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/11/18 03:57:49 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Waiting for transfers to finish
2024/11/18 03:57:49 DEBUG : pacer: Reducing sleep to 411.453081ms
2024/11/18 03:57:49 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 1/1
2024/11/18 03:57:50 DEBUG : pacer: Reducing sleep to 308.58981ms
2024/11/18 03:57:50 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Uploading chunk 2/1
2024/11/18 03:57:51 DEBUG : pacer: Reducing sleep to 231.442357ms
2024/11/18 03:57:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "subdira/subdirb/subdirc/subdird/filewithoutcasedifferences" to batch
2024/11/18 03:57:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:57:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/11/18 03:57:52 DEBUG : pacer: Reducing sleep to 173.581767ms
2024/11/18 03:57:52 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: subdira/subdirb/subdirc/subdird/filewithoutcasedifferences
2024/11/18 03:57:52 DEBUG : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: dropbox = 876764f8f7cb4581b40dd4a7a1be217b2c58ae386ca01c86ea0b30bba6d050ed OK
2024/11/18 03:57:52 INFO  : subdira/subdirb/subdirc/subdird/filewithoutcasedifferences: Copied (replaced existing)
2024/11/18 03:57:52 ERROR : Dropbox root 'rclone-test-sorozay0reva': not deleting files as there were IO errors
2024/11/18 03:57:52 ERROR : Dropbox root 'rclone-test-sorozay0reva': 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
2024/11/18 03:57:52 DEBUG : pacer: Reducing sleep to 130.186325ms
2024/11/18 03:57:53 DEBUG : pacer: Reducing sleep to 97.639743ms
2024/11/18 03:57:54 DEBUG : pacer: Reducing sleep to 73.229807ms
2024/11/18 03:57:54 DEBUG : pacer: Reducing sleep to 54.922355ms
2024/11/18 03:57:54 DEBUG : pacer: Reducing sleep to 41.191766ms
2024/11/18 03:57:54 DEBUG : pacer: Reducing sleep to 30.893824ms
2024/11/18 03:57:55 DEBUG : pacer: Reducing sleep to 23.170368ms
2024/11/18 03:57:55 DEBUG : pacer: Reducing sleep to 17.377776ms
2024/11/18 03:57:56 DEBUG : pacer: Reducing sleep to 13.033332ms
2024/11/18 03:57:56 DEBUG : pacer: Reducing sleep to 10ms
--- FAIL: TestFixCase (73.47s)
=== RUN   TestSyncConcurrentTruncate
    run.go:180: Remote "Dropbox root 'rclone-test-sorozay0reva'", Local "Local file system at /tmp/rclone3760835199", Modify Window "1s"
2024/11/18 03:58:04 DEBUG : both0: Uploading chunk 1/1
2024/11/18 03:58:04 DEBUG : both0: Uploading chunk 2/1
2024/11/18 03:58:04 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both0" to batch
2024/11/18 03:58:05 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:05 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both0
2024/11/18 03:58:05 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both0
2024/11/18 03:58:06 DEBUG : only0: Uploading chunk 1/1
2024/11/18 03:58:06 DEBUG : only0: Uploading chunk 2/1
2024/11/18 03:58:06 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only0" to batch
2024/11/18 03:58:07 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:07 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only0
2024/11/18 03:58:08 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only0
2024/11/18 03:58:08 DEBUG : both1: Uploading chunk 1/1
2024/11/18 03:58:08 DEBUG : both1: Uploading chunk 2/1
2024/11/18 03:58:09 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both1" to batch
2024/11/18 03:58:09 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:09 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both1
2024/11/18 03:58:10 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both1
2024/11/18 03:58:10 DEBUG : only1: Uploading chunk 1/1
2024/11/18 03:58:11 DEBUG : only1: Uploading chunk 2/1
2024/11/18 03:58:11 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only1" to batch
2024/11/18 03:58:12 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:12 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only1
2024/11/18 03:58:13 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only1
2024/11/18 03:58:13 DEBUG : both2: Uploading chunk 1/1
2024/11/18 03:58:14 DEBUG : both2: Uploading chunk 2/1
2024/11/18 03:58:14 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both2" to batch
2024/11/18 03:58:15 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:15 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both2
2024/11/18 03:58:15 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both2
2024/11/18 03:58:16 DEBUG : only2: Uploading chunk 1/1
2024/11/18 03:58:16 DEBUG : only2: Uploading chunk 2/1
2024/11/18 03:58:17 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only2" to batch
2024/11/18 03:58:17 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:17 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only2
2024/11/18 03:58:18 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only2
2024/11/18 03:58:18 DEBUG : both3: Uploading chunk 1/1
2024/11/18 03:58:18 DEBUG : both3: Uploading chunk 2/1
2024/11/18 03:58:19 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both3" to batch
2024/11/18 03:58:19 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:19 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both3
2024/11/18 03:58:20 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both3
2024/11/18 03:58:20 DEBUG : only3: Uploading chunk 1/1
2024/11/18 03:58:21 DEBUG : only3: Uploading chunk 2/1
2024/11/18 03:58:21 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only3" to batch
2024/11/18 03:58:22 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:22 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only3
2024/11/18 03:58:23 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only3
2024/11/18 03:58:23 DEBUG : both4: Uploading chunk 1/1
2024/11/18 03:58:24 DEBUG : both4: Uploading chunk 2/1
2024/11/18 03:58:25 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both4" to batch
2024/11/18 03:58:26 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:26 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both4
2024/11/18 03:58:27 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both4
2024/11/18 03:58:27 DEBUG : only4: Uploading chunk 1/1
2024/11/18 03:58:27 DEBUG : only4: Uploading chunk 2/1
2024/11/18 03:58:28 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only4" to batch
2024/11/18 03:58:28 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:28 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only4
2024/11/18 03:58:29 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only4
2024/11/18 03:58:29 DEBUG : both5: Uploading chunk 1/1
2024/11/18 03:58:30 DEBUG : both5: Uploading chunk 2/1
2024/11/18 03:58:30 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both5" to batch
2024/11/18 03:58:31 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:31 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both5
2024/11/18 03:58:31 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both5
2024/11/18 03:58:32 DEBUG : only5: Uploading chunk 1/1
2024/11/18 03:58:32 DEBUG : only5: Uploading chunk 2/1
2024/11/18 03:58:32 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only5" to batch
2024/11/18 03:58:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only5
2024/11/18 03:58:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only5
2024/11/18 03:58:34 DEBUG : both6: Uploading chunk 1/1
2024/11/18 03:58:34 DEBUG : both6: Uploading chunk 2/1
2024/11/18 03:58:35 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both6" to batch
2024/11/18 03:58:35 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:35 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both6
2024/11/18 03:58:36 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both6
2024/11/18 03:58:36 DEBUG : only6: Uploading chunk 1/1
2024/11/18 03:58:36 DEBUG : only6: Uploading chunk 2/1
2024/11/18 03:58:37 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only6" to batch
2024/11/18 03:58:37 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:37 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only6
2024/11/18 03:58:38 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only6
2024/11/18 03:58:39 DEBUG : both7: Uploading chunk 1/1
2024/11/18 03:58:39 DEBUG : both7: Uploading chunk 2/1
2024/11/18 03:58:40 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both7" to batch
2024/11/18 03:58:40 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:40 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both7
2024/11/18 03:58:41 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both7
2024/11/18 03:58:41 DEBUG : only7: Uploading chunk 1/1
2024/11/18 03:58:41 DEBUG : only7: Uploading chunk 2/1
2024/11/18 03:58:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only7" to batch
2024/11/18 03:58:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only7
2024/11/18 03:58:44 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only7
2024/11/18 03:58:44 DEBUG : both8: Uploading chunk 1/1
2024/11/18 03:58:44 DEBUG : both8: Uploading chunk 2/1
2024/11/18 03:58:45 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both8" to batch
2024/11/18 03:58:45 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:45 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both8
2024/11/18 03:58:47 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both8
2024/11/18 03:58:47 DEBUG : only8: Uploading chunk 1/1
2024/11/18 03:58:48 DEBUG : only8: Uploading chunk 2/1
2024/11/18 03:58:48 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only8" to batch
2024/11/18 03:58:49 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:49 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only8
2024/11/18 03:58:49 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only8
2024/11/18 03:58:50 DEBUG : both9: Uploading chunk 1/1
2024/11/18 03:58:50 DEBUG : both9: Uploading chunk 2/1
2024/11/18 03:58:50 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both9" to batch
2024/11/18 03:58:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both9
2024/11/18 03:58:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both9
2024/11/18 03:58:52 DEBUG : only9: Uploading chunk 1/1
2024/11/18 03:58:52 DEBUG : only9: Uploading chunk 2/1
2024/11/18 03:58:53 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only9" to batch
2024/11/18 03:58:53 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:53 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only9
2024/11/18 03:58:54 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only9
2024/11/18 03:58:54 DEBUG : both10: Uploading chunk 1/1
2024/11/18 03:58:54 DEBUG : both10: Uploading chunk 2/1
2024/11/18 03:58:55 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both10" to batch
2024/11/18 03:58:55 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:55 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both10
2024/11/18 03:58:56 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both10
2024/11/18 03:58:57 DEBUG : only10: Uploading chunk 1/1
2024/11/18 03:58:57 DEBUG : only10: Uploading chunk 2/1
2024/11/18 03:58:57 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only10" to batch
2024/11/18 03:58:58 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:58:58 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only10
2024/11/18 03:58:59 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only10
2024/11/18 03:58:59 DEBUG : both11: Uploading chunk 1/1
2024/11/18 03:58:59 DEBUG : both11: Uploading chunk 2/1
2024/11/18 03:59:00 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both11" to batch
2024/11/18 03:59:00 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:00 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both11
2024/11/18 03:59:01 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both11
2024/11/18 03:59:01 DEBUG : only11: Uploading chunk 1/1
2024/11/18 03:59:02 DEBUG : only11: Uploading chunk 2/1
2024/11/18 03:59:02 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only11" to batch
2024/11/18 03:59:02 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:02 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only11
2024/11/18 03:59:03 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only11
2024/11/18 03:59:03 DEBUG : both12: Uploading chunk 1/1
2024/11/18 03:59:04 DEBUG : both12: Uploading chunk 2/1
2024/11/18 03:59:04 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both12" to batch
2024/11/18 03:59:05 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:05 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both12
2024/11/18 03:59:05 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both12
2024/11/18 03:59:06 DEBUG : only12: Uploading chunk 1/1
2024/11/18 03:59:06 DEBUG : only12: Uploading chunk 2/1
2024/11/18 03:59:06 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only12" to batch
2024/11/18 03:59:07 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:07 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only12
2024/11/18 03:59:08 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only12
2024/11/18 03:59:08 DEBUG : both13: Uploading chunk 1/1
2024/11/18 03:59:08 DEBUG : both13: Uploading chunk 2/1
2024/11/18 03:59:09 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both13" to batch
2024/11/18 03:59:09 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:09 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both13
2024/11/18 03:59:10 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both13
2024/11/18 03:59:10 DEBUG : only13: Uploading chunk 1/1
2024/11/18 03:59:10 DEBUG : only13: Uploading chunk 2/1
2024/11/18 03:59:11 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only13" to batch
2024/11/18 03:59:11 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:11 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only13
2024/11/18 03:59:12 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only13
2024/11/18 03:59:12 DEBUG : both14: Uploading chunk 1/1
2024/11/18 03:59:12 DEBUG : both14: Uploading chunk 2/1
2024/11/18 03:59:13 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both14" to batch
2024/11/18 03:59:14 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:14 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both14
2024/11/18 03:59:14 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both14
2024/11/18 03:59:15 DEBUG : only14: Uploading chunk 1/1
2024/11/18 03:59:15 DEBUG : only14: Uploading chunk 2/1
2024/11/18 03:59:15 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only14" to batch
2024/11/18 03:59:16 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:16 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only14
2024/11/18 03:59:17 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only14
2024/11/18 03:59:17 DEBUG : both15: Uploading chunk 1/1
2024/11/18 03:59:17 DEBUG : both15: Uploading chunk 2/1
2024/11/18 03:59:18 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both15" to batch
2024/11/18 03:59:18 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:18 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both15
2024/11/18 03:59:20 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both15
2024/11/18 03:59:20 DEBUG : only15: Uploading chunk 1/1
2024/11/18 03:59:20 DEBUG : only15: Uploading chunk 2/1
2024/11/18 03:59:21 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only15" to batch
2024/11/18 03:59:21 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:21 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only15
2024/11/18 03:59:22 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only15
2024/11/18 03:59:22 DEBUG : both16: Uploading chunk 1/1
2024/11/18 03:59:23 DEBUG : both16: Uploading chunk 2/1
2024/11/18 03:59:23 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both16" to batch
2024/11/18 03:59:24 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:24 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both16
2024/11/18 03:59:24 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both16
2024/11/18 03:59:24 DEBUG : only16: Uploading chunk 1/1
2024/11/18 03:59:25 DEBUG : only16: Uploading chunk 2/1
2024/11/18 03:59:25 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only16" to batch
2024/11/18 03:59:26 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:26 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only16
2024/11/18 03:59:26 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only16
2024/11/18 03:59:27 DEBUG : both17: Uploading chunk 1/1
2024/11/18 03:59:27 DEBUG : both17: Uploading chunk 2/1
2024/11/18 03:59:27 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both17" to batch
2024/11/18 03:59:28 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:28 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both17
2024/11/18 03:59:29 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both17
2024/11/18 03:59:29 DEBUG : only17: Uploading chunk 1/1
2024/11/18 03:59:30 DEBUG : only17: Uploading chunk 2/1
2024/11/18 03:59:30 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only17" to batch
2024/11/18 03:59:31 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:31 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only17
2024/11/18 03:59:32 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only17
2024/11/18 03:59:32 DEBUG : both18: Uploading chunk 1/1
2024/11/18 03:59:32 DEBUG : both18: Uploading chunk 2/1
2024/11/18 03:59:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both18" to batch
2024/11/18 03:59:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:33 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both18
2024/11/18 03:59:34 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both18
2024/11/18 03:59:34 DEBUG : only18: Uploading chunk 1/1
2024/11/18 03:59:35 DEBUG : only18: Uploading chunk 2/1
2024/11/18 03:59:35 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only18" to batch
2024/11/18 03:59:36 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:36 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only18
2024/11/18 03:59:36 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only18
2024/11/18 03:59:36 DEBUG : both19: Uploading chunk 1/1
2024/11/18 03:59:37 DEBUG : both19: Uploading chunk 2/1
2024/11/18 03:59:37 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "both19" to batch
2024/11/18 03:59:38 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:38 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: both19
2024/11/18 03:59:38 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: both19
2024/11/18 03:59:39 DEBUG : only19: Uploading chunk 1/1
2024/11/18 03:59:39 DEBUG : only19: Uploading chunk 2/1
2024/11/18 03:59:39 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only19" to batch
2024/11/18 03:59:40 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Batch idle for 500ms so committing
2024/11/18 03:59:40 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 1 starting with: only19
2024/11/18 03:59:40 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 1 starting with: only19
2024/11/18 03:59:41 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both0: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both1: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both10: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both11: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both12: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both13: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both14: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both15: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both16: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both17: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both18: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both19: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both2: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both3: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both4: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both5: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both6: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both7: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both8: Unchanged skipping
2024/11/18 03:59:41 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/18 03:59:41 DEBUG : both9: Unchanged skipping
2024/11/18 03:59:41 DEBUG : only0: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only1: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only10: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only11: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only12: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only13: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only14: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only15: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only16: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only17: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only18: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only19: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only2: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only3: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only4: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only5: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only6: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only7: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only8: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : only9: Sizes differ (src 0 vs dst 6)
2024/11/18 03:59:41 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Waiting for checks to finish
2024/11/18 03:59:41 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Waiting for transfers to finish
2024/11/18 03:59:41 DEBUG : only0: Uploading chunk 1/0
2024/11/18 03:59:41 DEBUG : only10: Uploading chunk 1/0
2024/11/18 03:59:41 DEBUG : only1: Uploading chunk 1/0
2024/11/18 03:59:41 DEBUG : only11: Uploading chunk 1/0
2024/11/18 03:59:42 DEBUG : only0: Uploading chunk 2/0
2024/11/18 03:59:42 DEBUG : only10: Uploading chunk 2/0
2024/11/18 03:59:42 DEBUG : only1: Uploading chunk 2/0
2024/11/18 03:59:42 DEBUG : only11: Uploading chunk 2/0
2024/11/18 03:59:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only0" to batch
2024/11/18 03:59:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only1" to batch
2024/11/18 03:59:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only10" to batch
2024/11/18 03:59:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only11" to batch
2024/11/18 03:59:42 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 4 starting with: only0
2024/11/18 03:59:43 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 4 starting with: only0
2024/11/18 03:59:43 DEBUG : only11: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:43 INFO  : only11: Copied (replaced existing)
2024/11/18 03:59:43 DEBUG : only0: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:43 INFO  : only0: Copied (replaced existing)
2024/11/18 03:59:43 DEBUG : only1: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:43 INFO  : only1: Copied (replaced existing)
2024/11/18 03:59:43 DEBUG : only10: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:43 INFO  : only10: Copied (replaced existing)
2024/11/18 03:59:43 DEBUG : only14: Uploading chunk 1/0
2024/11/18 03:59:43 DEBUG : only12: Uploading chunk 1/0
2024/11/18 03:59:43 DEBUG : only13: Uploading chunk 1/0
2024/11/18 03:59:43 DEBUG : only15: Uploading chunk 1/0
2024/11/18 03:59:44 DEBUG : only14: Uploading chunk 2/0
2024/11/18 03:59:44 DEBUG : only15: Uploading chunk 2/0
2024/11/18 03:59:44 DEBUG : only13: Uploading chunk 2/0
2024/11/18 03:59:44 DEBUG : only12: Uploading chunk 2/0
2024/11/18 03:59:44 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only15" to batch
2024/11/18 03:59:44 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only14" to batch
2024/11/18 03:59:44 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only12" to batch
2024/11/18 03:59:44 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only13" to batch
2024/11/18 03:59:44 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 4 starting with: only15
2024/11/18 03:59:45 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 4 starting with: only15
2024/11/18 03:59:45 DEBUG : only13: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:45 INFO  : only13: Copied (replaced existing)
2024/11/18 03:59:45 DEBUG : only15: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:45 INFO  : only15: Copied (replaced existing)
2024/11/18 03:59:45 DEBUG : only14: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:45 INFO  : only14: Copied (replaced existing)
2024/11/18 03:59:45 DEBUG : only12: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:45 INFO  : only12: Copied (replaced existing)
2024/11/18 03:59:45 DEBUG : only16: Uploading chunk 1/0
2024/11/18 03:59:45 DEBUG : only18: Uploading chunk 1/0
2024/11/18 03:59:45 DEBUG : only16: Uploading chunk 2/0
2024/11/18 03:59:45 DEBUG : only19: Uploading chunk 1/0
2024/11/18 03:59:45 DEBUG : only17: Uploading chunk 1/0
2024/11/18 03:59:45 DEBUG : only18: Uploading chunk 2/0
2024/11/18 03:59:46 DEBUG : only17: Uploading chunk 2/0
2024/11/18 03:59:46 DEBUG : only19: Uploading chunk 2/0
2024/11/18 03:59:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only16" to batch
2024/11/18 03:59:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only18" to batch
2024/11/18 03:59:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only17" to batch
2024/11/18 03:59:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only19" to batch
2024/11/18 03:59:46 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 4 starting with: only16
2024/11/18 03:59:47 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 4 starting with: only16
2024/11/18 03:59:47 DEBUG : only18: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:47 INFO  : only18: Copied (replaced existing)
2024/11/18 03:59:47 DEBUG : only19: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:47 INFO  : only19: Copied (replaced existing)
2024/11/18 03:59:47 DEBUG : only16: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:47 INFO  : only16: Copied (replaced existing)
2024/11/18 03:59:47 DEBUG : only17: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:47 INFO  : only17: Copied (replaced existing)
2024/11/18 03:59:48 DEBUG : only4: Uploading chunk 1/0
2024/11/18 03:59:48 DEBUG : only2: Uploading chunk 1/0
2024/11/18 03:59:48 DEBUG : only3: Uploading chunk 1/0
2024/11/18 03:59:48 DEBUG : only5: Uploading chunk 1/0
2024/11/18 03:59:48 DEBUG : only4: Uploading chunk 2/0
2024/11/18 03:59:48 DEBUG : only3: Uploading chunk 2/0
2024/11/18 03:59:48 DEBUG : only2: Uploading chunk 2/0
2024/11/18 03:59:48 DEBUG : only5: Uploading chunk 2/0
2024/11/18 03:59:48 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only4" to batch
2024/11/18 03:59:48 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only2" to batch
2024/11/18 03:59:48 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only3" to batch
2024/11/18 03:59:48 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only5" to batch
2024/11/18 03:59:48 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 4 starting with: only4
2024/11/18 03:59:50 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 4 starting with: only4
2024/11/18 03:59:50 DEBUG : only5: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:50 INFO  : only5: Copied (replaced existing)
2024/11/18 03:59:50 DEBUG : only4: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:50 INFO  : only4: Copied (replaced existing)
2024/11/18 03:59:50 DEBUG : only2: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:50 INFO  : only2: Copied (replaced existing)
2024/11/18 03:59:50 DEBUG : only3: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:50 INFO  : only3: Copied (replaced existing)
2024/11/18 03:59:50 DEBUG : only8: Uploading chunk 1/0
2024/11/18 03:59:50 DEBUG : only6: Uploading chunk 1/0
2024/11/18 03:59:50 DEBUG : only7: Uploading chunk 1/0
2024/11/18 03:59:50 DEBUG : only9: Uploading chunk 1/0
2024/11/18 03:59:50 DEBUG : only8: Uploading chunk 2/0
2024/11/18 03:59:50 DEBUG : only7: Uploading chunk 2/0
2024/11/18 03:59:50 DEBUG : only6: Uploading chunk 2/0
2024/11/18 03:59:50 DEBUG : only9: Uploading chunk 2/0
2024/11/18 03:59:50 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only8" to batch
2024/11/18 03:59:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only6" to batch
2024/11/18 03:59:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only7" to batch
2024/11/18 03:59:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Adding "only9" to batch
2024/11/18 03:59:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committing sync batch length 4 starting with: only8
2024/11/18 03:59:51 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Committed sync batch length 4 starting with: only8
2024/11/18 03:59:51 DEBUG : only9: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:51 INFO  : only9: Copied (replaced existing)
2024/11/18 03:59:51 DEBUG : only8: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:51 INFO  : only8: Copied (replaced existing)
2024/11/18 03:59:51 DEBUG : only6: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:51 INFO  : only6: Copied (replaced existing)
2024/11/18 03:59:51 DEBUG : only7: dropbox = e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855 OK
2024/11/18 03:59:51 INFO  : only7: Copied (replaced existing)
2024/11/18 03:59:51 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "Dropbox root 'rclone-test-sorozay0reva'", Local "Local file system at /tmp/rclone3760835199", Modify Window "1s"
--- PASS: TestSyncConcurrentTruncate (138.63s)
FAIL
2024/11/18 04:00:22 DEBUG : Dropbox root 'rclone-test-sorozay0reva': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestFixCase|TestSyncConcurrentTruncate)$'" - Finished ERROR in 3m33.48974934s (try 2/5): exit status 1: Failed [TestFixCase]