"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestCheckDownload|TestCheckSumDownload|TestListDirSorted|TestListDirSortedFn)$'" - Starting (try 2/5)
2025/09/25 04:24:41 DEBUG : Creating backend with remote "TestDropbox:rclone-test-yopaxun5lusi"
2025/09/25 04:24:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/09/25 04:24:42 DEBUG : Creating backend with remote "/tmp/rclone689497139"
=== RUN   TestCheckDownload
    run.go:180: Remote "Dropbox root 'rclone-test-yopaxun5lusi'", Local "Local file system at /tmp/rclone689497139", Modify Window "1s"
2025/09/25 04:24:44 DEBUG : rutabaga: Uploading chunk 1/1
2025/09/25 04:24:44 DEBUG : rutabaga: Uploading chunk 2/1
2025/09/25 04:24:45 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "rutabaga" to batch
2025/09/25 04:24:45 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:24:45 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: rutabaga
2025/09/25 04:24:46 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: rutabaga
=== RUN   TestCheckDownload/1
=== RUN   TestCheckDownload/2
2025/09/25 04:24:48 DEBUG : empty space: Uploading chunk 1/1
2025/09/25 04:24:48 DEBUG : empty space: Uploading chunk 2/1
2025/09/25 04:24:49 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "empty space" to batch
2025/09/25 04:24:49 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:24:49 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: empty space
2025/09/25 04:24:50 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: empty space
=== RUN   TestCheckDownload/3
2025/09/25 04:24:51 DEBUG : potato2: Uploading chunk 1/1
2025/09/25 04:24:52 DEBUG : potato2: Uploading chunk 2/1
2025/09/25 04:24:52 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "potato2" to batch
2025/09/25 04:24:52 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:24:52 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: potato2
2025/09/25 04:24:53 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: potato2
=== RUN   TestCheckDownload/4
=== RUN   TestCheckDownload/5
2025/09/25 04:24:55 DEBUG : remotepotato: Uploading chunk 1/1
2025/09/25 04:24:56 DEBUG : remotepotato: Uploading chunk 2/1
2025/09/25 04:24:56 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "remotepotato" to batch
2025/09/25 04:24:57 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:24:57 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: remotepotato
2025/09/25 04:24:57 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: remotepotato
=== RUN   TestCheckDownload/6
=== RUN   TestCheckDownload/7
--- PASS: TestCheckDownload (20.50s)
    --- PASS: TestCheckDownload/1 (0.85s)
    --- PASS: TestCheckDownload/2 (0.81s)
    --- PASS: TestCheckDownload/3 (0.81s)
    --- PASS: TestCheckDownload/4 (0.88s)
    --- PASS: TestCheckDownload/5 (0.78s)
    --- PASS: TestCheckDownload/6 (1.09s)
    --- PASS: TestCheckDownload/7 (0.85s)
=== RUN   TestCheckSumDownload
    run.go:180: Remote "Dropbox root 'rclone-test-yopaxun5lusi'", Local "Local file system at /tmp/rclone689497139", Modify Window "1s"
2025/09/25 04:25:02 DEBUG : Creating backend with remote "TestDropbox:rclone-test-yopaxun5lusi/data"
2025/09/25 04:25:03 DEBUG : data/banana: Uploading chunk 1/1
2025/09/25 04:25:03 DEBUG : data/banana: Uploading chunk 2/1
2025/09/25 04:25:04 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "data/banana" to batch
2025/09/25 04:25:04 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:04 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: data/banana
2025/09/25 04:25:05 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: data/banana
2025/09/25 04:25:05 DEBUG : test.sum: Uploading chunk 1/1
2025/09/25 04:25:06 DEBUG : test.sum: Uploading chunk 2/1
2025/09/25 04:25:06 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "test.sum" to batch
2025/09/25 04:25:06 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:06 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: test.sum
2025/09/25 04:25:07 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest1
2025/09/25 04:25:09 DEBUG : data/potato: Uploading chunk 1/1
2025/09/25 04:25:09 DEBUG : data/potato: Uploading chunk 2/1
2025/09/25 04:25:10 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "data/potato" to batch
2025/09/25 04:25:10 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:10 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: data/potato
2025/09/25 04:25:11 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: data/potato
2025/09/25 04:25:11 DEBUG : test.sum: Uploading chunk 1/1
2025/09/25 04:25:12 DEBUG : test.sum: Uploading chunk 2/1
2025/09/25 04:25:12 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "test.sum" to batch
2025/09/25 04:25:12 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:12 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: test.sum
2025/09/25 04:25:13 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest2
2025/09/25 04:25:15 DEBUG : test.sum: Uploading chunk 1/1
2025/09/25 04:25:15 DEBUG : test.sum: Uploading chunk 2/1
2025/09/25 04:25:16 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "test.sum" to batch
2025/09/25 04:25:16 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:16 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: test.sum
2025/09/25 04:25:17 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest3
2025/09/25 04:25:19 DEBUG : test.sum: Uploading chunk 1/1
2025/09/25 04:25:20 DEBUG : test.sum: Uploading chunk 2/1
2025/09/25 04:25:20 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "test.sum" to batch
2025/09/25 04:25:21 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:21 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: test.sum
2025/09/25 04:25:22 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest4
2025/09/25 04:25:24 DEBUG : test.sum: Uploading chunk 1/1
2025/09/25 04:25:24 DEBUG : test.sum: Uploading chunk 2/1
2025/09/25 04:25:24 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "test.sum" to batch
2025/09/25 04:25:25 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:25 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: test.sum
2025/09/25 04:25:26 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest5
2025/09/25 04:25:28 DEBUG : test.sum: Uploading chunk 1/1
2025/09/25 04:25:29 DEBUG : test.sum: Uploading chunk 2/1
2025/09/25 04:25:29 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "test.sum" to batch
2025/09/25 04:25:30 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:30 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: test.sum
2025/09/25 04:25:31 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest6
2025/09/25 04:25:33 DEBUG : data/banana: Uploading chunk 1/1
2025/09/25 04:25:33 DEBUG : data/banana: Uploading chunk 2/1
2025/09/25 04:25:34 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "data/banana" to batch
2025/09/25 04:25:34 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:34 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: data/banana
2025/09/25 04:25:35 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: data/banana
2025/09/25 04:25:35 DEBUG : data/potato: Uploading chunk 1/1
2025/09/25 04:25:35 DEBUG : data/potato: Uploading chunk 2/1
2025/09/25 04:25:36 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "data/potato" to batch
2025/09/25 04:25:36 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:36 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: data/potato
2025/09/25 04:25:37 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: data/potato
2025/09/25 04:25:37 DEBUG : test.sum: Uploading chunk 1/1
2025/09/25 04:25:38 DEBUG : test.sum: Uploading chunk 2/1
2025/09/25 04:25:38 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "test.sum" to batch
2025/09/25 04:25:38 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:38 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: test.sum
2025/09/25 04:25:39 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: test.sum
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (42.47s)
    --- PASS: TestCheckSumDownload/subtest1 (1.33s)
    --- PASS: TestCheckSumDownload/subtest2 (1.76s)
    --- PASS: TestCheckSumDownload/subtest3 (1.53s)
    --- PASS: TestCheckSumDownload/subtest4 (1.54s)
    --- PASS: TestCheckSumDownload/subtest5 (1.94s)
    --- PASS: TestCheckSumDownload/subtest6 (1.88s)
    --- PASS: TestCheckSumDownload/subtest7 (1.80s)
=== RUN   TestListDirSorted
    run.go:180: Remote "Dropbox root 'rclone-test-yopaxun5lusi'", Local "Local file system at /tmp/rclone689497139", Modify Window "1s"
2025/09/25 04:25:45 DEBUG : a.txt: Uploading chunk 1/1
2025/09/25 04:25:45 DEBUG : a.txt: Uploading chunk 2/1
2025/09/25 04:25:46 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "a.txt" to batch
2025/09/25 04:25:46 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:46 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: a.txt
2025/09/25 04:25:47 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: a.txt
2025/09/25 04:25:47 DEBUG : zend.txt: Uploading chunk 1/1
2025/09/25 04:25:47 DEBUG : zend.txt: Uploading chunk 2/1
2025/09/25 04:25:48 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "zend.txt" to batch
2025/09/25 04:25:49 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:49 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: zend.txt
2025/09/25 04:25:49 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: zend.txt
2025/09/25 04:25:49 DEBUG : sub dir/hello world: Uploading chunk 1/1
2025/09/25 04:25:50 DEBUG : sub dir/hello world: Uploading chunk 2/1
2025/09/25 04:25:50 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/hello world" to batch
2025/09/25 04:25:50 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:50 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/hello world
2025/09/25 04:25:51 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/hello world
2025/09/25 04:25:51 DEBUG : sub dir/hello world2: Uploading chunk 1/1
2025/09/25 04:25:52 DEBUG : sub dir/hello world2: Uploading chunk 2/1
2025/09/25 04:25:52 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/hello world2" to batch
2025/09/25 04:25:53 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:53 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/hello world2
2025/09/25 04:25:53 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/hello world2
2025/09/25 04:25:53 DEBUG : sub dir/ignore dir/.ignore: Uploading chunk 1/1
2025/09/25 04:25:54 DEBUG : sub dir/ignore dir/.ignore: Uploading chunk 2/1
2025/09/25 04:25:55 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/ignore dir/.ignore" to batch
2025/09/25 04:25:55 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:55 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/ignore dir/.ignore
2025/09/25 04:25:56 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/ignore dir/.ignore
2025/09/25 04:25:56 DEBUG : sub dir/ignore dir/should be ignored: Uploading chunk 1/1
2025/09/25 04:25:56 DEBUG : sub dir/ignore dir/should be ignored: Uploading chunk 2/1
2025/09/25 04:25:57 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/ignore dir/should be ignored" to batch
2025/09/25 04:25:57 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:25:57 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/ignore dir/should be ignored
2025/09/25 04:25:58 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/ignore dir/should be ignored
2025/09/25 04:25:58 DEBUG : sub dir/sub sub dir/hello world3: Uploading chunk 1/1
2025/09/25 04:25:59 DEBUG : sub dir/sub sub dir/hello world3: Uploading chunk 2/1
2025/09/25 04:25:59 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/sub sub dir/hello world3" to batch
2025/09/25 04:26:00 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:00 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/sub sub dir/hello world3
2025/09/25 04:26:00 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/sub sub dir/hello world3
2025/09/25 04:26:02 DEBUG : a.txt: Excluded (Size Filter)
2025/09/25 04:26:02 DEBUG : a.txt: Excluded
2025/09/25 04:26:02 DEBUG : sub dir/hello world: Excluded (Size Filter)
2025/09/25 04:26:02 DEBUG : sub dir/hello world: Excluded
2025/09/25 04:26:02 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2025/09/25 04:26:02 DEBUG : sub dir/hello world2: Excluded
2025/09/25 04:26:02 DEBUG : sub dir/ignore dir: Excluded
2025/09/25 04:26:03 DEBUG : sub dir/hello world: Excluded (Size Filter)
2025/09/25 04:26:03 DEBUG : sub dir/hello world: Excluded
2025/09/25 04:26:03 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2025/09/25 04:26:03 DEBUG : sub dir/hello world2: Excluded
2025/09/25 04:26:03 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSorted (26.66s)
=== RUN   TestListDirSortedFn
    run.go:180: Remote "Dropbox root 'rclone-test-yopaxun5lusi'", Local "Local file system at /tmp/rclone689497139", Modify Window "1s"
2025/09/25 04:26:12 DEBUG : a.txt: Uploading chunk 1/1
2025/09/25 04:26:12 DEBUG : a.txt: Uploading chunk 2/1
2025/09/25 04:26:12 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "a.txt" to batch
2025/09/25 04:26:13 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:13 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: a.txt
2025/09/25 04:26:14 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: a.txt
2025/09/25 04:26:14 DEBUG : zend.txt: Uploading chunk 1/1
2025/09/25 04:26:14 DEBUG : zend.txt: Uploading chunk 2/1
2025/09/25 04:26:15 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "zend.txt" to batch
2025/09/25 04:26:15 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:15 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: zend.txt
2025/09/25 04:26:16 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: zend.txt
2025/09/25 04:26:16 DEBUG : sub dir/hello world: Uploading chunk 1/1
2025/09/25 04:26:17 DEBUG : sub dir/hello world: Uploading chunk 2/1
2025/09/25 04:26:17 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/hello world" to batch
2025/09/25 04:26:18 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:18 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/hello world
2025/09/25 04:26:18 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/hello world
2025/09/25 04:26:19 DEBUG : sub dir/hello world2: Uploading chunk 1/1
2025/09/25 04:26:19 DEBUG : sub dir/hello world2: Uploading chunk 2/1
2025/09/25 04:26:19 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/hello world2" to batch
2025/09/25 04:26:20 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:20 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/hello world2
2025/09/25 04:26:21 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/hello world2
2025/09/25 04:26:21 DEBUG : sub dir/ignore dir/.ignore: Uploading chunk 1/1
2025/09/25 04:26:22 DEBUG : sub dir/ignore dir/.ignore: Uploading chunk 2/1
2025/09/25 04:26:22 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/ignore dir/.ignore" to batch
2025/09/25 04:26:22 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:22 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/ignore dir/.ignore
2025/09/25 04:26:23 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/ignore dir/.ignore
2025/09/25 04:26:23 DEBUG : sub dir/ignore dir/should be ignored: Uploading chunk 1/1
2025/09/25 04:26:24 DEBUG : sub dir/ignore dir/should be ignored: Uploading chunk 2/1
2025/09/25 04:26:24 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/ignore dir/should be ignored" to batch
2025/09/25 04:26:25 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:25 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/ignore dir/should be ignored
2025/09/25 04:26:25 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/ignore dir/should be ignored
2025/09/25 04:26:26 DEBUG : sub dir/sub sub dir/hello world3: Uploading chunk 1/1
2025/09/25 04:26:26 DEBUG : sub dir/sub sub dir/hello world3: Uploading chunk 2/1
2025/09/25 04:26:26 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Adding "sub dir/sub sub dir/hello world3" to batch
2025/09/25 04:26:27 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Batch idle for 500ms so committing
2025/09/25 04:26:27 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committing sync batch length 1 starting with: sub dir/sub sub dir/hello world3
2025/09/25 04:26:28 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Committed sync batch length 1 starting with: sub dir/sub sub dir/hello world3
2025/09/25 04:26:29 DEBUG : a.txt: Excluded (Size Filter)
2025/09/25 04:26:29 DEBUG : a.txt: Excluded
2025/09/25 04:26:29 DEBUG : sub dir/hello world: Excluded (Size Filter)
2025/09/25 04:26:29 DEBUG : sub dir/hello world: Excluded
2025/09/25 04:26:29 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2025/09/25 04:26:29 DEBUG : sub dir/hello world2: Excluded
2025/09/25 04:26:30 DEBUG : sub dir/ignore dir: Excluded
2025/09/25 04:26:30 DEBUG : sub dir/hello world: Excluded (Size Filter)
2025/09/25 04:26:30 DEBUG : sub dir/hello world: Excluded
2025/09/25 04:26:30 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2025/09/25 04:26:30 DEBUG : sub dir/hello world2: Excluded
2025/09/25 04:26:30 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSortedFn (27.56s)
PASS
2025/09/25 04:26:39 DEBUG : Dropbox root 'rclone-test-yopaxun5lusi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestCheckDownload|TestCheckSumDownload|TestListDirSorted|TestListDirSortedFn)$'" - Finished OK in 1m58.104695488s (try 2/5)