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.

Sign up for GitHub

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

Jump to bottom

net/http: apparent deadlock in TestIdentityTransferEncoding_h1 via syscall.Open on plan9-arm #52896

Open
bcmills opened this issue May 13, 2022 · 27 comments
Open

net/http: apparent deadlock in TestIdentityTransferEncoding_h1 via syscall.Open on plan9-arm #52896

bcmills opened this issue May 13, 2022 · 27 comments
Labels
arch-arm Issues solely affecting the 32-bit arm architecture. NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one. OS-Plan9
Milestone
Backlog

Comments

@bcmills
Copy link
Contributor

bcmills commented May 13, 2022 •
edited
Loading 

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`

goroutine 1974 [chan receive, 17 minutes]:
runtime.gopark(0x4af1e8, 0x1105a370, 0xe, 0x17, 0x2)
	/boot/workdir/go/src/runtime/proc.go:363 +0x100 fp=0x111c5cb4 sp=0x111c5ca0 pc=0x3f158
runtime.chanrecv(0x1105a340, 0x111c5d54, 0x1)
	/boot/workdir/go/src/runtime/chan.go:583 +0x528 fp=0x111c5d00 sp=0x111c5cb4 pc=0x5ab0
runtime.chanrecv1(0x1105a340, 0x111c5d54)
	/boot/workdir/go/src/runtime/chan.go:442 +0x20 fp=0x111c5d14 sp=0x111c5d00 pc=0x5558
internal/poll.(*asyncIO).Wait(...)
	/boot/workdir/go/src/internal/poll/fd_io_plan9.go:85
internal/poll.(*FD).Read(0x11058b80, 0x1102a798, {0x10ffa000, 0x1000, 0x1000})
	/boot/workdir/go/src/internal/poll/fd_plan9.go:79 +0x194 fp=0x111c5d64 sp=0x111c5d14 pc=0x99444
net.(*netFD).Read(0x11058b80, {0x10ffa000, 0x1000, 0x1000})
	/boot/workdir/go/src/net/fd_plan9.go:86 +0x98 fp=0x111c5d94 sp=0x111c5d64 pc=0x1e8e44
net.(*conn).Read(0x1102a748, {0x10ffa000, 0x1000, 0x1000})
	/boot/workdir/go/src/net/net.go:182 +0x48 fp=0x111c5dc4 sp=0x111c5d94 pc=0x1f5bec
net/http.(*persistConn).Read(0x10fb9a40, {0x10ffa000, 0x1000, 0x1000})
	/boot/workdir/go/src/net/http/transport.go:1928 +0x16c fp=0x111c5df8 sp=0x111c5dc4 pc=0x2e14b4
bufio.(*Reader).Read(0x112077a0, {0x10fe4804, 0x1fc, 0x1fc})
	/boot/workdir/go/src/bufio/bufio.go:237 +0x228 fp=0x111c5e1c sp=0x111c5df8 pc=0xf965c
net/http.(*body).readLocked(0x11207800, {0x10fe4804, 0x1fc, 0x1fc})
	/boot/workdir/go/src/net/http/transfer.go:845 +0x4c fp=0x111c5e48 sp=0x111c5e1c pc=0x2d6c0c
net/http.(*body).Read(0x11207800, {0x10fe4804, 0x1fc, 0x1fc})
	/boot/workdir/go/src/net/http/transfer.go:837 +0xe8 fp=0x111c5e7c sp=0x111c5e48 pc=0x2d6b18
net/http.(*bodyEOFSignal).Read(0x11207830, {0x10fe4804, 0x1fc, 0x1fc})
	/boot/workdir/go/src/net/http/transport.go:2773 +0xc0 fp=0x111c5eb8 sp=0x111c5e7c pc=0x2e56d0
io.ReadAll({0x537110, 0x11207830})
	/boot/workdir/go/src/io/io.go:666 +0xe4 fp=0x111c5ef8 sp=0x111c5eb8 pc=0x949c0
net/http_test.testIdentityTransferEncoding(0x10f825a0, 0x0)
	/boot/workdir/go/src/net/http/clientserver_test.go:1611 +0x290 fp=0x111c5f8c sp=0x111c5ef8 pc=0x34c7f0
net/http_test.TestIdentityTransferEncoding_h1(0x10f825a0)
	/boot/workdir/go/src/net/http/clientserver_test.go:1586 +0x24 fp=0x111c5f98 sp=0x111c5f8c pc=0x34c51c
testing.tRunner(0x10f825a0, 0x4ae924)
	/boot/workdir/go/src/testing/testing.go:1446 +0x118 fp=0x111c5fe0 sp=0x111c5f98 pc=0xf3a28
testing.(*T).Run.func1()
	/boot/workdir/go/src/testing/testing.go:1493 +0x30 fp=0x111c5fec sp=0x111c5fe0 pc=0xf4880
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:824 +0x4 fp=0x111c5fec sp=0x111c5fec pc=0x6edb4
created by testing.(*T).Run
	/boot/workdir/go/src/testing/testing.go:1493 +0x3a0

…

goroutine 11972 [syscall, 17 minutes]:
syscall.Syscall(0xe, 0x11286498, 0x0, 0x0)
	/boot/workdir/go/src/syscall/asm_plan9_arm.s:16 +0x8 fp=0x1181bd38 sp=0x1181bca4 pc=0x7c810
syscall.open({0x11286480, 0x12}, 0x0)
	/boot/workdir/go/src/syscall/zsyscall_plan9_arm.go:61 +0x88 fp=0x1181bd6c sp=0x1181bd38 pc=0x7b83c
syscall.Open({0x11286480, 0x12}, 0x0)
	/boot/workdir/go/src/syscall/syscall_plan9.go:384 +0x64 fp=0x1181bd90 sp=0x1181bd6c pc=0x7b3f4
os.openFileNolog({0x11286480, 0x12}, 0x0, 0x0)
	/boot/workdir/go/src/os/file_plan9.go:118 +0xd8 fp=0x1181bdd0 sp=0x1181bd90 pc=0x9e6b8
os.OpenFile({0x11286480, 0x12}, 0x0, 0x0)
	/boot/workdir/go/src/os/file.go:337 +0x48 fp=0x1181bdf0 sp=0x1181bdd0 pc=0x9d944
os.Open(...)
	/boot/workdir/go/src/os/file.go:317
net.(*netFD).acceptPlan9(0x11112780)
	/boot/workdir/go/src/net/ipsock_plan9.go:262 +0x110 fp=0x1181beb8 sp=0x1181bdf0 pc=0x1f1818
net.(*TCPListener).accept(0x1118af70)
	/boot/workdir/go/src/net/tcpsock_plan9.go:48 +0x20 fp=0x1181bef4 sp=0x1181beb8 pc=0x1f9d08
net.(*TCPListener).Accept(0x1118af70)
	/boot/workdir/go/src/net/tcpsock.go:288 +0x3c fp=0x1181bf10 sp=0x1181bef4 pc=0x1f92a4
net/http.(*onceCloseListener).Accept(0x11119720)
	<autogenerated>:1 +0x34 fp=0x1181bf28 sp=0x1181bf10 pc=0x3115cc
net/http.(*Server).Serve(0x10c78ab0, {0x538bcc, 0x1118af70})
	/boot/workdir/go/src/net/http/server.go:3040 +0x344 fp=0x1181bfc4 sp=0x1181bf28 pc=0x2cc104
net/http/httptest.(*Server).goServe.func1()
	/boot/workdir/go/src/net/http/httptest/server.go:310 +0x74 fp=0x1181bfec sp=0x1181bfc4 pc=0x316f1c
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:824 +0x4 fp=0x1181bfec sp=0x1181bfec pc=0x6edb4
created by net/http/httptest.(*Server).goServe
	/boot/workdir/go/src/net/http/httptest/server.go:308 +0x74

(attn @millerresearch; CC @golang/plan9)
@bcmills bcmills added OS-Plan9 arch-arm Issues solely affecting the 32-bit arm architecture. labels May 13, 2022
@bcmills bcmills added this to the Backlog milestone May 13, 2022
@bcmills
Copy link
Contributor Author

bcmills commented May 13, 2022

greplogs -l -e 'goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open' --since=2022-01-01
2022-05-12T21:40:53-2136e15/plan9-arm
2022-05-01T00:24:25-aafffac-d09ca2c/plan9-386-0intro
2022-04-04T15:58:39-7d125fe-c8110c3/plan9-386-0intro
2022-02-17T17:37:03-fd59bdf-eaf0405/plan9-arm

@heschi heschi added the NeedsFix The path to resolution is known, but the work has not been done. label May 13, 2022
@bcmills bcmills added the NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one. label Dec 7, 2022
@gopherbot gopherbot removed the NeedsFix The path to resolution is known, but the work has not been done. label Dec 7, 2022
@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2022-12-01 18:03 plan9-arm go@2ca32a5b net/http (log) 
http.test 33514: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m29s)

goroutine 67293 [running]:
panic({0x44f4c0, 0xb6240a8})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x9ff8f80 sp=0x9ff8f24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2240 +0x398 fp=0x9ff8fec sp=0x9ff8f80 pc=0x10370c
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9ff8fec sp=0x9ff8fec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2022-12-08 15:23 plan9-arm go@0aad4d32 net/http (log) 
http.test 30800: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h2 (8m29s)

goroutine 67890 [running]:
panic({0x44fbc8, 0xbb8e030})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x9d82f80 sp=0x9d82f24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2240 +0x398 fp=0x9d82fec sp=0x9d82f80 pc=0x103930
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d82fec sp=0x9d82fec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2022-12-12 14:20 plan9-arm go@6b895d9e net/http (log) 
http.test 33158: warning: process exceeds 100 file descriptors
1 second passes in backend, proxygone= false
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m52s)
	TestServerWriteTimeout/h1 (8m10s)

goroutine 68537 [running]:
panic({0x44fbc8, 0xa552030})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x9e0ef80 sp=0x9e0ef24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2240 +0x398 fp=0x9e0efec sp=0x9e0ef80 pc=0x103930
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9e0efec sp=0x9e0efec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2022-12-27 21:10 plan9-arm go@e870de99 net/http (log) 
http.test 46421: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m31s)

goroutine 67581 [running]:
panic({0x44f9a8, 0xa6700e8})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x9d1ef80 sp=0x9d1ef24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x398 fp=0x9d1efec sp=0x9d1ef80 pc=0x103928
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d1efec sp=0x9d1efec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-03 18:53 plan9-arm go@d03231d9 net/http (log) 
http.test 33062: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (6m55s)
	TestServerWriteTimeout/h1 (6m32s)

goroutine 68559 [running]:
panic({0x44f9a8, 0x9236058})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x9576f80 sp=0x9576f24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x398 fp=0x9576fec sp=0x9576f80 pc=0x103928
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9576fec sp=0x9576fec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-01-18 01:53 plan9-arm go@d449c01d net/http (log) 
http.test 35553: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h2 (8m30s)

goroutine 67546 [running]:
panic({0x44f9a8, 0xad1c098})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x93adf80 sp=0x93adf24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x398 fp=0x93adfec sp=0x93adf80 pc=0x103928
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x93adfec sp=0x93adfec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-19 20:46 plan9-arm go@2f8f5172 net/http (log) 
http.test 35907: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m33s)

goroutine 70184 [running]:
panic({0x44f228, 0xbab8050})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x9dd7f80 sp=0x9dd7f24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x398 fp=0x9dd7fec sp=0x9dd7f80 pc=0x1031a8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9dd7fec sp=0x9dd7fec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-20 01:31 plan9-arm go@cf9adf4a net/http (log) 
http.test 35686: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m31s)

goroutine 67155 [running]:
panic({0x455628, 0xb664040})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x945ff80 sp=0x945ff20 pc=0x3f114
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x945ffec sp=0x945ff80 pc=0x1085ac
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x945ffec sp=0x945ffec pc=0x75c68
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-20 18:13 plan9-arm go@5724daa6 net/http.TestWriteHeaderNoCodeCheck (log) 
http.test 35651: warning: process exceeds 100 file descriptors
--- FAIL: TestWriteHeaderNoCodeCheck (0.00s)
    --- FAIL: TestWriteHeaderNoCodeCheck/h1 (0.61s)
        clientserver_test.go:1533: Get "https://127.0.0.1:39903": EOF
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h2 (8m35s)

goroutine 68418 [running]:
panic({0x45a650, 0xba44040})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x93b1f80 sp=0x93b1f20 pc=0x3f33c
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x93b1fec sp=0x93b1f80 pc=0x1088d0
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x93b1fec sp=0x93b1fec pc=0x76038
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-24 12:05 plan9-arm go@cf9263de net/http (log) 
http.test 35739: warning: process exceeds 100 file descriptors
http.test 35778: warning: process exceeds 200 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m51s)

goroutine 68966 [running]:
panic({0x456aa0, 0xa236050})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x93b9f80 sp=0x93b9f20 pc=0x3e154
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x93b9fec sp=0x93b9f80 pc=0x106e38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x93b9fec sp=0x93b9fec pc=0x74c50
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-24 13:28 plan9-arm go@733ba921 net/http (log) 
http.test 35586: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m50s)
	TestServerWriteTimeout/h2 (8m12s)

goroutine 69065 [running]:
panic({0x456aa0, 0xa12a058})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9414f80 sp=0x9414f20 pc=0x3e154
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x9414fec sp=0x9414f80 pc=0x106e38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9414fec sp=0x9414fec pc=0x74c50
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-24 17:00 plan9-arm go@dc9d219c net/http (log) 
http.test 35960: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m29s)

goroutine 68162 [running]:
panic({0x456aa0, 0xa124090})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9306f80 sp=0x9306f20 pc=0x3e154
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x9306fec sp=0x9306f80 pc=0x106e38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9306fec sp=0x9306fec pc=0x74c50
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-24 17:50 plan9-arm go@8c37d486 net/http (log) 
http.test 35588: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h2 (8m17s)

goroutine 71224 [running]:
panic({0x456aa0, 0xa1c4030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9dadf80 sp=0x9dadf20 pc=0x3e154
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x9dadfec sp=0x9dadf80 pc=0x106e38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9dadfec sp=0x9dadfec pc=0x74c50
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-24 22:38 plan9-arm go@91c1c592 net/http (log) 
http.test 35638: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m45s)

goroutine 68276 [running]:
panic({0x456aa0, 0xba60030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0xa108f80 sp=0xa108f20 pc=0x3e154
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0xa108fec sp=0xa108f80 pc=0x106e38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0xa108fec sp=0xa108fec pc=0x74c50
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-01-26 23:30 plan9-arm go@8e0781e5 net/http (log) 
http.test 35585: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m52s)
	TestServerWriteTimeout/h1 (8m42s)

goroutine 68037 [running]:
panic({0x4571e0, 0xaa92118})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9d06f80 sp=0x9d06f20 pc=0x3e150
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x9d06fec sp=0x9d06f80 pc=0x106e30
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d06fec sp=0x9d06fec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-30 18:10 plan9-arm go@dbfdc446 net/http (log) 
http.test 33854: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m22s)

goroutine 68057 [running]:
panic({0x44fd58, 0xa9e6048})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9d43f80 sp=0x9d43f20 pc=0x3e150
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x9d43fec sp=0x9d43f80 pc=0x106e30
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d43fec sp=0x9d43fec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-30 19:26 plan9-arm go@57f9ed5f net/http (log) 
http.test 28913: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m23s)

goroutine 67419 [running]:
panic({0x44fd58, 0xb6f8030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x967af80 sp=0x967af20 pc=0x3e150
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x967afec sp=0x967af80 pc=0x106e30
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x967afec sp=0x967afec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-31 17:38 plan9-arm go@adc1db23 net/http (log) 
http.test 31233: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m46s)
	TestServerWriteTimeout/h2 (8m14s)

goroutine 68532 [running]:
panic({0x44fd58, 0xb5aa030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x942df80 sp=0x942df20 pc=0x3e150
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x942dfec sp=0x942df80 pc=0x106e30
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x942dfec sp=0x942dfec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-31 18:09 plan9-arm go@00e7fdc0 net/http (log) 
http.test 23181: warning: process exceeds 100 file descriptors
http.test 23219: warning: process exceeds 200 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m39s)

goroutine 67626 [running]:
panic({0x44fae0, 0xa926358})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x920bf80 sp=0x920bf20 pc=0x3e150
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x920bfec sp=0x920bf80 pc=0x106de0
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x920bfec sp=0x920bfec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-01-31 20:33 plan9-arm go@f36c7c59 net/http (log) 
http.test 31133: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m52s)
	TestServerWriteTimeout/h2 (8m10s)

goroutine 68268 [running]:
panic({0x44fae0, 0xab52030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9174f80 sp=0x9174f20 pc=0x3e150
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0x9174fec sp=0x9174f80 pc=0x106de0
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9174fec sp=0x9174fec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-01 15:42 plan9-arm go@38d1a666 net/http (log) 
http.test 31142: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m45s)

goroutine 67729 [running]:
panic({0x44f580, 0x9e7a090})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0xa563f80 sp=0xa563f20 pc=0x3e21c
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x3a4 fp=0xa563fec sp=0xa563f80 pc=0x106ebc
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0xa563fec sp=0xa563fec pc=0x74d14
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-01 21:30 plan9-arm go@4b7f7eef net/http (log) 
http.test 31389: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m45s)

goroutine 67395 [running]:
panic({0x44eb90, 0xb3e8030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9487f80 sp=0x9487f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9487fec sp=0x9487f80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9487fec sp=0x9487fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-01 21:30 plan9-arm go@bd749504 net/http (log) 
http.test 30983: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m51s)

goroutine 67384 [running]:
panic({0x44eb90, 0xb4ca030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x96f8f80 sp=0x96f8f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x96f8fec sp=0x96f8f80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x96f8fec sp=0x96f8fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-02 15:35 plan9-arm go@3c529c53 net/http (log) 
http.test 31002: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m45s)

goroutine 66662 [running]:
panic({0x44eb90, 0x93000c0})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x96f2f80 sp=0x96f2f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x96f2fec sp=0x96f2f80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x96f2fec sp=0x96f2fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-02 15:37 plan9-arm go@3693fd25 net/http (log) 
http.test 31442: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m26s)
	TestServerWriteTimeout/h2 (8m25s)

goroutine 68217 [running]:
panic({0x44ed08, 0x96e60d8})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x92f1f80 sp=0x92f1f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x92f1fec sp=0x92f1f80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x92f1fec sp=0x92f1fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-02-02 23:40 plan9-arm go@93f5335b net/http (log) 
http.test 21849: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m25s)
	TestServerWriteTimeout/h2 (8m24s)

goroutine 68206 [running]:
panic({0x44ed18, 0x95ea070})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9201f80 sp=0x9201f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9201fec sp=0x9201f80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9201fec sp=0x9201fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-03 04:37 plan9-arm go@9222a01e net/http (log) 
http.test 21490: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m50s)
	TestServerWriteTimeout/h1 (8m13s)

goroutine 68780 [running]:
panic({0x44ed18, 0xa2b4088})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x929ff80 sp=0x929ff20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x929ffec sp=0x929ff80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x929ffec sp=0x929ffec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-02-03 16:52 plan9-arm go@10643b74 net/http (log) 
http.test 29825: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h2 (8m23s)

goroutine 69080 [running]:
panic({0x44ed18, 0xadd6030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9269f80 sp=0x9269f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9269fec sp=0x9269f80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9269fec sp=0x9269fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-02-04 07:03 plan9-arm go@25f5d9d4 net/http (log) 
http.test 30154: warning: process exceeds 100 file descriptors
http.test 30175: warning: process exceeds 200 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h2 (8m35s)

goroutine 67976 [running]:
panic({0x44ed68, 0x9edc228})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x96f7f80 sp=0x96f7f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x96f7fec sp=0x96f7f80 pc=0x106a68
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x96f7fec sp=0x96f7fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-02-07 20:09 plan9-arm go@d939b371 net/http (log) 
http.test 30124: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h2 (8m46s)

goroutine 67046 [running]:
panic({0x44d770, 0x919c090})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x95dbf80 sp=0x95dbf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x95dbfec sp=0x95dbf80 pc=0x106350
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x95dbfec sp=0x95dbfec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-02-08 20:36 plan9-arm go@9d81ccbf net/http (log) 
http.test 29826: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m37s)

goroutine 68903 [running]:
panic({0x44da48, 0xab44030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9d7bf80 sp=0x9d7bf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9d7bfec sp=0x9d7bf80 pc=0x106640
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d7bfec sp=0x9d7bfec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-08 23:52 plan9-arm go@910f041f net/http (log) 
http.test 30175: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h1 (8m24s)

goroutine 67518 [running]:
panic({0x44da48, 0xa402030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9d2cf80 sp=0x9d2cf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9d2cfec sp=0x9d2cf80 pc=0x106640
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d2cfec sp=0x9d2cfec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-02-02 16:40 plan9-arm go@18772915 net/http (log) 
http.test 31061: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m45s)

goroutine 66945 [running]:
panic({0x44ed08, 0x9daa030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9d57f80 sp=0x9d57f20 pc=0x3e210
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9d57fec sp=0x9d57f80 pc=0x106ca8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d57fec sp=0x9d57fec pc=0x74c18
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-06 22:13 plan9-arm go@02d8ebda net/http (log) 
http.test 30297: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m32s)

goroutine 67644 [running]:
panic({0x44d770, 0xab18048})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x95fbf80 sp=0x95fbf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x95fbfec sp=0x95fbf80 pc=0x106350
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x95fbfec sp=0x95fbfec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-08 18:18 plan9-arm go@cdc65b83 net/http (log) 
http.test 30210: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m29s)

goroutine 67185 [running]:
panic({0x44da48, 0xb1640d8})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x94abf80 sp=0x94abf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x94abfec sp=0x94abf80 pc=0x106640
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x94abfec sp=0x94abfec pc=0x74c48
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-10 14:29 plan9-arm go@48f47282 net/http (log) 
http.test 31597: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m39s)

goroutine 68026 [running]:
panic({0x454230, 0xa2100c0})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x96bdf80 sp=0x96bdf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x96bdfec sp=0x96bdf80 pc=0x107934
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x96bdfec sp=0x96bdfec pc=0x74c84
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-10 16:53 plan9-arm go@2b807e1d net/http (log) 
http.test 29921: warning: process exceeds 100 file descriptors
http.test 29921: warning: process exceeds 200 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m32s)

goroutine 67497 [running]:
panic({0x4541f0, 0xb592078})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x970ef80 sp=0x970ef20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x970efec sp=0x970ef80 pc=0x107c38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x970efec sp=0x970efec pc=0x74c84
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-10 17:29 plan9-arm go@aa5b2255 net/http (log) 
http.test 29972: warning: process exceeds 100 file descriptors
http.test 29978: warning: process exceeds 200 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m46s)

goroutine 67317 [running]:
panic({0x4541f0, 0xaa0e0e8})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9d6ef80 sp=0x9d6ef20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9d6efec sp=0x9d6ef80 pc=0x107c38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d6efec sp=0x9d6efec pc=0x74c84
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-10 19:03 plan9-arm go@7180a097 net/http (log) 
http.test 29946: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m46s)
	TestServerWriteTimeout/h2 (8m46s)

goroutine 68439 [running]:
panic({0x454328, 0xbe5a138})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x94a0f80 sp=0x94a0f20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x94a0fec sp=0x94a0f80 pc=0x107c38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x94a0fec sp=0x94a0fec pc=0x74c84
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-13 21:28 plan9-arm go@93f10b88 net/http (log) 
http.test 29957: warning: process exceeds 100 file descriptors
2023/02/14 00:28:15 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestHeadResponses (8m54s)
	TestHeadResponses/h2 (8m33s)

goroutine 69019 [running]:
panic({0x4545e0, 0x9fa2030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0xb2dcf80 sp=0xb2dcf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0xb2dcfec sp=0xb2dcf80 pc=0x107c38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0xb2dcfec sp=0xb2dcfec pc=0x74c84
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-14 16:24 plan9-arm go@b146d762 net/http (log) 
http.test 31778: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m31s)

goroutine 68714 [running]:
panic({0x4545e0, 0x9d3c040})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9d1bf80 sp=0x9d1bf20 pc=0x3e214
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9d1bfec sp=0x9d1bf80 pc=0x107c38
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9d1bfec sp=0x9d1bfec pc=0x74c84
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-15 15:41 plan9-arm go@40ed3591 net/http (log) 
http.test 35892: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m45s)

goroutine 67565 [running]:
panic({0x455e60, 0x95a2060})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9e2bf80 sp=0x9e2bf20 pc=0x3e254
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9e2bfec sp=0x9e2bf80 pc=0x107c00
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9e2bfec sp=0x9e2bfec pc=0x74cbc
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-15 22:00 plan9-arm go@ed370d87 net/http (log) 
http.test 29900: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m28s)

goroutine 68764 [running]:
panic({0x455e60, 0xa1b8068})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9a49f80 sp=0x9a49f20 pc=0x3e254
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9a49fec sp=0x9a49f80 pc=0x107c00
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9a49fec sp=0x9a49fec pc=0x74cbc
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-15 22:27 plan9-arm go@87366feb net/http (log) 
http.test 29939: warning: process exceeds 100 file descriptors
http.test 29963: warning: process exceeds 200 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m46s)

goroutine 68014 [running]:
panic({0x455e60, 0xa2a00e8})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9626f80 sp=0x9626f20 pc=0x3e254
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9626fec sp=0x9626f80 pc=0x107c00
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9626fec sp=0x9626fec pc=0x74cbc
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-15 23:00 plan9-arm go@0e426323 net/http (log) 
http.test 29922: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h2 (8m45s)

goroutine 67291 [running]:
panic({0x455e60, 0x9cca030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x92cef80 sp=0x92cef20 pc=0x3e254
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x92cefec sp=0x92cef80 pc=0x107c00
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x92cefec sp=0x92cefec pc=0x74cbc
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-16 02:02 plan9-arm go@518889b3 net/http (log) 
http.test 29870: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h1 (8m29s)
	TestServerWriteTimeout/h2 (8m29s)

goroutine 68492 [running]:
panic({0x455040, 0xa47c080})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x936ff80 sp=0x936ff20 pc=0x3d5d4
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x936ffec sp=0x936ff80 pc=0x106e94
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x936ffec sp=0x936ffec pc=0x73fc4
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-17 03:58 plan9-arm go@95be547e net/http (log) 
http.test 30067: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m52s)
	TestServerWriteTimeout/h2 (8m29s)

goroutine 68919 [running]:
panic({0x455040, 0xb2fc068})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x470 fp=0x9374f80 sp=0x9374f20 pc=0x3d5d4
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9374fec sp=0x9374f80 pc=0x106e94
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9374fec sp=0x9374fec pc=0x73fc4
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-19 23:51 plan9-arm go@2baf8ad8 net/http (log) 
http.test 45668: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m51s)
	TestServerWriteTimeout/h1 (8m18s)

goroutine 69285 [running]:
panic({0x452aa8, 0x9226060})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x938cf80 sp=0x938cf20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x938cfec sp=0x938cf80 pc=0x106160
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x938cfec sp=0x938cfec pc=0x73be0
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-21 23:33 plan9-arm go@feb355c4 net/http (log) 
http.test 29950: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h2 (8m28s)

goroutine 69312 [running]:
panic({0x452b40, 0x95b8030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x9222f80 sp=0x9222f20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9222fec sp=0x9222f80 pc=0x1061f4
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9222fec sp=0x9222fec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-22 16:11 plan9-arm go@c17f8057 net/http (log) 
http.test 29959: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m31s)

goroutine 68750 [running]:
panic({0x452b40, 0xb2e4030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x9651f80 sp=0x9651f20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x39c fp=0x9651fec sp=0x9651f80 pc=0x1061f4
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9651fec sp=0x9651fec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-22 16:42 plan9-arm go@81316ff5 net/http (log) 
http.test 29915: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h2 (8m46s)

goroutine 67879 [running]:
panic({0x452bc8, 0xb4da108})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x90ebf80 sp=0x90ebf20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x90ebfec sp=0x90ebf80 pc=0x106278
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x90ebfec sp=0x90ebfec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-22 21:35 plan9-arm go@521d2614 net/http (log) 
http.test 29854: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m27s)

goroutine 68248 [running]:
panic({0x452648, 0xbca4030})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x91eaf80 sp=0x91eaf20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x91eafec sp=0x91eaf80 pc=0x106278
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x91eafec sp=0x91eafec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-23 06:10 plan9-arm go@f07fafac net/http (log) 
http.test 29879: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m48s)

goroutine 68793 [running]:
panic({0x452648, 0xa06c0a0})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x9424f80 sp=0x9424f20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x9424fec sp=0x9424f80 pc=0x106278
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9424fec sp=0x9424fec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-23 11:28 plan9-arm go@4c5d6ede net/http (log) 
http.test 29929: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m24s)

goroutine 66682 [running]:
panic({0x452648, 0xbb96040})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x91e5f80 sp=0x91e5f20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x91e5fec sp=0x91e5f80 pc=0x106278
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x91e5fec sp=0x91e5fec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-02-23 17:50 plan9-arm go@612c00bf net/http (log) 
http.test 30276: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m51s)
	TestServerWriteTimeout/h1 (8m18s)
	TestServerWriteTimeout/h2 (8m18s)

goroutine 67223 [running]:
panic({0x452648, 0xa0d4108})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x9312f80 sp=0x9312f20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x9312fec sp=0x9312f80 pc=0x106278
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9312fec sp=0x9312fec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-23 18:57 plan9-arm go@ebe49f98 net/http (log) 
http.test 30011: warning: process exceeds 100 file descriptors
http.test 30041: warning: process exceeds 200 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m46s)

goroutine 67825 [running]:
panic({0x452648, 0xa1d00e8})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x450 fp=0x9607f80 sp=0x9607f20 pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x9607fec sp=0x9607f80 pc=0x106278
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9607fec sp=0x9607fec pc=0x73c74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-24 17:53 plan9-arm go@e7c7f332 net/http (log) 
http.test 29864: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m30s)

goroutine 68627 [running]:
panic({0x456a60, 0xa4a0180})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x434 fp=0x9698f80 sp=0x9698f2c pc=0x3d440
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x9698fec sp=0x9698f80 pc=0x107838
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9698fec sp=0x9698fec pc=0x73ec0
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-24 19:00 plan9-arm go@21ff6704 net/http (log) 
http.test 29893: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h2 (8m28s)

goroutine 68216 [running]:
panic({0x4572e0, 0x9250070})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x434 fp=0x9c6bf80 sp=0x9c6bf2c pc=0x3d440
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x9c6bfec sp=0x9c6bf80 pc=0x107838
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9c6bfec sp=0x9c6bfec pc=0x73ec0
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-27 11:58 plan9-arm go@ac27b4dd net/http (log) 
http.test 21671: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h2 (8m24s)

goroutine 67497 [running]:
panic({0x457bd8, 0x91f00a8})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x434 fp=0x9342f80 sp=0x9342f2c pc=0x3d440
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x9342fec sp=0x9342f80 pc=0x10774c
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9342fec sp=0x9342fec pc=0x73f74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-27 14:40 plan9-arm go@5e4e2acc net/http (log) 
http.test 21621: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m54s)
	TestServerWriteTimeout/h1 (8m34s)

goroutine 66735 [running]:
panic({0x457bd8, 0x90f80f8})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x434 fp=0x946cf80 sp=0x946cf2c pc=0x3d440
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x946cfec sp=0x946cf80 pc=0x10774c
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x946cfec sp=0x946cfec pc=0x73f74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c
2023-02-27 17:29 plan9-arm go@cb3e170a net/http (log) 
http.test 29900: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h2 (8m32s)

goroutine 68234 [running]:
panic({0x457e88, 0xa5f2070})
	/boot/workdir/go/src/runtime/panic.go:1015 +0x434 fp=0x92f9f80 sp=0x92f9f2c pc=0x3d440
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2244 +0x39c fp=0x92f9fec sp=0x92f9f80 pc=0x107ac8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x92f9fec sp=0x92f9fec pc=0x73f74
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-01-17 23:10 plan9-arm go@8a27154b net/http (log) 
http.test 28533: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m53s)
	TestServerWriteTimeout/h1 (8m17s)

goroutine 68047 [running]:
panic({0x44f9a8, 0x9f4e030})
	/boot/workdir/go/src/runtime/panic.go:987 +0x414 fp=0x9da3f80 sp=0x9da3f24 pc=0x3c108
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2241 +0x398 fp=0x9da3fec sp=0x9da3f80 pc=0x103928
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:831 +0x4 fp=0x9da3fec sp=0x9da3fec pc=0x7113c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@rsc rsc mentioned this issue Mar 15, 2023
Closed
@millerresearch
Copy link
Contributor

All the logs from this year are TestServerWriteTimeout deadlocks (duplicate of #57114), fixed by CL 470215.

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-03-27 19:33 plan9-arm go@524f820b net/http (log) 
http.test 30047: warning: process exceeds 100 file descriptors
2023/03/27 21:42:58 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestResponseControllerSetFutureWriteDeadline (8m54s)
	TestResponseControllerSetFutureWriteDeadline/h2 (8m27s)

goroutine 68881 [running]:
panic({0x458820, 0xa38e0b8})
	/boot/workdir/go/src/runtime/panic.go:1016 +0x434 fp=0x9cdbf80 sp=0x9cdbf2c pc=0x3d3b8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2260 +0x39c fp=0x9cdbfec sp=0x9cdbf80 pc=0x107ab4
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x9cdbfec sp=0x9cdbfec pc=0x73130
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot gopherbot reopened this Mar 27, 2023
@millerresearch
Copy link
Contributor

This should not have been reopened: the deadlock situation in the log caught by watchflakes is different from the ones seen in this issue (no I/O or deadlock cancellation is going on). I've opened a new issue #59306 for this deadlock.

@gopherbot gopherbot reopened this Apr 4, 2023
@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-04-04 16:46 plan9-arm go@66ae75ff net/http (log) 
http.test 30441: warning: process exceeds 100 file descriptors
2023/04/04 18:28:51 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestTLSHandshakeTimeout (8m55s)
	TestTLSHandshakeTimeout/https1 (8m43s)

goroutine 69170 [running]:
panic({0x458b68, 0xa99e340})
	/boot/workdir/go/src/runtime/panic.go:1016 +0x434 fp=0x90e6f80 sp=0x90e6f2c pc=0x3d2a8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2260 +0x3ac fp=0x90e6fec sp=0x90e6f80 pc=0x107ab0
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x90e6fec sp=0x90e6fec pc=0x7338c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-05-03 17:05 plan9-arm go@57cb4720 net/http (log) 
http.test 30690: warning: process exceeds 100 file descriptors
2023/05/03 19:27:29 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestTransportConnectionCloseOnRequestDisableKeepAlive (8m56s)
	TestTransportConnectionCloseOnRequestDisableKeepAlive/h1 (8m51s)

goroutine 68140 [running]:
panic({0x454c18, 0xa302080})
	/boot/workdir/go/src/runtime/panic.go:1017 +0x434 fp=0x95b3f80 sp=0x95b3f2c pc=0x3dec0
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x95b3fec sp=0x95b3f80 pc=0x107ab8
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x95b3fec sp=0x95b3fec pc=0x74258
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-05-19 01:37 plan9-arm go@408f7a46 net/http (log) 
http.test 31036: warning: process exceeds 100 file descriptors
2023/05/19 06:16:02 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestServerWriteTimeout (8m55s)
	TestServerWriteTimeout/h1 (8m38s)

goroutine 67803 [running]:
panic({0x467e00, 0xa284068})
	/boot/workdir/go/src/runtime/panic.go:1017 +0x434 fp=0x92b0f80 sp=0x92b0f2c pc=0x3f870
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x92b0fec sp=0x92b0f80 pc=0x10c17c
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x92b0fec sp=0x92b0fec pc=0x765c8
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Change https://go.dev/cl/496137 mentions this issue: internal/poll: handle SetDeadline to time.Now() in Plan 9

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-06-01 17:35 plan9-arm go@73a29bad net/http (log) 
http.test 33741: warning: process exceeds 100 file descriptors
2023/06/01 20:01:54 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestClientTimeout_Headers (8m54s)
	TestClientTimeout_Headers/h1 (8m33s)

goroutine 67591 [running]:
panic({0x471c60, 0xa2ee030})
	/boot/workdir/go/src/runtime/panic.go:1017 +0x434 fp=0x9dbdf80 sp=0x9dbdf2c pc=0x3fcd0
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x9dbdfec sp=0x9dbdf80 pc=0x10d09c
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x9dbdfec sp=0x9dbdfec pc=0x76e08
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot gopherbot reopened this Jun 1, 2023
@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-06-13 16:14 plan9-arm go@886fba58 net/http (log) 
http.test 34234: warning: process exceeds 100 file descriptors
2023/06/13 18:09:39 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestHeadResponses (8m51s)
	TestHeadResponses/h2 (8m30s)

goroutine 68235 [running]:
panic({0x472c18, 0x9aba0b8})
	/boot/workdir/go/src/runtime/panic.go:1017 +0x434 fp=0x98c9f80 sp=0x98c9f2c pc=0x3ff3c
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x98c9fec sp=0x98c9f80 pc=0x10d674
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x98c9fec sp=0x98c9fec pc=0x77340
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:176 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-07-27 19:06 plan9-arm go@f55e7e10 net/http (log) 
http.test 35933: warning: process exceeds 100 file descriptors
2023/07/27 21:09:16 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestRedirectCookiesJar (8m54s)
	TestRedirectCookiesJar/h2 (8m29s)

goroutine 67598 [running]:
panic({0x474648, 0xbdb0030})
	/boot/workdir/go/src/runtime/panic.go:1017 +0x434 fp=0x93f3f80 sp=0x93f3f2c pc=0x400c8
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x93f3fec sp=0x93f3f80 pc=0x110644
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x93f3fec sp=0x93f3fec pc=0x772d4
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:177 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-07-31 18:36 plan9-arm go@17d67ed0 net/http (log) 
http.test 23009: warning: process exceeds 100 file descriptors
2023/08/01 00:14:01 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestTrailersServerToClient (8m56s)
	TestTrailersServerToClient/h1 (8m38s)

goroutine 68499 [running]:
panic({0x473538, 0x923c0a8})
	/boot/workdir/go/src/runtime/panic.go:621 +0x12c fp=0x9e51f80 sp=0x9e51f28 pc=0x3f250
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x9e51fec sp=0x9e51f80 pc=0x10fac0
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x9e51fec sp=0x9e51fec pc=0x76a90
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:177 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-08-02 17:14 plan9-arm go@a915b999 net/http (log) 
http.test 35795: warning: process exceeds 100 file descriptors
2023/08/02 19:09:06 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestResponseControllerSetFutureWriteDeadline (8m54s)
	TestResponseControllerSetFutureWriteDeadline/h1 (8m37s)

goroutine 68621 [running]:
panic({0x473940, 0x9f380b0})
	/boot/workdir/go/src/runtime/panic.go:621 +0x12c fp=0x9285f80 sp=0x9285f28 pc=0x3f250
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x9285fec sp=0x9285f80 pc=0x10faec
runtime.goexit()
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x9285fec sp=0x9285fec pc=0x76a90
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:177 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-09-12 17:45 plan9-arm go@36024659 net/http (log) 
http.test 35727: warning: process exceeds 100 file descriptors
panic: test timed out after 9m0s
running tests:
	TestResponseControllerSetPastReadDeadline (8m56s)
	TestResponseControllerSetPastReadDeadline/h2 (8m39s)

goroutine 56641 [running]:
panic({0x47b238, 0xad18060})
	/boot/workdir/go/src/runtime/panic.go:774 +0x12c fp=0x96b8f80 sp=0x96b8f2c pc=0x3f860
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2259 +0x3ac fp=0x96b8fec sp=0x96b8f80 pc=0x10fa20
runtime.goexit({})
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x96b8fec sp=0x96b8fec pc=0x77168
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:177 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-09-13 21:00 plan9-arm go@399b2a4b net/http (log) 
http.test 35917: warning: process exceeds 100 file descriptors
2023/09/14 02:22:19 httptest.Server blocked in Close after 5 seconds, waiting for connections:
panic: test timed out after 9m0s
running tests:
	TestNoPanicOnRoundTripWithBasicAuth (8m53s)
	TestNoPanicOnRoundTripWithBasicAuth/h1 (8m35s)

goroutine 56978 [running]:
panic({0x483398, 0xa6e0030})
	/boot/workdir/go/src/runtime/panic.go:774 +0x12c fp=0x9d7ef80 sp=0x9d7ef2c pc=0x3f860
testing.(*M).startAlarm.func1()
	/boot/workdir/go/src/testing/testing.go:2257 +0x3ac fp=0x9d7efec sp=0x9d7ef80 pc=0x10ff30
runtime.goexit({})
	/boot/workdir/go/src/runtime/asm_arm.s:859 +0x4 fp=0x9d7efec sp=0x9d7efec pc=0x7701c
created by time.goFunc
	/boot/workdir/go/src/time/sleep.go:177 +0x2c

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- builder ~ `^plan9` && `goroutine \d+ \[syscall, \d+ minutes\]:\n(.+\n\t.+\n)*syscall\.Open`
2023-10-26 07:37 plan9-arm go@5fe20359 net/http.TestHandlerPanicNil (log) 
panic: test timed out after 9m0s
running tests:
	TestHandlerPanicNil (8m58s)
	TestHandlerPanicNil/h1 (8m58s)

runtime.gopark(0x521ae0, 0x90fe870, 0xe, 0x17, 0x2)
	/boot/workdir/go/src/runtime/proc.go:400 +0x104 fp=0x94dde70 sp=0x94dde5c pc=0x433dc
runtime.chanrecv(0x90fe840, 0x94ddee7, 0x1)
	/boot/workdir/go/src/runtime/chan.go:583 +0x4a8 fp=0x94ddeac sp=0x94dde70 pc=0x65ac
runtime.chanrecv1(0x90fe840, 0x94ddee7)
	/boot/workdir/go/src/runtime/chan.go:442 +0x20 fp=0x94ddec0 sp=0x94ddeac pc=0x60d4
testing.(*T).Run(0x948e400, {0x4e7ad3, 0x2}, 0x92874a0)
	/boot/workdir/go/src/testing/testing.go:1736 +0x3e4 fp=0x94ddf24 sp=0x94ddec0 pc=0x10c37c
net/http_test.run[...](0x948e400, 0x5212fc, {0x94ddf8c, 0x1, 0x1})
	/boot/workdir/go/src/net/http/clientserver_test.go:82 +0x238 fp=0x94ddf70 sp=0x94ddf24 pc=0x459cd0
net/http_test.TestHandlerPanicNil(0x948e400)
	/boot/workdir/go/src/net/http/serve_test.go:2740 +0x60 fp=0x94ddf94 sp=0x94ddf70 pc=0x3df4c0
testing.tRunner(0x948e400, 0x520a4c)

— watchflakes

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
arch-arm Issues solely affecting the 32-bit arm architecture. NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one. OS-Plan9
Projects
Test Flakes
Status: Done
Milestone
Backlog
Development

No branches or pull requests
4 participants
@bcmills @gopherbot @millerresearch @heschi