"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestDirMove|TestMaxDelete|TestMaxDeleteSizeLargeFile|TestParseSumFile|TestStatJSON)$'" - Starting (try 2/5) 2025/07/09 04:33:21 DEBUG : Creating backend with remote "TestDropbox:rclone-test-facemiv7tito" 2025/07/09 04:33:21 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/09 04:33:21 DEBUG : Creating backend with remote "/tmp/rclone1806555472" === RUN TestParseSumFile run.go:180: Remote "Dropbox root 'rclone-test-facemiv7tito'", Local "Local file system at /tmp/rclone1806555472", Modify Window "1s" 2025/07/09 04:33:22 DEBUG : test.sum: Uploading chunk 1/1 2025/07/09 04:33:23 DEBUG : test.sum: Uploading chunk 2/1 2025/07/09 04:33:23 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "test.sum" to batch 2025/07/09 04:33:24 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:24 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: test.sum 2025/07/09 04:33:25 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: test.sum 2025/07/09 04:33:25 NOTICE: test.sum: improperly formatted checksum line 4 2025/07/09 04:33:25 NOTICE: test.sum: improperly formatted checksum line 5 2025/07/09 04:33:25 NOTICE: test.sum: improperly formatted checksum line 6 2025/07/09 04:33:25 NOTICE: test.sum: 2 warning(s) suppressed... 2025/07/09 04:33:25 DEBUG : test.sum: Uploading chunk 1/1 2025/07/09 04:33:26 DEBUG : test.sum: Uploading chunk 2/1 2025/07/09 04:33:26 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "test.sum" to batch 2025/07/09 04:33:27 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:27 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: test.sum 2025/07/09 04:33:27 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: test.sum 2025/07/09 04:33:28 NOTICE: test.sum: improperly formatted checksum line 4 2025/07/09 04:33:28 NOTICE: test.sum: improperly formatted checksum line 5 2025/07/09 04:33:28 NOTICE: test.sum: improperly formatted checksum line 6 2025/07/09 04:33:28 NOTICE: test.sum: 2 warning(s) suppressed... --- PASS: TestParseSumFile (7.69s) === RUN TestStatJSON run.go:180: Remote "Dropbox root 'rclone-test-facemiv7tito'", Local "Local file system at /tmp/rclone1806555472", Modify Window "1s" 2025/07/09 04:33:29 DEBUG : file1: Uploading chunk 1/1 2025/07/09 04:33:30 DEBUG : file1: Uploading chunk 2/1 2025/07/09 04:33:31 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "file1" to batch 2025/07/09 04:33:31 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:31 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: file1 2025/07/09 04:33:32 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: file1 2025/07/09 04:33:32 DEBUG : sub/file2: Uploading chunk 1/1 2025/07/09 04:33:32 DEBUG : sub/file2: Uploading chunk 2/1 2025/07/09 04:33:33 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "sub/file2" to batch 2025/07/09 04:33:33 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:33 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: sub/file2 2025/07/09 04:33:34 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: sub/file2 === RUN TestStatJSON/Root === RUN TestStatJSON/RootFilesOnly === RUN TestStatJSON/RootDirsOnly === RUN TestStatJSON/Dir === RUN TestStatJSON/DirWithTrailingSlash === RUN TestStatJSON/File === RUN TestStatJSON/NotFound === RUN TestStatJSON/DirFilesOnly === RUN TestStatJSON/FileFilesOnly === RUN TestStatJSON/NotFoundFilesOnly === RUN TestStatJSON/DirDirsOnly === RUN TestStatJSON/FileDirsOnly === RUN TestStatJSON/NotFoundDirsOnly === RUN TestStatJSON/RootNotFound 2025/07/09 04:33:37 DEBUG : Creating backend with remote "TestDropbox:rclone-test-facemiv7tito/notfound" --- PASS: TestStatJSON (11.34s) --- PASS: TestStatJSON/Root (0.21s) --- PASS: TestStatJSON/RootFilesOnly (0.00s) --- PASS: TestStatJSON/RootDirsOnly (0.22s) --- PASS: TestStatJSON/Dir (0.45s) --- PASS: TestStatJSON/DirWithTrailingSlash (0.23s) --- PASS: TestStatJSON/File (0.20s) --- PASS: TestStatJSON/NotFound (0.43s) --- PASS: TestStatJSON/DirFilesOnly (0.20s) --- PASS: TestStatJSON/FileFilesOnly (0.19s) --- PASS: TestStatJSON/NotFoundFilesOnly (0.19s) --- PASS: TestStatJSON/DirDirsOnly (0.22s) --- PASS: TestStatJSON/FileDirsOnly (0.28s) --- PASS: TestStatJSON/NotFoundDirsOnly (0.22s) --- PASS: TestStatJSON/RootNotFound (0.44s) === RUN TestMaxDelete run.go:180: Remote "Dropbox root 'rclone-test-facemiv7tito'", Local "Local file system at /tmp/rclone1806555472", Modify Window "1s" 2025/07/09 04:33:41 DEBUG : small: Uploading chunk 1/1 2025/07/09 04:33:41 DEBUG : small: Uploading chunk 2/1 2025/07/09 04:33:42 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "small" to batch 2025/07/09 04:33:42 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:42 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: small 2025/07/09 04:33:43 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: small 2025/07/09 04:33:43 DEBUG : medium: Uploading chunk 1/1 2025/07/09 04:33:44 DEBUG : medium: Uploading chunk 2/1 2025/07/09 04:33:44 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "medium" to batch 2025/07/09 04:33:45 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:45 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: medium 2025/07/09 04:33:46 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: medium 2025/07/09 04:33:46 DEBUG : large: Uploading chunk 1/1 2025/07/09 04:33:46 DEBUG : large: Uploading chunk 2/1 2025/07/09 04:33:47 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "large" to batch 2025/07/09 04:33:47 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:47 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: large 2025/07/09 04:33:48 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: large 2025/07/09 04:33:48 DEBUG : Waiting for deletions to finish 2025/07/09 04:33:48 ERROR : medium: Got fatal error on delete: --max-delete threshold reached 2025/07/09 04:33:49 INFO : large: Deleted 2025/07/09 04:33:49 INFO : small: Deleted --- PASS: TestMaxDelete (10.24s) === RUN TestMaxDeleteSizeLargeFile run.go:180: Remote "Dropbox root 'rclone-test-facemiv7tito'", Local "Local file system at /tmp/rclone1806555472", Modify Window "1s" 2025/07/09 04:33:51 DEBUG : small: Uploading chunk 1/1 2025/07/09 04:33:51 DEBUG : small: Uploading chunk 2/1 2025/07/09 04:33:52 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "small" to batch 2025/07/09 04:33:52 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:52 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: small 2025/07/09 04:33:56 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: small 2025/07/09 04:33:57 DEBUG : medium: Uploading chunk 1/1 2025/07/09 04:33:57 DEBUG : medium: Uploading chunk 2/1 2025/07/09 04:33:58 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "medium" to batch 2025/07/09 04:33:58 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:33:58 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: medium 2025/07/09 04:33:59 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: medium 2025/07/09 04:33:59 DEBUG : large: Uploading chunk 1/1 2025/07/09 04:33:59 DEBUG : large: Uploading chunk 2/1 2025/07/09 04:34:00 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "large" to batch 2025/07/09 04:34:00 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:34:00 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: large 2025/07/09 04:34:01 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: large 2025/07/09 04:34:01 DEBUG : Waiting for deletions to finish 2025/07/09 04:34:02 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached 2025/07/09 04:34:02 INFO : medium: Deleted 2025/07/09 04:34:02 INFO : small: Deleted --- PASS: TestMaxDeleteSizeLargeFile (13.39s) === RUN TestDirMove run.go:180: Remote "Dropbox root 'rclone-test-facemiv7tito'", Local "Local file system at /tmp/rclone1806555472", Modify Window "1s" 2025/07/09 04:34:05 DEBUG : A1/one: Uploading chunk 1/1 2025/07/09 04:34:05 DEBUG : A1/one: Uploading chunk 2/1 2025/07/09 04:34:05 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "A1/one" to batch 2025/07/09 04:34:06 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:34:06 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: A1/one 2025/07/09 04:34:07 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: A1/one 2025/07/09 04:34:08 DEBUG : A1/two: Uploading chunk 1/1 2025/07/09 04:34:08 DEBUG : A1/two: Uploading chunk 2/1 2025/07/09 04:34:08 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "A1/two" to batch 2025/07/09 04:34:09 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:34:09 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: A1/two 2025/07/09 04:34:10 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committed sync batch length 1 starting with: A1/two 2025/07/09 04:34:10 DEBUG : A1/B1/three: Uploading chunk 1/1 2025/07/09 04:34:10 DEBUG : A1/B1/three: Uploading chunk 2/1 2025/07/09 04:34:11 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Adding "A1/B1/three" to batch 2025/07/09 04:34:11 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Batch idle for 500ms so committing 2025/07/09 04:34:11 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Committing sync batch length 1 starting with: A1/B1/three 2025/07/09 04:34:15 ERROR : Dropbox root 'rclone-test-facemiv7tito': sync batch commit: failed to commit batch length 1: batch had 1 errors: last error: upload failed: too_many_write_operations run.go:285: Failed to put "A1/B1/three" to "Dropbox root 'rclone-test-facemiv7tito'": upload failed: batch upload failed: upload failed: too_many_write_operations --- FAIL: TestDirMove (14.10s) FAIL 2025/07/09 04:34:18 DEBUG : Dropbox root 'rclone-test-facemiv7tito': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestDirMove|TestMaxDelete|TestMaxDeleteSizeLargeFile|TestParseSumFile|TestStatJSON)$'" - Finished ERROR in 57.971147525s (try 2/5): exit status 1: Failed [TestDirMove]