"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/08/26 05:12:35 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/08/26 05:12:35 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/08/26 05:12:35 NOTICE: zoho root '': Failed to parse Retry-After: "soon": strconv.Atoi: parsing "soon": invalid syntax 2026/08/26 05:12:35 NOTICE: zoho root '': Too many requests: Trying again in 61 seconds. assert.AnError general error for testing === RUN TestShouldRetry/401_missing_scope_aborts 2026/08/26 05:12:35 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/08/26 05:12:35 NOTICE: zoho root '': Too many requests: Trying again in 2 seconds. assert.AnError general error for testing --- PASS: TestThrottleEpisode (0.00s) === RUN TestThrottleStateConcurrent 2026/08/26 05:12:35 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:457: Using remote "TestZoho:" 2026/08/26 05:12:35 DEBUG : Creating backend with remote "TestZoho:rclone-test-lamawal8zumo" 2026/08/26 05:12:35 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/26 05:12:35 DEBUG : zoho root 'rclone-test-lamawal8zumo': folder listing limiter sweep: evicted 0 of 0 idle limiters 2026/08/26 05:12:35 DEBUG : TestZoho: Token expired 2026/08/26 05:12:35 DEBUG : TestZoho: No updated token found in the config file 2026/08/26 05:12:35 DEBUG : TestZoho: Token refresh successful 2026/08/26 05:12:35 DEBUG : Saving config "token" in section "TestZoho" of the config file 2026/08/26 05:12:35 DEBUG : TestZoho: Saved new token in config file 2026/08/26 05:12:36 DEBUG : pacer: Reducing sleep to 3.495993ms === RUN TestIntegration/FsCheckWrap fstests.go:498: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:526: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/08/26 05:12:36 DEBUG : pacer: Reducing sleep to 38.141477ms 2026/08/26 05:12:36 DEBUG : pacer: Reducing sleep to 75.589261ms 2026/08/26 05:12:36 DEBUG : pacer: Reducing sleep to 70.420424ms 2026/08/26 05:12:36 DEBUG : pacer: Reducing sleep to 195.435592ms === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty 2026/08/26 05:12:36 DEBUG : pacer: Reducing sleep to 287.524915ms 2026/08/26 05:12:37 DEBUG : pacer: Reducing sleep to 246.172151ms === RUN TestIntegration/FsMkdir 2026/08/26 05:12:37 DEBUG : pacer: Reducing sleep to 53.696437ms 2026/08/26 05:12:37 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:12:37 DEBUG : pacer: Reducing sleep to 125.480115ms === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/26 05:12:37 INFO : dir/subdir: Making directory 2026/08/26 05:12:37 DEBUG : pacer: Reducing sleep to 252.380792ms 2026/08/26 05:12:37 DEBUG : pacer: Reducing sleep to 260.876417ms 2026/08/26 05:12:38 DEBUG : pacer: Reducing sleep to 207.010334ms 2026/08/26 05:12:38 DEBUG : pacer: Reducing sleep to 78.896584ms 2026/08/26 05:12:38 DEBUG : pacer: Reducing sleep to 56.480579ms 2026/08/26 05:12:38 DEBUG : pacer: Reducing sleep to 148.88565ms 2026/08/26 05:12:38 DEBUG : pacer: Reducing sleep to 263.813909ms 2026/08/26 05:12:38 INFO : dir/subdir: Removing directory 2026/08/26 05:12:38 DEBUG : pacer: Reducing sleep to 279.63141ms 2026/08/26 05:12:39 DEBUG : pacer: Reducing sleep to 169.183106ms 2026/08/26 05:12:39 DEBUG : pacer: Reducing sleep to 66.472203ms 2026/08/26 05:12:39 DEBUG : pacer: Reducing sleep to 67.505125ms 2026/08/26 05:12:39 INFO : dir: Removing directory 2026/08/26 05:12:39 DEBUG : pacer: Reducing sleep to 163.191682ms 2026/08/26 05:12:39 DEBUG : pacer: Reducing sleep to 252.957889ms 2026/08/26 05:12:39 DEBUG : pacer: Reducing sleep to 269.790136ms === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/26 05:12:40 DEBUG : pacer: Reducing sleep to 178.708922ms === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/26 05:12:44 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/26 05:12:49 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:727: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/08/26 05:12:58 DEBUG : pacer: Reducing sleep to 104.066998ms 2026/08/26 05:12:58 DEBUG : pacer: Reducing sleep to 229.096743ms 2026/08/26 05:12:58 DEBUG : pacer: Reducing sleep to 153.132895ms 2026/08/26 05:12:58 DEBUG : pacer: Reducing sleep to 219.299798ms 2026/08/26 05:13:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:13:03 DEBUG : pacer: Reducing sleep to 120.781202ms 2026/08/26 05:13:03 DEBUG : pacer: Reducing sleep to 106.405649ms 2026/08/26 05:13:03 DEBUG : pacer: Reducing sleep to 163.098845ms 2026/08/26 05:13:03 DEBUG : pacer: Reducing sleep to 213.476424ms 2026/08/26 05:13:07 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "." 2026/08/26 05:13:12 DEBUG : pacer: Reducing sleep to 102.259738ms 2026/08/26 05:13:12 DEBUG : pacer: Reducing sleep to 227.522561ms 2026/08/26 05:13:12 DEBUG : pacer: Reducing sleep to 122.993835ms 2026/08/26 05:13:12 DEBUG : pacer: Reducing sleep to 226.791025ms 2026/08/26 05:13:16 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:13:16 DEBUG : pacer: Reducing sleep to 117.039115ms 2026/08/26 05:13:17 DEBUG : pacer: Reducing sleep to 93.502183ms 2026/08/26 05:13:17 DEBUG : pacer: Reducing sleep to 157.2981ms 2026/08/26 05:13:17 DEBUG : pacer: Reducing sleep to 211.867896ms 2026/08/26 05:13:21 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing ".." 2026/08/26 05:13:26 DEBUG : pacer: Reducing sleep to 101.022713ms 2026/08/26 05:13:26 DEBUG : pacer: Reducing sleep to 226.353314ms 2026/08/26 05:13:26 DEBUG : pacer: Reducing sleep to 196.972356ms 2026/08/26 05:13:26 DEBUG : pacer: Reducing sleep to 223.663479ms 2026/08/26 05:13:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:13:30 DEBUG : pacer: Reducing sleep to 114.809513ms 2026/08/26 05:13:31 DEBUG : pacer: Reducing sleep to 99.867903ms 2026/08/26 05:13:31 DEBUG : pacer: Reducing sleep to 164.779296ms 2026/08/26 05:13:31 DEBUG : pacer: Reducing sleep to 219.407984ms 2026/08/26 05:13:35 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/08/26 05:13:35 DEBUG : zoho root 'rclone-test-lamawal8zumo': folder listing limiter sweep: evicted 0 of 8 idle limiters 2026/08/26 05:13:40 DEBUG : pacer: Reducing sleep to 73.809997ms 2026/08/26 05:13:40 DEBUG : pacer: Reducing sleep to 193.755009ms 2026/08/26 05:13:40 DEBUG : pacer: Reducing sleep to 154.092658ms 2026/08/26 05:13:40 DEBUG : pacer: Reducing sleep to 257.224512ms 2026/08/26 05:13:40 DEBUG : pacer: Reducing sleep to 272.085426ms 2026/08/26 05:13:40 DEBUG : pacer: Reducing sleep to 177.737063ms 2026/08/26 05:13:41 DEBUG : pacer: Reducing sleep to 64.37772ms 2026/08/26 05:13:41 DEBUG : pacer: Reducing sleep to 61.670109ms 2026/08/26 05:13:41 DEBUG : pacer: Reducing sleep to 156.564629ms 2026/08/26 05:13:41 DEBUG : pacer: Reducing sleep to 272.781904ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/26 05:13:41 DEBUG : pacer: Reducing sleep to 283.233021ms 2026/08/26 05:13:41 DEBUG : pacer: Reducing sleep to 146.222108ms 2026/08/26 05:13:42 DEBUG : pacer: Reducing sleep to 52.383396ms 2026/08/26 05:13:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:13:42 DEBUG : pacer: Reducing sleep to 118.8108ms 2026/08/26 05:13:42 DEBUG : pacer: Reducing sleep to 238.248145ms 2026/08/26 05:13:42 DEBUG : pacer: Reducing sleep to 276.642696ms 2026/08/26 05:13:42 DEBUG : pacer: Reducing sleep to 205.982612ms 2026/08/26 05:13:43 DEBUG : pacer: Reducing sleep to 100.146617ms 2026/08/26 05:13:43 DEBUG : pacer: Reducing sleep to 55.118062ms 2026/08/26 05:13:43 DEBUG : pacer: Reducing sleep to 131.547476ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/26 05:13:47 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:13:48 DEBUG : pacer: Reducing sleep to 98.439083ms 2026/08/26 05:13:48 DEBUG : pacer: Reducing sleep to 200.765476ms 2026/08/26 05:13:48 DEBUG : pacer: Reducing sleep to 111.235641ms 2026/08/26 05:13:48 DEBUG : pacer: Reducing sleep to 227.967326ms 2026/08/26 05:13:52 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:13:52 DEBUG : pacer: Reducing sleep to 114.894817ms 2026/08/26 05:13:52 DEBUG : pacer: Reducing sleep to 93.212646ms 2026/08/26 05:13:52 DEBUG : pacer: Reducing sleep to 159.366185ms 2026/08/26 05:13:53 DEBUG : pacer: Reducing sleep to 218.005665ms 2026/08/26 05:13:57 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/26 05:14:01 DEBUG : pacer: Reducing sleep to 100.753614ms 2026/08/26 05:14:01 DEBUG : pacer: Reducing sleep to 225.103874ms 2026/08/26 05:14:02 DEBUG : pacer: Reducing sleep to 115.250682ms 2026/08/26 05:14:02 DEBUG : pacer: Reducing sleep to 227.347936ms 2026/08/26 05:14:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:14:06 DEBUG : pacer: Reducing sleep to 113.125856ms 2026/08/26 05:14:06 DEBUG : pacer: Reducing sleep to 96.812092ms 2026/08/26 05:14:06 DEBUG : pacer: Reducing sleep to 158.265817ms 2026/08/26 05:14:06 DEBUG : pacer: Reducing sleep to 220.249692ms 2026/08/26 05:14:11 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/26 05:14:15 DEBUG : pacer: Reducing sleep to 97.934421ms 2026/08/26 05:14:15 DEBUG : pacer: Reducing sleep to 222.902938ms 2026/08/26 05:14:15 DEBUG : pacer: Reducing sleep to 203.044181ms 2026/08/26 05:14:16 DEBUG : pacer: Reducing sleep to 220.515164ms 2026/08/26 05:14:20 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:14:20 DEBUG : pacer: Reducing sleep to 114.805829ms 2026/08/26 05:14:20 DEBUG : pacer: Reducing sleep to 98.31459ms 2026/08/26 05:14:20 DEBUG : pacer: Reducing sleep to 162.06945ms 2026/08/26 05:14:20 DEBUG : pacer: Reducing sleep to 219.245106ms 2026/08/26 05:14:24 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/26 05:14:29 DEBUG : pacer: Reducing sleep to 93.548818ms 2026/08/26 05:14:29 DEBUG : pacer: Reducing sleep to 219.327717ms 2026/08/26 05:14:29 DEBUG : pacer: Reducing sleep to 149.31799ms 2026/08/26 05:14:29 DEBUG : pacer: Reducing sleep to 230.681329ms 2026/08/26 05:14:34 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:14:34 DEBUG : pacer: Reducing sleep to 116.185082ms 2026/08/26 05:14:34 DEBUG : pacer: Reducing sleep to 98.376296ms 2026/08/26 05:14:34 DEBUG : pacer: Reducing sleep to 161.207352ms 2026/08/26 05:14:34 DEBUG : pacer: Reducing sleep to 219.487222ms 2026/08/26 05:14:38 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/26 05:14:38 DEBUG : zoho root 'rclone-test-lamawal8zumo': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/26 05:14:38 DEBUG : pacer: Reducing sleep to 126.035712ms 2026/08/26 05:14:38 DEBUG : pacer: Reducing sleep to 83.863171ms 2026/08/26 05:14:39 DEBUG : pacer: Reducing sleep to 153.576622ms 2026/08/26 05:14:39 DEBUG : pacer: Reducing sleep to 152.786552ms 2026/08/26 05:14:39 DEBUG : pacer: Reducing sleep to 242.202517ms 2026/08/26 05:14:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:14:40 DEBUG : pacer: Reducing sleep to 117.670405ms 2026/08/26 05:14:40 DEBUG : pacer: Reducing sleep to 82.103406ms 2026/08/26 05:14:40 DEBUG : pacer: Reducing sleep to 141.69726ms 2026/08/26 05:14:40 DEBUG : pacer: Reducing sleep to 216.833251ms 2026/08/26 05:14:41 DEBUG : pacer: Reducing sleep to 253.86618ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/26 05:14:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:14:41 DEBUG : pacer: Reducing sleep to 101.016169ms 2026/08/26 05:14:42 DEBUG : pacer: Reducing sleep to 76.25246ms 2026/08/26 05:14:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:14:42 DEBUG : pacer: Reducing sleep to 121.426319ms 2026/08/26 05:14:42 DEBUG : pacer: Reducing sleep to 239.750891ms 2026/08/26 05:14:42 DEBUG : pacer: Reducing sleep to 284.262084ms 2026/08/26 05:14:42 DEBUG : pacer: Reducing sleep to 197.425973ms 2026/08/26 05:14:43 DEBUG : pacer: Reducing sleep to 97.296602ms 2026/08/26 05:14:43 DEBUG : pacer: Reducing sleep to 54.980751ms 2026/08/26 05:14:47 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/26 05:14:51 DEBUG : pacer: Reducing sleep to 100.061828ms 2026/08/26 05:14:51 DEBUG : pacer: Reducing sleep to 224.334131ms 2026/08/26 05:14:52 DEBUG : pacer: Reducing sleep to 194.721396ms 2026/08/26 05:14:52 DEBUG : pacer: Reducing sleep to 227.65257ms 2026/08/26 05:14:56 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:14:56 DEBUG : pacer: Reducing sleep to 115.355045ms 2026/08/26 05:14:56 DEBUG : pacer: Reducing sleep to 95.785203ms 2026/08/26 05:14:56 DEBUG : pacer: Reducing sleep to 156.840265ms 2026/08/26 05:14:56 DEBUG : pacer: Reducing sleep to 216.321905ms 2026/08/26 05:15:00 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/26 05:15:05 DEBUG : pacer: Reducing sleep to 95.207299ms 2026/08/26 05:15:05 DEBUG : pacer: Reducing sleep to 221.690158ms 2026/08/26 05:15:05 DEBUG : pacer: Reducing sleep to 149.641552ms 2026/08/26 05:15:06 DEBUG : pacer: Reducing sleep to 227.438365ms 2026/08/26 05:15:10 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:15:10 DEBUG : pacer: Reducing sleep to 111.439249ms 2026/08/26 05:15:10 DEBUG : pacer: Reducing sleep to 96.213731ms 2026/08/26 05:15:10 DEBUG : pacer: Reducing sleep to 162.516482ms 2026/08/26 05:15:10 DEBUG : pacer: Reducing sleep to 224.44884ms 2026/08/26 05:15:14 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/26 05:15:19 DEBUG : pacer: Reducing sleep to 100.456362ms 2026/08/26 05:15:19 DEBUG : pacer: Reducing sleep to 226.175307ms 2026/08/26 05:15:19 DEBUG : pacer: Reducing sleep to 155.211909ms 2026/08/26 05:15:19 DEBUG : pacer: Reducing sleep to 226.105949ms 2026/08/26 05:15:24 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:15:24 DEBUG : pacer: Reducing sleep to 85.863546ms 2026/08/26 05:15:24 DEBUG : pacer: Reducing sleep to 104.305762ms 2026/08/26 05:15:24 DEBUG : pacer: Reducing sleep to 196.588471ms 2026/08/26 05:15:24 DEBUG : pacer: Reducing sleep to 246.991196ms 2026/08/26 05:15:28 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/26 05:15:33 DEBUG : pacer: Reducing sleep to 100.990511ms 2026/08/26 05:15:33 DEBUG : pacer: Reducing sleep to 226.739292ms 2026/08/26 05:15:33 DEBUG : pacer: Reducing sleep to 173.242868ms 2026/08/26 05:15:33 DEBUG : pacer: Reducing sleep to 224.408713ms 2026/08/26 05:15:37 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:15:37 DEBUG : pacer: Reducing sleep to 114.806828ms 2026/08/26 05:15:38 DEBUG : pacer: Reducing sleep to 81.674797ms 2026/08/26 05:15:38 DEBUG : pacer: Reducing sleep to 159.458147ms 2026/08/26 05:15:38 DEBUG : pacer: Reducing sleep to 233.652268ms 2026/08/26 05:15:38 DEBUG : pacer: Reducing sleep to 252.322155ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/26 05:15:39 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:15:39 DEBUG : pacer: Reducing sleep to 99.983699ms 2026/08/26 05:15:39 DEBUG : zoho root 'rclone-test-lamawal8zumo': folder listing limiter sweep: evicted 6 of 13 idle limiters 2026/08/26 05:15:39 DEBUG : pacer: Reducing sleep to 77.741161ms 2026/08/26 05:15:39 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:15:39 DEBUG : pacer: Reducing sleep to 118.681657ms 2026/08/26 05:15:39 DEBUG : pacer: Reducing sleep to 238.633772ms 2026/08/26 05:15:39 DEBUG : pacer: Reducing sleep to 284.579271ms 2026/08/26 05:15:40 DEBUG : pacer: Reducing sleep to 202.092615ms 2026/08/26 05:15:40 DEBUG : pacer: Reducing sleep to 95.404958ms 2026/08/26 05:15:40 DEBUG : pacer: Reducing sleep to 46.316978ms 2026/08/26 05:15:41 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/26 05:15:41 DEBUG : pacer: Reducing sleep to 102.000728ms 2026/08/26 05:15:41 DEBUG : pacer: Reducing sleep to 227.260637ms 2026/08/26 05:15:41 DEBUG : pacer: Reducing sleep to 226.736296ms 2026/08/26 05:15:41 DEBUG : pacer: Reducing sleep to 224.955116ms 2026/08/26 05:15:46 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:15:46 DEBUG : pacer: Reducing sleep to 115.164635ms 2026/08/26 05:15:46 DEBUG : pacer: Reducing sleep to 111.990052ms 2026/08/26 05:15:46 DEBUG : pacer: Reducing sleep to 177.353468ms 2026/08/26 05:15:46 DEBUG : pacer: Reducing sleep to 223.329967ms 2026/08/26 05:15:50 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:718: Skipping invalid UTF-8 === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:727: testing "test%46.txt" 2026/08/26 05:15:55 DEBUG : pacer: Reducing sleep to 96.053318ms 2026/08/26 05:15:55 DEBUG : pacer: Reducing sleep to 222.081968ms 2026/08/26 05:15:55 DEBUG : pacer: Reducing sleep to 214.413088ms 2026/08/26 05:15:55 DEBUG : pacer: Reducing sleep to 227.860402ms 2026/08/26 05:15:59 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:16:00 DEBUG : pacer: Reducing sleep to 45.905153ms 2026/08/26 05:16:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:16:00 DEBUG : pacer: Reducing sleep to 100.749073ms 2026/08/26 05:16:00 DEBUG : pacer: Reducing sleep to 172.153838ms 2026/08/26 05:16:04 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/26 05:16:23 DEBUG : pacer: Reducing sleep to 96.250591ms 2026/08/26 05:16:23 DEBUG : pacer: Reducing sleep to 222.094521ms 2026/08/26 05:16:23 DEBUG : pacer: Reducing sleep to 260.230944ms 2026/08/26 05:16:23 DEBUG : pacer: Reducing sleep to 234.696771ms 2026/08/26 05:16:23 DEBUG : pacer: Reducing sleep to 110.851836ms 2026/08/26 05:16:23 DEBUG : pacer: Reducing sleep to 72.686379ms 2026/08/26 05:16:24 DEBUG : pacer: Reducing sleep to 85.467055ms 2026/08/26 05:16:24 DEBUG : pacer: Reducing sleep to 251.34949ms 2026/08/26 05:16:24 DEBUG : pacer: Reducing sleep to 291.637396ms === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/26 05:16:27 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:16:27 DEBUG : pacer: Reducing sleep to 54.38202ms 2026/08/26 05:16:32 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:16:32 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:16:32 UTC": parsing time "Wed, 26 Aug 2026 05:16:32 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:16:32 UTC" as " " 2026/08/26 05:16:32 DEBUG : pacer: Reducing sleep to 111.539879ms === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:806: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:839: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:892: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/08/26 05:16:36 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:16:41 DEBUG : zoho root 'rclone-test-lamawal8zumo': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/26 05:16:41 DEBUG : pacer: Reducing sleep to 126.24622ms 2026/08/26 05:16:41 DEBUG : pacer: Reducing sleep to 99.595958ms 2026/08/26 05:16:41 DEBUG : pacer: Reducing sleep to 218.575837ms 2026/08/26 05:16:41 DEBUG : pacer: Reducing sleep to 282.877269ms 2026/08/26 05:16:42 DEBUG : pacer: Reducing sleep to 162.198824ms 2026/08/26 05:16:42 DEBUG : pacer: Reducing sleep to 115.093717ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/26 05:16:42 DEBUG : pacer: Reducing sleep to 120.866118ms 2026/08/26 05:16:42 DEBUG : pacer: Reducing sleep to 169.561961ms 2026/08/26 05:16:42 DEBUG : pacer: Reducing sleep to 209.754827ms 2026/08/26 05:16:42 DEBUG : pacer: Reducing sleep to 212.77983ms 2026/08/26 05:16:43 DEBUG : pacer: Reducing sleep to 166.6521ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/26 05:16:43 DEBUG : pacer: Reducing sleep to 121.841996ms 2026/08/26 05:16:43 DEBUG : pacer: Reducing sleep to 120.94857ms 2026/08/26 05:16:43 DEBUG : pacer: Reducing sleep to 165.905874ms 2026/08/26 05:16:43 DEBUG : pacer: Reducing sleep to 209.022161ms 2026/08/26 05:16:43 DEBUG : pacer: Reducing sleep to 203.484175ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/26 05:16:44 DEBUG : pacer: Reducing sleep to 164.913694ms 2026/08/26 05:16:44 DEBUG : pacer: Reducing sleep to 128.279479ms 2026/08/26 05:16:44 DEBUG : pacer: Reducing sleep to 127.42185ms 2026/08/26 05:16:44 DEBUG : pacer: Reducing sleep to 166.195027ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/26 05:16:44 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/26 05:16:49 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/08/26 05:16:53 DEBUG : pacer: Reducing sleep to 118.056657ms 2026/08/26 05:16:53 DEBUG : pacer: Reducing sleep to 238.727488ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/26 05:16:58 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:16:58 DEBUG : pacer: Reducing sleep to 120.384732ms 2026/08/26 05:16:58 DEBUG : pacer: Reducing sleep to 97.440356ms 2026/08/26 05:16:58 DEBUG : pacer: Reducing sleep to 144.190746ms 2026/08/26 05:16:58 DEBUG : pacer: Reducing sleep to 212.355952ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2026/08/26 05:17:03 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/26 05:17:07 DEBUG : pacer: Reducing sleep to 120.669852ms 2026/08/26 05:17:07 DEBUG : pacer: Reducing sleep to 241.051728ms 2026/08/26 05:17:07 DEBUG : pacer: Reducing sleep to 284.7324ms 2026/08/26 05:17:08 DEBUG : pacer: Reducing sleep to 207.892624ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2026/08/26 05:17:12 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2026/08/26 05:17:12 DEBUG : pacer: Reducing sleep to 118.290297ms 2026/08/26 05:17:17 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:17 DEBUG : pacer: Reducing sleep to 96.569354ms 2026/08/26 05:17:17 DEBUG : pacer: Reducing sleep to 46.461375ms 2026/08/26 05:17:17 DEBUG : pacer: Reducing sleep to 165.128174ms 2026/08/26 05:17:21 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:21 DEBUG : pacer: Reducing sleep to 119.13854ms 2026/08/26 05:17:21 DEBUG : pacer: Reducing sleep to 281.980404ms 2026/08/26 05:17:21 DEBUG : pacer: Reducing sleep to 336.332578ms 2026/08/26 05:17:22 DEBUG : pacer: Reducing sleep to 220.428926ms 2026/08/26 05:17:22 DEBUG : pacer: Reducing sleep to 47.333864ms 2026/08/26 05:17:22 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:22 DEBUG : pacer: Reducing sleep to 111.239033ms 2026/08/26 05:17:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:26 DEBUG : pacer: Reducing sleep to 115.796889ms 2026/08/26 05:17:26 DEBUG : pacer: Reducing sleep to 220.855581ms 2026/08/26 05:17:26 DEBUG : pacer: Reducing sleep to 271.642692ms 2026/08/26 05:17:26 DEBUG : pacer: Reducing sleep to 215.001509ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2026/08/26 05:17:31 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:35 DEBUG : pacer: Reducing sleep to 101.300325ms 2026/08/26 05:17:35 DEBUG : pacer: Reducing sleep to 145.386682ms 2026/08/26 05:17:35 DEBUG : pacer: Reducing sleep to 265.131657ms 2026/08/26 05:17:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:40 DEBUG : pacer: Reducing sleep to 119.440619ms 2026/08/26 05:17:40 DEBUG : pacer: Reducing sleep to 281.062189ms 2026/08/26 05:17:40 DEBUG : pacer: Reducing sleep to 234.94672ms 2026/08/26 05:17:40 DEBUG : pacer: Reducing sleep to 119.305387ms 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 50.209243ms 2026/08/26 05:17:41 DEBUG : Creating backend with remote "TestZoho:rclone-test-lamawal8zumo/dirToPurgeFromRoot" 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 117.061617ms 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 242.077775ms 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 269.743427ms 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:41 DEBUG : zoho root 'rclone-test-lamawal8zumo': folder listing limiter sweep: evicted 2 of 10 idle limiters 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 117.535962ms 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 238.796599ms 2026/08/26 05:17:41 DEBUG : pacer: Reducing sleep to 284.35637ms 2026/08/26 05:17:42 DEBUG : pacer: Reducing sleep to 212.338181ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/26 05:17:42 DEBUG : Creating backend with remote "TestZoho:rclone-test-lamawal8zumo/hello? sausage/êé" 2026/08/26 05:17:42 DEBUG : pacer: Reducing sleep to 120.9291ms 2026/08/26 05:17:42 DEBUG : pacer: Reducing sleep to 242.014366ms 2026/08/26 05:17:42 DEBUG : pacer: Reducing sleep to 287.297184ms 2026/08/26 05:17:42 DEBUG : pacer: Reducing sleep to 209.170429ms 2026/08/26 05:17:43 DEBUG : pacer: Reducing sleep to 68.990649ms 2026/08/26 05:17:43 DEBUG : pacer: Reducing sleep to 53.661944ms 2026/08/26 05:17:43 DEBUG : pacer: Reducing sleep to 119.102135ms 2026/08/26 05:17:43 DEBUG : pacer: Reducing sleep to 247.094814ms 2026/08/26 05:17:43 DEBUG : pacer: Reducing sleep to 261.817054ms 2026/08/26 05:17:43 DEBUG : pacer: Reducing sleep to 210.732743ms 2026/08/26 05:17:43 DEBUG : pacer: Reducing sleep to 85.175205ms 2026/08/26 05:17:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:44 DEBUG : pacer: Reducing sleep to 118.716462ms 2026/08/26 05:17:44 DEBUG : pacer: Reducing sleep to 238.784988ms 2026/08/26 05:17:44 DEBUG : pacer: Reducing sleep to 276.601816ms 2026/08/26 05:17:44 DEBUG : pacer: Reducing sleep to 214.026789ms 2026/08/26 05:17:45 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:45 DEBUG : pacer: Reducing sleep to 95.59923ms 2026/08/26 05:17:45 DEBUG : pacer: Reducing sleep to 248.846216ms 2026/08/26 05:17:45 DEBUG : pacer: Reducing sleep to 370.180812ms 2026/08/26 05:17:45 DEBUG : pacer: Reducing sleep to 425.311886ms 2026/08/26 05:17:45 DEBUG : pacer: Reducing sleep to 237.251363ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2026/08/26 05:17:45 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:46 DEBUG : pacer: Reducing sleep to 102.60124ms 2026/08/26 05:17:46 DEBUG : pacer: Reducing sleep to 218.843422ms 2026/08/26 05:17:46 DEBUG : pacer: Reducing sleep to 282.6778ms 2026/08/26 05:17:49 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:49 DEBUG : pacer: Reducing sleep to 117.6775ms 2026/08/26 05:17:49 DEBUG : pacer: Reducing sleep to 47.170453ms 2026/08/26 05:17:53 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:53 DEBUG : pacer: Reducing sleep to 86.624663ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1318: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/26 05:17:58 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:17:58 DEBUG : pacer: Reducing sleep to 100.305948ms 2026/08/26 05:17:58 DEBUG : pacer: Reducing sleep to 188.353087ms 2026/08/26 05:17:58 DEBUG : pacer: Reducing sleep to 277.097764ms 2026/08/26 05:17:58 DEBUG : pacer: Reducing sleep to 263.70265ms 2026/08/26 05:17:59 DEBUG : pacer: Reducing sleep to 150.503407ms 2026/08/26 05:17:59 DEBUG : pacer: Reducing sleep to 54.408914ms 2026/08/26 05:17:59 DEBUG : pacer: Reducing sleep to 69.118501ms 2026/08/26 05:18:02 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:12 DEBUG : pacer: Reducing sleep to 97.196536ms 2026/08/26 05:18:12 DEBUG : pacer: Reducing sleep to 206.009927ms 2026/08/26 05:18:12 DEBUG : pacer: Reducing sleep to 259.488982ms 2026/08/26 05:18:12 DEBUG : pacer: Reducing sleep to 236.846978ms 2026/08/26 05:18:17 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:17 DEBUG : pacer: Reducing sleep to 121.293308ms 2026/08/26 05:18:17 DEBUG : pacer: Reducing sleep to 281.1475ms 2026/08/26 05:18:17 DEBUG : pacer: Reducing sleep to 260.311995ms 2026/08/26 05:18:17 DEBUG : pacer: Reducing sleep to 150.173423ms 2026/08/26 05:18:17 DEBUG : pacer: Reducing sleep to 61.777646ms 2026/08/26 05:18:18 DEBUG : pacer: Reducing sleep to 60.562734ms 2026/08/26 05:18:18 DEBUG : pacer: Reducing sleep to 140.674799ms 2026/08/26 05:18:18 DEBUG : pacer: Reducing sleep to 239.853878ms 2026/08/26 05:18:18 DEBUG : pacer: Reducing sleep to 273.983567ms 2026/08/26 05:18:21 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:21 DEBUG : pacer: Reducing sleep to 125.914293ms 2026/08/26 05:18:21 DEBUG : pacer: Reducing sleep to 284.012869ms 2026/08/26 05:18:22 DEBUG : pacer: Reducing sleep to 228.974222ms 2026/08/26 05:18:22 DEBUG : pacer: Reducing sleep to 99.081627ms 2026/08/26 05:18:22 DEBUG : pacer: Reducing sleep to 55.012642ms 2026/08/26 05:18:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:26 DEBUG : pacer: Reducing sleep to 108.222385ms 2026/08/26 05:18:26 DEBUG : pacer: Reducing sleep to 195.012591ms 2026/08/26 05:18:26 DEBUG : pacer: Reducing sleep to 273.719133ms 2026/08/26 05:18:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:31 DEBUG : pacer: Reducing sleep to 124.19712ms 2026/08/26 05:18:31 DEBUG : pacer: Reducing sleep to 287.381492ms 2026/08/26 05:18:31 DEBUG : pacer: Reducing sleep to 228.468197ms 2026/08/26 05:18:31 DEBUG : pacer: Reducing sleep to 106.132963ms 2026/08/26 05:18:31 DEBUG : pacer: Reducing sleep to 45.675552ms 2026/08/26 05:18:31 DEBUG : pacer: Reducing sleep to 103.801561ms 2026/08/26 05:18:31 DEBUG : pacer: Reducing sleep to 215.262834ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/26 05:18:31 DEBUG : Creating backend with remote "TestZoho:rclone-test-dejuzes0sudo" 2026/08/26 05:18:32 DEBUG : pacer: Reducing sleep to 36.125205ms 2026/08/26 05:18:32 DEBUG : pacer: Reducing sleep to 79.365816ms 2026/08/26 05:18:32 DEBUG : pacer: Reducing sleep to 105.713458ms 2026/08/26 05:18:32 DEBUG : pacer: Reducing sleep to 231.559255ms 2026/08/26 05:18:32 DEBUG : pacer: Reducing sleep to 260.918592ms 2026/08/26 05:18:32 DEBUG : pacer: Reducing sleep to 224.358037ms 2026/08/26 05:18:33 DEBUG : pacer: Reducing sleep to 93.953606ms 2026/08/26 05:18:33 DEBUG : pacer: Reducing sleep to 52.749531ms 2026/08/26 05:18:33 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:33 DEBUG : pacer: Reducing sleep to 44.423349ms 2026/08/26 05:18:33 DEBUG : pacer: Reducing sleep to 158.567157ms 2026/08/26 05:18:35 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:35 DEBUG : pacer: Reducing sleep to 116.05669ms 2026/08/26 05:18:35 DEBUG : pacer: Reducing sleep to 177.999987ms 2026/08/26 05:18:35 DEBUG : pacer: Reducing sleep to 226.06533ms 2026/08/26 05:18:36 DEBUG : pacer: Reducing sleep to 190.400866ms 2026/08/26 05:18:37 DEBUG : pacer: Reducing sleep to 35.561441ms 2026/08/26 05:18:37 DEBUG : pacer: Reducing sleep to 154.397158ms 2026/08/26 05:18:37 DEBUG : pacer: Reducing sleep to 273.220752ms 2026/08/26 05:18:38 DEBUG : pacer: Reducing sleep to 266.519378ms 2026/08/26 05:18:38 DEBUG : pacer: Reducing sleep to 175.132624ms 2026/08/26 05:18:38 DEBUG : pacer: Reducing sleep to 72.354589ms 2026/08/26 05:18:38 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:18:38 DEBUG : pacer: Reducing sleep to 126.009975ms 2026/08/26 05:18:38 DEBUG : zoho root 'rclone-test-dejuzes0sudo': Purge remote 2026/08/26 05:18:38 DEBUG : pacer: Reducing sleep to 140.002636ms 2026/08/26 05:18:39 DEBUG : pacer: Reducing sleep to 172.724655ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2026/08/26 05:18:39 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2026/08/26 05:18:39 DEBUG : pacer: Reducing sleep to 118.990598ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2026/08/26 05:18:39 DEBUG : pacer: Reducing sleep to 234.302452ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2026/08/26 05:18:39 DEBUG : pacer: Reducing sleep to 282.221969ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2026/08/26 05:18:39 DEBUG : pacer: Reducing sleep to 213.728322ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2026/08/26 05:18:40 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1626: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata 2026/08/26 05:18:45 DEBUG : zoho root 'rclone-test-lamawal8zumo': folder listing limiter sweep: evicted 6 of 15 idle limiters fstests.go:1657: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1728: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime fstests.go:1785: can't set modified time === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/08/26 05:19:08 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:08 UTC": parsing time "Wed, 26 Aug 2026 05:19:08 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:08 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/26 05:19:13 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:13 UTC": parsing time "Wed, 26 Aug 2026 05:19:13 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:13 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/26 05:19:17 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:17 UTC": parsing time "Wed, 26 Aug 2026 05:19:17 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:17 UTC" as " " 2026/08/26 05:19:18 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:18 UTC": parsing time "Wed, 26 Aug 2026 05:19:18 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:18 UTC" as " " 2026/08/26 05:19:18 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:18 UTC": parsing time "Wed, 26 Aug 2026 05:19:18 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:18 UTC" as " " 2026/08/26 05:19:18 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:18 UTC": parsing time "Wed, 26 Aug 2026 05:19:18 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:18 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/26 05:19:22 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:22 UTC": parsing time "Wed, 26 Aug 2026 05:19:22 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:22 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/26 05:19:27 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:27 UTC": parsing time "Wed, 26 Aug 2026 05:19:27 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:27 UTC" as " " 2026/08/26 05:19:27 DEBUG : pacer: Reducing sleep to 18.514531ms 2026/08/26 05:19:31 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:19:31 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:31 UTC": parsing time "Wed, 26 Aug 2026 05:19:31 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:31 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/26 05:19:31 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:31 UTC": parsing time "Wed, 26 Aug 2026 05:19:31 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:31 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/26 05:19:32 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:32 UTC": parsing time "Wed, 26 Aug 2026 05:19:32 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:32 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/26 05:19:32 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:32 UTC": parsing time "Wed, 26 Aug 2026 05:19:32 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:32 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/26 05:19:32 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:32 UTC": parsing time "Wed, 26 Aug 2026 05:19:32 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:32 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/26 05:19:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:36 UTC": parsing time "Wed, 26 Aug 2026 05:19:36 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:36 UTC" as " " 2026/08/26 05:19:36 DEBUG : pacer: Reducing sleep to 14.382038ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/26 05:19:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:19:40 DEBUG : pacer: Reducing sleep to 119.305604ms 2026/08/26 05:19:41 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Wed, 26 Aug 2026 05:19:41 UTC": parsing time "Wed, 26 Aug 2026 05:19:41 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 26 Aug 2026 05:19:41 UTC" as " " 2026/08/26 05:19:41 DEBUG : pacer: Reducing sleep to 12.341656ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2026/08/26 05:19:41 DEBUG : pacer: Reducing sleep to 128.478346ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/26 05:19:41 DEBUG : Creating backend with remote "TestZoho:rclone-test-lamawal8zumo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/26 05:19:41 DEBUG : pacer: Reducing sleep to 115.737765ms 2026/08/26 05:19:41 DEBUG : pacer: Reducing sleep to 236.884626ms 2026/08/26 05:19:41 DEBUG : pacer: Reducing sleep to 281.197234ms 2026/08/26 05:19:41 DEBUG : pacer: Reducing sleep to 212.752439ms 2026/08/26 05:19:42 DEBUG : pacer: Reducing sleep to 92.332482ms 2026/08/26 05:19:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:19:42 DEBUG : pacer: Reducing sleep to 116.026514ms 2026/08/26 05:19:42 DEBUG : pacer: Reducing sleep to 233.371354ms 2026/08/26 05:19:42 DEBUG : pacer: Reducing sleep to 283.639526ms 2026/08/26 05:19:42 DEBUG : pacer: Reducing sleep to 214.729444ms 2026/08/26 05:19:43 DEBUG : pacer: Reducing sleep to 94.661682ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/26 05:19:43 DEBUG : pacer: Reducing sleep to 46.98841ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/26 05:19:43 DEBUG : Creating backend with remote "TestZoho:rclone-test-lamawal8zumo/not found.txt" 2026/08/26 05:19:43 DEBUG : pacer: Reducing sleep to 119.662517ms 2026/08/26 05:19:43 DEBUG : pacer: Reducing sleep to 163.125698ms 2026/08/26 05:19:48 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:19:48 DEBUG : zoho root 'rclone-test-lamawal8zumo/not found.txt': folder listing limiter sweep: evicted 3 of 9 idle limiters 2026/08/26 05:19:52 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestZoho:" path "rclone-test-lamawal8zumo" from "TestZoho:rclone-test-lamawal8zumo" 2026/08/26 05:19:52 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/26 05:19:57 DEBUG : pacer: Reducing sleep to 118.44486ms 2026/08/26 05:19:57 DEBUG : pacer: Reducing sleep to 239.103699ms 2026/08/26 05:19:57 DEBUG : pacer: Reducing sleep to 282.605204ms 2026/08/26 05:19:58 DEBUG : pacer: Reducing sleep to 205.527699ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/26 05:20:02 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2024: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/08/26 05:20:16 DEBUG : pacer: Reducing sleep to 113.655976ms 2026/08/26 05:20:16 DEBUG : pacer: Reducing sleep to 233.85096ms 2026/08/26 05:20:16 DEBUG : pacer: Reducing sleep to 284.92813ms 2026/08/26 05:20:16 DEBUG : pacer: Reducing sleep to 213.961052ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/26 05:20:16 DEBUG : pacer: Reducing sleep to 76.561541ms 2026/08/26 05:20:20 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:20:20 DEBUG : pacer: Reducing sleep to 121.175936ms 2026/08/26 05:20:20 DEBUG : pacer: Reducing sleep to 240.605704ms 2026/08/26 05:20:20 DEBUG : pacer: Reducing sleep to 288.343849ms 2026/08/26 05:20:21 DEBUG : pacer: Reducing sleep to 209.949937ms === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2083: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:431: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2188: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2204: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/08/26 05:20:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:20:29 DEBUG : pacer: Reducing sleep to 87.865937ms 2026/08/26 05:20:30 DEBUG : pacer: Reducing sleep to 49.992851ms 2026/08/26 05:20:30 DEBUG : pacer: Reducing sleep to 4.804101ms 2026/08/26 05:20:30 DEBUG : pacer: Reducing sleep to 84.735114ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout 2026/08/26 05:20:30 DEBUG : pacer: Reducing sleep to 150.987178ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream fstests.go:2378: FS has no PutStream interface === RUN TestIntegration/FsMkdir/FsPutFiles/Internal fstests.go:2424: *zoho.Fs does not implement InternalTester === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2445: *zoho.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/08/26 05:20:34 DEBUG : pacer: Reducing sleep to 0s 2026/08/26 05:20:34 DEBUG : pacer: Reducing sleep to 108.095126ms fstests.go:2596: Put returned an error (acceptable): upload error: HTTP error 400 (400 Bad Request) returned body: "\r\n