"./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCat$'" - Starting (try 2/5)
2025/08/17 03:44:27 DEBUG : Creating backend with remote "TestPikPak:rclone-test-cuyewey5jubi"
2025/08/17 03:44:27 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/17 03:44:29 DEBUG : Creating backend with remote "/tmp/rclone1992819596"
=== RUN   TestCat
    run.go:180: Remote "PikPak root 'rclone-test-cuyewey5jubi'", Local "Local file system at /tmp/rclone1992819596", Modify Window "876000h0m0s"
2025/08/17 03:44:30 DEBUG : file1: calculating gcid: failed to unwrap object from src: file1
2025/08/17 03:44:30 DEBUG : file1: gcid = 4d8356ed1af6fd7e9537777328c6d176effe38a0
2025/08/17 03:44:32 DEBUG : file2: calculating gcid: failed to unwrap object from src: file2
2025/08/17 03:44:32 DEBUG : file2: gcid = 9e3614f5e363b3d1060c1e4d6738e7c26804ae41
2025/08/17 03:44:40 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:44:40 DEBUG : pacer: Rate limited, increasing sleep to 200ms
2025/08/17 03:44:46 DEBUG : pacer: low level retry 2/10 (error no link)
2025/08/17 03:44:46 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2025/08/17 03:44:47 DEBUG : pacer: Reducing sleep to 300ms
2025/08/17 03:44:48 DEBUG : pacer: Reducing sleep to 225ms
2025/08/17 03:44:55 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:44:55 DEBUG : pacer: Rate limited, increasing sleep to 450ms
2025/08/17 03:44:55 DEBUG : pacer: Reducing sleep to 337.5ms
2025/08/17 03:44:56 DEBUG : pacer: Reducing sleep to 253.125ms
2025/08/17 03:44:57 DEBUG : pacer: Reducing sleep to 189.84375ms
2025/08/17 03:44:57 DEBUG : pacer: Reducing sleep to 142.382812ms
2025/08/17 03:44:58 DEBUG : pacer: Reducing sleep to 106.787109ms
2025/08/17 03:44:59 DEBUG : pacer: Reducing sleep to 100ms
2025/08/17 03:45:06 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:45:06 DEBUG : pacer: Rate limited, increasing sleep to 200ms
2025/08/17 03:45:07 DEBUG : pacer: Reducing sleep to 150ms
2025/08/17 03:45:07 DEBUG : pacer: Reducing sleep to 112.5ms
2025/08/17 03:45:13 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:45:13 DEBUG : pacer: Rate limited, increasing sleep to 225ms
2025/08/17 03:45:20 DEBUG : pacer: low level retry 2/10 (error no link)
2025/08/17 03:45:20 DEBUG : pacer: Rate limited, increasing sleep to 450ms
2025/08/17 03:45:26 DEBUG : pacer: low level retry 3/10 (error no link)
2025/08/17 03:45:26 DEBUG : pacer: Rate limited, increasing sleep to 900ms
2025/08/17 03:45:32 DEBUG : pacer: low level retry 4/10 (error no link)
2025/08/17 03:45:32 DEBUG : pacer: Rate limited, increasing sleep to 1.8s
2025/08/17 03:45:34 DEBUG : Saving config "captcha_token" in section "TestPikPak" of the config file
2025/08/17 03:45:40 DEBUG : pacer: low level retry 5/10 (error no link)
2025/08/17 03:45:40 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/08/17 03:45:47 DEBUG : pacer: low level retry 6/10 (error no link)
2025/08/17 03:45:53 DEBUG : pacer: low level retry 7/10 (error no link)
2025/08/17 03:45:59 DEBUG : pacer: low level retry 8/10 (error no link)
2025/08/17 03:46:06 DEBUG : pacer: low level retry 9/10 (error no link)
2025/08/17 03:46:12 DEBUG : pacer: low level retry 10/10 (error no link)
2025/08/17 03:46:12 ERROR : file2: Failed to open: can't download: no link
    operations_test.go:566: Incorrect output from Cat(-3,-1,): "HIJ"
2025/08/17 03:46:12 DEBUG : pacer: Reducing sleep to 1.5s
2025/08/17 03:46:21 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:46:21 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/08/17 03:46:27 DEBUG : pacer: low level retry 2/10 (error no link)
2025/08/17 03:46:34 DEBUG : pacer: low level retry 3/10 (error no link)
2025/08/17 03:46:40 DEBUG : pacer: low level retry 4/10 (error no link)
2025/08/17 03:46:46 DEBUG : pacer: low level retry 5/10 (error no link)
2025/08/17 03:46:53 DEBUG : pacer: low level retry 6/10 (error no link)
2025/08/17 03:46:53 DEBUG : pacer: Reducing sleep to 1.5s
2025/08/17 03:46:56 DEBUG : pacer: Reducing sleep to 1.125s
2025/08/17 03:47:03 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:47:03 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/08/17 03:47:09 DEBUG : pacer: low level retry 2/10 (error no link)
2025/08/17 03:47:15 DEBUG : pacer: low level retry 3/10 (error no link)
2025/08/17 03:47:22 DEBUG : pacer: low level retry 4/10 (error no link)
2025/08/17 03:47:28 DEBUG : pacer: low level retry 5/10 (error no link)
2025/08/17 03:47:34 DEBUG : pacer: low level retry 6/10 (error no link)
2025/08/17 03:47:41 DEBUG : pacer: low level retry 7/10 (error no link)
2025/08/17 03:47:47 DEBUG : pacer: low level retry 8/10 (error no link)
2025/08/17 03:47:53 DEBUG : pacer: low level retry 9/10 (error no link)
2025/08/17 03:47:55 DEBUG : pacer: Reducing sleep to 1.5s
2025/08/17 03:47:56 DEBUG : pacer: Reducing sleep to 1.125s
2025/08/17 03:47:57 DEBUG : pacer: Reducing sleep to 843.75ms
2025/08/17 03:48:04 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:48:04 DEBUG : pacer: Rate limited, increasing sleep to 1.6875s
2025/08/17 03:48:11 DEBUG : pacer: low level retry 2/10 (error no link)
2025/08/17 03:48:11 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/08/17 03:48:17 DEBUG : pacer: low level retry 3/10 (error no link)
2025/08/17 03:48:18 DEBUG : pacer: Reducing sleep to 1.5s
2025/08/17 03:48:20 DEBUG : pacer: Reducing sleep to 1.125s
2025/08/17 03:48:27 DEBUG : pacer: low level retry 1/10 (error no link)
2025/08/17 03:48:27 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/08/17 03:48:33 DEBUG : pacer: low level retry 2/10 (error no link)
2025/08/17 03:48:34 DEBUG : pacer: Reducing sleep to 1.5s
2025/08/17 03:48:37 DEBUG : pacer: Reducing sleep to 1.125s
2025/08/17 03:48:37 DEBUG : pacer: Reducing sleep to 843.75ms
2025/08/17 03:48:38 DEBUG : pacer: Reducing sleep to 632.8125ms
2025/08/17 03:48:39 DEBUG : pacer: Reducing sleep to 474.609375ms
2025/08/17 03:48:40 DEBUG : pacer: Reducing sleep to 355.957031ms
2025/08/17 03:48:41 DEBUG : pacer: Reducing sleep to 266.967773ms
2025/08/17 03:48:41 DEBUG : pacer: Reducing sleep to 200.225829ms
--- FAIL: TestCat (252.61s)
FAIL
2025/08/17 03:48:41 DEBUG : PikPak root 'rclone-test-cuyewey5jubi': Purge remote
2025/08/17 03:48:42 DEBUG : pacer: Reducing sleep to 150.169371ms
2025/08/17 03:48:42 DEBUG : pacer: Reducing sleep to 112.627028ms
"./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCat$'" - Finished ERROR in 4m15.414315473s (try 2/5): exit status 1: Failed [TestCat]