#!watchflakes
default <- pkg == "runtime:mayMoreStackPreempt" && test == "TestCrashWhileTracing"

Issue created automatically to collect these failures.

Example (log):

=== RUN   TestCrashWhileTracing
    crash_test.go:916: error at event 1: failed to read full batch: read 2427 but wanted 65455
    crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken
    crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match
    crash_test.go:942: stderr output:
        panic: yzzyx

        goroutine 1 [running]:
        runtime_test.init.1()
            C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85
--- FAIL: TestCrashWhileTracing (0.17s)

watchflakes

Comment From: gopherbot

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "runtime:mayMoreStackPreempt" && test == "TestCrashWhileTracing"
2024-04-24 18:15 gotip-windows-amd64-longtest go@e6891188 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2427 but wanted 65455 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.17s)
2024-04-25 00:43 gotip-windows-amd64-longtest go@799968df runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2469 but wanted 65459 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)
2024-04-25 01:05 gotip-windows-amd64-longtest go@db5f2b41 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 3000 but wanted 65459 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)
2024-04-25 11:28 gotip-windows-amd64-longtest go@8960925a runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 3018 but wanted 65457 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.15s)
2024-04-25 17:07 gotip-windows-amd64-longtest go@06478e4b runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2241 but wanted 65457 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)
2024-04-26 21:24 gotip-windows-amd64-longtest go@0e7f5cf3 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2439 but wanted 65456 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.15s)
2024-04-26 22:13 gotip-windows-amd64-longtest go@9effeeab runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2583 but wanted 65457 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)
2024-04-26 23:07 gotip-windows-amd64-longtest go@ad22356e runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2199 but wanted 65455 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.17s)
2024-04-30 12:44 gotip-windows-amd64-longtest go@dc164ead runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 1836 but wanted 65457 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.22s)
2024-04-30 15:43 gotip-windows-amd64-longtest go@cf058730 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 1087 but wanted 65456 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.17s)
2024-05-02 22:43 gotip-windows-amd64-longtest go@344075d9 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 325 but wanted 65455 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.15s)
2024-05-03 16:41 gotip-linux-arm64-longtest go@44e48c7e runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 61420 but wanted 65456 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() /home/swarming/.swarming/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0xbc --- FAIL: TestCrashWhileTracing (0.12s)
2024-05-03 18:15 gotip-windows-amd64-longtest go@23f760fd runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2583 but wanted 65455 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.17s)
2024-05-04 07:50 gotip-windows-amd64-longtest go@17fce632 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2802 but wanted 65456 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)
2024-05-04 07:51 gotip-windows-amd64-longtest go@20130cc3 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2580 but wanted 65457 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.18s)
2024-05-05 00:26 gotip-windows-amd64-longtest go@619b419a runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2226 but wanted 65458 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)
2024-05-06 14:00 gotip-windows-amd64-longtest go@eabf59bc runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 1241 but wanted 65457 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.15s)
2024-05-06 20:33 gotip-linux-arm64-longtest go@5a181c50 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 61420 but wanted 65458 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() /home/swarming/.swarming/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0xbc --- FAIL: TestCrashWhileTracing (0.12s)
2024-05-06 21:14 gotip-linux-386-longtest go@e988d6c4 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 61420 but wanted 65473 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() /home/swarming/.swarming/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0xb4 --- FAIL: TestCrashWhileTracing (0.67s)
2024-05-06 21:14 gotip-windows-amd64-longtest go@e988d6c4 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 2625 but wanted 65456 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)
2024-05-07 15:21 gotip-windows-amd64-longtest go@38ee0c76 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 3194 but wanted 65455 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.17s)
2024-05-07 18:24 gotip-linux-386-longtest go@1e4de058 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 61420 but wanted 65470 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() /home/swarming/.swarming/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0xb4 --- FAIL: TestCrashWhileTracing (0.63s)
2024-05-08 16:13 gotip-windows-amd64-longtest go@328aa9e3 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 910 but wanted 65455 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.18s)
2024-05-08 17:09 gotip-windows-amd64-longtest go@93e3696b runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 1830 but wanted 65458 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.17s)
2024-05-08 17:47 gotip-linux-386-longtest go@724bab15 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 61420 but wanted 65469 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() /home/swarming/.swarming/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0xb4 --- FAIL: TestCrashWhileTracing (0.57s)
2024-05-08 17:47 gotip-linux-386-longtest go@c3bd543c runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 61420 but wanted 65469 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() /home/swarming/.swarming/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0xb4 --- FAIL: TestCrashWhileTracing (0.56s)
2024-05-08 18:03 gotip-windows-amd64-longtest go@ff743ce8 runtime:mayMoreStackPreempt.TestCrashWhileTracing (log) === RUN TestCrashWhileTracing crash_test.go:916: error at event 1: failed to read full batch: read 1896 but wanted 65459 crash_test.go:937: expected at least one full generation to have been emitted before the trace was considered broken crash_test.go:940: expected one matching log event matching, but none of the 1 received trace events match crash_test.go:942: stderr output: panic: yzzyx goroutine 1 [running]: runtime_test.init.1() C:/b/s/w/ir/x/w/goroot/src/runtime/crash_test.go:887 +0x85 --- FAIL: TestCrashWhileTracing (0.16s)

watchflakes

Comment From: mknyszek

I believe this is fixed (TODO: find the CL that fixed it). Closing optimistically.