"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/13 05:35:00 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/13 05:35:00 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/13 05:35:00 NOTICE: zoho root '': Failed to parse Retry-After: "soon": strconv.Atoi: parsing "soon": invalid syntax 2026/08/13 05:35:00 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/13 05:35:00 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/13 05:35:00 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/13 05:35:00 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/13 05:35:00 DEBUG : Creating backend with remote "TestZoho:rclone-test-qajural2qoqa" 2026/08/13 05:35:00 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/13 05:35:00 DEBUG : zoho root 'rclone-test-qajural2qoqa': folder listing limiter sweep: evicted 0 of 0 idle limiters 2026/08/13 05:35:00 DEBUG : TestZoho: Token expired 2026/08/13 05:35:00 DEBUG : TestZoho: No updated token found in the config file 2026/08/13 05:35:00 DEBUG : TestZoho: Token refresh successful 2026/08/13 05:35:00 DEBUG : Saving config "token" in section "TestZoho" of the config file 2026/08/13 05:35:00 DEBUG : TestZoho: Saved new token in config file === 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/13 05:35:01 DEBUG : pacer: Reducing sleep to 31.39743ms 2026/08/13 05:35:01 DEBUG : pacer: Reducing sleep to 66.932724ms 2026/08/13 05:35:01 DEBUG : pacer: Reducing sleep to 58.268121ms 2026/08/13 05:35:01 DEBUG : pacer: Reducing sleep to 183.327378ms === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty 2026/08/13 05:35:01 DEBUG : pacer: Reducing sleep to 285.128496ms 2026/08/13 05:35:01 DEBUG : pacer: Reducing sleep to 257.006392ms === RUN TestIntegration/FsMkdir 2026/08/13 05:35:02 DEBUG : pacer: Reducing sleep to 64.486416ms 2026/08/13 05:35:02 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:35:02 DEBUG : pacer: Reducing sleep to 124.571475ms === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/13 05:35:02 INFO : dir/subdir: Making directory 2026/08/13 05:35:02 DEBUG : pacer: Reducing sleep to 249.787938ms 2026/08/13 05:35:02 DEBUG : pacer: Reducing sleep to 262.612406ms 2026/08/13 05:35:02 DEBUG : pacer: Reducing sleep to 208.575917ms 2026/08/13 05:35:03 DEBUG : pacer: Reducing sleep to 80.414252ms 2026/08/13 05:35:03 DEBUG : pacer: Reducing sleep to 55.837344ms 2026/08/13 05:35:03 DEBUG : pacer: Reducing sleep to 147.183137ms 2026/08/13 05:35:03 DEBUG : pacer: Reducing sleep to 263.347077ms 2026/08/13 05:35:03 INFO : dir/subdir: Removing directory 2026/08/13 05:35:03 DEBUG : pacer: Reducing sleep to 276.373506ms 2026/08/13 05:35:03 DEBUG : pacer: Reducing sleep to 167.631253ms 2026/08/13 05:35:04 DEBUG : pacer: Reducing sleep to 59.680955ms 2026/08/13 05:35:04 DEBUG : pacer: Reducing sleep to 72.339209ms 2026/08/13 05:35:04 INFO : dir: Removing directory 2026/08/13 05:35:04 DEBUG : pacer: Reducing sleep to 175.030628ms 2026/08/13 05:35:04 DEBUG : pacer: Reducing sleep to 259.657383ms 2026/08/13 05:35:04 DEBUG : pacer: Reducing sleep to 263.528514ms === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/13 05:35:04 DEBUG : pacer: Reducing sleep to 169.967067ms === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/13 05:35:09 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/13 05:35:13 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/13 05:35:23 DEBUG : pacer: Reducing sleep to 98.439768ms 2026/08/13 05:35:23 DEBUG : pacer: Reducing sleep to 224.559157ms 2026/08/13 05:35:23 DEBUG : pacer: Reducing sleep to 91.1513ms 2026/08/13 05:35:23 DEBUG : pacer: Reducing sleep to 209.293736ms 2026/08/13 05:35:27 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:35:27 DEBUG : pacer: Reducing sleep to 116.284866ms 2026/08/13 05:35:27 DEBUG : pacer: Reducing sleep to 116.476151ms 2026/08/13 05:35:28 DEBUG : pacer: Reducing sleep to 170.442121ms 2026/08/13 05:35:28 DEBUG : pacer: Reducing sleep to 218.300666ms 2026/08/13 05:35:32 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "." 2026/08/13 05:35:36 DEBUG : pacer: Reducing sleep to 99.068296ms 2026/08/13 05:35:37 DEBUG : pacer: Reducing sleep to 223.190886ms 2026/08/13 05:35:37 DEBUG : pacer: Reducing sleep to 192.150273ms 2026/08/13 05:35:37 DEBUG : pacer: Reducing sleep to 228.358029ms 2026/08/13 05:35:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:35:41 DEBUG : pacer: Reducing sleep to 114.853796ms 2026/08/13 05:35:41 DEBUG : pacer: Reducing sleep to 91.583948ms 2026/08/13 05:35:41 DEBUG : pacer: Reducing sleep to 153.351881ms 2026/08/13 05:35:41 DEBUG : pacer: Reducing sleep to 219.944182ms 2026/08/13 05:35:46 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing ".." 2026/08/13 05:35:50 DEBUG : pacer: Reducing sleep to 101.913249ms 2026/08/13 05:35:50 DEBUG : pacer: Reducing sleep to 226.658394ms 2026/08/13 05:35:51 DEBUG : pacer: Reducing sleep to 141.45709ms 2026/08/13 05:35:51 DEBUG : pacer: Reducing sleep to 225.30133ms 2026/08/13 05:35:55 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:35:55 DEBUG : pacer: Reducing sleep to 116.676167ms 2026/08/13 05:35:55 DEBUG : pacer: Reducing sleep to 98.43216ms 2026/08/13 05:35:55 DEBUG : pacer: Reducing sleep to 155.132836ms 2026/08/13 05:35:55 DEBUG : pacer: Reducing sleep to 213.089262ms 2026/08/13 05:36:00 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/08/13 05:36:04 DEBUG : pacer: Reducing sleep to 96.697011ms 2026/08/13 05:36:04 DEBUG : zoho root 'rclone-test-qajural2qoqa': folder listing limiter sweep: evicted 4 of 8 idle limiters 2026/08/13 05:36:04 DEBUG : pacer: Reducing sleep to 222.943631ms 2026/08/13 05:36:04 DEBUG : pacer: Reducing sleep to 179.45726ms 2026/08/13 05:36:05 DEBUG : pacer: Reducing sleep to 225.348734ms 2026/08/13 05:36:05 DEBUG : pacer: Reducing sleep to 216.035834ms 2026/08/13 05:36:05 DEBUG : pacer: Reducing sleep to 156.213125ms 2026/08/13 05:36:05 DEBUG : pacer: Reducing sleep to 95.675927ms 2026/08/13 05:36:05 DEBUG : pacer: Reducing sleep to 117.602186ms 2026/08/13 05:36:05 DEBUG : pacer: Reducing sleep to 176.428445ms 2026/08/13 05:36:06 DEBUG : pacer: Reducing sleep to 236.317642ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/13 05:36:06 DEBUG : pacer: Reducing sleep to 227.649789ms 2026/08/13 05:36:06 DEBUG : pacer: Reducing sleep to 126.459887ms 2026/08/13 05:36:06 DEBUG : pacer: Reducing sleep to 94.944311ms 2026/08/13 05:36:06 DEBUG : pacer: Reducing sleep to 3.742618ms 2026/08/13 05:36:06 DEBUG : pacer: Reducing sleep to 123.415846ms 2026/08/13 05:36:07 DEBUG : pacer: Reducing sleep to 244.086297ms 2026/08/13 05:36:07 DEBUG : pacer: Reducing sleep to 283.529645ms 2026/08/13 05:36:07 DEBUG : pacer: Reducing sleep to 198.691569ms 2026/08/13 05:36:07 DEBUG : pacer: Reducing sleep to 93.109833ms 2026/08/13 05:36:07 DEBUG : pacer: Reducing sleep to 49.56333ms 2026/08/13 05:36:07 DEBUG : pacer: Reducing sleep to 138.201332ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/13 05:36:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:36:12 DEBUG : pacer: Reducing sleep to 101.373131ms 2026/08/13 05:36:12 DEBUG : pacer: Reducing sleep to 195.078874ms 2026/08/13 05:36:12 DEBUG : pacer: Reducing sleep to 167.049402ms 2026/08/13 05:36:12 DEBUG : pacer: Reducing sleep to 224.973718ms 2026/08/13 05:36:17 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:36:17 DEBUG : pacer: Reducing sleep to 117.023412ms 2026/08/13 05:36:17 DEBUG : pacer: Reducing sleep to 100.405581ms 2026/08/13 05:36:17 DEBUG : pacer: Reducing sleep to 160.788499ms 2026/08/13 05:36:17 DEBUG : pacer: Reducing sleep to 216.309647ms 2026/08/13 05:36:21 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/13 05:36:26 DEBUG : pacer: Reducing sleep to 97.059928ms 2026/08/13 05:36:26 DEBUG : pacer: Reducing sleep to 222.314894ms 2026/08/13 05:36:26 DEBUG : pacer: Reducing sleep to 148.322802ms 2026/08/13 05:36:26 DEBUG : pacer: Reducing sleep to 225.701134ms 2026/08/13 05:36:31 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:36:31 DEBUG : pacer: Reducing sleep to 114.842887ms 2026/08/13 05:36:31 DEBUG : pacer: Reducing sleep to 97.331737ms 2026/08/13 05:36:31 DEBUG : pacer: Reducing sleep to 159.102668ms 2026/08/13 05:36:31 DEBUG : pacer: Reducing sleep to 216.917107ms 2026/08/13 05:36:35 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/13 05:36:40 DEBUG : pacer: Reducing sleep to 70.081114ms 2026/08/13 05:36:40 DEBUG : pacer: Reducing sleep to 193.201521ms 2026/08/13 05:36:40 DEBUG : pacer: Reducing sleep to 180.726171ms 2026/08/13 05:36:40 DEBUG : pacer: Reducing sleep to 257.751287ms 2026/08/13 05:36:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:36:44 DEBUG : pacer: Reducing sleep to 114.937474ms 2026/08/13 05:36:45 DEBUG : pacer: Reducing sleep to 36.205414ms 2026/08/13 05:36:45 DEBUG : pacer: Reducing sleep to 113.537349ms 2026/08/13 05:36:45 DEBUG : pacer: Reducing sleep to 219.587452ms 2026/08/13 05:36:49 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/13 05:36:54 DEBUG : pacer: Reducing sleep to 100.663061ms 2026/08/13 05:36:54 DEBUG : pacer: Reducing sleep to 228.60843ms 2026/08/13 05:36:54 DEBUG : pacer: Reducing sleep to 212.424288ms 2026/08/13 05:36:54 DEBUG : pacer: Reducing sleep to 223.822301ms 2026/08/13 05:36:58 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:36:58 DEBUG : pacer: Reducing sleep to 114.84952ms 2026/08/13 05:36:58 DEBUG : pacer: Reducing sleep to 99.450512ms 2026/08/13 05:36:59 DEBUG : pacer: Reducing sleep to 163.029618ms 2026/08/13 05:36:59 DEBUG : pacer: Reducing sleep to 216.399456ms 2026/08/13 05:37:03 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/13 05:37:03 DEBUG : pacer: Reducing sleep to 124.563272ms 2026/08/13 05:37:03 DEBUG : pacer: Reducing sleep to 86.515106ms 2026/08/13 05:37:03 DEBUG : pacer: Reducing sleep to 159.984709ms 2026/08/13 05:37:03 DEBUG : pacer: Reducing sleep to 104.464721ms 2026/08/13 05:37:03 DEBUG : pacer: Reducing sleep to 222.987517ms 2026/08/13 05:37:05 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:37:05 DEBUG : zoho root 'rclone-test-qajural2qoqa': folder listing limiter sweep: evicted 3 of 11 idle limiters 2026/08/13 05:37:05 DEBUG : pacer: Reducing sleep to 122.335686ms 2026/08/13 05:37:05 DEBUG : pacer: Reducing sleep to 98.417953ms 2026/08/13 05:37:05 DEBUG : pacer: Reducing sleep to 156.440116ms 2026/08/13 05:37:05 DEBUG : pacer: Reducing sleep to 209.800777ms 2026/08/13 05:37:05 DEBUG : pacer: Reducing sleep to 232.714474ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/13 05:37:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:37:06 DEBUG : pacer: Reducing sleep to 102.151162ms 2026/08/13 05:37:06 DEBUG : pacer: Reducing sleep to 100.49264ms 2026/08/13 05:37:06 DEBUG : pacer: Reducing sleep to 71.260661ms 2026/08/13 05:37:06 DEBUG : pacer: Reducing sleep to 190.852656ms 2026/08/13 05:37:07 DEBUG : pacer: Reducing sleep to 287.408271ms 2026/08/13 05:37:07 DEBUG : pacer: Reducing sleep to 261.745343ms 2026/08/13 05:37:07 DEBUG : pacer: Reducing sleep to 128.555954ms 2026/08/13 05:37:07 DEBUG : pacer: Reducing sleep to 49.374056ms 2026/08/13 05:37:07 DEBUG : pacer: Reducing sleep to 73.115636ms 2026/08/13 05:37:11 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/13 05:37:16 DEBUG : pacer: Reducing sleep to 96.952647ms 2026/08/13 05:37:16 DEBUG : pacer: Reducing sleep to 222.625625ms 2026/08/13 05:37:16 DEBUG : pacer: Reducing sleep to 143.768891ms 2026/08/13 05:37:16 DEBUG : pacer: Reducing sleep to 229.732254ms 2026/08/13 05:37:20 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:37:20 DEBUG : pacer: Reducing sleep to 118.368464ms 2026/08/13 05:37:21 DEBUG : pacer: Reducing sleep to 94.180142ms 2026/08/13 05:37:21 DEBUG : pacer: Reducing sleep to 153.105432ms 2026/08/13 05:37:21 DEBUG : pacer: Reducing sleep to 217.821646ms 2026/08/13 05:37:25 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/13 05:37:30 DEBUG : pacer: Reducing sleep to 96.78519ms 2026/08/13 05:37:30 DEBUG : pacer: Reducing sleep to 50.007542ms 2026/08/13 05:37:30 DEBUG : pacer: Reducing sleep to 167.460457ms 2026/08/13 05:37:34 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:37:34 DEBUG : pacer: Reducing sleep to 115.17739ms 2026/08/13 05:37:34 DEBUG : pacer: Reducing sleep to 158.252231ms 2026/08/13 05:37:34 DEBUG : pacer: Reducing sleep to 221.283884ms 2026/08/13 05:37:35 DEBUG : pacer: Reducing sleep to 218.229127ms 2026/08/13 05:37:39 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/13 05:37:43 DEBUG : pacer: Reducing sleep to 98.947062ms 2026/08/13 05:37:44 DEBUG : pacer: Reducing sleep to 220.24999ms 2026/08/13 05:37:44 DEBUG : pacer: Reducing sleep to 206.112025ms 2026/08/13 05:37:44 DEBUG : pacer: Reducing sleep to 228.78448ms 2026/08/13 05:37:48 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:37:48 DEBUG : pacer: Reducing sleep to 110.976949ms 2026/08/13 05:37:48 DEBUG : pacer: Reducing sleep to 92.847938ms 2026/08/13 05:37:48 DEBUG : pacer: Reducing sleep to 160.880244ms 2026/08/13 05:37:48 DEBUG : pacer: Reducing sleep to 224.293319ms 2026/08/13 05:37:53 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/13 05:37:57 DEBUG : pacer: Reducing sleep to 100.25421ms 2026/08/13 05:37:57 DEBUG : pacer: Reducing sleep to 226.288872ms 2026/08/13 05:37:58 DEBUG : pacer: Reducing sleep to 149.793302ms 2026/08/13 05:37:58 DEBUG : pacer: Reducing sleep to 224.957216ms 2026/08/13 05:38:02 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:38:02 DEBUG : pacer: Reducing sleep to 114.731919ms 2026/08/13 05:38:02 DEBUG : pacer: Reducing sleep to 98.551227ms 2026/08/13 05:38:02 DEBUG : pacer: Reducing sleep to 162.512498ms 2026/08/13 05:38:02 DEBUG : pacer: Reducing sleep to 219.542331ms 2026/08/13 05:38:02 DEBUG : pacer: Reducing sleep to 237.330494ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/13 05:38:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:38:03 DEBUG : pacer: Reducing sleep to 100.594242ms 2026/08/13 05:38:04 DEBUG : pacer: Reducing sleep to 89.088531ms 2026/08/13 05:38:04 DEBUG : pacer: Reducing sleep to 64.113024ms 2026/08/13 05:38:04 DEBUG : pacer: Reducing sleep to 182.914197ms 2026/08/13 05:38:04 DEBUG : pacer: Reducing sleep to 285.704147ms 2026/08/13 05:38:04 DEBUG : pacer: Reducing sleep to 268.122102ms 2026/08/13 05:38:04 DEBUG : pacer: Reducing sleep to 134.804957ms 2026/08/13 05:38:05 DEBUG : pacer: Reducing sleep to 46.620215ms 2026/08/13 05:38:05 DEBUG : pacer: Reducing sleep to 70.197669ms 2026/08/13 05:38:05 DEBUG : zoho root 'rclone-test-qajural2qoqa': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/13 05:38:05 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/13 05:38:06 DEBUG : pacer: Reducing sleep to 99.273208ms 2026/08/13 05:38:06 DEBUG : pacer: Reducing sleep to 224.648335ms 2026/08/13 05:38:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:38:06 DEBUG : pacer: Reducing sleep to 118.773119ms 2026/08/13 05:38:10 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:38:10 DEBUG : pacer: Reducing sleep to 113.47197ms 2026/08/13 05:38:10 DEBUG : pacer: Reducing sleep to 200.568757ms 2026/08/13 05:38:10 DEBUG : pacer: Reducing sleep to 269.137397ms 2026/08/13 05:38:11 DEBUG : pacer: Reducing sleep to 223.198527ms 2026/08/13 05:38:15 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/13 05:38:20 DEBUG : pacer: Reducing sleep to 88.717516ms 2026/08/13 05:38:20 DEBUG : pacer: Reducing sleep to 203.674962ms 2026/08/13 05:38:20 DEBUG : pacer: Reducing sleep to 118.491268ms 2026/08/13 05:38:20 DEBUG : pacer: Reducing sleep to 237.390114ms 2026/08/13 05:38:24 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:38:24 DEBUG : pacer: Reducing sleep to 115.868206ms 2026/08/13 05:38:24 DEBUG : pacer: Reducing sleep to 71.563252ms 2026/08/13 05:38:24 DEBUG : pacer: Reducing sleep to 146.163834ms 2026/08/13 05:38:25 DEBUG : pacer: Reducing sleep to 229.014803ms 2026/08/13 05:38:29 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/13 05:38:47 DEBUG : pacer: Reducing sleep to 100.818497ms 2026/08/13 05:38:47 DEBUG : pacer: Reducing sleep to 228.251571ms 2026/08/13 05:38:47 DEBUG : pacer: Reducing sleep to 263.151107ms 2026/08/13 05:38:48 DEBUG : pacer: Reducing sleep to 218.106307ms 2026/08/13 05:38:48 DEBUG : pacer: Reducing sleep to 105.096483ms 2026/08/13 05:38:48 DEBUG : pacer: Reducing sleep to 76.883547ms 2026/08/13 05:38:48 DEBUG : pacer: Reducing sleep to 110.51607ms 2026/08/13 05:38:48 DEBUG : pacer: Reducing sleep to 268.876923ms 2026/08/13 05:38:48 DEBUG : pacer: Reducing sleep to 282.750066ms === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/13 05:38:52 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:38:52 DEBUG : pacer: Reducing sleep to 56.848131ms 2026/08/13 05:38:56 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:38:57 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:38:57 UTC": parsing time "Thu, 13 Aug 2026 05:38:57 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:38:57 UTC" as " " 2026/08/13 05:38:57 DEBUG : pacer: Reducing sleep to 109.688417ms === 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/13 05:39:01 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:39:01 DEBUG : pacer: Reducing sleep to 2.765239ms 2026/08/13 05:39:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:39:06 DEBUG : zoho root 'rclone-test-qajural2qoqa': folder listing limiter sweep: evicted 6 of 13 idle limiters 2026/08/13 05:39:06 DEBUG : pacer: Reducing sleep to 125.181944ms 2026/08/13 05:39:06 DEBUG : pacer: Reducing sleep to 127.018089ms 2026/08/13 05:39:06 DEBUG : pacer: Reducing sleep to 244.616089ms 2026/08/13 05:39:06 DEBUG : pacer: Reducing sleep to 286.003899ms 2026/08/13 05:39:06 DEBUG : pacer: Reducing sleep to 87.425362ms 2026/08/13 05:39:07 DEBUG : pacer: Reducing sleep to 86.03871ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/13 05:39:07 DEBUG : pacer: Reducing sleep to 163.323521ms 2026/08/13 05:39:07 DEBUG : pacer: Reducing sleep to 240.245637ms 2026/08/13 05:39:07 DEBUG : pacer: Reducing sleep to 243.393199ms 2026/08/13 05:39:07 DEBUG : pacer: Reducing sleep to 172.591136ms 2026/08/13 05:39:07 DEBUG : pacer: Reducing sleep to 95.834528ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/13 05:39:08 DEBUG : pacer: Reducing sleep to 83.044404ms 2026/08/13 05:39:08 DEBUG : pacer: Reducing sleep to 157.225574ms 2026/08/13 05:39:08 DEBUG : pacer: Reducing sleep to 242.015356ms 2026/08/13 05:39:08 DEBUG : pacer: Reducing sleep to 250.866418ms 2026/08/13 05:39:08 DEBUG : pacer: Reducing sleep to 173.754891ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/13 05:39:08 DEBUG : pacer: Reducing sleep to 89.114555ms 2026/08/13 05:39:09 DEBUG : pacer: Reducing sleep to 83.38287ms 2026/08/13 05:39:09 DEBUG : pacer: Reducing sleep to 158.379511ms 2026/08/13 05:39:09 DEBUG : pacer: Reducing sleep to 243.013859ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/13 05:39:09 DEBUG : Creating backend with remote "TestZoho:" 2026/08/13 05:39:09 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/13 05:39:13 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/13 05:39:18 DEBUG : pacer: Reducing sleep to 121.510458ms 2026/08/13 05:39:18 DEBUG : pacer: Reducing sleep to 241.721284ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/13 05:39:23 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:39:23 DEBUG : pacer: Reducing sleep to 118.68224ms 2026/08/13 05:39:23 DEBUG : pacer: Reducing sleep to 91.532012ms 2026/08/13 05:39:23 DEBUG : pacer: Reducing sleep to 137.959006ms 2026/08/13 05:39:23 DEBUG : pacer: Reducing sleep to 213.325877ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2026/08/13 05:39:27 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/13 05:39:32 DEBUG : pacer: Reducing sleep to 118.87815ms 2026/08/13 05:39:32 DEBUG : pacer: Reducing sleep to 238.541532ms 2026/08/13 05:39:32 DEBUG : pacer: Reducing sleep to 285.453413ms 2026/08/13 05:39:32 DEBUG : pacer: Reducing sleep to 212.30492ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2026/08/13 05:39:37 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2026/08/13 05:39:37 DEBUG : pacer: Reducing sleep to 118.454239ms 2026/08/13 05:39:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:39:41 DEBUG : pacer: Reducing sleep to 97.254819ms 2026/08/13 05:39:41 DEBUG : pacer: Reducing sleep to 143.668648ms 2026/08/13 05:39:41 DEBUG : pacer: Reducing sleep to 261.882433ms 2026/08/13 05:39:46 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:39:46 DEBUG : pacer: Reducing sleep to 119.637202ms 2026/08/13 05:39:46 DEBUG : pacer: Reducing sleep to 283.394475ms 2026/08/13 05:39:46 DEBUG : pacer: Reducing sleep to 236.854224ms 2026/08/13 05:39:46 DEBUG : pacer: Reducing sleep to 119.119273ms 2026/08/13 05:39:47 DEBUG : pacer: Reducing sleep to 49.99526ms 2026/08/13 05:39:47 DEBUG : pacer: Reducing sleep to 98.261488ms 2026/08/13 05:39:47 DEBUG : pacer: Reducing sleep to 203.491648ms 2026/08/13 05:39:50 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:39:51 DEBUG : pacer: Reducing sleep to 119.624249ms 2026/08/13 05:39:51 DEBUG : pacer: Reducing sleep to 130.330044ms 2026/08/13 05:39:51 DEBUG : pacer: Reducing sleep to 177.176863ms 2026/08/13 05:39:51 DEBUG : pacer: Reducing sleep to 210.845739ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2026/08/13 05:39:55 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:00 DEBUG : pacer: Reducing sleep to 39.857078ms 2026/08/13 05:40:00 DEBUG : pacer: Reducing sleep to 75.242786ms 2026/08/13 05:40:00 DEBUG : pacer: Reducing sleep to 190.716828ms 2026/08/13 05:40:04 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:04 DEBUG : pacer: Reducing sleep to 121.516643ms 2026/08/13 05:40:04 DEBUG : pacer: Reducing sleep to 287.238715ms 2026/08/13 05:40:05 DEBUG : pacer: Reducing sleep to 309.180326ms 2026/08/13 05:40:05 DEBUG : pacer: Reducing sleep to 189.769542ms 2026/08/13 05:40:05 DEBUG : pacer: Reducing sleep to 44.65807ms 2026/08/13 05:40:05 DEBUG : Creating backend with remote "TestZoho:rclone-test-qajural2qoqa/dirToPurgeFromRoot" 2026/08/13 05:40:05 DEBUG : Config file has changed externally - reloading 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 118.706135ms 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 241.228938ms 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 279.18052ms 2026/08/13 05:40:06 DEBUG : zoho root 'rclone-test-qajural2qoqa': folder listing limiter sweep: evicted 2 of 10 idle limiters 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 121.038177ms 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 242.387173ms 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 285.348975ms 2026/08/13 05:40:06 DEBUG : pacer: Reducing sleep to 209.14779ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/13 05:40:06 DEBUG : Creating backend with remote "TestZoho:rclone-test-qajural2qoqa/hello? sausage/êé" 2026/08/13 05:40:06 DEBUG : Config file has changed externally - reloading 2026/08/13 05:40:07 DEBUG : pacer: Reducing sleep to 120.81172ms 2026/08/13 05:40:07 DEBUG : pacer: Reducing sleep to 242.309568ms 2026/08/13 05:40:07 DEBUG : pacer: Reducing sleep to 286.982723ms 2026/08/13 05:40:07 DEBUG : pacer: Reducing sleep to 210.502049ms 2026/08/13 05:40:08 DEBUG : pacer: Reducing sleep to 71.64175ms 2026/08/13 05:40:08 DEBUG : pacer: Reducing sleep to 50.127957ms 2026/08/13 05:40:08 DEBUG : pacer: Reducing sleep to 114.044589ms 2026/08/13 05:40:08 DEBUG : pacer: Reducing sleep to 242.533626ms 2026/08/13 05:40:08 DEBUG : pacer: Reducing sleep to 264.628026ms 2026/08/13 05:40:08 DEBUG : pacer: Reducing sleep to 218.137803ms 2026/08/13 05:40:08 DEBUG : pacer: Reducing sleep to 85.131348ms 2026/08/13 05:40:09 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:09 DEBUG : pacer: Reducing sleep to 121.509429ms 2026/08/13 05:40:09 DEBUG : pacer: Reducing sleep to 240.310996ms 2026/08/13 05:40:09 DEBUG : pacer: Reducing sleep to 280.439649ms 2026/08/13 05:40:09 DEBUG : pacer: Reducing sleep to 214.077914ms 2026/08/13 05:40:10 DEBUG : pacer: Reducing sleep to 82.987024ms 2026/08/13 05:40:10 DEBUG : pacer: Reducing sleep to 48.817987ms 2026/08/13 05:40:10 DEBUG : pacer: Reducing sleep to 134.012174ms 2026/08/13 05:40:10 DEBUG : pacer: Reducing sleep to 250.644974ms 2026/08/13 05:40:10 DEBUG : pacer: Reducing sleep to 284.95902ms 2026/08/13 05:40:10 DEBUG : pacer: Reducing sleep to 188.002033ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2026/08/13 05:40:10 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:11 DEBUG : pacer: Reducing sleep to 103.668481ms 2026/08/13 05:40:11 DEBUG : pacer: Reducing sleep to 222.934654ms 2026/08/13 05:40:11 DEBUG : pacer: Reducing sleep to 286.884989ms 2026/08/13 05:40:14 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:14 DEBUG : pacer: Reducing sleep to 108.137641ms 2026/08/13 05:40:14 DEBUG : pacer: Reducing sleep to 48.40863ms 2026/08/13 05:40:18 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:18 DEBUG : pacer: Reducing sleep to 96.527538ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1318: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/13 05:40:23 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:23 DEBUG : pacer: Reducing sleep to 106.112155ms 2026/08/13 05:40:23 DEBUG : pacer: Reducing sleep to 201.273182ms 2026/08/13 05:40:23 DEBUG : pacer: Reducing sleep to 275.826517ms 2026/08/13 05:40:23 DEBUG : pacer: Reducing sleep to 247.576066ms 2026/08/13 05:40:24 DEBUG : pacer: Reducing sleep to 130.778307ms 2026/08/13 05:40:24 DEBUG : pacer: Reducing sleep to 60.43757ms 2026/08/13 05:40:24 DEBUG : pacer: Reducing sleep to 92.805119ms 2026/08/13 05:40:27 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:37 DEBUG : pacer: Reducing sleep to 101.620173ms 2026/08/13 05:40:37 DEBUG : pacer: Reducing sleep to 210.938183ms 2026/08/13 05:40:37 DEBUG : pacer: Reducing sleep to 259.910805ms 2026/08/13 05:40:37 DEBUG : pacer: Reducing sleep to 234.997976ms 2026/08/13 05:40:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:42 DEBUG : pacer: Reducing sleep to 119.943952ms 2026/08/13 05:40:42 DEBUG : pacer: Reducing sleep to 286.057744ms 2026/08/13 05:40:42 DEBUG : pacer: Reducing sleep to 273.989979ms 2026/08/13 05:40:42 DEBUG : pacer: Reducing sleep to 153.791932ms 2026/08/13 05:40:42 DEBUG : pacer: Reducing sleep to 52.914114ms 2026/08/13 05:40:43 DEBUG : pacer: Reducing sleep to 58.511667ms 2026/08/13 05:40:43 DEBUG : pacer: Reducing sleep to 162.464375ms 2026/08/13 05:40:43 DEBUG : pacer: Reducing sleep to 255.004855ms 2026/08/13 05:40:43 DEBUG : pacer: Reducing sleep to 271.841218ms 2026/08/13 05:40:46 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:46 DEBUG : pacer: Reducing sleep to 125.401588ms 2026/08/13 05:40:46 DEBUG : pacer: Reducing sleep to 279.977695ms 2026/08/13 05:40:46 DEBUG : pacer: Reducing sleep to 229.965494ms 2026/08/13 05:40:47 DEBUG : pacer: Reducing sleep to 116.613945ms 2026/08/13 05:40:47 DEBUG : pacer: Reducing sleep to 56.753488ms 2026/08/13 05:40:51 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:51 DEBUG : pacer: Reducing sleep to 109.732482ms 2026/08/13 05:40:51 DEBUG : pacer: Reducing sleep to 203.521099ms 2026/08/13 05:40:51 DEBUG : pacer: Reducing sleep to 274.880033ms 2026/08/13 05:40:55 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:56 DEBUG : pacer: Reducing sleep to 125.836609ms 2026/08/13 05:40:56 DEBUG : pacer: Reducing sleep to 287.874836ms 2026/08/13 05:40:56 DEBUG : pacer: Reducing sleep to 227.135091ms 2026/08/13 05:40:56 DEBUG : pacer: Reducing sleep to 108.167607ms 2026/08/13 05:40:56 DEBUG : pacer: Reducing sleep to 46.74465ms 2026/08/13 05:40:56 DEBUG : pacer: Reducing sleep to 104.854998ms 2026/08/13 05:40:56 DEBUG : pacer: Reducing sleep to 215.684703ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/13 05:40:56 DEBUG : Creating backend with remote "TestZoho:rclone-test-wavalab3nefu" 2026/08/13 05:40:57 DEBUG : pacer: Reducing sleep to 38.934237ms 2026/08/13 05:40:57 DEBUG : pacer: Reducing sleep to 83.440818ms 2026/08/13 05:40:57 DEBUG : pacer: Reducing sleep to 114.850121ms 2026/08/13 05:40:57 DEBUG : pacer: Reducing sleep to 239.98762ms 2026/08/13 05:40:57 DEBUG : pacer: Reducing sleep to 264.423746ms 2026/08/13 05:40:57 DEBUG : pacer: Reducing sleep to 215.039391ms 2026/08/13 05:40:58 DEBUG : pacer: Reducing sleep to 91.898548ms 2026/08/13 05:40:58 DEBUG : pacer: Reducing sleep to 50.894496ms 2026/08/13 05:40:58 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:40:58 DEBUG : pacer: Reducing sleep to 47.506974ms 2026/08/13 05:40:58 DEBUG : pacer: Reducing sleep to 166.188113ms 2026/08/13 05:41:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:41:00 DEBUG : pacer: Reducing sleep to 114.733644ms 2026/08/13 05:41:00 DEBUG : pacer: Reducing sleep to 169.438063ms 2026/08/13 05:41:00 DEBUG : pacer: Reducing sleep to 217.107035ms 2026/08/13 05:41:01 DEBUG : pacer: Reducing sleep to 208.522149ms 2026/08/13 05:41:02 DEBUG : pacer: Reducing sleep to 43.432572ms 2026/08/13 05:41:02 DEBUG : pacer: Reducing sleep to 160.790904ms 2026/08/13 05:41:03 DEBUG : pacer: Reducing sleep to 280.299767ms 2026/08/13 05:41:03 DEBUG : pacer: Reducing sleep to 287.124658ms 2026/08/13 05:41:03 DEBUG : pacer: Reducing sleep to 174.486666ms 2026/08/13 05:41:03 DEBUG : pacer: Reducing sleep to 46.744955ms 2026/08/13 05:41:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:41:03 DEBUG : pacer: Reducing sleep to 126.233238ms 2026/08/13 05:41:03 DEBUG : zoho root 'rclone-test-wavalab3nefu': Purge remote 2026/08/13 05:41:04 DEBUG : pacer: Reducing sleep to 120.394538ms 2026/08/13 05:41:04 DEBUG : pacer: Reducing sleep to 144.481463ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2026/08/13 05:41:04 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2026/08/13 05:41:04 DEBUG : pacer: Reducing sleep to 119.285128ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2026/08/13 05:41:04 DEBUG : pacer: Reducing sleep to 237.279111ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2026/08/13 05:41:04 DEBUG : pacer: Reducing sleep to 286.444459ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2026/08/13 05:41:04 DEBUG : pacer: Reducing sleep to 211.556218ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2026/08/13 05:41:05 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/13 05:41:09 DEBUG : zoho root 'rclone-test-qajural2qoqa': folder listing limiter sweep: evicted 4 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/13 05:41:33 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:33 UTC": parsing time "Thu, 13 Aug 2026 05:41:33 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:33 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/13 05:41:37 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:37 UTC": parsing time "Thu, 13 Aug 2026 05:41:37 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:37 UTC" as " " 2026/08/13 05:41:37 DEBUG : pacer: Reducing sleep to 928.048µs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/13 05:41:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:41:42 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:42 UTC": parsing time "Thu, 13 Aug 2026 05:41:42 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:42 UTC" as " " 2026/08/13 05:41:42 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:42 UTC": parsing time "Thu, 13 Aug 2026 05:41:42 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:42 UTC" as " " 2026/08/13 05:41:43 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:43 UTC": parsing time "Thu, 13 Aug 2026 05:41:43 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:43 UTC" as " " 2026/08/13 05:41:43 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:43 UTC": parsing time "Thu, 13 Aug 2026 05:41:43 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:43 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/13 05:41:47 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:47 UTC": parsing time "Thu, 13 Aug 2026 05:41:47 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:47 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/13 05:41:51 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:51 UTC": parsing time "Thu, 13 Aug 2026 05:41:51 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:51 UTC" as " " 2026/08/13 05:41:51 DEBUG : pacer: Reducing sleep to 10.035494ms 2026/08/13 05:41:56 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:41:56 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:56 UTC": parsing time "Thu, 13 Aug 2026 05:41:56 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:56 UTC" as " " 2026/08/13 05:41:56 DEBUG : pacer: Reducing sleep to 10.973205ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/13 05:41:56 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:56 UTC": parsing time "Thu, 13 Aug 2026 05:41:56 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:56 UTC" as " " 2026/08/13 05:41:56 DEBUG : pacer: Reducing sleep to 16.613321ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/13 05:41:56 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:56 UTC": parsing time "Thu, 13 Aug 2026 05:41:56 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:56 UTC" as " " 2026/08/13 05:41:56 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/13 05:41:57 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:57 UTC": parsing time "Thu, 13 Aug 2026 05:41:57 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:57 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/13 05:41:57 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:41:57 UTC": parsing time "Thu, 13 Aug 2026 05:41:57 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:41:57 UTC" as " " 2026/08/13 05:41:57 DEBUG : pacer: Reducing sleep to 20.563644ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/13 05:42:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:42:00 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:42:00 UTC": parsing time "Thu, 13 Aug 2026 05:42:00 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:42:00 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/13 05:42:05 DEBUG : pacer: Reducing sleep to 119.580046ms 2026/08/13 05:42:05 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Thu, 13 Aug 2026 05:42:05 UTC": parsing time "Thu, 13 Aug 2026 05:42:05 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 13 Aug 2026 05:42:05 UTC" as " " 2026/08/13 05:42:05 DEBUG : pacer: Reducing sleep to 122.084873ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2026/08/13 05:42:05 DEBUG : pacer: Reducing sleep to 240.135051ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/13 05:42:05 DEBUG : Creating backend with remote "TestZoho:rclone-test-qajural2qoqa/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/13 05:42:06 DEBUG : pacer: Reducing sleep to 119.34323ms 2026/08/13 05:42:06 DEBUG : pacer: Reducing sleep to 229.236827ms 2026/08/13 05:42:06 DEBUG : pacer: Reducing sleep to 286.283008ms 2026/08/13 05:42:06 DEBUG : pacer: Reducing sleep to 221.899275ms 2026/08/13 05:42:06 DEBUG : pacer: Reducing sleep to 102.565876ms 2026/08/13 05:42:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:42:07 DEBUG : pacer: Reducing sleep to 119.959474ms 2026/08/13 05:42:07 DEBUG : pacer: Reducing sleep to 240.760567ms 2026/08/13 05:42:07 DEBUG : pacer: Reducing sleep to 285.479592ms 2026/08/13 05:42:07 DEBUG : pacer: Reducing sleep to 210.748179ms 2026/08/13 05:42:07 DEBUG : pacer: Reducing sleep to 88.289799ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/13 05:42:07 DEBUG : pacer: Reducing sleep to 39.433856ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/13 05:42:07 DEBUG : Creating backend with remote "TestZoho:rclone-test-qajural2qoqa/not found.txt" 2026/08/13 05:42:08 DEBUG : pacer: Reducing sleep to 90.191825ms 2026/08/13 05:42:08 DEBUG : pacer: Reducing sleep to 105.661841ms 2026/08/13 05:42:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:42:12 DEBUG : zoho root 'rclone-test-qajural2qoqa/not found.txt': folder listing limiter sweep: evicted 5 of 11 idle limiters 2026/08/13 05:42:17 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestZoho:" path "rclone-test-qajural2qoqa" from "TestZoho:rclone-test-qajural2qoqa" 2026/08/13 05:42:17 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/13 05:42:22 DEBUG : pacer: Reducing sleep to 119.275312ms 2026/08/13 05:42:22 DEBUG : pacer: Reducing sleep to 239.128134ms 2026/08/13 05:42:22 DEBUG : pacer: Reducing sleep to 284.564154ms 2026/08/13 05:42:22 DEBUG : pacer: Reducing sleep to 210.598038ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/13 05:42:26 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/13 05:42:31 DEBUG : pacer: Reducing sleep to 46.669799ms 2026/08/13 05:42:35 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:42:40 DEBUG : pacer: Reducing sleep to 120.887575ms 2026/08/13 05:42:40 DEBUG : pacer: Reducing sleep to 240.072838ms 2026/08/13 05:42:40 DEBUG : pacer: Reducing sleep to 284.119194ms 2026/08/13 05:42:41 DEBUG : pacer: Reducing sleep to 207.418657ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/13 05:42:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:42:45 DEBUG : pacer: Reducing sleep to 105.952025ms 2026/08/13 05:42:45 DEBUG : pacer: Reducing sleep to 221.377257ms 2026/08/13 05:42:45 DEBUG : pacer: Reducing sleep to 284.697366ms 2026/08/13 05:42:45 DEBUG : pacer: Reducing sleep to 228.811499ms === 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/13 05:42:49 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:42:54 DEBUG : pacer: Reducing sleep to 119.776559ms 2026/08/13 05:42:54 DEBUG : pacer: Reducing sleep to 241.290838ms 2026/08/13 05:42:54 DEBUG : pacer: Reducing sleep to 287.07764ms 2026/08/13 05:42:54 DEBUG : pacer: Reducing sleep to 209.022005ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout 2026/08/13 05:42:55 DEBUG : pacer: Reducing sleep to 87.926863ms === 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/13 05:42:59 DEBUG : pacer: Reducing sleep to 0s 2026/08/13 05:42:59 DEBUG : pacer: Reducing sleep to 139.122577ms fstests.go:2596: Put returned an error (acceptable): upload error: HTTP error 400 (400 Bad Request) returned body: "\r\n