"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestCheckSumDownload$'" - Starting (try 3/5)
2025/01/20 01:54:36 DEBUG : Creating backend with remote "TestDropbox:rclone-test-vitudiq1cusi"
2025/01/20 01:54:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/20 01:54:37 DEBUG : Creating backend with remote "/tmp/rclone1976176986"
=== RUN   TestCheckSumDownload
    run.go:180: Remote "Dropbox root 'rclone-test-vitudiq1cusi'", Local "Local file system at /tmp/rclone1976176986", Modify Window "1s"
2025/01/20 01:54:37 DEBUG : Creating backend with remote "TestDropbox:rclone-test-vitudiq1cusi/data"
2025/01/20 01:54:39 DEBUG : data/banana: Uploading chunk 1/1
2025/01/20 01:54:39 DEBUG : data/banana: Uploading chunk 2/1
2025/01/20 01:54:40 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "data/banana" to batch
2025/01/20 01:54:40 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:54:40 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: data/banana
2025/01/20 01:54:41 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: data/banana
2025/01/20 01:54:41 DEBUG : test.sum: Uploading chunk 1/1
2025/01/20 01:54:42 DEBUG : test.sum: Uploading chunk 2/1
2025/01/20 01:54:42 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "test.sum" to batch
2025/01/20 01:54:43 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:54:43 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: test.sum
2025/01/20 01:54:43 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest1
2025/01/20 01:54:47 DEBUG : data/potato: Uploading chunk 1/1
2025/01/20 01:54:48 DEBUG : data/potato: Uploading chunk 2/1
2025/01/20 01:54:49 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "data/potato" to batch
2025/01/20 01:54:49 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:54:49 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: data/potato
2025/01/20 01:54:50 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: data/potato
2025/01/20 01:54:50 DEBUG : test.sum: Uploading chunk 1/1
2025/01/20 01:54:51 DEBUG : test.sum: Uploading chunk 2/1
2025/01/20 01:54:51 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "test.sum" to batch
2025/01/20 01:54:52 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:54:52 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: test.sum
2025/01/20 01:54:52 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest2
2025/01/20 01:54:56 DEBUG : test.sum: Uploading chunk 1/1
2025/01/20 01:54:57 DEBUG : test.sum: Uploading chunk 2/1
2025/01/20 01:54:57 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "test.sum" to batch
2025/01/20 01:54:58 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:54:58 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: test.sum
2025/01/20 01:54:59 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest3
2025/01/20 01:55:04 DEBUG : test.sum: Uploading chunk 1/1
2025/01/20 01:55:04 DEBUG : test.sum: Uploading chunk 2/1
2025/01/20 01:55:05 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "test.sum" to batch
2025/01/20 01:55:05 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:55:05 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: test.sum
2025/01/20 01:55:06 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest4
2025/01/20 01:55:11 DEBUG : test.sum: Uploading chunk 1/1
2025/01/20 01:55:11 DEBUG : test.sum: Uploading chunk 2/1
2025/01/20 01:55:12 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "test.sum" to batch
2025/01/20 01:55:13 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:55:13 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: test.sum
2025/01/20 01:55:13 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest5
2025/01/20 01:55:17 DEBUG : test.sum: Uploading chunk 1/1
2025/01/20 01:55:18 DEBUG : test.sum: Uploading chunk 2/1
2025/01/20 01:55:18 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "test.sum" to batch
2025/01/20 01:55:19 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:55:19 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: test.sum
2025/01/20 01:55:20 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest6
2025/01/20 01:55:24 DEBUG : data/banana: Uploading chunk 1/1
2025/01/20 01:55:25 DEBUG : data/banana: Uploading chunk 2/1
2025/01/20 01:55:25 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "data/banana" to batch
2025/01/20 01:55:26 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:55:26 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: data/banana
2025/01/20 01:55:26 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: data/banana
2025/01/20 01:55:26 DEBUG : data/potato: Uploading chunk 1/1
2025/01/20 01:55:27 DEBUG : data/potato: Uploading chunk 2/1
2025/01/20 01:55:28 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "data/potato" to batch
2025/01/20 01:55:28 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:55:28 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: data/potato
2025/01/20 01:55:29 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: data/potato
2025/01/20 01:55:29 DEBUG : test.sum: Uploading chunk 1/1
2025/01/20 01:55:30 DEBUG : test.sum: Uploading chunk 2/1
2025/01/20 01:55:30 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Adding "test.sum" to batch
2025/01/20 01:55:31 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Batch idle for 500ms so committing
2025/01/20 01:55:31 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committing sync batch length 1 starting with: test.sum
2025/01/20 01:55:31 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (63.45s)
    --- PASS: TestCheckSumDownload/subtest1 (3.03s)
    --- PASS: TestCheckSumDownload/subtest2 (2.98s)
    --- PASS: TestCheckSumDownload/subtest3 (4.01s)
    --- PASS: TestCheckSumDownload/subtest4 (3.89s)
    --- PASS: TestCheckSumDownload/subtest5 (2.75s)
    --- PASS: TestCheckSumDownload/subtest6 (3.26s)
    --- PASS: TestCheckSumDownload/subtest7 (3.81s)
PASS
2025/01/20 01:55:40 DEBUG : Dropbox root 'rclone-test-vitudiq1cusi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestCheckSumDownload$'" - Finished OK in 1m4.489227423s (try 3/5)