"go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsEncoding$/^(URL_encoding|invalid_UTF-8|trailing_CR|trailing_HT|trailing_LF|trailing_VT|trailing_dot|trailing_space)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsDirMove|FsListDirFile2|FsListLevel2|FsListR|FsPurge|FsPurgeRoot|FsRmdirFull|ObjectFs|ObjectHashes|ObjectMetadata|ObjectModTime|ObjectOpen|ObjectOpenRange|ObjectOpenSeek|ObjectPartialRead|ObjectRemote|ObjectRemove|ObjectSetMetadata|ObjectSetModTime|ObjectSize|ObjectStorable|ObjectString|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FsIsFile$/^FsRoot$'" - Starting (try 2/5) === RUN TestIntegration fstests.go:442: Using remote "TestPikPak:" 2024/10/29 02:58:13 DEBUG : Creating backend with remote "TestPikPak:rclone-test-lapipax1gato" 2024/10/29 02:58:13 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/29 02:58:13 DEBUG : TestPikPak: Loaded invalid token from config file - ignoring 2024/10/29 02:58:14 DEBUG : Saving config "token" in section "TestPikPak" of the config file 2024/10/29 02:58:14 DEBUG : TestPikPak: Saved new token in config file === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:711: testing "trailing space " 2024/10/29 02:58:18 DEBUG : trailing space /trailing space : calculating gcid: failed to unwrap object from src: trailing space /trailing space 2024/10/29 02:58:18 DEBUG : trailing space /trailing space : gcid = 45ccfa87d94be0c8d259f855e0e697d18861df5d 2024/10/29 02:58:21 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:21 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2024/10/29 02:58:21 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:21 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2024/10/29 02:58:21 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:21 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2024/10/29 02:58:22 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:22 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2024/10/29 02:58:22 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:22 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/10/29 02:58:24 DEBUG : pacer: Reducing sleep to 1.5s 2024/10/29 02:58:26 DEBUG : pacer: Reducing sleep to 1.125s 2024/10/29 02:58:28 DEBUG : pacer: Reducing sleep to 843.75ms 2024/10/29 02:58:29 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/10/29 02:58:30 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/10/29 02:58:30 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/10/29 02:58:31 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/10/29 02:58:31 DEBUG : trailing space : Rmdir: contains trashed file: "trailing space " 2024/10/29 02:58:31 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/10/29 02:58:32 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/10/29 02:58:32 DEBUG : pacer: Reducing sleep to 112.627028ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:711: testing "trailing CR␍" 2024/10/29 02:58:32 DEBUG : pacer: Reducing sleep to 100ms 2024/10/29 02:58:33 DEBUG : trailing CR␍/trailing CR␍: calculating gcid: failed to unwrap object from src: trailing CR␍/trailing CR␍ 2024/10/29 02:58:33 DEBUG : trailing CR␍/trailing CR␍: gcid = 4957a85077e9fc7d2946eabb5a9c5e8a1f69477f 2024/10/29 02:58:37 DEBUG : trailing CR␍: Rmdir: contains trashed file: "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:711: testing "trailing LF␊" 2024/10/29 02:58:39 DEBUG : trailing LF␊/trailing LF␊: calculating gcid: failed to unwrap object from src: trailing LF␊/trailing LF␊ 2024/10/29 02:58:39 DEBUG : trailing LF␊/trailing LF␊: gcid = 5b5682b774918ad06715c4e44b1dc900f132bab2 2024/10/29 02:58:42 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:42 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2024/10/29 02:58:42 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:42 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2024/10/29 02:58:42 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:42 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2024/10/29 02:58:43 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:43 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2024/10/29 02:58:43 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:43 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/10/29 02:58:45 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:47 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:58:49 DEBUG : pacer: Reducing sleep to 1.5s 2024/10/29 02:58:51 DEBUG : pacer: Reducing sleep to 1.125s 2024/10/29 02:58:53 DEBUG : pacer: Reducing sleep to 843.75ms 2024/10/29 02:58:54 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/10/29 02:58:55 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/10/29 02:58:56 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/10/29 02:58:56 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/10/29 02:58:56 DEBUG : trailing LF␊: Rmdir: contains trashed file: "trailing LF␊" 2024/10/29 02:58:56 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/10/29 02:58:57 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/10/29 02:58:57 DEBUG : pacer: Reducing sleep to 112.627028ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:711: testing "trailing HT␉" 2024/10/29 02:58:58 DEBUG : pacer: Reducing sleep to 100ms 2024/10/29 02:58:58 DEBUG : trailing HT␉/trailing HT␉: calculating gcid: failed to unwrap object from src: trailing HT␉/trailing HT␉ 2024/10/29 02:58:58 DEBUG : trailing HT␉/trailing HT␉: gcid = 9e48c7f5b121fe0e65af82849da779359260c1f2 2024/10/29 02:59:00 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:00 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2024/10/29 02:59:01 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:01 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2024/10/29 02:59:01 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:01 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2024/10/29 02:59:01 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:01 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2024/10/29 02:59:02 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:02 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/10/29 02:59:04 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:06 DEBUG : pacer: Reducing sleep to 1.5s 2024/10/29 02:59:08 DEBUG : pacer: Reducing sleep to 1.125s 2024/10/29 02:59:09 DEBUG : pacer: Reducing sleep to 843.75ms 2024/10/29 02:59:10 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/10/29 02:59:11 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/10/29 02:59:12 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/10/29 02:59:12 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/10/29 02:59:12 DEBUG : trailing HT␉: Rmdir: contains trashed file: "trailing HT␉" 2024/10/29 02:59:13 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/10/29 02:59:13 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/10/29 02:59:14 DEBUG : pacer: Reducing sleep to 112.627028ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:711: testing "trailing VT␋" 2024/10/29 02:59:14 DEBUG : pacer: Reducing sleep to 100ms 2024/10/29 02:59:14 DEBUG : trailing VT␋/trailing VT␋: calculating gcid: failed to unwrap object from src: trailing VT␋/trailing VT␋ 2024/10/29 02:59:14 DEBUG : trailing VT␋/trailing VT␋: gcid = e80d606d488b1eef59d0501897947a274f94720c 2024/10/29 02:59:18 DEBUG : trailing VT␋: Rmdir: contains trashed file: "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:711: testing "trailing dot." 2024/10/29 02:59:20 DEBUG : trailing dot./trailing dot.: calculating gcid: failed to unwrap object from src: trailing dot./trailing dot. 2024/10/29 02:59:20 DEBUG : trailing dot./trailing dot.: gcid = 7bc19f45042c777c74a87b645ce4ec4d3db20060 2024/10/29 02:59:25 DEBUG : trailing dot.: Rmdir: contains trashed file: "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:711: testing "invalid utf-8\xfe" 2024/10/29 02:59:27 DEBUG : invalid utf-8/invalid utf-8: calculating gcid: failed to unwrap object from src: invalid utf-8/invalid utf-8 2024/10/29 02:59:27 DEBUG : invalid utf-8/invalid utf-8: gcid = 22cf881c1b586165bf99484e5b74130a3f67fb1d 2024/10/29 02:59:29 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:29 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2024/10/29 02:59:30 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:30 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2024/10/29 02:59:30 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:30 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2024/10/29 02:59:30 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:30 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2024/10/29 02:59:31 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:31 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/10/29 02:59:33 DEBUG : pacer: Reducing sleep to 1.5s 2024/10/29 02:59:35 DEBUG : pacer: Reducing sleep to 1.125s 2024/10/29 02:59:36 DEBUG : pacer: Reducing sleep to 843.75ms 2024/10/29 02:59:37 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/10/29 02:59:38 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/10/29 02:59:39 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/10/29 02:59:39 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/10/29 02:59:39 DEBUG : invalid utf-8: Rmdir: contains trashed file: "invalid utf-8\xfe" 2024/10/29 02:59:40 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/10/29 02:59:40 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/10/29 02:59:41 DEBUG : pacer: Reducing sleep to 112.627028ms === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:711: testing "test%46.txt" 2024/10/29 02:59:41 DEBUG : pacer: Reducing sleep to 100ms 2024/10/29 02:59:42 DEBUG : test%46.txt/test%46.txt: calculating gcid: failed to unwrap object from src: test%46.txt/test%46.txt 2024/10/29 02:59:42 DEBUG : test%46.txt/test%46.txt: gcid = 80a747dd354594fdb164a395b9dc5fbe66c24b05 2024/10/29 02:59:46 DEBUG : test%46.txt: Rmdir: contains trashed file: "test%46.txt" === RUN TestIntegration/FsMkdir/FsPutFiles 2024/10/29 02:59:47 DEBUG : file name.txt: calculating gcid: failed to unwrap object from src: file name.txt 2024/10/29 02:59:47 DEBUG : file name.txt: gcid = 3c8879e73cd73072318a2e7d2684d75866391df3 2024/10/29 02:59:52 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: calculating gcid: failed to unwrap object from src: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt 2024/10/29 02:59:52 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: gcid = 2e2c937057267cc3a09f222866a34c5741111094 2024/10/29 02:59:54 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:54 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2024/10/29 02:59:54 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:54 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2024/10/29 02:59:55 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:55 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2024/10/29 02:59:55 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:55 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2024/10/29 02:59:56 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 02:59:56 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/10/29 02:59:57 DEBUG : pacer: Reducing sleep to 1.5s 2024/10/29 02:59:59 DEBUG : pacer: Reducing sleep to 1.125s 2024/10/29 03:00:01 DEBUG : pacer: Reducing sleep to 843.75ms 2024/10/29 03:00:01 DEBUG : file name.txt: calculating gcid: failed to unwrap object from src: file name.txt 2024/10/29 03:00:01 DEBUG : file name.txt: gcid = 8145efcc52eb184cd74d974a633e0068ea5dab3c 2024/10/29 03:00:02 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/10/29 03:00:04 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/10/29 03:00:04 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/10/29 03:00:05 DEBUG : pacer: Reducing sleep to 266.967773ms 2024/10/29 03:00:05 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/10/29 03:00:06 DEBUG : pacer: Reducing sleep to 150.169371ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2024/10/29 03:00:06 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/10/29 03:00:06 DEBUG : pacer: Reducing sleep to 100ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2024/10/29 03:00:10 DEBUG : dirToPurge/fileToPurge.txt: calculating gcid: failed to unwrap object from src: dirToPurge/fileToPurge.txt 2024/10/29 03:00:10 DEBUG : dirToPurge/fileToPurge.txt: gcid = 02fecf36b463d41f951ddbaf4c581995112f9d11 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2024/10/29 03:00:18 DEBUG : dirToPurgeFromRoot/fileToPurgeFromRoot.txt: calculating gcid: failed to unwrap object from src: dirToPurgeFromRoot/fileToPurgeFromRoot.txt 2024/10/29 03:00:18 DEBUG : dirToPurgeFromRoot/fileToPurgeFromRoot.txt: gcid = 4bd0ee6a10d1e785bddeb213222e9ebf8ec9d42e 2024/10/29 03:00:22 DEBUG : Creating backend with remote "TestPikPak:rclone-test-lapipax1gato/dirToPurgeFromRoot" === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2024/10/29 03:00:26 DEBUG : Creating backend with remote "TestPikPak:rclone-test-baduvay8fawi" 2024/10/29 03:00:36 DEBUG : PikPak root 'rclone-test-baduvay8fawi': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2024/10/29 03:00:38 DEBUG : : Rmdir: contains trashed file: "dirToPurgeFromRoot" 2024/10/29 03:00:38 DEBUG : : Rmdir: contains trashed file: "dirToPurge" 2024/10/29 03:00:38 DEBUG : : Rmdir: contains file: "hello? sausage" === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1627: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1698: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime fstests.go:1755: can't set modified time === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2024/10/29 03:00:48 DEBUG : file name.txt: calculating gcid: failed to unwrap object from src: file name.txt-should-be-ignored.bin 2024/10/29 03:00:48 DEBUG : file name.txt: gcid = 740bbe671ca336d7f844d4d0ab78014ac34718c5 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2024/10/29 03:00:52 DEBUG : Creating backend with remote "TestPikPak:rclone-test-lapipax1gato/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1915: Opening root remote "TestPikPak:" path "rclone-test-lapipax1gato" from "TestPikPak:rclone-test-lapipax1gato" 2024/10/29 03:00:56 DEBUG : Creating backend with remote "TestPikPak:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2024/10/29 03:00:59 DEBUG : rclone-test-lapipax1gato/created from root.txt: calculating gcid: failed to unwrap object from src: rclone-test-lapipax1gato/created from root.txt 2024/10/29 03:00:59 DEBUG : rclone-test-lapipax1gato/created from root.txt: gcid = 28ab1f639c60be70e6ef4d84c7ac4f3f4614395f 2024/10/29 03:01:01 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 03:01:01 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2024/10/29 03:01:02 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 03:01:02 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2024/10/29 03:01:02 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 03:01:02 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2024/10/29 03:01:02 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 03:01:02 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2024/10/29 03:01:03 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 03:01:03 DEBUG : pacer: Rate limited, increasing sleep to 2s 2024/10/29 03:01:05 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 03:01:07 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2024/10/29 03:01:09 DEBUG : pacer: Reducing sleep to 1.5s 2024/10/29 03:01:11 DEBUG : pacer: Reducing sleep to 1.125s 2024/10/29 03:01:12 DEBUG : pacer: Reducing sleep to 843.75ms 2024/10/29 03:01:13 DEBUG : pacer: Reducing sleep to 632.8125ms 2024/10/29 03:01:14 DEBUG : pacer: Reducing sleep to 474.609375ms 2024/10/29 03:01:15 DEBUG : pacer: Reducing sleep to 355.957031ms 2024/10/29 03:01:15 DEBUG : pacer: Reducing sleep to 266.967773ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2024/10/29 03:01:16 DEBUG : pacer: Reducing sleep to 200.225829ms 2024/10/29 03:01:16 DEBUG : pacer: Reducing sleep to 150.169371ms 2024/10/29 03:01:17 DEBUG : pacer: Reducing sleep to 112.627028ms 2024/10/29 03:01:17 DEBUG : pacer: Reducing sleep to 100ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2024/10/29 03:01:23 ERROR : : error listing: directory not found --- PASS: TestIntegration (189.59s) --- PASS: TestIntegration/FsMkdir (186.33s) --- PASS: TestIntegration/FsMkdir/FsEncoding (90.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (14.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (6.57s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (18.77s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (16.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (5.93s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (6.86s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (14.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (6.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (94.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.56s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (7.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (8.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (11.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.28s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.27s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (1.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (2.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (1.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (4.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (3.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (21.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (2.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (18.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (2.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (3.57s) PASS ok github.com/rclone/rclone/backend/pikpak 189.599s "go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsEncoding$/^(URL_encoding|invalid_UTF-8|trailing_CR|trailing_HT|trailing_LF|trailing_VT|trailing_dot|trailing_space)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsDirMove|FsListDirFile2|FsListLevel2|FsListR|FsPurge|FsPurgeRoot|FsRmdirFull|ObjectFs|ObjectHashes|ObjectMetadata|ObjectModTime|ObjectOpen|ObjectOpenRange|ObjectOpenSeek|ObjectPartialRead|ObjectRemote|ObjectRemove|ObjectSetMetadata|ObjectSetModTime|ObjectSize|ObjectStorable|ObjectString|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FsIsFile$/^FsRoot$'" - Finished OK in 3m10.724903082s (try 2/5)