"./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^(TestCat|TestCheckSumDownload|TestCopyFileMaxTransfer)$|^TestHashSums$/^Md5Download$'" - Starting (try 4/5) 2024/12/19 05:17:59 DEBUG : Creating backend with remote "TestPikPak:rclone-test-lovireb7woji" 2024/12/19 05:17:59 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/12/19 05:18:01 DEBUG : Creating backend with remote "/tmp/rclone3020174403" === RUN TestCheckSumDownload run.go:180: Remote "PikPak root 'rclone-test-lovireb7woji'", Local "Local file system at /tmp/rclone3020174403", Modify Window "876000h0m0s" 2024/12/19 05:18:01 DEBUG : Creating backend with remote "TestPikPak:rclone-test-lovireb7woji/data" 2024/12/19 05:18:03 DEBUG : data/banana: calculating gcid: failed to unwrap object from src: data/banana 2024/12/19 05:18:03 DEBUG : data/banana: gcid = 5a20dd2421f633d21da85b8911f9f37677f212d5 2024/12/19 05:18:03 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2024/12/19 05:18:03 DEBUG : test.sum: gcid = a5968cd7981dde739b5ed764a5ed354ef42c42b2 === RUN TestCheckSumDownload/subtest1 === NAME TestCheckSumDownload check_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:409 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Received unexpected error: failed to parse sum file: open file failed: Get "https://dl-a10b-0886.mypikpak.com/download/?fid=S_ZNW_6_aRCmHoWYBmJsI2F7WPTM0HpvkD4yUg3XK6WzJq9mYs4L8WlkbXxd2YuSwMQ725caXBsOjnIxKx119GDoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671885&g=A5968CD7981DDE739B5ED764A5ED354EF42C42B2&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=41&alt=0&us=0&hspu=&po=0&fileid=VOESLV84qZC1yeFQ935zahD5o1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVevb85PsEaM320Pe934rWdyFOve1kwgS6f13O8LE13Kkzd-kL8pvMWg9TeFgeHHy0m-FqIDD4VUkAUz-b9iol9zaMlywCjd16BtKNUn7bueaxQY_p3uL4-8h5XWKffPcALe7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMPUAc96I-9DGpcOrcxSbOUKL_yaE61l4jISdrc3xwJTM0vZ3KW-m6MQ683e581kgLa7j5F0H3VwjQXY6vX7Br4QeiowMg1-oVdVA0TDYjp1PZ8zYQBINboBZE1C30iq5v6FW7j2O-sbBhfnrmuv23HgPnSK50g8uyqXJFNNpe_S3MznNcb0igrTx8KVG1NruU2DoZzT-vUu_tJ2oJhKlEDU=&sign=7F3AB432892985D6DC56B53C5D25BAF9": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host Test: TestCheckSumDownload Messages: unexpected error in run 1 check_test.go:418: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:418 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: "" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 1 check_test.go:420: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: 1 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 1 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "= banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=8) "= banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong combined result in run 1 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 1 2024/12/19 05:18:05 DEBUG : data/potato: calculating gcid: failed to unwrap object from src: data/potato 2024/12/19 05:18:05 DEBUG : data/potato: gcid = 7a3c15f717358c93392def5ff0639db84c0d363b 2024/12/19 05:18:06 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2024/12/19 05:18:06 DEBUG : test.sum: gcid = a5968cd7981dde739b5ed764a5ed354ef42c42b2 === RUN TestCheckSumDownload/subtest2 === NAME TestCheckSumDownload check_test.go:414: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:414 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: 1 actual : 0 Test: TestCheckSumDownload Messages: wrong error count in run 2 check_test.go:418: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:418 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: "" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 2 check_test.go:420: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: 2 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 2 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "- potato", "= banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=8) "- potato", - (string) (len=8) "= banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong combined result in run 2 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:423 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong missingonsrc result in run 2 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 2 2024/12/19 05:18:09 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2024/12/19 05:18:09 DEBUG : test.sum: gcid = f3a0ff69df1baee079fa197e53142fe40231e82b === RUN TestCheckSumDownload/subtest3 2024/12/19 05:18:16 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2024/12/19 05:18:16 DEBUG : test.sum: gcid = 4432a75a15f9e866fc8b0361de0580e4ab920bea === RUN TestCheckSumDownload/subtest4 2024/12/19 05:18:21 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2024/12/19 05:18:21 DEBUG : test.sum: gcid = c2c6d29ce2f4e1f6e3e830802ef4a15c32af89c4 === RUN TestCheckSumDownload/subtest5 === NAME TestCheckSumDownload check_test.go:414: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:414 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: 1 actual : 2 Test: TestCheckSumDownload Messages: wrong error count in run 5 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "+ orange", "= banana", "= potato"} actual : []string{"", "! banana", "+ orange", "= potato"} Diff: --- Expected +++ Actual @@ -2,4 +2,4 @@ (string) "", + (string) (len=8) "! banana", (string) (len=8) "+ orange", - (string) (len=8) "= banana", (string) (len=8) "= potato" Test: TestCheckSumDownload Messages: wrong combined result in run 5 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "banana", "potato"} actual : []string{"", "potato"} Diff: --- Expected +++ Actual @@ -1,4 +1,3 @@ -([]string) (len=3) { +([]string) (len=2) { (string) "", - (string) (len=6) "banana", (string) (len=6) "potato" Test: TestCheckSumDownload Messages: wrong match result in run 5 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:427 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{} actual : []string{"", "banana"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) "", + (string) (len=6) "banana" } Test: TestCheckSumDownload Messages: wrong error result in run 5 2024/12/19 05:18:27 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2024/12/19 05:18:27 DEBUG : test.sum: gcid = 903d92580da389428c3eace6c6dce692463e75e8 === RUN TestCheckSumDownload/subtest6 === NAME TestCheckSumDownload check_test.go:414: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:414 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: 2 actual : 3 Test: TestCheckSumDownload Messages: wrong error count in run 6 check_test.go:418: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:418 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: "2024/12/19 05:18:32 ERROR : banana: Failed to calculate hash: open file failed: Get \"https://dl-a10b-0886.mypikpak.com/download/?fid=U-aRK8vbwS07_5__Ck8zg80b5s4PiaOsxAlBxcf6C3TQ_4CqeCbQfjq-_sgrkD9B0dbERai5NMCyhUNqJPh7VWDoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671912&g=5A20DD2421F633D21DA85B8911F9F37677F212D5&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=13&alt=0&us=0&hspu=&po=0&fileid=VOESLUzstJsXdVIWpfPhBe6Ao1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVehTq4Zk76OdYRwH43w3EjS3IKYSMGre4g1Wi2Q6NqqtodbkA6kZkSP_ujigZjQrxE1BXwrGqXHgFS49Rhcw6vrIZAnpBA-BAKIBnSwQwGX2YqSmKTD7HYvfntvICad-a-e7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMCBisSxKqEPPNdbcryMI_jlS1v76NFzaH5XXWODl5qCbiRPjIilxKQ4NAq1x_mX9uIJNHPbm3YSpxuSV7m947U8-I-UTTWomZxYMySrA2eeQgnJzcr8iIfolT7tqXwTt_q2F6hNDmStB1DByTrergppsiQImCPPGbgcWR7U9PRdySo2U29JeH3_dXYk7ftvRpw==&sign=FC487B407787EF1BB0D18CC382CA9276\": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host\n2024/12/19 05:18:33 DEBUG : md5 = 65a8e27d8879283831b664bd8b7f0ad4 (sum)\n2024/12/19 05:18:33 DEBUG : potato: md5 = 87396e030ef3f5b35bbf85c0a09a4fb3 (PikPak root 'rclone-test-lovireb7woji/data')\n2024/12/19 05:18:33 ERROR : potato: files differ\n2024/12/19 05:18:33 ERROR : orange: file not in PikPak root 'rclone-test-lovireb7woji/data'\n2024/12/19 05:18:33 NOTICE: PikPak root 'rclone-test-lovireb7woji/data': 1 files missing\n2024/12/19 05:18:33 NOTICE: PikPak root 'rclone-test-lovireb7woji/data': 3 differences found\n2024/12/19 05:18:33 NOTICE: PikPak root 'rclone-test-lovireb7woji/data': 3 errors while checking\n" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "* potato", "+ orange", "= banana"} actual : []string{"", "! banana", "* potato", "+ orange"} Diff: --- Expected +++ Actual @@ -2,5 +2,5 @@ (string) "", + (string) (len=8) "! banana", (string) (len=8) "* potato", - (string) (len=8) "+ orange", - (string) (len=8) "= banana" + (string) (len=8) "+ orange" } Test: TestCheckSumDownload Messages: wrong combined result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "banana"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,4 +1,2 @@ -([]string) (len=2) { - (string) "", - (string) (len=6) "banana" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 6 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:427 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{} actual : []string{"", "banana"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) "", + (string) (len=6) "banana" } Test: TestCheckSumDownload Messages: wrong error result in run 6 2024/12/19 05:18:33 DEBUG : data/banana: calculating gcid: failed to unwrap object from src: data/banana 2024/12/19 05:18:33 DEBUG : data/banana: gcid = 5a20dd2421f633d21da85b8911f9f37677f212d5 2024/12/19 05:18:35 DEBUG : data/potato: calculating gcid: failed to unwrap object from src: data/potato 2024/12/19 05:18:35 DEBUG : data/potato: gcid = 7a3c15f717358c93392def5ff0639db84c0d363b 2024/12/19 05:18:37 DEBUG : test.sum: calculating gcid: failed to unwrap object from src: test.sum 2024/12/19 05:18:37 DEBUG : test.sum: gcid = 551b7ddca65803810ea668343a66646180a0c0b7 === RUN TestCheckSumDownload/subtest7 === NAME TestCheckSumDownload check_test.go:409: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:409 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Received unexpected error: failed to parse sum file: open file failed: Get "https://dl-a10b-0886.mypikpak.com/download/?fid=OWY3L-jemBmEeqK_XAOSQAzby3QKLg7M_PpV3JaDp0ZX2L8e8Fiy6RoRuXz_d1_IkMoZdfU8pbDr03hKRP85aGDoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671920&g=551B7DDCA65803810EA668343A66646180A0C0B7&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=82&alt=0&us=0&hspu=&po=0&fileid=VOESLcPObGAqjO9BZJ76BVlqo1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVevFQtfd-AFabW_tL9EUuXpTCfNhKMvgZzV6VUBv26oqfN_-_T4pni5yHnwmqEAQNo2wSEKq8oV0-9dal4f4uma8HvA2qZFtaT6b3ULmbXiRhZ5Yd9eYx9GwcyCP1lCsEtu7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMPo_RpZbqkhX_MOvpvPpZZCO4kKPBW2ge3RH6-Pu1zkeHQ63VVKLOoJQHmV3VC_EaYv8NRJEFdvLoBk5O4j1eaUSI8zDZaR8vN_vPfoIhY0l1qdcdfKLEMeL6XIZPzEiP1YkGdjPRE6SydaiH3BeFLXCcAzuwkKmw1ATxTuwTQHDHCq0lEupgGoHE6Y02yxQGmDoZzT-vUu_tJ2oJhKlEDU=&sign=EDEE46EF9BA5321938E175F3DA74A416": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host Test: TestCheckSumDownload Messages: unexpected error in run 7 check_test.go:418: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:418 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: "" does not contain "matching files" Test: TestCheckSumDownload Messages: missing matching files in run 7 check_test.go:420: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:420 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: 2 actual : 0 Test: TestCheckSumDownload Messages: wrong number of checks in run 7 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:422 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "= banana", "= potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=8) "= banana", - (string) (len=8) "= potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong combined result in run 7 check_test.go:388: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:388 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:425 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:433 Error: Not equal: expected: []string{"", "banana", "potato"} actual : []string{} Diff: --- Expected +++ Actual @@ -1,5 +1,2 @@ -([]string) (len=3) { - (string) "", - (string) (len=6) "banana", - (string) (len=6) "potato" +([]string) { } Test: TestCheckSumDownload Messages: wrong match result in run 7 2024/12/19 05:18:44 DEBUG : data: Rmdir: contains trashed file: "potato" 2024/12/19 05:18:44 DEBUG : data: Rmdir: contains trashed file: "banana" 2024/12/19 05:18:44 DEBUG : data: Rmdir: contains trashed file: "potato" 2024/12/19 05:18:44 DEBUG : data: Rmdir: contains trashed file: "banana" --- FAIL: TestCheckSumDownload (44.75s) --- PASS: TestCheckSumDownload/subtest1 (0.66s) --- PASS: TestCheckSumDownload/subtest2 (0.61s) --- PASS: TestCheckSumDownload/subtest3 (4.21s) --- PASS: TestCheckSumDownload/subtest4 (3.15s) --- PASS: TestCheckSumDownload/subtest5 (2.80s) --- PASS: TestCheckSumDownload/subtest6 (3.88s) --- PASS: TestCheckSumDownload/subtest7 (0.61s) === RUN TestCopyFileMaxTransfer run.go:180: Remote "PikPak root 'rclone-test-lovireb7woji'", Local "Local file system at /tmp/rclone3020174403", Modify Window "876000h0m0s" 2024/12/19 05:18:46 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2024/12/19 05:18:47 DEBUG : TestCopyFileMaxTransfer/file1: gcid = 3823E2B83A3BA8D1137EFC1FE13E3A2E7CFB8D82 2024/12/19 05:18:47 DEBUG : TestCopyFileMaxTransfer/file1: Dst hash empty - aborting Src hash check 2024/12/19 05:18:47 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2024/12/19 05:18:48 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2024/12/19 05:18:49 DEBUG : TestCopyFileMaxTransfer/file2: calculating gcid: 2024/12/19 05:18:49 DEBUG : TestCopyFileMaxTransfer/file2: gcid = 34fe5fc4492c9b26f0b9b067fb40fe54e4ce0dd2 2024/12/19 05:18:49 DEBUG : file2: canceling upload: failed to upload: read upload data failed: max transfer limit reached as set by --max-transfer 2024/12/19 05:18:51 DEBUG : file2: waiting 500ms for the cancellation to be effective 2024/12/19 05:18:51 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: failed to upload: read upload data failed: max transfer limit reached as set by --max-transfer 2024/12/19 05:18:52 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination 2024/12/19 05:18:53 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination 2024/12/19 05:18:53 DEBUG : TestCopyFileMaxTransfer/file4: calculating gcid: 2024/12/19 05:18:53 DEBUG : TestCopyFileMaxTransfer/file4: gcid = cc66834a20c156579d9fa8c043cc8bf861bd6c9c 2024/12/19 05:18:56 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:18:56 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2024/12/19 05:18:56 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:18:56 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2024/12/19 05:18:56 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:18:56 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2024/12/19 05:18:57 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:18:57 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2024/12/19 05:18:57 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:18:57 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/12/19 05:18:59 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:19:01 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:19:03 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/12/19 05:19:05 DEBUG : pacer: Reducing sleep to 1.5s 2024/12/19 05:19:05 DEBUG : TestCopyFileMaxTransfer/file4: Dst hash empty - aborting Src hash check 2024/12/19 05:19:05 INFO : TestCopyFileMaxTransfer/file4: Copied (new) 2024/12/19 05:19:07 DEBUG : pacer: Reducing sleep to 1.125s 2024/12/19 05:19:09 DEBUG : pacer: Reducing sleep to 843.75ms 2024/12/19 05:19:10 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/12/19 05:19:10 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/12/19 05:19:11 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/12/19 05:19:12 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/12/19 05:19:12 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/12/19 05:19:13 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/12/19 05:19:13 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/12/19 05:19:13 DEBUG : TestCopyFileMaxTransfer: Rmdir: contains trashed file: "file4" 2024/12/19 05:19:13 DEBUG : TestCopyFileMaxTransfer: Rmdir: contains trashed file: "file1" 2024/12/19 05:19:13 DEBUG : pacer: Reducing sleep to 100ms --- PASS: TestCopyFileMaxTransfer (29.07s) === RUN TestHashSums run.go:180: Remote "PikPak root 'rclone-test-lovireb7woji'", Local "Local file system at /tmp/rclone3020174403", Modify Window "876000h0m0s" 2024/12/19 05:19:15 DEBUG : potato2: calculating gcid: failed to unwrap object from src: potato2 2024/12/19 05:19:15 DEBUG : potato2: gcid = f284ca644cf64403b777451495ca659cc12415af 2024/12/19 05:19:15 DEBUG : empty space: calculating gcid: failed to unwrap object from src: empty space 2024/12/19 05:19:15 DEBUG : empty space: gcid = 09f49478af9c899f0e74bf1a8e2ec667345a178b === RUN TestHashSums/Md5Download 2024/12/19 05:19:17 ERROR : potato2: failed to open file potato2: open file failed: Get "https://dl-a10b-0886.mypikpak.com/download/?fid=iYmBN12e48xy7opRIJHF6A6ex1yDvo_LpyAVGB3aIRz00C-96g7zxaHH7EKyqBdjpeXuHkQlVoI6Qg9zFY43iWDoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671957&g=F284CA644CF64403B777451495CA659CC12415AF&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=60&alt=0&us=0&hspu=&po=0&fileid=VOESLl_eIz_zcEoVY8ujHsVBo1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVekRJ_RBR5L_RA3-asZyT8NheQIKQZ687Oyq8K3Sm7wbt4VDavVNtVpb9qtlL0TMbpee6Ozo3xTpF1fB3APpiVp1UUNbUE6u6_QkeBEZdvcySNKZ6xkJ1RznYUcHURN7Rce7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMO5_g9lXF2jdTUGm1RS4q3DXuGKhrJbA497xffa6Q6KvqsE4WgawMe2YvAnY9XJCNzp2vYHULXFAyp9gbzqz_qC7n5f7RhWJXPnQC-R-QU0osji8YnRD1dWGOgU0eldV03TQnmqTBL_LZudWNqz85W2ZmWF3t-CPhFic_s73LwGGPOrE2d6WLkBN43dQf-tpgA==&sign=066F753E779E4C0411A20D18C26DFA2F": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host operations_test.go:280: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:280 Error: "336d5ebc5436534e61d16e63ddfca327 empty space\n" does not contain "d6548b156ea68a4e003e786df99eee76 potato2\n" Test: TestHashSums/Md5Download --- FAIL: TestHashSums (6.08s) --- FAIL: TestHashSums/Md5Download (2.11s) === RUN TestCat run.go:180: Remote "PikPak root 'rclone-test-lovireb7woji'", Local "Local file system at /tmp/rclone3020174403", Modify Window "876000h0m0s" 2024/12/19 05:19:21 DEBUG : file1: calculating gcid: failed to unwrap object from src: file1 2024/12/19 05:19:21 DEBUG : file1: gcid = 4d8356ed1af6fd7e9537777328c6d176effe38a0 2024/12/19 05:19:21 DEBUG : file2: calculating gcid: failed to unwrap object from src: file2 2024/12/19 05:19:21 DEBUG : file2: gcid = 9e3614f5e363b3d1060c1e4d6738e7c26804ae41 2024/12/19 05:19:24 ERROR : file2: Failed to open: open file failed: Get "https://dl-a10b-0886.mypikpak.com/download/?fid=7YIO7uckd3_jmos2W1ZROwIqYkyjbQM5MoQhucajPD6XPSL-DLrNKISQSh_lkfy80VWZULp2JWCi-775TgGmS2DoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671964&g=9E3614F5E363B3D1060C1E4D6738E7C26804AE41&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=9&alt=0&us=0&hspu=&po=0&fileid=VOESLnCLXMRAaBI1k-jizBS0o1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVepCDuOAF-_uKprwhedqnR5XBV4H3fEdftcIodcbvH4aHFfatBGaO6Rl3LaImfEGMVITGaFPAoPXDnFkmVgXyYb5p1hH1prCTNMVm0YybJoF3pF-xfZGR5GIp8bpfAECY6-7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMCBisSxKqEPPNdbcryMI_jlS1v76NFzaH5XXWODl5qCb51jY940cqUNYnswBPZNQVJMW5E3PjtYXgdf0gHeDU9cE2yom6NEmSQM-rxLKfLjwIKyapj_OwOdoxc7rOWEg41XZrjnMEXJ6FQ40_kwXFK6nhDiJKW2KLFttkkPWsxdLgGb7aEzR5DSj99-xXdl0tg==&sign=1ADAF05310BAD80B1CF5DB1DD641CB2B": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host operations_test.go:566: Incorrect output from Cat(0,-1,): "ABCDEFGHIJ" 2024/12/19 05:19:28 ERROR : file2: Failed to open: open file failed: Get "https://dl-a10b-0886.mypikpak.com/download/?fid=7YIO7uckd3_jmos2W1ZROwIqYkyjbQM5MoQhucajPD6XPSL-DLrNKISQSh_lkfy80VWZULp2JWCi-775TgGmS2DoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671968&g=9E3614F5E363B3D1060C1E4D6738E7C26804AE41&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=9&alt=0&us=0&hspu=&po=0&fileid=VOESLnCLXMRAaBI1k-jizBS0o1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVepCDuOAF-_uKprwhedqnR5XBV4H3fEdftcIodcbvH4aHFfatBGaO6Rl3LaImfEGMVITGaFPAoPXDnFkmVgXyYb5p1hH1prCTNMVm0YybJoF3pF-xfZGR5GIp8bpfAECY6-7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMI_xPSKL_YMxnqU3LoyqldRD6lTuDnu6eZqhf0zMsb80qBzNxdqNeXC0Eb7BXTyDbNR8qR_DpZM4onig9xYmt92xA0qpu2Z0HAWH0aSoTLLM3Lk_ymk2v6w-KxBDE7Gd6lTghU_DdWNoPTKCK3pUiAqmuVYwE5J-EgIYu0H4i4kS6j0hkrvIpf3jLMIjxVxItA==&sign=1BADB6C4C59C679D64BD9FE70D9E4F50": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host operations_test.go:566: Incorrect output from Cat(-3,-1,): "HIJ" 2024/12/19 05:19:29 ERROR : file1: Failed to open: open file failed: Get "https://dl-a10b-0886.mypikpak.com/download/?fid=UDEyDb0UhPsiGEH8kn6ruKCVbR4voY236XOvnoDVbz_hH9Lx93K3xMq4gvOAFQNAbS926G9WYgfwTx8WMQNajGDoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671968&g=4D8356ED1AF6FD7E9537777328C6D176EFFE38A0&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=10&alt=0&us=0&hspu=&po=0&fileid=VOESLn3dbGAqjO9BZJ76BYQNo1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVejwOvcQxDX4xsbHL9nTpagbbfdmVwhypQbghtwuVTHWPOi-2ij4tp5-KM7GswcAh2j4alQeSsGlH1IqyM2dZLpJDleDWsmxV_bLnZsamPP7uzcLfwImkUPbKWtCYn2VD6u7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMCBisSxKqEPPNdbcryMI_jkqV9ANrDg33y5IrreZ0fQP_oqOWuEV5a-cfSXPRAE8AuGiNg1Rycx2PUOzQDyxTKvS7kxoUEtLeXxtreJjdFsZJJEBrZb0h_7jx0Sffjlp7QbJX3YR4ZXaVXsaxrScyXZTTE_ozvBZ-HRStjgiHiNwHOc1ujhguIWrajHXSHrzdg==&sign=C704775F4C00A30F0A6586058BB95776": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host operations_test.go:566: Incorrect output from Cat(1,3,): "123" 2024/12/19 05:19:30 ERROR : file1: Failed to open: open file failed: Get "https://dl-a10b-0886.mypikpak.com/download/?fid=UDEyDb0UhPsiGEH8kn6ruKCVbR4voY236XOvnoDVbz_hH9Lx93K3xMq4gvOAFQNAbS926G9WYgfwTx8WMQNajGDoZzT-vUu_tJ2oJhKlEDU=&from=5&verno=3&prod=pikpak&expire=1734671970&g=4D8356ED1AF6FD7E9537777328C6D176EFFE38A0&ui=ZB7KFqZKGnYUJW_K&t=0&ms=6291456&th=6291456&f=10&alt=0&us=0&hspu=&po=0&fileid=VOESLn3dbGAqjO9BZJ76BYQNo1&userid=ZB7KFqZKGnYUJW_K&pr=XQPkPvr9WWiIuMvELmrVejwOvcQxDX4xsbHL9nTpagbbfdmVwhypQbghtwuVTHWPOi-2ij4tp5-KM7GswcAh2j4alQeSsGlH1IqyM2dZLpJDleDWsmxV_bLnZsamPP7uzcLfwImkUPbKWtCYn2VD6u7XfMsn-81SpNGg6doho5tEii4wy9hkZJ9C8h2auy9krLRJh7fARGBC61uo_b8JMPo_RpZbqkhX_MOvpvPpZZCblMpEPpLZVMCOzFLVJ-AD2xzR1lzoKcI1XAAQJ3P1QDmGmJmL9q0iqaQDpblRfCEfO-ZxCyBXb_GaPOpeEfwWm1Uhmedb1wC-GgZ8PsK-SvCrxnnu5NNdST6rkXZiLTFyQs0386MqfBYO91HEsPuYgGb7aEzR5DSj99-xXdl0tg==&sign=54BD4EA37F2B9D0AAC35B002222C513F": dial tcp: lookup dl-a10b-0886.mypikpak.com on 127.0.0.53:53: no such host operations_test.go:566: Incorrect output from Cat(0,-1, ): "012345678\n" --- FAIL: TestCat (12.60s) FAIL 2024/12/19 05:19:33 DEBUG : PikPak root 'rclone-test-lovireb7woji': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^(TestCat|TestCheckSumDownload|TestCopyFileMaxTransfer)$|^TestHashSums$/^Md5Download$'" - Finished ERROR in 1m34.867309731s (try 4/5): exit status 1: Failed [TestCheckSumDownload TestHashSums/Md5Download TestCat]