"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/21 05:15:37 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/21 05:15:37 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/21 05:15:37 NOTICE: zoho root '': Failed to parse Retry-After: "soon": strconv.Atoi: parsing "soon": invalid syntax 2026/08/21 05:15:37 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/21 05:15:37 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/21 05:15:37 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/21 05:15:37 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/21 05:15:37 DEBUG : Creating backend with remote "TestZoho:rclone-test-rebided3faha" 2026/08/21 05:15:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/21 05:15:37 DEBUG : zoho root 'rclone-test-rebided3faha': folder listing limiter sweep: evicted 0 of 0 idle limiters 2026/08/21 05:15:37 DEBUG : TestZoho: Token expired 2026/08/21 05:15:37 DEBUG : TestZoho: No updated token found in the config file 2026/08/21 05:15:38 DEBUG : TestZoho: Token refresh successful 2026/08/21 05:15:38 DEBUG : Saving config "token" in section "TestZoho" of the config file 2026/08/21 05:15:38 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/21 05:15:38 DEBUG : pacer: Reducing sleep to 28.312388ms 2026/08/21 05:15:39 DEBUG : pacer: Reducing sleep to 63.549837ms 2026/08/21 05:15:39 DEBUG : pacer: Reducing sleep to 46.047242ms 2026/08/21 05:15:39 DEBUG : pacer: Reducing sleep to 166.870908ms === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty 2026/08/21 05:15:39 DEBUG : pacer: Reducing sleep to 285.013112ms 2026/08/21 05:15:39 DEBUG : pacer: Reducing sleep to 271.773767ms === RUN TestIntegration/FsMkdir 2026/08/21 05:15:39 DEBUG : pacer: Reducing sleep to 87.808011ms 2026/08/21 05:15:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:15:40 DEBUG : pacer: Reducing sleep to 124.852705ms === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/21 05:15:40 INFO : dir/subdir: Making directory 2026/08/21 05:15:40 DEBUG : pacer: Reducing sleep to 249.606954ms 2026/08/21 05:15:40 DEBUG : pacer: Reducing sleep to 262.18831ms 2026/08/21 05:15:40 DEBUG : pacer: Reducing sleep to 205.285482ms 2026/08/21 05:15:40 DEBUG : pacer: Reducing sleep to 80.280325ms 2026/08/21 05:15:41 DEBUG : pacer: Reducing sleep to 59.387298ms 2026/08/21 05:15:41 DEBUG : pacer: Reducing sleep to 149.112125ms 2026/08/21 05:15:41 DEBUG : pacer: Reducing sleep to 263.134559ms 2026/08/21 05:15:41 INFO : dir/subdir: Removing directory 2026/08/21 05:15:41 DEBUG : pacer: Reducing sleep to 274.960392ms 2026/08/21 05:15:41 DEBUG : pacer: Reducing sleep to 169.286354ms 2026/08/21 05:15:41 DEBUG : pacer: Reducing sleep to 66.834881ms 2026/08/21 05:15:42 DEBUG : pacer: Reducing sleep to 67.932325ms 2026/08/21 05:15:42 INFO : dir: Removing directory 2026/08/21 05:15:42 DEBUG : pacer: Reducing sleep to 162.600786ms 2026/08/21 05:15:42 DEBUG : pacer: Reducing sleep to 252.563983ms 2026/08/21 05:15:42 DEBUG : pacer: Reducing sleep to 269.31278ms === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/21 05:15:42 DEBUG : pacer: Reducing sleep to 184.815908ms === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/21 05:15:47 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/21 05:15:51 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/21 05:16:00 DEBUG : pacer: Reducing sleep to 95.101378ms 2026/08/21 05:16:01 DEBUG : pacer: Reducing sleep to 219.56169ms 2026/08/21 05:16:01 DEBUG : pacer: Reducing sleep to 164.273238ms 2026/08/21 05:16:01 DEBUG : pacer: Reducing sleep to 228.469412ms 2026/08/21 05:16:05 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:16:05 DEBUG : pacer: Reducing sleep to 111.57855ms 2026/08/21 05:16:05 DEBUG : pacer: Reducing sleep to 94.039574ms 2026/08/21 05:16:05 DEBUG : pacer: Reducing sleep to 156.113801ms 2026/08/21 05:16:05 DEBUG : pacer: Reducing sleep to 220.563825ms 2026/08/21 05:16:10 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "." 2026/08/21 05:16:14 DEBUG : pacer: Reducing sleep to 94.42911ms 2026/08/21 05:16:14 DEBUG : pacer: Reducing sleep to 218.742765ms 2026/08/21 05:16:15 DEBUG : pacer: Reducing sleep to 58.904503ms 2026/08/21 05:16:15 DEBUG : pacer: Reducing sleep to 143.223752ms 2026/08/21 05:16:19 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:16:19 DEBUG : pacer: Reducing sleep to 111.036807ms 2026/08/21 05:16:19 DEBUG : pacer: Reducing sleep to 179.04584ms 2026/08/21 05:16:19 DEBUG : pacer: Reducing sleep to 245.339344ms 2026/08/21 05:16:19 DEBUG : pacer: Reducing sleep to 223.508754ms 2026/08/21 05:16:23 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing ".." 2026/08/21 05:16:28 DEBUG : pacer: Reducing sleep to 96.155678ms 2026/08/21 05:16:28 DEBUG : pacer: Reducing sleep to 220.920345ms 2026/08/21 05:16:28 DEBUG : pacer: Reducing sleep to 194.223937ms 2026/08/21 05:16:29 DEBUG : pacer: Reducing sleep to 229.681436ms 2026/08/21 05:16:33 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:16:33 DEBUG : pacer: Reducing sleep to 114.010211ms 2026/08/21 05:16:33 DEBUG : pacer: Reducing sleep to 89.611199ms 2026/08/21 05:16:33 DEBUG : pacer: Reducing sleep to 152.808857ms 2026/08/21 05:16:33 DEBUG : pacer: Reducing sleep to 220.746976ms 2026/08/21 05:16:37 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/08/21 05:16:37 DEBUG : zoho root 'rclone-test-rebided3faha': folder listing limiter sweep: evicted 0 of 8 idle limiters 2026/08/21 05:16:42 DEBUG : pacer: Reducing sleep to 102.231481ms 2026/08/21 05:16:42 DEBUG : pacer: Reducing sleep to 224.341886ms 2026/08/21 05:16:42 DEBUG : pacer: Reducing sleep to 159.155851ms 2026/08/21 05:16:42 DEBUG : pacer: Reducing sleep to 227.770656ms 2026/08/21 05:16:43 DEBUG : pacer: Reducing sleep to 233.361902ms 2026/08/21 05:16:43 DEBUG : pacer: Reducing sleep to 168.638522ms 2026/08/21 05:16:43 DEBUG : pacer: Reducing sleep to 87.649177ms 2026/08/21 05:16:43 DEBUG : pacer: Reducing sleep to 104.94214ms 2026/08/21 05:16:43 DEBUG : pacer: Reducing sleep to 169.791004ms 2026/08/21 05:16:43 DEBUG : pacer: Reducing sleep to 249.457658ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/21 05:16:44 DEBUG : pacer: Reducing sleep to 226.046261ms 2026/08/21 05:16:44 DEBUG : pacer: Reducing sleep to 131.847114ms 2026/08/21 05:16:44 DEBUG : pacer: Reducing sleep to 101.261482ms 2026/08/21 05:16:44 DEBUG : pacer: Reducing sleep to 63.716989ms 2026/08/21 05:16:44 DEBUG : pacer: Reducing sleep to 182.265019ms 2026/08/21 05:16:44 DEBUG : pacer: Reducing sleep to 283.897318ms 2026/08/21 05:16:45 DEBUG : pacer: Reducing sleep to 263.459946ms 2026/08/21 05:16:45 DEBUG : pacer: Reducing sleep to 130.15497ms 2026/08/21 05:16:45 DEBUG : pacer: Reducing sleep to 54.402085ms 2026/08/21 05:16:45 DEBUG : pacer: Reducing sleep to 81.213788ms 2026/08/21 05:16:45 DEBUG : pacer: Reducing sleep to 206.406543ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/21 05:16:50 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:16:50 DEBUG : pacer: Reducing sleep to 99.30811ms 2026/08/21 05:16:50 DEBUG : pacer: Reducing sleep to 124.221269ms 2026/08/21 05:16:50 DEBUG : pacer: Reducing sleep to 32.890839ms 2026/08/21 05:16:50 DEBUG : pacer: Reducing sleep to 151.187082ms 2026/08/21 05:16:54 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:16:55 DEBUG : pacer: Reducing sleep to 113.060467ms 2026/08/21 05:16:55 DEBUG : pacer: Reducing sleep to 171.53182ms 2026/08/21 05:16:55 DEBUG : pacer: Reducing sleep to 235.716831ms 2026/08/21 05:16:55 DEBUG : pacer: Reducing sleep to 211.498541ms 2026/08/21 05:16:59 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/21 05:17:04 DEBUG : pacer: Reducing sleep to 99.447933ms 2026/08/21 05:17:04 DEBUG : pacer: Reducing sleep to 222.852222ms 2026/08/21 05:17:04 DEBUG : pacer: Reducing sleep to 197.692492ms 2026/08/21 05:17:04 DEBUG : pacer: Reducing sleep to 226.696355ms 2026/08/21 05:17:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:17:08 DEBUG : pacer: Reducing sleep to 115.32384ms 2026/08/21 05:17:09 DEBUG : pacer: Reducing sleep to 93.363933ms 2026/08/21 05:17:09 DEBUG : pacer: Reducing sleep to 159.085985ms 2026/08/21 05:17:09 DEBUG : pacer: Reducing sleep to 220.782359ms 2026/08/21 05:17:13 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/21 05:17:18 DEBUG : pacer: Reducing sleep to 86.695275ms 2026/08/21 05:17:18 DEBUG : pacer: Reducing sleep to 210.212365ms 2026/08/21 05:17:18 DEBUG : pacer: Reducing sleep to 158.164255ms 2026/08/21 05:17:18 DEBUG : pacer: Reducing sleep to 240.370412ms 2026/08/21 05:17:22 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:17:22 DEBUG : pacer: Reducing sleep to 111.964507ms 2026/08/21 05:17:22 DEBUG : pacer: Reducing sleep to 83.208627ms 2026/08/21 05:17:23 DEBUG : pacer: Reducing sleep to 146.84392ms 2026/08/21 05:17:23 DEBUG : pacer: Reducing sleep to 223.966458ms 2026/08/21 05:17:27 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/21 05:17:31 DEBUG : pacer: Reducing sleep to 95.061561ms 2026/08/21 05:17:32 DEBUG : pacer: Reducing sleep to 220.570232ms 2026/08/21 05:17:32 DEBUG : pacer: Reducing sleep to 181.424143ms 2026/08/21 05:17:32 DEBUG : pacer: Reducing sleep to 225.487399ms 2026/08/21 05:17:36 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:17:36 DEBUG : pacer: Reducing sleep to 113.469049ms 2026/08/21 05:17:36 DEBUG : pacer: Reducing sleep to 101.451562ms 2026/08/21 05:17:36 DEBUG : pacer: Reducing sleep to 162.932366ms 2026/08/21 05:17:36 DEBUG : pacer: Reducing sleep to 219.779601ms 2026/08/21 05:17:41 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/21 05:17:41 DEBUG : zoho root 'rclone-test-rebided3faha': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/21 05:17:41 DEBUG : pacer: Reducing sleep to 122.608075ms 2026/08/21 05:17:41 DEBUG : pacer: Reducing sleep to 86.586104ms 2026/08/21 05:17:41 DEBUG : pacer: Reducing sleep to 157.353663ms 2026/08/21 05:17:41 DEBUG : pacer: Reducing sleep to 101.468224ms 2026/08/21 05:17:41 DEBUG : pacer: Reducing sleep to 220.522449ms 2026/08/21 05:17:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:17:43 DEBUG : pacer: Reducing sleep to 118.498624ms 2026/08/21 05:17:43 DEBUG : pacer: Reducing sleep to 103.733239ms 2026/08/21 05:17:43 DEBUG : pacer: Reducing sleep to 162.285163ms 2026/08/21 05:17:43 DEBUG : pacer: Reducing sleep to 214.234358ms 2026/08/21 05:17:43 DEBUG : pacer: Reducing sleep to 231.491169ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/21 05:17:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:17:44 DEBUG : pacer: Reducing sleep to 93.273075ms 2026/08/21 05:17:44 DEBUG : pacer: Reducing sleep to 102.19765ms 2026/08/21 05:17:44 DEBUG : pacer: Reducing sleep to 95.478588ms 2026/08/21 05:17:44 DEBUG : pacer: Reducing sleep to 214.975629ms 2026/08/21 05:17:44 DEBUG : pacer: Reducing sleep to 284.281058ms 2026/08/21 05:17:45 DEBUG : pacer: Reducing sleep to 184.243973ms 2026/08/21 05:17:45 DEBUG : pacer: Reducing sleep to 96.433804ms 2026/08/21 05:17:45 DEBUG : pacer: Reducing sleep to 102.74147ms 2026/08/21 05:17:45 DEBUG : pacer: Reducing sleep to 160.352527ms 2026/08/21 05:17:49 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/21 05:17:54 DEBUG : pacer: Reducing sleep to 90.265375ms 2026/08/21 05:17:54 DEBUG : pacer: Reducing sleep to 212.808146ms 2026/08/21 05:17:54 DEBUG : pacer: Reducing sleep to 144.619317ms 2026/08/21 05:17:54 DEBUG : pacer: Reducing sleep to 239.278359ms 2026/08/21 05:17:58 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:17:58 DEBUG : pacer: Reducing sleep to 116.056162ms 2026/08/21 05:17:58 DEBUG : pacer: Reducing sleep to 85.073145ms 2026/08/21 05:17:59 DEBUG : pacer: Reducing sleep to 145.049607ms 2026/08/21 05:17:59 DEBUG : pacer: Reducing sleep to 211.641482ms 2026/08/21 05:18:03 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/21 05:18:07 DEBUG : pacer: Reducing sleep to 94.538743ms 2026/08/21 05:18:08 DEBUG : pacer: Reducing sleep to 218.554766ms 2026/08/21 05:18:08 DEBUG : pacer: Reducing sleep to 190.560723ms 2026/08/21 05:18:08 DEBUG : pacer: Reducing sleep to 229.920486ms 2026/08/21 05:18:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:18:12 DEBUG : pacer: Reducing sleep to 112.079184ms 2026/08/21 05:18:12 DEBUG : pacer: Reducing sleep to 90.003715ms 2026/08/21 05:18:12 DEBUG : pacer: Reducing sleep to 158.820991ms 2026/08/21 05:18:12 DEBUG : pacer: Reducing sleep to 228.072896ms 2026/08/21 05:18:17 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/21 05:18:21 DEBUG : pacer: Reducing sleep to 96.01991ms 2026/08/21 05:18:21 DEBUG : pacer: Reducing sleep to 223.538857ms 2026/08/21 05:18:22 DEBUG : pacer: Reducing sleep to 113.605923ms 2026/08/21 05:18:22 DEBUG : pacer: Reducing sleep to 219.099953ms 2026/08/21 05:18:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:18:26 DEBUG : pacer: Reducing sleep to 114.139483ms 2026/08/21 05:18:26 DEBUG : pacer: Reducing sleep to 107.530959ms 2026/08/21 05:18:26 DEBUG : pacer: Reducing sleep to 166.537059ms 2026/08/21 05:18:26 DEBUG : pacer: Reducing sleep to 219.004883ms 2026/08/21 05:18:30 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/21 05:18:35 DEBUG : pacer: Reducing sleep to 100.646545ms 2026/08/21 05:18:35 DEBUG : pacer: Reducing sleep to 223.613936ms 2026/08/21 05:18:35 DEBUG : pacer: Reducing sleep to 159.805686ms 2026/08/21 05:18:36 DEBUG : pacer: Reducing sleep to 217.462928ms 2026/08/21 05:18:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:18:40 DEBUG : pacer: Reducing sleep to 112.409887ms 2026/08/21 05:18:40 DEBUG : pacer: Reducing sleep to 105.984156ms 2026/08/21 05:18:40 DEBUG : pacer: Reducing sleep to 174.80625ms 2026/08/21 05:18:40 DEBUG : pacer: Reducing sleep to 223.661722ms 2026/08/21 05:18:40 DEBUG : pacer: Reducing sleep to 229.311774ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/21 05:18:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:18:41 DEBUG : pacer: Reducing sleep to 99.724845ms 2026/08/21 05:18:41 DEBUG : zoho root 'rclone-test-rebided3faha': folder listing limiter sweep: evicted 6 of 13 idle limiters 2026/08/21 05:18:41 DEBUG : pacer: Reducing sleep to 104.763281ms 2026/08/21 05:18:42 DEBUG : pacer: Reducing sleep to 33.054522ms 2026/08/21 05:18:42 DEBUG : pacer: Reducing sleep to 150.049847ms 2026/08/21 05:18:42 DEBUG : pacer: Reducing sleep to 268.688847ms 2026/08/21 05:18:42 DEBUG : pacer: Reducing sleep to 281.76455ms 2026/08/21 05:18:42 DEBUG : pacer: Reducing sleep to 173.647623ms 2026/08/21 05:18:42 DEBUG : pacer: Reducing sleep to 66.754028ms 2026/08/21 05:18:43 DEBUG : pacer: Reducing sleep to 51.657525ms 2026/08/21 05:18:43 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/21 05:18:44 DEBUG : pacer: Reducing sleep to 94.115875ms 2026/08/21 05:18:44 DEBUG : pacer: Reducing sleep to 213.62125ms 2026/08/21 05:18:44 DEBUG : pacer: Reducing sleep to 198.514938ms 2026/08/21 05:18:44 DEBUG : pacer: Reducing sleep to 236.010752ms 2026/08/21 05:18:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:18:44 DEBUG : pacer: Reducing sleep to 119.184469ms 2026/08/21 05:18:45 DEBUG : pacer: Reducing sleep to 53.86328ms 2026/08/21 05:18:45 DEBUG : pacer: Reducing sleep to 130.180076ms 2026/08/21 05:18:45 DEBUG : pacer: Reducing sleep to 218.883941ms 2026/08/21 05:18:49 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/21 05:18:54 DEBUG : pacer: Reducing sleep to 80.407728ms 2026/08/21 05:18:54 DEBUG : pacer: Reducing sleep to 205.283805ms 2026/08/21 05:18:54 DEBUG : pacer: Reducing sleep to 194.514242ms 2026/08/21 05:18:54 DEBUG : pacer: Reducing sleep to 242.921858ms 2026/08/21 05:18:58 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:18:58 DEBUG : pacer: Reducing sleep to 111.938748ms 2026/08/21 05:18:58 DEBUG : pacer: Reducing sleep to 64.989157ms 2026/08/21 05:18:59 DEBUG : pacer: Reducing sleep to 144.992774ms 2026/08/21 05:18:59 DEBUG : pacer: Reducing sleep to 232.874387ms 2026/08/21 05:19:03 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/21 05:19:21 DEBUG : pacer: Reducing sleep to 97.088376ms 2026/08/21 05:19:21 DEBUG : pacer: Reducing sleep to 220.94164ms 2026/08/21 05:19:21 DEBUG : pacer: Reducing sleep to 257.83225ms 2026/08/21 05:19:22 DEBUG : pacer: Reducing sleep to 236.991529ms 2026/08/21 05:19:22 DEBUG : pacer: Reducing sleep to 112.468041ms 2026/08/21 05:19:22 DEBUG : pacer: Reducing sleep to 72.387411ms 2026/08/21 05:19:22 DEBUG : pacer: Reducing sleep to 93.703161ms 2026/08/21 05:19:22 DEBUG : pacer: Reducing sleep to 259.80477ms 2026/08/21 05:19:22 DEBUG : pacer: Reducing sleep to 290.140292ms === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/21 05:19:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:19:26 DEBUG : pacer: Reducing sleep to 4.017587ms 2026/08/21 05:19:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:19:31 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:19:31 UTC": parsing time "Fri, 21 Aug 2026 05:19:31 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:19:31 UTC" as " " 2026/08/21 05:19:31 DEBUG : pacer: Reducing sleep to 110.554994ms === 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/21 05:19:35 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:19:40 DEBUG : pacer: Reducing sleep to 122.017897ms 2026/08/21 05:19:40 DEBUG : pacer: Reducing sleep to 151.949746ms 2026/08/21 05:19:40 DEBUG : pacer: Reducing sleep to 270.767302ms 2026/08/21 05:19:40 DEBUG : pacer: Reducing sleep to 171.978396ms 2026/08/21 05:19:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:19:41 DEBUG : pacer: Reducing sleep to 52.870201ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/21 05:19:41 DEBUG : pacer: Reducing sleep to 170.367515ms 2026/08/21 05:19:41 DEBUG : pacer: Reducing sleep to 281.457118ms 2026/08/21 05:19:41 DEBUG : pacer: Reducing sleep to 271.525816ms 2026/08/21 05:19:41 DEBUG : pacer: Reducing sleep to 163.238294ms 2026/08/21 05:19:41 DEBUG : zoho root 'rclone-test-rebided3faha': folder listing limiter sweep: evicted 6 of 14 idle limiters 2026/08/21 05:19:42 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/21 05:19:42 DEBUG : pacer: Reducing sleep to 116.868526ms 2026/08/21 05:19:42 DEBUG : pacer: Reducing sleep to 236.262108ms 2026/08/21 05:19:42 DEBUG : pacer: Reducing sleep to 283.741563ms 2026/08/21 05:19:43 DEBUG : pacer: Reducing sleep to 206.061353ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/21 05:19:43 DEBUG : pacer: Reducing sleep to 92.983366ms 2026/08/21 05:19:43 DEBUG : pacer: Reducing sleep to 55.993311ms 2026/08/21 05:19:43 DEBUG : pacer: Reducing sleep to 127.917512ms 2026/08/21 05:19:43 DEBUG : pacer: Reducing sleep to 240.108976ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/21 05:19:43 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/21 05:19:48 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/21 05:19:53 DEBUG : pacer: Reducing sleep to 115.459064ms 2026/08/21 05:19:53 DEBUG : pacer: Reducing sleep to 236.472145ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/21 05:19:53 DEBUG : pacer: Reducing sleep to 283.191251ms 2026/08/21 05:19:53 DEBUG : pacer: Reducing sleep to 211.928971ms 2026/08/21 05:19:53 DEBUG : pacer: Reducing sleep to 97.678268ms 2026/08/21 05:19:53 DEBUG : pacer: Reducing sleep to 47.912328ms 2026/08/21 05:19:57 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2026/08/21 05:19:57 DEBUG : pacer: Reducing sleep to 23.944111ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/21 05:20:02 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:02 DEBUG : pacer: Reducing sleep to 112.169561ms 2026/08/21 05:20:02 DEBUG : pacer: Reducing sleep to 230.554731ms 2026/08/21 05:20:02 DEBUG : pacer: Reducing sleep to 284.620308ms 2026/08/21 05:20:02 DEBUG : pacer: Reducing sleep to 215.852318ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2026/08/21 05:20:07 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2026/08/21 05:20:07 DEBUG : pacer: Reducing sleep to 119.068029ms 2026/08/21 05:20:11 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:11 DEBUG : pacer: Reducing sleep to 102.972304ms 2026/08/21 05:20:12 DEBUG : pacer: Reducing sleep to 75.086269ms 2026/08/21 05:20:12 DEBUG : pacer: Reducing sleep to 191.431826ms 2026/08/21 05:20:16 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:16 DEBUG : pacer: Reducing sleep to 120.686805ms 2026/08/21 05:20:16 DEBUG : pacer: Reducing sleep to 286.887612ms 2026/08/21 05:20:16 DEBUG : pacer: Reducing sleep to 306.336105ms 2026/08/21 05:20:16 DEBUG : pacer: Reducing sleep to 185.256095ms 2026/08/21 05:20:17 DEBUG : pacer: Reducing sleep to 42.665329ms 2026/08/21 05:20:17 DEBUG : pacer: Reducing sleep to 27.535118ms 2026/08/21 05:20:17 DEBUG : pacer: Reducing sleep to 133.954673ms 2026/08/21 05:20:21 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:21 DEBUG : pacer: Reducing sleep to 120.249579ms 2026/08/21 05:20:21 DEBUG : pacer: Reducing sleep to 198.395195ms 2026/08/21 05:20:21 DEBUG : pacer: Reducing sleep to 245.244166ms 2026/08/21 05:20:21 DEBUG : pacer: Reducing sleep to 134.75251ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2026/08/21 05:20:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:30 DEBUG : pacer: Reducing sleep to 33.106973ms 2026/08/21 05:20:30 DEBUG : pacer: Reducing sleep to 64.432833ms 2026/08/21 05:20:30 DEBUG : pacer: Reducing sleep to 183.656786ms 2026/08/21 05:20:34 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:34 DEBUG : pacer: Reducing sleep to 122.060498ms 2026/08/21 05:20:34 DEBUG : pacer: Reducing sleep to 280.687553ms 2026/08/21 05:20:35 DEBUG : pacer: Reducing sleep to 314.852222ms 2026/08/21 05:20:35 DEBUG : pacer: Reducing sleep to 202.149981ms 2026/08/21 05:20:35 DEBUG : pacer: Reducing sleep to 48.025324ms 2026/08/21 05:20:35 DEBUG : Creating backend with remote "TestZoho:rclone-test-rebided3faha/dirToPurgeFromRoot" 2026/08/21 05:20:39 DEBUG : pacer: Reducing sleep to 121.514827ms 2026/08/21 05:20:39 DEBUG : pacer: Reducing sleep to 232.823112ms 2026/08/21 05:20:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:44 DEBUG : zoho root 'rclone-test-rebided3faha': folder listing limiter sweep: evicted 3 of 11 idle limiters 2026/08/21 05:20:44 DEBUG : pacer: Reducing sleep to 115.165048ms 2026/08/21 05:20:44 DEBUG : pacer: Reducing sleep to 234.300464ms 2026/08/21 05:20:44 DEBUG : pacer: Reducing sleep to 281.958903ms 2026/08/21 05:20:44 DEBUG : pacer: Reducing sleep to 216.526137ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/21 05:20:44 DEBUG : Creating backend with remote "TestZoho:rclone-test-rebided3faha/hello? sausage/êé" 2026/08/21 05:20:44 DEBUG : pacer: Reducing sleep to 117.954645ms 2026/08/21 05:20:44 DEBUG : pacer: Reducing sleep to 236.390911ms 2026/08/21 05:20:45 DEBUG : pacer: Reducing sleep to 218.001005ms 2026/08/21 05:20:45 DEBUG : pacer: Reducing sleep to 206.938152ms 2026/08/21 05:20:45 DEBUG : pacer: Reducing sleep to 135.544272ms 2026/08/21 05:20:45 DEBUG : pacer: Reducing sleep to 125.730369ms 2026/08/21 05:20:45 DEBUG : pacer: Reducing sleep to 124.357013ms 2026/08/21 05:20:45 DEBUG : pacer: Reducing sleep to 194.749641ms 2026/08/21 05:20:46 DEBUG : pacer: Reducing sleep to 194.002478ms 2026/08/21 05:20:46 DEBUG : pacer: Reducing sleep to 207.400574ms 2026/08/21 05:20:46 DEBUG : pacer: Reducing sleep to 146.883252ms 2026/08/21 05:20:46 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:46 DEBUG : pacer: Reducing sleep to 116.828328ms 2026/08/21 05:20:46 DEBUG : pacer: Reducing sleep to 232.461551ms 2026/08/21 05:20:47 DEBUG : pacer: Reducing sleep to 273.703873ms 2026/08/21 05:20:47 DEBUG : pacer: Reducing sleep to 214.928079ms 2026/08/21 05:20:47 DEBUG : pacer: Reducing sleep to 103.854752ms 2026/08/21 05:20:47 DEBUG : pacer: Reducing sleep to 59.739901ms 2026/08/21 05:20:47 DEBUG : pacer: Reducing sleep to 120.931183ms 2026/08/21 05:20:47 DEBUG : pacer: Reducing sleep to 226.399242ms 2026/08/21 05:20:48 DEBUG : pacer: Reducing sleep to 265.697014ms 2026/08/21 05:20:48 DEBUG : pacer: Reducing sleep to 197.159957ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2026/08/21 05:20:48 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:48 DEBUG : pacer: Reducing sleep to 98.011739ms 2026/08/21 05:20:48 DEBUG : pacer: Reducing sleep to 215.894448ms 2026/08/21 05:20:48 DEBUG : pacer: Reducing sleep to 281.548447ms 2026/08/21 05:20:49 DEBUG : pacer: Reducing sleep to 234.26438ms 2026/08/21 05:20:49 DEBUG : pacer: Reducing sleep to 117.408344ms 2026/08/21 05:20:49 DEBUG : pacer: Reducing sleep to 49.079922ms 2026/08/21 05:20:49 DEBUG : pacer: Reducing sleep to 95.977325ms 2026/08/21 05:20:49 DEBUG : pacer: Reducing sleep to 193.392777ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1318: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/21 05:20:54 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:54 DEBUG : pacer: Reducing sleep to 102.359727ms 2026/08/21 05:20:54 DEBUG : pacer: Reducing sleep to 121.343101ms 2026/08/21 05:20:54 DEBUG : pacer: Reducing sleep to 194.795476ms 2026/08/21 05:20:54 DEBUG : pacer: Reducing sleep to 247.694711ms 2026/08/21 05:20:54 DEBUG : pacer: Reducing sleep to 220.319216ms 2026/08/21 05:20:55 DEBUG : pacer: Reducing sleep to 140.383726ms 2026/08/21 05:20:55 DEBUG : pacer: Reducing sleep to 85.854198ms 2026/08/21 05:20:58 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:20:58 DEBUG : pacer: Reducing sleep to 117.389308ms 2026/08/21 05:20:58 DEBUG : pacer: Reducing sleep to 233.822099ms 2026/08/21 05:21:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:03 DEBUG : pacer: Reducing sleep to 95.573965ms 2026/08/21 05:21:03 DEBUG : pacer: Reducing sleep to 91.030363ms 2026/08/21 05:21:03 DEBUG : pacer: Reducing sleep to 140.113602ms 2026/08/21 05:21:03 DEBUG : pacer: Reducing sleep to 234.00532ms 2026/08/21 05:21:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:08 DEBUG : pacer: Reducing sleep to 120.929872ms 2026/08/21 05:21:08 DEBUG : pacer: Reducing sleep to 277.983959ms 2026/08/21 05:21:08 DEBUG : pacer: Reducing sleep to 264.844706ms 2026/08/21 05:21:08 DEBUG : pacer: Reducing sleep to 154.911412ms 2026/08/21 05:21:08 DEBUG : pacer: Reducing sleep to 60.825061ms 2026/08/21 05:21:09 DEBUG : pacer: Reducing sleep to 65.778251ms 2026/08/21 05:21:09 DEBUG : pacer: Reducing sleep to 161.804069ms 2026/08/21 05:21:09 DEBUG : pacer: Reducing sleep to 240.480377ms 2026/08/21 05:21:09 DEBUG : pacer: Reducing sleep to 263.069757ms 2026/08/21 05:21:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:12 DEBUG : pacer: Reducing sleep to 123.546365ms 2026/08/21 05:21:12 DEBUG : pacer: Reducing sleep to 284.336022ms 2026/08/21 05:21:13 DEBUG : pacer: Reducing sleep to 234.743908ms 2026/08/21 05:21:13 DEBUG : pacer: Reducing sleep to 116.609436ms 2026/08/21 05:21:13 DEBUG : pacer: Reducing sleep to 53.511689ms 2026/08/21 05:21:17 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:17 DEBUG : pacer: Reducing sleep to 103.378062ms 2026/08/21 05:21:17 DEBUG : pacer: Reducing sleep to 192.574905ms 2026/08/21 05:21:17 DEBUG : pacer: Reducing sleep to 271.471889ms 2026/08/21 05:21:21 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:22 DEBUG : pacer: Reducing sleep to 113.958629ms 2026/08/21 05:21:22 DEBUG : pacer: Reducing sleep to 280.52228ms 2026/08/21 05:21:22 DEBUG : pacer: Reducing sleep to 225.363754ms 2026/08/21 05:21:22 DEBUG : pacer: Reducing sleep to 114.513648ms 2026/08/21 05:21:22 DEBUG : pacer: Reducing sleep to 52.84516ms 2026/08/21 05:21:22 DEBUG : pacer: Reducing sleep to 106.325873ms 2026/08/21 05:21:22 DEBUG : pacer: Reducing sleep to 209.285242ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/21 05:21:22 DEBUG : Creating backend with remote "TestZoho:rclone-test-duwalax8xila" 2026/08/21 05:21:22 DEBUG : Config file has changed externally - reloading 2026/08/21 05:21:23 DEBUG : pacer: Reducing sleep to 43.331268ms 2026/08/21 05:21:23 DEBUG : pacer: Reducing sleep to 84.095557ms 2026/08/21 05:21:23 DEBUG : pacer: Reducing sleep to 116.911679ms 2026/08/21 05:21:23 DEBUG : pacer: Reducing sleep to 244.961106ms 2026/08/21 05:21:23 DEBUG : pacer: Reducing sleep to 263.3885ms 2026/08/21 05:21:23 DEBUG : pacer: Reducing sleep to 213.786535ms 2026/08/21 05:21:24 DEBUG : pacer: Reducing sleep to 92.955965ms 2026/08/21 05:21:24 DEBUG : pacer: Reducing sleep to 47.753686ms 2026/08/21 05:21:24 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:24 DEBUG : pacer: Reducing sleep to 40.320466ms 2026/08/21 05:21:24 DEBUG : pacer: Reducing sleep to 158.854797ms 2026/08/21 05:21:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:26 DEBUG : pacer: Reducing sleep to 119.89132ms 2026/08/21 05:21:26 DEBUG : pacer: Reducing sleep to 174.819548ms 2026/08/21 05:21:26 DEBUG : pacer: Reducing sleep to 220.432473ms 2026/08/21 05:21:27 DEBUG : pacer: Reducing sleep to 204.334534ms 2026/08/21 05:21:31 DEBUG : pacer: Reducing sleep to 118.454439ms 2026/08/21 05:21:31 DEBUG : pacer: Reducing sleep to 235.975025ms 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 284.831776ms 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 210.458566ms 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 86.441157ms 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 128.449471ms 2026/08/21 05:21:32 DEBUG : zoho root 'rclone-test-duwalax8xila': Purge remote 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 126.460421ms 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 160.587619ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2026/08/21 05:21:32 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2026/08/21 05:21:41 DEBUG : pacer: Reducing sleep to 116.685047ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2026/08/21 05:21:41 DEBUG : pacer: Reducing sleep to 233.242234ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2026/08/21 05:21:41 DEBUG : pacer: Reducing sleep to 284.02979ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType 2026/08/21 05:21:41 DEBUG : pacer: Reducing sleep to 213.566043ms fstests.go:1626: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata 2026/08/21 05:21:44 DEBUG : pacer: Reducing sleep to 0s fstests.go:1657: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata 2026/08/21 05:21:44 DEBUG : zoho root 'rclone-test-rebided3faha': folder listing limiter sweep: evicted 2 of 15 idle limiters 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/21 05:22:03 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:03 UTC": parsing time "Fri, 21 Aug 2026 05:22:03 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:03 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/21 05:22:07 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:07 UTC": parsing time "Fri, 21 Aug 2026 05:22:07 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:07 UTC" as " " 2026/08/21 05:22:07 DEBUG : pacer: Reducing sleep to 11.469984ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/21 05:22:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:22:12 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:12 UTC": parsing time "Fri, 21 Aug 2026 05:22:12 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:12 UTC" as " " 2026/08/21 05:22:12 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:12 UTC": parsing time "Fri, 21 Aug 2026 05:22:12 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:12 UTC" as " " 2026/08/21 05:22:13 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:13 UTC": parsing time "Fri, 21 Aug 2026 05:22:13 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:13 UTC" as " " 2026/08/21 05:22:13 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:13 UTC": parsing time "Fri, 21 Aug 2026 05:22:13 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:13 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/21 05:22:17 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:17 UTC": parsing time "Fri, 21 Aug 2026 05:22:17 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:17 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/21 05:22:21 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:21 UTC": parsing time "Fri, 21 Aug 2026 05:22:21 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:21 UTC" as " " 2026/08/21 05:22:26 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:26 UTC": parsing time "Fri, 21 Aug 2026 05:22:26 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:26 UTC" as " " 2026/08/21 05:22:26 DEBUG : pacer: Reducing sleep to 878.394µs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/21 05:22:26 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:26 UTC": parsing time "Fri, 21 Aug 2026 05:22:26 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:26 UTC" as " " 2026/08/21 05:22:26 DEBUG : pacer: Reducing sleep to 6.733615ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/21 05:22:26 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:26 UTC": parsing time "Fri, 21 Aug 2026 05:22:26 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:26 UTC" as " " 2026/08/21 05:22:26 DEBUG : pacer: Reducing sleep to 33.030406ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/21 05:22:26 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:26 UTC": parsing time "Fri, 21 Aug 2026 05:22:26 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:26 UTC" as " " 2026/08/21 05:22:26 DEBUG : pacer: Reducing sleep to 30.154451ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/21 05:22:27 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:26 UTC": parsing time "Fri, 21 Aug 2026 05:22:26 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:26 UTC" as " " 2026/08/21 05:22:27 DEBUG : pacer: Reducing sleep to 21.746669ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/21 05:22:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:22:30 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:30 UTC": parsing time "Fri, 21 Aug 2026 05:22:30 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:30 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/21 05:22:35 DEBUG : pacer: Reducing sleep to 370.675µs 2026/08/21 05:22:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:22:40 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 21 Aug 2026 05:22:40 UTC": parsing time "Fri, 21 Aug 2026 05:22:40 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 21 Aug 2026 05:22:40 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2026/08/21 05:22:40 DEBUG : pacer: Reducing sleep to 116.530947ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/21 05:22:40 DEBUG : Creating backend with remote "TestZoho:rclone-test-rebided3faha/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/21 05:22:41 DEBUG : pacer: Reducing sleep to 89.582749ms 2026/08/21 05:22:41 DEBUG : pacer: Reducing sleep to 180.862835ms 2026/08/21 05:22:41 DEBUG : pacer: Reducing sleep to 255.96349ms 2026/08/21 05:22:42 DEBUG : pacer: Reducing sleep to 240.118566ms 2026/08/21 05:22:42 DEBUG : pacer: Reducing sleep to 71.458624ms 2026/08/21 05:22:42 DEBUG : pacer: Reducing sleep to 72.902796ms 2026/08/21 05:22:42 DEBUG : pacer: Reducing sleep to 162.241947ms 2026/08/21 05:22:42 DEBUG : pacer: Reducing sleep to 252.563793ms 2026/08/21 05:22:42 DEBUG : pacer: Reducing sleep to 255.545138ms 2026/08/21 05:22:43 DEBUG : pacer: Reducing sleep to 166.777916ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/21 05:22:43 DEBUG : pacer: Reducing sleep to 75.18572ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/21 05:22:43 DEBUG : Creating backend with remote "TestZoho:rclone-test-rebided3faha/not found.txt" 2026/08/21 05:22:43 DEBUG : pacer: Reducing sleep to 119.13281ms 2026/08/21 05:22:43 DEBUG : pacer: Reducing sleep to 160.469879ms 2026/08/21 05:22:43 DEBUG : pacer: Reducing sleep to 279.710031ms 2026/08/21 05:22:43 DEBUG : pacer: Reducing sleep to 284.348194ms 2026/08/21 05:22:43 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestZoho:" path "rclone-test-rebided3faha" from "TestZoho:rclone-test-rebided3faha" 2026/08/21 05:22:43 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/21 05:22:48 DEBUG : zoho root '': folder listing limiter sweep: evicted 7 of 13 idle limiters 2026/08/21 05:22:48 DEBUG : pacer: Reducing sleep to 118.822984ms 2026/08/21 05:22:48 DEBUG : pacer: Reducing sleep to 236.552052ms 2026/08/21 05:22:48 DEBUG : pacer: Reducing sleep to 282.979584ms 2026/08/21 05:22:48 DEBUG : pacer: Reducing sleep to 210.487283ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/21 05:22:53 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/21 05:22:57 DEBUG : pacer: Reducing sleep to 23.001498ms 2026/08/21 05:23:02 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:23:06 DEBUG : pacer: Reducing sleep to 117.715123ms 2026/08/21 05:23:07 DEBUG : pacer: Reducing sleep to 233.47372ms 2026/08/21 05:23:07 DEBUG : pacer: Reducing sleep to 282.394751ms 2026/08/21 05:23:07 DEBUG : pacer: Reducing sleep to 212.300788ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/21 05:23:07 DEBUG : pacer: Reducing sleep to 77.621841ms 2026/08/21 05:23:11 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:23:11 DEBUG : pacer: Reducing sleep to 118.376421ms 2026/08/21 05:23:11 DEBUG : pacer: Reducing sleep to 234.500548ms 2026/08/21 05:23:11 DEBUG : pacer: Reducing sleep to 285.867017ms 2026/08/21 05:23:11 DEBUG : pacer: Reducing sleep to 212.1173ms === 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/21 05:23:16 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:23:20 DEBUG : pacer: Reducing sleep to 121.395531ms 2026/08/21 05:23:20 DEBUG : pacer: Reducing sleep to 243.440088ms 2026/08/21 05:23:20 DEBUG : pacer: Reducing sleep to 287.412774ms 2026/08/21 05:23:21 DEBUG : pacer: Reducing sleep to 208.318445ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout 2026/08/21 05:23:21 DEBUG : pacer: Reducing sleep to 86.025015ms === 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/21 05:23:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/21 05:23:25 DEBUG : pacer: Reducing sleep to 139.561756ms fstests.go:2596: Put returned an error (acceptable): upload error: HTTP error 400 (400 Bad Request) returned body: "\r\n