openbsd-386-72 at d7ea9ff50b6c0386c7784b27f66083396fa404af :: Running /tmp/workdir/go/src/make.bash with args ["/tmp/workdir/go/src/make.bash" "-force"] and env ["HOME=/" "INRC=1" "_=/bin/sh" "WORKDIR=/tmp/workdir" "GO_BUILDER_NAME=openbsd-386-72" "GOBIN=" "GOROOT_BOOTSTRAP=" "TMPDIR=/tmp/workdir/tmp" "GOCACHE=/tmp/workdir/gocache" "GOPLSCACHE=/tmp/workdir/goplscache" "PATH=/tmp/workdir/go1.4/go/bin:/sbin:/bin:/usr/sbin:/usr/bin:/usr/local/bin" "PWD=/tmp/workdir/go/src"] in dir /tmp/workdir/go/src WARNING: //go1.4/bin/go does not exist, found /tmp/workdir/go1.4/go/bin/go from env WARNING: set /tmp/workdir/go1.4/go as GOROOT_BOOTSTRAP Building Go cmd/dist using /tmp/workdir/go1.4/go. (go1.22.6 openbsd/386) Building Go toolchain1 using /tmp/workdir/go1.4/go. Building Go bootstrap cmd/go (go_bootstrap) using Go toolchain1. Building Go toolchain2 using go_bootstrap and Go toolchain1. Building Go toolchain3 using go_bootstrap and Go toolchain2. Building packages and commands for openbsd/386. --- Installed Go for openbsd/386 in /tmp/workdir/go Installed commands in /tmp/workdir/go/bin *** You need to add /tmp/workdir/go/bin to your PATH. ##### Test execution environment. # GOARCH: 386 # CPU: Intel(R) Xeon(R) CPU @ 2.80GHz # GOOS: openbsd # OS Version: OpenBSD 7.2 OpenBSD 7.2 (GENERIC) #5: Tue Jul 25 16:20:24 CEST 2023 root@syspatch-72-i386.openbsd.org:/usr/src/sys/arch/i386/compile/GENERIC i386 ##### Testing packages. ok archive/tar 0.209s ok archive/zip 0.450s ok bufio 0.084s ok bytes 0.411s ok cmp 0.016s ok compress/bzip2 0.094s ok compress/flate 0.868s ok compress/gzip 1.783s ok compress/lzw 0.111s ok compress/zlib 0.587s ok container/heap 0.018s ok container/list 0.021s ok container/ring 0.018s ok context 0.301s ok crypto 1.387s ok crypto/aes 0.043s ok crypto/cipher 2.652s ok crypto/des 0.033s ok crypto/dsa 0.019s ok crypto/ecdh 0.305s ok crypto/ecdsa 0.207s ok crypto/ed25519 0.338s ok crypto/elliptic 0.073s ok crypto/hmac 0.033s ok crypto/internal/alias 0.016s ok crypto/internal/bigmod 0.068s ok crypto/internal/boring 0.016s ok crypto/internal/boring/bcache 0.189s ok crypto/internal/edwards25519 0.531s ok crypto/internal/edwards25519/field 0.084s ok crypto/internal/fips 0.219s ok crypto/internal/fips/check 0.016s ok crypto/internal/fips/sha3 4.322s ok crypto/internal/fips/subtle 0.127s ok crypto/internal/hpke 0.022s ok crypto/internal/mlkem768 0.321s ok crypto/internal/nistec 1.120s ok crypto/internal/nistec/fiat 0.015s [no tests to run] ok crypto/md5 0.020s ok crypto/rand 0.796s ok crypto/rc4 0.065s ok crypto/rsa 1.156s ok crypto/sha1 0.019s ok crypto/sha256 0.020s ok crypto/sha512 0.025s ok crypto/subtle 0.018s ok crypto/tls 2.350s ok crypto/x509 2.497s ok database/sql 0.800s ok database/sql/driver 0.017s ok debug/buildinfo 0.097s ok debug/dwarf 0.062s ok debug/elf 0.218s ok debug/gosym 0.060s ok debug/macho 0.029s ok debug/pe 0.071s ok debug/plan9obj 0.019s ok embed 0.018s [no tests to run] ok embed/internal/embedtest 0.018s ok encoding/ascii85 0.018s ok encoding/asn1 0.020s ok encoding/base32 0.040s ok encoding/base64 0.020s ok encoding/binary 0.027s ok encoding/csv 0.029s ok encoding/gob 4.470s ok encoding/hex 0.020s ok encoding/json 0.471s ok encoding/pem 1.103s ok encoding/xml 0.102s ok errors 0.021s ok expvar 0.021s ok flag 0.073s ok fmt 0.106s ok go/ast 0.023s ok go/ast/internal/tests 0.017s ok go/build 5.265s ok go/build/constraint 0.080s ok go/constant 0.020s ok go/doc 0.107s ok go/doc/comment 1.931s ok go/format 0.022s ok go/importer 0.657s ok go/internal/gccgoimporter 0.036s ok go/internal/gcimporter 4.350s ok go/internal/srcimporter 17.562s ok go/parser 0.504s ok go/printer 0.213s ok go/scanner 0.018s ok go/token 0.031s ok go/types 27.101s ok go/version 0.016s ok hash 0.018s ok hash/adler32 0.023s ok hash/crc32 0.021s ok hash/crc64 0.017s ok hash/fnv 0.017s ok hash/maphash 2.286s ok html 0.023s ok html/template 0.099s ok image 0.090s ok image/color 0.031s ok image/draw 0.101s ok image/gif 0.217s ok image/jpeg 0.227s ok image/png 0.339s ok index/suffixarray 0.218s ok internal/abi 0.174s ok internal/buildcfg 0.017s ok internal/chacha8rand 0.016s ok internal/concurrent 0.089s ok internal/coverage/cfile 1.769s ok internal/coverage/cformat 0.017s ok internal/coverage/cmerge 0.016s ok internal/coverage/pods 0.020s ok internal/coverage/slicereader 0.016s ok internal/coverage/slicewriter 0.020s ok internal/coverage/test 0.026s ok internal/cpu 0.038s ok internal/dag 0.017s ok internal/diff 0.023s ok internal/fmtsort 0.017s ok internal/fuzz 0.024s ok internal/godebug 1.210s ok internal/godebugs 8.966s ok internal/gover 0.016s ok internal/itoa 0.016s ok internal/pkgbits 0.016s ok internal/platform 1.834s ok internal/poll 0.071s ok internal/profile 0.016s ok internal/reflectlite 0.019s ok internal/runtime/atomic 0.054s ok internal/runtime/maps 0.024s ok internal/runtime/math 0.016s ok internal/runtime/sys 0.016s ok internal/saferio 0.111s ok internal/singleflight 0.091s ok internal/sysinfo 0.016s ok internal/testenv 0.458s --- FAIL: TestTraceStressStartStop (95.78s) --- FAIL: TestTraceStressStartStop/Default (95.78s) exec.go:213: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress-start-stop.go trace_test.go:610: signal: killed --- FAIL: TestTraceWaitOnPipe (2.91s) --- FAIL: TestTraceWaitOnPipe/Default (2.91s) exec.go:213: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/wait-on-pipe.go trace_test.go:608: stderr: SIGQUIT: quit PC=0x3fd9792b m=3 sigcode=0 goroutine 0 gp=0x60008b48 m=3 mp=0x60042a08 [idle]: runtime.kevent(0x3d, 0x0, 0x0, 0x11c6e334, 0x40, 0x0) runtime/sys_openbsd2.go:219 +0x21 fp=0x11c6e2e0 sp=0x11c6e2d0 pc=0x809e6e1 runtime.netpoll(0xffffffffffffffff) runtime/netpoll_kqueue.go:110 +0xe5 fp=0x11c6e93c sp=0x11c6e2e0 pc=0x807b775 runtime.findRunnable() runtime/proc.go:3596 +0xa02 fp=0x11c6ea08 sp=0x11c6e93c pc=0x8086bf2 runtime.schedule() runtime/proc.go:4011 +0xb1 fp=0x11c6ea24 sp=0x11c6ea08 pc=0x8088331 runtime.park_m(0x602cd9e8) runtime/proc.go:4118 +0x1c7 fp=0x11c6ea4c sp=0x11c6ea24 pc=0x8088747 runtime.mcall(0x40000) runtime/asm_386.s:329 +0x40 fp=0x11c6ea54 sp=0x11c6ea4c pc=0x80b9560 goroutine 1 gp=0x60008128 m=nil [semacquire]: runtime.gopark(0x8774504, 0x8ba4200, 0x12, 0x5, 0x4) runtime/proc.go:435 +0xfa fp=0x600d3ae0 sp=0x600d3acc pc=0x80b4e9a runtime.goparkunlock(...) runtime/proc.go:441 runtime.semacquire1(0x60246558, 0x0, 0x1, 0x0, 0x12) runtime/sema.go:178 +0x27b fp=0x600d3b10 sp=0x600d3ae0 pc=0x8093fdb sync.runtime_Semacquire(0x60246558) runtime/sema.go:71 +0x35 fp=0x600d3b28 sp=0x600d3b10 pc=0x80b6405 sync.(*WaitGroup).Wait(0x60246550) sync/waitgroup.go:118 +0x5f fp=0x600d3b44 sp=0x600d3b28 pc=0x80cf2df cmd/go/internal/work.(*Builder).Do(0x600722d0, {0x882f600, 0x8ba92c0}, 0x60300fc8) cmd/go/internal/work/exec.go:231 +0x419 fp=0x600d3bdc sp=0x600d3b44 pc=0x8596819 cmd/go/internal/run.runRun({0x882f600, 0x8ba92c0}, 0x8b93ae0, {0x6001c058, 0x1, 0x1}) cmd/go/internal/run/run.go:174 +0x823 fp=0x600d3c90 sp=0x600d3bdc pc=0x85e79e3 main.invoke(0x8b93ae0, {0x6001c050, 0x2, 0x2}) cmd/go/main.go:339 +0x8b7 fp=0x600d3e64 sp=0x600d3c90 pc=0x8632b67 main.main() cmd/go/main.go:218 +0x1031 fp=0x600d3fac sp=0x600d3e64 pc=0x8631c01 runtime.main() runtime/proc.go:283 +0x288 fp=0x600d3ff0 sp=0x600d3fac pc=0x8080de8 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x600d3ff4 sp=0x600d3ff0 pc=0x80ba8f1 goroutine 2 gp=0x60008488 m=nil [force gc (idle)]: runtime.gopark(0x8774504, 0x8b9ab40, 0x11, 0xa, 0x1) runtime/proc.go:435 +0xfa fp=0x6003efdc sp=0x6003efc8 pc=0x80b4e9a runtime.goparkunlock(...) runtime/proc.go:441 runtime.forcegchelper() runtime/proc.go:348 +0xc7 fp=0x6003eff0 sp=0x6003efdc pc=0x8081147 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x6003eff4 sp=0x6003eff0 pc=0x80ba8f1 created by runtime.init.6 in goroutine 1 runtime/proc.go:336 +0x1d goroutine 3 gp=0x600085a8 m=nil [GC sweep wait]: runtime.gopark(0x8774504, 0x8b9b010, 0xc, 0x9, 0x1) runtime/proc.go:435 +0xfa fp=0x6003f7cc sp=0x6003f7b8 pc=0x80b4e9a runtime.goparkunlock(...) runtime/proc.go:441 runtime.bgsweep(0x60024040) runtime/mgcsweep.go:317 +0xec fp=0x6003f7e8 sp=0x6003f7cc pc=0x806d13c runtime.gcenable.gowrap1() runtime/mgc.go:204 +0x21 fp=0x6003f7f0 sp=0x6003f7e8 pc=0x805eb51 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x6003f7f4 sp=0x6003f7f0 pc=0x80ba8f1 created by runtime.gcenable in goroutine 1 runtime/mgc.go:204 +0x71 goroutine 4 gp=0x600086c8 m=nil [GC scavenge wait]: runtime.gopark(0x8774504, 0x8b9bb60, 0xd, 0xa, 0x2) runtime/proc.go:435 +0xfa fp=0x6003ffb8 sp=0x6003ffa4 pc=0x80b4e9a runtime.goparkunlock(...) runtime/proc.go:441 runtime.(*scavengerState).park(0x8b9bb60) runtime/mgcscavenge.go:425 +0x54 fp=0x6003ffcc sp=0x6003ffb8 pc=0x806a784 runtime.bgscavenge(0x60024040) runtime/mgcscavenge.go:658 +0x69 fp=0x6003ffe8 sp=0x6003ffcc pc=0x806add9 runtime.gcenable.gowrap2() runtime/mgc.go:205 +0x21 fp=0x6003fff0 sp=0x6003ffe8 pc=0x805eb11 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x6003fff4 sp=0x6003fff0 pc=0x80ba8f1 created by runtime.gcenable in goroutine 1 runtime/mgc.go:205 +0xb1 goroutine 5 gp=0x60008c68 m=nil [finalizer wait]: runtime.gopark(0x87743b8, 0x8ba9394, 0x10, 0xa, 0x1) runtime/proc.go:435 +0xfa fp=0x6003e798 sp=0x6003e784 pc=0x80b4e9a runtime.runfinq() runtime/mfinal.go:193 +0xf0 fp=0x6003e7f0 sp=0x6003e798 pc=0x805dcb0 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x6003e7f4 sp=0x6003e7f0 pc=0x80ba8f1 created by runtime.createfing in goroutine 1 runtime/mfinal.go:163 +0x5a goroutine 6 gp=0x60008fc8 m=nil [chan receive]: runtime.gopark(0x8774398, 0x600242f4, 0xe, 0x7, 0x2) runtime/proc.go:435 +0xfa fp=0x60040790 sp=0x6004077c pc=0x80b4e9a runtime.chanrecv(0x600242c0, 0x0, 0x1) runtime/chan.go:640 +0x3bd fp=0x600407cc sp=0x60040790 pc=0x8050a7d runtime.chanrecv1(0x600242c0, 0x0) runtime/chan.go:490 +0x1c fp=0x600407e0 sp=0x600407cc pc=0x805068c runtime.unique_runtime_registerUniqueMapCleanup.func1(...) runtime/mgc.go:1781 runtime.unique_runtime_registerUniqueMapCleanup.gowrap1() runtime/mgc.go:1784 +0x34 fp=0x600407f0 sp=0x600407e0 pc=0x8062324 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x600407f4 sp=0x600407f0 pc=0x80ba8f1 created by unique.runtime_registerUniqueMapCleanup in goroutine 1 runtime/mgc.go:1779 +0x96 goroutine 8 gp=0x60009208 m=0 mp=0x8b9cb40 [syscall]: syscall.syscall6(0x80dc3d0, 0x9570, 0x600d1aa8, 0x0, 0x60493770, 0x0, 0x0) runtime/sys_openbsd3.go:54 +0x20 fp=0x600d1a54 sp=0x600d1a44 pc=0x80b8270 syscall.wait4(0x9570, 0x600d1aa8, 0x0, 0x60493770) syscall/zsyscall_openbsd_386.go:43 +0x61 fp=0x600d1a8c sp=0x600d1a54 pc=0x80d9011 syscall.Wait4(0x9570, 0x600d1acc, 0x0, 0x60493770) syscall/syscall_bsd.go:144 +0x3b fp=0x600d1ab0 sp=0x600d1a8c pc=0x80d66eb os.(*Process).pidWait(0x601a7cb0) os/exec_unix.go:70 +0xb4 fp=0x600d1ae8 sp=0x600d1ab0 pc=0x813f404 os.(*Process).wait(0x601a7cb0) os/exec_unix.go:30 +0x23 fp=0x600d1afc sp=0x600d1ae8 pc=0x813f2f3 os.(*Process).Wait(...) os/exec.go:358 os/exec.(*Cmd).Wait(0x600a6348) os/exec/exec.go:922 +0x36 fp=0x600d1b34 sp=0x600d1afc pc=0x8178546 os/exec.(*Cmd).Run(0x600a6348) os/exec/exec.go:626 +0x3f fp=0x600d1b44 sp=0x600d1b34 pc=0x817733f cmd/go/internal/work.(*Shell).runOut(0x602efe98, {0x8828538, 0x1}, {0x600289a0, 0x1, 0x1}, {0x600d1d7c, 0x8, 0x8}) cmd/go/internal/work/shell.go:638 +0x703 fp=0x600d1c50 sp=0x600d1b44 pc=0x85cbe73 cmd/go/internal/work.(*Shell).run(0x602efe98, {0x8828538, 0x1}, {0x8726faa, 0x16}, {0x600289a0, 0x1, 0x1}, {0x600d1d7c, 0x8, ...}) cmd/go/internal/work/shell.go:565 +0x62 fp=0x600d1ca8 sp=0x600d1c50 pc=0x85cb5e2 cmd/go/internal/work.gcToolchain.ld({}, 0x600722d0, 0x60148248, {0x60237ac0, 0x39}, {0x60025680, 0x37}, {0x601a7710, 0x30}) cmd/go/internal/work/gc.go:683 +0x1068 fp=0x600d1dd4 sp=0x600d1ca8 pc=0x85bcc88 cmd/go/internal/work.(*gcToolchain).ld(0x8ba92c0, 0x600722d0, 0x60148248, {0x60237ac0, 0x39}, {0x60025680, 0x37}, {0x601a7710, 0x30}) :1 +0x62 fp=0x600d1e00 sp=0x600d1dd4 pc=0x85ce3d2 cmd/go/internal/work.(*Builder).link(0x600722d0, {0x882f600, 0x8ba92c0}, 0x60148248) cmd/go/internal/work/exec.go:1482 +0x353 fp=0x600d1e84 sp=0x600d1e00 pc=0x85a3ef3 cmd/go/internal/work.ActorFunc.Act(0x8774248, 0x600722d0, {0x882f600, 0x8ba92c0}, 0x60148248) cmd/go/internal/work/action.go:76 +0x36 fp=0x600d1ea0 sp=0x600d1e84 pc=0x8586d96 cmd/go/internal/work.(*Builder).Do.func3({0x882f600, 0x8ba92c0}, 0x60148248) cmd/go/internal/work/exec.go:153 +0x7fd fp=0x600d1f88 sp=0x600d1ea0 pc=0x859735d cmd/go/internal/work.(*Builder).Do.func4() cmd/go/internal/work/exec.go:222 +0xae fp=0x600d1ff0 sp=0x600d1f88 pc=0x85969fe runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x600d1ff4 sp=0x600d1ff0 pc=0x80ba8f1 created by cmd/go/internal/work.(*Builder).Do in goroutine 1 cmd/go/internal/work/exec.go:208 +0x37a goroutine 17 gp=0x602cd9e8 m=nil [IO wait]: runtime.gopark(0x87744f8, 0x28ae7980, 0x2, 0x2, 0x5) runtime/proc.go:435 +0xfa fp=0x60040da8 sp=0x60040d94 pc=0x80b4e9a runtime.netpollblock(0x28ae7970, 0x72, 0x0) runtime/netpoll.go:575 +0xe4 fp=0x60040dc0 sp=0x60040da8 pc=0x807af54 internal/poll.runtime_pollWait(0x28ae7970, 0x72) runtime/netpoll.go:351 +0x4c fp=0x60040dd4 sp=0x60040dc0 pc=0x80b41cc internal/poll.(*pollDesc).wait(0x60327d98, 0x72, 0x1) internal/poll/fd_poll_runtime.go:84 +0x31 fp=0x60040de8 sp=0x60040dd4 pc=0x8136801 internal/poll.(*pollDesc).waitRead(...) internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0x60327d80, {0x600aba00, 0x200, 0x200}) internal/poll/fd_unix.go:165 +0x1f6 fp=0x60040e30 sp=0x60040de8 pc=0x8137686 os.(*File).read(...) os/file_posix.go:29 os.(*File).Read(0x60028a48, {0x600aba00, 0x200, 0x200}) os/file.go:124 +0x6a fp=0x60040e54 sp=0x60040e30 pc=0x814013a bytes.(*Buffer).ReadFrom(0x602e4438, {0x882c240, 0x60028a88}) bytes/buffer.go:211 +0x8f fp=0x60040e90 sp=0x60040e54 pc=0x817224f io.copyBuffer({0x882c340, 0x602e4438}, {0x882c240, 0x60028a88}, {0x0, 0x0, 0x0}) io/io.go:415 +0x146 fp=0x60040edc sp=0x60040e90 pc=0x812f1e6 io.Copy(...) io/io.go:388 os.genericWriteTo(0x60028a48, {0x882c340, 0x602e4438}) os/file.go:275 +0x6f fp=0x60040f10 sp=0x60040edc pc=0x81409df os.(*File).WriteTo(0x60028a48, {0x882c340, 0x602e4438}) os/file.go:253 +0x61 fp=0x60040f30 sp=0x60040f10 pc=0x8140911 io.copyBuffer({0x882c340, 0x602e4438}, {0x882c1b0, 0x60028a48}, {0x0, 0x0, 0x0}) io/io.go:411 +0x186 fp=0x60040f7c sp=0x60040f30 pc=0x812f226 io.Copy(...) io/io.go:388 os/exec.(*Cmd).writerDescriptor.func1() os/exec/exec.go:596 +0x4f fp=0x60040fb8 sp=0x60040f7c pc=0x81772bf os/exec.(*Cmd).Start.func2(0x60302690) os/exec/exec.go:749 +0x2b fp=0x60040fe8 sp=0x60040fb8 pc=0x8177ddb os/exec.(*Cmd).Start.gowrap1() os/exec/exec.go:761 +0x23 fp=0x60040ff0 sp=0x60040fe8 pc=0x8177d93 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x60040ff4 sp=0x60040ff0 pc=0x80ba8f1 created by os/exec.(*Cmd).Start in goroutine 8 os/exec/exec.go:748 +0x8b6 goroutine 13 gp=0x602cdb08 m=nil [GC worker (idle)]: runtime.gopark(0x87743c4, 0x602b7dd0, 0x1a, 0xa, 0x0) runtime/proc.go:435 +0xfa fp=0x6004178c sp=0x60041778 pc=0x80b4e9a runtime.gcBgMarkWorker(0x6037a500) runtime/mgc.go:1412 +0xeb fp=0x600417e8 sp=0x6004178c pc=0x80614bb runtime.gcBgMarkStartWorkers.gowrap1() runtime/mgc.go:1328 +0x21 fp=0x600417f0 sp=0x600417e8 pc=0x80613b1 runtime.goexit({}) runtime/asm_386.s:1393 +0x1 fp=0x600417f4 sp=0x600417f0 pc=0x80ba8f1 created by runtime.gcBgMarkStartWorkers in goroutine 8 runtime/mgc.go:1328 +0x114 eax 0x4 ebx 0x40 ecx 0x0 edx 0x11c6e2e0 edi 0x79c esi 0x60008b48 ebp 0x11c6e288 esp 0x11c6e26c eip 0x3fd9792b eflags 0x203 cs 0x2b fs 0x5b gs 0x63 trace_test.go:610: exit status 2 --- FAIL: TestTraceIterPull (0.00s) --- FAIL: TestTraceIterPull/Default (0.00s) trace_test.go:610: context deadline exceeded panic: test timed out after 3m0s goroutine 154 gp=0x4cd97328 m=3 mp=0x4c83ca08 [running]: panic({0x8246dc0, 0x56cbac50}) /tmp/workdir/go/src/runtime/panic.go:806 +0x138 fp=0x4c83af84 sp=0x4c83af30 pc=0x80b34d8 testing.(*M).startAlarm.func1() /tmp/workdir/go/src/testing/testing.go:2456 +0x37f fp=0x4c83aff0 sp=0x4c83af84 pc=0x814677f runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c83aff4 sp=0x4c83aff0 pc=0x80b8fe1 created by time.goFunc /tmp/workdir/go/src/time/sleep.go:215 +0x29 goroutine 1 gp=0x4c806128 m=nil [chan receive]: runtime.gopark(0x8291a20, 0x538e94f4, 0xe, 0x7, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c866d24 sp=0x4c866d10 pc=0x80b38ea runtime.chanrecv(0x538e94c0, 0x0, 0x1) /tmp/workdir/go/src/runtime/chan.go:640 +0x3bd fp=0x4c866d60 sp=0x4c866d24 pc=0x804d9ed runtime.chanrecv1(0x538e94c0, 0x0) /tmp/workdir/go/src/runtime/chan.go:490 +0x1c fp=0x4c866d74 sp=0x4c866d60 pc=0x804d5fc testing.runFuzzTests({0x82d1680, 0x8417e00}, {0x8400500, 0x1, 0x1}, {0xc1c55d9cf544eee9, 0x29e8fd8358, 0x840bb80}) /tmp/workdir/go/src/testing/fuzz.go:528 +0x7f3 fp=0x4c866e08 sp=0x4c866d74 pc=0x813a6e3 testing.(*M).Run(0x4c858050) /tmp/workdir/go/src/testing/testing.go:2115 +0x685 fp=0x4c866f54 sp=0x4c866e08 pc=0x8143ce5 main.main() _testmain.go:99 +0xdf fp=0x4c866fac sp=0x4c866f54 pc=0x82292af runtime.main() /tmp/workdir/go/src/runtime/proc.go:283 +0x288 fp=0x4c866ff0 sp=0x4c866fac pc=0x807ffe8 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c866ff4 sp=0x4c866ff0 pc=0x80b8fe1 goroutine 2 gp=0x4c806488 m=nil [force gc (idle), 3 minutes]: runtime.gopark(0x8291b8c, 0x840b830, 0x11, 0xa, 0x1) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c838fdc sp=0x4c838fc8 pc=0x80b38ea runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:441 runtime.forcegchelper() /tmp/workdir/go/src/runtime/proc.go:348 +0xc7 fp=0x4c838ff0 sp=0x4c838fdc pc=0x8080347 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c838ff4 sp=0x4c838ff0 pc=0x80b8fe1 created by runtime.init.6 in goroutine 1 /tmp/workdir/go/src/runtime/proc.go:336 +0x1d goroutine 3 gp=0x4c8065a8 m=nil [GC sweep wait]: runtime.gopark(0x8291b8c, 0x840b9d0, 0xc, 0x9, 0x1) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c8397cc sp=0x4c8397b8 pc=0x80b38ea runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:441 runtime.bgsweep(0x4c81e040) /tmp/workdir/go/src/runtime/mgcsweep.go:317 +0xec fp=0x4c8397e8 sp=0x4c8397cc pc=0x8069ecc runtime.gcenable.gowrap1() /tmp/workdir/go/src/runtime/mgc.go:204 +0x21 fp=0x4c8397f0 sp=0x4c8397e8 pc=0x805b941 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c8397f4 sp=0x4c8397f0 pc=0x80b8fe1 created by runtime.gcenable in goroutine 1 /tmp/workdir/go/src/runtime/mgc.go:204 +0x71 goroutine 4 gp=0x4c8066c8 m=nil [GC scavenge wait]: runtime.gopark(0x8291b8c, 0x840bd00, 0xd, 0xa, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c839fb8 sp=0x4c839fa4 pc=0x80b38ea runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:441 runtime.(*scavengerState).park(0x840bd00) /tmp/workdir/go/src/runtime/mgcscavenge.go:425 +0x54 fp=0x4c839fcc sp=0x4c839fb8 pc=0x8067514 runtime.bgscavenge(0x4c81e040) /tmp/workdir/go/src/runtime/mgcscavenge.go:658 +0x69 fp=0x4c839fe8 sp=0x4c839fcc pc=0x8067b69 runtime.gcenable.gowrap2() /tmp/workdir/go/src/runtime/mgc.go:205 +0x21 fp=0x4c839ff0 sp=0x4c839fe8 pc=0x805b901 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c839ff4 sp=0x4c839ff0 pc=0x80b8fe1 created by runtime.gcenable in goroutine 1 /tmp/workdir/go/src/runtime/mgc.go:205 +0xb1 goroutine 5 gp=0x4c806c68 m=nil [finalizer wait, 2 minutes]: runtime.gopark(0x8291a40, 0x8417e54, 0x10, 0xa, 0x1) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c83a798 sp=0x4c83a784 pc=0x80b38ea runtime.runfinq() /tmp/workdir/go/src/runtime/mfinal.go:193 +0xf0 fp=0x4c83a7f0 sp=0x4c83a798 pc=0x805aaa0 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c83a7f4 sp=0x4c83a7f0 pc=0x80b8fe1 created by runtime.createfing in goroutine 1 /tmp/workdir/go/src/runtime/mfinal.go:163 +0x5a goroutine 146 gp=0x4c806fc8 m=nil [chan receive]: runtime.gopark(0x8291a20, 0x538e9bb4, 0xe, 0x7, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c865d30 sp=0x4c865d1c pc=0x80b38ea runtime.chanrecv(0x538e9b80, 0x0, 0x1) /tmp/workdir/go/src/runtime/chan.go:640 +0x3bd fp=0x4c865d6c sp=0x4c865d30 pc=0x804d9ed runtime.chanrecv1(0x538e9b80, 0x0) /tmp/workdir/go/src/runtime/chan.go:490 +0x1c fp=0x4c865d80 sp=0x4c865d6c pc=0x804d5fc testing.(*F).Fuzz.func1({0x82d0010, 0x4c8ac008}, {{0x0, 0x0}, {0x4ca7c4b0, 0x29}, {0x0, 0x0, 0x0}, {0x56cba8f8, ...}, ...}) /tmp/workdir/go/src/testing/fuzz.go:337 +0x502 fp=0x4c865df8 sp=0x4c865d80 pc=0x81396f2 testing.(*F).Fuzz(0x4c8ac008, {0x82431a0, 0x829199c}) /tmp/workdir/go/src/testing/fuzz.go:402 +0xbb1 fp=0x4c865f74 sp=0x4c865df8 pc=0x8138c51 internal/trace_test.FuzzReader(0x4c8ac008) /tmp/workdir/go/src/internal/trace/reader_test.go:55 +0x2f fp=0x4c865f84 sp=0x4c865f74 pc=0x821d96f testing.fRunner(0x4c8ac008, 0x8291830) /tmp/workdir/go/src/testing/fuzz.go:724 +0xe4 fp=0x4c865fe4 sp=0x4c865f84 pc=0x813b154 testing.runFuzzTests.gowrap1() /tmp/workdir/go/src/testing/fuzz.go:527 +0x28 fp=0x4c865ff0 sp=0x4c865fe4 pc=0x813a828 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c865ff4 sp=0x4c865ff0 pc=0x80b8fe1 created by testing.runFuzzTests in goroutine 1 /tmp/workdir/go/src/testing/fuzz.go:527 +0x7d9 goroutine 10 gp=0x4c807688 m=nil [GC worker (idle)]: runtime.gopark(0x8291a50, 0x4c818c48, 0x1a, 0xa, 0x0) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c83878c sp=0x4c838778 pc=0x80b38ea runtime.gcBgMarkWorker(0x4c81fe00) /tmp/workdir/go/src/runtime/mgc.go:1412 +0xeb fp=0x4c8387e8 sp=0x4c83878c pc=0x805e2ab runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir/go/src/runtime/mgc.go:1328 +0x21 fp=0x4c8387f0 sp=0x4c8387e8 pc=0x805e1a1 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c8387f4 sp=0x4c8387f0 pc=0x80b8fe1 created by runtime.gcBgMarkStartWorkers in goroutine 9 /tmp/workdir/go/src/runtime/mgc.go:1328 +0x114 goroutine 153 gp=0x4c807328 m=nil [runnable]: runtime.goschedguarded(...) /tmp/workdir/go/src/runtime/proc.go:372 runtime.memclrNoHeapPointersChunked(0x1e00000, 0x5fce0000) /tmp/workdir/go/src/runtime/malloc.go:1699 +0x5e fp=0x4c8645e4 sp=0x4c8645d0 pc=0x8054dee runtime.mallocgcLarge(0x1e00000, 0x82454c0, 0x1) /tmp/workdir/go/src/runtime/malloc.go:1600 +0x20b fp=0x4c86461c sp=0x4c8645e4 pc=0x8054a9b runtime.mallocgc(0x1e00000, 0x82454c0, 0x1) /tmp/workdir/go/src/runtime/malloc.go:1063 +0x11e fp=0x4c864638 sp=0x4c86461c pc=0x80b1f6e runtime.newobject(0x82454c0) /tmp/workdir/go/src/runtime/malloc.go:1714 +0x26 fp=0x4c86464c sp=0x4c864638 pc=0x8054e46 internal/trace/internal/oldtrace.(*Events).grow(...) /tmp/workdir/go/src/internal/trace/internal/oldtrace/parser.go:293 internal/trace/internal/oldtrace.(*Events).append(...) /tmp/workdir/go/src/internal/trace/internal/oldtrace/parser.go:302 internal/trace/internal/oldtrace.(*parser).parseEventBatches(0x4c8a8e00) /tmp/workdir/go/src/internal/trace/internal/oldtrace/parser.go:476 +0x508 fp=0x4c8649b8 sp=0x4c86464c pc=0x81dafa8 internal/trace/internal/oldtrace.(*parser).parse(0x4c8a8e00) /tmp/workdir/go/src/internal/trace/internal/oldtrace/parser.go:212 +0x1d0 fp=0x4c864a5c sp=0x4c8649b8 pc=0x81da4f0 internal/trace/internal/oldtrace.Parse({0x82d0040, 0x4cd90f90}, 0xb) /tmp/workdir/go/src/internal/trace/internal/oldtrace/parser.go:176 +0x96 fp=0x4c864ad8 sp=0x4c864a5c pc=0x81da2d6 internal/trace.NewReader({0x82d0060, 0x4c85ac60}) /tmp/workdir/go/src/internal/trace/reader.go:43 +0x19e fp=0x4c864bb0 sp=0x4c864ad8 pc=0x81ff97e internal/trace_test.FuzzReader.func1(0x4c807d48, {0x5447b800, 0x17, 0x18}) /tmp/workdir/go/src/internal/trace/reader_test.go:56 +0x8a fp=0x4c864c58 sp=0x4c864bb0 pc=0x8227e7a runtime.call16(0x4ccd18a0, 0x829199c, 0x4c8aa5f0, 0x10, 0x10, 0x10, 0x4c864d00) /tmp/workdir/go/src/runtime/asm_386.s:574 +0x2a fp=0x4c864c6c sp=0x4c864c58 pc=0x80b7f7a reflect.Value.call({0x82431a0, 0x829199c, 0x13}, {0x827bb18, 0x4}, {0x4c85ac48, 0x2, 0x2}) /tmp/workdir/go/src/reflect/value.go:581 +0x97c fp=0x4c864eb0 sp=0x4c864c6c pc=0x810904c reflect.Value.Call({0x82431a0, 0x829199c, 0x13}, {0x4c85ac48, 0x2, 0x2}) /tmp/workdir/go/src/reflect/value.go:365 +0x79 fp=0x4c864eec sp=0x4c864eb0 pc=0x8108639 testing.(*F).Fuzz.func1.1(0x4c807d48) /tmp/workdir/go/src/testing/fuzz.go:335 +0x2bc fp=0x4c864f84 sp=0x4c864eec pc=0x8139b7c testing.tRunner(0x4c807d48, 0x4ce7e410) /tmp/workdir/go/src/testing/testing.go:1764 +0x113 fp=0x4c864fe4 sp=0x4c864f84 pc=0x81422d3 testing.(*F).Fuzz.func1.gowrap1() /tmp/workdir/go/src/testing/fuzz.go:322 +0x28 fp=0x4c864ff0 sp=0x4c864fe4 pc=0x81398a8 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c864ff4 sp=0x4c864ff0 pc=0x80b8fe1 created by testing.(*F).Fuzz.func1 in goroutine 146 /tmp/workdir/go/src/testing/fuzz.go:322 +0x4e8 goroutine 138 gp=0x4cd96a28 m=nil [runnable]: runtime.gopark(0x8291bbc, 0x0, 0x9, 0x3, 0x1) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4c868e50 sp=0x4c868e3c pc=0x80b38ea runtime.selectgo(0x4c868f94, 0x4c868f58, 0x0, 0x1, 0x1, 0x1) /tmp/workdir/go/src/runtime/select.go:336 +0xb63 fp=0x4c868f38 sp=0x4c868e50 pc=0x8092813 os/exec.(*Cmd).watchCtx(0x4c88a4e8, 0x538e8f80) /tmp/workdir/go/src/os/exec/exec.go:819 +0x268 fp=0x4c868fe4 sp=0x4c868f38 pc=0x8173e58 os/exec.(*Cmd).Start.gowrap2() /tmp/workdir/go/src/os/exec/exec.go:775 +0x28 fp=0x4c868ff0 sp=0x4c868fe4 pc=0x81739a8 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4c868ff4 sp=0x4c868ff0 pc=0x80b8fe1 created by os/exec.(*Cmd).Start in goroutine 135 /tmp/workdir/go/src/os/exec/exec.go:775 +0x87b FAIL internal/trace 180.931s FAIL go tool dist: Failed: exit status 1