openbsd-386-72 at 4160ebf28f69a738203571bba6abab6ec0913080 :: 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.207s ok archive/zip 0.461s ok bufio 0.084s ok bytes 0.463s ok cmp 0.016s ok compress/bzip2 0.090s ok compress/flate 0.852s ok compress/gzip 1.858s ok compress/lzw 0.105s ok compress/zlib 0.585s ok container/heap 0.018s ok container/list 0.016s ok container/ring 0.017s ok context 0.296s ok crypto 1.249s ok crypto/aes 0.023s ok crypto/cipher 8.050s ok crypto/des 0.032s ok crypto/dsa 0.018s ok crypto/ecdh 0.329s ok crypto/ecdsa 0.191s ok crypto/ed25519 0.346s ok crypto/elliptic 0.057s ? crypto/fips140 [no test files] ok crypto/hkdf 0.017s ok crypto/hmac 0.032s ok crypto/internal/boring 0.015s ? crypto/internal/boring/bbig [no test files] ok crypto/internal/boring/bcache 0.193s ? crypto/internal/boring/sig [no test files] ? crypto/internal/cryptotest [no test files] ? crypto/internal/entropy [no test files] ? crypto/internal/fips140 [no test files] ok crypto/internal/fips140/aes 0.036s ok crypto/internal/fips140/aes/gcm 0.015s [no tests to run] ? crypto/internal/fips140/alias [no test files] ok crypto/internal/fips140/bigmod 0.081s ? crypto/internal/fips140/check [no test files] ? crypto/internal/fips140/check/checktest [no test files] ok crypto/internal/fips140/drbg 0.015s [no tests to run] ok crypto/internal/fips140/ecdh 0.015s ok crypto/internal/fips140/ecdsa 0.168s ? crypto/internal/fips140/ed25519 [no test files] ok crypto/internal/fips140/edwards25519 0.535s ok crypto/internal/fips140/edwards25519/field 0.084s ? crypto/internal/fips140/hkdf [no test files] ? crypto/internal/fips140/hmac [no test files] ok crypto/internal/fips140/mlkem 0.232s ok crypto/internal/fips140/nistec 0.161s ok crypto/internal/fips140/nistec/fiat 0.015s [no tests to run] ? crypto/internal/fips140/pbkdf2 [no test files] ok crypto/internal/fips140/rsa 0.340s ? crypto/internal/fips140/sha256 [no test files] ? crypto/internal/fips140/sha3 [no test files] ? crypto/internal/fips140/sha512 [no test files] ? crypto/internal/fips140/ssh [no test files] ? crypto/internal/fips140/subtle [no test files] ? crypto/internal/fips140/tls12 [no test files] ? crypto/internal/fips140/tls13 [no test files] ok crypto/internal/fips140deps 0.226s ? crypto/internal/fips140deps/byteorder [no test files] ? crypto/internal/fips140deps/cpu [no test files] ? crypto/internal/fips140deps/godebug [no test files] ? crypto/internal/fips140hash [no test files] ? crypto/internal/fips140only [no test files] ok crypto/internal/fips140test 2.586s ok crypto/internal/hpke 0.024s ? crypto/internal/impl [no test files] ? crypto/internal/randutil [no test files] ok crypto/internal/sysrand 0.398s ? crypto/internal/sysrand/internal/seccomp [no test files] ok crypto/md5 0.020s ok crypto/mlkem 0.109s ok crypto/pbkdf2 0.036s ok crypto/rand 0.789s ok crypto/rc4 0.064s ok crypto/rsa 1.295s ok crypto/sha1 0.019s ok crypto/sha256 0.020s ok crypto/sha3 4.328s ok crypto/sha512 0.024s ok crypto/subtle 0.201s ok crypto/tls 18.676s ? crypto/tls/internal/fips140tls [no test files] ok crypto/x509 2.664s ? crypto/x509/pkix [no test files] ok database/sql 0.801s ok database/sql/driver 0.015s ok debug/buildinfo 0.091s ok debug/dwarf 0.059s ok debug/elf 0.217s ok debug/gosym 0.060s ok debug/macho 0.028s ok debug/pe 0.068s ok debug/plan9obj 0.017s ok embed 0.017s [no tests to run] ok embed/internal/embedtest 0.017s ? encoding [no test files] ok encoding/ascii85 0.017s ok encoding/asn1 0.019s ok encoding/base32 0.039s ok encoding/base64 0.019s ok encoding/binary 0.026s ok encoding/csv 0.028s ok encoding/gob 4.476s ok encoding/hex 0.019s ok encoding/json 0.462s ok encoding/pem 1.098s ok encoding/xml 0.099s ok errors 0.020s ok expvar 0.020s ok flag 0.074s ok fmt 0.107s ok go/ast 0.022s ok go/ast/internal/tests 0.016s ok go/build 6.136s ok go/build/constraint 0.079s ok go/constant 0.020s ok go/doc 0.104s ok go/doc/comment 1.619s ok go/format 0.021s ok go/importer 0.657s ok go/internal/gccgoimporter 0.036s ok go/internal/gcimporter 4.806s ok go/internal/srcimporter 17.837s ok go/parser 0.490s ok go/printer 0.210s ok go/scanner 0.018s ok go/token 0.031s ok go/types 26.916s ok go/version 0.015s ok hash 0.018s ok hash/adler32 0.022s ok hash/crc32 0.021s ok hash/crc64 0.017s ok hash/fnv 0.016s ok hash/maphash 2.263s ok html 0.018s ok html/template 0.098s ok image 0.088s ok image/color 0.029s ? image/color/palette [no test files] ok image/draw 0.100s ok image/gif 0.227s ? image/internal/imageutil [no test files] ok image/jpeg 0.224s ok image/png 0.338s ok index/suffixarray 0.219s ok internal/abi 0.169s ? internal/asan [no test files] ? internal/bisect [no test files] ok internal/buildcfg 0.016s ? internal/bytealg [no test files] ? internal/byteorder [no test files] ? internal/cfg [no test files] ok internal/chacha8rand 0.016s ok internal/copyright 0.349s ? internal/coverage [no test files] ? internal/coverage/calloc [no test files] ok internal/coverage/cfile 1.781s ok internal/coverage/cformat 0.016s ok internal/coverage/cmerge 0.015s ? internal/coverage/decodecounter [no test files] ? internal/coverage/decodemeta [no test files] ? internal/coverage/encodecounter [no test files] ? internal/coverage/encodemeta [no test files] ok internal/coverage/pods 0.019s ? internal/coverage/rtcov [no test files] ok internal/coverage/slicereader 0.015s ok internal/coverage/slicewriter 0.015s ? internal/coverage/stringtab [no test files] ok internal/coverage/test 0.024s ? internal/coverage/uleb128 [no test files] ok internal/cpu 0.036s ok internal/dag 0.016s ok internal/diff 0.023s ? internal/exportdata [no test files] ? internal/filepathlite [no test files] ok internal/fmtsort 0.016s ok internal/fuzz 0.023s ? internal/goarch [no test files] ok internal/godebug 1.210s ok internal/godebugs 8.801s ? internal/goexperiment [no test files] ? internal/goos [no test files] ? internal/goroot [no test files] ok internal/gover 0.015s ? internal/goversion [no test files] ok internal/itoa 0.015s ? internal/lazyregexp [no test files] ? internal/lazytemplate [no test files] ? internal/msan [no test files] ? internal/nettrace [no test files] ? internal/obscuretestdata [no test files] ? internal/oserror [no test files] ok internal/pkgbits 0.016s ok internal/platform 1.896s ok internal/poll 0.065s ok internal/profile 0.015s ? internal/profilerecord [no test files] ? internal/race [no test files] ok internal/reflectlite 0.018s ok internal/routebsd 0.017s ok internal/runtime/atomic 0.053s ? internal/runtime/exithook [no test files] ok internal/runtime/maps 0.022s ok internal/runtime/math 0.015s ok internal/runtime/sys 0.015s ok internal/saferio 0.108s ok internal/singleflight 0.122s ? internal/stringslite [no test files] ok internal/sync 1.227s ok internal/synctest 1.285s ? internal/syscall/execenv [no test files] ? internal/syscall/unix [no test files] ok internal/sysinfo 0.016s ? internal/syslist [no test files] ok internal/testenv 0.468s ? internal/testlog [no test files] ? internal/testpty [no test files] --- FAIL: TestTraceStress (128.74s) --- FAIL: TestTraceStress/Default (128.74s) exec.go:213: test timed out while running command: /tmp/workdir/go/bin/go run testdata/testprog/stress.go trace_test.go:610: signal: killed panic: test timed out after 3m0s running tests: TestTraceStressStartStop (7s) TestTraceStressStartStop/Default (7s) goroutine 126 gp=0x4e59d328 m=2 mp=0x4e03c808 [running]: panic({0x824e900, 0x4e836168}) /tmp/workdir/go/src/runtime/panic.go:806 +0x138 fp=0x4e3b2f84 sp=0x4e3b2f30 pc=0x80bc1a8 testing.(*M).startAlarm.func1() /tmp/workdir/go/src/testing/testing.go:2480 +0x37c fp=0x4e3b2ff0 sp=0x4e3b2f84 pc=0x8148d0c runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e3b2ff4 sp=0x4e3b2ff0 pc=0x80c1ef1 created by time.goFunc /tmp/workdir/go/src/time/sleep.go:215 +0x29 goroutine 1 gp=0x4e006128 m=nil [chan receive]: runtime.gopark(0x829af7c, 0x4e6c01b4, 0xe, 0x7, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e04ac38 sp=0x4e04ac24 pc=0x80bc5ea runtime.chanrecv(0x4e6c0180, 0x4e04acaf, 0x1) /tmp/workdir/go/src/runtime/chan.go:664 +0x3f4 fp=0x4e04ac74 sp=0x4e04ac38 pc=0x8055634 runtime.chanrecv1(0x4e6c0180, 0x4e04acaf) /tmp/workdir/go/src/runtime/chan.go:506 +0x1c fp=0x4e04ac88 sp=0x4e04ac74 pc=0x805520c testing.(*T).Run(0x4e006d88, {0x828c315, 0x18}, 0x829addc) /tmp/workdir/go/src/testing/testing.go:1855 +0x481 fp=0x4e04ad10 sp=0x4e04ac88 pc=0x8145791 testing.runTests.func1(0x4e006d88) /tmp/workdir/go/src/testing/testing.go:2275 +0x3f fp=0x4e04ad30 sp=0x4e04ad10 pc=0x814791f testing.tRunner(0x4e006d88, 0x4e04adf4) /tmp/workdir/go/src/testing/testing.go:1788 +0x113 fp=0x4e04ad90 sp=0x4e04ad30 pc=0x8144813 testing.runTests(0x4e010050, {0x84180a0, 0x1a, 0x1a}, {0xc1e0688337f1f12f, 0x29e8f21a53, 0x841ffc0}) /tmp/workdir/go/src/testing/testing.go:2273 +0x3e4 fp=0x4e04ae08 sp=0x4e04ad90 pc=0x8147834 testing.(*M).Run(0x4e062050) /tmp/workdir/go/src/testing/testing.go:2138 +0x634 fp=0x4e04af54 sp=0x4e04ae08 pc=0x8146214 main.main() _testmain.go:99 +0xdf fp=0x4e04afac sp=0x4e04af54 pc=0x82213ff runtime.main() /tmp/workdir/go/src/runtime/proc.go:283 +0x288 fp=0x4e04aff0 sp=0x4e04afac pc=0x8088138 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e04aff4 sp=0x4e04aff0 pc=0x80c1ef1 goroutine 2 gp=0x4e006488 m=nil [force gc (idle), 3 minutes]: runtime.gopark(0x829b0e8, 0x841fc50, 0x11, 0xa, 0x1) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e0387dc sp=0x4e0387c8 pc=0x80bc5ea runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:441 runtime.forcegchelper() /tmp/workdir/go/src/runtime/proc.go:348 +0xc7 fp=0x4e0387f0 sp=0x4e0387dc pc=0x8088497 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e0387f4 sp=0x4e0387f0 pc=0x80c1ef1 created by runtime.init.6 in goroutine 1 /tmp/workdir/go/src/runtime/proc.go:336 +0x1d goroutine 3 gp=0x4e0065a8 m=nil [GC sweep wait]: runtime.gopark(0x829b0e8, 0x841fde0, 0xc, 0x9, 0x1) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e046fcc sp=0x4e046fb8 pc=0x80bc5ea runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:441 runtime.bgsweep(0x4e01e040) /tmp/workdir/go/src/runtime/mgcsweep.go:316 +0xec fp=0x4e046fe8 sp=0x4e046fcc pc=0x807209c runtime.gcenable.gowrap1() /tmp/workdir/go/src/runtime/mgc.go:204 +0x21 fp=0x4e046ff0 sp=0x4e046fe8 pc=0x80638e1 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e046ff4 sp=0x4e046ff0 pc=0x80c1ef1 created by runtime.gcenable in goroutine 1 /tmp/workdir/go/src/runtime/mgc.go:204 +0x71 goroutine 4 gp=0x4e0066c8 m=nil [GC scavenge wait]: runtime.gopark(0x829b0e8, 0x84200e0, 0xd, 0xa, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e3b7fb8 sp=0x4e3b7fa4 pc=0x80bc5ea runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:441 runtime.(*scavengerState).park(0x84200e0) /tmp/workdir/go/src/runtime/mgcscavenge.go:425 +0x54 fp=0x4e3b7fcc sp=0x4e3b7fb8 pc=0x806f6f4 runtime.bgscavenge(0x4e01e040) /tmp/workdir/go/src/runtime/mgcscavenge.go:658 +0x69 fp=0x4e3b7fe8 sp=0x4e3b7fcc pc=0x806fd49 runtime.gcenable.gowrap2() /tmp/workdir/go/src/runtime/mgc.go:205 +0x21 fp=0x4e3b7ff0 sp=0x4e3b7fe8 pc=0x80638a1 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e3b7ff4 sp=0x4e3b7ff0 pc=0x80c1ef1 created by runtime.gcenable in goroutine 1 /tmp/workdir/go/src/runtime/mgc.go:205 +0xb1 goroutine 5 gp=0x4e006c68 m=nil [finalizer wait, 2 minutes]: runtime.gopark(0x829af9c, 0x842c550, 0x10, 0xa, 0x1) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e3b6f9c sp=0x4e3b6f88 pc=0x80bc5ea runtime.runfinq() /tmp/workdir/go/src/runtime/mfinal.go:196 +0xed fp=0x4e3b6ff0 sp=0x4e3b6f9c pc=0x806298d runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e3b6ff4 sp=0x4e3b6ff0 pc=0x80c1ef1 created by runtime.createfing in goroutine 1 /tmp/workdir/go/src/runtime/mfinal.go:166 +0x5a goroutine 12 gp=0x4e006fc8 m=nil [chan receive, 3 minutes]: runtime.gopark(0x829af7c, 0x4e01e1f4, 0xe, 0x7, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e049d38 sp=0x4e049d24 pc=0x80bc5ea runtime.chanrecv(0x4e01e1c0, 0x0, 0x1) /tmp/workdir/go/src/runtime/chan.go:664 +0x3f4 fp=0x4e049d74 sp=0x4e049d38 pc=0x8055634 runtime.chanrecv1(0x4e01e1c0, 0x0) /tmp/workdir/go/src/runtime/chan.go:506 +0x1c fp=0x4e049d88 sp=0x4e049d74 pc=0x805520c testing.(*T).Parallel(0x4e0070e8) /tmp/workdir/go/src/testing/testing.go:1573 +0x267 fp=0x4e049e08 sp=0x4e049d88 pc=0x81444d7 internal/trace_test.TestMMU(0x4e0070e8) /tmp/workdir/go/src/internal/trace/gc_test.go:28 +0x2c fp=0x4e049f84 sp=0x4e049e08 pc=0x821390c testing.tRunner(0x4e0070e8, 0x829ad90) /tmp/workdir/go/src/testing/testing.go:1788 +0x113 fp=0x4e049fe4 sp=0x4e049f84 pc=0x8144813 testing.(*T).Run.gowrap1() /tmp/workdir/go/src/testing/testing.go:1847 +0x28 fp=0x4e049ff0 sp=0x4e049fe4 pc=0x81458d8 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e049ff4 sp=0x4e049ff0 pc=0x80c1ef1 created by testing.(*T).Run in goroutine 1 /tmp/workdir/go/src/testing/testing.go:1847 +0x462 goroutine 10 gp=0x4e007688 m=nil [GC worker (idle), 1 minutes]: runtime.gopark(0x829afac, 0x4e018c48, 0x1b, 0xa, 0x0) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e048f8c sp=0x4e048f78 pc=0x80bc5ea runtime.gcBgMarkWorker(0x4e01fd00) /tmp/workdir/go/src/runtime/mgc.go:1432 +0xeb fp=0x4e048fe8 sp=0x4e048f8c pc=0x806637b runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir/go/src/runtime/mgc.go:1348 +0x21 fp=0x4e048ff0 sp=0x4e048fe8 pc=0x8066271 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e048ff4 sp=0x4e048ff0 pc=0x80c1ef1 created by runtime.gcBgMarkStartWorkers in goroutine 9 /tmp/workdir/go/src/runtime/mgc.go:1348 +0x114 goroutine 120 gp=0x4e007328 m=nil [chan receive]: runtime.gopark(0x829af7c, 0x4e6c0234, 0xe, 0x7, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e04be5c sp=0x4e04be48 pc=0x80bc5ea runtime.chanrecv(0x4e6c0200, 0x4e04bed3, 0x1) /tmp/workdir/go/src/runtime/chan.go:664 +0x3f4 fp=0x4e04be98 sp=0x4e04be5c pc=0x8055634 runtime.chanrecv1(0x4e6c0200, 0x4e04bed3) /tmp/workdir/go/src/runtime/chan.go:506 +0x1c fp=0x4e04beac sp=0x4e04be98 pc=0x805520c testing.(*T).Run(0x4e124248, {0x82852cf, 0x7}, 0x4e836098) /tmp/workdir/go/src/testing/testing.go:1855 +0x481 fp=0x4e04bf34 sp=0x4e04beac pc=0x8145791 internal/trace_test.testTraceProg(0x4e124248, {0x828a45c, 0x14}, 0x0) /tmp/workdir/go/src/internal/trace/trace_test.go:645 +0x22b fp=0x4e04bf70 sp=0x4e04bf34 pc=0x821b9fb internal/trace_test.TestTraceStressStartStop(0x4e124248) /tmp/workdir/go/src/internal/trace/trace_test.go:512 +0x35 fp=0x4e04bf84 sp=0x4e04bf70 pc=0x821b0f5 testing.tRunner(0x4e124248, 0x829addc) /tmp/workdir/go/src/testing/testing.go:1788 +0x113 fp=0x4e04bfe4 sp=0x4e04bf84 pc=0x8144813 testing.(*T).Run.gowrap1() /tmp/workdir/go/src/testing/testing.go:1847 +0x28 fp=0x4e04bff0 sp=0x4e04bfe4 pc=0x81458d8 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e04bff4 sp=0x4e04bff0 pc=0x80c1ef1 created by testing.(*T).Run in goroutine 1 /tmp/workdir/go/src/testing/testing.go:1847 +0x462 goroutine 121 gp=0x4e0078c8 m=3 mp=0x4e03d008 [syscall]: syscall.syscall6(0x80d0850, 0x10cc0, 0x4e3b4e54, 0x0, 0x4e81c190, 0x0, 0x0) /tmp/workdir/go/src/runtime/sys_openbsd3.go:54 +0x20 fp=0x4e3b4e00 sp=0x4e3b4df0 pc=0x80bf520 syscall.wait4(0x10cc0, 0x4e3b4e54, 0x0, 0x4e81c190) /tmp/workdir/go/src/syscall/zsyscall_openbsd_386.go:43 +0x5d fp=0x4e3b4e38 sp=0x4e3b4e00 pc=0x80ced9d syscall.Wait4(0x10cc0, 0x4e3b4e7c, 0x0, 0x4e81c190) /tmp/workdir/go/src/syscall/syscall_bsd.go:144 +0x3b fp=0x4e3b4e5c sp=0x4e3b4e38 pc=0x80ce5eb os.(*Process).pidWait.func1(...) /tmp/workdir/go/src/os/exec_unix.go:68 os.ignoringEINTR2[...](...) /tmp/workdir/go/src/os/file_posix.go:261 os.(*Process).pidWait(0x4e1301e0) /tmp/workdir/go/src/os/exec_unix.go:67 +0xb6 fp=0x4e3b4e94 sp=0x4e3b4e5c pc=0x80ed366 os.(*Process).wait(0x4e1301e0) /tmp/workdir/go/src/os/exec_unix.go:30 +0x23 fp=0x4e3b4ea8 sp=0x4e3b4e94 pc=0x80ed253 os.(*Process).Wait(...) /tmp/workdir/go/src/os/exec.go:358 os/exec.(*Cmd).Wait(0x4e08a0d8) /tmp/workdir/go/src/os/exec/exec.go:922 +0x36 fp=0x4e3b4ee0 sp=0x4e3b4ea8 pc=0x816bbb6 os/exec.(*Cmd).Run(0x4e08a0d8) /tmp/workdir/go/src/os/exec/exec.go:626 +0x3f fp=0x4e3b4ef0 sp=0x4e3b4ee0 pc=0x816a9af internal/trace_test.testTraceProg.func1(0x4e124368, 0x0, {0x0, 0x0}) /tmp/workdir/go/src/internal/trace/trace_test.go:606 +0x3b4 fp=0x4e3b4f70 sp=0x4e3b4ef0 pc=0x821c074 internal/trace_test.testTraceProg.func2(0x4e124368) /tmp/workdir/go/src/internal/trace/trace_test.go:646 +0x32 fp=0x4e3b4f84 sp=0x4e3b4f70 pc=0x821bcb2 testing.tRunner(0x4e124368, 0x4e836098) /tmp/workdir/go/src/testing/testing.go:1788 +0x113 fp=0x4e3b4fe4 sp=0x4e3b4f84 pc=0x8144813 testing.(*T).Run.gowrap1() /tmp/workdir/go/src/testing/testing.go:1847 +0x28 fp=0x4e3b4ff0 sp=0x4e3b4fe4 pc=0x81458d8 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e3b4ff4 sp=0x4e3b4ff0 pc=0x80c1ef1 created by testing.(*T).Run in goroutine 120 /tmp/workdir/go/src/testing/testing.go:1847 +0x462 goroutine 124 gp=0x4e59ca28 m=nil [chan send]: runtime.gopark(0x829af7c, 0x4e6c02b4, 0xf, 0x6, 0x2) /tmp/workdir/go/src/runtime/proc.go:435 +0xfa fp=0x4e04cee8 sp=0x4e04ced4 pc=0x80bc5ea runtime.chansend(0x4e6c0280, 0x4e04cfd4, 0x1, 0x816baa7) /tmp/workdir/go/src/runtime/chan.go:283 +0x2d0 fp=0x4e04cf20 sp=0x4e04cee8 pc=0x8054930 runtime.chansend1(0x4e6c0280, 0x4e04cfd4) /tmp/workdir/go/src/runtime/chan.go:161 +0x24 fp=0x4e04cf38 sp=0x4e04cf20 pc=0x8054654 os/exec.(*Cmd).watchCtx(0x4e08a0d8, 0x4e6c0280) /tmp/workdir/go/src/os/exec/exec.go:873 +0x497 fp=0x4e04cfe4 sp=0x4e04cf38 pc=0x816baa7 os/exec.(*Cmd).Start.gowrap2() /tmp/workdir/go/src/os/exec/exec.go:775 +0x28 fp=0x4e04cff0 sp=0x4e04cfe4 pc=0x816b3c8 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0x4e04cff4 sp=0x4e04cff0 pc=0x80c1ef1 created by os/exec.(*Cmd).Start in goroutine 121 /tmp/workdir/go/src/os/exec/exec.go:775 +0x87b FAIL internal/trace 180.424s ? internal/trace/event [no test files] FAIL go tool dist: Failed: exit status 1