"go test -v -timeout 2h0m0s -remote TestZoho: -verbose" - Starting (try 1/5)
=== RUN TestFolderListLimiter
--- PASS: TestFolderListLimiter (0.00s)
=== RUN TestFolderWindowLimiterShape
--- PASS: TestFolderWindowLimiterShape (0.00s)
=== RUN TestFolderWindowLimiterIdleResume
--- PASS: TestFolderWindowLimiterIdleResume (0.00s)
=== RUN TestFolderWindowLimiterClamps
--- PASS: TestFolderWindowLimiterClamps (0.00s)
=== RUN TestFolderListLimiterConcurrent
--- PASS: TestFolderListLimiterConcurrent (0.00s)
=== RUN TestTPSMinSleep
--- PASS: TestTPSMinSleep (0.00s)
=== RUN TestShouldRetry
=== RUN TestShouldRetry/429_honours_Retry-After
2026/09/27 03:14:43 NOTICE: zoho root '': Too many requests: Trying again in 6 seconds. assert.AnError general error for testing
=== RUN TestShouldRetry/429_without_Retry-After_falls_back_to_60s
2026/09/27 03:14:43 NOTICE: zoho root '': Too many requests: Trying again in 61 seconds. assert.AnError general error for testing
=== RUN TestShouldRetry/429_with_unparseable_Retry-After_falls_back
2026/09/27 03:14:43 NOTICE: zoho root '': Failed to parse Retry-After: "soon": strconv.Atoi: parsing "soon": invalid syntax
2026/09/27 03:14:43 NOTICE: zoho root '': Too many requests: Trying again in 61 seconds. assert.AnError general error for testing
=== RUN TestShouldRetry/401_missing_scope_aborts
2026/09/27 03:14:43 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
=== RUN TestShouldRetry/401_expired_token_retries
=== RUN TestShouldRetry/401_R008_deleted_folder_is_not_retried
=== RUN TestShouldRetry/cancelled_context_aborts
--- PASS: TestShouldRetry (0.00s)
--- PASS: TestShouldRetry/429_honours_Retry-After (0.00s)
--- PASS: TestShouldRetry/429_without_Retry-After_falls_back_to_60s (0.00s)
--- PASS: TestShouldRetry/429_with_unparseable_Retry-After_falls_back (0.00s)
--- PASS: TestShouldRetry/401_missing_scope_aborts (0.00s)
--- PASS: TestShouldRetry/401_expired_token_retries (0.00s)
--- PASS: TestShouldRetry/401_R008_deleted_folder_is_not_retried (0.00s)
--- PASS: TestShouldRetry/cancelled_context_aborts (0.00s)
=== RUN TestIsMissingResourceErr
--- PASS: TestIsMissingResourceErr (0.00s)
=== RUN TestThrottleEpisode
2026/09/27 03:14:43 NOTICE: zoho root '': Too many requests: Trying again in 2 seconds. assert.AnError general error for testing
--- PASS: TestThrottleEpisode (0.00s)
=== RUN TestThrottleStateConcurrent
2026/09/27 03:14:43 NOTICE: zoho root '': Too many requests: Trying again in 2 seconds. assert.AnError general error for testing
--- PASS: TestThrottleStateConcurrent (0.00s)
=== RUN TestConfigRootFolderID
=== RUN TestConfigRootFolderID/SetRootAsksBeforeChanging
=== RUN TestConfigRootFolderID/EmptyRootGoesToEdition
=== RUN TestConfigRootFolderID/KeepRootOnNo
=== RUN TestConfigRootFolderID/ChangeRootOnYes
--- PASS: TestConfigRootFolderID (0.00s)
--- PASS: TestConfigRootFolderID/SetRootAsksBeforeChanging (0.00s)
--- PASS: TestConfigRootFolderID/EmptyRootGoesToEdition (0.00s)
--- PASS: TestConfigRootFolderID/KeepRootOnNo (0.00s)
--- PASS: TestConfigRootFolderID/ChangeRootOnYes (0.00s)
=== RUN TestIntegration
fstests.go:464: Using remote "TestZoho:"
2026/09/27 03:14:43 DEBUG : Creating backend with remote "TestZoho:rclone-test-xuriqoz2fuva"
2026/09/27 03:14:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/09/27 03:14:43 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 0 of 0 idle limiters
2026/09/27 03:14:43 DEBUG : TestZoho: Token expired
2026/09/27 03:14:43 DEBUG : TestZoho: No updated token found in the config file
2026/09/27 03:14:43 DEBUG : TestZoho: Token refresh successful
2026/09/27 03:14:43 DEBUG : Saving config "token" in section "TestZoho" of the config file
2026/09/27 03:14:43 DEBUG : TestZoho: Saved new token in config file
=== RUN TestIntegration/FsCheckWrap
fstests.go:505: Not a wrapping Fs
=== RUN TestIntegration/FsCommand
fstests.go:533: No commands in this remote
=== RUN TestIntegration/FsRmdirNotFound
=== RUN TestIntegration/FsString
=== RUN TestIntegration/FsName
=== RUN TestIntegration/FsRoot
=== RUN TestIntegration/FsRmdirEmpty
=== RUN TestIntegration/FsMkdir
=== RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2026/09/27 03:14:47 INFO : dir/subdir: Making directory
2026/09/27 03:14:48 DEBUG : pacer: Reducing sleep to 1.776873ms
2026/09/27 03:14:48 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:14:48 INFO : dir/subdir: Removing directory
2026/09/27 03:14:49 INFO : dir: Removing directory
=== RUN TestIntegration/FsMkdir/FsListEmpty
=== RUN TestIntegration/FsMkdir/FsListDirEmpty
=== RUN TestIntegration/FsMkdir/FsListRDirEmpty
fstests.go:425: FS has no ListR interface
=== RUN TestIntegration/FsMkdir/FsListDirNotFound
2026/09/27 03:14:59 ERROR : does not exist: error listing: directory not found
=== RUN TestIntegration/FsMkdir/FsListRDirNotFound
fstests.go:425: FS has no ListR interface
=== RUN TestIntegration/FsMkdir/FsEncoding
=== RUN TestIntegration/FsMkdir/FsEncoding/control_chars
fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡"
=== RUN TestIntegration/FsMkdir/FsEncoding/dot
fstests.go:734: testing "．"
=== RUN TestIntegration/FsMkdir/FsEncoding/dot_dot
fstests.go:734: testing "．．"
=== RUN TestIntegration/FsMkdir/FsEncoding/punctuation
fstests.go:734: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2026/09/27 03:15:45 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 0 of 8 idle limiters
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_space
fstests.go:734: testing " leading space"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde
fstests.go:734: testing "~leading tilde"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_CR
fstests.go:734: testing "␍leading CR"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_LF
fstests.go:734: testing "␊leading LF"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_HT
fstests.go:734: testing "␉leading HT"
2026/09/27 03:16:46 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 7 of 14 idle limiters
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_VT
fstests.go:734: testing "␋leading VT"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_dot
fstests.go:734: testing ".leading dot"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_space
fstests.go:734: testing "trailing space "
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR
fstests.go:734: testing "trailing CR␍"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF
fstests.go:734: testing "trailing LF␊"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT
fstests.go:734: testing "trailing HT␉"
2026/09/27 03:17:49 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 6 of 13 idle limiters
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT
fstests.go:734: testing "trailing VT␋"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot
fstests.go:734: testing "trailing dot."
2026/09/27 03:17:53 DEBUG : pacer: Reducing sleep to 12.420249ms
2026/09/27 03:17:53 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8
fstests.go:725: Skipping invalid UTF-8
=== RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding
fstests.go:734: testing "test%46.txt"
=== RUN TestIntegration/FsMkdir/FsNewObjectNotFound
=== RUN TestIntegration/FsMkdir/FsPutError
2026/09/27 03:18:36 DEBUG : pacer: Reducing sleep to 166.057006ms
2026/09/27 03:18:36 DEBUG : pacer: Reducing sleep to 154.15348ms
=== RUN TestIntegration/FsMkdir/FsPutZeroLength
2026/09/27 03:18:39 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:18:44 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:18:44 UTC": parsing time "Sun, 27 Sep 2026 03:18:44 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:18:44 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsOpenWriterAt
fstests.go:813: FS has no OpenWriterAt interface
=== RUN TestIntegration/FsMkdir/FsOpenChunkWriter
fstests.go:846: FS has no OpenChunkWriter interface
=== RUN TestIntegration/FsMkdir/FsChangeNotify
fstests.go:899: FS has no ChangeNotify interface
=== RUN TestIntegration/FsMkdir/FsPutFiles
2026/09/27 03:18:49 DEBUG : pacer: Reducing sleep to 2.262458ms
2026/09/27 03:18:49 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:18:49 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 6 of 14 idle limiters
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2
fstests.go:425: FS has no ListR interface
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListR
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot
2026/09/27 03:18:54 DEBUG : Creating backend with remote "TestZoho:"
2026/09/27 03:18:54 DEBUG : Config file has changed externally - reloading
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot
fstests.go:425: FS has no ListR interface
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01
fstests.go:425: FS has no ListR interface
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2
fstests.go:425: FS has no ListR interface
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive
fstests.go:1152: Not Case Insensitive
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge
2026/09/27 03:19:22 DEBUG : pacer: Reducing sleep to 2.81032ms
2026/09/27 03:19:27 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:19:32 DEBUG : pacer: Reducing sleep to 158.272733ms
2026/09/27 03:19:32 DEBUG : pacer: Reducing sleep to 164.690347ms
2026/09/27 03:19:32 DEBUG : pacer: Reducing sleep to 133.489429ms
2026/09/27 03:19:32 DEBUG : pacer: Reducing sleep to 89.95902ms
2026/09/27 03:19:32 DEBUG : pacer: Reducing sleep to 84.704661ms
2026/09/27 03:19:33 DEBUG : pacer: Reducing sleep to 64.186458ms
2026/09/27 03:19:36 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2026/09/27 03:19:50 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 3 of 11 idle limiters
2026/09/27 03:19:50 DEBUG : pacer: Reducing sleep to 161.724884ms
2026/09/27 03:19:50 DEBUG : pacer: Reducing sleep to 137.502094ms
2026/09/27 03:19:50 DEBUG : pacer: Reducing sleep to 124.758583ms
2026/09/27 03:19:51 DEBUG : pacer: Reducing sleep to 125.544351ms
2026/09/27 03:19:51 DEBUG : Creating backend with remote "TestZoho:rclone-test-xuriqoz2fuva/dirToPurgeFromRoot"
2026/09/27 03:19:51 DEBUG : Config file has changed externally - reloading
2026/09/27 03:19:51 DEBUG : pacer: Reducing sleep to 75.052608ms
2026/09/27 03:19:51 DEBUG : pacer: Reducing sleep to 142.700171ms
2026/09/27 03:19:51 DEBUG : pacer: Reducing sleep to 216.78439ms
2026/09/27 03:19:51 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2026/09/27 03:19:52 DEBUG : Creating backend with remote "TestZoho:rclone-test-xuriqoz2fuva/hello? sausage/êé"
2026/09/27 03:19:52 DEBUG : Config file has changed externally - reloading
2026/09/27 03:19:55 DEBUG : pacer: Reducing sleep to 10.354898ms
2026/09/27 03:19:55 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:19:56 DEBUG : pacer: Reducing sleep to 158.582298ms
2026/09/27 03:19:56 DEBUG : pacer: Reducing sleep to 155.866445ms
2026/09/27 03:19:56 DEBUG : pacer: Reducing sleep to 284.491612ms
2026/09/27 03:19:56 DEBUG : pacer: Reducing sleep to 265.291456ms
2026/09/27 03:19:56 DEBUG : pacer: Reducing sleep to 136.228823ms
2026/09/27 03:19:57 DEBUG : pacer: Reducing sleep to 51.545998ms
2026/09/27 03:19:57 DEBUG : pacer: Reducing sleep to 32.077206ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy
2026/09/27 03:20:00 DEBUG : pacer: Reducing sleep to 9.600355ms
2026/09/27 03:20:00 DEBUG : pacer: Reducing sleep to 3.028448ms
2026/09/27 03:20:05 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata
fstests.go:1325: Skipping test as can't write metadata
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove
2026/09/27 03:20:10 DEBUG : pacer: Reducing sleep to 3.275911ms
2026/09/27 03:20:10 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:20:29 DEBUG : pacer: Reducing sleep to 5.511233ms
2026/09/27 03:20:29 DEBUG : pacer: Reducing sleep to 151.631387ms
2026/09/27 03:20:29 DEBUG : pacer: Reducing sleep to 148.635594ms
2026/09/27 03:20:29 DEBUG : pacer: Reducing sleep to 134.245142ms
2026/09/27 03:20:30 DEBUG : pacer: Reducing sleep to 92.537383ms
2026/09/27 03:20:30 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:20:34 DEBUG : pacer: Reducing sleep to 160.757877ms
2026/09/27 03:20:34 DEBUG : pacer: Reducing sleep to 141.932249ms
2026/09/27 03:20:34 DEBUG : pacer: Reducing sleep to 92.80615ms
2026/09/27 03:20:34 DEBUG : pacer: Reducing sleep to 72.531458ms
2026/09/27 03:20:38 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:20:43 DEBUG : pacer: Reducing sleep to 158.731191ms
2026/09/27 03:20:43 DEBUG : pacer: Reducing sleep to 139.840731ms
2026/09/27 03:20:43 DEBUG : pacer: Reducing sleep to 85.112854ms
2026/09/27 03:20:43 DEBUG : pacer: Reducing sleep to 72.475122ms
2026/09/27 03:20:44 DEBUG : pacer: Reducing sleep to 56.775048ms
2026/09/27 03:20:44 DEBUG : pacer: Reducing sleep to 43.028914ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata
fstests.go:1437: Skipping test as can't write metadata
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2026/09/27 03:20:44 DEBUG : Creating backend with remote "TestZoho:rclone-test-jahugam5xiwu"
2026/09/27 03:20:44 DEBUG : Config file has changed externally - reloading
2026/09/27 03:20:45 DEBUG : pacer: Reducing sleep to 13.033768ms
2026/09/27 03:20:46 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:20:46 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:20:47 DEBUG : pacer: Reducing sleep to 4.711269ms
2026/09/27 03:20:48 DEBUG : pacer: Reducing sleep to 5.36524ms
2026/09/27 03:20:48 DEBUG : pacer: Reducing sleep to 15.841537ms
2026/09/27 03:20:48 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:20:50 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 2 of 15 idle limiters
2026/09/27 03:20:52 DEBUG : zoho root 'rclone-test-jahugam5xiwu': Purge remote
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType
fstests.go:1633: MimeType method not supported
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata
fstests.go:1664: Metadata method not supported
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata
fstests.go:1735: SetMetadata method not supported
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime
fstests.go:1792: can't set modified time
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen
2026/09/27 03:21:26 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:26 UTC": parsing time "Sun, 27 Sep 2026 03:21:26 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:26 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek
2026/09/27 03:21:30 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:30 UTC": parsing time "Sun, 27 Sep 2026 03:21:30 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:30 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange
2026/09/27 03:21:35 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:35 UTC": parsing time "Sun, 27 Sep 2026 03:21:35 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:35 UTC" as " "
2026/09/27 03:21:35 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:35 UTC": parsing time "Sun, 27 Sep 2026 03:21:35 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:35 UTC" as " "
2026/09/27 03:21:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:36 UTC": parsing time "Sun, 27 Sep 2026 03:21:36 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:36 UTC" as " "
2026/09/27 03:21:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:36 UTC": parsing time "Sun, 27 Sep 2026 03:21:36 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:36 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead
2026/09/27 03:21:39 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:39 UTC": parsing time "Sun, 27 Sep 2026 03:21:39 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:39 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint
2026/09/27 03:21:44 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:44 UTC": parsing time "Sun, 27 Sep 2026 03:21:44 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:44 UTC" as " "
2026/09/27 03:21:49 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:49 UTC": parsing time "Sun, 27 Sep 2026 03:21:49 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:49 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read
2026/09/27 03:21:49 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:49 UTC": parsing time "Sun, 27 Sep 2026 03:21:49 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:49 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read
2026/09/27 03:21:50 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:50 UTC": parsing time "Sun, 27 Sep 2026 03:21:50 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:50 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read
2026/09/27 03:21:50 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:50 UTC": parsing time "Sun, 27 Sep 2026 03:21:50 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:50 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end
2026/09/27 03:21:51 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:51 UTC": parsing time "Sun, 27 Sep 2026 03:21:51 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:51 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh
2026/09/27 03:21:51 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 8 of 13 idle limiters
2026/09/27 03:21:52 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:52 UTC": parsing time "Sun, 27 Sep 2026 03:21:52 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:52 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate
2026/09/27 03:21:53 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 27 Sep 2026 03:21:53 UTC": parsing time "Sun, 27 Sep 2026 03:21:53 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 27 Sep 2026 03:21:53 UTC" as " "
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2026/09/27 03:21:53 DEBUG : Creating backend with remote "TestZoho:rclone-test-xuriqoz2fuva/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2026/09/27 03:21:53 DEBUG : Config file has changed externally - reloading
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2026/09/27 03:22:00 DEBUG : Creating backend with remote "TestZoho:rclone-test-xuriqoz2fuva/not found.txt"
2026/09/27 03:22:12 ERROR : error listing: directory not found
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot
fstests.go:1994: Opening root remote "TestZoho:" path "rclone-test-xuriqoz2fuva" from "TestZoho:rclone-test-xuriqoz2fuva"
2026/09/27 03:22:12 DEBUG : Creating backend with remote "TestZoho:"
2026/09/27 03:22:12 DEBUG : Config file has changed externally - reloading
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
2026/09/27 03:22:17 DEBUG : pacer: Reducing sleep to 80.016802ms
2026/09/27 03:22:17 DEBUG : pacer: Reducing sleep to 162.524246ms
2026/09/27 03:22:17 DEBUG : pacer: Reducing sleep to 238.283208ms
2026/09/27 03:22:17 DEBUG : pacer: Reducing sleep to 229.076936ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
2026/09/27 03:22:22 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR
fstests.go:2031: FS has no ListR interface
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
2026/09/27 03:22:26 DEBUG : pacer: Reducing sleep to 3.813697ms
2026/09/27 03:22:31 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:22:36 DEBUG : pacer: Reducing sleep to 58.986066ms
2026/09/27 03:22:36 DEBUG : pacer: Reducing sleep to 135.271581ms
2026/09/27 03:22:36 DEBUG : pacer: Reducing sleep to 202.261665ms
2026/09/27 03:22:36 DEBUG : pacer: Reducing sleep to 226.17718ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
2026/09/27 03:22:36 DEBUG : pacer: Reducing sleep to 170.327305ms
2026/09/27 03:22:40 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:22:40 DEBUG : pacer: Reducing sleep to 78.842764ms
2026/09/27 03:22:40 DEBUG : pacer: Reducing sleep to 160.480717ms
2026/09/27 03:22:40 DEBUG : pacer: Reducing sleep to 235.777205ms
2026/09/27 03:22:40 DEBUG : pacer: Reducing sleep to 215.711505ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink
fstests.go:2090: FS has no PublicLinker interface
=== RUN TestIntegration/FsMkdir/FsPutFiles/SetTier
fstests.go:438: FS has no SetTier & GetTier interfaces
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap
fstests.go:2195: Not a wrapping Fs
=== RUN TestIntegration/FsMkdir/FsPutFiles/Bucket
fstests.go:2211: Not a bucket based backend
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
2026/09/27 03:22:50 DEBUG : pacer: Reducing sleep to 2.795593ms
2026/09/27 03:22:50 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream
fstests.go:2385: FS has no PutStream interface
=== RUN TestIntegration/FsMkdir/FsPutFiles/Internal
fstests.go:2431: *zoho.Fs does not implement InternalTester
=== RUN TestIntegration/FsMkdir/FsPutChunked
fstests.go:2452: *zoho.Fs does not implement SetUploadChunkSizer
=== RUN TestIntegration/FsMkdir/FsPutRetry
=== RUN TestIntegration/FsMkdir/FsPutRetry/Simple
=== RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500
2026/09/27 03:22:50 DEBUG : pacer: low level retry 1/1 (error HTTP error 500 (500 Internal Server Error) returned body: "")
2026/09/27 03:22:50 DEBUG : pacer: Rate limited, increasing sleep to 1.339984499s
fstests.go:2660: Put returned an error after the injected failure (acceptable): upload error: HTTP error 500 (500 Internal Server Error) returned body: ""
2026/09/27 03:22:51 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError
2026/09/27 03:22:51 DEBUG : zoho root 'rclone-test-xuriqoz2fuva': folder listing limiter sweep: evicted 2 of 8 idle limiters
2026/09/27 03:22:52 DEBUG : pacer: low level retry 1/1 (error Post "https://workdrive.zoho.eu/api/v1/upload?filename=retry-NetError.bin&override-name-exist=true&parent_id=1g3in94c0d03a80074b8bab91810183b31248": write tcp: unexpected EOF)
2026/09/27 03:22:52 DEBUG : pacer: Rate limited, increasing sleep to 1.6386493s
fstests.go:2660: Put returned an error after the injected failure (acceptable): upload error: Post "https://workdrive.zoho.eu/api/v1/upload?filename=retry-NetError.bin&override-name-exist=true&parent_id=1g3in94c0d03a80074b8bab91810183b31248": write tcp: unexpected EOF
2026/09/27 03:22:53 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutRetry/Chunked
fstests.go:2697: *zoho.Fs does not implement SetUploadChunkSizer
=== RUN TestIntegration/FsMkdir/FsPutShortEOF
=== RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple
2026/09/27 03:23:02 DEBUG : pacer: Reducing sleep to 39.820162ms
fstests.go:2784: Put returned an error (acceptable): upload error: HTTP error 400 (400 Bad Request) returned body: "\r\n400 Bad Request\r\n\r\n400 Bad Request
\r\n\r\n\r\n"
2026/09/27 03:23:07 DEBUG : pacer: Reducing sleep to 0s
=== RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked
fstests.go:2828: *zoho.Fs does not implement SetUploadChunkSizer
=== RUN TestIntegration/FsMkdir/FsCopyChunked
fstests.go:2879: *zoho.Fs does not implement SetCopyCutoff
=== RUN TestIntegration/FsMkdir/FsUploadUnknownSize
=== RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize
2026/09/27 03:23:11 DEBUG : pacer: Reducing sleep to 166.181601ms
=== RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2026/09/27 03:23:16 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:23:25 DEBUG : pacer: Reducing sleep to 166.23446ms
=== RUN TestIntegration/FsMkdir/FsRootCollapse
2026/09/27 03:23:25 DEBUG : Creating backend with remote "TestZoho:rclone-test-xuriqoz2fuva/deeper/nonexisting/directory"
2026/09/27 03:23:25 DEBUG : Config file has changed externally - reloading
=== RUN TestIntegration/FsMkdir/FsDirSetModTime
fstests.go:3019: FS has no DirSetModTime interface
=== RUN TestIntegration/FsMkdir/FsMkdirMetadata
fstests.go:3062: FS has no MkdirMetadata interface
=== RUN TestIntegration/FsMkdir/FsDirectory
fstests.go:3119: FS has no Directory methods and doesn't Wrap
2026/09/27 03:23:39 DEBUG : pacer: Reducing sleep to 0s
2026/09/27 03:23:40 ERROR : error listing: directory not found
=== RUN TestIntegration/FsShutdown
fstests.go:3225: Shutdown method not supported
--- PASS: TestIntegration (537.32s)
--- SKIP: TestIntegration/FsCheckWrap (0.00s)
--- SKIP: TestIntegration/FsCommand (0.00s)
--- PASS: TestIntegration/FsRmdirNotFound (0.31s)
--- PASS: TestIntegration/FsString (0.00s)
--- PASS: TestIntegration/FsName (0.00s)
--- PASS: TestIntegration/FsRoot (0.00s)
--- PASS: TestIntegration/FsRmdirEmpty (0.42s)
--- PASS: TestIntegration/FsMkdir (533.79s)
--- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (2.77s)
--- PASS: TestIntegration/FsMkdir/FsListEmpty (0.18s)
--- PASS: TestIntegration/FsMkdir/FsListDirEmpty (4.62s)
--- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
--- PASS: TestIntegration/FsMkdir/FsListDirNotFound (4.63s)
--- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
--- PASS: TestIntegration/FsMkdir/FsEncoding (196.59s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (13.86s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/dot (13.87s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (13.82s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (6.72s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (2.41s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (13.86s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (13.83s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (13.86s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (13.83s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (2.23s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (6.23s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (13.84s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (13.83s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (13.87s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (10.26s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (2.42s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (9.45s)
--- SKIP: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.00s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (13.81s)
--- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (9.23s)
--- PASS: TestIntegration/FsMkdir/FsPutError (10.86s)
--- PASS: TestIntegration/FsMkdir/FsPutZeroLength (8.28s)
--- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles (246.13s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.97s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.19s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.76s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.52s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (8.73s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.37s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (5.22s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (3.82s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (5.43s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (4.41s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (14.82s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (15.26s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.62s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (8.49s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (38.61s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (8.15s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.19s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.17s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.18s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.17s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.19s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (4.62s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (4.62s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (4.62s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (4.59s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (4.63s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (4.60s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (5.50s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (4.17s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (6.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (3.11s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (12.35s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.86s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.34s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.33s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.66s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.91s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.37s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.18s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (6.32s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (12.86s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (28.04s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (4.95s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (4.19s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (18.91s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (4.61s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (9.63s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.19s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutRetry (7.16s)
--- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (7.16s)
--- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (1.17s)
--- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (5.99s)
--- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutShortEOF (9.23s)
--- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (9.23s)
--- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
--- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (18.49s)
--- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (4.60s)
--- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (13.89s)
--- PASS: TestIntegration/FsMkdir/FsRootCollapse (13.83s)
--- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s)
--- SKIP: TestIntegration/FsShutdown (0.00s)
PASS
ok github.com/rclone/rclone/backend/zoho 537.340s
"go test -v -timeout 2h0m0s -remote TestZoho: -verbose" - Finished OK in 8m58.479435413s (try 1/5)