"./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestApplyTransforms$|^TestRcat$/^withChecksum=true,ignoreChecksum=false$'" - Starting (try 2/5) 2025/03/12 04:20:56 DEBUG : Creating backend with remote "TestDropbox:rclone-test-yubefuk6rile" 2025/03/12 04:20:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 04:20:57 DEBUG : Creating backend with remote "/tmp/rclone3037510535" === RUN TestApplyTransforms 2025/03/12 04:20:57 DEBUG : Creating backend with remote "TestDropbox:rclone-test-suxiqeq8peto" 2025/03/12 04:20:57 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 04:20:57 DEBUG : Creating backend with remote "/tmp/rclone1482409407" run.go:180: Remote "Dropbox root 'rclone-test-suxiqeq8peto'", Local "Local file system at /tmp/rclone1482409407", Modify Window "1s" 2025/03/12 04:20:58 DEBUG : hello, world!: Uploading chunk 1/1 2025/03/12 04:20:59 DEBUG : hello, world!: Uploading chunk 2/1 2025/03/12 04:20:59 DEBUG : Dropbox root 'rclone-test-suxiqeq8peto': Adding "hello, world!" to batch 2025/03/12 04:21:00 DEBUG : Dropbox root 'rclone-test-suxiqeq8peto': Batch idle for 500ms so committing 2025/03/12 04:21:00 DEBUG : Dropbox root 'rclone-test-suxiqeq8peto': Committing sync batch length 1 starting with: hello, world! 2025/03/12 04:21:01 DEBUG : Dropbox root 'rclone-test-suxiqeq8peto': Committed sync batch length 1 starting with: hello, world! upper checkfile vs. lower remote (without normalization) 2025/03/12 04:21:01 ERROR : hello, world!: sum not found 2025/03/12 04:21:01 ERROR : HELLO, WORLD!: file not in Dropbox root 'rclone-test-suxiqeq8peto' 2025/03/12 04:21:01 NOTICE: Dropbox root 'rclone-test-suxiqeq8peto': 1 files missing 2025/03/12 04:21:01 NOTICE: 1 hashes missing 2025/03/12 04:21:01 NOTICE: Dropbox root 'rclone-test-suxiqeq8peto': 2 differences found 2025/03/12 04:21:01 NOTICE: Dropbox root 'rclone-test-suxiqeq8peto': 2 errors while checking upper checkfile vs. lower remote (with normalization) 2025/03/12 04:21:02 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/12 04:21:02 NOTICE: Dropbox root 'rclone-test-suxiqeq8peto': 0 differences found 2025/03/12 04:21:02 NOTICE: Dropbox root 'rclone-test-suxiqeq8peto': 1 matching files 2025/03/12 04:21:02 DEBUG : Creating backend with remote "TestDropbox:rclone-test-noyiqit5meho" 2025/03/12 04:21:02 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 04:21:02 DEBUG : Creating backend with remote "/tmp/rclone3031423162" run.go:180: Remote "Dropbox root 'rclone-test-noyiqit5meho'", Local "Local file system at /tmp/rclone3031423162", Modify Window "1s" 2025/03/12 04:21:03 DEBUG : pacer: low level retry 1/10 (error too_many_write_operations/...) 2025/03/12 04:21:03 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/12 04:21:04 DEBUG : pacer: Reducing sleep to 15ms 2025/03/12 04:21:04 DEBUG : pacer: Reducing sleep to 11.25ms 2025/03/12 04:21:04 DEBUG : HELLO, WORLD!: Uploading chunk 1/1 2025/03/12 04:21:05 DEBUG : pacer: Reducing sleep to 10ms 2025/03/12 04:21:05 DEBUG : HELLO, WORLD!: Uploading chunk 2/1 2025/03/12 04:21:05 DEBUG : Dropbox root 'rclone-test-noyiqit5meho': Adding "HELLO, WORLD!" to batch 2025/03/12 04:21:06 DEBUG : Dropbox root 'rclone-test-noyiqit5meho': Batch idle for 500ms so committing 2025/03/12 04:21:06 DEBUG : Dropbox root 'rclone-test-noyiqit5meho': Committing sync batch length 1 starting with: HELLO, WORLD! 2025/03/12 04:21:06 DEBUG : Dropbox root 'rclone-test-noyiqit5meho': Committed sync batch length 1 starting with: HELLO, WORLD! lower checkfile vs. upper remote (without normalization) 2025/03/12 04:21:07 ERROR : HELLO, WORLD!: sum not found 2025/03/12 04:21:07 ERROR : hello, world!: file not in Dropbox root 'rclone-test-noyiqit5meho' 2025/03/12 04:21:07 NOTICE: Dropbox root 'rclone-test-noyiqit5meho': 1 files missing 2025/03/12 04:21:07 NOTICE: 1 hashes missing 2025/03/12 04:21:07 NOTICE: Dropbox root 'rclone-test-noyiqit5meho': 2 differences found 2025/03/12 04:21:07 NOTICE: Dropbox root 'rclone-test-noyiqit5meho': 2 errors while checking lower checkfile vs. upper remote (with normalization) 2025/03/12 04:21:08 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/12 04:21:08 NOTICE: Dropbox root 'rclone-test-noyiqit5meho': 0 differences found 2025/03/12 04:21:08 NOTICE: Dropbox root 'rclone-test-noyiqit5meho': 1 matching files 2025/03/12 04:21:08 DEBUG : Creating backend with remote "TestDropbox:rclone-test-yadugof4wowa" 2025/03/12 04:21:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 04:21:09 DEBUG : Creating backend with remote "/tmp/rclone1581064835" run.go:180: Remote "Dropbox root 'rclone-test-yadugof4wowa'", Local "Local file system at /tmp/rclone1581064835", Modify Window "1s" 2025/03/12 04:21:10 DEBUG : HeLlO, wOrLd!: Uploading chunk 1/1 2025/03/12 04:21:10 DEBUG : HeLlO, wOrLd!: Uploading chunk 2/1 2025/03/12 04:21:11 DEBUG : Dropbox root 'rclone-test-yadugof4wowa': Adding "HeLlO, wOrLd!" to batch 2025/03/12 04:21:11 DEBUG : Dropbox root 'rclone-test-yadugof4wowa': Batch idle for 500ms so committing 2025/03/12 04:21:11 DEBUG : Dropbox root 'rclone-test-yadugof4wowa': Committing sync batch length 1 starting with: HeLlO, wOrLd! 2025/03/12 04:21:12 DEBUG : Dropbox root 'rclone-test-yadugof4wowa': Committed sync batch length 1 starting with: HeLlO, wOrLd! lower checkfile vs. upperlowermixed remote (without normalization) 2025/03/12 04:21:13 ERROR : HeLlO, wOrLd!: sum not found 2025/03/12 04:21:13 ERROR : hello, world!: file not in Dropbox root 'rclone-test-yadugof4wowa' 2025/03/12 04:21:13 NOTICE: Dropbox root 'rclone-test-yadugof4wowa': 1 files missing 2025/03/12 04:21:13 NOTICE: 1 hashes missing 2025/03/12 04:21:13 NOTICE: Dropbox root 'rclone-test-yadugof4wowa': 2 differences found 2025/03/12 04:21:13 NOTICE: Dropbox root 'rclone-test-yadugof4wowa': 2 errors while checking lower checkfile vs. upperlowermixed remote (with normalization) 2025/03/12 04:21:14 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/12 04:21:14 NOTICE: Dropbox root 'rclone-test-yadugof4wowa': 0 differences found 2025/03/12 04:21:14 NOTICE: Dropbox root 'rclone-test-yadugof4wowa': 1 matching files 2025/03/12 04:21:14 DEBUG : Creating backend with remote "TestDropbox:rclone-test-tajajoh1yezo" 2025/03/12 04:21:14 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 04:21:14 DEBUG : Creating backend with remote "/tmp/rclone3893881623" run.go:180: Remote "Dropbox root 'rclone-test-tajajoh1yezo'", Local "Local file system at /tmp/rclone3893881623", Modify Window "1s" 2025/03/12 04:21:16 DEBUG : HELLO, WORLD!: Uploading chunk 1/1 2025/03/12 04:21:16 DEBUG : HELLO, WORLD!: Uploading chunk 2/1 2025/03/12 04:21:17 DEBUG : Dropbox root 'rclone-test-tajajoh1yezo': Adding "HELLO, WORLD!" to batch 2025/03/12 04:21:17 DEBUG : Dropbox root 'rclone-test-tajajoh1yezo': Batch idle for 500ms so committing 2025/03/12 04:21:17 DEBUG : Dropbox root 'rclone-test-tajajoh1yezo': Committing sync batch length 1 starting with: HELLO, WORLD! 2025/03/12 04:21:18 DEBUG : Dropbox root 'rclone-test-tajajoh1yezo': Committed sync batch length 1 starting with: HELLO, WORLD! upperlowermixed checkfile vs. upper remote (without normalization) 2025/03/12 04:21:19 ERROR : HELLO, WORLD!: sum not found 2025/03/12 04:21:19 ERROR : HeLlO, wOrLd!: file not in Dropbox root 'rclone-test-tajajoh1yezo' 2025/03/12 04:21:19 NOTICE: Dropbox root 'rclone-test-tajajoh1yezo': 1 files missing 2025/03/12 04:21:19 NOTICE: 1 hashes missing 2025/03/12 04:21:19 NOTICE: Dropbox root 'rclone-test-tajajoh1yezo': 2 differences found 2025/03/12 04:21:19 NOTICE: Dropbox root 'rclone-test-tajajoh1yezo': 2 errors while checking upperlowermixed checkfile vs. upper remote (with normalization) 2025/03/12 04:21:20 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/12 04:21:20 NOTICE: Dropbox root 'rclone-test-tajajoh1yezo': 0 differences found 2025/03/12 04:21:20 NOTICE: Dropbox root 'rclone-test-tajajoh1yezo': 1 matching files 2025/03/12 04:21:20 DEBUG : Creating backend with remote "TestDropbox:rclone-test-pacujab8gefi" 2025/03/12 04:21:20 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 04:21:20 DEBUG : Creating backend with remote "/tmp/rclone558955164" run.go:180: Remote "Dropbox root 'rclone-test-pacujab8gefi'", Local "Local file system at /tmp/rclone558955164", Modify Window "1s" 2025/03/12 04:21:21 DEBUG : 測試_Русский___ě_áñ: Uploading chunk 1/1 2025/03/12 04:21:22 DEBUG : 測試_Русский___ě_áñ: Uploading chunk 2/1 2025/03/12 04:21:22 DEBUG : Dropbox root 'rclone-test-pacujab8gefi': Adding "測試_Русский___ě_áñ" to batch 2025/03/12 04:21:23 DEBUG : Dropbox root 'rclone-test-pacujab8gefi': Batch idle for 500ms so committing 2025/03/12 04:21:23 DEBUG : Dropbox root 'rclone-test-pacujab8gefi': Committing sync batch length 1 starting with: 測試_Русский___ě_áñ 2025/03/12 04:21:24 DEBUG : Dropbox root 'rclone-test-pacujab8gefi': Committed sync batch length 1 starting with: 測試_Русский___ě_áñ NFD checkfile vs. NFC remote (without normalization) 2025/03/12 04:21:24 ERROR : 測試_Русский___ě_áñ: sum not found 2025/03/12 04:21:24 ERROR : 測試_Русский___ě_áñ: file not in Dropbox root 'rclone-test-pacujab8gefi' 2025/03/12 04:21:24 NOTICE: Dropbox root 'rclone-test-pacujab8gefi': 1 files missing 2025/03/12 04:21:24 NOTICE: 1 hashes missing 2025/03/12 04:21:24 NOTICE: Dropbox root 'rclone-test-pacujab8gefi': 2 differences found 2025/03/12 04:21:24 NOTICE: Dropbox root 'rclone-test-pacujab8gefi': 2 errors while checking NFD checkfile vs. NFC remote (with normalization) 2025/03/12 04:21:25 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/12 04:21:25 NOTICE: Dropbox root 'rclone-test-pacujab8gefi': 0 differences found 2025/03/12 04:21:25 NOTICE: Dropbox root 'rclone-test-pacujab8gefi': 1 matching files 2025/03/12 04:21:25 DEBUG : Creating backend with remote "TestDropbox:rclone-test-fukaken8caji" 2025/03/12 04:21:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/12 04:21:26 DEBUG : Creating backend with remote "/tmp/rclone2812858483" run.go:180: Remote "Dropbox root 'rclone-test-fukaken8caji'", Local "Local file system at /tmp/rclone2812858483", Modify Window "1s" 2025/03/12 04:21:27 DEBUG : 測試_Русский___ě_áñ: Uploading chunk 1/1 2025/03/12 04:21:27 DEBUG : 測試_Русский___ě_áñ: Uploading chunk 2/1 2025/03/12 04:21:28 DEBUG : Dropbox root 'rclone-test-fukaken8caji': Adding "測試_Русский___ě_áñ" to batch 2025/03/12 04:21:29 DEBUG : Dropbox root 'rclone-test-fukaken8caji': Batch idle for 500ms so committing 2025/03/12 04:21:29 DEBUG : Dropbox root 'rclone-test-fukaken8caji': Committing sync batch length 1 starting with: 測試_Русский___ě_áñ 2025/03/12 04:21:29 DEBUG : Dropbox root 'rclone-test-fukaken8caji': Committed sync batch length 1 starting with: 測試_Русский___ě_áñ check_test.go:574: Fs is incapable of running test, skipping: NFC checkfile vs. NFD remote (expected: 測試_Русский___ě_áñ (NFD) actual: 測試_Русский___ě_áñ (NFC)) 2025/03/12 04:21:30 DEBUG : Dropbox root 'rclone-test-fukaken8caji': Purge remote 2025/03/12 04:21:30 DEBUG : Dropbox root 'rclone-test-pacujab8gefi': Purge remote 2025/03/12 04:21:31 DEBUG : Dropbox root 'rclone-test-tajajoh1yezo': Purge remote 2025/03/12 04:21:32 DEBUG : Dropbox root 'rclone-test-yadugof4wowa': Purge remote 2025/03/12 04:21:32 DEBUG : Dropbox root 'rclone-test-noyiqit5meho': Purge remote 2025/03/12 04:21:33 DEBUG : Dropbox root 'rclone-test-suxiqeq8peto': Purge remote --- SKIP: TestApplyTransforms (37.13s) === RUN TestRcat === RUN TestRcat/withChecksum=true,ignoreChecksum=false run.go:180: Remote "Dropbox root 'rclone-test-yubefuk6rile'", Local "Local file system at /tmp/rclone3037510535", Modify Window "1s" 2025/03/12 04:21:34 ERROR : : error listing: directory not found 2025/03/12 04:21:34 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': File to upload is small (34 bytes), uploading instead of streaming 2025/03/12 04:21:34 DEBUG : with_checksum_small_file_from_pipe: Uploading chunk 1/1 2025/03/12 04:21:35 DEBUG : with_checksum_small_file_from_pipe: Uploading chunk 2/1 2025/03/12 04:21:36 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Adding "with_checksum_small_file_from_pipe" to batch 2025/03/12 04:21:36 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Batch idle for 500ms so committing 2025/03/12 04:21:36 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Committing sync batch length 1 starting with: with_checksum_small_file_from_pipe 2025/03/12 04:21:37 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Committed sync batch length 1 starting with: with_checksum_small_file_from_pipe 2025/03/12 04:21:37 DEBUG : with_checksum_small_file_from_pipe: dropbox = 6167057cad26d021a22944146dfef827ec973d33996a25ece54f17508427cf5f OK 2025/03/12 04:21:37 DEBUG : with_checksum_small_file_from_pipe: Size and dropbox of src and dst objects identical 2025/03/12 04:21:38 DEBUG : with_checksum_big_file_from_pipe: Uploading chunk 1/0 2025/03/12 04:21:38 DEBUG : with_checksum_big_file_from_pipe: Uploading chunk 2/0 2025/03/12 04:21:39 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Adding "with_checksum_big_file_from_pipe" to batch 2025/03/12 04:21:39 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Batch idle for 500ms so committing 2025/03/12 04:21:39 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Committing sync batch length 1 starting with: with_checksum_big_file_from_pipe 2025/03/12 04:21:40 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Committed sync batch length 1 starting with: with_checksum_big_file_from_pipe 2025/03/12 04:21:40 DEBUG : with_checksum_big_file_from_pipe: dropbox = 134292f7f01dbc9fa2e8230e98def0b183c01ca9fce46a144f90bee4ef0c4ef3 OK 2025/03/12 04:21:40 DEBUG : with_checksum_big_file_from_pipe: Size and dropbox of src and dst objects identical --- PASS: TestRcat (8.99s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (8.99s) PASS 2025/03/12 04:21:43 DEBUG : Dropbox root 'rclone-test-yubefuk6rile': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestDropbox: -verbose -test.run '^TestApplyTransforms$|^TestRcat$/^withChecksum=true,ignoreChecksum=false$'" - Finished OK in 47.138466165s (try 2/5)