internal/trace/v2: test timeouts #64794

gopherbot · 2023-12-19T01:02:11Z

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

Issue created automatically to collect these failures.

Example (log):

--- FAIL: TestTraceManyStartStop (0.74s)
    --- FAIL: TestTraceManyStartStop/Default (0.74s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:551: stderr: SIGQUIT: quit
            PC=0x250a4627 m=3 sigcode=0

            goroutine 0 gp=0x57406b48 m=3 mp=0x57440b08 [idle]:
            runtime.kevent(0x36, 0x0, 0x0, 0x19f70acc, 0x40, 0x19f70aa4)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x19f70a68 sp=0x19f70a58 pc=0x80a5541
            runtime.netpoll(0x3478c32f)
...
            edi    0x784
            esi    0x57406b48
            ebp    0x19f70a18
            esp    0x19f709fc
            eip    0x250a4627
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:553: exit status 2

— watchflakes

The text was updated successfully, but these errors were encountered:

gopherbot · 2023-12-19T01:02:12Z

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "internal/trace/v2" && test == "TestTraceManyStartStop"

2023-12-18 21:30 openbsd-386-72 go@c564d4ae internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.74s)
    --- FAIL: TestTraceManyStartStop/Default (0.74s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:551: stderr: SIGQUIT: quit
            PC=0x250a4627 m=3 sigcode=0

            goroutine 0 gp=0x57406b48 m=3 mp=0x57440b08 [idle]:
            runtime.kevent(0x36, 0x0, 0x0, 0x19f70acc, 0x40, 0x19f70aa4)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x19f70a68 sp=0x19f70a58 pc=0x80a5541
            runtime.netpoll(0x3478c32f)
...
            edi    0x784
            esi    0x57406b48
            ebp    0x19f70a18
            esp    0x19f709fc
            eip    0x250a4627
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:553: exit status 2

— watchflakes

bcmills · 2024-01-02T16:49:33Z

Given that TestTraceManyStartStop was running for less than a second before it timed out, it seems likely that some other test in this package is too long/expensive and should be skipped when testing.Short() is true.

(attn @mknyszek)

gopherbot · 2024-01-19T20:06:48Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-01-08 18:52 gotip-linux-amd64-longtest go@8eaa7935 internal/trace/v2.TestTraceStacks/Stress (log)

=== RUN   TestTraceStacks/Stress
    exec.go:193: test timed out while running command: /home/swarming/.swarming/w/ir/x/w/goroot/bin/go run testdata/testprog/stacks.go
    trace_test.go:553: signal: killed
--- FAIL: TestTraceStacks/Stress (842.69s)

— watchflakes

bcmills · 2024-01-24T14:00:33Z

https://storage.googleapis.com/go-build-log/33992f4a/openbsd-amd64-72_ed2d35db.log shows a timeout with a long running time in TestTraceStressStartStop/Default.

That one is a bit strange because it seems to show a go run command with a lot of goroutines in buildActionID, waiting on the results of go tool compile -V=full. 🤔

mknyszek · 2024-01-24T15:55:15Z

These tests do invoke the compiler, but only on very small programs. Still, if that's a problem, I can restructure the tests to group all the programs together like src/runtime/testdata/testprog. (Originally there weren't enough of them for me to consider that necessary, but maybe now there's enough that it causes problems...)

bcmills · 2024-01-24T16:03:07Z

It seems odd to me that the go run command stalled for that long on the builder in the first place. I'm not sure what's going on there. Linking can be expensive, but that go run command doesn't seem to have even gotten that far. I wonder if that's another symptom of a bug in the kqueue netpoll implementation...

gopherbot · 2024-01-29T22:44:01Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-01-29 19:39 openbsd-386-72 go@b91bad78 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (158.22s)
    --- FAIL: TestTraceStressStartStop/Default (158.22s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:562: exit status 1

— watchflakes

gopherbot · 2024-02-23T17:23:14Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-02-22 01:57 gotip-linux-amd64-longtest-race go@5d4e8f51 internal/trace/v2.TestTraceStacks/Stress (log)

=== RUN   TestTraceStacks/Stress
    exec.go:193: test timed out while running command: /home/swarming/.swarming/w/ir/x/w/goroot/bin/go run -race testdata/testprog/stacks.go
    trace_test.go:567: signal: killed
--- FAIL: TestTraceStacks/Stress (1676.23s)

— watchflakes

mknyszek · 2024-02-23T17:30:36Z

Woooaaah... that is way longer than that test should ever take. That could be a deadlock, perhaps. I'll try to reproduce.

gopherbot · 2024-03-06T05:32:09Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-03-05 20:52 linux-mipsle-rtrk go@9e3b1d53 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (658.46s)
    --- FAIL: TestTraceStressStartStop/Default (658.46s)
        exec.go:193: test timed out while running command: /tmp/gobuilder-mips64le/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:567: signal: killed

— watchflakes

gopherbot · 2024-03-22T21:02:27Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-03-22 04:41 gotip-linux-amd64-longtest-race go@ac0b2f95 internal/trace/v2.TestTraceStacks/Stress (log)

=== RUN   TestTraceStacks/Stress
    exec.go:193: test timed out while running command: /home/swarming/.swarming/w/ir/x/w/goroot/bin/go run -race testdata/testprog/stacks.go
    trace_test.go:567: signal: killed
--- FAIL: TestTraceStacks/Stress (1665.72s)

— watchflakes

gopherbot · 2024-03-27T19:52:03Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-03-27 17:55 openbsd-386-72 go@979b34b3 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (54.60s)
    --- FAIL: TestTraceStressStartStop/Default (54.60s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:571: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceIterPull (1s)

goroutine 126 gp=0x6b0070e8 m=0 mp=0x83aa020 [running]:
panic({0x8212be0, 0x6be62878})
...
runtime.chansend1(0x6b3a78c0, 0x6b087fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x6b087f38 sp=0x6b087f20 pc=0x804d224
os/exec.(*Cmd).watchCtx(0x6b3b1388, 0x6b3a78c0)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x4c6 fp=0x6b087fe4 sp=0x6b087f38 pc=0x8161006
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x6b087ff0 sp=0x6b087fe4 pc=0x81608f8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6b087ff4 sp=0x6b087ff0 pc=0x80baa11
created by os/exec.(*Cmd).Start in goroutine 121
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x901

— watchflakes

gopherbot · 2024-04-07T04:44:57Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-05 22:18 openbsd-386-72 go@58c5db31 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (72.49s)
    --- FAIL: TestTraceStressStartStop/Default (72.49s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-05 22:18 openbsd-386-72 go@58c5db31 internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (1.73s)
    --- FAIL: TestTraceWaitOnPipe/Default (1.73s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x2e651b1b m=3 sigcode=0

            goroutine 0 gp=0x50c08b48 m=3 mp=0x50c40a08 [idle]:
            runtime.thrsleep
        trace_test.go:575: signal: killed

2024-04-05 22:18 openbsd-386-72 go@58c5db31 internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:575: context deadline exceeded
panic: test timed out after 3m0s

goroutine 124 gp=0x61c06d88 m=2 mp=0x61c3a508 [running]:
panic({0x8213ca0, 0x638b8808})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x61c36784 sp=0x61c36730 pc=0x8081cb8
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2366 +0x386 fp=0x61c367f0 sp=0x61c36784 pc=0x813d2f6
...
runtime.gopark(0x82560ec, 0x61c180f0, 0x1a, 0xa, 0x0)
	/tmp/workdir/go/src/runtime/proc.go:402 +0xfa fp=0x61c38f8c sp=0x61c38f78 pc=0x808569a
runtime.gcBgMarkWorker(0x61c1ea00)
	/tmp/workdir/go/src/runtime/mgc.go:1333 +0xeb fp=0x61c38fe8 sp=0x61c38f8c pc=0x80636db
runtime.gcBgMarkStartWorkers.gowrap1()
	/tmp/workdir/go/src/runtime/mgc.go:1249 +0x21 fp=0x61c38ff0 sp=0x61c38fe8 pc=0x80635d1
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x61c38ff4 sp=0x61c38ff0 pc=0x80bb191
created by runtime.gcBgMarkStartWorkers in goroutine 10
	/tmp/workdir/go/src/runtime/mgc.go:1249 +0x114

— watchflakes

gopherbot · 2024-04-09T21:59:01Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-09 20:03 openbsd-386-72 go@a555ac63 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (123.61s)
    --- FAIL: TestTraceStressStartStop/Default (123.61s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: exit status 1

— watchflakes

gopherbot · 2024-04-15T21:23:59Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-15 19:10 openbsd-386-72 go@cfbe6cd9 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (132.95s)
    --- FAIL: TestTraceStress/Default (132.95s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 108 gp=0x5e407c28 m=2 mp=0x5e43a508 [running]:
...
runtime.chansend1(0x5e7a6200, 0x5e483fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x5e483f38 sp=0x5e483f20 pc=0x804d224
os/exec.(*Cmd).watchCtx(0x5e7c8008, 0x5e7a6200)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x4c6 fp=0x5e483fe4 sp=0x5e483f38 pc=0x8161f26
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x5e483ff0 sp=0x5e483fe4 pc=0x8161818
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x5e483ff4 sp=0x5e483ff0 pc=0x80bb4f1
created by os/exec.(*Cmd).Start in goroutine 103
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x901

— watchflakes

gopherbot · 2024-04-16T23:55:21Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-16 21:06 openbsd-386-72 go@15cec430 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (133.33s)
    --- FAIL: TestTraceStress/Default (133.33s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 108 gp=0x62c070e8 m=2 mp=0x62c3a508 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6300c208)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:611 +0x22 fp=0x62c85f98 sp=0x62c85f8c pc=0x81f8562
testing.tRunner(0x6300c208, 0x63a520e8)
	/tmp/workdir/go/src/testing/testing.go:1689 +0x11f fp=0x62c85fe4 sp=0x62c85f98 pc=0x813927f
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1742 +0x28 fp=0x62c85ff0 sp=0x62c85fe4 pc=0x813a258
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x62c85ff4 sp=0x62c85ff0 pc=0x80bb4f1
created by testing.(*T).Run in goroutine 102
	/tmp/workdir/go/src/testing/testing.go:1742 +0x3b3

— watchflakes

gopherbot · 2024-04-22T20:01:04Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-22 18:14 openbsd-386-72 go@79065f0a internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (12.68s)
    --- FAIL: TestTraceStressStartStop/Default (12.68s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-22 18:14 openbsd-386-72 go@79065f0a internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.54s)
    --- FAIL: TestTraceManyStartStop/Default (0.54s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x5010b0a7 m=3 sigcode=0

            goroutine 0 gp=0x70408b48 m=3 mp=0x70440a08 [idle]:
            runtime.kevent(0x39, 0x0, 0x0, 0x4558fc84, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x4558fc30 sp=0x4558fc20 pc=0x80a5e01
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x70408b48
            ebp    0x4558fbd8
            esp    0x4558fbbc
            eip    0x5010b0a7
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

— watchflakes

gopherbot · 2024-04-23T00:03:51Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-22 20:48 openbsd-386-72 go@aa63ef4b internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (46.49s)
    --- FAIL: TestTraceStressStartStop/Default (46.49s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: exit status 1

2024-04-22 22:06 openbsd-386-72 go@5a3b6400 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (27.29s)
    --- FAIL: TestTraceStressStartStop/Default (27.29s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-22 22:06 openbsd-386-72 go@5a3b6400 internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.29s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.28s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x3ae6e1a7 m=3 sigcode=0

            goroutine 0 gp=0x5b008b48 m=3 mp=0x5b040a08 [idle]:
            runtime.thrsleep(0x5b040d68, 0x3, 0x0, 0x0, 0x5b040d68)
            	runtime/sys_openbsd1.go:17 +0x21 fp=0x2adc4260 sp=0x2adc4250 pc=0x80a57a1
            runtime.semasleep(0xffffffffffffffff)
...
            	os/file.go:399 +0x37 fp=0x5b02d7ac sp=0x5b02d794 pc=0x81397d7
            os.ReadDir({0x5b226108, 0x17})
            	os/dir.go:118 +0x5d fp=0x5b02d800 sp=0x5b02d7ac pc=0x813581d
            cmd/go/internal/fsys.readDir({0x5b226108, 0x17})
            	cmd/go/internal/fsys/fsys.go:306 +0x27 fp=0x5b02d84c sp=0x5b02d800 pc=0x83c19d7
            cmd/go/internal/fsys.ReadDir({0x5b226108, 0x17})
            	cmd/go/internal/fsys/fsys.go:339 +0x2d7 fp=0x5b02d9f4 sp=0x5b02d84c pc=0x83c1f57
            cmd/go/internal/modindex.dirHash({0x5b2260f0, 0x13}, {0x5b226108, 0x17})
            	cmd/go/internal/modindex/read.go:89 +0x1ba fp=0x5b02dabc sp=0x5b02d9f4 pc=
        trace_test.go:575: signal: killed

2024-04-22 22:06 openbsd-386-72 go@5a3b6400 internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:575: context deadline exceeded
panic: test timed out after 3m0s

goroutine 132 gp=0x6c407e68 m=0 mp=0x83b3640 [running]:
panic({0x8216de0, 0x6e118ec0})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x6db97f84 sp=0x6db97f30 pc=0x8081fe8
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2366 +0x386 fp=0x6db97ff0 sp=0x6db97f84 pc=0x813d776
...
testing.(*F).Fuzz.func1.1(0x6c809608)
	/tmp/workdir/go/src/testing/fuzz.go:335 +0x2f8 fp=0x6c485f98 sp=0x6c485f00 pc=0x8130fd8
testing.tRunner(0x6c809608, 0x6d1fa500)
	/tmp/workdir/go/src/testing/testing.go:1689 +0x11f fp=0x6c485fe4 sp=0x6c485f98 pc=0x813943f
testing.(*F).Fuzz.func1.gowrap1()
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x28 fp=0x6c485ff0 sp=0x6c485fe4 pc=0x8130cc8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6c485ff4 sp=0x6c485ff0 pc=0x80bb711
created by testing.(*F).Fuzz.func1 in goroutine 124
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x4df

2024-04-22 22:06 openbsd-386-72 go@674657e1 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (28.27s)
    --- FAIL: TestTraceStressStartStop/Default (28.27s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-22 22:06 openbsd-386-72 go@674657e1 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.29s)
    --- FAIL: TestTraceManyStartStop/Default (1.29s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:575: exit status 1

— watchflakes

gopherbot · 2024-04-24T15:31:24Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-23 17:45 openbsd-386-72 go@a62c290c internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (17.28s)
    --- FAIL: TestTraceStressStartStop/Default (17.28s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-23 17:45 openbsd-386-72 go@a62c290c internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.76s)
    --- FAIL: TestTraceManyStartStop/Default (0.76s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x45cb20d7 m=3 sigcode=0

            goroutine 0 gp=0x66008b48 m=3 mp=0x66040a08 [idle]:
            runtime.kevent(0x39, 0x0, 0x0, 0x2856c0c4, 0x40, 0x2856c098)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x2856c070 sp=0x2856c060 pc=0x80a5de1
            runtime.netpoll(0x3408b16e)
...
            edi    0x79c
            esi    0x66008b48
            ebp    0x2856c018
            esp    0x2856bffc
            eip    0x45cb20d7
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-04-23 17:45 openbsd-386-72 go@960fa9bf internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (15.77s)
    --- FAIL: TestTraceStressStartStop/Default (15.77s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-23 17:45 openbsd-386-72 go@960fa9bf internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.71s)
    --- FAIL: TestTraceManyStartStop/Default (0.71s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x45344ce7 m=3 sigcode=0

            goroutine 0 gp=0x6ec08b48 m=3 mp=0x6ec40a08 [idle]:
            runtime.kevent(0x39, 0x0, 0x0, 0x28de4614, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x28de45c0 sp=0x28de45b0 pc=0x80a5de1
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x6ec08b48
            ebp    0x28de4568
            esp    0x28de454c
            eip    0x45344ce7
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

— watchflakes

gopherbot · 2024-04-24T17:32:54Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-24 13:37 openbsd-386-72 go@4792ca7b internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (67.23s)
    --- FAIL: TestTraceStressStartStop/Default (67.23s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (2s)
	TestTraceWaitOnPipe/Default (2s)

goroutine 120 gp=0x68807d48 m=2 mp=0x6883a508 [running]:
...
runtime.chansend1(0x68b671c0, 0x68882fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x68882f38 sp=0x68882f20 pc=0x804d214
os/exec.(*Cmd).watchCtx(0x68b5ce48, 0x68b671c0)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x4c6 fp=0x68882fe4 sp=0x68882f38 pc=0x8161fd6
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x68882ff0 sp=0x68882fe4 pc=0x81618c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x68882ff4 sp=0x68882ff0 pc=0x80bb731
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x901

— watchflakes

gopherbot · 2024-04-24T19:34:20Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-24 15:55 openbsd-386-72 go@d037bba1 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (127.61s)
    --- FAIL: TestTraceStress/Default (127.61s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:575: exit status 1

2024-04-24 15:55 openbsd-386-72 go@d037bba1 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (11.54s)
    --- FAIL: TestTraceStressStartStop/Default (11.54s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceManyStartStop (1s)
	TestTraceManyStartStop/Default (1s)

goroutine 115 gp=0x5e807e68 m=3 mp=0x5e83aa08 [running]:
...
runtime.chansend1(0x5eba44c0, 0x5e885fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x5e885f38 sp=0x5e885f20 pc=0x804d214
os/exec.(*Cmd).watchCtx(0x5ebc8188, 0x5eba44c0)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x4c6 fp=0x5e885fe4 sp=0x5e885f38 pc=0x8161fd6
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x5e885ff0 sp=0x5e885fe4 pc=0x81618c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x5e885ff4 sp=0x5e885ff0 pc=0x80bb731
created by os/exec.(*Cmd).Start in goroutine 110
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x901

— watchflakes

gopherbot · 2024-04-25T02:39:15Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-24 21:50 openbsd-386-72 go@9b9de261 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (64.65s)
    --- FAIL: TestTraceStressStartStop/Default (64.65s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-24 21:50 openbsd-386-72 go@9b9de261 internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (1.86s)
    --- FAIL: TestTraceWaitOnPipe/Default (1.86s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x44c713ab m=3 sigcode=0

            goroutine 0 gp=0x64c08b48 m=3 mp=0x64c40a08 [idle]:
            runtime.thrsleep(0x64c40d68, 0x3, 0x0, 0x0, 0x64c40d68)
            	runtime/sys_openbsd1.go:17 +0x21 fp=0x165ffd70 sp=0x165ffd60 pc=0x80a5781
            runtime.semasleep(0xffffffffffffffff)
...
            edi    0x1ac
            esi    0x64c08b48
            ebp    0x165ffd18
            esp    0x165ffd00
            eip    0x44c713ab
            eflags 0x202
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-04-24 21:50 openbsd-386-72 go@9b9de261 internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:575: context deadline exceeded
panic: test timed out after 3m0s

goroutine 132 gp=0x62fb0248 m=0 mp=0x83b3640 [running]:
panic({0x8216de0, 0x63a24cc8})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x62c36784 sp=0x62c36730 pc=0x8081fe8
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2366 +0x386 fp=0x62c367f0 sp=0x62c36784 pc=0x813d796
...
runtime.gopark(0x82594ac, 0x62c180f0, 0x1a, 0xa, 0x0)
	/tmp/workdir/go/src/runtime/proc.go:401 +0xfa fp=0x62c38f8c sp=0x62c38f78 pc=0x80859ca
runtime.gcBgMarkWorker(0x62c1ea00)
	/tmp/workdir/go/src/runtime/mgc.go:1352 +0xeb fp=0x62c38fe8 sp=0x62c38f8c pc=0x806383b
runtime.gcBgMarkStartWorkers.gowrap1()
	/tmp/workdir/go/src/runtime/mgc.go:1268 +0x21 fp=0x62c38ff0 sp=0x62c38fe8 pc=0x8063731
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x62c38ff4 sp=0x62c38ff0 pc=0x80bb731
created by runtime.gcBgMarkStartWorkers in goroutine 10
	/tmp/workdir/go/src/runtime/mgc.go:1268 +0x114

— watchflakes

gopherbot · 2024-04-25T18:50:49Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-25 11:28 openbsd-386-72 go@8960925a internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (24.99s)
    --- FAIL: TestTraceStressStartStop/Default (24.99s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceManyStartStop (1s)
	TestTraceManyStartStop/Default (1s)

goroutine 114 gp=0x6e807c28 m=3 mp=0x6e83aa08 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6ec0a508)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:611 +0x22 fp=0x6e835798 sp=0x6e83578c pc=0x81f86a2
testing.tRunner(0x6ec0a508, 0x7050c5e8)
	/tmp/workdir/go/src/testing/testing.go:1689 +0x11f fp=0x6e8357e4 sp=0x6e835798 pc=0x813945f
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1742 +0x28 fp=0x6e8357f0 sp=0x6e8357e4 pc=0x813a438
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6e8357f4 sp=0x6e8357f0 pc=0x80bb731
created by testing.(*T).Run in goroutine 108
	/tmp/workdir/go/src/testing/testing.go:1742 +0x3b3

2024-04-25 16:05 openbsd-386-72 go@8c0da423 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (45.25s)
    --- FAIL: TestTraceStressStartStop/Default (45.25s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (1s)
	TestTraceWaitOnPipe/Default (1s)

goroutine 120 gp=0x6d007c28 m=3 mp=0x6d03aa08 [running]:
...
runtime.chansend1(0x6d3a6100, 0x6d083fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x6d083f38 sp=0x6d083f20 pc=0x804d214
os/exec.(*Cmd).watchCtx(0x6d3cb088, 0x6d3a6100)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x4c6 fp=0x6d083fe4 sp=0x6d083f38 pc=0x8161fd6
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x6d083ff0 sp=0x6d083fe4 pc=0x81618c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6d083ff4 sp=0x6d083ff0 pc=0x80bb731
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x901

— watchflakes

gopherbot · 2024-04-25T21:53:02Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-25 18:50 openbsd-386-72 go@a8ba1636 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (14.88s)
    --- FAIL: TestTraceStressStartStop/Default (14.88s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-25 18:50 openbsd-386-72 go@a8ba1636 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.64s)
    --- FAIL: TestTraceManyStartStop/Default (0.64s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x3905c3ab m=3 sigcode=0

            goroutine 0 gp=0x5e808b48 m=3 mp=0x5e840a08 [idle]:
            runtime.kevent(0x39, 0x0, 0x0, 0x25a22164, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x25a22110 sp=0x25a22100 pc=0x80a5de1
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x5e808b48
            ebp    0x25a220b8
            esp    0x25a2209c
            eip    0x3905c3ab
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

— watchflakes

gopherbot · 2024-04-30T17:15:06Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-04-29 14:35 openbsd-386-72 go@16ce8b39 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (28.79s)
    --- FAIL: TestTraceStressStartStop/Default (28.79s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (1s)
	TestTraceWaitOnPipe/Default (1s)

goroutine 120 gp=0x59bb0248 m=2 mp=0x5983a508 [running]:
...
runtime.chansend1(0x59ba5c40, 0x59883fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x59883f38 sp=0x59883f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x5b374608, 0x59ba5c40)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x59883fe4 sp=0x59883f38 pc=0x8160277
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x59883ff0 sp=0x59883fe4 pc=0x815fb98
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x59883ff4 sp=0x59883ff0 pc=0x80baab1
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-04-30 12:44 openbsd-386-72 go@dc164ead internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (25.03s)
    --- FAIL: TestTraceStressStartStop/Default (25.03s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-30 12:44 openbsd-386-72 go@dc164ead internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.14s)
    --- FAIL: TestTraceManyStartStop/Default (1.14s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:575: exit status 1

2024-04-30 15:34 openbsd-386-72 go@476a3525 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (132.31s)
    --- FAIL: TestTraceStress/Default (132.30s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 108 gp=0x5f7b0248 m=2 mp=0x5f43a508 [running]:
...
runtime.chansend1(0x60efe200, 0x5f481fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x5f481f38 sp=0x5f481f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x5f7c8008, 0x60efe200)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x5f481fe4 sp=0x5f481f38 pc=0x8160277
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x5f481ff0 sp=0x5f481fe4 pc=0x815fb98
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x5f481ff4 sp=0x5f481ff0 pc=0x80baab1
created by os/exec.(*Cmd).Start in goroutine 103
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-04-30 15:38 openbsd-386-72 go@5616ab60 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (23.39s)
    --- FAIL: TestTraceStressStartStop/Default (23.39s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-04-30 15:38 openbsd-386-72 go@5616ab60 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.12s)
    --- FAIL: TestTraceManyStartStop/Default (1.12s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x40af01cf m=3 sigcode=0

            goroutine 0 gp=0x60c08b48 m=3 mp=0x60c40a08 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x146592c4, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x14659270 sp=0x14659260 pc=0x80a5501
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x60c08b48
            ebp    0x14659218
            esp    0x146591fc
            eip    0x40af01cf
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-04-30 15:38 openbsd-386-72 go@8509f693 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (24.93s)
    --- FAIL: TestTraceStressStartStop/Default (24.93s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (1s)
	TestTraceWaitOnPipe/Default (1s)

goroutine 117 gp=0x4d007e68 m=2 mp=0x4d03a508 [running]:
...
created by os/exec.(*Cmd).Start in goroutine 109
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

goroutine 116 gp=0x4d3b0248 m=nil [runnable]:
context.WithDeadlineCause.func2()
	/tmp/workdir/go/src/context/context.go:638 fp=0x4d0327f0 sp=0x4d0327ec pc=0x8127f10
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4d0327f4 sp=0x4d0327f0 pc=0x80baab1
created by time.goFunc
	/tmp/workdir/go/src/time/sleep.go:214 +0x29

— watchflakes

gopherbot · 2024-05-02T23:11:31Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-02 18:41 openbsd-386-72 go@865cf5c5 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (32.35s)
    --- FAIL: TestTraceStressStartStop/Default (32.35s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceManyStartStop (2s)
	TestTraceManyStartStop/Default (2s)

goroutine 114 gp=0x69007e68 m=0 mp=0x83b1640 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6940a508)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:611 +0x22 fp=0x69085f84 sp=0x69085f78 pc=0x81f5d92
testing.tRunner(0x6940a508, 0x69e5e630)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x69085fe4 sp=0x69085f84 pc=0x81380e3
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x69085ff0 sp=0x69085fe4 pc=0x81390e8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x69085ff4 sp=0x69085ff0 pc=0x80baab1
created by testing.(*T).Run in goroutine 108
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

— watchflakes

gopherbot · 2024-05-03T00:12:19Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-02 22:14 openbsd-386-72 go@b64e5e38 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (20.28s)
    --- FAIL: TestTraceStressStartStop/Default (20.28s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-02 22:14 openbsd-386-72 go@b64e5e38 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.01s)
    --- FAIL: TestTraceManyStartStop/Default (1.01s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:575: signal: killed

2024-05-02 22:18 openbsd-386-72 go@e602625c internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (18.33s)
    --- FAIL: TestTraceStressStartStop/Default (18.33s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-02 22:18 openbsd-386-72 go@e602625c internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.83s)
    --- FAIL: TestTraceManyStartStop/Default (0.83s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x1140a317 m=3 sigcode=0

            goroutine 0 gp=0x50c08b48 m=3 mp=0x50c40a08 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x1f1c28d4, 0x40, 0x1f1c28a8)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x1f1c2880 sp=0x1f1c2870 pc=0x80a5501
            runtime.netpoll(0x335e9a79)
...
            edi    0x79c
            esi    0x50c08b48
            ebp    0x1f1c2828
            esp    0x1f1c280c
            eip    0x1140a317
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

— watchflakes

gopherbot · 2024-05-03T13:21:39Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-03 02:38 openbsd-386-72 go@a3eb55ce internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (26.02s)
    --- FAIL: TestTraceStressStartStop/Default (26.02s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (1s)
	TestTraceWaitOnPipe/Default (1s)

goroutine 120 gp=0x607b0248 m=2 mp=0x6043a508 [running]:
...
runtime.chansend1(0x607a5b40, 0x60483fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x60483f38 sp=0x60483f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x617fc908, 0x607a5b40)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x60483fe4 sp=0x60483f38 pc=0x8160277
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x60483ff0 sp=0x60483fe4 pc=0x815fb98
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x60483ff4 sp=0x60483ff0 pc=0x80baab1
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-03T19:26:18Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-03 16:48 openbsd-386-72 go@10c035ac internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (48.56s)
    --- FAIL: TestTraceStressStartStop/Default (48.56s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-03 16:48 openbsd-386-72 go@10c035ac internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.14s)
    --- FAIL: TestTraceIterPull/Default (0.14s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/iter-pull.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x247b4347 m=3 sigcode=0

            goroutine 0 gp=0x66c08b48 m=3 mp=0x66c40a08 [idle]:
            runtime.thrsleep(0x66c40d68, 0x3, 0x0, 0x0, 0x66c40d68)
            	runtime/sys_openbsd1.go:17 +0x21 fp=0x486aa270 sp=0x486aa260 pc=0x80a4ec1
            runtime.semasleep(0xffffffffffffffff)
...
            edi    0x1ac
            esi    0x66c08b48
            ebp    0x486aa218
            esp    0x486aa200
            eip    0x247b4347
            eflags 0x202
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-05-03 17:28 openbsd-386-72 go@7b5206bd internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (22.49s)
    --- FAIL: TestTraceStressStartStop/Default (22.49s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-03 17:28 openbsd-386-72 go@7b5206bd internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.11s)
    --- FAIL: TestTraceManyStartStop/Default (1.11s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:575: signal: killed

— watchflakes

gopherbot · 2024-05-04T09:53:48Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-04 07:50 openbsd-386-72 go@8841f50d internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (73.67s)
    --- FAIL: TestTraceStressStartStop/Default (73.67s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (2s)
	TestTraceWaitOnPipe/Default (2s)

goroutine 120 gp=0x60c07e68 m=2 mp=0x60c3a508 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6100aa08)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:611 +0x22 fp=0x60c35784 sp=0x60c35778 pc=0x81f5fe2
testing.tRunner(0x6100aa08, 0x61a66740)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x60c357e4 sp=0x60c35784 pc=0x8138473
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x60c357f0 sp=0x60c357e4 pc=0x8139478
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x60c357f4 sp=0x60c357f0 pc=0x80baab1
created by testing.(*T).Run in goroutine 114
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

— watchflakes

gopherbot · 2024-05-06T13:29:53Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-05 00:24 openbsd-386-72 go@c3dff93a internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (132.76s)
    --- FAIL: TestTraceStress/Default (132.76s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 108 gp=0x653b8248 m=3 mp=0x6503aa08 [running]:
...
runtime.chansend1(0x653ac200, 0x65083fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x65083f38 sp=0x65083f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x653ce008, 0x653ac200)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x65083fe4 sp=0x65083f38 pc=0x8160837
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x65083ff0 sp=0x65083fe4 pc=0x8160158
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x65083ff4 sp=0x65083ff0 pc=0x80baab1
created by os/exec.(*Cmd).Start in goroutine 103
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-05-05 00:26 openbsd-386-72 go@619b419a internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (132.35s)
    --- FAIL: TestTraceStress/Default (132.35s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 108 gp=0x6b4070e8 m=0 mp=0x83b1660 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6b80a208)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:611 +0x22 fp=0x6b485f84 sp=0x6b485f78 pc=0x81f6352
testing.tRunner(0x6b80a208, 0x6c2360c8)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x6b485fe4 sp=0x6b485f84 pc=0x81387e3
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x6b485ff0 sp=0x6b485fe4 pc=0x81397e8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6b485ff4 sp=0x6b485ff0 pc=0x80baab1
created by testing.(*T).Run in goroutine 102
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

2024-05-06 11:46 openbsd-386-72 go@ff0bc466 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (74.38s)
    --- FAIL: TestTraceStressStartStop/Default (74.38s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-06 11:46 openbsd-386-72 go@ff0bc466 internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (2.45s)
    --- FAIL: TestTraceWaitOnPipe/Default (2.45s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x21662e23 m=3 sigcode=0

            goroutine 0 gp=0x6b808b48 m=3 mp=0x6b840a08 [idle]:
            runtime.kevent(0x39, 0x0, 0x0, 0x12b7f704, 0x40, 0x12b7f6d8)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x12b7f6b0 sp=0x12b7f6a0 pc=0x80a5501
            runtime.netpoll(0x3b8e5965)
...
            edi    0x79c
            esi    0x6b808b48
            ebp    0x12b7f658
            esp    0x12b7f63c
            eip    0x21662e23
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-05-06 11:46 openbsd-386-72 go@ff0bc466 internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:575: context deadline exceeded
panic: test timed out after 3m0s

goroutine 132 gp=0x6d407d48 m=2 mp=0x6d43a508 [running]:
panic({0x8213fc0, 0x6f0bedf8})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x6d436784 sp=0x6d436730 pc=0x80819f8
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x6d4367f0 sp=0x6d436784 pc=0x813ca66
...
runtime.selectgo(0x6d485f94, 0x6d485f58, 0x0, 0x1, 0x1, 0x1)
	/tmp/workdir/go/src/runtime/select.go:335 +0xb6f fp=0x6d485f38 sp=0x6d485e4c pc=0x809755f
os/exec.(*Cmd).watchCtx(0x6d7bd448, 0x6d7a6000)
	/tmp/workdir/go/src/os/exec/exec.go:794 +0x268 fp=0x6d485fe4 sp=0x6d485f38 pc=0x8160608
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x6d485ff0 sp=0x6d485fe4 pc=0x8160158
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6d485ff4 sp=0x6d485ff0 pc=0x80baab1
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-06T16:32:20Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-06 14:00 openbsd-386-72 go@eabf59bc internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (20.10s)
    --- FAIL: TestTraceStressStartStop/Default (20.10s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-06 14:00 openbsd-386-72 go@eabf59bc internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.94s)
    --- FAIL: TestTraceManyStartStop/Default (0.94s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:575: context deadline exceeded

— watchflakes

gopherbot · 2024-05-06T19:34:36Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-06 15:34 openbsd-386-72 go@3c72dd51 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (37.23s)
    --- FAIL: TestTraceStressStartStop/Default (37.23s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-06 15:34 openbsd-386-72 go@3c72dd51 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.89s)
    --- FAIL: TestTraceManyStartStop/Default (1.89s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:575: signal: killed

2024-05-06 17:39 openbsd-386-72 go@9050ce9b internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (38.13s)
    --- FAIL: TestTraceStressStartStop/Default (38.13s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (1s)
	TestTraceWaitOnPipe/Default (1s)

goroutine 120 gp=0x6dc07e68 m=2 mp=0x6dc3a508 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6e00aa08)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:611 +0x22 fp=0x6dc35784 sp=0x6dc35778 pc=0x81f6352
testing.tRunner(0x6e00aa08, 0x6e9fa770)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x6dc357e4 sp=0x6dc35784 pc=0x81387e3
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x6dc357f0 sp=0x6dc357e4 pc=0x81397e8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6dc357f4 sp=0x6dc357f0 pc=0x80baab1
created by testing.(*T).Run in goroutine 114
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

— watchflakes

gopherbot · 2024-05-06T22:36:51Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-06 21:13 openbsd-386-72 go@be003bd0 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (44.13s)
    --- FAIL: TestTraceStressStartStop/Default (44.13s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-06 21:13 openbsd-386-72 go@be003bd0 internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.34s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.34s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x2958a57f m=3 sigcode=0

            goroutine 0 gp=0x56c08b48 m=3 mp=0x56c40a08 [idle]:
            runtime.thrsleep(0x56c40d68, 0x3, 0x0, 0x0, 0x56c40d68)
            	runtime/sys_openbsd1.go:17 +0x21 fp=0x275a7960 sp=0x275a7950 pc=0x80a4ea1
            runtime.semasleep(0xffffffffffffffff)
...
            edi    0x1ac
            esi    0x56c08b48
            ebp    0x275a7908
            esp    0x275a78f0
            eip    0x2958a57f
            eflags 0x202
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-05-06 21:13 openbsd-386-72 go@be003bd0 internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:575: context deadline exceeded
panic: test timed out after 3m0s

goroutine 132 gp=0x4c807e68 m=3 mp=0x4c83aa08 [running]:
panic({0x8213fc0, 0x4e568d88})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x4c833784 sp=0x4c833730 pc=0x80819f8
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x4c8337f0 sp=0x4c833784 pc=0x813ca46
...
runtime.selectgo(0x4c883f94, 0x4c883f58, 0x0, 0x1, 0x1, 0x1)
	/tmp/workdir/go/src/runtime/select.go:335 +0xb6f fp=0x4c883f38 sp=0x4c883e4c pc=0x809751f
os/exec.(*Cmd).watchCtx(0x4cbbf448, 0x4cba9c40)
	/tmp/workdir/go/src/os/exec/exec.go:794 +0x268 fp=0x4c883fe4 sp=0x4c883f38 pc=0x81605e8
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x4c883ff0 sp=0x4c883fe4 pc=0x8160138
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c883ff4 sp=0x4c883ff0 pc=0x80baa91
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-07T19:51:58Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-07 17:08 openbsd-386-72 go@55a06f79 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (27.23s)
    --- FAIL: TestTraceStressStartStop/Default (27.23s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-07 17:08 openbsd-386-72 go@55a06f79 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.26s)
    --- FAIL: TestTraceManyStartStop/Default (1.26s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:575: context deadline exceeded

2024-05-07 17:25 openbsd-386-72 go@27ed85d4 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (25.27s)
    --- FAIL: TestTraceStressStartStop/Default (25.27s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-07 17:25 openbsd-386-72 go@27ed85d4 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.20s)
    --- FAIL: TestTraceManyStartStop/Default (1.20s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x4d4ad65b m=3 sigcode=0

            goroutine 0 gp=0x6d808b48 m=3 mp=0x6d840a08 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x39073b04, 0x40, 0x39073ad8)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x39073ab0 sp=0x39073aa0 pc=0x80a54e1
            runtime.netpoll(0x2776b8f6)
...
            edi    0x79c
            esi    0x6d808b48
            ebp    0x39073a58
            esp    0x39073a3c
            eip    0x4d4ad65b
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-05-07 18:03 openbsd-386-72 go@9c4849bf internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (15.51s)
    --- FAIL: TestTraceStressStartStop/Default (15.51s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-07 18:03 openbsd-386-72 go@9c4849bf internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.69s)
    --- FAIL: TestTraceManyStartStop/Default (0.69s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x1398d27b m=2 sigcode=0

            goroutine 0 gp=0x4d408908 m=2 mp=0x4d440508 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x14eb97d4, 0x40, 0x14eb97a8)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x14eb9780 sp=0x14eb9770 pc=0x80a54e1
            runtime.netpoll(0x3790c225)
...
            edi    0x79c
            esi    0x4d408908
            ebp    0x14eb9728
            esp    0x14eb970c
            eip    0x1398d27b
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-05-07 18:24 openbsd-386-72 go@1e4de058 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (42.48s)
    --- FAIL: TestTraceStressStartStop/Default (42.48s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-07 18:24 openbsd-386-72 go@1e4de058 internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.94s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.94s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x148db61f m=3 sigcode=0

            goroutine 0 gp=0x64008b48 m=3 mp=0x64040a08 [idle]:
            runtime.thrwakeup(0x64040368, 0x1)
            	runtime/sys_openbsd1.go:27 +0x21 fp=0x4697f7ac sp=0x4697f79c pc=0x80a4ed1
            runtime.semawakeup(0x64040008)
            	runtime/os_openbsd.go:128 +0x37 fp=0x4697f7cc sp=0x4697f7ac pc=0x8082107
            runtime.notewakeup(0x8b32de4)
            	runtime/lock_sema.go:163 +0x57 fp=0x4697f7e4 sp=0x4697f7cc pc=0x80565c7
            runtime.entersyscall_sysmon()
            	runtime/proc.go:4377 +0x59 fp=0x4697f7f0 sp=0x4697f7e4 pc=0x808f749
            runtime.systemstack(0x40000)
            	runtime/asm_386.s:374 +0x35 fp=0x4697f7f4 sp=0x4697f7f0 pc=0x80bc3a5

            goroutine 11 gp=0x642c9208 m=3 mp=0x64040a08 [syscall]:
            syscall.syscall(0x80d7b20, 0x3c, 0x64320000, 0x8000)
            	runtime/sys_openbsd3.go:24 +0x20 fp=0x6403eddc sp=0x6403edcc pc=0x80bba50
            syscall.read(0x3c, {0x64320000, 0x8000, 0x8000})
            	syscall/zsyscall_openbsd_386.go:1192 +0x49 fp=0x6403ee04
        trace_test.go:575: signal: killed

2024-05-07 18:24 openbsd-386-72 go@1e4de058 internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:575: context deadline exceeded
panic: test timed out after 3m0s

goroutine 132 gp=0x64bae248 m=3 mp=0x6483aa08 [running]:
panic({0x8213fc0, 0x65620de0})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x64835784 sp=0x64835730 pc=0x80819f8
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x648357f0 sp=0x64835784 pc=0x813ca46
...
runtime.chansend1(0x6481e4c0, 0x64883fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x64883f38 sp=0x64883f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x64bc92c8, 0x6481e4c0)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x64883fe4 sp=0x64883f38 pc=0x8160817
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x64883ff0 sp=0x64883fe4 pc=0x8160138
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x64883ff4 sp=0x64883ff0 pc=0x80baa91
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-05-07 18:36 openbsd-386-72 go@709d6d5d internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (97.08s)
    --- FAIL: TestTraceStressStartStop/Default (97.08s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-07 18:36 openbsd-386-72 go@709d6d5d internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (3.41s)
    --- FAIL: TestTraceWaitOnPipe/Default (3.41s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x24a3ac4f m=1 sigcode=0

            goroutine 0 gp=0x53008368 m=1 mp=0x53040008 [idle]:
            runtime.usleep(0x14)
            	runtime/sys_openbsd2.go:140 +0x19 fp=0x3bbef834 sp=0x3bbef824 pc=0x80a51c9
            runtime.sysmon()
...
            edi    0x98
            esi    0x48050004
            ebp    0x3bbef7a0
            esp    0x3bbef78c
            eip    0x24a3ac4f
            eflags 0x247
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-05-07 18:38 openbsd-386-72 go@008cc58a internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (19.67s)
    --- FAIL: TestTraceStressStartStop/Default (19.67s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-07 18:38 openbsd-386-72 go@008cc58a internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.91s)
    --- FAIL: TestTraceManyStartStop/Default (0.91s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x4b6da6a3 m=3 sigcode=0

            goroutine 0 gp=0x6b808b48 m=3 mp=0x6b840a08 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x423da414, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x423da3c0 sp=0x423da3b0 pc=0x80a54e1
            runtime.netpoll(0xffffffffffffffff)
...
panic: test timed out after 3m0s
running tests:
	TestTraceManyStartStop (1s)

goroutine 115 gp=0x63807d48 m=2 mp=0x6383a508 [running]:
panic({0x8214fe0, 0x655de7e0})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x63883f84 sp=0x63883f30 pc=0x80819f8
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x63883ff0 sp=0x63883f84 pc=0x813e0b6
runtime.goexit({})
...
runtime.gopark(0x82579a4, 0x638180f0, 0x1a, 0xa, 0x0)
	/tmp/workdir/go/src/runtime/proc.go:401 +0xfa fp=0x63838f8c sp=0x63838f78 pc=0x80852da
runtime.gcBgMarkWorker(0x6381ea00)
	/tmp/workdir/go/src/runtime/mgc.go:1352 +0xeb fp=0x63838fe8 sp=0x63838f8c pc=0x806360b
runtime.gcBgMarkStartWorkers.gowrap1()
	/tmp/workdir/go/src/runtime/mgc.go:1268 +0x21 fp=0x63838ff0 sp=0x63838fe8 pc=0x8063501
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x63838ff4 sp=0x63838ff0 pc=0x80baa91
created by runtime.gcBgMarkStartWorkers in goroutine 10
	/tmp/workdir/go/src/runtime/mgc.go:1268 +0x114

— watchflakes

gopherbot · 2024-05-07T21:53:24Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-07 18:44 openbsd-386-72 go@dc548bb3 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (132.35s)
    --- FAIL: TestTraceStress/Default (132.34s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 108 gp=0x6dfb0248 m=2 mp=0x6dc3a508 [running]:
...
runtime.chansend1(0x6dfa6200, 0x6dc83fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x6dc83f38 sp=0x6dc83f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x6dfb8008, 0x6dfa6200)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x6dc83fe4 sp=0x6dc83f38 pc=0x8161e37
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x6dc83ff0 sp=0x6dc83fe4 pc=0x8161758
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6dc83ff4 sp=0x6dc83ff0 pc=0x80baa91
created by os/exec.(*Cmd).Start in goroutine 103
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-05-07 18:48 openbsd-386-72 go@5f5e9f4f internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (18.65s)
    --- FAIL: TestTraceStressStartStop/Default (18.65s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed

2024-05-07 18:48 openbsd-386-72 go@5f5e9f4f internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.90s)
    --- FAIL: TestTraceManyStartStop/Default (0.90s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:573: stderr: SIGQUIT: quit
            PC=0x199873ab m=3 sigcode=0

            goroutine 0 gp=0x50808b48 m=3 mp=0x50840a08 [idle]:
            runtime.thrsleep(0x50840d68, 0x3, 0x0, 0x0, 0x50840d68)
            	runtime/sys_openbsd1.go:17 +0x21 fp=0x2d821070 sp=0x2d821060 pc=0x80a4ea1
            runtime.semasleep(0xffffffffffffffff)
...
            edi    0x18c
            esi    0x50808b48
            ebp    0x2d821018
            esp    0x2d821000
            eip    0x199873ab
            eflags 0x202
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:575: exit status 2

2024-05-07 19:58 openbsd-386-72 go@9c5269c2 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (36.65s)
    --- FAIL: TestTraceStressStartStop/Default (36.65s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (1s)
	TestTraceWaitOnPipe/Default (1s)

goroutine 120 gp=0x63807d48 m=0 mp=0x83b1660 [running]:
...
runtime.chansend1(0x638f3200, 0x63883fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x63883f38 sp=0x63883f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x63b7e0c8, 0x638f3200)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x63883fe4 sp=0x63883f38 pc=0x8161e37
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x63883ff0 sp=0x63883fe4 pc=0x8161758
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x63883ff4 sp=0x63883ff0 pc=0x80baa91
created by os/exec.(*Cmd).Start in goroutine 115
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-08T19:08:35Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-08 17:09 openbsd-386-72 go@93e3696b internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (33.16s)
    --- FAIL: TestTraceStressStartStop/Default (33.16s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:575: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceWaitOnPipe (1s)
	TestTraceWaitOnPipe/Default (1s)

goroutine 120 gp=0x6d007e68 m=3 mp=0x6d03aa08 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6d40a808)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:611 +0x22 fp=0x6d083f84 sp=0x6d083f78 pc=0x81f6342
testing.tRunner(0x6d40a808, 0x6ece8758)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x6d083fe4 sp=0x6d083f84 pc=0x8139de3
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x6d083ff0 sp=0x6d083fe4 pc=0x813ade8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6d083ff4 sp=0x6d083ff0 pc=0x80baa91
created by testing.(*T).Run in goroutine 114
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

2024-05-08 17:47 openbsd-386-72 go@c3bd543c internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (13.30s)
    --- FAIL: TestTraceStressStartStop/Default (13.30s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-08 17:47 openbsd-386-72 go@c3bd543c internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.56s)
    --- FAIL: TestTraceManyStartStop/Default (0.56s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x26bf9fc3 m=3 sigcode=0

            goroutine 0 gp=0x5e408b48 m=3 mp=0x5e440a08 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x1ef84294, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x1ef84240 sp=0x1ef84230 pc=0x80a5391
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x5e408b48
            ebp    0x1ef841e8
            esp    0x1ef841cc
            eip    0x26bf9fc3
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

2024-05-08 17:48 openbsd-386-72 go@97c13cfb internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (37.13s)
    --- FAIL: TestTraceStressStartStop/Default (37.13s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-08 17:48 openbsd-386-72 go@97c13cfb internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.82s)
    --- FAIL: TestTraceManyStartStop/Default (1.82s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x1e7fdddf m=3 sigcode=0

            goroutine 0 gp=0x58408b48 m=3 mp=0x58442a08 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x4cb2e7a4, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x4cb2e750 sp=0x4cb2e740 pc=0x80a52c1
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x58408b48
            ebp    0x4cb2e6f8
            esp    0x4cb2e6dc
            eip    0x1e7fdddf
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

2024-05-08 17:52 openbsd-386-72 go@36d32f68 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (132.99s)
    --- FAIL: TestTraceStress/Default (132.99s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 117 gp=0x66bb8248 m=2 mp=0x6683c508 [running]:
...
runtime.chansend1(0x66820480, 0x66883fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x66883f38 sp=0x66883f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x66be2008, 0x66820480)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x66883fe4 sp=0x66883f38 pc=0x8162ea7
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x66883ff0 sp=0x66883fe4 pc=0x81627c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x66883ff4 sp=0x66883ff0 pc=0x80bbb61
created by os/exec.(*Cmd).Start in goroutine 112
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-08T21:10:03Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-08 19:04 openbsd-386-72 go@4513f1a1 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (132.33s)
    --- FAIL: TestTraceStress/Default (132.33s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
running tests:
	TestTraceStressStartStop (7s)
	TestTraceStressStartStop/Default (7s)

goroutine 118 gp=0x654070e8 m=2 mp=0x6543c508 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x657ec308)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:615 +0x32 fp=0x65482f84 sp=0x65482f70 pc=0x81f7cb2
testing.tRunner(0x657ec308, 0x66fdc110)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x65482fe4 sp=0x65482f84 pc=0x813ae53
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x65482ff0 sp=0x65482fe4 pc=0x813be58
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x65482ff4 sp=0x65482ff0 pc=0x80bbb61
created by testing.(*T).Run in goroutine 112
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

— watchflakes

gopherbot · 2024-05-09T19:26:25Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-09 17:06 openbsd-386-72 go@dd6dee48 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (18.71s)
    --- FAIL: TestTraceStressStartStop/Default (18.71s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-09 17:06 openbsd-386-72 go@dd6dee48 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.86s)
    --- FAIL: TestTraceManyStartStop/Default (0.86s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x46f9062b m=3 sigcode=0

            goroutine 0 gp=0x67008b48 m=3 mp=0x67042a08 [idle]:
            runtime.kevent(0x3b, 0x0, 0x0, 0x179ca3b4, 0x40, 0x179ca388)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x179ca360 sp=0x179ca350 pc=0x80a53d1
            runtime.netpoll(0x33dd109f)
...
            edi    0x79c
            esi    0x67008b48
            ebp    0x179ca308
            esp    0x179ca2ec
            eip    0x46f9062b
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

— watchflakes

gopherbot · 2024-05-09T22:28:40Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-09 19:20 openbsd-386-72 go@0b5f7225 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (33.86s)
    --- FAIL: TestTraceStressStartStop/Default (33.86s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: exit status 1

2024-05-09 20:17 openbsd-386-72 go@e2375c49 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (37.42s)
    --- FAIL: TestTraceStressStartStop/Default (37.42s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-09 20:17 openbsd-386-72 go@e2375c49 internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.65s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.65s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x27a1e10f m=3 sigcode=0

            goroutine 0 gp=0x6ec08b48 m=3 mp=0x6ec42a08 [idle]:
            runtime.kevent(0x3a, 0x0, 0x0, 0x3a5c02d4, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x3a5c0280 sp=0x3a5c0270 pc=0x80a53d1
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x6ec08b48
            ebp    0x3a5c0228
            esp    0x3a5c020c
            eip    0x27a1e10f
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

— watchflakes

gopherbot · 2024-05-10T00:30:10Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-09 22:40 openbsd-386-72 go@58561624 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (15.91s)
    --- FAIL: TestTraceStressStartStop/Default (15.91s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-09 22:40 openbsd-386-72 go@58561624 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.70s)
    --- FAIL: TestTraceManyStartStop/Default (0.70s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x301988bf m=3 sigcode=0

            goroutine 0 gp=0x50408b48 m=3 mp=0x50442a08 [idle]:
            runtime.kevent(0x3b, 0x0, 0x0, 0x22c73744, 0x40, 0x22c73718)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x22c736f0 sp=0x22c736e0 pc=0x80a53d1
            runtime.netpoll(0x3511c203)
...
            edi    0x79c
            esi    0x50408b48
            ebp    0x22c73698
            esp    0x22c7367c
            eip    0x301988bf
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

— watchflakes

gopherbot · 2024-05-10T01:30:54Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-09 23:06 openbsd-386-72 go@2064413b internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (30.59s)
    --- FAIL: TestTraceStressStartStop/Default (30.59s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-09 23:06 openbsd-386-72 go@2064413b internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.73s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.73s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:579: signal: killed

2024-05-09 23:06 openbsd-386-72 go@2064413b internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:579: context deadline exceeded
panic: test timed out after 3m0s

goroutine 146 gp=0x4b0070e8 m=2 mp=0x4b03c508 [running]:
panic({0x82162c0, 0x4ce06fa8})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x4c87ff84 sp=0x4c87ff30 pc=0x8081738
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x4c87fff0 sp=0x4c87ff84 pc=0x813f1d6
...
testing.(*F).Fuzz.func1.1(0x4b3f5b08)
	/tmp/workdir/go/src/testing/fuzz.go:335 +0x2bc fp=0x4b086f84 sp=0x4b086eec pc=0x8132c5c
testing.tRunner(0x4b3f5b08, 0x4ce2a500)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x4b086fe4 sp=0x4b086f84 pc=0x813af53
testing.(*F).Fuzz.func1.gowrap1()
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x28 fp=0x4b086ff0 sp=0x4b086fe4 pc=0x8132988
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4b086ff4 sp=0x4b086ff0 pc=0x80bbc61
created by testing.(*F).Fuzz.func1 in goroutine 138
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x4df

2024-05-09 23:09 openbsd-386-72 go@671696a2 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (23.97s)
    --- FAIL: TestTraceStressStartStop/Default (23.97s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-09 23:09 openbsd-386-72 go@671696a2 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.12s)
    --- FAIL: TestTraceManyStartStop/Default (1.12s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x1b0eccaf m=3 sigcode=0

            goroutine 0 gp=0x59008b48 m=3 mp=0x59042a08 [idle]:
            runtime.kevent(0x3b, 0x0, 0x0, 0x481eb4b4, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x481eb460 sp=0x481eb450 pc=0x80a53d1
            runtime.netpoll(0xffffffffffffffff)
...
panic: test timed out after 3m0s
	running tests:
		TestTraceWaitOnPipe (0s)

goroutine 129 gp=0x69807e68 m=3 mp=0x6983ca08 [running]:
panic({0x82162c0, 0x6b422850})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x69837784 sp=0x69837730 pc=0x8081738
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x698377f0 sp=0x69837784 pc=0x813f1d6
runtime.goexit({})
...
runtime.selectgo(0x69885f94, 0x69885f58, 0x0, 0x1, 0x1, 0x1)
	/tmp/workdir/go/src/runtime/select.go:335 +0xb6f fp=0x69885f38 sp=0x69885e4c pc=0x809731f
os/exec.(*Cmd).watchCtx(0x6ace0488, 0x69bab740)
	/tmp/workdir/go/src/os/exec/exec.go:794 +0x268 fp=0x69885fe4 sp=0x69885f38 pc=0x8162d78
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x69885ff0 sp=0x69885fe4 pc=0x81628c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x69885ff4 sp=0x69885ff0 pc=0x80bbc61
created by os/exec.(*Cmd).Start in goroutine 120
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-10T15:41:15Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-10 02:36 openbsd-386-72 go@1259a30a internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (29.68s)
    --- FAIL: TestTraceStressStartStop/Default (29.68s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-10 02:36 openbsd-386-72 go@1259a30a internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.51s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.50s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x113479ef m=3 sigcode=0

            goroutine 0 gp=0x70808b48 m=3 mp=0x70842a08 [idle]:
            runtime.thrsleep(0x70842d04, 0x3, 0x0, 0x0, 0x70842d04)
            	runtime/sys_openbsd1.go:17 +0x21 fp=0x45c62170 sp=0x45c62160 pc=0x80a4d91
            runtime.semasleep(0xffffffffffffffff)
...
            edi    0x1ac
            esi    0x70808b48
            ebp    0x45c62118
            esp    0x45c62100
            eip    0x113479ef
            eflags 0x202
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

— watchflakes

gopherbot · 2024-05-11T01:49:21Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-10 21:32 openbsd-386-72 go@a0a6026b internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (131.60s)
    --- FAIL: TestTraceStress/Default (131.60s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceStressStartStop (7s)
		TestTraceStressStartStop/Default (7s)

goroutine 118 gp=0x6ac070e8 m=2 mp=0x6ac3c508 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6afec308)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:615 +0x32 fp=0x6ac82f84 sp=0x6ac82f70 pc=0x81f7e42
testing.tRunner(0x6afec308, 0x6c876128)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x6ac82fe4 sp=0x6ac82f84 pc=0x813afe3
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x6ac82ff0 sp=0x6ac82fe4 pc=0x813bfe8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6ac82ff4 sp=0x6ac82ff0 pc=0x80bbcf1
created by testing.(*T).Run in goroutine 112
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

— watchflakes

gopherbot · 2024-05-11T23:05:04Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-11 20:38 openbsd-386-72 go@7f9edb42 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (130.82s)
    --- FAIL: TestTraceStress/Default (130.82s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceStressStartStop (7s)
		TestTraceStressStartStop/Default (7s)

goroutine 118 gp=0x5b807c28 m=0 mp=0x83b64c0 [running]:
...
runtime.chansend1(0x5c5d8280, 0x5b883fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x5b883f38 sp=0x5b883f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x5bbc4008, 0x5c5d8280)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x5b883fe4 sp=0x5b883f38 pc=0x8163037
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x5b883ff0 sp=0x5b883fe4 pc=0x8162958
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x5b883ff4 sp=0x5b883ff0 pc=0x80bbcf1
created by os/exec.(*Cmd).Start in goroutine 113
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-12T06:30:17Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-11 21:29 gotip-linux-386-longtest go@9623a358 internal/trace/v2.TestTraceStacks/Stress (log)

=== RUN   TestTraceStacks/Stress
    exec.go:193: test timed out while running command: /home/swarming/.swarming/w/ir/x/w/goroot/bin/go run testdata/testprog/stacks.go
    trace_test.go:579: signal: killed
--- FAIL: TestTraceStacks/Stress (791.46s)

— watchflakes

gopherbot · 2024-05-13T16:11:24Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-13 14:20 openbsd-386-72 go@0eaf8d97 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (130.88s)
    --- FAIL: TestTraceStress/Default (130.88s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceStressStartStop (7s)
		TestTraceStressStartStop/Default (7s)

goroutine 118 gp=0x60007d48 m=2 mp=0x6003c508 [running]:
...
runtime.chansend1(0x60020480, 0x60083fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x60083f38 sp=0x60083f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x603d0008, 0x60020480)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x60083fe4 sp=0x60083f38 pc=0x8163037
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x60083ff0 sp=0x60083fe4 pc=0x8162958
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x60083ff4 sp=0x60083ff0 pc=0x80bbcf1
created by os/exec.(*Cmd).Start in goroutine 113
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-13T17:12:15Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-13 15:52 openbsd-386-72 go@9ea4770e internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (27.94s)
    --- FAIL: TestTraceStressStartStop/Default (27.94s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-13 15:52 openbsd-386-72 go@9ea4770e internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.34s)
    --- FAIL: TestTraceManyStartStop/Default (1.34s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x2425bc4f m=3 sigcode=0

            goroutine 0 gp=0x69c08b48 m=3 mp=0x69c42a08 [idle]:
            runtime.kevent(0x3b, 0x0, 0x0, 0x49278e84, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x49278e30 sp=0x49278e20 pc=0x80a5051
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x69c08b48
            ebp    0x49278dd8
            esp    0x49278dbc
            eip    0x2425bc4f
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

2024-05-13 15:52 openbsd-386-72 go@9ea4770e internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.00s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.00s)
        trace_test.go:579: context deadline exceeded
panic: test timed out after 3m0s
	running tests:
		TestTraceIterPull (1s)
		TestTraceIterPull/Stress (1s)

goroutine 134 gp=0x6f007e68 m=0 mp=0x83b64c0 [running]:
panic({0x82162c0, 0x6fb2e940})
...
runtime.selectgo(0x6f082f94, 0x6f082f58, 0x0, 0x1, 0x1, 0x1)
	/tmp/workdir/go/src/runtime/select.go:335 +0xb6f fp=0x6f082f38 sp=0x6f082e4c pc=0x809731f
os/exec.(*Cmd).watchCtx(0x6f3e7ec8, 0x6f0fafc0)
	/tmp/workdir/go/src/os/exec/exec.go:794 +0x268 fp=0x6f082fe4 sp=0x6f082f38 pc=0x8162e08
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x6f082ff0 sp=0x6f082fe4 pc=0x8162958
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6f082ff4 sp=0x6f082ff0 pc=0x80bbcf1
created by os/exec.(*Cmd).Start in goroutine 120
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-13T18:13:07Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-13 15:55 openbsd-386-72 go@f43d9c40 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (25.51s)
    --- FAIL: TestTraceStressStartStop/Default (25.51s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceManyStartStop (1s)

goroutine 125 gp=0x54c070e8 m=3 mp=0x54c3ca08 [running]:
panic({0x82162c0, 0x55738778})
...
runtime.selectgo(0x54c87f94, 0x54c87f58, 0x0, 0x1, 0x1, 0x1)
	/tmp/workdir/go/src/runtime/select.go:335 +0xb6f fp=0x54c87f38 sp=0x54c87e4c pc=0x809731f
os/exec.(*Cmd).watchCtx(0x55de6d88, 0x54c206c0)
	/tmp/workdir/go/src/os/exec/exec.go:794 +0x268 fp=0x54c87fe4 sp=0x54c87f38 pc=0x8162e08
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x54c87ff0 sp=0x54c87fe4 pc=0x8162958
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x54c87ff4 sp=0x54c87ff0 pc=0x80bbcf1
created by os/exec.(*Cmd).Start in goroutine 120
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-05-13 16:41 openbsd-386-72 go@b5bfb5a3 internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (125.27s)
    --- FAIL: TestTraceStress/Default (125.27s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:579: exit status 1

2024-05-13 16:41 openbsd-386-72 go@b5bfb5a3 internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.47s)
    --- FAIL: TestTraceIterPull/Default (0.47s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/iter-pull.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x25965287 m=3 sigcode=0

            goroutine 0 gp=0x70008b48 m=3 mp=0x70042a08 [idle]:
            runtime.thrsleep(0x70042d04, 0x3, 0x0, 0x0, 0x70042d04)
            	runtime/sys_openbsd1.go:17 +0x21 fp=0x47bcd0d0 sp=0x47bcd0c0 pc=0x80a4a11
            runtime.semasleep(0xffffffffffffffff)
...
panic: test timed out after 3m0s

goroutine 149 gp=0x60407c28 m=3 mp=0x6043ca08 [running]:
panic({0x82162c0, 0x60efade8})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x60436784 sp=0x60436730 pc=0x8081738
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x604367f0 sp=0x60436784 pc=0x813f2b6
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x604367f4 sp=0x604367f0 pc=0x80bbd41
created by time.goFunc
...
testing.(*F).Fuzz.func1.1(0x607edb08)
	/tmp/workdir/go/src/testing/fuzz.go:335 +0x2bc fp=0x60486f84 sp=0x60486eec pc=0x8132d3c
testing.tRunner(0x607edb08, 0x605d04b0)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x60486fe4 sp=0x60486f84 pc=0x813b033
testing.(*F).Fuzz.func1.gowrap1()
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x28 fp=0x60486ff0 sp=0x60486fe4 pc=0x8132a68
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x60486ff4 sp=0x60486ff0 pc=0x80bbd41
created by testing.(*F).Fuzz.func1 in goroutine 141
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x4df

— watchflakes

gopherbot · 2024-05-13T23:17:22Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-13 21:22 openbsd-386-72 go@ec1724bc internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (25.01s)
    --- FAIL: TestTraceStressStartStop/Default (25.01s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceManyStartStop (1s)
		TestTraceManyStartStop/Default (1s)

goroutine 125 gp=0x70407e68 m=0 mp=0x83b64c0 [running]:
...
runtime.chansend1(0x71f2df40, 0x70483fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x70483f38 sp=0x70483f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x71cd4cc8, 0x71f2df40)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x70483fe4 sp=0x70483f38 pc=0x8163157
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x70483ff0 sp=0x70483fe4 pc=0x8162a78
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x70483ff4 sp=0x70483ff0 pc=0x80bbe11
created by os/exec.(*Cmd).Start in goroutine 120
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-05-13 21:31 openbsd-386-72 go@509bbeb4 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (23.91s)
    --- FAIL: TestTraceStressStartStop/Default (23.91s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-13 21:31 openbsd-386-72 go@509bbeb4 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.14s)
    --- FAIL: TestTraceManyStartStop/Default (1.14s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x46b1e1bb m=3 sigcode=0

            goroutine 0 gp=0x66c08b48 m=3 mp=0x66c42a08 [idle]:
            runtime.kevent(0x3b, 0x0, 0x0, 0x26ca44e4, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x26ca4490 sp=0x26ca4480 pc=0x80a5101
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x66c08b48
            ebp    0x26ca4438
            esp    0x26ca441c
            eip    0x46b1e1bb
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

2024-05-13 21:32 openbsd-386-72 go@133cdfb4 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (50.12s)
    --- FAIL: TestTraceStressStartStop/Default (50.12s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceWaitOnPipe (1s)
		TestTraceWaitOnPipe/Default (1s)

goroutine 132 gp=0x51c07d48 m=2 mp=0x51c3c508 [running]:
...
runtime.chansend1(0x51f69fc0, 0x51c83fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x51c83f38 sp=0x51c83f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x52cf29c8, 0x51f69fc0)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x51c83fe4 sp=0x51c83f38 pc=0x8163ca7
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x51c83ff0 sp=0x51c83fe4 pc=0x81635c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x51c83ff4 sp=0x51c83ff0 pc=0x80bbe11
created by os/exec.(*Cmd).Start in goroutine 127
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

2024-05-13 21:38 openbsd-386-72 go@a949ade5 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (19.12s)
    --- FAIL: TestTraceStressStartStop/Default (19.12s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-13 21:38 openbsd-386-72 go@a949ade5 internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (0.87s)
    --- FAIL: TestTraceManyStartStop/Default (0.87s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x383128c7 m=3 sigcode=0

            goroutine 0 gp=0x6c808b48 m=3 mp=0x6c842a08 [idle]:
            runtime.kevent(0x3b, 0x0, 0x0, 0x2df1bdf4, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x2df1bda0 sp=0x2df1bd90 pc=0x80a5101
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x6c808b48
            ebp    0x2df1bd48
            esp    0x2df1bd2c
            eip    0x383128c7
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

— watchflakes

gopherbot · 2024-05-14T17:31:25Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-13 21:47 openbsd-386-72 go@8623c0ba internal/trace/v2.TestTraceStress (log)

--- FAIL: TestTraceStress (131.73s)
    --- FAIL: TestTraceStress/Default (131.73s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceStressStartStop (7s)
		TestTraceStressStartStop/Default (7s)

goroutine 118 gp=0x4e807c28 m=2 mp=0x4e83c508 [running]:
...
runtime.chansend1(0x4eb9e280, 0x4e885fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x4e885f38 sp=0x4e885f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x4ebc6008, 0x4eb9e280)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x4e885fe4 sp=0x4e885f38 pc=0x8163ca7
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x4e885ff0 sp=0x4e885fe4 pc=0x81635c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e885ff4 sp=0x4e885ff0 pc=0x80bbe11
created by os/exec.(*Cmd).Start in goroutine 113
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-14T18:32:18Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-14 16:25 openbsd-386-72 go@c7c578cd internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (43.13s)
    --- FAIL: TestTraceStressStartStop/Default (43.13s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-14 16:25 openbsd-386-72 go@c7c578cd internal/trace/v2.TestTraceWaitOnPipe (log)

--- FAIL: TestTraceWaitOnPipe (0.60s)
    --- FAIL: TestTraceWaitOnPipe/Default (0.60s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x35819eff m=3 sigcode=0

            goroutine 0 gp=0x55808b48 m=3 mp=0x55842a08 [idle]:
            runtime.kevent(0x3b, 0x0, 0x0, 0x4288edd4, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x4288ed80 sp=0x4288ed70 pc=0x80a5101
            runtime.netpoll(0xffffffffffffffff)
...
            	internal/poll/fd_unix.go:165 +0x1f6 fp=0x55840e4c sp=0x55840e04 pc=0x81382f6
            os.(*File).read(...)
            	os/file_posix.go:29
            os.(*File).Read(0x55ad7098, {0x55af8000, 0x8000, 0x8000})
            	os/file.go:124 +0x6a fp=0x55840e70 sp=0x55840e4c pc=0x8140dca
            os.(*fileWithoutWriteTo).Read(0x55ad70d8, {0x55af8000, 0x8000, 0x8000})
            	<autogenerated>:1 +0x3c fp=0x55840e90 sp=0x55840e70 pc=0x814934c
            io.copyBuffer({0x87dca2c, 0x55ad9860}, {0x87dcad0, 0x55ad70d8}, {0x0, 0x0, 0x0})
            	io/io.go:429 +0x1e0 fp=0x55840edc sp=0x55840e90 pc=0x8131960
        trace_test.go:579: signal: killed

2024-05-14 16:25 openbsd-386-72 go@c7c578cd internal/trace/v2.TestTraceIterPull (log)

--- FAIL: TestTraceIterPull (0.00s)
    --- FAIL: TestTraceIterPull/Default (0.00s)
        trace_test.go:579: context deadline exceeded
panic: test timed out after 3m0s

goroutine 146 gp=0x6fc07e68 m=3 mp=0x6fc3ca08 [running]:
panic({0x8217360, 0x71998e78})
	/tmp/workdir/go/src/runtime/panic.go:778 +0x138 fp=0x6fc36784 sp=0x6fc36730 pc=0x8081808
testing.(*M).startAlarm.func1()
	/tmp/workdir/go/src/testing/testing.go:2367 +0x386 fp=0x6fc367f0 sp=0x6fc36784 pc=0x813fed6
...
testing.(*F).Fuzz.func1.1(0x6ffedb08)
	/tmp/workdir/go/src/testing/fuzz.go:335 +0x2bc fp=0x6fc85f84 sp=0x6fc85eec pc=0x813395c
testing.tRunner(0x6ffedb08, 0x71a1e500)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x6fc85fe4 sp=0x6fc85f84 pc=0x813bc53
testing.(*F).Fuzz.func1.gowrap1()
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x28 fp=0x6fc85ff0 sp=0x6fc85fe4 pc=0x8133688
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6fc85ff4 sp=0x6fc85ff0 pc=0x80bbe11
created by testing.(*F).Fuzz.func1 in goroutine 138
	/tmp/workdir/go/src/testing/fuzz.go:322 +0x4df

— watchflakes

gopherbot · 2024-05-14T20:33:58Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-14 17:18 openbsd-386-72 go@0767ffdf internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (41.36s)
    --- FAIL: TestTraceStressStartStop/Default (41.36s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceWaitOnPipe (1s)
		TestTraceWaitOnPipe/Default (1s)

goroutine 132 gp=0x604070e8 m=2 mp=0x6043c508 [running]:
...
runtime.chansend1(0x61f31e40, 0x60485fd4)
	/tmp/workdir/go/src/runtime/chan.go:146 +0x24 fp=0x60485f38 sp=0x60485f20 pc=0x804d164
os/exec.(*Cmd).watchCtx(0x61a5ef08, 0x61f31e40)
	/tmp/workdir/go/src/os/exec/exec.go:848 +0x497 fp=0x60485fe4 sp=0x60485f38 pc=0x8163ca7
os/exec.(*Cmd).Start.gowrap2()
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x28 fp=0x60485ff0 sp=0x60485fe4 pc=0x81635c8
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x60485ff4 sp=0x60485ff0 pc=0x80bbe11
created by os/exec.(*Cmd).Start in goroutine 127
	/tmp/workdir/go/src/os/exec/exec.go:750 +0x8d5

— watchflakes

gopherbot · 2024-05-14T21:34:46Z

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/trace/v2" && `test timed out`

2024-05-14 18:34 openbsd-386-72 go@ca5fc8de internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (28.58s)
    --- FAIL: TestTraceStressStartStop/Default (28.58s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-14 18:34 openbsd-386-72 go@ca5fc8de internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.36s)
    --- FAIL: TestTraceManyStartStop/Default (1.36s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x1a8f79f7 m=3 sigcode=0

            goroutine 0 gp=0x68c08b48 m=3 mp=0x68c42a08 [idle]:
            runtime.kevent(0x3c, 0x0, 0x0, 0x158b6454, 0x40, 0x0)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x158b6400 sp=0x158b63f0 pc=0x80a5101
            runtime.netpoll(0xffffffffffffffff)
...
            edi    0x79c
            esi    0x68c08b48
            ebp    0x158b63a8
            esp    0x158b638c
            eip    0x1a8f79f7
            eflags 0x207
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

2024-05-14 19:09 openbsd-386-72 go@efc34734 internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (48.37s)
    --- FAIL: TestTraceStressStartStop/Default (48.37s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed
panic: test timed out after 3m0s
	running tests:
		TestTraceWaitOnPipe (1s)
		TestTraceWaitOnPipe/Default (1s)

goroutine 132 gp=0x6f007e68 m=2 mp=0x6f03c508 [running]:
...
internal/trace/v2_test.testTraceProg.func2(0x6f3f4b08)
	/tmp/workdir/go/src/internal/trace/v2/trace_test.go:615 +0x32 fp=0x6f037784 sp=0x6f037770 pc=0x81f8ab2
testing.tRunner(0x6f3f4b08, 0x70dcc798)
	/tmp/workdir/go/src/testing/testing.go:1690 +0x113 fp=0x6f0377e4 sp=0x6f037784 pc=0x813bc53
testing.(*T).Run.gowrap1()
	/tmp/workdir/go/src/testing/testing.go:1743 +0x28 fp=0x6f0377f0 sp=0x6f0377e4 pc=0x813cc58
runtime.goexit({})
	/tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x6f0377f4 sp=0x6f0377f0 pc=0x80bbe11
created by testing.(*T).Run in goroutine 126
	/tmp/workdir/go/src/testing/testing.go:1743 +0x3cb

2024-05-14 20:11 openbsd-386-72 go@7008859a internal/trace/v2.TestTraceStressStartStop (log)

--- FAIL: TestTraceStressStartStop (23.80s)
    --- FAIL: TestTraceStressStartStop/Default (23.80s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go
        trace_test.go:579: signal: killed

2024-05-14 20:11 openbsd-386-72 go@7008859a internal/trace/v2.TestTraceManyStartStop (log)

--- FAIL: TestTraceManyStartStop (1.13s)
    --- FAIL: TestTraceManyStartStop/Default (1.13s)
        exec.go:193: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/many-start-stop.go
        trace_test.go:577: stderr: SIGQUIT: quit
            PC=0x1575214b m=3 sigcode=0

            goroutine 0 gp=0x4fc08b48 m=3 mp=0x4fc42a08 [idle]:
            runtime.kevent(0x3c, 0x0, 0x0, 0x31a5b844, 0x40, 0x31a5b818)
            	runtime/sys_openbsd2.go:219 +0x21 fp=0x31a5b7f0 sp=0x31a5b7e0 pc=0x80a5101
            runtime.netpoll(0xd14d466)
...
            edi    0x77c
            esi    0x4fc08b48
            ebp    0x31a5b798
            esp    0x31a5b77c
            eip    0x1575214b
            eflags 0x203
            cs     0x2b
            fs     0x5b
            gs     0x63
        trace_test.go:579: exit status 2

— watchflakes

gopherbot added the NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one. label Dec 19, 2023

bcmills added the compiler/runtime Issues related to the Go compiler and/or runtime. label Jan 2, 2024

bcmills changed the title ~~internal/trace/v2: TestTraceManyStartStop failures~~ internal/trace/v2: test timeouts Jan 2, 2024

bcmills mentioned this issue Jan 2, 2024

internal/trace/v2: TestTraceStressStartStop failures #64792

Closed

mknyszek self-assigned this Jan 3, 2024

mknyszek added this to the Backlog milestone Jan 3, 2024

internal/trace/v2: test timeouts #64794

internal/trace/v2: test timeouts #64794

Comments

gopherbot commented Dec 19, 2023 • edited by bcmills

gopherbot commented Dec 19, 2023

bcmills commented Jan 2, 2024 • edited

gopherbot commented Jan 19, 2024

bcmills commented Jan 24, 2024

mknyszek commented Jan 24, 2024

bcmills commented Jan 24, 2024

gopherbot commented Jan 29, 2024

gopherbot commented Feb 23, 2024

mknyszek commented Feb 23, 2024

gopherbot commented Mar 6, 2024

gopherbot commented Mar 22, 2024

gopherbot commented Mar 27, 2024

gopherbot commented Apr 7, 2024

gopherbot commented Apr 9, 2024

gopherbot commented Apr 15, 2024

gopherbot commented Apr 16, 2024

gopherbot commented Apr 22, 2024

gopherbot commented Apr 23, 2024

gopherbot commented Apr 24, 2024

gopherbot commented Apr 24, 2024

gopherbot commented Apr 24, 2024

gopherbot commented Apr 25, 2024

gopherbot commented Apr 25, 2024

gopherbot commented Apr 25, 2024

gopherbot commented Apr 30, 2024

gopherbot commented May 2, 2024

gopherbot commented May 3, 2024

gopherbot commented May 3, 2024

gopherbot commented May 3, 2024

gopherbot commented May 4, 2024

gopherbot commented May 6, 2024

gopherbot commented May 6, 2024

gopherbot commented May 6, 2024

gopherbot commented May 6, 2024

gopherbot commented May 7, 2024

gopherbot commented May 7, 2024

gopherbot commented May 8, 2024

gopherbot commented May 8, 2024

gopherbot commented May 9, 2024

gopherbot commented May 9, 2024

gopherbot commented May 10, 2024

gopherbot commented May 10, 2024

gopherbot commented May 10, 2024

gopherbot commented May 11, 2024

gopherbot commented May 11, 2024

gopherbot commented May 12, 2024

gopherbot commented May 13, 2024

gopherbot commented May 13, 2024

gopherbot commented May 13, 2024

gopherbot commented May 13, 2024

gopherbot commented May 14, 2024

gopherbot commented May 14, 2024

gopherbot commented May 14, 2024

gopherbot commented May 14, 2024

gopherbot commented Dec 19, 2023 •

edited by bcmills

bcmills commented Jan 2, 2024 •

edited