"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestCheckSumDownload$'" - Starting (try 3/5)
2026/02/16 04:58:09 DEBUG : Creating backend with remote "TestDropbox:rclone-test-vahupoq1yaxu"
2026/02/16 04:58:09 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/16 04:58:10 DEBUG : Creating backend with remote "/tmp/rclone1880606907"
=== RUN   TestCheckSumDownload
    run.go:185: Remote "Dropbox root 'rclone-test-vahupoq1yaxu'", Local "Local file system at /tmp/rclone1880606907", Modify Window "1s"
2026/02/16 04:58:10 DEBUG : Creating backend with remote "TestDropbox:rclone-test-vahupoq1yaxu/data"
2026/02/16 04:58:11 DEBUG : data/banana: Uploading chunk 1/1
2026/02/16 04:58:12 DEBUG : data/banana: Uploading chunk 2/1
2026/02/16 04:58:12 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "data/banana" to batch
2026/02/16 04:58:13 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:13 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: data/banana
2026/02/16 04:58:13 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: data/banana
2026/02/16 04:58:14 DEBUG : test.sum: Uploading chunk 1/1
2026/02/16 04:58:14 DEBUG : test.sum: Uploading chunk 2/1
2026/02/16 04:58:15 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "test.sum" to batch
2026/02/16 04:58:15 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:15 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: test.sum
2026/02/16 04:58:16 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest1
2026/02/16 04:58:19 DEBUG : data/potato: Uploading chunk 1/1
2026/02/16 04:58:19 DEBUG : data/potato: Uploading chunk 2/1
2026/02/16 04:58:20 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "data/potato" to batch
2026/02/16 04:58:21 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:21 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: data/potato
2026/02/16 04:58:21 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: data/potato
2026/02/16 04:58:22 DEBUG : test.sum: Uploading chunk 1/1
2026/02/16 04:58:22 DEBUG : test.sum: Uploading chunk 2/1
2026/02/16 04:58:23 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "test.sum" to batch
2026/02/16 04:58:23 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:23 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: test.sum
2026/02/16 04:58:24 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest2
2026/02/16 04:58:27 DEBUG : test.sum: Uploading chunk 1/1
2026/02/16 04:58:27 DEBUG : test.sum: Uploading chunk 2/1
2026/02/16 04:58:28 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "test.sum" to batch
2026/02/16 04:58:29 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:29 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: test.sum
2026/02/16 04:58:29 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest3
2026/02/16 04:58:32 DEBUG : test.sum: Uploading chunk 1/1
2026/02/16 04:58:33 DEBUG : test.sum: Uploading chunk 2/1
2026/02/16 04:58:33 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "test.sum" to batch
2026/02/16 04:58:34 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:34 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: test.sum
2026/02/16 04:58:34 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest4
2026/02/16 04:58:37 DEBUG : test.sum: Uploading chunk 1/1
2026/02/16 04:58:38 DEBUG : test.sum: Uploading chunk 2/1
2026/02/16 04:58:38 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "test.sum" to batch
2026/02/16 04:58:39 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:39 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: test.sum
2026/02/16 04:58:40 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest5
2026/02/16 04:58:43 DEBUG : test.sum: Uploading chunk 1/1
2026/02/16 04:58:43 DEBUG : test.sum: Uploading chunk 2/1
2026/02/16 04:58:44 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "test.sum" to batch
2026/02/16 04:58:44 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:44 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: test.sum
2026/02/16 04:58:45 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest6
2026/02/16 04:58:48 DEBUG : data/banana: Uploading chunk 1/1
2026/02/16 04:58:48 DEBUG : data/banana: Uploading chunk 2/1
2026/02/16 04:58:49 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "data/banana" to batch
2026/02/16 04:58:49 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:49 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: data/banana
2026/02/16 04:58:50 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: data/banana
2026/02/16 04:58:50 DEBUG : data/potato: Uploading chunk 1/1
2026/02/16 04:58:51 DEBUG : data/potato: Uploading chunk 2/1
2026/02/16 04:58:51 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "data/potato" to batch
2026/02/16 04:58:52 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:52 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: data/potato
2026/02/16 04:58:52 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: data/potato
2026/02/16 04:58:52 DEBUG : test.sum: Uploading chunk 1/1
2026/02/16 04:58:53 DEBUG : test.sum: Uploading chunk 2/1
2026/02/16 04:58:53 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Adding "test.sum" to batch
2026/02/16 04:58:54 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Batch idle for 500ms so committing
2026/02/16 04:58:54 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committing sync batch length 1 starting with: test.sum
2026/02/16 04:58:55 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (50.91s)
    --- PASS: TestCheckSumDownload/subtest1 (2.26s)
    --- PASS: TestCheckSumDownload/subtest2 (2.13s)
    --- PASS: TestCheckSumDownload/subtest3 (1.85s)
    --- PASS: TestCheckSumDownload/subtest4 (1.86s)
    --- PASS: TestCheckSumDownload/subtest5 (2.05s)
    --- PASS: TestCheckSumDownload/subtest6 (2.02s)
    --- PASS: TestCheckSumDownload/subtest7 (1.87s)
PASS
2026/02/16 04:59:01 DEBUG : Dropbox root 'rclone-test-vahupoq1yaxu': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestCheckSumDownload$'" - Finished OK in 51.841812695s (try 3/5)