"go test -v -timeout 2h0m0s -remote TestZoho: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsCopy|FsDirMove|FsListDirFile2|FsListFile1|FsListFile1and2|FsListLevel2|FsListR|FsMove|FsPurge|FsPurgeRoot|ObjectOpen|ObjectOpenRange|ObjectOpenSeek|ObjectPartialRead|ObjectRemove|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$|^TestIntegration$/^FsMkdir$/^FsPutZeroLength$'" - Starting (try 5/5)
=== RUN TestIntegration
fstests.go:438: Using remote "TestZoho:"
2026/01/04 04:09:25 DEBUG : Creating backend with remote "TestZoho:rclone-test-sininit4vido"
2026/01/04 04:09:25 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN TestIntegration/FsMkdir
=== RUN TestIntegration/FsMkdir/FsPutZeroLength
2026/01/04 04:09:27 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 04 Jan 2026 04:09:27 UTC": parsing time "Sun, 04 Jan 2026 04:09:27 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 04 Jan 2026 04:09:27 UTC" as " "
2026/01/04 04:09:27 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
fstests.go:262:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:262
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:275
Error: Received unexpected error:
HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
Test: TestIntegration/FsMkdir/FsPutZeroLength
=== RUN TestIntegration/FsMkdir/FsPutFiles
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
fstests.go:979:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:979
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:998
Error: Not equal:
expected: []string{"file name.txt"}
actual : []string{"file name.txt", "zero-length-file"}
Diff:
--- Expected
+++ Actual
@@ -1,3 +1,4 @@
-([]string) (len=1) {
- (string) (len=13) "file name.txt"
+([]string) (len=2) {
+ (string) (len=13) "file name.txt",
+ (string) (len=16) "zero-length-file"
}
Test: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListR
fstests.go:1021:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1021
Error: Not equal:
expected: []string{"file name.txt", "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"}
actual : []string{"file name.txt", "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "zero-length-file"}
Diff:
--- Expected
+++ Actual
@@ -1,4 +1,5 @@
-([]string) (len=2) {
+([]string) (len=3) {
(string) (len=13) "file name.txt",
- (string) (len=60) "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
+ (string) (len=60) "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt",
+ (string) (len=16) "zero-length-file"
}
Test: TestIntegration/FsMkdir/FsPutFiles/FsListR
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
fstests.go:1093:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1093
Error: Not equal:
expected: []string{"file name.txt"}
actual : []string{"file name.txt", "zero-length-file"}
Diff:
--- Expected
+++ Actual
@@ -1,3 +1,4 @@
-([]string) (len=1) {
- (string) (len=13) "file name.txt"
+([]string) (len=2) {
+ (string) (len=13) "file name.txt",
+ (string) (len=16) "zero-length-file"
}
Test: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1107
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsListFile1
Messages: listing wrong, want
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1107
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsListFile1
Messages: Unexpected file "zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1134
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
Messages: listing wrong, want
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1134
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
Messages: Unexpected file "zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge
2026/01/04 04:09:47 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:09:47 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:09:47 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2026/01/04 04:09:47 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:09:47 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:10:47 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:10:47 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:11:47 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:11:47 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:12:47 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:12:47 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:13:47 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:13:47 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:14:47 DEBUG : pacer: Reducing sleep to 45s
2026/01/04 04:15:47 DEBUG : pacer: Reducing sleep to 33.75s
2026/01/04 04:16:32 DEBUG : pacer: Reducing sleep to 25.3125s
2026/01/04 04:17:05 DEBUG : pacer: Reducing sleep to 18.984375s
2026/01/04 04:17:31 DEBUG : pacer: Reducing sleep to 14.23828125s
2026/01/04 04:17:50 DEBUG : pacer: Reducing sleep to 10.678710937s
2026/01/04 04:18:04 DEBUG : pacer: Reducing sleep to 8.009033202s
2026/01/04 04:18:15 DEBUG : pacer: Reducing sleep to 6.006774901s
2026/01/04 04:18:23 DEBUG : pacer: Reducing sleep to 4.505081175s
2026/01/04 04:18:29 DEBUG : pacer: Reducing sleep to 3.378810881s
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:18:33 DEBUG : pacer: Reducing sleep to 2.53410816s
2026/01/04 04:18:37 DEBUG : pacer: Reducing sleep to 1.90058112s
2026/01/04 04:18:39 DEBUG : pacer: Reducing sleep to 1.42543584s
2026/01/04 04:18:41 DEBUG : pacer: Reducing sleep to 1.06907688s
2026/01/04 04:18:42 DEBUG : pacer: Reducing sleep to 801.80766ms
2026/01/04 04:18:43 DEBUG : pacer: Reducing sleep to 601.355745ms
2026/01/04 04:18:44 DEBUG : pacer: Reducing sleep to 451.016808ms
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:18:46 DEBUG : pacer: Reducing sleep to 338.262606ms
2026/01/04 04:18:47 DEBUG : pacer: Reducing sleep to 253.696954ms
2026/01/04 04:18:47 DEBUG : pacer: Reducing sleep to 190.272715ms
2026/01/04 04:18:47 DEBUG : pacer: Reducing sleep to 142.704536ms
2026/01/04 04:18:48 DEBUG : pacer: Reducing sleep to 107.028402ms
2026/01/04 04:18:48 DEBUG : pacer: Reducing sleep to 80.271301ms
2026/01/04 04:18:48 DEBUG : pacer: Reducing sleep to 60.203475ms
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1163
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurge
Messages: listing wrong, want
dirToPurge/fileToPurge.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
dirToPurge/fileToPurge.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1163
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurge
Messages: Unexpected file "zero-length-file"
2026/01/04 04:18:52 DEBUG : pacer: Reducing sleep to 45.152606ms
2026/01/04 04:18:52 DEBUG : pacer: Reducing sleep to 33.864454ms
2026/01/04 04:18:52 DEBUG : pacer: Reducing sleep to 25.39834ms
2026/01/04 04:18:52 DEBUG : pacer: Reducing sleep to 19.048755ms
2026/01/04 04:18:52 DEBUG : pacer: Reducing sleep to 14.286566ms
2026/01/04 04:18:52 DEBUG : pacer: Reducing sleep to 10.714924ms
2026/01/04 04:18:52 DEBUG : pacer: Reducing sleep to 10ms
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1175
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurge
Messages: listing wrong, want
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1175
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurge
Messages: Unexpected file "zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1200
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
Messages: listing wrong, want
dirToPurgeFromRoot/fileToPurgeFromRoot.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
dirToPurgeFromRoot/fileToPurgeFromRoot.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1200
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
Messages: Unexpected file "zero-length-file"
2026/01/04 04:19:09 DEBUG : Creating backend with remote "TestZoho:rclone-test-sininit4vido/dirToPurgeFromRoot"
2026/01/04 04:19:09 DEBUG : Config file has changed externally - reloading
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1217
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
Messages: listing wrong, want
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1217
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
Messages: Unexpected file "zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1270
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy
Messages: listing wrong, want
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy (100) got
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1270
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy
Messages: Unexpected file "zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata
fstests.go:1289: Skipping test as can't write metadata
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove
2026/01/04 04:19:28 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:19:28 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:19:28 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2026/01/04 04:19:28 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:19:28 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:20:28 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:20:28 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:21:28 DEBUG : pacer: low level retry 4/10 (error HTTP error 502 (502 Bad Gateway) returned body: "\n\n
\n\t\n\t\n\t\n\tZoho - Temporarily Unavailable\n\t\n\n\n\n\t\n\t\t\n\t\t\t
\n\t\t\t\t
\n\t\t\t\t\t
\n\t\t\t\t\t\t
\n\t\t\t\t\t\t
\n\t\t\t\t\t\t\t

\n\t\t\t\t\t\t
\n\t\t\t\t\t
\n\t\t\t\t
\n\t\t\t
\n\t\t
\n\t\n\t\n\n\n")
2026/01/04 04:22:28 DEBUG : pacer: Reducing sleep to 45s
2026/01/04 04:23:28 DEBUG : pacer: Reducing sleep to 33.75s
2026/01/04 04:24:13 DEBUG : pacer: Reducing sleep to 25.3125s
2026/01/04 04:24:47 DEBUG : pacer: Reducing sleep to 18.984375s
2026/01/04 04:25:12 DEBUG : pacer: Reducing sleep to 14.23828125s
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:25:31 DEBUG : pacer: Reducing sleep to 10.678710937s
2026/01/04 04:25:45 DEBUG : pacer: Reducing sleep to 8.009033202s
2026/01/04 04:25:56 DEBUG : pacer: Reducing sleep to 6.006774901s
2026/01/04 04:26:04 DEBUG : pacer: Reducing sleep to 4.505081175s
2026/01/04 04:26:10 DEBUG : pacer: Reducing sleep to 3.378810881s
2026/01/04 04:26:14 DEBUG : pacer: Reducing sleep to 2.53410816s
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:26:18 DEBUG : pacer: Reducing sleep to 1.90058112s
2026/01/04 04:26:20 DEBUG : pacer: Reducing sleep to 1.42543584s
2026/01/04 04:26:22 DEBUG : pacer: Reducing sleep to 1.06907688s
2026/01/04 04:26:24 DEBUG : pacer: Reducing sleep to 801.80766ms
2026/01/04 04:26:25 DEBUG : pacer: Reducing sleep to 601.355745ms
2026/01/04 04:26:26 DEBUG : pacer: Reducing sleep to 451.016808ms
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1362
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: listing wrong, want
file name.txt (100), other.txt (100) got
file name.txt (100), other.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1362
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: Unexpected file "zero-length-file"
2026/01/04 04:26:30 DEBUG : pacer: Reducing sleep to 338.262606ms
2026/01/04 04:26:30 DEBUG : pacer: Reducing sleep to 253.696954ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 190.272715ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 142.704536ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 107.028402ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 80.271301ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 60.203475ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 45.152606ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 33.864454ms
2026/01/04 04:26:31 DEBUG : pacer: Reducing sleep to 25.39834ms
2026/01/04 04:26:32 DEBUG : pacer: Reducing sleep to 19.048755ms
2026/01/04 04:26:32 DEBUG : pacer: Reducing sleep to 14.286566ms
2026/01/04 04:26:32 DEBUG : pacer: Reducing sleep to 10.714924ms
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:26:33 DEBUG : pacer: Reducing sleep to 10ms
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1373
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: listing wrong, want
moveTest/other.txt (100), other.txt (100) got
moveTest/other.txt (100), other.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1373
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: Unexpected file "zero-length-file"
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1381
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: listing wrong, want
file name.txt (100), other.txt (100) got
file name.txt (100), other.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1381
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: Unexpected file "zero-length-file"
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1388
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: listing wrong, want
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1388
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsMove
Messages: Unexpected file "zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata
fstests.go:1398: Skipping test as can't write metadata
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2026/01/04 04:27:00 DEBUG : Creating backend with remote "TestZoho:rclone-test-todujay1nuca"
2026/01/04 04:27:00 DEBUG : Config file has changed externally - reloading
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1485
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsDirMove
Messages: listing wrong, want
new_name/sub_new_name/file name.txt (100), new_name/sub_new_name/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
new_name/sub_new_name/file name.txt (100), new_name/sub_new_name/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), new_name/sub_new_name/zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1485
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsDirMove
Messages: Unexpected file "new_name/sub_new_name/zero-length-file"
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:27:15 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:27:15 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:27:15 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2026/01/04 04:27:15 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:27:15 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:28:15 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:28:15 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:29:15 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:29:15 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:30:15 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:30:15 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:31:15 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:31:15 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:32:16 DEBUG : pacer: Reducing sleep to 45s
2026/01/04 04:33:16 DEBUG : pacer: Reducing sleep to 33.75s
2026/01/04 04:34:00 DEBUG : pacer: Reducing sleep to 25.3125s
2026/01/04 04:34:34 DEBUG : TestZoho: Token expired
2026/01/04 04:34:34 DEBUG : TestZoho: No updated token found in the config file
2026/01/04 04:34:34 DEBUG : TestZoho: Token refresh successful
2026/01/04 04:34:34 DEBUG : Saving config "token" in section "TestZoho" of the config file
2026/01/04 04:34:34 DEBUG : TestZoho: Saved new token in config file
2026/01/04 04:34:34 DEBUG : pacer: Reducing sleep to 18.984375s
2026/01/04 04:34:59 DEBUG : pacer: Reducing sleep to 14.23828125s
2026/01/04 04:35:18 DEBUG : pacer: Reducing sleep to 10.678710937s
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:35:33 DEBUG : pacer: Reducing sleep to 8.009033202s
2026/01/04 04:35:43 DEBUG : pacer: Reducing sleep to 6.006774901s
2026/01/04 04:35:51 DEBUG : pacer: Reducing sleep to 4.505081175s
2026/01/04 04:35:57 DEBUG : pacer: Reducing sleep to 3.378810881s
2026/01/04 04:36:02 DEBUG : pacer: Reducing sleep to 2.53410816s
2026/01/04 04:36:05 DEBUG : pacer: Reducing sleep to 1.90058112s
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1499
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsDirMove
Messages: listing wrong, want
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1499
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FsDirMove
Messages: Unexpected file "zero-length-file"
2026/01/04 04:36:09 DEBUG : TestZoho: Token expired
2026/01/04 04:36:09 DEBUG : Config file has changed externally - reloading
2026/01/04 04:36:09 DEBUG : TestZoho: Loaded fresh token from config file
2026/01/04 04:36:09 DEBUG : TestZoho: Token refresh successful
2026/01/04 04:36:09 DEBUG : zoho root 'rclone-test-todujay1nuca': Purge remote
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen
2026/01/04 04:36:10 DEBUG : pacer: Reducing sleep to 1.42543584s
2026/01/04 04:36:12 DEBUG : pacer: Reducing sleep to 1.06907688s
2026/01/04 04:36:14 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 04 Jan 2026 04:36:14 UTC": parsing time "Sun, 04 Jan 2026 04:36:14 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 04 Jan 2026 04:36:14 UTC" as " "
2026/01/04 04:36:14 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2026/01/04 04:36:14 DEBUG : pacer: Reducing sleep to 801.80766ms
fstests.go:287:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1772
Error: Received unexpected error:
HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
Test: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen
Messages: readObject("file name.txt") limit=-1, options=[]
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek
2026/01/04 04:36:14 DEBUG : pacer: Reducing sleep to 601.355745ms
2026/01/04 04:36:15 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 04 Jan 2026 04:36:15 UTC": parsing time "Sun, 04 Jan 2026 04:36:15 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 04 Jan 2026 04:36:15 UTC" as " "
2026/01/04 04:36:15 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2026/01/04 04:36:15 DEBUG : pacer: Reducing sleep to 451.016808ms
fstests.go:287:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1779
Error: Received unexpected error:
HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
Test: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek
Messages: readObject("file name.txt") limit=-1, options=[SeekOption(50)]
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange
2026/01/04 04:36:15 DEBUG : pacer: Reducing sleep to 338.262606ms
2026/01/04 04:36:16 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 04 Jan 2026 04:36:16 UTC": parsing time "Sun, 04 Jan 2026 04:36:16 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 04 Jan 2026 04:36:16 UTC" as " "
2026/01/04 04:36:16 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2026/01/04 04:36:16 DEBUG : pacer: Reducing sleep to 253.696954ms
fstests.go:287:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1798
Error: Received unexpected error:
HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
Test: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange
Messages: readObject("file name.txt") limit=-1, options=[RangeOption(5,15)]
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead
2026/01/04 04:36:17 DEBUG : pacer: Reducing sleep to 190.272715ms
2026/01/04 04:36:17 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 04 Jan 2026 04:36:17 UTC": parsing time "Sun, 04 Jan 2026 04:36:17 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 04 Jan 2026 04:36:17 UTC" as " "
2026/01/04 04:36:17 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2026/01/04 04:36:17 DEBUG : pacer: Reducing sleep to 142.704536ms
fstests.go:287:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1809
Error: Received unexpected error:
HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
Test: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead
Messages: readObject("file name.txt") limit=50, options=[]
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate
2026/01/04 04:36:17 DEBUG : pacer: Reducing sleep to 107.028402ms
2026/01/04 04:36:17 DEBUG : pacer: Reducing sleep to 80.271301ms
2026/01/04 04:36:18 DEBUG : pacer: Reducing sleep to 60.203475ms
2026/01/04 04:36:18 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 04 Jan 2026 04:36:18 UTC": parsing time "Sun, 04 Jan 2026 04:36:18 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 04 Jan 2026 04:36:18 UTC" as " "
2026/01/04 04:36:18 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2026/01/04 04:36:18 DEBUG : pacer: Reducing sleep to 45.152606ms
fstests.go:287:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1840
Error: Received unexpected error:
HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
Test: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate
Messages: readObject("file name.txt") limit=-1, options=[]
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot
fstests.go:1911: Opening root remote "TestZoho:" path "rclone-test-sininit4vido" from "TestZoho:rclone-test-sininit4vido"
2026/01/04 04:36:18 DEBUG : Creating backend with remote "TestZoho:"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1931
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
Messages: listing wrong, want
rclone-test-sininit4vido/file name.txt (200), rclone-test-sininit4vido/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
rclone-test-sininit4vido/file name.txt (200), rclone-test-sininit4vido/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), rclone-test-sininit4vido/zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1931
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
Messages: Unexpected file "rclone-test-sininit4vido/zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
fstest.go:380:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:380
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1938
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
Messages: ListEntries not equal, want
rclone-test-sininit4vido/file name.txt (200) got
rclone-test-sininit4vido/file name.txt (200), rclone-test-sininit4vido/zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:383
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1938
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
Messages: Unexpected file "rclone-test-sininit4vido/zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1987
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
Messages: listing wrong, want
rclone-test-sininit4vido/created from root.txt (100), rclone-test-sininit4vido/file name.txt (200), rclone-test-sininit4vido/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
rclone-test-sininit4vido/created from root.txt (100), rclone-test-sininit4vido/file name.txt (200), rclone-test-sininit4vido/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), rclone-test-sininit4vido/zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1987
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
Messages: Unexpected file "rclone-test-sininit4vido/zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
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:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1992
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
Messages: listing wrong, want
rclone-test-sininit4vido/file name.txt (200), rclone-test-sininit4vido/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
rclone-test-sininit4vido/file name.txt (200), rclone-test-sininit4vido/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), rclone-test-sininit4vido/zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1992
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
Messages: Unexpected file "rclone-test-sininit4vido/zero-length-file"
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
2026/01/04 04:36:46 DEBUG : pacer: Reducing sleep to 33.864454ms
2026/01/04 04:36:46 DEBUG : pacer: Reducing sleep to 25.39834ms
2026/01/04 04:36:46 DEBUG : pacer: Reducing sleep to 19.048755ms
2026/01/04 04:36:47 DEBUG : pacer: Reducing sleep to 14.286566ms
2026/01/04 04:36:47 DEBUG : pacer: Reducing sleep to 10.714924ms
2026/01/04 04:36:47 DEBUG : pacer: Reducing sleep to 10ms
fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:36:48 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:36:48 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:36:48 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2026/01/04 04:36:48 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:36:48 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:37:49 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:37:49 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:38:48 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:38:48 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:39:48 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:39:48 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:40:48 DEBUG : Too many requests. Trying again in 60 seconds.
2026/01/04 04:40:48 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s)
2026/01/04 04:41:48 DEBUG : pacer: Reducing sleep to 45s
2026/01/04 04:42:48 DEBUG : pacer: Reducing sleep to 33.75s
2026/01/04 04:43:33 DEBUG : pacer: Reducing sleep to 25.3125s
2026/01/04 04:44:07 DEBUG : pacer: Reducing sleep to 18.984375s
2026/01/04 04:44:32 DEBUG : pacer: Reducing sleep to 14.23828125s
fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
fstest.go:301: Flushing the directory cache
2026/01/04 04:44:51 DEBUG : pacer: Reducing sleep to 10.678710937s
2026/01/04 04:45:05 DEBUG : pacer: Reducing sleep to 8.009033202s
2026/01/04 04:45:16 DEBUG : pacer: Reducing sleep to 6.006774901s
2026/01/04 04:45:24 DEBUG : pacer: Reducing sleep to 4.505081175s
2026/01/04 04:45:30 DEBUG : pacer: Reducing sleep to 3.378810881s
2026/01/04 04:45:35 DEBUG : pacer: Reducing sleep to 2.53410816s
fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
fstest.go:301: Flushing the directory cache
fstest.go:305:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2269
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
Messages: listing wrong, want
hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
fstest.go:191:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2269
Error: Should be true
Test: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
Messages: Unexpected file "zero-length-file"
2026/01/04 04:45:39 DEBUG : pacer: Reducing sleep to 1.90058112s
2026/01/04 04:45:41 DEBUG : pacer: Reducing sleep to 1.42543584s
2026/01/04 04:45:43 DEBUG : pacer: Reducing sleep to 1.06907688s
2026/01/04 04:45:45 DEBUG : pacer: Reducing sleep to 801.80766ms
2026/01/04 04:45:45 ERROR : error listing: directory not found
2026/01/04 04:45:46 DEBUG : pacer: Reducing sleep to 601.355745ms
--- FAIL: TestIntegration (2180.34s)
--- FAIL: TestIntegration/FsMkdir (2179.33s)
--- FAIL: TestIntegration/FsMkdir/FsPutZeroLength (0.55s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles (2171.64s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.30s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.39s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.11s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (8.12s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (8.22s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsPurge (553.84s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (17.71s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy (9.27s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsMove (452.95s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (549.44s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (4.15s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.43s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.27s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.56s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.16s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot (27.88s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (8.99s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.25s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (18.64s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (9.20s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (532.64s)
FAIL
exit status 1
FAIL github.com/rclone/rclone/backend/zoho 2180.354s
"go test -v -timeout 2h0m0s -remote TestZoho: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsCopy|FsDirMove|FsListDirFile2|FsListFile1|FsListFile1and2|FsListLevel2|FsListR|FsMove|FsPurge|FsPurgeRoot|ObjectOpen|ObjectOpenRange|ObjectOpenSeek|ObjectPartialRead|ObjectRemove|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$|^TestIntegration$/^FsMkdir$/^FsPutZeroLength$'" - Finished ERROR in 36m21.599781328s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutZeroLength TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 TestIntegration/FsMkdir/FsPutFiles/FsListR TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 TestIntegration/FsMkdir/FsPutFiles/FsListFile1 TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 TestIntegration/FsMkdir/FsPutFiles/FsPurge TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot TestIntegration/FsMkdir/FsPutFiles/FsCopy TestIntegration/FsMkdir/FsPutFiles/FsMove TestIntegration/FsMkdir/FsPutFiles/FsDirMove TestIntegration/FsMkdir/FsPutFiles/ObjectOpen TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate TestIntegration/FsMkdir/FsPutFiles/FromRoot/List TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove TestIntegration/FsMkdir/FsPutFiles/ObjectRemove]