"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestApplyTransforms|TestCheck)$'" - Starting (try 2/5)
2026/08/08 04:51:20 DEBUG : Creating backend with remote "TestDropbox:rclone-test-kemohah8wafo"
2026/08/08 04:51:20 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/08 04:51:21 DEBUG : Creating backend with remote "/tmp/rclone2894978639"
=== RUN   TestCheck
    run.go:198: Remote "Dropbox root 'rclone-test-kemohah8wafo'", Local "Local file system at /tmp/rclone2894978639", Modify Window "1s"
2026/08/08 04:51:22 DEBUG : rutabaga: Uploading chunk 1/1
2026/08/08 04:51:22 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Adding "rutabaga" to batch
2026/08/08 04:51:23 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Batch idle for 500ms so committing
2026/08/08 04:51:23 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committing sync batch length 1 starting with: rutabaga
2026/08/08 04:51:23 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committed sync batch length 1 starting with: rutabaga
=== RUN   TestCheck/1
=== RUN   TestCheck/2
2026/08/08 04:51:25 DEBUG : empty space: Uploading chunk 1/1
2026/08/08 04:51:25 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Adding "empty space" to batch
2026/08/08 04:51:26 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Batch idle for 500ms so committing
2026/08/08 04:51:26 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committing sync batch length 1 starting with: empty space
2026/08/08 04:51:26 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committed sync batch length 1 starting with: empty space
=== RUN   TestCheck/3
2026/08/08 04:51:27 DEBUG : potato2: Uploading chunk 1/1
2026/08/08 04:51:28 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Adding "potato2" to batch
2026/08/08 04:51:28 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Batch idle for 500ms so committing
2026/08/08 04:51:28 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committing sync batch length 1 starting with: potato2
2026/08/08 04:51:29 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committed sync batch length 1 starting with: potato2
=== RUN   TestCheck/4
=== RUN   TestCheck/5
2026/08/08 04:51:30 DEBUG : remotepotato: Uploading chunk 1/1
2026/08/08 04:51:31 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Adding "remotepotato" to batch
2026/08/08 04:51:31 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Batch idle for 500ms so committing
2026/08/08 04:51:31 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committing sync batch length 1 starting with: remotepotato
2026/08/08 04:51:33 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Committed sync batch length 1 starting with: remotepotato
=== RUN   TestCheck/6
=== RUN   TestCheck/7
--- PASS: TestCheck (15.82s)
    --- PASS: TestCheck/1 (0.27s)
    --- PASS: TestCheck/2 (0.27s)
    --- PASS: TestCheck/3 (0.29s)
    --- PASS: TestCheck/4 (0.29s)
    --- PASS: TestCheck/5 (0.27s)
    --- PASS: TestCheck/6 (0.28s)
    --- PASS: TestCheck/7 (0.28s)
=== RUN   TestApplyTransforms
2026/08/08 04:51:36 DEBUG : Creating backend with remote "TestDropbox:rclone-test-yugumaf4vuna"
2026/08/08 04:51:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/08 04:51:37 DEBUG : Creating backend with remote "/tmp/rclone897613857"
    run.go:198: Remote "Dropbox root 'rclone-test-yugumaf4vuna'", Local "Local file system at /tmp/rclone897613857", Modify Window "1s"
2026/08/08 04:51:38 DEBUG : hello, world!: Uploading chunk 1/1
2026/08/08 04:51:38 DEBUG : Dropbox root 'rclone-test-yugumaf4vuna': Adding "hello, world!" to batch
2026/08/08 04:51:39 DEBUG : Dropbox root 'rclone-test-yugumaf4vuna': Batch idle for 500ms so committing
2026/08/08 04:51:39 DEBUG : Dropbox root 'rclone-test-yugumaf4vuna': Committing sync batch length 1 starting with: hello, world!
2026/08/08 04:51:40 DEBUG : Dropbox root 'rclone-test-yugumaf4vuna': Committed sync batch length 1 starting with: hello, world!
upper checkfile vs. lower remote (without normalization)
2026/08/08 04:51:41 ERROR : hello, world!: sum not found
2026/08/08 04:51:41 ERROR : HELLO, WORLD!: file not in Dropbox root 'rclone-test-yugumaf4vuna'
2026/08/08 04:51:41 NOTICE: Dropbox root 'rclone-test-yugumaf4vuna': 1 files missing
2026/08/08 04:51:41 NOTICE: 1 hashes missing
2026/08/08 04:51:41 NOTICE: Dropbox root 'rclone-test-yugumaf4vuna': 1 differences found
2026/08/08 04:51:41 NOTICE: Dropbox root 'rclone-test-yugumaf4vuna': 2 errors while checking
upper checkfile vs. lower remote (with normalization)
2026/08/08 04:51:42 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/08/08 04:51:42 NOTICE: Dropbox root 'rclone-test-yugumaf4vuna': 0 differences found
2026/08/08 04:51:42 NOTICE: Dropbox root 'rclone-test-yugumaf4vuna': 1 matching files
2026/08/08 04:51:42 DEBUG : Creating backend with remote "TestDropbox:rclone-test-xugosid6mito"
2026/08/08 04:51:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/08 04:51:42 DEBUG : Creating backend with remote "/tmp/rclone2594398013"
    run.go:198: Remote "Dropbox root 'rclone-test-xugosid6mito'", Local "Local file system at /tmp/rclone2594398013", Modify Window "1s"
2026/08/08 04:51:43 DEBUG : pacer: low level retry 1/10 (error )
2026/08/08 04:51:43 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/08/08 04:51:43 DEBUG : pacer: Reducing sleep to 15ms
2026/08/08 04:51:44 DEBUG : pacer: Reducing sleep to 11.25ms
2026/08/08 04:51:44 DEBUG : HELLO, WORLD!: Uploading chunk 1/1
2026/08/08 04:51:45 DEBUG : pacer: Reducing sleep to 10ms
2026/08/08 04:51:45 DEBUG : Dropbox root 'rclone-test-xugosid6mito': Adding "HELLO, WORLD!" to batch
2026/08/08 04:51:45 DEBUG : Dropbox root 'rclone-test-xugosid6mito': Batch idle for 500ms so committing
2026/08/08 04:51:45 DEBUG : Dropbox root 'rclone-test-xugosid6mito': Committing sync batch length 1 starting with: HELLO, WORLD!
2026/08/08 04:51:46 DEBUG : Dropbox root 'rclone-test-xugosid6mito': Committed sync batch length 1 starting with: HELLO, WORLD!
lower checkfile vs. upper remote (without normalization)
2026/08/08 04:51:46 ERROR : HELLO, WORLD!: sum not found
2026/08/08 04:51:46 ERROR : hello, world!: file not in Dropbox root 'rclone-test-xugosid6mito'
2026/08/08 04:51:46 NOTICE: Dropbox root 'rclone-test-xugosid6mito': 1 files missing
2026/08/08 04:51:46 NOTICE: 1 hashes missing
2026/08/08 04:51:46 NOTICE: Dropbox root 'rclone-test-xugosid6mito': 1 differences found
2026/08/08 04:51:46 NOTICE: Dropbox root 'rclone-test-xugosid6mito': 2 errors while checking
lower checkfile vs. upper remote (with normalization)
2026/08/08 04:51:47 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/08/08 04:51:47 NOTICE: Dropbox root 'rclone-test-xugosid6mito': 0 differences found
2026/08/08 04:51:47 NOTICE: Dropbox root 'rclone-test-xugosid6mito': 1 matching files
2026/08/08 04:51:47 DEBUG : Creating backend with remote "TestDropbox:rclone-test-kojamop1hido"
2026/08/08 04:51:47 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/08 04:51:48 DEBUG : Creating backend with remote "/tmp/rclone2369246376"
    run.go:198: Remote "Dropbox root 'rclone-test-kojamop1hido'", Local "Local file system at /tmp/rclone2369246376", Modify Window "1s"
2026/08/08 04:51:49 DEBUG : HeLlO, wOrLd!: Uploading chunk 1/1
2026/08/08 04:51:49 DEBUG : Dropbox root 'rclone-test-kojamop1hido': Adding "HeLlO, wOrLd!" to batch
2026/08/08 04:51:50 DEBUG : Dropbox root 'rclone-test-kojamop1hido': Batch idle for 500ms so committing
2026/08/08 04:51:50 DEBUG : Dropbox root 'rclone-test-kojamop1hido': Committing sync batch length 1 starting with: HeLlO, wOrLd!
2026/08/08 04:51:50 DEBUG : Dropbox root 'rclone-test-kojamop1hido': Committed sync batch length 1 starting with: HeLlO, wOrLd!
lower checkfile vs. upperlowermixed remote (without normalization)
2026/08/08 04:51:51 ERROR : HeLlO, wOrLd!: sum not found
2026/08/08 04:51:51 ERROR : hello, world!: file not in Dropbox root 'rclone-test-kojamop1hido'
2026/08/08 04:51:51 NOTICE: Dropbox root 'rclone-test-kojamop1hido': 1 files missing
2026/08/08 04:51:51 NOTICE: 1 hashes missing
2026/08/08 04:51:51 NOTICE: Dropbox root 'rclone-test-kojamop1hido': 1 differences found
2026/08/08 04:51:51 NOTICE: Dropbox root 'rclone-test-kojamop1hido': 2 errors while checking
lower checkfile vs. upperlowermixed remote (with normalization)
2026/08/08 04:51:52 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/08/08 04:51:52 NOTICE: Dropbox root 'rclone-test-kojamop1hido': 0 differences found
2026/08/08 04:51:52 NOTICE: Dropbox root 'rclone-test-kojamop1hido': 1 matching files
2026/08/08 04:51:52 DEBUG : Creating backend with remote "TestDropbox:rclone-test-kedohup3qilu"
2026/08/08 04:51:52 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/08 04:51:52 DEBUG : Creating backend with remote "/tmp/rclone2605966036"
    run.go:198: Remote "Dropbox root 'rclone-test-kedohup3qilu'", Local "Local file system at /tmp/rclone2605966036", Modify Window "1s"
2026/08/08 04:51:54 DEBUG : HELLO, WORLD!: Uploading chunk 1/1
2026/08/08 04:51:54 DEBUG : Dropbox root 'rclone-test-kedohup3qilu': Adding "HELLO, WORLD!" to batch
2026/08/08 04:51:55 DEBUG : Dropbox root 'rclone-test-kedohup3qilu': Batch idle for 500ms so committing
2026/08/08 04:51:55 DEBUG : Dropbox root 'rclone-test-kedohup3qilu': Committing sync batch length 1 starting with: HELLO, WORLD!
2026/08/08 04:51:55 DEBUG : Dropbox root 'rclone-test-kedohup3qilu': Committed sync batch length 1 starting with: HELLO, WORLD!
upperlowermixed checkfile vs. upper remote (without normalization)
2026/08/08 04:51:56 ERROR : HELLO, WORLD!: sum not found
2026/08/08 04:51:56 ERROR : HeLlO, wOrLd!: file not in Dropbox root 'rclone-test-kedohup3qilu'
2026/08/08 04:51:56 NOTICE: Dropbox root 'rclone-test-kedohup3qilu': 1 files missing
2026/08/08 04:51:56 NOTICE: 1 hashes missing
2026/08/08 04:51:56 NOTICE: Dropbox root 'rclone-test-kedohup3qilu': 1 differences found
2026/08/08 04:51:56 NOTICE: Dropbox root 'rclone-test-kedohup3qilu': 2 errors while checking
upperlowermixed checkfile vs. upper remote (with normalization)
2026/08/08 04:51:57 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/08/08 04:51:57 NOTICE: Dropbox root 'rclone-test-kedohup3qilu': 0 differences found
2026/08/08 04:51:57 NOTICE: Dropbox root 'rclone-test-kedohup3qilu': 1 matching files
2026/08/08 04:51:57 DEBUG : Creating backend with remote "TestDropbox:rclone-test-wivovun8kugo"
2026/08/08 04:51:57 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/08 04:51:57 DEBUG : Creating backend with remote "/tmp/rclone2477328720"
    run.go:198: Remote "Dropbox root 'rclone-test-wivovun8kugo'", Local "Local file system at /tmp/rclone2477328720", Modify Window "1s"
2026/08/08 04:51:58 DEBUG : 測試_Русский___ě_áñ: Uploading chunk 1/1
2026/08/08 04:51:59 DEBUG : Dropbox root 'rclone-test-wivovun8kugo': Adding "測試_Русский___ě_áñ" to batch
2026/08/08 04:51:59 DEBUG : Dropbox root 'rclone-test-wivovun8kugo': Batch idle for 500ms so committing
2026/08/08 04:51:59 DEBUG : Dropbox root 'rclone-test-wivovun8kugo': Committing sync batch length 1 starting with: 測試_Русский___ě_áñ
2026/08/08 04:52:00 DEBUG : Dropbox root 'rclone-test-wivovun8kugo': Committed sync batch length 1 starting with: 測試_Русский___ě_áñ
NFD checkfile vs. NFC remote (without normalization)
2026/08/08 04:52:00 ERROR : 測試_Русский___ě_áñ: sum not found
2026/08/08 04:52:00 ERROR : 測試_Русский___ě_áñ: file not in Dropbox root 'rclone-test-wivovun8kugo'
2026/08/08 04:52:00 NOTICE: Dropbox root 'rclone-test-wivovun8kugo': 1 files missing
2026/08/08 04:52:00 NOTICE: 1 hashes missing
2026/08/08 04:52:00 NOTICE: Dropbox root 'rclone-test-wivovun8kugo': 1 differences found
2026/08/08 04:52:00 NOTICE: Dropbox root 'rclone-test-wivovun8kugo': 2 errors while checking
NFD checkfile vs. NFC remote (with normalization)
2026/08/08 04:52:01 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/08/08 04:52:01 NOTICE: Dropbox root 'rclone-test-wivovun8kugo': 0 differences found
2026/08/08 04:52:01 NOTICE: Dropbox root 'rclone-test-wivovun8kugo': 1 matching files
2026/08/08 04:52:01 DEBUG : Creating backend with remote "TestDropbox:rclone-test-dujatis1rexi"
2026/08/08 04:52:01 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/08 04:52:02 DEBUG : Creating backend with remote "/tmp/rclone3389612430"
    run.go:198: Remote "Dropbox root 'rclone-test-dujatis1rexi'", Local "Local file system at /tmp/rclone3389612430", Modify Window "1s"
2026/08/08 04:52:02 DEBUG : pacer: low level retry 1/10 (error )
2026/08/08 04:52:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/08/08 04:52:03 DEBUG : pacer: Reducing sleep to 15ms
2026/08/08 04:52:03 DEBUG : pacer: Reducing sleep to 11.25ms
2026/08/08 04:52:03 DEBUG : 測試_Русский___ě_áñ: Uploading chunk 1/1
2026/08/08 04:52:04 DEBUG : pacer: Reducing sleep to 10ms
2026/08/08 04:52:04 DEBUG : Dropbox root 'rclone-test-dujatis1rexi': Adding "測試_Русский___ě_áñ" to batch
2026/08/08 04:52:04 DEBUG : Dropbox root 'rclone-test-dujatis1rexi': Batch idle for 500ms so committing
2026/08/08 04:52:04 DEBUG : Dropbox root 'rclone-test-dujatis1rexi': Committing sync batch length 1 starting with: 測試_Русский___ě_áñ
2026/08/08 04:52:05 DEBUG : Dropbox root 'rclone-test-dujatis1rexi': Committed sync batch length 1 starting with: 測試_Русский___ě_áñ
    check_test.go:570: Fs is incapable of running test, skipping: NFC checkfile vs. NFD remote (expected: 測試_Русский___ě_áñ (NFD) actual: 測試_Русский___ě_áñ (NFC))
2026/08/08 04:52:05 DEBUG : Dropbox root 'rclone-test-dujatis1rexi': Purge remote
2026/08/08 04:52:06 DEBUG : Dropbox root 'rclone-test-wivovun8kugo': Purge remote
2026/08/08 04:52:06 DEBUG : Dropbox root 'rclone-test-kedohup3qilu': Purge remote
2026/08/08 04:52:07 DEBUG : Dropbox root 'rclone-test-kojamop1hido': Purge remote
2026/08/08 04:52:08 DEBUG : Dropbox root 'rclone-test-xugosid6mito': Purge remote
2026/08/08 04:52:08 DEBUG : Dropbox root 'rclone-test-yugumaf4vuna': Purge remote
--- SKIP: TestApplyTransforms (32.28s)
PASS
2026/08/08 04:52:09 DEBUG : Dropbox root 'rclone-test-kemohah8wafo': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^(TestApplyTransforms|TestCheck)$'" - Finished OK in 49.07175396s (try 2/5)