"go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$'" - Starting (try 3/5)
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestPikPak:"
2024/11/27 02:21:32 DEBUG : Creating backend with remote "TestPikPak:rclone-test-xutuhat8posu"
2024/11/27 02:21:32 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2024/11/27 02:21:35 DEBUG : file name.txt: calculating gcid: failed to unwrap object from src: file name.txt
2024/11/27 02:21:35 DEBUG : file name.txt: gcid = e8bf233e2b0989767ad1ba7603373b5e632e7b3e
2024/11/27 02:21:37 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:37 DEBUG : pacer: Rate limited, increasing sleep to 200ms
2024/11/27 02:21:38 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:38 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2024/11/27 02:21:38 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:38 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2024/11/27 02:21:38 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:38 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2024/11/27 02:21:39 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:39 DEBUG : pacer: Rate limited, increasing sleep to 2s
2024/11/27 02:21:41 DEBUG : pacer: Reducing sleep to 1.5s
2024/11/27 02:21:43 DEBUG : pacer: Reducing sleep to 1.125s
2024/11/27 02:21:44 DEBUG : pacer: Reducing sleep to 843.75ms
2024/11/27 02:21:45 DEBUG : pacer: Reducing sleep to 632.8125ms
2024/11/27 02:21:46 DEBUG : pacer: Reducing sleep to 474.609375ms
2024/11/27 02:21:47 DEBUG : pacer: Reducing sleep to 355.957031ms
2024/11/27 02:21:47 DEBUG : pacer: Reducing sleep to 266.967773ms
2024/11/27 02:21:48 DEBUG : pacer: Reducing sleep to 200.225829ms
2024/11/27 02:21:48 DEBUG : pacer: Reducing sleep to 150.169371ms
2024/11/27 02:21:48 DEBUG : pacer: Reducing sleep to 112.627028ms
2024/11/27 02:21:48 DEBUG : pacer: Reducing sleep to 100ms
2024/11/27 02:21:48 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: calculating gcid: failed to unwrap object from src: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt
2024/11/27 02:21:48 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: gcid = dcde7dbe63635efb45e9c57610b19a7180524348
2024/11/27 02:21:51 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 200ms
2024/11/27 02:21:51 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2024/11/27 02:21:51 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2024/11/27 02:21:51 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2024/11/27 02:21:52 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:21:52 DEBUG : pacer: Rate limited, increasing sleep to 2s
2024/11/27 02:21:54 DEBUG : pacer: Reducing sleep to 1.5s
2024/11/27 02:21:56 DEBUG : pacer: Reducing sleep to 1.125s
2024/11/27 02:21:57 DEBUG : pacer: Reducing sleep to 843.75ms
2024/11/27 02:21:57 DEBUG : file name.txt: calculating gcid: failed to unwrap object from src: file name.txt
2024/11/27 02:21:57 DEBUG : file name.txt: gcid = 88aa268caa580d5943a20ed806fc035308a4bbd3
2024/11/27 02:21:59 DEBUG : pacer: Reducing sleep to 632.8125ms
2024/11/27 02:22:00 DEBUG : pacer: Reducing sleep to 474.609375ms
2024/11/27 02:22:01 DEBUG : pacer: Reducing sleep to 355.957031ms
2024/11/27 02:22:02 DEBUG : pacer: Reducing sleep to 266.967773ms
2024/11/27 02:22:02 DEBUG : pacer: Reducing sleep to 200.225829ms
2024/11/27 02:22:03 DEBUG : pacer: Reducing sleep to 150.169371ms
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1915: Opening root remote "TestPikPak:" path "rclone-test-xutuhat8posu" from "TestPikPak:rclone-test-xutuhat8posu"
2024/11/27 02:22:03 DEBUG : Creating backend with remote "TestPikPak:"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
2024/11/27 02:22:04 DEBUG : rclone-test-xutuhat8posu/created from root.txt: calculating gcid: failed to unwrap object from src: rclone-test-xutuhat8posu/created from root.txt
2024/11/27 02:22:04 DEBUG : rclone-test-xutuhat8posu/created from root.txt: gcid = a015163fb0afb8b07aa6b26eb9f6e834084b90d8
2024/11/27 02:22:06 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:06 DEBUG : pacer: Rate limited, increasing sleep to 200ms
2024/11/27 02:22:07 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:07 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2024/11/27 02:22:07 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:07 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2024/11/27 02:22:07 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:07 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2024/11/27 02:22:08 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:08 DEBUG : pacer: Rate limited, increasing sleep to 2s
2024/11/27 02:22:10 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:12 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:14 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING)
2024/11/27 02:22:16 DEBUG : pacer: Reducing sleep to 1.5s
2024/11/27 02:22:18 DEBUG : pacer: Reducing sleep to 1.125s
2024/11/27 02:22:19 DEBUG : pacer: Reducing sleep to 843.75ms
2024/11/27 02:22:20 DEBUG : pacer: Reducing sleep to 632.8125ms
2024/11/27 02:22:21 DEBUG : pacer: Reducing sleep to 474.609375ms
2024/11/27 02:22:22 DEBUG : pacer: Reducing sleep to 355.957031ms
2024/11/27 02:22:22 DEBUG : pacer: Reducing sleep to 266.967773ms
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
2024/11/27 02:22:23 DEBUG : pacer: Reducing sleep to 200.225829ms
2024/11/27 02:22:23 DEBUG : pacer: Reducing sleep to 150.169371ms
2024/11/27 02:22:24 DEBUG : pacer: Reducing sleep to 112.627028ms
2024/11/27 02:22:24 DEBUG : pacer: Reducing sleep to 100ms
2024/11/27 02:22:26 DEBUG : pacer: Reducing sleep to 112.627028ms
2024/11/27 02:22:26 DEBUG : pacer: Reducing sleep to 100ms
2024/11/27 02:22:27 ERROR : : error listing: directory not found
--- PASS: TestIntegration (54.36s)
    --- PASS: TestIntegration/FsMkdir (52.34s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (49.99s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (22.17s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (22.17s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (2.52s)
PASS
ok  	github.com/rclone/rclone/backend/pikpak	54.366s
"go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$'" - Finished OK in 55.015045447s (try 3/5)