"./operations.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^(TestApplyTransforms|TestCopyFile|TestDirMove)$'" - Starting (try 2/5)
2024/11/15 01:16:52 DEBUG : Creating backend with remote "TestGoFile:rclone-test-linafol0yoxi"
2024/11/15 01:16:52 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:16:52 DEBUG : Creating backend with remote "/tmp/rclone2895058112"
=== RUN   TestApplyTransforms
2024/11/15 01:16:52 DEBUG : Creating backend with remote "TestGoFile:rclone-test-xeticeg7qolu"
2024/11/15 01:16:52 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:16:53 DEBUG : Creating backend with remote "/tmp/rclone2377549060"
    run.go:180: Remote "gofile root 'rclone-test-xeticeg7qolu'", Local "Local file system at /tmp/rclone2377549060", Modify Window "1s"
2024/11/15 01:16:53 DEBUG : Upload server store4 (eu) responded in 121.955436ms
2024/11/15 01:16:53 DEBUG : Upload server store5 (eu) responded in 125.39301ms
2024/11/15 01:16:53 DEBUG : hello, world!: Using upload server store5 (eu)
upper checkfile vs. lower remote (without normalization)
2024/11/15 01:16:55 ERROR : hello, world!: sum not found
2024/11/15 01:16:55 ERROR : HELLO, WORLD!: file not in gofile root 'rclone-test-xeticeg7qolu'
2024/11/15 01:16:55 NOTICE: gofile root 'rclone-test-xeticeg7qolu': 1 files missing
2024/11/15 01:16:55 NOTICE: 1 hashes missing
2024/11/15 01:16:55 NOTICE: gofile root 'rclone-test-xeticeg7qolu': 2 differences found
2024/11/15 01:16:55 NOTICE: gofile root 'rclone-test-xeticeg7qolu': 2 errors while checking
upper checkfile vs. lower remote (with normalization)
2024/11/15 01:16:55 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:16:55 NOTICE: gofile root 'rclone-test-xeticeg7qolu': 0 differences found
2024/11/15 01:16:55 NOTICE: gofile root 'rclone-test-xeticeg7qolu': 1 matching files
2024/11/15 01:16:55 DEBUG : Creating backend with remote "TestGoFile:rclone-test-dafasad7hiwu"
2024/11/15 01:16:55 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:16:55 DEBUG : Creating backend with remote "/tmp/rclone1735798120"
    run.go:180: Remote "gofile root 'rclone-test-dafasad7hiwu'", Local "Local file system at /tmp/rclone1735798120", Modify Window "1s"
2024/11/15 01:16:56 DEBUG : Upload server store4 (eu) responded in 125.855013ms
2024/11/15 01:16:56 DEBUG : Upload server store10 (eu) responded in 129.95736ms
2024/11/15 01:16:56 DEBUG : HELLO, WORLD!: Using upload server store10 (eu)
lower checkfile vs. upper remote (without normalization)
2024/11/15 01:16:57 ERROR : HELLO, WORLD!: sum not found
2024/11/15 01:16:57 ERROR : hello, world!: file not in gofile root 'rclone-test-dafasad7hiwu'
2024/11/15 01:16:57 NOTICE: gofile root 'rclone-test-dafasad7hiwu': 1 files missing
2024/11/15 01:16:57 NOTICE: 1 hashes missing
2024/11/15 01:16:57 NOTICE: gofile root 'rclone-test-dafasad7hiwu': 2 differences found
2024/11/15 01:16:57 NOTICE: gofile root 'rclone-test-dafasad7hiwu': 2 errors while checking
lower checkfile vs. upper remote (with normalization)
2024/11/15 01:16:58 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:16:58 NOTICE: gofile root 'rclone-test-dafasad7hiwu': 0 differences found
2024/11/15 01:16:58 NOTICE: gofile root 'rclone-test-dafasad7hiwu': 1 matching files
2024/11/15 01:16:58 DEBUG : Creating backend with remote "TestGoFile:rclone-test-mumekip4xala"
2024/11/15 01:16:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:16:59 DEBUG : Creating backend with remote "/tmp/rclone2812480950"
    run.go:180: Remote "gofile root 'rclone-test-mumekip4xala'", Local "Local file system at /tmp/rclone2812480950", Modify Window "1s"
2024/11/15 01:16:59 DEBUG : Upload server store4 (eu) responded in 130.383725ms
2024/11/15 01:16:59 DEBUG : Upload server store10 (eu) responded in 134.307539ms
2024/11/15 01:16:59 DEBUG : HeLlO, wOrLd!: Using upload server store10 (eu)
lower checkfile vs. upperlowermixed remote (without normalization)
2024/11/15 01:17:00 ERROR : HeLlO, wOrLd!: sum not found
2024/11/15 01:17:00 ERROR : hello, world!: file not in gofile root 'rclone-test-mumekip4xala'
2024/11/15 01:17:00 NOTICE: gofile root 'rclone-test-mumekip4xala': 1 files missing
2024/11/15 01:17:00 NOTICE: 1 hashes missing
2024/11/15 01:17:00 NOTICE: gofile root 'rclone-test-mumekip4xala': 2 differences found
2024/11/15 01:17:00 NOTICE: gofile root 'rclone-test-mumekip4xala': 2 errors while checking
lower checkfile vs. upperlowermixed remote (with normalization)
2024/11/15 01:17:00 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:00 NOTICE: gofile root 'rclone-test-mumekip4xala': 0 differences found
2024/11/15 01:17:00 NOTICE: gofile root 'rclone-test-mumekip4xala': 1 matching files
2024/11/15 01:17:00 DEBUG : Creating backend with remote "TestGoFile:rclone-test-gijusiq0zaso"
2024/11/15 01:17:00 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:17:00 DEBUG : Creating backend with remote "/tmp/rclone2307007842"
    run.go:180: Remote "gofile root 'rclone-test-gijusiq0zaso'", Local "Local file system at /tmp/rclone2307007842", Modify Window "1s"
2024/11/15 01:17:01 DEBUG : Upload server store5 (eu) responded in 121.476931ms
2024/11/15 01:17:01 DEBUG : Upload server store10 (eu) responded in 126.322006ms
2024/11/15 01:17:01 DEBUG : HELLO, WORLD!: Using upload server store5 (eu)
upperlowermixed checkfile vs. upper remote (without normalization)
2024/11/15 01:17:02 ERROR : HELLO, WORLD!: sum not found
2024/11/15 01:17:02 ERROR : HeLlO, wOrLd!: file not in gofile root 'rclone-test-gijusiq0zaso'
2024/11/15 01:17:02 NOTICE: gofile root 'rclone-test-gijusiq0zaso': 1 files missing
2024/11/15 01:17:02 NOTICE: 1 hashes missing
2024/11/15 01:17:02 NOTICE: gofile root 'rclone-test-gijusiq0zaso': 2 differences found
2024/11/15 01:17:02 NOTICE: gofile root 'rclone-test-gijusiq0zaso': 2 errors while checking
upperlowermixed checkfile vs. upper remote (with normalization)
2024/11/15 01:17:03 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:03 NOTICE: gofile root 'rclone-test-gijusiq0zaso': 0 differences found
2024/11/15 01:17:03 NOTICE: gofile root 'rclone-test-gijusiq0zaso': 1 matching files
2024/11/15 01:17:03 DEBUG : Creating backend with remote "TestGoFile:rclone-test-mareqer4ceja"
2024/11/15 01:17:03 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:17:03 DEBUG : Creating backend with remote "/tmp/rclone3756606599"
    run.go:180: Remote "gofile root 'rclone-test-mareqer4ceja'", Local "Local file system at /tmp/rclone3756606599", Modify Window "1s"
2024/11/15 01:17:05 DEBUG : Upload server store4 (eu) responded in 123.840659ms
2024/11/15 01:17:05 DEBUG : Upload server store5 (eu) responded in 129.864616ms
2024/11/15 01:17:05 DEBUG : 測試_Русский___ě_áñ: Using upload server store4 (eu)
NFD checkfile vs. NFC remote (without normalization)
2024/11/15 01:17:06 ERROR : 測試_Русский___ě_áñ: sum not found
2024/11/15 01:17:06 ERROR : 測試_Русский___ě_áñ: file not in gofile root 'rclone-test-mareqer4ceja'
2024/11/15 01:17:06 NOTICE: gofile root 'rclone-test-mareqer4ceja': 1 files missing
2024/11/15 01:17:06 NOTICE: 1 hashes missing
2024/11/15 01:17:06 NOTICE: gofile root 'rclone-test-mareqer4ceja': 2 differences found
2024/11/15 01:17:06 NOTICE: gofile root 'rclone-test-mareqer4ceja': 2 errors while checking
NFD checkfile vs. NFC remote (with normalization)
2024/11/15 01:17:07 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:07 NOTICE: gofile root 'rclone-test-mareqer4ceja': 0 differences found
2024/11/15 01:17:07 NOTICE: gofile root 'rclone-test-mareqer4ceja': 1 matching files
2024/11/15 01:17:07 DEBUG : Creating backend with remote "TestGoFile:rclone-test-gineduz3fiba"
2024/11/15 01:17:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:17:08 DEBUG : Creating backend with remote "/tmp/rclone1749752010"
    run.go:180: Remote "gofile root 'rclone-test-gineduz3fiba'", Local "Local file system at /tmp/rclone1749752010", Modify Window "1s"
2024/11/15 01:17:08 DEBUG : Upload server store6 (eu) responded in 125.426915ms
2024/11/15 01:17:08 DEBUG : Upload server store5 (eu) responded in 129.465971ms
2024/11/15 01:17:08 DEBUG : 測試_Русский___ě_áñ: Using upload server store5 (eu)
2024/11/15 01:17:08 DEBUG : Upload server store10 (eu) responded in 129.751976ms
NFC checkfile vs. NFD remote (without normalization)
2024/11/15 01:17:09 ERROR : 測試_Русский___ě_áñ: sum not found
2024/11/15 01:17:09 ERROR : 測試_Русский___ě_áñ: file not in gofile root 'rclone-test-gineduz3fiba'
2024/11/15 01:17:09 NOTICE: gofile root 'rclone-test-gineduz3fiba': 1 files missing
2024/11/15 01:17:09 NOTICE: 1 hashes missing
2024/11/15 01:17:09 NOTICE: gofile root 'rclone-test-gineduz3fiba': 2 differences found
2024/11/15 01:17:09 NOTICE: gofile root 'rclone-test-gineduz3fiba': 2 errors while checking
NFC checkfile vs. NFD remote (with normalization)
2024/11/15 01:17:10 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:10 NOTICE: gofile root 'rclone-test-gineduz3fiba': 0 differences found
2024/11/15 01:17:10 NOTICE: gofile root 'rclone-test-gineduz3fiba': 1 matching files
2024/11/15 01:17:10 DEBUG : Creating backend with remote "TestGoFile:rclone-test-kulider0xoku"
2024/11/15 01:17:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:17:11 DEBUG : Creating backend with remote "/tmp/rclone3652464015"
    run.go:180: Remote "gofile root 'rclone-test-kulider0xoku'", Local "Local file system at /tmp/rclone3652464015", Modify Window "1s"
2024/11/15 01:17:13 DEBUG : Upload server store5 (eu) responded in 123.960624ms
2024/11/15 01:17:13 DEBUG : Upload server store2 (eu) responded in 128.852324ms
2024/11/15 01:17:13 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Using upload server store5 (eu)
NFDx2 checkfile vs. both remote (without normalization)
2024/11/15 01:17:14 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2024/11/15 01:17:14 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in gofile root 'rclone-test-kulider0xoku'
2024/11/15 01:17:14 NOTICE: gofile root 'rclone-test-kulider0xoku': 1 files missing
2024/11/15 01:17:14 NOTICE: 1 hashes missing
2024/11/15 01:17:14 NOTICE: gofile root 'rclone-test-kulider0xoku': 2 differences found
2024/11/15 01:17:14 NOTICE: gofile root 'rclone-test-kulider0xoku': 2 errors while checking
NFDx2 checkfile vs. both remote (with normalization)
2024/11/15 01:17:14 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:14 NOTICE: gofile root 'rclone-test-kulider0xoku': 0 differences found
2024/11/15 01:17:14 NOTICE: gofile root 'rclone-test-kulider0xoku': 1 matching files
2024/11/15 01:17:14 DEBUG : Creating backend with remote "TestGoFile:rclone-test-luraveh9fopo"
2024/11/15 01:17:14 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:17:15 DEBUG : Creating backend with remote "/tmp/rclone1886972126"
    run.go:180: Remote "gofile root 'rclone-test-luraveh9fopo'", Local "Local file system at /tmp/rclone1886972126", Modify Window "1s"
2024/11/15 01:17:15 DEBUG : Upload server store1 (eu) responded in 122.959383ms
2024/11/15 01:17:15 DEBUG : Upload server store6 (eu) responded in 127.592581ms
2024/11/15 01:17:15 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Using upload server store1 (eu)
NFCx2 checkfile vs. both remote (without normalization)
2024/11/15 01:17:16 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2024/11/15 01:17:16 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in gofile root 'rclone-test-luraveh9fopo'
2024/11/15 01:17:16 NOTICE: gofile root 'rclone-test-luraveh9fopo': 1 files missing
2024/11/15 01:17:16 NOTICE: 1 hashes missing
2024/11/15 01:17:16 NOTICE: gofile root 'rclone-test-luraveh9fopo': 2 differences found
2024/11/15 01:17:16 NOTICE: gofile root 'rclone-test-luraveh9fopo': 2 errors while checking
NFCx2 checkfile vs. both remote (with normalization)
2024/11/15 01:17:16 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:16 NOTICE: gofile root 'rclone-test-luraveh9fopo': 0 differences found
2024/11/15 01:17:16 NOTICE: gofile root 'rclone-test-luraveh9fopo': 1 matching files
2024/11/15 01:17:16 DEBUG : Creating backend with remote "TestGoFile:rclone-test-yunisir2tiwa"
2024/11/15 01:17:16 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:17:17 DEBUG : Creating backend with remote "/tmp/rclone3295947627"
    run.go:180: Remote "gofile root 'rclone-test-yunisir2tiwa'", Local "Local file system at /tmp/rclone3295947627", Modify Window "1s"
2024/11/15 01:17:18 DEBUG : Upload server store4 (eu) responded in 124.064999ms
2024/11/15 01:17:18 DEBUG : Upload server store2 (eu) responded in 125.639552ms
2024/11/15 01:17:18 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Using upload server store2 (eu)
both checkfile vs. NFDx2 remote (without normalization)
2024/11/15 01:17:19 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2024/11/15 01:17:19 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in gofile root 'rclone-test-yunisir2tiwa'
2024/11/15 01:17:19 NOTICE: gofile root 'rclone-test-yunisir2tiwa': 1 files missing
2024/11/15 01:17:19 NOTICE: 1 hashes missing
2024/11/15 01:17:19 NOTICE: gofile root 'rclone-test-yunisir2tiwa': 2 differences found
2024/11/15 01:17:19 NOTICE: gofile root 'rclone-test-yunisir2tiwa': 2 errors while checking
both checkfile vs. NFDx2 remote (with normalization)
2024/11/15 01:17:20 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:20 NOTICE: gofile root 'rclone-test-yunisir2tiwa': 0 differences found
2024/11/15 01:17:20 NOTICE: gofile root 'rclone-test-yunisir2tiwa': 1 matching files
2024/11/15 01:17:20 DEBUG : Creating backend with remote "TestGoFile:rclone-test-dugujoq2julu"
2024/11/15 01:17:20 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/15 01:17:20 DEBUG : Creating backend with remote "/tmp/rclone860934616"
    run.go:180: Remote "gofile root 'rclone-test-dugujoq2julu'", Local "Local file system at /tmp/rclone860934616", Modify Window "1s"
2024/11/15 01:17:21 DEBUG : Upload server store1 (eu) responded in 127.556144ms
2024/11/15 01:17:21 DEBUG : Upload server store6 (eu) responded in 127.571382ms
2024/11/15 01:17:21 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: Using upload server store1 (eu)
both checkfile vs. NFCx2 remote (without normalization)
2024/11/15 01:17:21 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2024/11/15 01:17:21 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in gofile root 'rclone-test-dugujoq2julu'
2024/11/15 01:17:21 NOTICE: gofile root 'rclone-test-dugujoq2julu': 1 files missing
2024/11/15 01:17:21 NOTICE: 1 hashes missing
2024/11/15 01:17:21 NOTICE: gofile root 'rclone-test-dugujoq2julu': 2 differences found
2024/11/15 01:17:21 NOTICE: gofile root 'rclone-test-dugujoq2julu': 2 errors while checking
both checkfile vs. NFCx2 remote (with normalization)
2024/11/15 01:17:21 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2024/11/15 01:17:21 NOTICE: gofile root 'rclone-test-dugujoq2julu': 0 differences found
2024/11/15 01:17:21 NOTICE: gofile root 'rclone-test-dugujoq2julu': 1 matching files
2024/11/15 01:17:21 DEBUG : gofile root 'rclone-test-dugujoq2julu': Purge remote
2024/11/15 01:17:22 DEBUG : gofile root 'rclone-test-yunisir2tiwa': Purge remote
2024/11/15 01:17:22 DEBUG : gofile root 'rclone-test-luraveh9fopo': Purge remote
2024/11/15 01:17:22 DEBUG : gofile root 'rclone-test-kulider0xoku': Purge remote
2024/11/15 01:17:23 DEBUG : gofile root 'rclone-test-gineduz3fiba': Purge remote
2024/11/15 01:17:23 DEBUG : gofile root 'rclone-test-mareqer4ceja': Purge remote
2024/11/15 01:17:23 DEBUG : gofile root 'rclone-test-gijusiq0zaso': Purge remote
2024/11/15 01:17:24 DEBUG : gofile root 'rclone-test-mumekip4xala': Purge remote
2024/11/15 01:17:25 DEBUG : gofile root 'rclone-test-dafasad7hiwu': Purge remote
2024/11/15 01:17:25 DEBUG : gofile root 'rclone-test-xeticeg7qolu': Purge remote
--- PASS: TestApplyTransforms (33.31s)
=== RUN   TestCopyFile
    run.go:180: Remote "gofile root 'rclone-test-linafol0yoxi'", Local "Local file system at /tmp/rclone2895058112", Modify Window "1s"
2024/11/15 01:17:26 DEBUG : file1: Need to transfer - File not found at Destination
2024/11/15 01:17:27 DEBUG : Upload server store4 (eu) responded in 120.295506ms
2024/11/15 01:17:27 DEBUG : Upload server store5 (eu) responded in 124.026349ms
2024/11/15 01:17:27 DEBUG : sub/file2: Using upload server store4 (eu)
2024/11/15 01:17:27 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK
2024/11/15 01:17:27 INFO  : file1: Copied (new) to: sub/file2
2024/11/15 01:17:27 DEBUG : file1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/15 01:17:27 DEBUG : file1: Unchanged skipping
2024/11/15 01:17:27 DEBUG : gofile root 'rclone-test-linafol0yoxi': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestCopyFile (3.09s)
=== RUN   TestDirMove
    run.go:180: Remote "gofile root 'rclone-test-linafol0yoxi'", Local "Local file system at /tmp/rclone2895058112", Modify Window "1s"
2024/11/15 01:17:29 DEBUG : A1/one: Using upload server store4 (eu)
2024/11/15 01:17:29 DEBUG : A1/two: Using upload server store5 (eu)
2024/11/15 01:17:30 DEBUG : A1/B1/three: Using upload server store5 (eu)
2024/11/15 01:17:31 DEBUG : A1/B1/C1/four: Using upload server store5 (eu)
2024/11/15 01:17:32 DEBUG : A1/B1/C2/five: Using upload server store5 (eu)
2024/11/15 01:17:32 DEBUG : A1/B2: Making directory
2024/11/15 01:17:32 DEBUG : A1/B1/C3: Making directory
2024/11/15 01:17:37 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:17:42 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2024/11/15 01:17:42 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2024/11/15 01:17:43 DEBUG : pacer: Reducing sleep to 10ms
2024/11/15 01:17:43 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:17:43 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:17:44 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2024/11/15 01:17:44 INFO  : A2/two: Moved (server-side) to: A3/two
2024/11/15 01:17:44 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2024/11/15 01:17:48 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2024/11/15 01:17:48 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2024/11/15 01:17:48 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2024/11/15 01:17:48 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2024/11/15 01:17:48 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:17:48 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:17:53 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2024/11/15 01:17:53 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2024/11/15 01:17:53 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2024/11/15 01:17:53 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2024/11/15 01:17:54 DEBUG : pacer: Reducing sleep to 80ms
2024/11/15 01:17:54 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2024/11/15 01:17:54 DEBUG : pacer: Reducing sleep to 40ms
2024/11/15 01:17:54 INFO  : A2/one: Moved (server-side) to: A3/one
2024/11/15 01:17:54 DEBUG : pacer: Reducing sleep to 20ms
2024/11/15 01:17:54 DEBUG : pacer: Reducing sleep to 10ms
2024/11/15 01:17:57 INFO  : gofile root 'rclone-test-linafol0yoxi': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2024/11/15 01:18:00 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:00 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:00 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:00 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:01 INFO  : A3/one: Moved (server-side) to: A4/one
2024/11/15 01:18:05 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2024/11/15 01:18:05 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2024/11/15 01:18:05 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2024/11/15 01:18:05 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2024/11/15 01:18:05 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2024/11/15 01:18:05 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2024/11/15 01:18:05 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2024/11/15 01:18:05 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2024/11/15 01:18:05 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:05 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:05 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:06 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:10 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2024/11/15 01:18:10 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2024/11/15 01:18:10 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2024/11/15 01:18:10 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2024/11/15 01:18:10 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:10 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2024/11/15 01:18:10 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2024/11/15 01:18:11 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:11 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2024/11/15 01:18:11 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2024/11/15 01:18:12 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:14 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:15 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2024/11/15 01:18:15 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2024/11/15 01:18:16 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2024/11/15 01:18:16 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
2024/11/15 01:18:17 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2024/11/15 01:18:17 DEBUG : pacer: Rate limited, increasing sleep to 20s
2024/11/15 01:18:17 DEBUG : Rate limited, sleep for 5s
2024/11/15 01:18:19 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2024/11/15 01:18:22 DEBUG : pacer: low level retry 4/10 (error Error "error-rateLimit")
2024/11/15 01:18:37 DEBUG : pacer: Reducing sleep to 10s
2024/11/15 01:18:37 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
2024/11/15 01:18:57 DEBUG : pacer: Reducing sleep to 5s
2024/11/15 01:18:57 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2024/11/15 01:19:07 DEBUG : pacer: Reducing sleep to 2.5s
2024/11/15 01:19:07 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
2024/11/15 01:19:12 DEBUG : pacer: Reducing sleep to 1.25s
2024/11/15 01:19:12 INFO  : A3/two: Moved (server-side) to: A4/two
2024/11/15 01:19:15 DEBUG : pacer: Reducing sleep to 625ms
2024/11/15 01:19:16 DEBUG : pacer: Reducing sleep to 312.5ms
2024/11/15 01:19:16 DEBUG : pacer: Reducing sleep to 156.25ms
2024/11/15 01:19:17 DEBUG : pacer: Reducing sleep to 78.125ms
2024/11/15 01:19:17 DEBUG : pacer: Reducing sleep to 39.0625ms
2024/11/15 01:19:17 DEBUG : pacer: Reducing sleep to 19.53125ms
2024/11/15 01:19:18 DEBUG : pacer: Reducing sleep to 10ms
--- PASS: TestDirMove (120.00s)
PASS
2024/11/15 01:19:29 DEBUG : gofile root 'rclone-test-linafol0yoxi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^(TestApplyTransforms|TestCopyFile|TestDirMove)$'" - Finished OK in 2m37.001013456s (try 2/5)