Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

pkg/runtest: TestCover keeps timing out #4954

Open
a-nogikh opened this issue Jul 1, 2024 · 10 comments
Open

pkg/runtest: TestCover keeps timing out #4954

a-nogikh opened this issue Jul 1, 2024 · 10 comments
Labels

Comments

@a-nogikh
Copy link
Collaborator

a-nogikh commented Jul 1, 2024

On a recent after submit testing: https://github.com/google/syzkaller/actions/runs/9742478582/job/26883877667

2024-07-01T10:36:26.6973073Z panic: test timed out after 10m0s
2024-07-01T10:36:26.6973563Z running tests:
2024-07-01T10:36:26.6974138Z 	TestCover (9m46s)
2024-07-01T10:36:26.6974535Z 	TestCover/64 (9m46s)
2024-07-01T10:36:26.6974954Z 	TestCover/64/13 (9m40s)
2024-07-01T10:36:26.6975243Z 
2024-07-01T10:36:26.6975406Z goroutine 1588 [running]:
2024-07-01T10:36:26.6975874Z testing.(*M).startAlarm.func1()
2024-07-01T10:36:26.6976458Z 	/usr/local/go/src/testing/testing.go:2259 +0x1fc
2024-07-01T10:36:26.6977095Z created by time.goFunc
2024-07-01T10:36:26.6977582Z 	/usr/local/go/src/time/sleep.go:176 +0x45
2024-07-01T10:36:26.6977986Z 
2024-07-01T10:36:26.6978187Z goroutine 1 [chan receive, 9 minutes]:
2024-07-01T10:36:26.6978714Z testing.tRunner.func1()
2024-07-01T10:36:26.6979249Z 	/usr/local/go/src/testing/testing.go:1561 +0x8cc
2024-07-01T10:36:26.6979954Z testing.tRunner(0xc00160f380, 0xc0015dfb08)
2024-07-01T10:36:26.6980591Z 	/usr/local/go/src/testing/testing.go:1601 +0x26c
2024-07-01T10:36:26.6981515Z testing.runTests(0xc00179a0a0?, {0x360fce0, 0x7, 0x7}, {0x1c?, 0x4addb9?, 0x64c8540?})
2024-07-01T10:36:26.6982454Z 	/usr/local/go/src/testing/testing.go:2052 +0x897
2024-07-01T10:36:26.6983052Z testing.(*M).Run(0xc00179a0a0)
2024-07-01T10:36:26.6983794Z 	/usr/local/go/src/testing/testing.go:1925 +0xb58
2024-07-01T10:36:26.6984444Z main.main()
2024-07-01T10:36:26.6984808Z 	_testmain.go:59 +0x2be
2024-07-01T10:36:26.6985099Z 
2024-07-01T10:36:26.6985248Z goroutine 6 [select]:
2024-07-01T10:36:26.6985826Z go.opencensus.io/stats/view.(*worker).start(0xc00154e380)
2024-07-01T10:36:26.6987256Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/vendor/go.opencensus.io/stats/view/worker.go:292 +0x199
2024-07-01T10:36:26.6988677Z created by go.opencensus.io/stats/view.init.0 in goroutine 1
2024-07-01T10:36:26.6990073Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/vendor/go.opencensus.io/stats/view/worker.go:34 +0xfd
2024-07-01T10:36:26.6991101Z 
2024-07-01T10:36:26.6991284Z goroutine 8 [chan receive]:
2024-07-01T10:36:26.6991856Z github.com/google/syzkaller/pkg/stats.newSet.func1()
2024-07-01T10:36:26.6992911Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/stats/set.go:98 +0x85
2024-07-01T10:36:26.6994320Z created by github.com/google/syzkaller/pkg/stats.newSet in goroutine 1
2024-07-01T10:36:26.6995523Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/stats/set.go:97 +0x1ad
2024-07-01T10:36:26.6996340Z 
2024-07-01T10:36:26.6996537Z goroutine 1029 [chan receive, 9 minutes]:
2024-07-01T10:36:26.6997153Z testing.tRunner.func1()
2024-07-01T10:36:26.6997697Z 	/usr/local/go/src/testing/testing.go:1561 +0x8cc
2024-07-01T10:36:26.6998328Z testing.tRunner(0xc001881860, 0x1359780)
2024-07-01T10:36:26.6998965Z 	/usr/local/go/src/testing/testing.go:1601 +0x26c
2024-07-01T10:36:26.6999655Z created by testing.(*T).Run in goroutine 1
2024-07-01T10:36:26.7000305Z 	/usr/local/go/src/testing/testing.go:1648 +0x82b
2024-07-01T10:36:26.7000763Z 
2024-07-01T10:36:26.7000907Z goroutine 194 [sleep]:
2024-07-01T10:36:26.7001358Z time.Sleep(0x989680)
2024-07-01T10:36:26.7001815Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7002741Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc001e28320)
2024-07-01T10:36:26.7004408Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7006376Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001912120, 0xc001810240?)
2024-07-01T10:36:26.7015766Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7017894Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001912120, 0xc002122000)
2024-07-01T10:36:26.7019445Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7020791Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7022043Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7023460Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 115
2024-07-01T10:36:26.7025186Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7026060Z 
2024-07-01T10:36:26.7026211Z goroutine 1454 [sleep]:
2024-07-01T10:36:26.7026642Z time.Sleep(0x989680)
2024-07-01T10:36:26.7027371Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7028402Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc000f6dc20)
2024-07-01T10:36:26.7029900Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7031364Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001034240, 0xc001041b60?)
2024-07-01T10:36:26.7032889Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7034589Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001034240, 0xc0029a0eb0)
2024-07-01T10:36:26.7036083Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7037433Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7039048Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7040517Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1227
2024-07-01T10:36:26.7041985Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7042834Z 
2024-07-01T10:36:26.7042982Z goroutine 1456 [sleep]:
2024-07-01T10:36:26.7043809Z time.Sleep(0x989680)
2024-07-01T10:36:26.7044347Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7045308Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc001300640)
2024-07-01T10:36:26.7046758Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7048310Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001160120, 0xc00117a0f0?)
2024-07-01T10:36:26.7049844Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7051404Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001160120, 0xc001f8ce10)
2024-07-01T10:36:26.7052912Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7054410Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7055648Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7057181Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1243
2024-07-01T10:36:26.7059057Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7059905Z 
2024-07-01T10:36:26.7060078Z goroutine 1228 [syscall, 9 minutes]:
2024-07-01T10:36:26.7061145Z syscall.Syscall6(0xc00160c5a0?, 0xc000c8c000?, 0xc0027aa260?, 0xc002ceedf8?, 0xe7a007?, 0xc0027aa240?, 0xc0016df080?)
2024-07-01T10:36:26.7062738Z 	/usr/local/go/src/syscall/syscall_linux.go:91 +0x3d
2024-07-01T10:36:26.7063446Z os.(*Process).blockUntilWaitable(0xc002640090)
2024-07-01T10:36:26.7064604Z 	/usr/local/go/src/os/wait_waitid.go:32 +0x9f
2024-07-01T10:36:26.7065215Z os.(*Process).wait(0xc002640090)
2024-07-01T10:36:26.7065732Z 	/usr/local/go/src/os/exec_unix.go:22 +0x4b
2024-07-01T10:36:26.7066299Z os.(*Process).Wait(...)
2024-07-01T10:36:26.7067128Z 	/usr/local/go/src/os/exec.go:134
2024-07-01T10:36:26.7067622Z os/exec.(*Cmd).Wait(0xc001642160)
2024-07-01T10:36:26.7068174Z 	/usr/local/go/src/os/exec/exec.go:890 +0xb9
2024-07-01T10:36:26.7068936Z github.com/google/syzkaller/pkg/rpcserver.RunLocal.func1()
2024-07-01T10:36:26.7070132Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/local.go:82 +0x34
2024-07-01T10:36:26.7071487Z created by github.com/google/syzkaller/pkg/rpcserver.RunLocal in goroutine 1333
2024-07-01T10:36:26.7073131Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/local.go:82 +0x9d6
2024-07-01T10:36:26.7074258Z 
2024-07-01T10:36:26.7074409Z goroutine 1303 [sleep]:
2024-07-01T10:36:26.7074846Z time.Sleep(0x989680)
2024-07-01T10:36:26.7075315Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7076247Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc001620000)
2024-07-01T10:36:26.7077701Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7079184Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc000238120, 0xc0000f25d0?)
2024-07-01T10:36:26.7080706Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7082186Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc000238120, 0xc001a264b0)
2024-07-01T10:36:26.7083816Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7085139Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7086366Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7087821Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 673
2024-07-01T10:36:26.7089242Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7090086Z 
2024-07-01T10:36:26.7090237Z goroutine 1061 [sleep]:
2024-07-01T10:36:26.7090672Z time.Sleep(0x989680)
2024-07-01T10:36:26.7091154Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7092066Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc00180ad20)
2024-07-01T10:36:26.7093447Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7095170Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc0001a4120, 0xc001aa3500?)
2024-07-01T10:36:26.7096685Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7098213Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc0001a4120, 0xc00187e000)
2024-07-01T10:36:26.7099777Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7101077Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7102293Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7103881Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1162
2024-07-01T10:36:26.7105320Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7106135Z 
2024-07-01T10:36:26.7106324Z goroutine 334 [chan receive, 9 minutes]:
2024-07-01T10:36:26.7106893Z testing.tRunner.func1()
2024-07-01T10:36:26.7107939Z 	/usr/local/go/src/testing/testing.go:1561 +0x8cc
2024-07-01T10:36:26.7108573Z testing.tRunner(0xc001e83380, 0xc004b12318)
2024-07-01T10:36:26.7109230Z 	/usr/local/go/src/testing/testing.go:1601 +0x26c
2024-07-01T10:36:26.7110080Z created by testing.(*T).Run in goroutine 1029
2024-07-01T10:36:26.7110733Z 	/usr/local/go/src/testing/testing.go:1648 +0x82b
2024-07-01T10:36:26.7111197Z 
2024-07-01T10:36:26.7111349Z goroutine 410 [sleep]:
2024-07-01T10:36:26.7111774Z time.Sleep(0x989680)
2024-07-01T10:36:26.7112244Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7113146Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc0015fc0a0)
2024-07-01T10:36:26.7114731Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7116193Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001912000, 0xc004b0c300?)
2024-07-01T10:36:26.7117860Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7119329Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001912000, 0xc00245cd20)
2024-07-01T10:36:26.7120824Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7122113Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7123342Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7124950Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1301
2024-07-01T10:36:26.7126378Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7127236Z 
2024-07-01T10:36:26.7127405Z goroutine 1333 [select, 9 minutes]:
2024-07-01T10:36:26.7128152Z github.com/google/syzkaller/pkg/rpcserver.RunLocal(0xc0017aa000)
2024-07-01T10:36:26.7129389Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/local.go:88 +0xb19
2024-07-01T10:36:26.7130633Z github.com/google/syzkaller/pkg/runtest.startRpcserver.func2()
2024-07-01T10:36:26.7131870Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/runtest/run_test.go:469 +0x34
2024-07-01T10:36:26.7133247Z created by github.com/google/syzkaller/pkg/runtest.startRpcserver in goroutine 334
2024-07-01T10:36:26.7134860Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/runtest/run_test.go:468 +0x607
2024-07-01T10:36:26.7135725Z 
2024-07-01T10:36:26.7135916Z goroutine 609 [chan receive, 9 minutes]:
2024-07-01T10:36:26.7137137Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).finishFeatures(0xc001929ec0, {0xc0019fe000, 0x15, 0x10ec23f?})
2024-07-01T10:36:26.7138749Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:93 +0x378
2024-07-01T10:36:26.7140234Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).wait(0xc001929ec0, {0xc0019fe000, 0x15, 0x15})
2024-07-01T10:36:26.7141748Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/syscalls.go:108 +0x18f
2024-07-01T10:36:26.7143352Z github.com/google/syzkaller/pkg/vminfo.(*Checker).Run(0xc000e3d0e0, {0x6548d40, 0x0, 0x0}, {0xc0019fe000, 0x15, 0x15})
2024-07-01T10:36:26.7145155Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/vminfo.go:105 +0xe7
2024-07-01T10:36:26.7146770Z github.com/google/syzkaller/pkg/rpcserver.(*Server).runCheck(0xc0016307e0, {0x6548d40, 0x0, 0x0}, {0xc0019fe000, 0x15, 0x15})
2024-07-01T10:36:26.7148539Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:354 +0xbc
2024-07-01T10:36:26.7149903Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handshake.func1.1()
2024-07-01T10:36:26.7151248Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:302 +0xa5
2024-07-01T10:36:26.7152780Z created by github.com/google/syzkaller/pkg/rpcserver.(*Server).handshake.func1 in goroutine 1455
2024-07-01T10:36:26.7154928Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:301 +0x5ff
2024-07-01T10:36:26.7155827Z 
2024-07-01T10:36:26.7155991Z goroutine 411 [sleep]:
2024-07-01T10:36:26.7156593Z time.Sleep(0x989680)
2024-07-01T10:36:26.7157121Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7158045Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc00169ad20)
2024-07-01T10:36:26.7159399Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7160944Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc000f96000, 0xc0024390b0?)
2024-07-01T10:36:26.7162457Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7164091Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc000f96000, 0xc00245cd70)
2024-07-01T10:36:26.7165570Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7166873Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7168154Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7169552Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1190
2024-07-01T10:36:26.7170984Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7171802Z 
2024-07-01T10:36:26.7171993Z goroutine 1062 [select, 9 minutes]:
2024-07-01T10:36:26.7172721Z github.com/google/syzkaller/pkg/rpcserver.RunLocal(0xc000e86460)
2024-07-01T10:36:26.7174152Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/local.go:88 +0xb19
2024-07-01T10:36:26.7175387Z github.com/google/syzkaller/pkg/runtest.startRpcserver.func2()
2024-07-01T10:36:26.7176592Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/runtest/run_test.go:469 +0x34
2024-07-01T10:36:26.7178035Z created by github.com/google/syzkaller/pkg/runtest.startRpcserver in goroutine 1522
2024-07-01T10:36:26.7179446Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/runtest/run_test.go:468 +0x607
2024-07-01T10:36:26.7180334Z 
2024-07-01T10:36:26.7180505Z goroutine 1293 [sleep]:
2024-07-01T10:36:26.7180913Z time.Sleep(0x989680)
2024-07-01T10:36:26.7181387Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7182306Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc000e18dc0)
2024-07-01T10:36:26.7183807Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7185316Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001034120, 0xc001041950?)
2024-07-01T10:36:26.7186818Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7188313Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001034120, 0xc001948820)
2024-07-01T10:36:26.7189802Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7191122Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7192341Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7193967Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1224
2024-07-01T10:36:26.7195390Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7196203Z 
2024-07-01T10:36:26.7196395Z goroutine 1227 [IO wait, 9 minutes]:
2024-07-01T10:36:26.7197015Z internal/poll.runtime_pollWait(0x7cd358d8a630, 0x72)
2024-07-01T10:36:26.7197778Z 	/usr/local/go/src/runtime/netpoll.go:343 +0x85
2024-07-01T10:36:26.7198533Z internal/poll.(*pollDesc).wait(0xc0044e8b20, 0x4af801?, 0x0)
2024-07-01T10:36:26.7199730Z 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0xb1
2024-07-01T10:36:26.7200477Z internal/poll.(*pollDesc).waitRead(...)
2024-07-01T10:36:26.7201319Z 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
2024-07-01T10:36:26.7202016Z internal/poll.(*FD).Accept(0xc0044e8b00)
2024-07-01T10:36:26.7202667Z 	/usr/local/go/src/internal/poll/fd_unix.go:611 +0x405
2024-07-01T10:36:26.7203325Z net.(*netFD).accept(0xc0044e8b00)
2024-07-01T10:36:26.7204055Z 	/usr/local/go/src/net/fd_unix.go:172 +0x3e
2024-07-01T10:36:26.7204649Z net.(*TCPListener).accept(0xc0022a6da0)
2024-07-01T10:36:26.7205281Z 	/usr/local/go/src/net/tcpsock_posix.go:152 +0x3e
2024-07-01T10:36:26.7205917Z net.(*TCPListener).Accept(0xc0022a6da0)
2024-07-01T10:36:26.7206654Z 	/usr/local/go/src/net/tcpsock.go:315 +0x65
2024-07-01T10:36:26.7207491Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1()
2024-07-01T10:36:26.7208685Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:39 +0x55
2024-07-01T10:36:26.7210048Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe in goroutine 1333
2024-07-01T10:36:26.7211415Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:37 +0x10e
2024-07-01T10:36:26.7212232Z 
2024-07-01T10:36:26.7212401Z goroutine 1346 [sleep]:
2024-07-01T10:36:26.7212813Z time.Sleep(0x989680)
2024-07-01T10:36:26.7213284Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7214421Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc0026203c0)
2024-07-01T10:36:26.7215779Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7217295Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc0016305a0, 0xc001e245d0?)
2024-07-01T10:36:26.7218794Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7220292Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc0016305a0, 0xc001f8cc80)
2024-07-01T10:36:26.7221738Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7223046Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7224449Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7225835Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1290
2024-07-01T10:36:26.7227336Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7228180Z 
2024-07-01T10:36:26.7228328Z goroutine 1324 [sleep]:
2024-07-01T10:36:26.7228753Z time.Sleep(0x989680)
2024-07-01T10:36:26.7229204Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7230144Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc0011a6000)
2024-07-01T10:36:26.7231511Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7232962Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc000c92000, 0xc002438270?)
2024-07-01T10:36:26.7234648Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7236111Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc000c92000, 0xc004263b30)
2024-07-01T10:36:26.7237608Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7238915Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7240166Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7241584Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1253
2024-07-01T10:36:26.7242979Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7244374Z 
2024-07-01T10:36:26.7244550Z goroutine 1510 [syscall, 9 minutes]:
2024-07-01T10:36:26.7245386Z syscall.Syscall6(0x2?, 0xc002a150e0?, 0xc00493aef4?, 0x1?, 0x64ea5d0?, 0xadc8?, 0x0?)
2024-07-01T10:36:26.7246795Z 	/usr/local/go/src/syscall/syscall_linux.go:91 +0x3d
2024-07-01T10:36:26.7247602Z os.(*Process).blockUntilWaitable(0xc00003eb10)
2024-07-01T10:36:26.7248259Z 	/usr/local/go/src/os/wait_waitid.go:32 +0x9f
2024-07-01T10:36:26.7248828Z os.(*Process).wait(0xc00003eb10)
2024-07-01T10:36:26.7249360Z 	/usr/local/go/src/os/exec_unix.go:22 +0x4b
2024-07-01T10:36:26.7249946Z os.(*Process).Wait(...)
2024-07-01T10:36:26.7250374Z 	/usr/local/go/src/os/exec.go:134
2024-07-01T10:36:26.7250880Z os/exec.(*Cmd).Wait(0xc004b842c0)
2024-07-01T10:36:26.7251441Z 	/usr/local/go/src/os/exec/exec.go:890 +0xb9
2024-07-01T10:36:26.7252269Z github.com/google/syzkaller/pkg/rpcserver.RunLocal.func1()
2024-07-01T10:36:26.7253451Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/local.go:82 +0x34
2024-07-01T10:36:26.7255037Z created by github.com/google/syzkaller/pkg/rpcserver.RunLocal in goroutine 1062
2024-07-01T10:36:26.7256402Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/local.go:82 +0x9d6
2024-07-01T10:36:26.7257293Z 
2024-07-01T10:36:26.7257444Z goroutine 1065 [sleep]:
2024-07-01T10:36:26.7257878Z time.Sleep(0x989680)
2024-07-01T10:36:26.7258349Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7259252Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc000eb2dc0)
2024-07-01T10:36:26.7260652Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7262118Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001034480, 0xc0020fba70?)
2024-07-01T10:36:26.7263733Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7265328Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001034480, 0xc000eae870)
2024-07-01T10:36:26.7266863Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7268539Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7269805Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7271255Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1722
2024-07-01T10:36:26.7272669Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7273482Z 
2024-07-01T10:36:26.7273818Z goroutine 1522 [select, 9 minutes]:
2024-07-01T10:36:26.7274849Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc000eb2000, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7276358Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7278320Z github.com/google/syzkaller/pkg/runtest.testCover1(0xc000ff2ea0, 0x1976080?, {0x1, {0xc00490a3c0, 0x30, 0x40}, {0xc004918048, 0x3, 0x3}, {0x0, ...}, ...}, ...)
2024-07-01T10:36:26.7280197Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/runtest/run_test.go:391 +0x4a5
2024-07-01T10:36:26.7281428Z github.com/google/syzkaller/pkg/runtest.testCover.func1(0x0?)
2024-07-01T10:36:26.7282657Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/runtest/run_test.go:369 +0x2bc
2024-07-01T10:36:26.7283917Z testing.tRunner(0xc000ff2ea0, 0xc000fdef30)
2024-07-01T10:36:26.7284577Z 	/usr/local/go/src/testing/testing.go:1595 +0x239
2024-07-01T10:36:26.7285253Z created by testing.(*T).Run in goroutine 334
2024-07-01T10:36:26.7285900Z 	/usr/local/go/src/testing/testing.go:1648 +0x82b
2024-07-01T10:36:26.7286363Z 
2024-07-01T10:36:26.7286510Z goroutine 1278 [sleep]:
2024-07-01T10:36:26.7286947Z time.Sleep(0x989680)
2024-07-01T10:36:26.7287445Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7288800Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc001485c20)
2024-07-01T10:36:26.7294072Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7295921Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc0001a4240, 0xc001aa3e00?)
2024-07-01T10:36:26.7297589Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7299057Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc0001a4240, 0xc0029a0f00)
2024-07-01T10:36:26.7300538Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7301860Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7303086Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7304722Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1166
2024-07-01T10:36:26.7306137Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7306951Z 
2024-07-01T10:36:26.7307652Z goroutine 1509 [IO wait, 9 minutes]:
2024-07-01T10:36:26.7308284Z internal/poll.runtime_pollWait(0x7cd3102c46f0, 0x72)
2024-07-01T10:36:26.7309002Z 	/usr/local/go/src/runtime/netpoll.go:343 +0x85
2024-07-01T10:36:26.7309782Z internal/poll.(*pollDesc).wait(0xc002b4b1a0, 0x4af801?, 0x0)
2024-07-01T10:36:26.7310633Z 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0xb1
2024-07-01T10:36:26.7311373Z internal/poll.(*pollDesc).waitRead(...)
2024-07-01T10:36:26.7312056Z 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
2024-07-01T10:36:26.7312725Z internal/poll.(*FD).Accept(0xc002b4b180)
2024-07-01T10:36:26.7313401Z 	/usr/local/go/src/internal/poll/fd_unix.go:611 +0x405
2024-07-01T10:36:26.7314266Z net.(*netFD).accept(0xc002b4b180)
2024-07-01T10:36:26.7314804Z 	/usr/local/go/src/net/fd_unix.go:172 +0x3e
2024-07-01T10:36:26.7315405Z net.(*TCPListener).accept(0xc0023548c0)
2024-07-01T10:36:26.7316042Z 	/usr/local/go/src/net/tcpsock_posix.go:152 +0x3e
2024-07-01T10:36:26.7316664Z net.(*TCPListener).Accept(0xc0023548c0)
2024-07-01T10:36:26.7317302Z 	/usr/local/go/src/net/tcpsock.go:315 +0x65
2024-07-01T10:36:26.7318103Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1()
2024-07-01T10:36:26.7319301Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:39 +0x55
2024-07-01T10:36:26.7320765Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe in goroutine 1062
2024-07-01T10:36:26.7322129Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:37 +0x10e
2024-07-01T10:36:26.7322946Z 
2024-07-01T10:36:26.7323115Z goroutine 1277 [sleep]:
2024-07-01T10:36:26.7323528Z time.Sleep(0x989680)
2024-07-01T10:36:26.7324197Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7325136Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc00073df40)
2024-07-01T10:36:26.7326493Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7328027Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc000f96240, 0xc000fdf860?)
2024-07-01T10:36:26.7329557Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7331035Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc000f96240, 0xc0019aa000)
2024-07-01T10:36:26.7332487Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7333986Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7335222Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7336616Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1528
2024-07-01T10:36:26.7338623Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7339437Z 
2024-07-01T10:36:26.7339825Z goroutine 1455 [IO wait, 9 minutes]:
2024-07-01T10:36:26.7340462Z internal/poll.runtime_pollWait(0x7cd3102c4fa8, 0x72)
2024-07-01T10:36:26.7341175Z 	/usr/local/go/src/runtime/netpoll.go:343 +0x85
2024-07-01T10:36:26.7341948Z internal/poll.(*pollDesc).wait(0xc0055246a0, 0xc0019f8000?, 0x0)
2024-07-01T10:36:26.7342846Z 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0xb1
2024-07-01T10:36:26.7343561Z internal/poll.(*pollDesc).waitRead(...)
2024-07-01T10:36:26.7344462Z 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
2024-07-01T10:36:26.7345311Z internal/poll.(*FD).Read(0xc005524680, {0xc0019f8000, 0x294, 0x2c0})
2024-07-01T10:36:26.7346139Z 	/usr/local/go/src/internal/poll/fd_unix.go:164 +0x3e5
2024-07-01T10:36:26.7346927Z net.(*netFD).Read(0xc005524680, {0xc0019f8000, 0x294, 0x2c0})
2024-07-01T10:36:26.7347695Z 	/usr/local/go/src/net/fd_posix.go:55 +0x4b
2024-07-01T10:36:26.7348375Z net.(*conn).Read(0xc000d00070, {0xc0019f8000, 0x294, 0x2c0})
2024-07-01T10:36:26.7349068Z 	/usr/local/go/src/net/net.go:179 +0xad
2024-07-01T10:36:26.7349883Z io.ReadAtLeast({0x1571440, 0xc000d00070}, {0xc0019f8000, 0x294, 0x2c0}, 0x4)
2024-07-01T10:36:26.7350668Z 	/usr/local/go/src/io/io.go:335 +0xd0
2024-07-01T10:36:26.7351488Z github.com/google/syzkaller/pkg/flatrpc.(*Conn).recv(0xc001f8cdc0, 0x4)
2024-07-01T10:36:26.7352763Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:182 +0x36a
2024-07-01T10:36:26.7354154Z github.com/google/syzkaller/pkg/flatrpc.RecvRaw[...](0xc001f8cdc0)
2024-07-01T10:36:26.7355389Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:153 +0x205
2024-07-01T10:36:26.7356580Z github.com/google/syzkaller/pkg/flatrpc.Recv[...](0xc000f76c60)
2024-07-01T10:36:26.7357820Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:129 +0xd4
2024-07-01T10:36:26.7359133Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc0014700a0)
2024-07-01T10:36:26.7360540Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:89 +0x2bd
2024-07-01T10:36:26.7362010Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc0016307e0, 0xc000e3d140?)
2024-07-01T10:36:26.7363503Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7365160Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc0016307e0, 0xc001f8cdc0)
2024-07-01T10:36:26.7366635Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7368072Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7369281Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7370727Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1509
2024-07-01T10:36:26.7372152Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7372973Z 
2024-07-01T10:36:26.7373124Z goroutine 1139 [sleep]:
2024-07-01T10:36:26.7373555Z time.Sleep(0x989680)
2024-07-01T10:36:26.7374252Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7375161Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc000d203c0)
2024-07-01T10:36:26.7376531Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7378056Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc000eb8000, 0xc00191cba0?)
2024-07-01T10:36:26.7379628Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7381075Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc000eb8000, 0xc00191ab40)
2024-07-01T10:36:26.7383314Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7385111Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7386331Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7387811Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1063
2024-07-01T10:36:26.7389234Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7390074Z 
2024-07-01T10:36:26.7390272Z goroutine 1480 [select, 9 minutes]:
2024-07-01T10:36:26.7391318Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001206c80, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7392830Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7394450Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7395822Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7397402Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7398921Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7399790Z 
2024-07-01T10:36:26.7399986Z goroutine 1481 [select, 9 minutes]:
2024-07-01T10:36:26.7400966Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001206e60, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7402468Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7404535Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7406024Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7407901Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7409729Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7410694Z 
2024-07-01T10:36:26.7410983Z goroutine 1483 [select, 9 minutes]:
2024-07-01T10:36:26.7412086Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc0012b0320, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7414062Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7415650Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7417156Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7418886Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7420600Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7421561Z 
2024-07-01T10:36:26.7421780Z goroutine 1484 [select, 9 minutes]:
2024-07-01T10:36:26.7422995Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001206b40, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7424859Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7426460Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7427980Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7429669Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7431381Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7432273Z 
2024-07-01T10:36:26.7432501Z goroutine 1485 [select, 9 minutes]:
2024-07-01T10:36:26.7434227Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001206d20, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7436228Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7437854Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7439383Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7441146Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7442797Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7443857Z 
2024-07-01T10:36:26.7444137Z goroutine 1486 [select, 9 minutes]:
2024-07-01T10:36:26.7445342Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001206dc0, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7446999Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7448621Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7450156Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7451849Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7453521Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7454652Z 
2024-07-01T10:36:26.7454929Z goroutine 1489 [select, 9 minutes]:
2024-07-01T10:36:26.7456335Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc0012b00a0, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7458041Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7459645Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7461118Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7462782Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7464678Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7465597Z 
2024-07-01T10:36:26.7465817Z goroutine 1554 [select, 9 minutes]:
2024-07-01T10:36:26.7466959Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001206f00, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7468699Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7470301Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7471750Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7473474Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7475412Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7476306Z 
2024-07-01T10:36:26.7476528Z goroutine 1556 [select, 9 minutes]:
2024-07-01T10:36:26.7477791Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001380640, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7479437Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7481005Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7482510Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7484366Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7486038Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7487432Z 
2024-07-01T10:36:26.7487658Z goroutine 1558 [select, 9 minutes]:
2024-07-01T10:36:26.7488975Z github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc0012b01e0, {0x157a248, 0x6548d40})
2024-07-01T10:36:26.7490682Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0xe6
2024-07-01T10:36:26.7492348Z github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
2024-07-01T10:36:26.7494052Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0x1f7
2024-07-01T10:36:26.7495745Z created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 609
2024-07-01T10:36:26.7497528Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x34d
2024-07-01T10:36:26.7498414Z 
2024-07-01T10:36:26.7498622Z goroutine 1511 [sleep]:
2024-07-01T10:36:26.7499211Z time.Sleep(0x989680)
2024-07-01T10:36:26.7499897Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7500906Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc000d20960)
2024-07-01T10:36:26.7502440Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7504300Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001c92120, 0xc0020fb650?)
2024-07-01T10:36:26.7505979Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7507580Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001c92120, 0xc000ffcaf0)
2024-07-01T10:36:26.7509316Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7510826Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7512130Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7513946Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1730
2024-07-01T10:36:26.7515539Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7516410Z 
2024-07-01T10:36:26.7516727Z goroutine 203 [sleep]:
2024-07-01T10:36:26.7517298Z time.Sleep(0x989680)
2024-07-01T10:36:26.7517912Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7519020Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc001c5a000)
2024-07-01T10:36:26.7520520Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7522132Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001034360, 0xc0016b4150?)
2024-07-01T10:36:26.7524082Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7525672Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001034360, 0xc001da8f00)
2024-07-01T10:36:26.7527337Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7528847Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7530241Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7531741Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1231
2024-07-01T10:36:26.7533358Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7534487Z 
2024-07-01T10:36:26.7534751Z goroutine 1748 [sleep]:
2024-07-01T10:36:26.7535260Z time.Sleep(0x989680)
2024-07-01T10:36:26.7535937Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7537009Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc001db0e60)
2024-07-01T10:36:26.7538912Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7540690Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc001c2a360, 0xc001f03ef0?)
2024-07-01T10:36:26.7542548Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:26.7544406Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc001c2a360, 0xc001f8d090)
2024-07-01T10:36:26.7546023Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:229 +0x6ad
2024-07-01T10:36:26.7547544Z github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1.1()
2024-07-01T10:36:26.7548930Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:54 +0x2ad
2024-07-01T10:36:26.7550489Z created by github.com/google/syzkaller/pkg/flatrpc.ListenAndServe.func1 in goroutine 1689
2024-07-01T10:36:26.7552114Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/flatrpc/conn.go:51 +0x114
2024-07-01T10:36:26.7552989Z 
2024-07-01T10:36:26.7553248Z goroutine 1747 [sleep]:
2024-07-01T10:36:26.7553998Z time.Sleep(0x989680)
2024-07-01T10:36:26.7554656Z 	/usr/local/go/src/runtime/time.go:195 +0x125
2024-07-01T10:36:26.7556310Z github.com/google/syzkaller/pkg/rpcserver.(*Runner).connectionLoop(0xc0013814a0)
2024-07-01T10:36:26.7557866Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/runner.go:86 +0x28f
2024-07-01T10:36:26.7559501Z github.com/google/syzkaller/pkg/rpcserver.(*Server).connectionLoop(0xc00128e6c0, 0xc001d8c3c0?)
2024-07-01T10:36:26.7561201Z 	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/rpcserver/rpcserver.go:336 +0x18b
2024-07-01T10:36:48.0680878Z github.com/google/syzkaller/pkg/rpcserver.(*Server).handleConn(0xc00128e6c
@a-nogikh a-nogikh added the bug label Jul 1, 2024
@a-nogikh
Copy link
Collaborator Author

a-nogikh commented Jul 2, 2024

One more case: https://github.com/google/syzkaller/actions/runs/9758033237/job/26931740035
I've also seen it happen in presubmit tests.

I was not the case up to this week, so I guess it's caused by some recent changes.

@a-nogikh
Copy link
Collaborator Author

a-nogikh commented Jul 3, 2024

It happens not just under -race: https://github.com/google/syzkaller/actions/runs/9777468361/job/26992218647


goroutine 4178 [select, 9 minutes]:
github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc006d505a0, {0x10cad50, 0x6377780})
	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0x76
github.com/google/syzkaller/pkg/runtest.testCover1(0xc00569b1e0, 0x1467c18?, {0x1, {0xc003f22240, 0x40, 0x40}, {0x0, 0x0, 0x0}, {0x0, ...}, ...}, ...)
	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/runtest/run_test.go:390 +0x265
github.com/google/syzkaller/pkg/runtest.testCover.func1(0x10cad50?)

That's here:

res := req.Wait(context.Background())

goroutine 4391 [select, 9 minutes]:
github.com/google/syzkaller/pkg/fuzzer/queue.(*Request).Wait(0xc001228b40, {0x10cad50, 0x6377780})
	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/fuzzer/queue/queue.go:89 +0x76
github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck.func1()
	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:69 +0xc5
created by github.com/google/syzkaller/pkg/vminfo.(*checkContext).startFeaturesCheck in goroutine 4268
	/__w/syzkaller/syzkaller/gopath/src/github.com/google/syzkaller/pkg/vminfo/features.go:56 +0x1c5

That's here:

res := req.Wait(ctx.ctx)


So some syz-executors just stop communicating and we wait forever for their responses? That's bad by itself, we probably somehow not react to their errors.

Regarding the reason why they fail -- could it be that the Docker container we use for testing e.g. somehow limits the number of simultaneous processes? After the recent change that made TestCover subtests create their own PRC servers, the load must have increased significantly.

@a-nogikh a-nogikh changed the title pkg/runtest: TestCover may timeout under -race pkg/runtest: TestCover keeps timing out Jul 3, 2024
@a-nogikh
Copy link
Collaborator Author

a-nogikh commented Jul 3, 2024

https://github.com/google/syzkaller/actions/runs/9779999561/job/27000577263

2024-07-03T14:50:16.6135500Z 2024/07/03 14:49:21 [FATAL] check failed: execution of simple program fails: executor crashed
2024-07-03T14:50:16.6136996Z exit status 1
2024-07-03T14:50:16.6137510Z FAIL	github.com/google/syzkaller/pkg/runtest	20.392s

Probably related?

@a-nogikh
Copy link
Collaborator Author

a-nogikh commented Jul 4, 2024

Memory consumption doesn't look crazy:

$ /usr/bin/time -v go test ./pkg/runtest -run TestCover
ok      github.com/google/syzkaller/pkg/runtest 7.609s
        Command being timed: "go test ./pkg/runtest -run TestCover"
        User time (seconds): 205.97
        System time (seconds): 33.55
        Percent of CPU this job got: 244%
        Elapsed (wall clock) time (h:mm:ss or m:ss): 1:37.89
        Average shared text size (kbytes): 0
        Average unshared data size (kbytes): 0
        Average stack size (kbytes): 0
        Average total size (kbytes): 0
        Maximum resident set size (kbytes): 4455168
        Average resident set size (kbytes): 0
        Major (requiring I/O) page faults: 4321
        Minor (reclaiming a frame) page faults: 3851240
        Voluntary context switches: 244682
        Involuntary context switches: 34610
        Swaps: 0
        File system inputs: 444440
        File system outputs: 1372704

In any case, I've tried to reproduce it many times locally and never managed to.

@tarasmadan
Copy link
Collaborator

@a-nogikh what commit do you think triggered or scaled this problem?

@a-nogikh
Copy link
Collaborator Author

a-nogikh commented Jul 4, 2024

I think we've begun to observe it after startRpcServer was moved inside the TestCoverage subtests in a6f99ac

@dvyukov
Copy link
Collaborator

dvyukov commented Jul 4, 2024

We may try to remove t.Parallel() from there, maybe there is some contention...

@dvyukov
Copy link
Collaborator

dvyukov commented Jul 4, 2024

In any case, I've tried to reproduce it many times locally and never managed to.

Have you tried with taskset -c 0 or 0-1? The test VMs should be small.

@a-nogikh
Copy link
Collaborator Author

a-nogikh commented Jul 4, 2024

The test VMs should be actually quite big (as told by @tarasmadan) -- up to 32 cores.

If it were just getting slower, I think the test would have still passed, just slower. But here something definitely goes very wrong, and in a weird way.

I wonder if we're really staying careful w.r.t. the executor process crashes. If the process exits, we definitely notice it:

go func() { res <- cmd.Wait() }()

case err := <-res:
cmdErr = fmt.Errorf("executor process exited: %w", err)

And then eventually close the flatrpc server. But do the runner loops ever notice that?

If we don't send new requests, we're just sleeping and not even interacting with the socket.

if len(runner.requests) == 0 {
// The runner has not requests at all, so don't wait to receive anything from it.
time.Sleep(10 * time.Millisecond)
continue
}

(If yes, we have a separate problem -- no new requests mean we never read from the socket, so we never get results for the previous one(s)).

Ideally, RPCServer.Close() should also stop all Runner's loops.

@dvyukov
Copy link
Collaborator

dvyukov commented Jul 4, 2024

Good point. There are sleeping goroutines in connectionLoop in the dump.
The simplest thing we can do is to send empty signal updates before the sleep and check errors.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Projects
None yet
Development

No branches or pull requests

3 participants