"./vfs.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose" - Starting (try 1/5) 2025/11/17 03:04:49 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-lifahij7duhe" 2025/11/17 03:04:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/17 03:04:50 DEBUG : Creating backend with remote "/tmp/rclone3120766753" === RUN TestDirHandleMethods run.go:185: Remote "OneDrive root 'rclone-test-lifahij7duhe'", Local "Local file system at /tmp/rclone3120766753", Modify Window "1s" 2025/11/17 03:04:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Next delta token is: aTE09NjM4OTg5NDA5MDQwNTM7SUQ9NzFBOTY3OThFN0IxRDI1MyExMDE7TFI9NjM4OTg5NDU0OTA2MzM7RVA9MjA7U0k9NzE7RExFUD0xO1NHPTE7U089NjtQST0z 2025/11/17 03:04:50 NOTICE: OneDrive root 'rclone-test-lifahij7duhe': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2025/11/17 03:04:50 DEBUG : Too many requests. Trying again in 51898 seconds. 2025/11/17 03:04:50 DEBUG : pacer: low level retry 1/10 (error accessDenied: throttledRequest: Too Many Requests: trying again in 14h24m58s) 2025/11/17 03:04:50 DEBUG : pacer: Rate limited, increasing sleep to 14h24m58s 2025/11/17 03:04:51 DEBUG : Too many requests. Trying again in 55497 seconds. 2025/11/17 03:04:51 DEBUG : pacer: low level retry 2/10 (error accessDenied: throttledRequest: Too Many Requests: trying again in 15h24m57s) 2025/11/17 03:04:51 DEBUG : pacer: Rate limited, increasing sleep to 15h24m57s 2025/11/17 03:05:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:06:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:07:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:08:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:09:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:10:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:11:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:12:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:13:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:14:50 DEBUG : forgetting directory cache 2025/11/17 03:14:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:15:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:16:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:17:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:18:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:19:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:20:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:20:51 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: accessDenied: throttledRequest: Too Many Requests 2025/11/17 03:21:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:21:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:22:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:22:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:23:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:23:51 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:24:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:24:51 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:25:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:25:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:26:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:26:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:27:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:27:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:28:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:28:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:29:46 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Background refresher detected expired token but no uploads in progress - doing nothing 2025/11/17 03:29:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:29:50 DEBUG : TestOneDrive: Token expired 2025/11/17 03:29:50 DEBUG : Config file has changed externally - reloading 2025/11/17 03:29:50 DEBUG : TestOneDrive: No updated token found in the config file 2025/11/17 03:29:51 DEBUG : TestOneDrive: Token refresh successful 2025/11/17 03:29:51 DEBUG : Config file has changed externally - reloading 2025/11/17 03:29:51 DEBUG : Saving config "token" in section "TestOneDrive" of the config file 2025/11/17 03:29:51 DEBUG : TestOneDrive: Saved new token in config file 2025/11/17 03:29:51 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:30:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:30:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:31:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:31:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:32:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:32:51 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:33:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:33:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:34:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:34:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:35:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:35:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:36:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:36:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:37:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:37:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:38:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:38:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:39:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:39:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:40:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:40:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:41:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:41:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:42:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:42:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:43:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:43:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:44:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:44:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:45:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:45:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:46:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:46:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:47:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:47:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:48:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:48:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:49:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:49:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:50:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:50:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:51:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:51:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:52:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:52:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:53:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:53:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:54:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:54:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:55:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:55:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:56:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:56:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:57:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:57:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:58:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:58:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 03:59:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 03:59:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 04:00:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 04:00:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 04:01:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 04:01:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 04:02:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 04:02:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. 2025/11/17 04:03:50 DEBUG : OneDrive root 'rclone-test-lifahij7duhe': Checking for changes on remote 2025/11/17 04:03:50 INFO : OneDrive root 'rclone-test-lifahij7duhe': Change notify listener failure: invalidRequest: [token.String] A value is required but was not present in the request. panic: test timed out after 1h0m0s running tests: TestDirHandleMethods (1h0m0s) goroutine 163 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:2484 +0x394 created by time.goFunc /usr/local/go/src/time/sleep.go:215 +0x2d goroutine 1 [chan receive, 60 minutes]: testing.(*T).Run(0xc0006bbc00, {0x28db8cb?, 0xc000069ad8?}, 0x2a16bd0) /usr/local/go/src/testing/testing.go:1859 +0x431 testing.runTests.func1(0xc0006bbc00) /usr/local/go/src/testing/testing.go:2279 +0x37 testing.tRunner(0xc0006bbc00, 0xc000069c18) /usr/local/go/src/testing/testing.go:1792 +0xf4 testing.runTests(0xc0003d3968, {0x427fc20, 0x59, 0x59}, {0xee0ac87d2?, 0x429cae0?, 0x429cae0?}) /usr/local/go/src/testing/testing.go:2277 +0x4b4 testing.(*M).Run(0xc00088c8c0) /usr/local/go/src/testing/testing.go:2142 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc00088c8c0) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:74 +0xa6 github.com/rclone/rclone/vfs.TestMain(...) /home/rclone/go/src/github.com/rclone/rclone/vfs/vfs_test.go:36 main.main() _testmain.go:225 +0xa9 goroutine 26 [syscall, 60 minutes]: os/signal.signal_recv() /usr/local/go/src/runtime/sigqueue.go:152 +0x29 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func1.1 in goroutine 1 /usr/local/go/src/os/signal/signal.go:152 +0x1f goroutine 27 [chan receive, 60 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 28 [select, 36 minutes]: github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000880e00) /home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86 created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5 goroutine 82 [select]: github.com/rclone/rclone/backend/onedrive.(*Fs).ChangeNotify.func1() /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:2887 +0x1c5 created by github.com/rclone/rclone/backend/onedrive.(*Fs).ChangeNotify in goroutine 16 /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:2874 +0xa8 goroutine 16 [chan receive, 60 minutes]: github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc0000ae840, 0x0) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:162 +0x26 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc0000ae840, 0xc000880780, 0xa) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:215 +0xb2 github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc0000ae840, 0xc000880780) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:235 +0x93 github.com/rclone/rclone/backend/onedrive.(*Fs).readMetaDataForPathRelativeToID(0xc00048ca80, {0x2dac648, 0x42c03a0}, {0xc0007c4330, 0x25}, {0xc000054f3d, 0x18}) /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:934 +0x2c9 github.com/rclone/rclone/backend/onedrive.(*Fs).FindLeaf(0xc00048ca80, {0x2dac648, 0x42c03a0}, {0xc0007c4330, 0x25}, {0xc000054f3d, 0x18}) /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:1232 +0x77 github.com/rclone/rclone/lib/dircache.(*DirCache)._findDir(0xc00017d830, {0x2dac648, 0x42c03a0}, {0xc000054f3d, 0x18}, 0x1) /home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:234 +0x112 github.com/rclone/rclone/lib/dircache.(*DirCache)._findRoot(0xc00017d830, {0x2dac648?, 0x42c03a0?}, 0xe0?) /home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:305 +0x45 github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0xc00017d830, {0x2dac648, 0x42c03a0}, {0x0, 0x0}, 0x1) /home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:201 +0xcd github.com/rclone/rclone/backend/onedrive.(*Fs).Mkdir(0x28d5ee5?, {0x2dac648?, 0x42c03a0?}, {0x0?, 0x1?}) /home/rclone/go/src/github.com/rclone/rclone/backend/onedrive/onedrive.go:1587 +0x2f github.com/rclone/rclone/fstest.(*Run).ForceMkdir(0xc0007e6e00, {0x2dac648?, 0x42c03a0?}, {0x2dc53a0, 0xc00048ca80}) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:240 +0x38 github.com/rclone/rclone/fstest.(*Run).Mkdir(0xc0007e6e00, {0x2dac648, 0x42c03a0}, {0x2dc53a0, 0xc00048ca80}) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:250 +0x71 github.com/rclone/rclone/fstest.(*Run).WriteObjectTo(0xc0007e6e00, {0x2dac648, 0x42c03a0}, {0x2dc53a0, 0xc00048ca80}, {0x28ba58b, 0x9}, {0x28c8752, 0xe}, {0x1dcd64ff, ...}, ...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:263 +0x145 github.com/rclone/rclone/fstest.(*Run).WriteObject(...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:297 github.com/rclone/rclone/vfs.dirCreate(0xc0006bbdc0) /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:25 +0xbb github.com/rclone/rclone/vfs.TestDirHandleMethods(0xc0006bbdc0) /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_handle_test.go:14 +0x1f testing.tRunner(0xc0006bbdc0, 0x2a16bd0) /usr/local/go/src/testing/testing.go:1792 +0xf4 created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1851 +0x413 goroutine 84 [select, 60 minutes]: github.com/rclone/rclone/vfs.(*VFS).signalHandler(0xc0003c7cc0, {0x2dac760, 0xc0005b4eb0}) /home/rclone/go/src/github.com/rclone/rclone/vfs/vfs.go:290 +0xc5 created by github.com/rclone/rclone/vfs.New in goroutine 16 /home/rclone/go/src/github.com/rclone/rclone/vfs/vfs.go:266 +0x7fe goroutine 87 [sleep, 60 minutes]: time.Sleep(0x2f3371dac400) /usr/local/go/src/runtime/time.go:338 +0x165 github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall.func1(0x0?) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:170 +0x1c created by github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall in goroutine 16 /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:169 +0xf6 goroutine 120 [IO wait]: internal/poll.runtime_pollWait(0x7cfad1acc6f0, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0001e5500?, 0xc0000fc600?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0001e5500, {0xc0000fc600, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0001e5500, {0xc0000fc600?, 0x12d2?, 0xc00039e520?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000088530, {0xc0000fc600?, 0xc0000fc629?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0006f04c8, {0xc0000fc600?, 0x7cfad1ad2ef8?, 0x7cfb195c0108?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc0006f0048, {0xc0000fc600?, 0x12d2?, 0x7cfad009de48?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0006dc9b8, {0x2d85d60, 0xc0006f0048}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0006dc708, {0x7cfad0043e98, 0xc0006f04c8}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0006dc708, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0006dc708, {0xc00082b000, 0x1000, 0xc0003e5ca0?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 bufio.(*Reader).Read(0xc0000afc80, {0xc0005983c0, 0x9, 0x4203320?}) /usr/local/go/src/bufio/bufio.go:245 +0x197 io.ReadAtLeast({0x2d82cc0, 0xc0000afc80}, {0xc0005983c0, 0x9, 0x9}, 0x9) /usr/local/go/src/io/io.go:335 +0x91 io.ReadFull(...) /usr/local/go/src/io/io.go:354 net/http.http2readFrameHeader({0xc0005983c0, 0x9, 0xc0004484e0?}, {0x2d82cc0?, 0xc0000afc80?}) /usr/local/go/src/net/http/h2_bundle.go:1805 +0x65 net/http.(*http2Framer).ReadFrame(0xc000598380) /usr/local/go/src/net/http/h2_bundle.go:2072 +0x7d net/http.(*http2clientConnReadLoop).run(0xc0003e5fa8) /usr/local/go/src/net/http/h2_bundle.go:9933 +0xda net/http.(*http2ClientConn).readLoop(0xc0008a1180) /usr/local/go/src/net/http/h2_bundle.go:9812 +0x79 created by net/http.(*http2Transport).newClientConn in goroutine 119 /usr/local/go/src/net/http/h2_bundle.go:8334 +0xde5 "./vfs.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose" - Finished ERROR in 1h0m1.206256296s (try 1/5): exit status 2: Failed []