"go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsDirMove|FsPurge|FsPurgeRoot)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$'" - Starting (try 3/5) === RUN TestIntegration fstests.go:442: Using remote "TestPikPak:" 2025/02/17 05:35:48 DEBUG : Creating backend with remote "TestPikPak:rclone-test-bahofaj5kuye" 2025/02/17 05:35:48 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsPutFiles 2025/02/17 05:35:50 DEBUG : file name.txt: calculating gcid: failed to unwrap object from src: file name.txt 2025/02/17 05:35:50 DEBUG : file name.txt: gcid = 3223b1e5b7248b7983604e59668e2d66ac066435 2025/02/17 05:35:53 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:35:53 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2025/02/17 05:35:53 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:35:53 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2025/02/17 05:35:53 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:35:53 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2025/02/17 05:35:53 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:35:53 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2025/02/17 05:35:54 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:35:54 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/02/17 05:35:56 DEBUG : pacer: Reducing sleep to 1.5s 2025/02/17 05:35:58 DEBUG : pacer: Reducing sleep to 1.125s 2025/02/17 05:35:59 DEBUG : pacer: Reducing sleep to 843.75ms 2025/02/17 05:36:00 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/02/17 05:36:01 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/02/17 05:36:02 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/02/17 05:36:02 DEBUG : pacer: Reducing sleep to 266.967773ms 2025/02/17 05:36:03 DEBUG : pacer: Reducing sleep to 200.225829ms 2025/02/17 05:36:03 DEBUG : pacer: Reducing sleep to 150.169371ms 2025/02/17 05:36:03 DEBUG : pacer: Reducing sleep to 112.627028ms 2025/02/17 05:36:04 DEBUG : pacer: Reducing sleep to 100ms 2025/02/17 05:36:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: calculating gcid: failed to unwrap object from src: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt 2025/02/17 05:36:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: gcid = 0541f1b27809e0c41ff8297ce6ec4805bdcfb946 2025/02/17 05:36:06 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:06 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2025/02/17 05:36:06 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:06 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2025/02/17 05:36:06 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:06 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2025/02/17 05:36:07 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:07 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2025/02/17 05:36:07 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:07 DEBUG : pacer: Rate limited, increasing sleep to 2s 2025/02/17 05:36:09 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:11 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:13 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:15 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:17 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2025/02/17 05:36:17 DEBUG : z.txt: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOJHP-tyLdYUx8G9hxMr6exko1", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0xc0001eee80), FileID:"VOJHP-tjLdYUx8G9hxMr6exio1", FileName:"z.txt", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0xd3b7380, ext:63875367364, loc:(*time.Location)(0xc0001e09a0)}, UpdatedTime:api.Time{wall:0xf32fdc0, ext:63875367364, loc:(*time.Location)(0xc0001e09a0)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0d8b20b308a8f2fb094caba73cd2b809f7f3c636", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2025/02/17 05:36:19 DEBUG : pacer: Reducing sleep to 1.5s 2025/02/17 05:36:21 DEBUG : pacer: Reducing sleep to 1.125s 2025/02/17 05:36:23 DEBUG : pacer: Reducing sleep to 843.75ms 2025/02/17 05:36:23 DEBUG : z.txt: waiting 500ms for the cancellation to be effective fstests.go:145: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:161 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:223 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:213 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:958 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOJHP-tyLdYUx8G9hxMr6exko1", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0xc0001eee80), FileID:"VOJHP-tjLdYUx8G9hxMr6exio1", FileName:"z.txt", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0xd3b7380, ext:63875367364, loc:(*time.Location)(0xc0001e09a0)}, UpdatedTime:api.Time{wall:0xf32fdc0, ext:63875367364, loc:(*time.Location)(0xc0001e09a0)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0d8b20b308a8f2fb094caba73cd2b809f7f3c636", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsPutFiles Messages: Put 2025/02/17 05:36:24 DEBUG : pacer: Reducing sleep to 632.8125ms 2025/02/17 05:36:25 DEBUG : pacer: Reducing sleep to 474.609375ms 2025/02/17 05:36:25 DEBUG : pacer: Reducing sleep to 355.957031ms 2025/02/17 05:36:25 ERROR : : error listing: directory not found 2025/02/17 05:36:26 DEBUG : pacer: Reducing sleep to 266.967773ms --- FAIL: TestIntegration (37.71s) --- FAIL: TestIntegration/FsMkdir (36.15s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (33.65s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/pikpak 37.718s "go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsDirMove|FsPurge|FsPurgeRoot)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$'" - Finished ERROR in 38.501263357s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutFiles]