"go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsEncoding$/^(URL_encoding|dot|dot_dot|invalid_UTF-8|leading_CR|leading_HT|leading_LF|leading_VT|leading_dot|leading_space|leading_tilde|punctuation|trailing_CR|trailing_HT|trailing_LF|trailing_VT|trailing_dot|trailing_space)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsDirMove|FsListDirFile2|FsListLevel2|FsListR|FsPurge|FsPurgeRoot|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$'" - Starting (try 4/5) === RUN TestIntegration fstests.go:438: Using remote "TestPikPak:" 2026/05/26 05:48:16 DEBUG : Creating backend with remote "TestPikPak:rclone-test-xalomag6vawa" 2026/05/26 05:48:16 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "." 2026/05/26 05:48:20 DEBUG : ./.: calculating gcid: failed to unwrap object from src: ./. 2026/05/26 05:48:20 DEBUG : ./.: gcid = 895e1a70ffb00522cc021a634f2ab6951fff62d8 2026/05/26 05:48:22 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:22 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2026/05/26 05:48:22 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:22 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/05/26 05:48:22 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:22 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/05/26 05:48:23 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:23 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/05/26 05:48:24 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:24 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:48:25 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:27 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:29 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:31 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:33 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:33 DEBUG : .: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXoupCvMrbtRECAyCY2IFSo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7c6c0), FileID:"VOtXouosvMrbtRECAyCY2IFLo2", FileName:".", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0xa4fc540, ext:63915371300, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0xb34a700, ext:63915371300, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:48:35 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:48:37 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:48:39 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:48:39 DEBUG : .: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXoupCvMrbtRECAyCY2IFSo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7c6c0), FileID:"VOtXouosvMrbtRECAyCY2IFLo2", FileName:".", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0xa4fc540, ext:63915371300, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0xb34a700, ext:63915371300, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/dot Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing ".." 2026/05/26 05:48:40 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:48:41 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:48:41 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:48:41 DEBUG : ../..: calculating gcid: failed to unwrap object from src: ../.. 2026/05/26 05:48:41 DEBUG : ../..: gcid = 6e1b9082a276cd0e394be1b3809e4a80b116d0e7 2026/05/26 05:48:42 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:48:43 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:48:44 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:44 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:48:44 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:44 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:48:45 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:45 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:48:45 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:45 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:48:47 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:49 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:51 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:53 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:55 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:57 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:48:57 DEBUG : ..: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXp-BEPKMfnjsNrfnRSPDso2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bdb080), FileID:"VOtXp-AxPKMfnjsNrfnRSPDpo2", FileName:"..", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x791ddc0, ext:63915371322, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x88601c0, ext:63915371322, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:48:59 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:49:01 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:49:02 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:49:02 DEBUG : ..: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXp-BEPKMfnjsNrfnRSPDso2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bdb080), FileID:"VOtXp-AxPKMfnjsNrfnRSPDpo2", FileName:"..", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x791ddc0, ext:63915371322, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x88601c0, ext:63915371322, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/dot_dot Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/05/26 05:49:04 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:49:04 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:49:05 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:49:05 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: calculating gcid: failed to unwrap object from src: !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~ 2026/05/26 05:49:05 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: gcid = 08176ffb2ffe0beb0c70874b4a70ddc71eee2a51 2026/05/26 05:49:06 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:49:07 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:49:08 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:08 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:49:08 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:08 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:49:08 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:08 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:49:09 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:09 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:49:11 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:13 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:15 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:17 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:19 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:21 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:21 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXp4z2xysrtlbGO4bdegSCo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bda140), FileID:"VOtXp4yixysrtlbGO4bdegSAo2", FileName:"!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x33334cc0, ext:63915371345, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x34c00740, ext:63915371345, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:49:23 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:49:25 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:49:26 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:49:26 DEBUG : !"#$%&'()*+,-./:;<=>?@[\]^_`{|}~: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXp4z2xysrtlbGO4bdegSCo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bda140), FileID:"VOtXp4yixysrtlbGO4bdegSAo2", FileName:"!"#$%&'()*+,-./:;<=>?@[\]^_`{|}~", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x33334cc0, ext:63915371345, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x34c00740, ext:63915371345, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/punctuation Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/05/26 05:49:27 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:49:28 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:49:29 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:49:29 DEBUG : leading space/ leading space: calculating gcid: failed to unwrap object from src: leading space/ leading space 2026/05/26 05:49:29 DEBUG : leading space/ leading space: gcid = 5ecbfead8d696510b20bf95162f7312f9e572f71 2026/05/26 05:49:29 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:49:30 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:49:31 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:31 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:49:32 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:32 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:49:32 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:32 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:49:33 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:33 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:49:34 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:36 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:38 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:40 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:42 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:44 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:44 DEBUG : leading space: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpAlAwdghKGXvoDVJszhdo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7db00), FileID:"VOtXpAkswdghKGXvoDVJszhYo2", FileName:"␠leading space", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x209a8ec0, ext:63915371369, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x21dafe00, ext:63915371369, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:49:46 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:49:48 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:49:50 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:49:50 DEBUG : leading space: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpAlAwdghKGXvoDVJszhdo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7db00), FileID:"VOtXpAkswdghKGXvoDVJszhYo2", FileName:"␠leading space", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x209a8ec0, ext:63915371369, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x21dafe00, ext:63915371369, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/leading_space Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/05/26 05:49:51 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:49:52 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:49:52 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:49:52 DEBUG : ~leading tilde/~leading tilde: calculating gcid: failed to unwrap object from src: ~leading tilde/~leading tilde 2026/05/26 05:49:52 DEBUG : ~leading tilde/~leading tilde: gcid = 7fc841ae6d4289485ae26ff52661dee34175ab63 2026/05/26 05:49:53 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:49:54 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:49:56 DEBUG : Saving config "captcha_token" in section "TestPikPak" of the config file 2026/05/26 05:49:56 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:56 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:49:56 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:56 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:49:57 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:57 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:49:57 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:49:57 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:49:59 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:01 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:03 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:05 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:07 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:09 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:09 DEBUG : ~leading tilde: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpGZA7eiNHlxF1dHLr6N5o2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b1cc0), FileID:"VOtXpGYr7eiNHlxF1dHLr6N3o2", FileName:"~leading tilde", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x11584ec0, ext:63915371393, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x127a3980, ext:63915371393, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:50:11 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:50:13 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:50:15 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:50:15 DEBUG : ~leading tilde: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpGZA7eiNHlxF1dHLr6N5o2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b1cc0), FileID:"VOtXpGYr7eiNHlxF1dHLr6N3o2", FileName:"~leading tilde", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x11584ec0, ext:63915371393, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x127a3980, ext:63915371393, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/leading_tilde Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/05/26 05:50:16 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:50:17 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:50:17 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:50:17 DEBUG : ␍leading CR/␍leading CR: calculating gcid: failed to unwrap object from src: ␍leading CR/␍leading CR 2026/05/26 05:50:17 DEBUG : ␍leading CR/␍leading CR: gcid = 1e43b4d071aa0a516912f26efe1bd07c5e19923a 2026/05/26 05:50:18 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:50:19 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:50:20 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:20 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:50:20 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:20 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:50:20 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:20 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:50:21 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:21 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:50:23 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:25 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:50:27 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:50:29 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:50:30 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:50:31 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:50:32 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:50:33 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:50:33 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:50:34 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:50:34 DEBUG : pacer: Reducing sleep to 150.169371ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/05/26 05:50:36 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/05/26 05:50:36 DEBUG : pacer: Reducing sleep to 100ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:715 Error: Not equal: expected: []string{"␍leading CR"} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", "~leading tilde", "␍leading CR", ".", ".."} Diff: --- Expected +++ Actual @@ -1,3 +1,8 @@ -([]string) (len=1) { - (string) (len=13) "␍leading CR" +([]string) (len=6) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=14) "~leading tilde", + (string) (len=13) "␍leading CR", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/leading_CR Messages: directories 2026/05/26 05:50:46 DEBUG : ␍leading CR: Rmdir: contains trashed file: "␍leading CR" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:718 Error: Not equal: expected: []string{} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", "~leading tilde", ".", ".."} Diff: --- Expected +++ Actual @@ -1,2 +1,7 @@ -([]string) { +([]string) (len=5) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=14) "~leading tilde", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/leading_CR Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/05/26 05:50:59 DEBUG : ␊leading LF/␊leading LF: calculating gcid: failed to unwrap object from src: ␊leading LF/␊leading LF 2026/05/26 05:50:59 DEBUG : ␊leading LF/␊leading LF: gcid = 93c1d57399310f3777fad2a4c22a0b02f5855cc2 2026/05/26 05:51:02 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:02 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2026/05/26 05:51:02 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:02 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/05/26 05:51:02 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:02 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/05/26 05:51:03 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:03 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/05/26 05:51:04 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:04 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:51:05 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:07 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:09 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:11 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:13 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:13 DEBUG : ␊leading LF: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpWoDxysrtlbGO4bdejcco2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b0c40), FileID:"VOtXpWnpxysrtlbGO4bdejcao2", FileName:"␊leading LF", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x32e70180, ext:63915371459, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x3436b300, ext:63915371459, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:51:15 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:51:17 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:51:19 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:51:19 DEBUG : ␊leading LF: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpWoDxysrtlbGO4bdejcco2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b0c40), FileID:"VOtXpWnpxysrtlbGO4bdejcao2", FileName:"␊leading LF", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x32e70180, ext:63915371459, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x3436b300, ext:63915371459, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/leading_LF Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/05/26 05:51:20 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:51:21 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:51:21 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:51:21 DEBUG : ␉leading HT/␉leading HT: calculating gcid: failed to unwrap object from src: ␉leading HT/␉leading HT 2026/05/26 05:51:21 DEBUG : ␉leading HT/␉leading HT: gcid = a76ab38cfb3b876232ed105bc066a8f34a34be56 2026/05/26 05:51:22 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:51:23 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:51:24 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:24 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:51:24 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:24 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:51:24 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:24 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:51:25 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:25 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:51:27 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:29 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:31 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:33 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:35 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:37 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:37 DEBUG : ␉leading HT: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpbG_P8pJpznJL4h1NTPno2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e8577fe40), FileID:"VOtXpbGIP8pJpznJL4h1NTPlo2", FileName:"␉leading HT", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0xcb21f40, ext:63915371482, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0xea9a980, ext:63915371482, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:51:39 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:51:41 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:51:42 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:51:42 DEBUG : ␉leading HT: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpbG_P8pJpznJL4h1NTPno2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e8577fe40), FileID:"VOtXpbGIP8pJpznJL4h1NTPlo2", FileName:"␉leading HT", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0xcb21f40, ext:63915371482, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0xea9a980, ext:63915371482, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/leading_HT Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/05/26 05:51:44 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:51:44 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:51:45 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:51:45 DEBUG : ␋leading VT/␋leading VT: calculating gcid: failed to unwrap object from src: ␋leading VT/␋leading VT 2026/05/26 05:51:45 DEBUG : ␋leading VT/␋leading VT: gcid = 7f9df04b21a4efefa3ccbae390e9fc1f951743f0 2026/05/26 05:51:46 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:51:47 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:51:48 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:48 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:51:48 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:48 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:51:48 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:48 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:51:49 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:49 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:51:51 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:53 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:55 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:57 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:51:59 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:01 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:01 DEBUG : ␋leading VT: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXph1kUBs4vXGGkBmGgWJmo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bda0c0), FileID:"VOtXph1QUBs4vXGGkBmGgWJko2", FileName:"␋leading VT", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x32116200, ext:63915371505, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x337055c0, ext:63915371505, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:52:03 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:52:05 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:52:06 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:52:06 DEBUG : ␋leading VT: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXph1kUBs4vXGGkBmGgWJmo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bda0c0), FileID:"VOtXph1QUBs4vXGGkBmGgWJko2", FileName:"␋leading VT", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x32116200, ext:63915371505, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x337055c0, ext:63915371505, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/leading_VT Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/05/26 05:52:07 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:52:08 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:52:09 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:52:09 DEBUG : .leading dot/.leading dot: calculating gcid: failed to unwrap object from src: .leading dot/.leading dot 2026/05/26 05:52:09 DEBUG : .leading dot/.leading dot: gcid = 91d8ebf4a26d74f049ce651f9299ada1acbd3b4e 2026/05/26 05:52:09 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:52:11 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:52:12 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:12 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:52:12 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:12 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:52:12 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:12 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:52:13 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:13 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:52:15 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:17 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:19 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:21 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:23 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:25 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:25 DEBUG : .leading dot: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpmpWP8pJpznJL4h1NVsfo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7dd00), FileID:"VOtXpmoyP8pJpznJL4h1NVsTo2", FileName:".leading dot", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x21ea4040, ext:63915371529, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x230c2b00, ext:63915371529, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:52:27 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:52:29 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:52:30 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:52:30 DEBUG : .leading dot: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpmpWP8pJpznJL4h1NVsfo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7dd00), FileID:"VOtXpmoyP8pJpznJL4h1NVsTo2", FileName:".leading dot", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x21ea4040, ext:63915371529, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x230c2b00, ext:63915371529, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/leading_dot Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/05/26 05:52:32 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:52:32 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:52:33 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:52:33 DEBUG : trailing space /trailing space : calculating gcid: failed to unwrap object from src: trailing space /trailing space 2026/05/26 05:52:33 DEBUG : trailing space /trailing space : gcid = 6acdc743a60dcb483769c0ab5898e4ab86be9e66 2026/05/26 05:52:34 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:52:35 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:52:35 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:35 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:52:36 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:36 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:52:36 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:36 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:52:37 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:37 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:52:38 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:40 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:42 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:44 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:46 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:48 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:48 DEBUG : trailing space : canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpskZzX6u7mP6jFvZfabso2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b0500), FileID:"VOtXpskDzX6u7mP6jFvZfabmo2", FileName:"trailing space␠", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x315a4700, ext:63915371553, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x327c31c0, ext:63915371553, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:52:50 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:52:52 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:52:54 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:52:54 DEBUG : trailing space : waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpskZzX6u7mP6jFvZfabso2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b0500), FileID:"VOtXpskDzX6u7mP6jFvZfabmo2", FileName:"trailing space␠", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x315a4700, ext:63915371553, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x327c31c0, ext:63915371553, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/trailing_space Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/05/26 05:52:55 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:52:56 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:52:57 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:52:57 DEBUG : trailing CR␍/trailing CR␍: calculating gcid: failed to unwrap object from src: trailing CR␍/trailing CR␍ 2026/05/26 05:52:57 DEBUG : trailing CR␍/trailing CR␍: gcid = 0c2a1fa2db90e4f518b4f7b5a239d8725bb2f7fc 2026/05/26 05:52:57 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:52:58 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:52:59 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:59 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:52:59 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:52:59 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:53:00 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:00 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:53:01 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:01 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:53:02 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:04 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:06 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:08 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:10 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:12 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:12 DEBUG : trailing CR␍: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpyWEvMrbtRECAyCY2edZo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7c3c0), FileID:"VOtXpyVqvMrbtRECAyCY2edQo2", FileName:"trailing CR␍", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x1945ba00, ext:63915371577, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x1a492040, ext:63915371577, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:53:14 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:53:16 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:53:18 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:53:18 DEBUG : trailing CR␍: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXpyWEvMrbtRECAyCY2edZo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7c3c0), FileID:"VOtXpyVqvMrbtRECAyCY2edQo2", FileName:"trailing CR␍", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x1945ba00, ext:63915371577, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x1a492040, ext:63915371577, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/trailing_CR Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/05/26 05:53:19 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:53:20 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:53:20 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:53:20 DEBUG : trailing LF␊/trailing LF␊: calculating gcid: failed to unwrap object from src: trailing LF␊/trailing LF␊ 2026/05/26 05:53:20 DEBUG : trailing LF␊/trailing LF␊: gcid = 9c328065f69fe462a57596d2517e90d1feb58441 2026/05/26 05:53:21 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:53:22 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:53:23 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/05/26 05:53:23 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/05/26 05:53:23 DEBUG : pacer: Reducing sleep to 100ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:715 Error: Not equal: expected: []string{"trailing LF␊"} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing LF␊", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,3 +1,14 @@ -([]string) (len=1) { - (string) (len=14) "trailing LF␊" +([]string) (len=12) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=14) "trailing LF␊", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_LF Messages: directories 2026/05/26 05:53:38 DEBUG : trailing LF␊: Rmdir: contains trashed file: "trailing LF␊" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:718 Error: Not equal: expected: []string{} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,2 +1,13 @@ -([]string) { +([]string) (len=11) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_LF Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/05/26 05:53:52 DEBUG : trailing HT␉/trailing HT␉: calculating gcid: failed to unwrap object from src: trailing HT␉/trailing HT␉ 2026/05/26 05:53:52 DEBUG : trailing HT␉/trailing HT␉: gcid = 70c7f65593397c304868bc393f2126e955e0b68a 2026/05/26 05:53:55 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:55 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2026/05/26 05:53:55 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:55 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/05/26 05:53:55 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:55 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/05/26 05:53:56 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:56 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/05/26 05:53:56 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:53:56 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:53:58 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:00 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:02 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:04 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:54:06 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:54:08 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:54:09 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:54:10 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:54:10 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:54:11 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:54:11 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:54:11 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/05/26 05:54:12 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/05/26 05:54:12 DEBUG : pacer: Reducing sleep to 100ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:715 Error: Not equal: expected: []string{"trailing HT␉"} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing HT␉", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,3 +1,14 @@ -([]string) (len=1) { - (string) (len=14) "trailing HT␉" +([]string) (len=12) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=14) "trailing HT␉", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_HT Messages: directories 2026/05/26 05:54:25 DEBUG : trailing HT␉: Rmdir: contains trashed file: "trailing HT␉" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:718 Error: Not equal: expected: []string{} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,2 +1,13 @@ -([]string) { +([]string) (len=11) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_HT Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/05/26 05:54:40 DEBUG : trailing VT␋/trailing VT␋: calculating gcid: failed to unwrap object from src: trailing VT␋/trailing VT␋ 2026/05/26 05:54:40 DEBUG : trailing VT␋/trailing VT␋: gcid = dd3406212fbace5c2f44555649938a7502891a4e 2026/05/26 05:54:43 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:43 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2026/05/26 05:54:43 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:43 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/05/26 05:54:43 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:43 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/05/26 05:54:44 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:44 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/05/26 05:54:45 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:54:45 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:54:47 DEBUG : Saving config "captcha_token" in section "TestPikPak" of the config file 2026/05/26 05:54:47 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:54:48 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:54:50 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:54:51 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:54:52 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:54:52 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:54:53 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:54:53 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:54:53 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/05/26 05:54:54 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/05/26 05:54:54 DEBUG : pacer: Reducing sleep to 100ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:715 Error: Not equal: expected: []string{"trailing VT␋"} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing VT␋", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,3 +1,14 @@ -([]string) (len=1) { - (string) (len=14) "trailing VT␋" +([]string) (len=12) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=14) "trailing VT␋", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_VT Messages: directories 2026/05/26 05:55:07 DEBUG : trailing VT␋: Rmdir: contains trashed file: "trailing VT␋" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:718 Error: Not equal: expected: []string{} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,2 +1,13 @@ -([]string) { +([]string) (len=11) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_VT Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/05/26 05:55:22 DEBUG : trailing dot./trailing dot.: calculating gcid: failed to unwrap object from src: trailing dot./trailing dot. 2026/05/26 05:55:22 DEBUG : trailing dot./trailing dot.: gcid = d8fee26da1277c65cc7e259e6237566a2cb1f3de 2026/05/26 05:55:24 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:55:24 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2026/05/26 05:55:25 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:55:25 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/05/26 05:55:25 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:55:25 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/05/26 05:55:25 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:55:25 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/05/26 05:55:26 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:55:26 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:55:28 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:55:30 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:55:31 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:55:32 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:55:33 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:55:34 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:55:34 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:55:35 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:55:35 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/05/26 05:55:35 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/05/26 05:55:35 DEBUG : pacer: Reducing sleep to 100ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:715 Error: Not equal: expected: []string{"trailing dot."} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing dot.", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,3 +1,14 @@ -([]string) (len=1) { - (string) (len=13) "trailing dot." +([]string) (len=12) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=13) "trailing dot.", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_dot Messages: directories 2026/05/26 05:55:49 DEBUG : trailing dot.: Rmdir: contains trashed file: "trailing dot." fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:718 Error: Not equal: expected: []string{} actual : []string{" leading space", "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", ".leading dot", "trailing CR␍", "trailing space ", "~leading tilde", "␉leading HT", "␊leading LF", "␋leading VT", ".", ".."} Diff: --- Expected +++ Actual @@ -1,2 +1,13 @@ -([]string) { +([]string) (len=11) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~", + (string) (len=12) ".leading dot", + (string) (len=14) "trailing CR␍", + (string) (len=15) "trailing space ", + (string) (len=14) "~leading tilde", + (string) (len=13) "␉leading HT", + (string) (len=13) "␊leading LF", + (string) (len=13) "␋leading VT", + (string) (len=3) ".", + (string) (len=6) ".." } Test: TestIntegration/FsMkdir/FsEncoding/trailing_dot Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/05/26 05:56:03 DEBUG : invalid utf-8/invalid utf-8: calculating gcid: failed to unwrap object from src: invalid utf-8/invalid utf-8 2026/05/26 05:56:03 DEBUG : invalid utf-8/invalid utf-8: gcid = 6f080a32d2a0486d515dedb5661ff4168667e755 2026/05/26 05:56:06 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:06 DEBUG : pacer: Rate limited, increasing sleep to 200ms 2026/05/26 05:56:06 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:06 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/05/26 05:56:06 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:06 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/05/26 05:56:07 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:07 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/05/26 05:56:07 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:07 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:56:09 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:11 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:13 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:15 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:17 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:17 DEBUG : invalid utf-8: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXqg2PTpLbpKrNq_Rrxzi-o2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b0180), FileID:"VOtXqg1wTpLbpKrNq_Rrxzhro2", FileName:"invalid utf-8‛FE", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x376eac80, ext:63915371763, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x38cda040, ext:63915371763, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:56:19 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:56:21 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:56:23 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:56:23 DEBUG : invalid utf-8: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXqg2PTpLbpKrNq_Rrxzi-o2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e859b0180), FileID:"VOtXqg1wTpLbpKrNq_Rrxzhro2", FileName:"invalid utf-8‛FE", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x376eac80, ext:63915371763, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x38cda040, ext:63915371763, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0ed033dfc7b3862af92a52ef7e3e4d257223df81", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/05/26 05:56:24 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:56:24 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:56:25 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:56:25 DEBUG : test%46.txt/test%46.txt: calculating gcid: failed to unwrap object from src: test%46.txt/test%46.txt 2026/05/26 05:56:25 DEBUG : test%46.txt/test%46.txt: gcid = 5a4bb4d060527b1b17710aaff546ab6dc1c5072f 2026/05/26 05:56:26 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/05/26 05:56:27 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/05/26 05:56:28 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:28 DEBUG : pacer: Rate limited, increasing sleep to 400.451658ms 2026/05/26 05:56:28 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:28 DEBUG : pacer: Rate limited, increasing sleep to 800.903316ms 2026/05/26 05:56:28 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:28 DEBUG : pacer: Rate limited, increasing sleep to 1.601806632s 2026/05/26 05:56:29 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:29 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:56:31 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:33 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:35 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:37 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:39 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:41 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:41 DEBUG : test%46.txt: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXqlQGblOdCp3UK98ym3Xdo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bdad80), FileID:"VOtXqlPxblOdCp3UK98ym3Xao2", FileName:"test%46.txt", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x37d97c40, ext:63915371785, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x39292dc0, ext:63915371785, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0d8b20b308a8f2fb094caba73cd2b809f7f3c636", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:56:43 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:56:45 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:56:46 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:56:46 DEBUG : test%46.txt: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXqlQGblOdCp3UK98ym3Xdo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85bdad80), FileID:"VOtXqlPxblOdCp3UK98ym3Xao2", FileName:"test%46.txt", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x37d97c40, ext:63915371785, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x39292dc0, ext:63915371785, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0d8b20b308a8f2fb094caba73cd2b809f7f3c636", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsEncoding/URL_encoding Messages: Put === RUN TestIntegration/FsMkdir/FsPutFiles 2026/05/26 05:56:47 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:56:47 DEBUG : file name.txt: calculating gcid: failed to unwrap object from src: file name.txt 2026/05/26 05:56:47 DEBUG : file name.txt: gcid = 73ce6695a5ddd8b8249652f3497985a0549bdd8c 2026/05/26 05:56:48 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:56:50 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:56:51 DEBUG : pacer: low level retry 1/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:51 DEBUG : pacer: Rate limited, increasing sleep to 711.914062ms 2026/05/26 05:56:51 DEBUG : pacer: low level retry 2/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:51 DEBUG : pacer: Rate limited, increasing sleep to 1.423828124s 2026/05/26 05:56:52 DEBUG : pacer: low level retry 3/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:52 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/05/26 05:56:53 DEBUG : pacer: low level retry 4/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:55 DEBUG : pacer: low level retry 5/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:57 DEBUG : pacer: low level retry 6/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:56:59 DEBUG : pacer: low level retry 7/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:57:01 DEBUG : pacer: low level retry 8/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:57:03 DEBUG : pacer: low level retry 9/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:57:05 DEBUG : pacer: low level retry 10/10 (error upload (upload) is still in PHASE_TYPE_PENDING) 2026/05/26 05:57:05 DEBUG : file name.txt: canceling upload: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXqqyIblOdCp3UK98ym4fjo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7d200), FileID:"VOtXqqy2blOdCp3UK98ym4ffo2", FileName:"file name.txt", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x27478ac0, ext:63915371808, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x2878b7c0, ext:63915371808, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0d8b20b308a8f2fb094caba73cd2b809f7f3c636", Callback:"", ReferenceResource:interface {}(nil), Space:""} 2026/05/26 05:57:07 DEBUG : pacer: Reducing sleep to 1.5s 2026/05/26 05:57:09 DEBUG : pacer: Reducing sleep to 1.125s 2026/05/26 05:57:11 DEBUG : pacer: Reducing sleep to 843.75ms 2026/05/26 05:57:11 DEBUG : file name.txt: waiting 500ms for the cancellation to be effective fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:958 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Received unexpected error: can't verify the task is completed: &api.Task{Kind:"drive#task", ID:"VOtXqqyIblOdCp3UK98ym4fjo2", Name:"upload", Type:"upload", UserID:"ZB7KFqZKGnYUJW_K", Statuses:[]interface {}{}, StatusSize:0, Params:(*api.TaskParams)(0x288e85b7d200), FileID:"VOtXqqy2blOdCp3UK98ym4ffo2", FileName:"file name.txt", FileSize:"100", Message:"Pending", CreatedTime:api.Time{wall:0x27478ac0, ext:63915371808, loc:(*time.Location)(0x288e8590cd20)}, UpdatedTime:api.Time{wall:0x2878b7c0, ext:63915371808, loc:(*time.Location)(0x288e8590cd20)}, ThirdTaskID:"", Phase:"PHASE_TYPE_PENDING", Progress:0, IconLink:"https://static.mypikpak.com/0d8b20b308a8f2fb094caba73cd2b809f7f3c636", Callback:"", ReferenceResource:interface {}(nil), Space:""} Test: TestIntegration/FsMkdir/FsPutFiles Messages: Put 2026/05/26 05:57:12 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/05/26 05:57:13 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/05/26 05:57:13 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/05/26 05:57:13 ERROR : error listing: directory not found 2026/05/26 05:57:14 DEBUG : pacer: Reducing sleep to 266.967773ms --- FAIL: TestIntegration (537.93s) --- FAIL: TestIntegration/FsMkdir (535.61s) --- FAIL: TestIntegration/FsMkdir/FsEncoding (508.50s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/dot (20.60s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/dot_dot (23.74s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/punctuation (23.69s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_space (23.78s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_tilde (24.68s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_CR (42.90s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_LF (21.31s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_HT (23.62s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_VT (23.71s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_dot (24.28s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_space (23.60s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_CR (23.67s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_LF (32.93s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_HT (47.73s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_VT (41.85s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_dot (41.40s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (20.93s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/URL_encoding (23.81s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (24.26s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/pikpak 537.946s "go test -v -timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsEncoding$/^(URL_encoding|dot|dot_dot|invalid_UTF-8|leading_CR|leading_HT|leading_LF|leading_VT|leading_dot|leading_space|leading_tilde|punctuation|trailing_CR|trailing_HT|trailing_LF|trailing_VT|trailing_dot|trailing_space)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsDirMove|FsListDirFile2|FsListLevel2|FsListR|FsPurge|FsPurgeRoot|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$'" - Finished ERROR in 8m58.845267894s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsEncoding/dot TestIntegration/FsMkdir/FsEncoding/dot_dot TestIntegration/FsMkdir/FsEncoding/punctuation TestIntegration/FsMkdir/FsEncoding/leading_space TestIntegration/FsMkdir/FsEncoding/leading_tilde TestIntegration/FsMkdir/FsEncoding/leading_CR TestIntegration/FsMkdir/FsEncoding/leading_LF TestIntegration/FsMkdir/FsEncoding/leading_HT TestIntegration/FsMkdir/FsEncoding/leading_VT TestIntegration/FsMkdir/FsEncoding/leading_dot TestIntegration/FsMkdir/FsEncoding/trailing_space TestIntegration/FsMkdir/FsEncoding/trailing_CR TestIntegration/FsMkdir/FsEncoding/trailing_LF TestIntegration/FsMkdir/FsEncoding/trailing_HT TestIntegration/FsMkdir/FsEncoding/trailing_VT TestIntegration/FsMkdir/FsEncoding/trailing_dot TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 TestIntegration/FsMkdir/FsEncoding/URL_encoding TestIntegration/FsMkdir/FsPutFiles]