runtime: flaky failures on NetBSD since CL 526118

golang / go

The Go programming language

https://go.dev

BSD 3-Clause "New" or "Revised" License

124.31k stars 17.7k forks source link

runtime: flaky failures on NetBSD since CL 526118 #62524

Open cherrymui opened 1 year ago

cherrymui commented 1 year ago

#!watchflakes
post <- goos == "netbsd" && pkg == "runtime" && date > "2023-08-01"

On the build dashboard, the NetBSD ports start to become very flaky since CL https://go.dev/cl/526118. The failures are usually related to tests that are specific to OS threads. So the CL could be related. Filing an issue to investigate.

cc @prattmic @golang/netbsd @golang/runtime

gopherbot commented 1 year ago

Found new dashboard test flakes for:

#!watchflakes
post <- goos == "netbsd" && pkg == "runtime"

2023-07-31 17:13 netbsd-386-9_3 go@4a14d9c9 runtime.TestSelectFairness (log)

--- FAIL: TestSelectFairness (0.02s) chan_test.go:488: 4742 5258 0.4742 0.02579999999999999 chan_test.go:490: unfair select: in 10000 trials, results were 4742, 5258

2023-08-03 15:59 netbsd-arm-bsiegert go@e4aec1fa runtime.TestDeferLiveness (log)

panic: test timed out after 30m0s running tests: TestDeferLiveness (27m39s) syscall.Syscall6(0x1e1, 0x1, 0x2be3, 0x842de4, 0x10020, 0x0, 0x0) /var/gobuilder/buildlet/go/src/syscall/asm_netbsd_arm.s:39 +0x8 fp=0x842db8 sp=0x842db4 pc=0xa90d0 os.wait6(0x1, 0x2be3, 0x10020) /var/gobuilder/buildlet/go/src/os/wait6_netbsd.go:16 +0x58 fp=0x842dec sp=0x842db8 pc=0xd34e0 os.(*Process).blockUntilWaitable(0x8205a0) /var/gobuilder/buildlet/go/src/os/wait_wait6.go:20 +0x30 fp=0x842e08 sp=0x842dec pc=0xd3530 os.(*Process).wait(0x8205a0) /var/gobuilder/buildlet/go/src/os/exec_unix.go:22 +0x2c fp=0x842e44 sp=0x842e08 pc=0xcd670 os.(*Process).Wait(...) /var/gobuilder/buildlet/go/src/os/exec.go:134 os/exec.(*Cmd).Wait(0x1786000) /var/gobuilder/buildlet/go/src/os/exec/exec.go:862 +0x38 fp=0x842e7c sp=0x842e44 pc=0x165e20 os/exec.(*Cmd).Run(0x1786000) /var/gobuilder/buildlet/go/src/os/exec/exec.go:590 +0x48 fp=0x842e8c sp=0x842e7c pc=0x164b24 os/exec.(*Cmd).CombinedOutput(0x1786000) /var/gobuilder/buildlet/go/src/os/exec/exec.go:977 +0xa0 fp=0x842ea0 sp=0x842e8c pc=0x166750 runtime_test.runBuiltTestProg(0x97e2d0, {0x1aaba40, 0x3b}, {0x465433, 0xd}, {0x128df8c, 0x1, 0x1}) /var/gobuilder/buildlet/go/src/runtime/crash_test.go:76 +0x2a8 fp=0x842f1c sp=0x842ea0 pc=0x31ebd4 runtime_test.runTestProg(0x97e2d0, {0x4622ca, 0x8}, {0x465433, 0xd}, {0x128df8c, 0x1, 0x1}) /var/gobuilder/buildlet/go/src/runtime/crash_test.go:59 +0x168 fp=0x842f58 sp=0x842f1c pc=0x31e8f8 runtime_test.TestDeferLiveness(0x97e2d0) /var/gobuilder/buildlet/go/src/runtime/stack_test.go:868 +0x70 fp=0x842f94 sp=0x842f58 pc=0x3afbcc testing.tRunner(0x97e2d0, 0x48c438)

2023-08-22 02:47 netbsd-amd64-9_3 go@b291538d runtime.TestCgoExecSignalMask (log)

--- FAIL: TestCgoExecSignalMask (139.11s) exec.go:190: test timed out while running command: /tmp/workdir/tmp/go-build3391162740/testprogcgo.exe CgoExecSignalMask crash_cgo_test.go:141: /tmp/workdir/tmp/go-build3391162740/testprogcgo.exe CgoExecSignalMask: exit status 2 crash_cgo_test.go:144: expected "OK\n", got SIGQUIT: quit PC=0x46ef23 m=13 sigcode=0 rax 0x4 rbx 0x0 rcx 0x46ef23 rdx 0x0 rdi 0x3 rsi 0x0 rbp 0x783f437efd08 rsp 0x783f437efcb0 r8 0xc0002244d0 r9 0x0 r10 0x0 r11 0x202 r12 0xe r13 0x1 r14 0xc0002044e0 r15 0x1 rip 0x46ef23 rflags 0x203 cs 0x47 fs 0x0 gs 0x0

2023-08-25 21:04 netbsd-arm-bsiegert go@789b3f84 runtime.TestSegv (log)

--- FAIL: TestSegv (0.00s) --- FAIL: TestSegv/SegvInCgo (0.03s) crash_cgo_test.go:655: /var/gobuilder/buildlet/tmp/go-build1238234895/testprogcgo.exe SegvInCgo (28.856047ms): ok crash_cgo_test.go:656: crash_cgo_test.go:662: did not see "SIGSEGV" in output

2023-08-29 23:22 netbsd-386-9_3 go@1f8f2ab9 runtime.TestCgoExecSignalMask (log)

--- FAIL: TestCgoExecSignalMask (142.07s) exec.go:190: test timed out while running command: /tmp/workdir/tmp/go-build1079410108/testprogcgo.exe CgoExecSignalMask crash_cgo_test.go:141: /tmp/workdir/tmp/go-build1079410108/testprogcgo.exe CgoExecSignalMask: exit status 2 crash_cgo_test.go:144: expected "OK\n", got SIGQUIT: quit PC=0x80b8447 m=13 sigcode=0 eax 0x4 ebx 0x0 ecx 0x8682400 edx 0x8680380 edi 0x829a498 esi 0xe ebp 0x5 esp 0xa7dffe18 eip 0x80b8447 eflags 0x247 cs 0x17 fs 0xab gs 0xb3

2023-09-01 15:17 netbsd-arm-bsiegert go@e3ef8d18 runtime.TestDeferLiveness (log)

panic: test timed out after 30m0s running tests: TestDeferLiveness (27m37s) syscall.Syscall6(0x1e1, 0x1, 0x8da, 0x165fde4, 0x10020, 0x0, 0x0) /var/gobuilder/buildlet/go/src/syscall/asm_netbsd_arm.s:39 +0x8 fp=0x165fdb8 sp=0x165fdb4 pc=0xa96b4 os.wait6(0x1, 0x8da, 0x10020) /var/gobuilder/buildlet/go/src/os/wait6_netbsd.go:16 +0x58 fp=0x165fdec sp=0x165fdb8 pc=0xd3980 os.(*Process).blockUntilWaitable(0x820900) /var/gobuilder/buildlet/go/src/os/wait_wait6.go:20 +0x30 fp=0x165fe08 sp=0x165fdec pc=0xd39d0 os.(*Process).wait(0x820900) /var/gobuilder/buildlet/go/src/os/exec_unix.go:22 +0x2c fp=0x165fe44 sp=0x165fe08 pc=0xcdcdc os.(*Process).Wait(...) /var/gobuilder/buildlet/go/src/os/exec.go:134 os/exec.(*Cmd).Wait(0x8fa3c0) /var/gobuilder/buildlet/go/src/os/exec/exec.go:862 +0x38 fp=0x165fe7c sp=0x165fe44 pc=0x1668fc os/exec.(*Cmd).Run(0x8fa3c0) /var/gobuilder/buildlet/go/src/os/exec/exec.go:590 +0x48 fp=0x165fe8c sp=0x165fe7c pc=0x165600 os/exec.(*Cmd).CombinedOutput(0x8fa3c0) /var/gobuilder/buildlet/go/src/os/exec/exec.go:977 +0x88 fp=0x165fea0 sp=0x165fe8c pc=0x167214 runtime_test.runBuiltTestProg(0x891b30, {0x1a7bf00, 0x3b}, {0x465ed3, 0xd}, {0x165ff8c, 0x1, 0x1}) /var/gobuilder/buildlet/go/src/runtime/crash_test.go:76 +0x2a8 fp=0x165ff1c sp=0x165fea0 pc=0x321cd8 runtime_test.runTestProg(0x891b30, {0x462d3c, 0x8}, {0x465ed3, 0xd}, {0x165ff8c, 0x1, 0x1}) /var/gobuilder/buildlet/go/src/runtime/crash_test.go:59 +0x168 fp=0x165ff58 sp=0x165ff1c pc=0x3219fc runtime_test.TestDeferLiveness(0x891b30) /var/gobuilder/buildlet/go/src/runtime/stack_test.go:868 +0x70 fp=0x165ff94 sp=0x165ff58 pc=0x3b32c0 testing.tRunner(0x891b30, 0x48d1d4)

2023-09-01 20:40 netbsd-arm-bsiegert go@227ec028 runtime.TestDeferLiveness (log)

panic: test timed out after 30m0s running tests: TestDeferLiveness (27m44s) syscall.Syscall6(0x1e1, 0x1, 0x104b, 0x1745de4, 0x10020, 0x0, 0x0) /var/gobuilder/buildlet/go/src/syscall/asm_netbsd_arm.s:39 +0x8 fp=0x1745db8 sp=0x1745db4 pc=0xa96b4 os.wait6(0x1, 0x104b, 0x10020) /var/gobuilder/buildlet/go/src/os/wait6_netbsd.go:16 +0x58 fp=0x1745dec sp=0x1745db8 pc=0xd3980 os.(*Process).blockUntilWaitable(0x205c0f0) /var/gobuilder/buildlet/go/src/os/wait_wait6.go:20 +0x30 fp=0x1745e08 sp=0x1745dec pc=0xd39d0 os.(*Process).wait(0x205c0f0) /var/gobuilder/buildlet/go/src/os/exec_unix.go:22 +0x2c fp=0x1745e44 sp=0x1745e08 pc=0xcdcdc os.(*Process).Wait(...) /var/gobuilder/buildlet/go/src/os/exec.go:134 os/exec.(*Cmd).Wait(0x1734000) /var/gobuilder/buildlet/go/src/os/exec/exec.go:862 +0x38 fp=0x1745e7c sp=0x1745e44 pc=0x1668fc os/exec.(*Cmd).Run(0x1734000) /var/gobuilder/buildlet/go/src/os/exec/exec.go:590 +0x48 fp=0x1745e8c sp=0x1745e7c pc=0x165600 os/exec.(*Cmd).CombinedOutput(0x1734000) /var/gobuilder/buildlet/go/src/os/exec/exec.go:977 +0x88 fp=0x1745ea0 sp=0x1745e8c pc=0x167214 runtime_test.runBuiltTestProg(0x14780f0, {0x1ae18c0, 0x3b}, {0x465ed3, 0xd}, {0x12a9f8c, 0x1, 0x1}) /var/gobuilder/buildlet/go/src/runtime/crash_test.go:76 +0x2a8 fp=0x1745f1c sp=0x1745ea0 pc=0x321cd8 runtime_test.runTestProg(0x14780f0, {0x462d3c, 0x8}, {0x465ed3, 0xd}, {0x12a9f8c, 0x1, 0x1}) /var/gobuilder/buildlet/go/src/runtime/crash_test.go:59 +0x168 fp=0x1745f58 sp=0x1745f1c pc=0x3219fc runtime_test.TestDeferLiveness(0x14780f0) /var/gobuilder/buildlet/go/src/runtime/stack_test.go:868 +0x70 fp=0x1745f94 sp=0x1745f58 pc=0x3b32c0 testing.tRunner(0x14780f0, 0x48d1d4)

2023-09-05 21:59 netbsd-amd64-9_3 go@b6372114 runtime.TestLockOSThreadTemplateThreadRace (log)

panic: test timed out after 3m0s running tests: TestLockOSThreadTemplateThreadRace (2m31s) syscall.Syscall6(0x1e1, 0x1, 0x42bb, 0xc00209dc74, 0x10020, 0x0, 0x0) /tmp/workdir/go/src/syscall/asm_unix_amd64.s:39 +0x9 fp=0xc00209dc20 sp=0xc00209dc10 pc=0x487509 os.wait6(0x400?, 0xc000900ba0?, 0xc0009368a0?) /tmp/workdir/go/src/os/wait6_netbsd.go:16 +0x4c fp=0xc00209dc90 sp=0xc00209dc20 pc=0x4ad52c os.(*Process).blockUntilWaitable(0xc000029290) /tmp/workdir/go/src/os/wait_wait6.go:20 +0x30 fp=0xc00209dcc0 sp=0xc00209dc90 pc=0x4ad5b0 os.(*Process).wait(0xc000029290) /tmp/workdir/go/src/os/exec_unix.go:22 +0x25 fp=0xc00209dd20 sp=0xc00209dcc0 pc=0x4a84c5 os.(*Process).Wait(...) /tmp/workdir/go/src/os/exec.go:134 os/exec.(*Cmd).Wait(0xc000164840) /tmp/workdir/go/src/os/exec/exec.go:862 +0x45 fp=0xc00209dd80 sp=0xc00209dd20 pc=0x53b005 os/exec.(*Cmd).Run(0x1?) /tmp/workdir/go/src/os/exec/exec.go:590 +0x2d fp=0xc00209dda0 sp=0xc00209dd80 pc=0x539c8d os/exec.(*Cmd).CombinedOutput(0xc000164840) /tmp/workdir/go/src/os/exec/exec.go:977 +0x85 fp=0xc00209ddc8 sp=0xc00209dda0 pc=0x53b8c5 runtime_test.runBuiltTestProg(0xc000144680, {0xc000b40120, 0x30}, {0x8676e2, 0x1e}, {0x0, 0x0, 0xf?}) /tmp/workdir/go/src/runtime/crash_test.go:76 +0x2c7 fp=0xc00209deb0 sp=0xc00209ddc8 pc=0x6ebb27 runtime_test.TestLockOSThreadTemplateThreadRace(0xc000144680) /tmp/workdir/go/src/runtime/proc_test.go:1022 +0x13c fp=0xc00209df70 sp=0xc00209deb0 pc=0x75cf7c testing.tRunner(0xc000144680, 0x880da8)

2023-09-06 14:20 netbsd-amd64-9_3 go@b0e1d3ea runtime.TestSegv (log)

--- FAIL: TestSegv (0.00s) --- FAIL: TestSegv/SegvInCgo (0.00s) crash_cgo_test.go:655: /tmp/workdir/tmp/go-build2292806128/testprogcgo.exe SegvInCgo (4.798403ms): ok crash_cgo_test.go:656: crash_cgo_test.go:662: did not see "SIGSEGV" in output

2023-09-06 18:36 netbsd-amd64-9_3 go@4be921d8 runtime.TestLockOSThreadTemplateThreadRace (log)

--- FAIL: TestLockOSThreadTemplateThreadRace (136.70s) proc_test.go:1022: /tmp/workdir/tmp/go-build2203932734/testprog.exe LockOSThreadTemplateThreadRace (165.613465ms): ok proc_test.go:1022: /tmp/workdir/tmp/go-build2203932734/testprog.exe LockOSThreadTemplateThreadRace (60.926942ms): ok proc_test.go:1022: /tmp/workdir/tmp/go-build2203932734/testprog.exe LockOSThreadTemplateThreadRace (14.578327ms): ok proc_test.go:1022: /tmp/workdir/tmp/go-build2203932734/testprog.exe LockOSThreadTemplateThreadRace (43.865807ms): ok exec.go:190: test timed out while running command: /tmp/workdir/tmp/go-build2203932734/testprog.exe LockOSThreadTemplateThreadRace proc_test.go:1022: /tmp/workdir/tmp/go-build2203932734/testprog.exe LockOSThreadTemplateThreadRace: exit status 2 proc_test.go:1024: run 4: want "OK\n", got "SIGQUIT: quit\nPC=0x463fa3 m=6 sigcode=0\n\ngoroutine 0 [idle]:\nruntime.lwp_park(0x3, 0x0, 0x0, 0x0, 0xc000080a50, 0x0)\n\t/tmp/workdir/go/src/runtime/sys_netbsd_amd64.s:99 +0x23 fp=0xc000059d00 sp=0xc000059cf8 pc=0x463fa3\nruntime.semasleep(0xffffffffffffffff)\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:183 +0x11f fp=0xc000059d60 sp=0xc000059d00 pc=0x431adf\nruntime.notesleep(0x0?)\n\t/tmp/workdir/go/src/runtime/lock_sema.go:181 +0x75 fp=0xc000059da0 sp=0xc000059d60 pc=0x40ae55\nruntime.mPark(...)\n\t/tmp/workdir/go/src/runtime/proc.go:1631\nruntime.stopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2535 +0x8c fp=0xc000059dd0 sp=0xc000059da0 pc=0x43b1cc\nruntime.gcstopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2834 +0xaa fp=0xc000059df8 sp=0xc000059dd0 pc=0x43bd8a\nruntime.findRunnable()\n\t/tmp/workdir/go/src/runtime/proc.go:2900 +0x3f fp=0xc000059f20 sp=0xc000059df8 pc=0x43bf7f\nruntime.schedule()\n\t/tmp/workdir/go/src/runtime/proc.go:3602 +0xb1 fp=0xc000059f58 sp=0xc000059f20 pc=0x43da31\nruntime.mstart1()\n\t/tmp/workdir/go/src/runtime/proc.go:1606 +0xcd fp=0xc000059f80 sp=0xc000059f58 pc=0x439c6d\nruntime.mstart0()\n\t/tmp/workdir/go/src/runtime/proc.go:1556 +0x76 fp=0xc000059fb0 sp=0xc000059f80 pc=0x439b76\nruntime.netbsdMstart0()\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:263 +0x45 fp=0xc000059fe8 sp=0xc000059fb0 pc=0x431f85\nruntime.netbsdMstart()\n\t/tmp/workdir/go/src/runtime/sys_netbsd_amd64.s:82 +0x9 fp=0xc000059ff8 sp=0xc000059fe8 pc=0x463f49\n\ngoroutine 1 [runnable]:\nruntime.gopark(0x439429?, 0xc00007adc8?, 0x0?, 0x80?, 0x1?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc00007ad88 sp=0xc00007ad68 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.semacquire1(0xc000012158, 0x30?, 0x1, 0x0, 0x6b?)\n\t/tmp/workdir/go/src/runtime/sema.go:160 +0x218 fp=0xc00007adf0 sp=0xc00007ad88 pc=0x446eb8\nsync.runtime_Semacquire(0xc000106120?)\n\t/tmp/workdir/go/src/runtime/sema.go:62 +0x25 fp=0xc00007ae28 sp=0xc00007adf0 pc=0x45f165\nsync.(*WaitGroup).Wait(0xc1364ffec184373f?)\n\t/tmp/workdir/go/src/sync/waitgroup.go:116 +0x48 fp=0xc00007ae50 sp=0xc00007ae28 pc=0x46ca28\nmain.LockOSThreadTemplateThreadRace()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:243 +0xec fp=0xc00007aea8 sp=0xc00007ae50 pc=0x4b808c\nmain.main()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/main.go:34 +0x133 fp=0xc00007af40 sp=0xc00007aea8 pc=0x4b8293\nruntime.main()\n\t/tmp/workdir/go/src/runtime/proc.go:267 +0x2bb fp=0xc00007afe0 sp=0xc00007af40 pc=0x4370bb\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc00007afe8 sp=0xc00007afe0 pc=0x462841\n\ngoroutine 2 [force gc (idle)]:\nruntime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000044fa8 sp=0xc000044f88 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.forcegchelper()\n\t/tmp/workdir/go/src/runtime/proc.go:322 +0xb3 fp=0xc000044fe0 sp=0xc000044fa8 pc=0x437393\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000044fe8 sp=0xc000044fe0 pc=0x462841\ncreated by runtime.init.6 in goroutine 1\n\t/tmp/workdir/go/src/runtime/proc.go:310 +0x1a\n\ngoroutine 3 [GC sweep wait]:\nruntime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000045778 sp=0xc000045758 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.bgsweep(0x0?)\n\t/tmp/workdir/go/src/runtime/mgcsweep.go:280 +0x94 fp=0xc0000457c8 sp=0xc000045778 pc=0x4234b4\nruntime.gcenable.gowrap1()\n\t/tmp/workdir/go/src/runtime/mgc.go:203 +0x25 fp=0xc0000457e0 sp=0xc0000457c8 pc=0x418345\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc0000457e8 sp=0xc0000457e0 pc=0x462841\ncreated by runtime.gcenable in goroutine 1\n\t/tmp/workdir/go/src/runtime/mgc.go:203 +0x66\n\ngoroutine 4 [GC scavenge wait]:\nruntime.gopark(0xc000066000?, 0x50bcc8?, 0x1?, 0x0?, 0xc000006d00?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000045f70 sp=0xc000045f50 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.(*scavengerState).park(0x5a3900)\n\t/tmp/workdir/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0xc000045fa0 sp=0xc000045f70 pc=0x420da9\nruntime.bgscavenge(0x0?)\n\t/tmp/workdir/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0xc000045fc8 sp=0xc000045fa0 pc=0x42133c\nruntime.gcenable.gowrap2()\n\t/tmp/workdir/go/src/runtime/mgc.go:204 +0x25 fp=0xc000045fe0 sp=0xc000045fc8 pc=0x4182e5\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000045fe8 sp=0xc000045fe0 pc=0x462841\ncreated by runtime.gcenable in goroutine 1\n\t/tmp/workdir/go/src/runtime/mgc.go:204 +0xa5\n\ngoroutine 5 [finalizer wait]:\nruntime.gopark(0x400000?, 0xc000044670?, 0x9c?, 0x1?, 0x5d1d80?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000044628 sp=0xc000044608 pc=0x43750e\nruntime.runfinq()\n\t/tmp/workdir/go/src/runtime/mfinal.go:193 +0x107 fp=0xc0000447e0 sp=0xc000044628 pc=0x4173a7\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc0000447e8 sp=0xc0000447e0 pc=0x462841\ncreated by runtime.createfing in goroutine 1\n\t/tmp/workdir/go/src/runtime/mfinal.go:163 +0x3d\n\ngoroutine 6 [stopping the world]:\nruntime.systemstack_switch()\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:474 +0x8 fp=0xc0000948b0 sp=0xc0000948a0 pc=0x4609e8\nruntime.stopTheWorld(0x7)\n\t/tmp/workdir/go/src/runtime/proc.go:1262 +0xc9 fp=0xc000094910 sp=0xc0000948b0 pc=0x439429\nruntime.ReadMemStats(0xc000094940)\n\t/tmp/workdir/go/src/runtime/mstats.go:361 +0x1f fp=0xc000094938 sp=0xc000094910 pc=0x42f73f\nmain.LockOSThreadTemplateThreadRace.func1()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:218 +0x36 fp=0xc000095fe0 sp=0xc000094938 pc=0x4bb8b6\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000095fe8 sp=0xc000095fe0 pc=0x462841\ncreated by main.LockOSThreadTemplateThreadRace in goroutine 1\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:214 +0x28\n\nrax 0x4\nrbx 0x0\nrcx 0x463fa3\nrdx 0x0\nrdi 0x3\nrsi 0x0\nrbp 0xc000059d50\nrsp 0xc000059cf8\nr8 0xc000080a50\nr9 0x0\nr10 0x0\nr11 0x206\nr12 0xc000059e78\nr13 0x0\nr14 0xc0000844e0\nr15 0x3\nrip 0x463fa3\nrflags 0x207\ncs 0x47\nfs 0x0\ngs 0x0\n"

2023-09-06 18:36 netbsd-arm64-bsiegert go@4be921d8 runtime.TestLockOSThreadTemplateThreadRace (log)

--- FAIL: TestLockOSThreadTemplateThreadRace (1569.60s) proc_test.go:1022: /scratch/gobuilder/buildlet/tmp/go-build1243018962/testprog.exe LockOSThreadTemplateThreadRace (144.013056ms): ok proc_test.go:1022: /scratch/gobuilder/buildlet/tmp/go-build1243018962/testprog.exe LockOSThreadTemplateThreadRace (44.823427ms): ok exec.go:190: test timed out while running command: /scratch/gobuilder/buildlet/tmp/go-build1243018962/testprog.exe LockOSThreadTemplateThreadRace proc_test.go:1022: /scratch/gobuilder/buildlet/tmp/go-build1243018962/testprog.exe LockOSThreadTemplateThreadRace: exit status 2 proc_test.go:1024: run 2: want "OK\n", got "SIGQUIT: quit\nPC=0x7466c m=7 sigcode=0\n\ngoroutine 0 [idle]:\nruntime.lwp_park(0x3, 0x0, 0x0, 0x0, 0x4000037ad0, 0x0)\n\t/scratch/gobuilder/buildlet/go/src/runtime/sys_netbsd_arm64.s:92 +0x1c fp=0x400011bce0 sp=0x400011bce0 pc=0x7466c\nruntime.semasleep(0xffffffffffffffff)\n\t/scratch/gobuilder/buildlet/go/src/runtime/os_netbsd.go:183 +0x12c fp=0x400011bd40 sp=0x400011bce0 pc=0x41a0c\nruntime.notesleep(0x4000037600?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/lock_sema.go:181 +0xac fp=0x400011bd80 sp=0x400011bd40 pc=0x1a60c\nruntime.mPark(...)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:1631\nruntime.stopm()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:2535 +0x84 fp=0x400011bdb0 sp=0x400011bd80 pc=0x4b1c4\nruntime.gcstopm()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:2834 +0xe8 fp=0x400011bde0 sp=0x400011bdb0 pc=0x4bee8\nruntime.findRunnable()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:2900 +0x4c fp=0x400011bf00 sp=0x400011bde0 pc=0x4c0dc\nruntime.schedule()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:3602 +0x98 fp=0x400011bf40 sp=0x400011bf00 pc=0x4e098\nruntime.mstart1()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:1606 +0xb8 fp=0x400011bf70 sp=0x400011bf40 pc=0x49908\nruntime.mstart0()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:1556 +0x68 fp=0x400011bfa0 sp=0x400011bf70 pc=0x49828\nruntime.netbsdMstart0()\n\t/scratch/gobuilder/buildlet/go/src/runtime/os_netbsd.go:263 +0x2c fp=0x400011bfe0 sp=0x400011bfa0 pc=0x41e1c\nruntime.netbsdMstart()\n\t/scratch/gobuilder/buildlet/go/src/runtime/sys_netbsd_arm64.s:77 +0x10 fp=0x400011bff0 sp=0x400011bfe0 pc=0x74630\n\ngoroutine 1 [runnable]:\nruntime.gopark(0x1c3e60?, 0x1c15c?, 0x0?, 0x40?, 0x30?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:398 +0xc8 fp=0x4000066d80 sp=0x4000066d60 pc=0x47108\nruntime.goparkunlock(...)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:404\nruntime.semacquire1(0x400000e198, 0xb8?, 0x1, 0x0, 0x8?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/sema.go:160 +0x208 fp=0x4000066dd0 sp=0x4000066d80 pc=0x57ba8\nsync.runtime_Semacquire(0x40000021a0?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/sema.go:62 +0x2c fp=0x4000066e10 sp=0x4000066dd0 pc=0x6ff3c\nsync.(*WaitGroup).Wait(0x400000e190)\n\t/scratch/gobuilder/buildlet/go/src/sync/waitgroup.go:116 +0x74 fp=0x4000066e30 sp=0x4000066e10 pc=0x7d554\nmain.LockOSThreadTemplateThreadRace()\n\t/scratch/gobuilder/buildlet/go/src/runtime/testdata/testprog/lockosthread.go:243 +0xe8 fp=0x4000066e90 sp=0x4000066e30 pc=0xc4f98\nmain.main()\n\t/scratch/gobuilder/buildlet/go/src/runtime/testdata/testprog/main.go:34 +0x11c fp=0x4000066f30 sp=0x4000066e90 pc=0xc518c\nruntime.main()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:267 +0x2bc fp=0x4000066fd0 sp=0x4000066f30 pc=0x46cdc\nruntime.goexit({})\n\t/scratch/gobuilder/buildlet/go/src/runtime/asm_arm64.s:1197 +0x4 fp=0x4000066fd0 sp=0x4000066fd0 pc=0x73944\n\ngoroutine 2 [force gc (idle)]:\nruntime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:398 +0xc8 fp=0x4000030f90 sp=0x4000030f70 pc=0x47108\nruntime.goparkunlock(...)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:404\nruntime.forcegchelper()\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:322 +0xb8 fp=0x4000030fd0 sp=0x4000030f90 pc=0x46f98\nruntime.goexit({})\n\t/scratch/gobuilder/buildlet/go/src/runtime/asm_arm64.s:1197 +0x4 fp=0x4000030fd0 sp=0x4000030fd0 pc=0x73944\ncreated by runtime.init.6 in goroutine 1\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:310 +0x24\n\ngoroutine 3 [GC sweep wait]:\nruntime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:398 +0xc8 fp=0x4000031760 sp=0x4000031740 pc=0x47108\nruntime.goparkunlock(...)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:404\nruntime.bgsweep(0x0?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/mgcsweep.go:280 +0xa0 fp=0x40000317b0 sp=0x4000031760 pc=0x33170\nruntime.gcenable.gowrap1()\n\t/scratch/gobuilder/buildlet/go/src/runtime/mgc.go:203 +0x28 fp=0x40000317d0 sp=0x40000317b0 pc=0x27918\nruntime.goexit({})\n\t/scratch/gobuilder/buildlet/go/src/runtime/asm_arm64.s:1197 +0x4 fp=0x40000317d0 sp=0x40000317d0 pc=0x73944\ncreated by runtime.gcenable in goroutine 1\n\t/scratch/gobuilder/buildlet/go/src/runtime/mgc.go:203 +0x6c\n\ngoroutine 4 [GC scavenge wait]:\nruntime.gopark(0x4000052000?, 0x11f1f8?, 0x1?, 0x0?, 0x4000002d00?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:398 +0xc8 fp=0x4000031f50 sp=0x4000031f30 pc=0x47108\nruntime.goparkunlock(...)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:404\nruntime.(*scavengerState).park(0x1bb880)\n\t/scratch/gobuilder/buildlet/go/src/runtime/mgcscavenge.go:425 +0x5c fp=0x4000031f80 sp=0x4000031f50 pc=0x30a0c\nruntime.bgscavenge(0x0?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/mgcscavenge.go:653 +0x44 fp=0x4000031fb0 sp=0x4000031f80 pc=0x30f54\nruntime.gcenable.gowrap2()\n\t/scratch/gobuilder/buildlet/go/src/runtime/mgc.go:204 +0x28 fp=0x4000031fd0 sp=0x4000031fb0 pc=0x278b8\nruntime.goexit({})\n\t/scratch/gobuilder/buildlet/go/src/runtime/asm_arm64.s:1197 +0x4 fp=0x4000031fd0 sp=0x4000031fd0 pc=0x73944\ncreated by runtime.gcenable in goroutine 1\n\t/scratch/gobuilder/buildlet/go/src/runtime/mgc.go:204 +0xac\n\ngoroutine 5 [finalizer wait]:\nruntime.gopark(0x40000305d8?, 0x23684?, 0x0?, 0x0?, 0x0?)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:398 +0xc8 fp=0x4000030580 sp=0x4000030560 pc=0x47108\nruntime.runfinq()\n\t/scratch/gobuilder/buildlet/go/src/runtime/mfinal.go:193 +0x108 fp=0x40000307d0 sp=0x4000030580 pc=0x26a08\nruntime.goexit({})\n\t/scratch/gobuilder/buildlet/go/src/runtime/asm_arm64.s:1197 +0x4 fp=0x40000307d0 sp=0x40000307d0 pc=0x73944\ncreated by runtime.createfing in goroutine 1\n\t/scratch/gobuilder/buildlet/go/src/runtime/mfinal.go:163 +0x80\n\ngoroutine 6 [stopping the world]:\nruntime.systemstack_switch()\n\t/scratch/gobuilder/buildlet/go/src/runtime/asm_arm64.s:200 +0x8 fp=0x4000094890 sp=0x4000094880 pc=0x715c8\nruntime.stopTheWorld(0x7)\n\t/scratch/gobuilder/buildlet/go/src/runtime/proc.go:1262 +0xc4 fp=0x40000948f0 sp=0x4000094890 pc=0x49024\nruntime.ReadMemStats(0x4000094938)\n\t/scratch/gobuilder/buildlet/go/src/runtime/mstats.go:361 +0x28 fp=0x4000094920 sp=0x40000948f0 pc=0x3f428\nmain.LockOSThreadTemplateThreadRace.func1()\n\t/scratch/gobuilder/buildlet/go/src/runtime/testdata/testprog/lockosthread.go:218 +0x4c fp=0x4000095fd0 sp=0x4000094920 pc=0xc8a7c\nruntime.goexit({})\n\t/scratch/gobuilder/buildlet/go/src/runtime/asm_arm64.s:1197 +0x4 fp=0x4000095fd0 sp=0x4000095fd0 pc=0x73944\ncreated by main.LockOSThreadTemplateThreadRace in goroutine 1\n\t/scratch/gobuilder/buildlet/go/src/runtime/testdata/testprog/lockosthread.go:214 +0x2c\n\nr0 0x4\nr1 0x0\nr2 0x0\nr3 0x0\nr4 0x4000037ad0\nr5 0x0\nr6 0x2\nr7 0x1\nr8 0x400011a000\nr9 0x40000561a0\nr10 0x0\nr11 0x0\nr12 0x56\nr13 0x13\nr14 0x2\nr15 0x11\nr16 0x400011a3a0\nr17 0x400011be60\nr18 0x0\nr19 0x0\nr20 0x400011bde0\nr21 0x4000000120\nr22 0x0\nr23 0x0\nr24 0x0\nr25 0x0\nr26 0x102940\nr27 0xffffffffffffffa0\nr28 0x40000561a0\nr29 0x400011bcd8\nlr 0x41a0c\nsp 0x400011bce0\npc 0x7466c\nfault 0xf14\n"

2023-09-07 01:59 netbsd-386-9_3 go@3466e573 runtime.TestGoroutineParallelism (log)

SIGQUIT: quit PC=0x80c4107 m=19 sigcode=0 eax 0x4 ebx 0x0 ecx 0x8ab7d00 edx 0x8b0a700 edi 0x8719cd8 esi 0xd ebp 0x4 esp 0xb17dfe0c eip 0x80c4107 eflags 0x247 cs 0x17 fs 0xab gs 0xb3 *** Test killed with quit: ran too long (6m0s). runtime.systemstack_switch() /tmp/workdir/go/src/runtime/asm_386.s:341 fp=0x8e43ef4 sp=0x8e43ef0 pc=0x80c1b30 runtime.stopTheWorld(0x9) /tmp/workdir/go/src/runtime/proc.go:1262 +0xc7 fp=0x8e43f1c sp=0x8e43ef4 pc=0x808c027 runtime.stopTheWorldGC(0x9) /tmp/workdir/go/src/runtime/proc.go:1310 +0x45 fp=0x8e43f34 sp=0x8e43f1c pc=0x808c1b5 runtime.GOMAXPROCS(0x3) /tmp/workdir/go/src/runtime/debug.go:28 +0x5f fp=0x8e43f40 sp=0x8e43f34 pc=0x8051eaf runtime_test.TestGoroutineParallelism(0x8bb21e0) /tmp/workdir/go/src/runtime/proc_test.go:117 +0xdb fp=0x8e43f98 sp=0x8e43f40 pc=0x838ec6b testing.tRunner(0x8bb21e0, 0x84902f4)

2023-09-07 13:18 netbsd-386-9_3 go@660620dd runtime.TestLockOSThreadTemplateThreadRace (log)

--- FAIL: TestLockOSThreadTemplateThreadRace (138.85s) proc_test.go:1022: /tmp/workdir/tmp/go-build1726040129/testprog.exe LockOSThreadTemplateThreadRace (15.434ms): ok exec.go:190: test timed out while running command: /tmp/workdir/tmp/go-build1726040129/testprog.exe LockOSThreadTemplateThreadRace proc_test.go:1022: /tmp/workdir/tmp/go-build1726040129/testprog.exe LockOSThreadTemplateThreadRace: exit status 2 proc_test.go:1024: run 1: want "OK\n", got "SIGQUIT: quit\nPC=0x80ad9e7 m=7 sigcode=0\n\ngoroutine 0 [idle]:\nruntime.lwp_park(0x3, 0x0, 0x0, 0x0, 0x84809e0, 0x0)\n\t/tmp/workdir/go/src/runtime/sys_netbsd_386.s:404 +0x7 fp=0x8517e6c sp=0x8517e68 pc=0x80ad9e7\nruntime.semasleep(0xffffffffffffffff)\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:183 +0x24c fp=0x8517eb4 sp=0x8517e6c pc=0x807c4dc\nruntime.notesleep(0x84807d8)\n\t/tmp/workdir/go/src/runtime/lock_sema.go:181 +0x82 fp=0x8517ed0 sp=0x8517eb4 pc=0x8052432\nruntime.mPark(...)\n\t/tmp/workdir/go/src/runtime/proc.go:1631\nruntime.stopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2535 +0x97 fp=0x8517ee4 sp=0x8517ed0 pc=0x8085557\nruntime.gcstopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2834 +0xce fp=0x8517efc sp=0x8517ee4 pc=0x80860be\nruntime.findRunnable()\n\t/tmp/workdir/go/src/runtime/proc.go:2900 +0x5a fp=0x8517fa8 sp=0x8517efc pc=0x808629a\nruntime.schedule()\n\t/tmp/workdir/go/src/runtime/proc.go:3602 +0xb1 fp=0x8517fc4 sp=0x8517fa8 pc=0x8088191\nruntime.mstart1()\n\t/tmp/workdir/go/src/runtime/proc.go:1606 +0xa7 fp=0x8517fd4 sp=0x8517fc4 pc=0x8083fc7\nruntime.mstart0()\n\t/tmp/workdir/go/src/runtime/proc.go:1556 +0x54 fp=0x8517fe4 sp=0x8517fd4 pc=0x8083f04\nruntime.netbsdMstart0()\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:263 +0x34 fp=0x8517ffc sp=0x8517fe4 pc=0x807c934\nruntime.netbsdMstart()\n\t/tmp/workdir/go/src/runtime/sys_netbsd_386.s:364 +0x5 fp=0x8518000 sp=0x8517ffc pc=0x80ad985\n\ngoroutine 1 [semacquire]:\nruntime.gopark(0x8130b64, 0x81dc820, 0x12, 0x19, 0x4)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xfa fp=0x8432664 sp=0x8432650 pc=0x8081a1a\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.semacquire1(0x84bc008, 0x0, 0x1, 0x0, 0x12)\n\t/tmp/workdir/go/src/runtime/sema.go:160 +0x287 fp=0x8432694 sp=0x8432664 pc=0x8091f27\nsync.runtime_Semacquire(0x84bc008)\n\t/tmp/workdir/go/src/runtime/sema.go:62 +0x35 fp=0x84326ac sp=0x8432694 pc=0x80aa6c5\nsync.(*WaitGroup).Wait(0x84bc000)\n\t/tmp/workdir/go/src/sync/waitgroup.go:116 +0x5f fp=0x84326c8 sp=0x84326ac pc=0x80b558f\nmain.LockOSThreadTemplateThreadRace()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:243 +0x131 fp=0x8432734 sp=0x84326c8 pc=0x8100331\nmain.main()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/main.go:34 +0x148 fp=0x84327a4 sp=0x8432734 pc=0x8100548\nruntime.main()\n\t/tmp/workdir/go/src/runtime/proc.go:267 +0x2bf fp=0x84327f0 sp=0x84327a4 pc=0x808158f\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x84327f4 sp=0x84327f0 pc=0x80ac931\n\ngoroutine 2 [force gc (idle)]:\nruntime.gopark(0x8130b64, 0x81d7870, 0x11, 0x14, 0x1)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xfa fp=0x8432fdc sp=0x8432fc8 pc=0x8081a1a\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.forcegchelper()\n\t/tmp/workdir/go/src/runtime/proc.go:322 +0xc7 fp=0x8432ff0 sp=0x8432fdc pc=0x8081887\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x8432ff4 sp=0x8432ff0 pc=0x80ac931\ncreated by runtime.init.5 in goroutine 1\n\t/tmp/workdir/go/src/runtime/proc.go:310 +0x1d\n\ngoroutine 3 [GC sweep wait]:\nruntime.gopark(0x8130b64, 0x81d79e0, 0xc, 0x14, 0x1)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xfa fp=0x84337cc sp=0x84337b8 pc=0x8081a1a\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.bgsweep(0x841a040)\n\t/tmp/workdir/go/src/runtime/mgcsweep.go:280 +0x8f fp=0x84337e8 sp=0x84337cc pc=0x806ca1f\nruntime.gcenable.gowrap1()\n\t/tmp/workdir/go/src/runtime/mgc.go:203 +0x21 fp=0x84337f0 sp=0x84337e8 pc=0x805e961\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x84337f4 sp=0x84337f0 pc=0x80ac931\ncreated by runtime.gcenable in goroutine 1\n\t/tmp/workdir/go/src/runtime/mgc.go:203 +0x71\n\ngoroutine 4 [GC scavenge wait]:\nruntime.gopark(0x8130b64, 0x81d7a40, 0xd, 0x14, 0x2)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xfa fp=0x8433fb8 sp=0x8433fa4 pc=0x8081a1a\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.(*scavengerState).park(0x81d7a40)\n\t/tmp/workdir/go/src/runtime/mgcscavenge.go:425 +0x54 fp=0x8433fcc sp=0x8433fb8 pc=0x8069f44\nruntime.bgscavenge(0x841a040)\n\t/tmp/workdir/go/src/runtime/mgcscavenge.go:653 +0x45 fp=0x8433fe8 sp=0x8433fcc pc=0x806a585\nruntime.gcenable.gowrap2()\n\t/tmp/workdir/go/src/runtime/mgc.go:204 +0x21 fp=0x8433ff0 sp=0x8433fe8 pc=0x805e921\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x8433ff4 sp=0x8433ff0 pc=0x80ac931\ncreated by runtime.gcenable in goroutine 1\n\t/tmp/workdir/go/src/runtime/mgc.go:204 +0xb1\n\ngoroutine 17 [finalizer wait]:\nruntime.gopark(0x8130a1c, 0x81e9cf8, 0x10, 0x14, 0x1)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xfa fp=0x842e798 sp=0x842e784 pc=0x8081a1a\nruntime.runfinq()\n\t/tmp/workdir/go/src/runtime/mfinal.go:193 +0xf0 fp=0x842e7f0 sp=0x842e798 pc=0x805daf0\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x842e7f4 sp=0x842e7f0 pc=0x80ac931\ncreated by runtime.createfing in goroutine 1\n\t/tmp/workdir/go/src/runtime/mfinal.go:163 +0x5a\n\ngoroutine 18 [stopping the world]:\nruntime.systemstack_switch()\n\t/tmp/workdir/go/src/runtime/asm_386.s:341 fp=0x8442a18 sp=0x8442a14 pc=0x80ab5f0\nruntime.stopTheWorld(0x7)\n\t/tmp/workdir/go/src/runtime/proc.go:1262 +0xc7 fp=0x8442a40 sp=0x8442a18 pc=0x80837b7\nruntime.ReadMemStats(0x8442a54)\n\t/tmp/workdir/go/src/runtime/mstats.go:361 +0x1e fp=0x8442a50 sp=0x8442a40 pc=0x80792ae\nmain.LockOSThreadTemplateThreadRace.func1()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:218 +0x34 fp=0x8443ff0 sp=0x8442a50 pc=0x81045f4\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x8443ff4 sp=0x8443ff0 pc=0x80ac931\ncreated by main.LockOSThreadTemplateThreadRace in goroutine 1\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:214 +0x2d\n\ngoroutine 20 [runnable, locked to thread]:\nruntime.Gosched(...)\n\t/tmp/workdir/go/src/runtime/proc.go:338\nmain.LockOSThreadTemplateThreadRace.func2()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:238 +0x7b fp=0x842fff0 sp=0x842ffa4 pc=0x81003db\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x842fff4 sp=0x842fff0 pc=0x80ac931\ncreated by main.LockOSThreadTemplateThreadRace in goroutine 1\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:229 +0xae\n\ngoroutine 21 [runnable]:\nmain.LockOSThreadTemplateThreadRace.func2.1()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:235 fp=0x84347f0 sp=0x84347ec pc=0x8104600\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x84347f4 sp=0x84347f0 pc=0x80ac931\ncreated by main.LockOSThreadTemplateThreadRace.func2 in goroutine 19\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:235 +0x67\n\ngoroutine 33 [runnable]:\nmain.LockOSThreadTemplateThreadRace.func2.1()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:235 fp=0x8504ff0 sp=0x8504fec pc=0x8104600\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x8504ff4 sp=0x8504ff0 pc=0x80ac931\ncreated by main.LockOSThreadTemplateThreadRace.func2 in goroutine 20\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:235 +0x67\n\neax 0x4\nebx 0x0\necx 0x8482800\nedx 0x8480700\nedi 0x8517fb4\nesi 0x8\nebp 0x2\nesp 0x8517e68\neip 0x80ad9e7\neflags 0x247\ncs 0x17\nfs 0xab\ngs 0xb3\n"

2023-09-07 13:18 netbsd-arm-bsiegert go@660620dd runtime.TestGoroutineProfileTrivial (log)

SIGQUIT: quit PC=0x9a7e8 m=19 sigcode=0 trap 0x0 error 0x0 oldmask 0x0 r0 0x4 r1 0x0 r2 0x0 r3 0x0 ... /var/gobuilder/buildlet/go/src/runtime/proc.go:1262 +0xd4 fp=0x14b96cc sp=0x14b96a0 pc=0x5b660 runtime.goroutineProfileWithLabelsConcurrent({0x0, 0x0, 0x0}, {0x0, 0x0, 0x0}) /var/gobuilder/buildlet/go/src/runtime/mprof.go:905 +0x50 fp=0x14b970c sp=0x14b96cc pc=0x4c458 runtime.goroutineProfileWithLabels({0x0, 0x0, 0x0}, {0x0, 0x0, 0x0}) /var/gobuilder/buildlet/go/src/runtime/mprof.go:854 +0x80 fp=0x14b9730 sp=0x14b970c pc=0x4c3e8 runtime.GoroutineProfile(...) /var/gobuilder/buildlet/go/src/runtime/mprof.go:1173 runtime_test.TestGoroutineProfileTrivial(0x11252c0) /var/gobuilder/buildlet/go/src/runtime/runtime_test.go:353 +0x4c fp=0x14b9794 sp=0x14b9730 pc=0x3a2afc testing.tRunner(0x11252c0, 0x48d240)

2023-09-07 15:14 netbsd-amd64-9_3 go@fb5bdb4c runtime.TestLockOSThreadTemplateThreadRace (log)

--- FAIL: TestLockOSThreadTemplateThreadRace (135.31s) proc_test.go:1022: /tmp/workdir/tmp/go-build930327044/testprog.exe LockOSThreadTemplateThreadRace (296.944444ms): ok proc_test.go:1022: /tmp/workdir/tmp/go-build930327044/testprog.exe LockOSThreadTemplateThreadRace (50.770419ms): ok exec.go:190: test timed out while running command: /tmp/workdir/tmp/go-build930327044/testprog.exe LockOSThreadTemplateThreadRace proc_test.go:1022: /tmp/workdir/tmp/go-build930327044/testprog.exe LockOSThreadTemplateThreadRace: exit status 2 proc_test.go:1024: run 2: want "OK\n", got "SIGQUIT: quit\nPC=0x463fa3 m=6 sigcode=0\n\ngoroutine 0 [idle]:\nruntime.lwp_park(0x3, 0x0, 0x0, 0x0, 0xc00004bad0, 0x0)\n\t/tmp/workdir/go/src/runtime/sys_netbsd_amd64.s:99 +0x23 fp=0xc000059d00 sp=0xc000059cf8 pc=0x463fa3\nruntime.semasleep(0xffffffffffffffff)\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:183 +0x11f fp=0xc000059d60 sp=0xc000059d00 pc=0x431adf\nruntime.notesleep(0x0?)\n\t/tmp/workdir/go/src/runtime/lock_sema.go:181 +0x75 fp=0xc000059da0 sp=0xc000059d60 pc=0x40ae55\nruntime.mPark(...)\n\t/tmp/workdir/go/src/runtime/proc.go:1631\nruntime.stopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2535 +0x8c fp=0xc000059dd0 sp=0xc000059da0 pc=0x43b1cc\nruntime.gcstopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2834 +0xaa fp=0xc000059df8 sp=0xc000059dd0 pc=0x43bd8a\nruntime.findRunnable()\n\t/tmp/workdir/go/src/runtime/proc.go:2900 +0x3f fp=0xc000059f20 sp=0xc000059df8 pc=0x43bf7f\nruntime.schedule()\n\t/tmp/workdir/go/src/runtime/proc.go:3602 +0xb1 fp=0xc000059f58 sp=0xc000059f20 pc=0x43da31\nruntime.mstart1()\n\t/tmp/workdir/go/src/runtime/proc.go:1606 +0xcd fp=0xc000059f80 sp=0xc000059f58 pc=0x439c6d\nruntime.mstart0()\n\t/tmp/workdir/go/src/runtime/proc.go:1556 +0x76 fp=0xc000059fb0 sp=0xc000059f80 pc=0x439b76\nruntime.netbsdMstart0()\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:263 +0x45 fp=0xc000059fe8 sp=0xc000059fb0 pc=0x431f85\nruntime.netbsdMstart()\n\t/tmp/workdir/go/src/runtime/sys_netbsd_amd64.s:82 +0x9 fp=0xc000059ff8 sp=0xc000059fe8 pc=0x463f49\n\ngoroutine 1 [semacquire]:\nruntime.gopark(0x5a91a0?, 0xc000012158?, 0x0?, 0x80?, 0x0?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc00007ad88 sp=0xc00007ad68 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.semacquire1(0xc000012158, 0x30?, 0x1, 0x0, 0x6b?)\n\t/tmp/workdir/go/src/runtime/sema.go:160 +0x218 fp=0xc00007adf0 sp=0xc00007ad88 pc=0x446eb8\nsync.runtime_Semacquire(0xc000106120?)\n\t/tmp/workdir/go/src/runtime/sema.go:62 +0x25 fp=0xc00007ae28 sp=0xc00007adf0 pc=0x45f165\nsync.(*WaitGroup).Wait(0xc13698e3c4f7b19b?)\n\t/tmp/workdir/go/src/sync/waitgroup.go:116 +0x48 fp=0xc00007ae50 sp=0xc00007ae28 pc=0x46ca28\nmain.LockOSThreadTemplateThreadRace()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:243 +0xec fp=0xc00007aea8 sp=0xc00007ae50 pc=0x4b7eec\nmain.main()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/main.go:34 +0x133 fp=0xc00007af40 sp=0xc00007aea8 pc=0x4b80f3\nruntime.main()\n\t/tmp/workdir/go/src/runtime/proc.go:267 +0x2bb fp=0xc00007afe0 sp=0xc00007af40 pc=0x4370bb\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc00007afe8 sp=0xc00007afe0 pc=0x462841\n\ngoroutine 2 [force gc (idle)]:\nruntime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000044fa8 sp=0xc000044f88 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.forcegchelper()\n\t/tmp/workdir/go/src/runtime/proc.go:322 +0xb3 fp=0xc000044fe0 sp=0xc000044fa8 pc=0x437393\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000044fe8 sp=0xc000044fe0 pc=0x462841\ncreated by runtime.init.6 in goroutine 1\n\t/tmp/workdir/go/src/runtime/proc.go:310 +0x1a\n\ngoroutine 3 [GC sweep wait]:\nruntime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000045778 sp=0xc000045758 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.bgsweep(0x0?)\n\t/tmp/workdir/go/src/runtime/mgcsweep.go:280 +0x94 fp=0xc0000457c8 sp=0xc000045778 pc=0x4234b4\nruntime.gcenable.gowrap1()\n\t/tmp/workdir/go/src/runtime/mgc.go:203 +0x25 fp=0xc0000457e0 sp=0xc0000457c8 pc=0x418345\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc0000457e8 sp=0xc0000457e0 pc=0x462841\ncreated by runtime.gcenable in goroutine 1\n\t/tmp/workdir/go/src/runtime/mgc.go:203 +0x66\n\ngoroutine 4 [GC scavenge wait]:\nruntime.gopark(0xc000066000?, 0x50bb88?, 0x1?, 0x0?, 0xc000006d00?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000045f70 sp=0xc000045f50 pc=0x43750e\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.(*scavengerState).park(0x5a3900)\n\t/tmp/workdir/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0xc000045fa0 sp=0xc000045f70 pc=0x420da9\nruntime.bgscavenge(0x0?)\n\t/tmp/workdir/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0xc000045fc8 sp=0xc000045fa0 pc=0x42133c\nruntime.gcenable.gowrap2()\n\t/tmp/workdir/go/src/runtime/mgc.go:204 +0x25 fp=0xc000045fe0 sp=0xc000045fc8 pc=0x4182e5\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000045fe8 sp=0xc000045fe0 pc=0x462841\ncreated by runtime.gcenable in goroutine 1\n\t/tmp/workdir/go/src/runtime/mgc.go:204 +0xa5\n\ngoroutine 5 [finalizer wait]:\nruntime.gopark(0x400000?, 0xc000044670?, 0x9c?, 0x1?, 0x5d1d80?)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000044628 sp=0xc000044608 pc=0x43750e\nruntime.runfinq()\n\t/tmp/workdir/go/src/runtime/mfinal.go:193 +0x107 fp=0xc0000447e0 sp=0xc000044628 pc=0x4173a7\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc0000447e8 sp=0xc0000447e0 pc=0x462841\ncreated by runtime.createfing in goroutine 1\n\t/tmp/workdir/go/src/runtime/mfinal.go:163 +0x3d\n\ngoroutine 6 [stopping the world]:\nruntime.systemstack_switch()\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:474 +0x8 fp=0xc0000948b0 sp=0xc0000948a0 pc=0x4609e8\nruntime.stopTheWorld(0x7)\n\t/tmp/workdir/go/src/runtime/proc.go:1262 +0xc9 fp=0xc000094910 sp=0xc0000948b0 pc=0x439429\nruntime.ReadMemStats(0xc000094940)\n\t/tmp/workdir/go/src/runtime/mstats.go:361 +0x1f fp=0xc000094938 sp=0xc000094910 pc=0x42f73f\nmain.LockOSThreadTemplateThreadRace.func1()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:218 +0x36 fp=0xc000095fe0 sp=0xc000094938 pc=0x4bb716\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000095fe8 sp=0xc000095fe0 pc=0x462841\ncreated by main.LockOSThreadTemplateThreadRace in goroutine 1\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:214 +0x28\n\ngoroutine 7 [runnable, locked to thread]:\nruntime.Gosched(...)\n\t/tmp/workdir/go/src/runtime/proc.go:338\nmain.LockOSThreadTemplateThreadRace.func2()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:238 +0x72 fp=0xc000046fe0 sp=0xc000046f80 pc=0x4b7f92\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000046fe8 sp=0xc000046fe0 pc=0x462841\ncreated by main.LockOSThreadTemplateThreadRace in goroutine 1\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:229 +0x76\n\ngoroutine 17 [runnable]:\nmain.LockOSThreadTemplateThreadRace.func2.1()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:235 fp=0xc0001857e0 sp=0xc0001857d8 pc=0x4bb720\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc0001857e8 sp=0xc0001857e0 pc=0x462841\ncreated by main.LockOSThreadTemplateThreadRace.func2 in goroutine 7\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:235 +0x5f\n\nrax 0x4\nrbx 0x0\nrcx 0x463fa3\nrdx 0x0\nrdi 0x3\nrsi 0x0\nrbp 0xc000059d50\nrsp 0xc000059cf8\nr8 0xc00004bad0\nr9 0x0\nr10 0x0\nr11 0x202\nr12 0xc000059e78\nr13 0x0\nr14 0xc0001221a0\nr15 0x12\nrip 0x463fa3\nrflags 0x203\ncs 0x47\nfs 0x0\ngs 0x0\n"

2023-09-07 16:18 netbsd-386-9_3 go@a35bb44a runtime.TestLockOSThreadTemplateThreadRace (log)

--- FAIL: TestLockOSThreadTemplateThreadRace (139.00s) proc_test.go:1022: /tmp/workdir/tmp/go-build1293478726/testprog.exe LockOSThreadTemplateThreadRace (128.124888ms): ok proc_test.go:1022: /tmp/workdir/tmp/go-build1293478726/testprog.exe LockOSThreadTemplateThreadRace (201.417413ms): ok exec.go:190: test timed out while running command: /tmp/workdir/tmp/go-build1293478726/testprog.exe LockOSThreadTemplateThreadRace proc_test.go:1022: /tmp/workdir/tmp/go-build1293478726/testprog.exe LockOSThreadTemplateThreadRace: exit status 2 proc_test.go:1024: run 2: want "OK\n", got "SIGQUIT: quit\nPC=0x80ad9e7 m=7 sigcode=0\n\ngoroutine 0 [idle]:\nruntime.lwp_park(0x3, 0x0, 0x0, 0x0, 0x84370e0, 0x0)\n\t/tmp/workdir/go/src/runtime/sys_netbsd_386.s:404 +0x7 fp=0x8493e6c sp=0x8493e68 pc=0x80ad9e7\nruntime.semasleep(0xffffffffffffffff)\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:183 +0x24c fp=0x8493eb4 sp=0x8493e6c pc=0x807c4dc\nruntime.notesleep(0x8436ed8)\n\t/tmp/workdir/go/src/runtime/lock_sema.go:181 +0x82 fp=0x8493ed0 sp=0x8493eb4 pc=0x8052432\nruntime.mPark(...)\n\t/tmp/workdir/go/src/runtime/proc.go:1631\nruntime.stopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2535 +0x97 fp=0x8493ee4 sp=0x8493ed0 pc=0x8085557\nruntime.gcstopm()\n\t/tmp/workdir/go/src/runtime/proc.go:2834 +0xce fp=0x8493efc sp=0x8493ee4 pc=0x80860be\nruntime.findRunnable()\n\t/tmp/workdir/go/src/runtime/proc.go:2900 +0x5a fp=0x8493fa8 sp=0x8493efc pc=0x808629a\nruntime.schedule()\n\t/tmp/workdir/go/src/runtime/proc.go:3602 +0xb1 fp=0x8493fc4 sp=0x8493fa8 pc=0x8088191\nruntime.mstart1()\n\t/tmp/workdir/go/src/runtime/proc.go:1606 +0xa7 fp=0x8493fd4 sp=0x8493fc4 pc=0x8083fc7\nruntime.mstart0()\n\t/tmp/workdir/go/src/runtime/proc.go:1556 +0x54 fp=0x8493fe4 sp=0x8493fd4 pc=0x8083f04\nruntime.netbsdMstart0()\n\t/tmp/workdir/go/src/runtime/os_netbsd.go:263 +0x34 fp=0x8493ffc sp=0x8493fe4 pc=0x807c934\nruntime.netbsdMstart()\n\t/tmp/workdir/go/src/runtime/sys_netbsd_386.s:364 +0x5 fp=0x8494000 sp=0x8493ffc pc=0x80ad985\n\ngoroutine 1 [semacquire]:\nruntime.gopark(0x8130b64, 0x81dc820, 0x12, 0x19, 0x4)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xfa fp=0x8432664 sp=0x8432650 pc=0x8081a1a\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.semacquire1(0x84bc008, 0x0, 0x1, 0x0, 0x12)\n\t/tmp/workdir/go/src/runtime/sema.go:160 +0x287 fp=0x8432694 sp=0x8432664 pc=0x8091f27\nsync.runtime_Semacquire(0x84bc008)\n\t/tmp/workdir/go/src/runtime/sema.go:62 +0x35 fp=0x84326ac sp=0x8432694 pc=0x80aa6c5\nsync.(*WaitGroup).Wait(0x84bc000)\n\t/tmp/workdir/go/src/sync/waitgroup.go:116 +0x5f fp=0x84326c8 sp=0x84326ac pc=0x80b558f\nmain.LockOSThreadTemplateThreadRace()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/lockosthread.go:243 +0x131 fp=0x8432734 sp=0x84326c8 pc=0x8100331\nmain.main()\n\t/tmp/workdir/go/src/runtime/testdata/testprog/main.go:34 +0x148 fp=0x84327a4 sp=0x8432734 pc=0x8100548\nruntime.main()\n\t/tmp/workdir/go/src/runtime/proc.go:267 +0x2bf fp=0x84327f0 sp=0x84327a4 pc=0x808158f\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x84327f4 sp=0x84327f0 pc=0x80ac931\n\ngoroutine 2 [force gc (idle)]:\nruntime.gopark(0x8130b64, 0x81d7870, 0x11, 0x14, 0x1)\n\t/tmp/workdir/go/src/runtime/proc.go:398 +0xfa fp=0x8432fdc sp=0x8432fc8 pc=0x8081a1a\nruntime.goparkunlock(...)\n\t/tmp/workdir/go/src/runtime/proc.go:404\nruntime.forcegchelper()\n\t/tmp/workdir/go/src/runtime/proc.go:322 +0xc7 fp=0x8432ff0 sp=0x8432fdc pc=0x8081887\nruntime.goexit({})\n\t/tmp/workdir/go/src/runtime/asm_386.s:1363 +0x1 fp=0x8432ff4 sp=0x8432ff0 pc=0x80ac931\ncreated by runtime.init.5 in goroutine 1\n\t/tmp/workdir/go/src/runtime/proc.go:310 +0x1d\n\ngoroutine 3 [GC sweep wai

(... long comment truncated ...)