plan9-amd64-0intro at 4b0dd556080fc207962fabdd93007cd4c6ebb04a :: Running /tmp/workdir-gnot/go/src/make.rc with args ["/tmp/workdir-gnot/go/src/make.rc" "-force"] and env ["home=/usr/glenda" "path=.\x00/bin" "*=" "type=host-plan9-amd64-0intro" "rcname=gobuildlet" "pid=183" "fn#term%=fn term% {$*}\n" "fn#newworkdir=fn newworkdir {if(test -d $workdir){for(i in `{du -a $workdir|awk '{print $2}'})chmod u+w $i;rm -rf $workdir};mkdir $workdir}\n" "status=" "fn#cd=fn cd {builtin cd $* && awd}\n" "GO_TEST_TIMEOUT_SCALE=2" "workdir=/tmp/workdir-gnot" "objtype=amd64" "fn#sigexit=" "cflag=" "0=/bin/gobuildlet" "WORKDIR=/tmp/workdir-gnot" "GOROOT_BOOTSTRAP=/tmp/workdir-gnot/go1.4" "GO_BUILDER_NAME=plan9-amd64-0intro" "GOBIN=" "PWD=/tmp/workdir-gnot/go/src"] in dir /tmp/workdir-gnot/go/src Building Go cmd/dist using /tmp/workdir-gnot/go1.4. (go1.20.6 plan9/amd64) Building Go toolchain1 using /tmp/workdir-gnot/go1.4. 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 plan9/amd64. --- Installed Go for plan9/amd64 in /tmp/workdir-gnot/go Installed commands in /tmp/workdir-gnot/go/bin *** You need to bind /tmp/workdir-gnot/go/bin before /bin. ##### Test execution environment. # GOARCH: amd64 # CPU: QEMU Virtual CPU version 2.4.0 # GOOS: plan9 # OS Version: 2000 ##### Testing packages. ok archive/tar 0.140s ok archive/zip 0.228s ok bufio 0.087s ok bytes 0.149s ok cmp 0.063s ok compress/bzip2 0.089s ok compress/flate 0.389s ok compress/gzip 1.115s ok compress/lzw 0.099s ok compress/zlib 0.236s ok container/heap 0.062s ok container/list 0.063s ok container/ring 0.062s ok context 0.272s ok crypto 1.520s ok crypto/aes 0.072s ok crypto/cipher 0.664s ok crypto/des 0.066s ok crypto/dsa 0.170s ok crypto/ecdh 0.133s ok crypto/ecdsa 0.294s ok crypto/ed25519 0.540s ok crypto/elliptic 0.217s ok crypto/hmac 0.064s ok crypto/internal/alias 0.064s ok crypto/internal/bigmod 0.084s ok crypto/internal/boring 0.063s ok crypto/internal/boring/bcache 0.159s ok crypto/internal/edwards25519 0.099s ok crypto/internal/edwards25519/field 0.489s ok crypto/internal/hpke 0.066s ok crypto/internal/mlkem768 0.540s ok crypto/internal/nistec 0.113s ok crypto/internal/nistec/fiat 0.061s [no tests to run] ok crypto/md5 0.235s ok crypto/rand 0.144s ok crypto/rc4 0.073s ok crypto/rsa 0.689s ok crypto/sha1 0.261s ok crypto/sha256 0.458s ok crypto/sha512 0.122s ok crypto/subtle 0.468s ok crypto/tls 14.644s ok crypto/x509 0.242s ok database/sql 0.778s ok database/sql/driver 0.062s ok debug/buildinfo 0.071s ok debug/dwarf 0.099s ok debug/elf 0.154s ok debug/gosym 0.132s ok debug/macho 0.068s ok debug/pe 0.176s ok debug/plan9obj 0.064s ok embed 0.063s [no tests to run] ok embed/internal/embedtest 0.063s ok encoding/ascii85 0.063s ok encoding/asn1 0.065s ok encoding/base32 0.070s ok encoding/base64 0.072s ok encoding/binary 0.065s ok encoding/csv 0.067s ok encoding/gob 1.334s ok encoding/hex 0.064s ok encoding/json 0.262s ok encoding/pem 0.222s ok encoding/xml 0.093s ok errors 0.065s ok expvar 0.071s ok flag 0.361s ok fmt 0.095s ok go/ast 0.073s ok go/build 3.470s ok go/build/constraint 0.064s ok go/constant 0.069s ok go/doc 0.127s ok go/doc/comment 1.184s ok go/format 0.070s ok go/importer 1.085s ok go/internal/gccgoimporter 0.081s ok go/internal/gcimporter 8.306s ok go/internal/srcimporter 4.669s ok go/parser 0.134s ok go/printer 0.153s ok go/scanner 0.062s ok go/token 0.074s ok go/types 27.362s ok go/version 0.063s ok hash 0.070s ok hash/adler32 0.067s ok hash/crc32 0.068s ok hash/crc64 0.063s ok hash/fnv 0.064s ok hash/maphash 0.092s ok html 0.062s ok html/template 0.121s ok image 0.098s ok image/color 0.069s ok image/draw 0.090s ok image/gif 0.116s ok image/jpeg 0.135s ok image/png 0.164s ok index/suffixarray 0.122s ok internal/abi 0.659s ok internal/buildcfg 0.066s ok internal/chacha8rand 0.068s ok internal/concurrent 0.092s ok internal/coverage/cfile 0.064s ok internal/coverage/cformat 0.065s ok internal/coverage/cmerge 0.062s ok internal/coverage/pods 0.069s ok internal/coverage/slicereader 0.064s ok internal/coverage/slicewriter 0.064s ok internal/coverage/test 0.076s ok internal/cpu 0.069s ok internal/dag 0.065s ok internal/diff 0.066s ok internal/fmtsort 0.067s ok internal/fuzz 0.073s ok internal/godebug 2.948s ok internal/godebugs 5.709s ok internal/gover 0.063s ok internal/itoa 0.066s ok internal/platform 1.963s ok internal/poll 0.091s ok internal/profile 0.069s ok internal/reflectlite 0.073s ok internal/runtime/atomic 0.102s ok internal/saferio 0.081s ok internal/singleflight 0.092s ok internal/sysinfo 0.063s ok internal/testenv 0.790s --- FAIL: TestTraceAnnotationsStress (0.95s) --- FAIL: TestTraceAnnotationsStress/Default (0.95s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: code=0x0 addr=0x0 pc=0x257196] runtime stack: runtime.throw({0x2be859?, 0x40ad40?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe908 sp=0x7fffffffe8d8 pc=0x261569 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe988 sp=0x7fffffffe908 pc=0x22e285 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40ae80?, 0x48007378?, 0x200000001?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffedf8 sp=0x7fffffffe988 pc=0x257196 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.GoPark({0x40ae80?, 0x400000002?}, 0x7, 0x2) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:486 +0x8e fp=0x7fffffffee80 sp=0x7fffffffedf8 pc=0x25658e runtime.park_m(0x48007340) /tmp/workdir-gnot/go/src/runtime/proc.go:4077 +0x68 fp=0x7fffffffeed8 sp=0x7fffffffee80 pc=0x23b628 runtime.mcall() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:459 +0x53 fp=0x7fffffffeef0 sp=0x7fffffffeed8 pc=0x266993 goroutine 7 gp=0x48007340 m=0 mp=0x40ae80 [running]: runtime.gopark(0x48007340?, 0x17d68134dae81be1?, 0x10?, 0x4f?, 0x24c054?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054eb0 sp=0x48054e90 pc=0x26168e runtime.chanrecv(0x48082230, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48054f28 sp=0x48054eb0 pc=0x204c7c runtime.chanrecv1(0x480800a0?, 0x17d68134dae81be1?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48054f50 sp=0x48054f28 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a048, 0x3b9aca00) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48054fb0 sp=0x48054f50 pc=0x24e7d1 runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:959 +0x28 fp=0x48054fe0 sp=0x48054fb0 pc=0x24e668 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x268881 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 1 gp=0x480061c0 m=nil [sleep]: runtime.gopark(0x48056de8?, 0x17d681349f4b984d?, 0x5?, 0x0?, 0x2b8a0b?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056dc8 sp=0x48056da8 pc=0x26168e time.Sleep(0x989680) /tmp/workdir-gnot/go/src/runtime/time.go:285 +0x110 fp=0x48056e08 sp=0x48056dc8 pc=0x264150 main.do({0x2dd6c0, 0x4279e0}, 0x4) /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:83 +0x112 fp=0x48056e98 sp=0x48056e08 pc=0x297052 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:43 +0x166 fp=0x48056f48 sp=0x48056e98 pc=0x296e86 runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x48056fe0 sp=0x48056f48 pc=0x2341bd runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x268881 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x26168e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x2344e7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x268881 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x26168e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x2205d4 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x214c65 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x268881 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [GC scavenge wait]: runtime.gopark(0x48018280?, 0x2dc2b0?, 0x1?, 0x0?, 0x48006a80?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x26168e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x40a0e0) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21df89 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x48059fc8 sp=0x48059fa8 pc=0x21e55c runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x214c05 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x268881 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x26168e runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x213ca7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x268881 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [chan receive]: runtime.gopark(0x48007180?, 0x17d68134a543276e?, 0x8?, 0x3f?, 0x24c054?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053ea8 sp=0x48053e88 pc=0x26168e runtime.chanrecv(0x480820e0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48053f20 sp=0x48053ea8 pc=0x204c7c runtime.chanrecv1(0x48080050?, 0x17d68134a543276e?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48053f48 sp=0x48053f20 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a030, 0x5f5e100) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48053fa8 sp=0x48053f48 pc=0x24e7d1 runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:54 +0x45 fp=0x48053fe0 sp=0x48053fa8 pc=0x254085 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x268881 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 8 gp=0x48007500 m=nil [runnable]: runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 fp=0x48055fe0 sp=0x48055fd8 pc=0x296b40 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x268881 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf goroutine 9 gp=0x480076c0 m=nil [runnable]: main.do.func1.gowrap1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:69 fp=0x48090fe0 sp=0x48090fd8 pc=0x2971c0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48090fe8 sp=0x48090fe0 pc=0x268881 created by main.do.func1 in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:69 +0x45 goroutine 10 gp=0x48007880 m=nil [runnable]: main.do.func1.gowrap1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:69 fp=0x48091fe0 sp=0x48091fd8 pc=0x2971c0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48091fe8 sp=0x48091fe0 pc=0x268881 created by main.do.func1 in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:69 +0x45 goroutine 11 gp=0x48007a40 m=nil [runnable]: main.do.func1.gowrap1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:69 fp=0x48092fe0 sp=0x48092fd8 pc=0x2971c0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48092fe8 sp=0x48092fe0 pc=0x268881 created by main.do.func1 in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/annotations-stress.go:69 +0x45 exit status: 'annotations-stress 19055: 2' trace_test.go:579: exit status: 'go 19034: 1' --- FAIL: TestTraceCPUProfile (4.21s) --- FAIL: TestTraceCPUProfile/Default (4.21s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: code=0x0 addr=0x0 pc=0x258776] runtime stack: runtime.throw({0x2f4ba7?, 0x40c3c0?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe908 sp=0x7fffffffe8d8 pc=0x262b49 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe988 sp=0x7fffffffe908 pc=0x22e9e5 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40c500?, 0x48007378?, 0x200000001?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffedf8 sp=0x7fffffffe988 pc=0x258776 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.GoPark({0x40c500?, 0x400000002?}, 0x7, 0x2) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:486 +0x8e fp=0x7fffffffee80 sp=0x7fffffffedf8 pc=0x257b6e runtime.park_m(0x48007340) /tmp/workdir-gnot/go/src/runtime/proc.go:4077 +0x68 fp=0x7fffffffeed8 sp=0x7fffffffee80 pc=0x23bec8 runtime.mcall() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:459 +0x53 fp=0x7fffffffeef0 sp=0x7fffffffeed8 pc=0x267fb3 goroutine 7 gp=0x48007340 m=0 mp=0x40c500 [running]: runtime.gopark(0x48007340?, 0x0?, 0x8?, 0x4f?, 0x24d634?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054ea8 sp=0x48054e88 pc=0x262c6e runtime.chanrecv(0x48082150, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48054f20 sp=0x48054ea8 pc=0x20501c runtime.chanrecv1(0x48080050?, 0x17d68135a41890cb?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48054f48 sp=0x48054f20 pc=0x204bf2 runtime.(*wakeableSleep).sleep(0x4801a048, 0x5f5e100) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48054fa8 sp=0x48054f48 pc=0x24fdb1 runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:54 +0x45 fp=0x48054fe0 sp=0x48054fa8 pc=0x255665 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x269ea1 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 1 gp=0x480061c0 m=nil [runnable]: runtime.Gosched(...) /tmp/workdir-gnot/go/src/runtime/proc.go:353 main.cpuHog0(0x4809bb98?, 0x186a0) /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/cpu-profile.go:128 +0x65 fp=0x4809bb88 sp=0x4809bb60 pc=0x2c3925 main.cpuHog1(0x0?) /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/cpu-profile.go:120 +0x18 fp=0x4809bba8 sp=0x4809bb88 pc=0x2c3898 main.cpuHogger(0x2f6d58, 0x42b8a8, 0x5f5e100) /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/cpu-profile.go:107 +0x4f fp=0x4809bbf8 sp=0x4809bba8 pc=0x2c37ef main.main.func1(0x5f5e100) /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/cpu-profile.go:49 +0x245 fp=0x4809bcc0 sp=0x4809bbf8 pc=0x2c36a5 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/cpu-profile.go:50 +0x10f fp=0x4809bf48 sp=0x4809bcc0 pc=0x2c2e8f runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x4809bfe0 sp=0x4809bf48 pc=0x234a5d runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4809bfe8 sp=0x4809bfe0 pc=0x269ea1 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x262c6e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x234d87 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x269ea1 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x262c6e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x220d34 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x2153c5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x269ea1 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [GC scavenge wait]: runtime.gopark(0x48018280?, 0x316bd0?, 0x1?, 0x0?, 0x48006a80?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x262c6e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x40b760) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21e6e9 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x48059fc8 sp=0x48059fa8 pc=0x21ecbc runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x215365 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x269ea1 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x262c6e runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x214407 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x269ea1 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [sleep]: runtime.gopark(0x48053f38?, 0x17d681359e22972b?, 0x0?, 0x60?, 0x480a8000?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053f18 sp=0x48053ef8 pc=0x262c6e time.Sleep(0x5f5e100) /tmp/workdir-gnot/go/src/runtime/time.go:285 +0x110 fp=0x48053f58 sp=0x48053f18 pc=0x265cb0 runtime/pprof.profileWriter({0x3182e8?, 0x480840f0?}) /tmp/workdir-gnot/go/src/runtime/pprof/pprof.go:848 +0x4a fp=0x48053fc0 sp=0x48053f58 pc=0x2b9b4a runtime/pprof.StartCPUProfile.gowrap2() /tmp/workdir-gnot/go/src/runtime/pprof/pprof.go:833 +0x25 fp=0x48053fe0 sp=0x48053fc0 pc=0x2b9a65 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x269ea1 created by runtime/pprof.StartCPUProfile in goroutine 1 /tmp/workdir-gnot/go/src/runtime/pprof/pprof.go:833 +0x145 goroutine 8 gp=0x48007500 m=nil [chan receive]: runtime.gopark(0x48007500?, 0x17d68135d3c77a3d?, 0x10?, 0x5f?, 0x24d634?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48055eb0 sp=0x48055e90 pc=0x262c6e runtime.chanrecv(0x480822a0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48055f28 sp=0x48055eb0 pc=0x20501c runtime.chanrecv1(0x480800a0?, 0x17d68135d3c77a3d?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48055f50 sp=0x48055f28 pc=0x204bf2 runtime.(*wakeableSleep).sleep(0x4801a060, 0x3b9aca00) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48055fb0 sp=0x48055f50 pc=0x24fdb1 runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:959 +0x28 fp=0x48055fe0 sp=0x48055fb0 pc=0x24fc48 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x269ea1 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 9 gp=0x480076c0 m=nil [trace reader (blocked)]: runtime.gopark(0x480a1f78?, 0x480260c0?, 0x38?, 0x1f?, 0x480a1f90?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x480a1f38 sp=0x480a1f18 pc=0x262c6e runtime.ReadTrace() /tmp/workdir-gnot/go/src/runtime/trace.go:757 +0x31 fp=0x480a1fa0 sp=0x480a1f38 pc=0x24f671 runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:130 +0x45 fp=0x480a1fe0 sp=0x480a1fa0 pc=0x2c2b85 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x480a1fe8 sp=0x480a1fe0 pc=0x269ea1 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf exit status: 'cpu-profile 19129: 2' trace_test.go:579: exit status: 'go 19061: 1' --- FAIL: TestTraceGCStress (1.08s) --- FAIL: TestTraceGCStress/Default (1.08s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: code=0x0 addr=0x0 pc=0x257096] runtime stack: runtime.throw({0x2b5c1d?, 0x1?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe878 sp=0x7fffffffe848 pc=0x2611a9 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe8f8 sp=0x7fffffffe878 pc=0x22e285 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40a900?, 0x1?, 0x2b1bcb?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffed68 sp=0x7fffffffe8f8 pc=0x257096 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.STWStart({0x40ad20?, 0x20a7b5?}, 0x1) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:362 +0xa6 fp=0x7fffffffede8 sp=0x7fffffffed68 pc=0x255b26 runtime.stopTheWorldWithSema(0x1) /tmp/workdir-gnot/go/src/runtime/proc.go:1540 +0x59 fp=0x7fffffffeec0 sp=0x7fffffffede8 pc=0x236d39 runtime.gcMarkDone.func2() /tmp/workdir-gnot/go/src/runtime/mgc.go:884 +0x25 fp=0x7fffffffeee0 sp=0x7fffffffeec0 pc=0x215b25 runtime.systemstack(0x40a0c0) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:514 +0x4d fp=0x7fffffffeef0 sp=0x7fffffffeee0 pc=0x265f0d goroutine 7 gp=0x48007340 m=0 mp=0x40ad20 [running]: runtime.systemstack_switch() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:479 +0x8 fp=0x490e0db8 sp=0x490e0da8 pc=0x265ea8 runtime.gcMarkDone() /tmp/workdir-gnot/go/src/runtime/mgc.go:883 +0x247 fp=0x490e0e60 sp=0x490e0db8 pc=0x215827 runtime.gcAssistAlloc(0x48007340) /tmp/workdir-gnot/go/src/runtime/mgcmark.go:552 +0x245 fp=0x490e0ec0 sp=0x490e0e60 pc=0x2198a5 runtime.deductAssistCredit(0x4a9a7000?) /tmp/workdir-gnot/go/src/runtime/malloc.go:1349 +0x54 fp=0x490e0ee8 sp=0x490e0ec0 pc=0x20bcb4 runtime.mallocgc(0x1000, 0x299060, 0x1) /tmp/workdir-gnot/go/src/runtime/malloc.go:1037 +0xde fp=0x490e0f88 sp=0x490e0ee8 pc=0x25d63e runtime.makeslice(0x299060?, 0x1000?, 0x1000?) /tmp/workdir-gnot/go/src/runtime/slice.go:116 +0x49 fp=0x490e0fb0 sp=0x490e0f88 pc=0x262329 main.main.func1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/gc-stress.go:64 +0x35 fp=0x490e0fe0 sp=0x490e0fb0 pc=0x290775 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x490e0fe8 sp=0x490e0fe0 pc=0x267d81 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/gc-stress.go:62 +0x18b goroutine 1 gp=0x480061c0 m=nil [sleep]: runtime.gopark(0x4aa77ea8?, 0x17d68136179b7426?, 0x0?, 0x0?, 0x290200?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x490dfe88 sp=0x490dfe68 pc=0x2612ce time.Sleep(0x17d78400) /tmp/workdir-gnot/go/src/runtime/time.go:285 +0x110 fp=0x490dfec8 sp=0x490dfe88 pc=0x263d90 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/gc-stress.go:79 +0x21a fp=0x490dff48 sp=0x490dfec8 pc=0x29069a runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x490dffe0 sp=0x490dff48 pc=0x2341bd runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x490dffe8 sp=0x490dffe0 pc=0x267d81 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x2612ce runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x2344e7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x267d81 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [runnable]: runtime.goschedIfBusy() /tmp/workdir-gnot/go/src/runtime/proc.go:376 +0x28 fp=0x48058f80 sp=0x48058f68 pc=0x2345c8 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:301 +0x14f fp=0x48058fc8 sp=0x48058f80 pc=0x22068f runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x214c65 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x267d81 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [runnable]: runtime.gopark(0x48080000?, 0x17d6813653509057?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f28 sp=0x48059f08 pc=0x2612ce runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).sleep(0x409f80, 0x412e86d200000000) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:504 +0x138 fp=0x48059fa8 sp=0x48059f28 pc=0x21e178 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:662 +0x74 fp=0x48059fc8 sp=0x48059fa8 pc=0x21e594 runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x214c05 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x267d81 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x2612ce runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x213ca7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x267d81 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [GC worker (idle)]: runtime.gopark(0x48053f68?, 0x17d681361790db57?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053f28 sp=0x48053f08 pc=0x2612ce runtime.gcBgMarkWorker(0x480820e0) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x48053fc8 sp=0x48053f28 pc=0x216eec runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x48053fe0 sp=0x48053fc8 pc=0x216dc5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x267d81 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 8 gp=0x48007500 m=nil [chan receive]: runtime.gopark(0x48007500?, 0x17d681361da7d11d?, 0x8?, 0x6f?, 0x24bf93?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056ea8 sp=0x48056e88 pc=0x2612ce runtime.chanrecv(0x480820e0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48056f20 sp=0x48056ea8 pc=0x204c7c runtime.chanrecv1(0x480800a0?, 0x17d681361da7d11d?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48056f48 sp=0x48056f20 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a048, 0x5f5e100) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48056fa8 sp=0x48056f48 pc=0x24e6d1 runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:54 +0x45 fp=0x48056fe0 sp=0x48056fa8 pc=0x253f85 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x267d81 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 9 gp=0x480076c0 m=nil [chan receive]: runtime.gopark(0x480076c0?, 0x0?, 0x10?, 0xff?, 0x24bf54?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054eb0 sp=0x48054e90 pc=0x2612ce runtime.chanrecv(0x48082230, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48054f28 sp=0x48054eb0 pc=0x204c7c runtime.chanrecv1(0x480800f0?, 0x17d68136534cc2e0?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48054f50 sp=0x48054f28 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a060, 0x3b9aca00) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48054fb0 sp=0x48054f50 pc=0x24e6d1 runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:959 +0x28 fp=0x48054fe0 sp=0x48054fb0 pc=0x24e568 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x267d81 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 10 gp=0x48007880 m=nil [trace reader (blocked)]: runtime.gopark(0x490e1f78?, 0x480260c0?, 0x38?, 0x1f?, 0x490e1f90?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x490e1f38 sp=0x490e1f18 pc=0x2612ce runtime.ReadTrace() /tmp/workdir-gnot/go/src/runtime/trace.go:757 +0x31 fp=0x490e1fa0 sp=0x490e1f38 pc=0x24df91 runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:130 +0x45 fp=0x490e1fe0 sp=0x490e1fa0 pc=0x2901e5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x490e1fe8 sp=0x490e1fe0 pc=0x267d81 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf exit status: 'gc-stress 19179: 2' trace_test.go:579: exit status: 'go 19158: 1' --- FAIL: TestTraceGOMAXPROCS (0.94s) --- FAIL: TestTraceGOMAXPROCS/Default (0.94s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: code=0x0 addr=0x0 pc=0x257356] runtime stack: runtime.throw({0x2b575d?, 0x40ab40?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe908 sp=0x7fffffffe8d8 pc=0x261469 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe988 sp=0x7fffffffe908 pc=0x22e545 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40ac80?, 0x48007538?, 0x200000001?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffedf8 sp=0x7fffffffe988 pc=0x257356 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.GoPark({0x40ac80?, 0x400000002?}, 0x7, 0x2) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:486 +0x8e fp=0x7fffffffee80 sp=0x7fffffffedf8 pc=0x25674e runtime.park_m(0x48007500) /tmp/workdir-gnot/go/src/runtime/proc.go:4077 +0x68 fp=0x7fffffffeed8 sp=0x7fffffffee80 pc=0x23b8e8 runtime.mcall() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:459 +0x53 fp=0x7fffffffeef0 sp=0x7fffffffeed8 pc=0x266153 goroutine 8 gp=0x48007500 m=0 mp=0x40ac80 [running]: runtime.gopark(0x48007500?, 0x17d681368c3a9440?, 0x10?, 0x5f?, 0x24c214?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48055eb0 sp=0x48055e90 pc=0x26158e runtime.chanrecv(0x48082230, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48055f28 sp=0x48055eb0 pc=0x204c7c runtime.chanrecv1(0x480800a0?, 0x17d681368c3a9440?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48055f50 sp=0x48055f28 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a048, 0x3b9aca00) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48055fb0 sp=0x48055f50 pc=0x24e991 runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:959 +0x28 fp=0x48055fe0 sp=0x48055fb0 pc=0x24e828 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x268041 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 1 gp=0x480061c0 m=nil [sleep]: runtime.gopark(0x48056ed0?, 0x17d68136509c744b?, 0x0?, 0x0?, 0x2904c0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056eb0 sp=0x48056e90 pc=0x26158e time.Sleep(0xf4240) /tmp/workdir-gnot/go/src/runtime/time.go:285 +0x110 fp=0x48056ef0 sp=0x48056eb0 pc=0x264050 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/gomaxprocs.go:38 +0x91 fp=0x48056f48 sp=0x48056ef0 pc=0x2906d1 runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x48056fe0 sp=0x48056f48 pc=0x23447d runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x268041 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x26158e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x2347a7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x268041 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x26158e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x2207d4 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x214c65 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x268041 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [runnable]: runtime.gopark(0x48018280?, 0x2d2c18?, 0x1?, 0x0?, 0x48006a80?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x26158e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x409ee0) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21e189 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x48059fc8 sp=0x48059fa8 pc=0x21e75c runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x214c05 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x268041 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x26158e runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x213ca7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x268041 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [wait for GC cycle]: runtime.gopark(0x48053f18?, 0x48053ee8?, 0x80?, 0x57?, 0x48053ee8?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053f60 sp=0x48053f40 pc=0x26158e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.gcWaitOnMark(0x1) /tmp/workdir-gnot/go/src/runtime/mgc.go:538 +0x55 fp=0x48053f90 sp=0x48053f60 pc=0x214f15 runtime.GC() /tmp/workdir-gnot/go/src/runtime/mgc.go:482 +0x47 fp=0x48053fc8 sp=0x48053f90 pc=0x214dc7 main.main.func1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/gomaxprocs.go:26 +0x13 fp=0x48053fe0 sp=0x48053fc8 pc=0x290753 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x268041 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/gomaxprocs.go:24 +0x1e goroutine 7 gp=0x48007340 m=nil [chan receive]: runtime.gopark(0x48007340?, 0x17d6813656959bc0?, 0x8?, 0x4f?, 0x24c214?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054ea8 sp=0x48054e88 pc=0x26158e runtime.chanrecv(0x480820e0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48054f20 sp=0x48054ea8 pc=0x204c7c runtime.chanrecv1(0x48080050?, 0x17d6813656959bc0?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48054f48 sp=0x48054f20 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a030, 0x5f5e100) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48054fa8 sp=0x48054f48 pc=0x24e991 runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:54 +0x45 fp=0x48054fe0 sp=0x48054fa8 pc=0x254245 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x268041 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 9 gp=0x480076c0 m=nil [trace reader (blocked)]: runtime.gopark(0x48090f78?, 0x480260c0?, 0x38?, 0xf?, 0x48090f90?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48090f38 sp=0x48090f18 pc=0x26158e runtime.ReadTrace() /tmp/workdir-gnot/go/src/runtime/trace.go:757 +0x31 fp=0x48090fa0 sp=0x48090f38 pc=0x24e251 runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:130 +0x45 fp=0x48090fe0 sp=0x48090fa0 pc=0x2904a5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48090fe8 sp=0x48090fe0 pc=0x268041 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf goroutine 10 gp=0x48007880 m=nil [GC worker (idle)]: runtime.gopark(0x48091f68?, 0x17d68136509fae7f?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48091f28 sp=0x48091f08 pc=0x26158e runtime.gcBgMarkWorker(0x480822a0) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x48091fc8 sp=0x48091f28 pc=0x2170ec runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x48091fe0 sp=0x48091fc8 pc=0x216fc5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48091fe8 sp=0x48091fe0 pc=0x268041 created by runtime.gcBgMarkStartWorkers in goroutine 6 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 exit status: 'gomaxprocs 19202: 2' trace_test.go:579: exit status: 'go 19182: 1' --- FAIL: TestTraceStacks (3.13s) --- FAIL: TestTraceStacks/Default (3.13s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: code=0x0 addr=0x0 pc=0x259ff6] runtime stack: runtime.throw({0x307ee0?, 0x40bb60?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe918 sp=0x7fffffffe8e8 pc=0x2648e9 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe998 sp=0x7fffffffe918 pc=0x22f205 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40bca0?, 0x1?, 0x15?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffee08 sp=0x7fffffffe998 pc=0x259ff6 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.GoPark({0x40bca0?, 0x48096a80?}, 0xe, 0x1) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:486 +0x8e fp=0x7fffffffee90 sp=0x7fffffffee08 pc=0x2593ee runtime.park_m(0x480061c0) /tmp/workdir-gnot/go/src/runtime/proc.go:4077 +0x68 fp=0x7fffffffeee8 sp=0x7fffffffee90 pc=0x23c9e8 runtime.mcall() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:459 +0x53 fp=0x7fffffffef00 sp=0x7fffffffeee8 pc=0x269b53 goroutine 1 gp=0x480061c0 m=0 mp=0x40bca0 [running]: runtime.gopark(0x48056de0?, 0x17d681370aa9044c?, 0x60?, 0xe8?, 0x4801a120?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056dc0 sp=0x48056da0 pc=0x264a0e time.Sleep(0x5f5e100) /tmp/workdir-gnot/go/src/runtime/time.go:285 +0x110 fp=0x48056e00 sp=0x48056dc0 pc=0x267890 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:101 +0x59e fp=0x48056f48 sp=0x48056e00 pc=0x2cd25e runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x48056fe0 sp=0x48056f48 pc=0x23557d runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x26ba41 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x2358a7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x26ba41 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x221174 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x2155a5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x26ba41 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [GC scavenge wait]: runtime.gopark(0x48018280?, 0x32be68?, 0x1?, 0x0?, 0x48006a80?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x40af00) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21eb29 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x48059fc8 sp=0x48059fa8 pc=0x21f0fc runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x215545 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x26ba41 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [runnable]: runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:176 fp=0x48052fe0 sp=0x48052fd8 pc=0x2144e0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x26ba41 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [runnable]: runtime.unique_runtime_registerUniqueMapCleanup.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1730 fp=0x48053fe0 sp=0x48053fd8 pc=0x218760 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x26ba41 created by unique.runtime_registerUniqueMapCleanup in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1730 +0x96 goroutine 7 gp=0x48007340 m=nil [runnable]: runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 fp=0x48054fe0 sp=0x48054fd8 pc=0x256ea0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x26ba41 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 8 gp=0x48007500 m=nil [runnable]: runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:956 fp=0x48055fe0 sp=0x48055fd8 pc=0x2514a0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x26ba41 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 9 gp=0x480076c0 m=nil [runnable]: runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 fp=0x48092fe0 sp=0x48092fd8 pc=0x2ccae0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48092fe8 sp=0x48092fe0 pc=0x26ba41 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf goroutine 10 gp=0x48007880 m=nil [runnable]: main.main.func1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:32 fp=0x48093fe0 sp=0x48093fd8 pc=0x2cd900 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48093fe8 sp=0x48093fe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:32 +0xd4 goroutine 11 gp=0x48007a40 m=nil [runnable]: main.main.func2() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:35 fp=0x48094fe0 sp=0x48094fd8 pc=0x2cd920 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48094fe8 sp=0x48094fe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:35 +0xe5 goroutine 12 gp=0x48007c00 m=nil [runnable]: main.main.func3() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:39 fp=0x48095fe0 sp=0x48095fd8 pc=0x2cd960 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48095fe8 sp=0x48095fe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:39 +0xf1 goroutine 13 gp=0x48007dc0 m=nil [runnable]: main.main.func4() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:44 fp=0x4808efe0 sp=0x4808efd8 pc=0x2cd8c0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4808efe8 sp=0x4808efe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:44 +0x149 goroutine 14 gp=0x48096000 m=nil [runnable]: main.main.func5() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:48 fp=0x4808ffe0 sp=0x4808ffd8 pc=0x2cd880 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4808ffe8 sp=0x4808ffe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:48 +0x1a5 goroutine 15 gp=0x480961c0 m=nil [runnable]: main.main.func6() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:53 fp=0x48090fe0 sp=0x48090fd8 pc=0x2cd800 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48090fe8 sp=0x48090fe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:53 +0x22b goroutine 16 gp=0x48096380 m=nil [runnable]: main.main.func7() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:61 fp=0x48091fe0 sp=0x48091fd8 pc=0x2cd7a0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48091fe8 sp=0x48091fe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:61 +0x29f goroutine 17 gp=0x48096540 m=nil [runnable]: main.main.func8() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:67 fp=0x4809cfe0 sp=0x4809cfd8 pc=0x2cd760 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4809cfe8 sp=0x4809cfe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:67 +0x2ff goroutine 18 gp=0x48096700 m=nil [runnable]: main.main.func9() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:71 fp=0x4809dfe0 sp=0x4809dfd8 pc=0x2cd700 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4809dfe8 sp=0x4809dfe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:71 +0x396 goroutine 20 gp=0x480968c0 m=nil [runnable]: main.main.func10() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:80 fp=0x4809efe0 sp=0x4809efd8 pc=0x2cd5c0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4809efe8 sp=0x4809efe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:80 +0x465 goroutine 21 gp=0x48096a80 m=nil [runnable]: main.main.func11() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:95 fp=0x4809ffe0 sp=0x4809ffd8 pc=0x2cd4a0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4809ffe8 sp=0x4809ffe0 pc=0x26ba41 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stacks.go:95 +0x594 exit status: 'stacks 19252: 2' trace_test.go:579: exit status: 'go 19205: 1' --- FAIL: TestTraceStress (2.77s) --- FAIL: TestTraceStress/Default (2.77s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: fault read code=0x0 addr=0x0 pc=0x259ff6] runtime stack: runtime.throw({0x306ff2?, 0x40bb30?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe5b0 sp=0x7fffffffe580 pc=0x2648e9 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe630 sp=0x7fffffffe5b0 pc=0x22f205 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x4805a708?, 0x2341cb?, 0x48007a02?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffeaa0 sp=0x7fffffffe630 pc=0x259ff6 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.GoStop({0x4805a708?, 0x48007a40?}, 0x2) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:478 +0x85 fp=0x7fffffffeb28 sp=0x7fffffffeaa0 pc=0x2592a5 runtime.traceLocker.GoPreempt(...) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:473 runtime.goschedImpl(0x48582e00, 0x1?) /tmp/workdir-gnot/go/src/runtime/proc.go:4117 +0x7a fp=0x7fffffffeb78 sp=0x7fffffffeb28 pc=0x23cc1a runtime.gopreempt_m(...) /tmp/workdir-gnot/go/src/runtime/proc.go:4153 runtime.newstack() /tmp/workdir-gnot/go/src/runtime/stack.go:1084 +0x3b1 fp=0x7fffffffecb0 sp=0x7fffffffeb78 pc=0x249f91 runtime.morestack() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:621 +0x7d fp=0x7fffffffecb8 sp=0x7fffffffecb0 pc=0x26999d goroutine 25 gp=0x48582e00 m=2 mp=0x4805a708 [running]: runtime.gcMarkDone() /tmp/workdir-gnot/go/src/runtime/mgc.go:824 +0x386 fp=0x4858af28 sp=0x4858af20 pc=0x2164a6 runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1499 +0x385 fp=0x4858afc8 sp=0x4858af28 pc=0x217cc5 runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x4858afe0 sp=0x4858afc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4858afe8 sp=0x4858afe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 1 gp=0x480061c0 m=nil [wait for GC cycle]: runtime.gopark(0x48056d98?, 0x48056d68?, 0xc0?, 0x60?, 0x48056d68?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056de0 sp=0x48056dc0 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.gcWaitOnMark(0x1) /tmp/workdir-gnot/go/src/runtime/mgc.go:538 +0x55 fp=0x48056e10 sp=0x48056de0 pc=0x215855 runtime.GC() /tmp/workdir-gnot/go/src/runtime/mgc.go:482 +0x47 fp=0x48056e48 sp=0x48056e10 pc=0x215707 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress.go:71 +0x2cc fp=0x48056f48 sp=0x48056e48 pc=0x2cc7cc runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x48056fe0 sp=0x48056f48 pc=0x23557d runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x26b701 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x2358a7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x26b701 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x221174 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x2155a5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x26b701 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [GC scavenge wait]: runtime.gopark(0x10000?, 0x32adb8?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x40af00) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21eb29 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:658 +0x59 fp=0x48059fc8 sp=0x48059fa8 pc=0x21f119 runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x215545 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x26b701 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x264a0e runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x2145e7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x26b701 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [chan receive]: runtime.gopark(0x48053f60?, 0x2a5745?, 0x20?, 0x41?, 0x32e020?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053f18 sp=0x48053ef8 pc=0x264a0e runtime.chanrecv(0x480820e0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48053f90 sp=0x48053f18 pc=0x204fdc runtime.chanrecv1(0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48053fb8 sp=0x48053f90 pc=0x204bb2 runtime.unique_runtime_registerUniqueMapCleanup.func1(...) /tmp/workdir-gnot/go/src/runtime/mgc.go:1732 runtime.unique_runtime_registerUniqueMapCleanup.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1735 +0x2f fp=0x48053fe0 sp=0x48053fb8 pc=0x21878f runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x26b701 created by unique.runtime_registerUniqueMapCleanup in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1730 +0x96 goroutine 7 gp=0x48007340 m=nil [chan receive]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054f18 sp=0x48054ef8 pc=0x264a0e runtime.chanrecv(0x48082150, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48054f90 sp=0x48054f18 pc=0x204fdc runtime.chanrecv1(0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48054fb8 sp=0x48054f90 pc=0x204bb2 main.main.func1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress.go:29 +0x25 fp=0x48054fe0 sp=0x48054fb8 pc=0x2cd025 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x26b701 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress.go:28 +0xd2 goroutine 8 gp=0x48007500 m=0 mp=0x40bca0 [syscall]: syscall.Syscall6(0x32, 0x3, 0x48055fbf, 0x1, 0xffffffffffffffff, 0xffffffffffffffff, 0x0) /tmp/workdir-gnot/go/src/syscall/asm_plan9_amd64.s:63 +0x10 fp=0x48055e70 sp=0x48055db8 pc=0x2856f0 syscall.Pread(0x48026140?, {0x48055fbf?, 0x0?, 0x0?}, 0x0?) /tmp/workdir-gnot/go/src/syscall/zsyscall_plan9_amd64.go:218 +0x5e fp=0x48055ee8 sp=0x48055e70 pc=0x28531e syscall.Read(...) /tmp/workdir-gnot/go/src/syscall/syscall_plan9.go:170 os.(*File).read(0x48042048, {0x48055fbf, 0x1, 0x1}) /tmp/workdir-gnot/go/src/os/file_plan9.go:295 +0xd9 fp=0x48055f58 sp=0x48055ee8 pc=0x2931d9 os.(*File).Read(0x48042048, {0x48055fbf, 0x1, 0x1}) /tmp/workdir-gnot/go/src/os/file.go:124 +0x65 fp=0x48055f98 sp=0x48055f58 pc=0x291fc5 main.main.func3() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress.go:45 +0x3b fp=0x48055fe0 sp=0x48055f98 pc=0x2ccf5b runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x26b701 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress.go:43 +0x1ed goroutine 9 gp=0x480076c0 m=nil [chan receive]: runtime.gopark(0x480076c0?, 0x17d68137ae9eb247?, 0x8?, 0x2f?, 0x24eef3?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48092ea8 sp=0x48092e88 pc=0x264a0e runtime.chanrecv(0x480821c0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48092f20 sp=0x48092ea8 pc=0x204fdc runtime.chanrecv1(0x480800a0?, 0x17d68137ae9eb247?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48092f48 sp=0x48092f20 pc=0x204bb2 runtime.(*wakeableSleep).sleep(0x4801a0a8, 0x5f5e100) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48092fa8 sp=0x48092f48 pc=0x251631 runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:54 +0x45 fp=0x48092fe0 sp=0x48092fa8 pc=0x256ee5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48092fe8 sp=0x48092fe0 pc=0x26b701 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 10 gp=0x48007880 m=nil [runnable]: runtime.(*inlineUnwinder).next(0x48093d60?, {0x258644?, 0x0?}) /tmp/workdir-gnot/go/src/runtime/symtabinl.go:91 +0xb9 fp=0x48093d10 sp=0x48093d08 pc=0x24e1f9 runtime.fpunwindExpand({0x48628000, 0x80, 0x400?}, {0x45e4f010?, 0x0?, 0x48380008?}) /tmp/workdir-gnot/go/src/runtime/tracestack.go:319 +0x1d2 fp=0x48093d90 sp=0x48093d10 pc=0x25adb2 runtime.dumpStacksRec(0x48093e50?, {{0x0?, 0x48093e50?}, 0x2565c5?}, {0x48628000, 0x80, 0x80}) /tmp/workdir-gnot/go/src/runtime/tracestack.go:164 +0xac fp=0x48093e18 sp=0x48093d90 pc=0x25a34c runtime.(*traceStackTable).dump(0x40b710, 0x1) /tmp/workdir-gnot/go/src/runtime/tracestack.go:153 +0x68 fp=0x48093e60 sp=0x48093e18 pc=0x25a248 runtime.traceAdvance(0x0) /tmp/workdir-gnot/go/src/runtime/trace.go:588 +0x5d1 fp=0x48093fb0 sp=0x48093e60 pc=0x267e71 runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:962 +0x2f fp=0x48093fe0 sp=0x48093fb0 pc=0x2514cf runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48093fe8 sp=0x48093fe0 pc=0x26b701 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 11 gp=0x48007a40 m=nil [runnable]: syscall.Syscall6(0x33, 0x1, 0x45c0f020, 0xffc8, 0xffffffffffffffff, 0xffffffffffffffff, 0x0) /tmp/workdir-gnot/go/src/syscall/asm_plan9_amd64.s:63 +0x10 fp=0x48094e78 sp=0x48094dc0 pc=0x2856f0 syscall.Pwrite(0x480260c0?, {0x45c0f020?, 0x7fffffffde00?, 0x48094f28?}, 0x264a0e?) /tmp/workdir-gnot/go/src/syscall/zsyscall_plan9_amd64.go:235 +0x5e fp=0x48094ef0 sp=0x48094e78 pc=0x28541e syscall.Write(...) /tmp/workdir-gnot/go/src/syscall/syscall_plan9.go:182 os.(*File).write(0x48042030, {0x45c0f020, 0xffc8, 0xffe0}) /tmp/workdir-gnot/go/src/os/file_plan9.go:329 +0x11d fp=0x48094f60 sp=0x48094ef0 pc=0x29347d os.(*File).Write(0x48042030, {0x45c0f020, 0xffc8, 0xffe0}) /tmp/workdir-gnot/go/src/os/file.go:195 +0x65 fp=0x48094fa0 sp=0x48094f60 pc=0x2920a5 runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:134 +0x3b fp=0x48094fe0 sp=0x48094fa0 pc=0x2cc35b runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48094fe8 sp=0x48094fe0 pc=0x26b701 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf goroutine 17 gp=0x48582000 m=nil [runnable, locked to thread]: runtime.Gosched(...) /tmp/workdir-gnot/go/src/runtime/proc.go:353 main.main.func4() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress.go:66 +0x65 fp=0x4808efe0 sp=0x4808efb8 pc=0x2ccec5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4808efe8 sp=0x4808efe0 pc=0x26b701 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress.go:59 +0x2c7 goroutine 18 gp=0x485821c0 m=nil [GC worker (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x4808ff28 sp=0x4808ff08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x4808ffc8 sp=0x4808ff28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x4808ffe0 sp=0x4808ffc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4808ffe8 sp=0x4808ffe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 19 gp=0x48582380 m=nil [GC worker (idle)]: runtime.gopark(0x48090f68?, 0x17d68137a508c587?, 0xf?, 0xdd?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48090f28 sp=0x48090f08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x48090fc8 sp=0x48090f28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x48090fe0 sp=0x48090fc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48090fe8 sp=0x48090fe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 20 gp=0x48582540 m=nil [GC worker (idle)]: runtime.gopark(0x4291c0?, 0x3?, 0xe2?, 0x4e?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48091f28 sp=0x48091f08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x48091fc8 sp=0x48091f28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x48091fe0 sp=0x48091fc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48091fe8 sp=0x48091fe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 21 gp=0x48582700 m=nil [GC worker (idle)]: runtime.gopark(0x4858ef68?, 0x17d68137a209eaec?, 0x13?, 0x19?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x4858ef28 sp=0x4858ef08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x4858efc8 sp=0x4858ef28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x4858efe0 sp=0x4858efc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4858efe8 sp=0x4858efe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 22 gp=0x485828c0 m=nil [GC worker (idle)]: runtime.gopark(0x4291c0?, 0x3?, 0x74?, 0x6?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x4858ff28 sp=0x4858ff08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x4858ffc8 sp=0x4858ff28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x4858ffe0 sp=0x4858ffc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4858ffe8 sp=0x4858ffe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 23 gp=0x48582a80 m=nil [GC worker (idle)]: runtime.gopark(0x48590f68?, 0x17d68137a209690a?, 0x53?, 0xc6?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48590f28 sp=0x48590f08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x48590fc8 sp=0x48590f28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x48590fe0 sp=0x48590fc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48590fe8 sp=0x48590fe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 24 gp=0x48582c40 m=nil [GC worker (idle)]: runtime.gopark(0x4291c0?, 0x3?, 0x42?, 0x22?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48591f28 sp=0x48591f08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x48591fc8 sp=0x48591f28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x48591fe0 sp=0x48591fc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48591fe8 sp=0x48591fe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 26 gp=0x48582fc0 m=nil [GC worker (idle)]: runtime.gopark(0x4858bf68?, 0x17d68137acc132e0?, 0x56?, 0x58?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x4858bf28 sp=0x4858bf08 pc=0x264a0e runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1363 +0xec fp=0x4858bfc8 sp=0x4858bf28 pc=0x217a2c runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x4858bfe0 sp=0x4858bfc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4858bfe8 sp=0x4858bfe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 27 gp=0x48583180 m=13 mp=0x48480e08 [GC mark termination]: runtime.systemstack_switch() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:479 +0x8 fp=0x4858ce80 sp=0x4858ce70 pc=0x269828 runtime.forEachP(...) /tmp/workdir-gnot/go/src/runtime/proc.go:2000 runtime.gcMarkDone() /tmp/workdir-gnot/go/src/runtime/mgc.go:847 +0x15b fp=0x4858cf28 sp=0x4858ce80 pc=0x21627b runtime.gcBgMarkWorker(0x48584000) /tmp/workdir-gnot/go/src/runtime/mgc.go:1499 +0x385 fp=0x4858cfc8 sp=0x4858cf28 pc=0x217cc5 runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x4858cfe0 sp=0x4858cfc8 pc=0x217905 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x4858cfe8 sp=0x4858cfe0 pc=0x26b701 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 exit status: 'stress 19276: 2' trace_test.go:579: exit status: 'go 19255: 1' --- FAIL: TestTraceStressStartStop (1.07s) --- FAIL: TestTraceStressStartStop/Default (1.07s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: fault read code=0x0 addr=0x0 pc=0x259ff6] runtime stack: runtime.throw({0x307da9?, 0x40bb80?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe908 sp=0x7fffffffe8d8 pc=0x2648e9 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe988 sp=0x7fffffffe908 pc=0x22f205 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40bcc0?, 0x1?, 0xa?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffedf8 sp=0x7fffffffe988 pc=0x259ff6 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.GoPark({0x40bcc0?, 0x48007880?}, 0xe, 0x1) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:486 +0x8e fp=0x7fffffffee80 sp=0x7fffffffedf8 pc=0x2593ee runtime.park_m(0x480061c0) /tmp/workdir-gnot/go/src/runtime/proc.go:4077 +0x68 fp=0x7fffffffeed8 sp=0x7fffffffee80 pc=0x23c9e8 runtime.mcall() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:459 +0x53 fp=0x7fffffffeef0 sp=0x7fffffffeed8 pc=0x269813 goroutine 1 gp=0x480061c0 m=0 mp=0x40bcc0 [running]: runtime.gopark(0x48056eb0?, 0x17d68137ef812d28?, 0x0?, 0x0?, 0x2ccac0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056e90 sp=0x48056e70 pc=0x264a0e time.Sleep(0xf4240) /tmp/workdir-gnot/go/src/runtime/time.go:285 +0x110 fp=0x48056ed0 sp=0x48056e90 pc=0x267550 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress-start-stop.go:162 +0xa6 fp=0x48056f48 sp=0x48056ed0 pc=0x2ccce6 runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x48056fe0 sp=0x48056f48 pc=0x23557d runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x26b701 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x2358a7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x26b701 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x221174 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x2155a5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x26b701 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [GC scavenge wait]: runtime.gopark(0x48018280?, 0x32bc08?, 0x1?, 0x0?, 0x48006a80?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x264a0e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x40af20) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21eb29 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x48059fc8 sp=0x48059fa8 pc=0x21f0fc runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x215545 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x26b701 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x264a0e runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x2145e7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x26b701 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [chan receive]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053f18 sp=0x48053ef8 pc=0x264a0e runtime.chanrecv(0x480820e0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48053f90 sp=0x48053f18 pc=0x204fdc runtime.chanrecv1(0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48053fb8 sp=0x48053f90 pc=0x204bb2 runtime.unique_runtime_registerUniqueMapCleanup.func1(...) /tmp/workdir-gnot/go/src/runtime/mgc.go:1732 runtime.unique_runtime_registerUniqueMapCleanup.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1735 +0x2f fp=0x48053fe0 sp=0x48053fb8 pc=0x21878f runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x26b701 created by unique.runtime_registerUniqueMapCleanup in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1730 +0x96 goroutine 7 gp=0x48007340 m=nil [sleep]: runtime.gopark(0x48054eb8?, 0x17d68137ef7fda41?, 0x60?, 0xe8?, 0x483e0000?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054e98 sp=0x48054e78 pc=0x264a0e time.Sleep(0xf4240) /tmp/workdir-gnot/go/src/runtime/time.go:285 +0x110 fp=0x48054ed8 sp=0x48054e98 pc=0x267550 main.main.func1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress-start-stop.go:58 +0x1d6 fp=0x48054fe0 sp=0x48054ed8 pc=0x2ccf96 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x26b701 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress-start-stop.go:28 +0x98 goroutine 17 gp=0x48104380 m=nil [chan receive]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48124f18 sp=0x48124ef8 pc=0x264a0e runtime.chanrecv(0x4811c000, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48124f90 sp=0x48124f18 pc=0x204fdc runtime.chanrecv1(0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48124fb8 sp=0x48124f90 pc=0x204bb2 main.main.func1.2() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress-start-stop.go:38 +0x25 fp=0x48124fe0 sp=0x48124fb8 pc=0x2cd925 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48124fe8 sp=0x48124fe0 pc=0x26b701 created by main.main.func1 in goroutine 7 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress-start-stop.go:37 +0x108 goroutine 8 gp=0x48007500 m=nil [runnable]: runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 fp=0x48055fe0 sp=0x48055fd8 pc=0x256ea0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x26b701 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 33 gp=0x483c6380 m=3 mp=0x48100008 [syscall]: syscall.Syscall6(0x32, 0x3, 0x48120fbf, 0x1, 0xffffffffffffffff, 0xffffffffffffffff, 0x0) /tmp/workdir-gnot/go/src/syscall/asm_plan9_amd64.s:63 +0x10 fp=0x48120e70 sp=0x48120db8 pc=0x285e30 syscall.Pread(0x483de000?, {0x48120fbf?, 0x0?, 0x0?}, 0x0?) /tmp/workdir-gnot/go/src/syscall/zsyscall_plan9_amd64.go:218 +0x5e fp=0x48120ee8 sp=0x48120e70 pc=0x285a5e syscall.Read(...) /tmp/workdir-gnot/go/src/syscall/syscall_plan9.go:170 os.(*File).read(0x483dc000, {0x48120fbf, 0x1, 0x1}) /tmp/workdir-gnot/go/src/os/file_plan9.go:295 +0xd9 fp=0x48120f58 sp=0x48120ee8 pc=0x293919 os.(*File).Read(0x483dc000, {0x48120fbf, 0x1, 0x1}) /tmp/workdir-gnot/go/src/os/file.go:124 +0x65 fp=0x48120f98 sp=0x48120f58 pc=0x292705 main.main.func1.4() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress-start-stop.go:54 +0x3b fp=0x48120fe0 sp=0x48120f98 pc=0x2cd85b runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48120fe8 sp=0x48120fe0 pc=0x26b701 created by main.main.func1 in goroutine 7 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/stress-start-stop.go:52 +0x1cc goroutine 9 gp=0x480076c0 m=nil [runnable]: runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:956 fp=0x480a0fe0 sp=0x480a0fd8 pc=0x2514a0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x480a0fe8 sp=0x480a0fe0 pc=0x26b701 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 10 gp=0x48007880 m=nil [runnable]: runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 fp=0x480a1fe0 sp=0x480a1fd8 pc=0x2cca60 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x480a1fe8 sp=0x480a1fe0 pc=0x26b701 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf exit status: 'stress-start-stop 19314: 2' trace_test.go:579: exit status: 'go 19294: 1' --- FAIL: TestTraceManyStartStop (0.96s) --- FAIL: TestTraceManyStartStop/Default (0.96s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: code=0x0 addr=0x0 pc=0x257236] runtime stack: runtime.throw({0x2b5f14?, 0x1?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe878 sp=0x7fffffffe848 pc=0x261349 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe8f8 sp=0x7fffffffe878 pc=0x22e545 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40a880?, 0x1?, 0x2b1eab?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffed68 sp=0x7fffffffe8f8 pc=0x257236 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.STWStart({0x40aca0?, 0x20a7b5?}, 0x1) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:362 +0xa6 fp=0x7fffffffede8 sp=0x7fffffffed68 pc=0x255cc6 runtime.stopTheWorldWithSema(0x1) /tmp/workdir-gnot/go/src/runtime/proc.go:1540 +0x59 fp=0x7fffffffeec0 sp=0x7fffffffede8 pc=0x236ff9 runtime.gcMarkDone.func2() /tmp/workdir-gnot/go/src/runtime/mgc.go:884 +0x25 fp=0x7fffffffeee0 sp=0x7fffffffeec0 pc=0x215d25 runtime.systemstack(0x40a040) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:514 +0x4d fp=0x7fffffffeef0 sp=0x7fffffffeee0 pc=0x265f6d goroutine 9 gp=0x480076c0 m=0 mp=0x40aca0 [running]: runtime.systemstack_switch() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:479 +0x8 fp=0x48090e80 sp=0x48090e70 pc=0x265f08 runtime.gcMarkDone() /tmp/workdir-gnot/go/src/runtime/mgc.go:883 +0x247 fp=0x48090f28 sp=0x48090e80 pc=0x215a27 runtime.gcBgMarkWorker(0x480822a0) /tmp/workdir-gnot/go/src/runtime/mgc.go:1499 +0x385 fp=0x48090fc8 sp=0x48090f28 pc=0x217385 runtime.gcBgMarkStartWorkers.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x25 fp=0x48090fe0 sp=0x48090fc8 pc=0x216fc5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48090fe8 sp=0x48090fe0 pc=0x267de1 created by runtime.gcBgMarkStartWorkers in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:1279 +0x105 goroutine 1 gp=0x480061c0 m=nil [wait for GC cycle]: runtime.gopark(0x48056e48?, 0x48056e18?, 0x80?, 0x57?, 0x48056e18?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056e90 sp=0x48056e70 pc=0x26146e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.gcWaitOnMark(0x1) /tmp/workdir-gnot/go/src/runtime/mgc.go:538 +0x55 fp=0x48056ec0 sp=0x48056e90 pc=0x214f15 runtime.GC() /tmp/workdir-gnot/go/src/runtime/mgc.go:482 +0x47 fp=0x48056ef8 sp=0x48056ec0 pc=0x214dc7 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/many-start-stop.go:28 +0x1b fp=0x48056f48 sp=0x48056ef8 pc=0x290a1b runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x48056fe0 sp=0x48056f48 pc=0x23447d runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x267de1 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x26146e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x2347a7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x267de1 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x26146e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x2207d4 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x214c65 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x267de1 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [GC scavenge wait]: runtime.gopark(0x10000?, 0x2d33b8?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x26146e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x409f00) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21e189 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:658 +0x59 fp=0x48059fc8 sp=0x48059fa8 pc=0x21e779 runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x214c05 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x267de1 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x26146e runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x213ca7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x267de1 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [chan receive]: runtime.gopark(0x48007180?, 0x17d681382e9cdf0d?, 0x8?, 0x3f?, 0x24c133?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053ea8 sp=0x48053e88 pc=0x26146e runtime.chanrecv(0x480820e0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48053f20 sp=0x48053ea8 pc=0x204c7c runtime.chanrecv1(0x48080050?, 0x17d681382e9cdf0d?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48053f48 sp=0x48053f20 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a030, 0x5f5e100) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48053fa8 sp=0x48053f48 pc=0x24e871 runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:54 +0x45 fp=0x48053fe0 sp=0x48053fa8 pc=0x254125 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x267de1 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 7 gp=0x48007340 m=nil [chan receive]: runtime.gopark(0x48007340?, 0x17d68138644202f5?, 0x10?, 0x4f?, 0x24c0f4?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054eb0 sp=0x48054e90 pc=0x26146e runtime.chanrecv(0x48082230, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48054f28 sp=0x48054eb0 pc=0x204c7c runtime.chanrecv1(0x480800a0?, 0x17d68138644202f5?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48054f50 sp=0x48054f28 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a048, 0x3b9aca00) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48054fb0 sp=0x48054f50 pc=0x24e871 runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:959 +0x28 fp=0x48054fe0 sp=0x48054fb0 pc=0x24e708 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x267de1 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 8 gp=0x48007500 m=nil [trace reader (blocked)]: runtime.gopark(0x48055f78?, 0x26931b?, 0xc0?, 0x41?, 0x4801c320?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48055f38 sp=0x48055f18 pc=0x26146e runtime.ReadTrace() /tmp/workdir-gnot/go/src/runtime/trace.go:757 +0x31 fp=0x48055fa0 sp=0x48055f38 pc=0x24e131 runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:130 +0x45 fp=0x48055fe0 sp=0x48055fa0 pc=0x290865 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x267de1 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf exit status: 'many-start-stop 19339: 2' trace_test.go:579: exit status: 'go 19319: 1' --- FAIL: TestTraceIterPull (0.97s) --- FAIL: TestTraceIterPull/Default (0.97s) trace_test.go:577: stderr: fatal error: unexpected signal during runtime execution [signal sys: trap: code=0x0 addr=0x0 pc=0x257676] runtime stack: runtime.throw({0x2b77f3?, 0x40ab40?}) /tmp/workdir-gnot/go/src/runtime/panic.go:1067 +0x49 fp=0x7fffffffe908 sp=0x7fffffffe8d8 pc=0x261909 runtime.sigpanic() /tmp/workdir-gnot/go/src/runtime/os_plan9.go:76 +0x485 fp=0x7fffffffe988 sp=0x7fffffffe908 pc=0x22e8c5 runtime.fpTracebackPCs(...) /tmp/workdir-gnot/go/src/runtime/tracestack.go:258 runtime.traceStack(0x40ac80?, 0x48007378?, 0x200000001?) /tmp/workdir-gnot/go/src/runtime/tracestack.go:116 +0x296 fp=0x7fffffffedf8 sp=0x7fffffffe988 pc=0x257676 runtime.traceLocker.stack(...) /tmp/workdir-gnot/go/src/runtime/traceevent.go:176 runtime.traceLocker.GoPark({0x40ac80?, 0x400000002?}, 0x7, 0x2) /tmp/workdir-gnot/go/src/runtime/traceruntime.go:486 +0x8e fp=0x7fffffffee80 sp=0x7fffffffedf8 pc=0x25696e runtime.park_m(0x48007340) /tmp/workdir-gnot/go/src/runtime/proc.go:4077 +0x68 fp=0x7fffffffeed8 sp=0x7fffffffee80 pc=0x23bc68 runtime.mcall() /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:459 +0x53 fp=0x7fffffffeef0 sp=0x7fffffffeed8 pc=0x2664f3 goroutine 7 gp=0x48007340 m=0 mp=0x40ac80 [running]: runtime.gopark(0x48007340?, 0x17d681389dc57ebc?, 0x10?, 0x4f?, 0x24c434?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48054eb0 sp=0x48054e90 pc=0x261a2e runtime.chanrecv(0x48082230, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48054f28 sp=0x48054eb0 pc=0x204c9c runtime.chanrecv1(0x480800a0?, 0x17d681389dc57ebc?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48054f50 sp=0x48054f28 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a048, 0x3b9aca00) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48054fb0 sp=0x48054f50 pc=0x24ebb1 runtime.(*traceAdvancerState).start.func1() /tmp/workdir-gnot/go/src/runtime/trace.go:959 +0x28 fp=0x48054fe0 sp=0x48054fb0 pc=0x24ea48 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48054fe8 sp=0x48054fe0 pc=0x2683e1 created by runtime.(*traceAdvancerState).start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace.go:956 +0x15a goroutine 1 gp=0x480061c0 m=nil [semacquire]: runtime.gopark(0x0?, 0x0?, 0x0?, 0xe0?, 0x439058?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48056e10 sp=0x48056df0 pc=0x261a2e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.semacquire1(0x4801c348, 0x0, 0x1, 0x0, 0x12) /tmp/workdir-gnot/go/src/runtime/sema.go:178 +0x235 fp=0x48056e78 sp=0x48056e10 pc=0x244b15 sync.runtime_Semacquire(0x48022080?) /tmp/workdir-gnot/go/src/runtime/sema.go:71 +0x25 fp=0x48056eb0 sp=0x48056e78 pc=0x2627e5 sync.(*WaitGroup).Wait(0x64?) /tmp/workdir-gnot/go/src/sync/waitgroup.go:116 +0x48 fp=0x48056ed8 sp=0x48056eb0 pc=0x272fc8 main.main() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/iter-pull.go:67 +0x1da fp=0x48056f48 sp=0x48056ed8 pc=0x290e1a runtime.main() /tmp/workdir-gnot/go/src/runtime/proc.go:272 +0x2bd fp=0x48056fe0 sp=0x48056f48 pc=0x2347fd runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48056fe8 sp=0x48056fe0 pc=0x2683e1 goroutine 2 gp=0x48006700 m=nil [force gc (idle)]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48057fa0 sp=0x48057f80 pc=0x261a2e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.forcegchelper() /tmp/workdir-gnot/go/src/runtime/proc.go:337 +0xa7 fp=0x48057fe0 sp=0x48057fa0 pc=0x234b27 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48057fe8 sp=0x48057fe0 pc=0x2683e1 created by runtime.init.7 in goroutine 1 /tmp/workdir-gnot/go/src/runtime/proc.go:325 +0x1a goroutine 3 gp=0x480068c0 m=nil [GC sweep wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48058f80 sp=0x48058f60 pc=0x261a2e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.bgsweep(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcsweep.go:277 +0x94 fp=0x48058fc8 sp=0x48058f80 pc=0x220c14 runtime.gcenable.gowrap1() /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x25 fp=0x48058fe0 sp=0x48058fc8 pc=0x2152a5 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48058fe8 sp=0x48058fe0 pc=0x2683e1 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:203 +0x66 goroutine 4 gp=0x48006a80 m=nil [GC scavenge wait]: runtime.gopark(0x48018280?, 0x2d4e50?, 0x1?, 0x0?, 0x48006a80?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48059f78 sp=0x48059f58 pc=0x261a2e runtime.goparkunlock(...) /tmp/workdir-gnot/go/src/runtime/proc.go:430 runtime.(*scavengerState).park(0x409ee0) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0x48059fa8 sp=0x48059f78 pc=0x21e5c9 runtime.bgscavenge(0x48018280) /tmp/workdir-gnot/go/src/runtime/mgcscavenge.go:653 +0x3c fp=0x48059fc8 sp=0x48059fa8 pc=0x21eb9c runtime.gcenable.gowrap2() /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0x25 fp=0x48059fe0 sp=0x48059fc8 pc=0x215245 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48059fe8 sp=0x48059fe0 pc=0x2683e1 created by runtime.gcenable in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 gp=0x48006fc0 m=nil [finalizer wait]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48052e20 sp=0x48052e00 pc=0x261a2e runtime.runfinq() /tmp/workdir-gnot/go/src/runtime/mfinal.go:193 +0x107 fp=0x48052fe0 sp=0x48052e20 pc=0x2142e7 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48052fe8 sp=0x48052fe0 pc=0x2683e1 created by runtime.createfing in goroutine 1 /tmp/workdir-gnot/go/src/runtime/mfinal.go:163 +0x3d goroutine 6 gp=0x48007180 m=nil [chan receive]: runtime.gopark(0x48007180?, 0x17d6813868205b0d?, 0x8?, 0x3f?, 0x24c473?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48053ea8 sp=0x48053e88 pc=0x261a2e runtime.chanrecv(0x480820e0, 0x0, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48053f20 sp=0x48053ea8 pc=0x204c9c runtime.chanrecv1(0x48080050?, 0x17d6813868205b0d?) /tmp/workdir-gnot/go/src/runtime/chan.go:489 +0x12 fp=0x48053f48 sp=0x48053f20 pc=0x204852 runtime.(*wakeableSleep).sleep(0x4801a030, 0x5f5e100) /tmp/workdir-gnot/go/src/runtime/trace.go:1022 +0xb1 fp=0x48053fa8 sp=0x48053f48 pc=0x24ebb1 runtime.traceStartReadCPU.func1() /tmp/workdir-gnot/go/src/runtime/tracecpu.go:54 +0x45 fp=0x48053fe0 sp=0x48053fa8 pc=0x254465 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48053fe8 sp=0x48053fe0 pc=0x2683e1 created by runtime.traceStartReadCPU in goroutine 1 /tmp/workdir-gnot/go/src/runtime/tracecpu.go:42 +0x146 goroutine 8 gp=0x48007500 m=nil [runnable]: runtime/trace.Start.func1() /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 fp=0x48055fe0 sp=0x48055fd8 pc=0x290a60 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48055fe8 sp=0x48055fe0 pc=0x2683e1 created by runtime/trace.Start in goroutine 1 /tmp/workdir-gnot/go/src/runtime/trace/trace.go:128 +0xdf goroutine 10 gp=0x480076c0 m=nil [runnable]: main.main.func1() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/iter-pull.go:40 fp=0x48090fe0 sp=0x48090fd8 pc=0x290fc0 runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48090fe8 sp=0x48090fe0 pc=0x2683e1 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/iter-pull.go:40 +0x155 goroutine 11 gp=0x48007880 m=nil [chan receive]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/proc.go:424 +0xce fp=0x48091ec0 sp=0x48091ea0 pc=0x261a2e runtime.chanrecv(0x48082310, 0x48091fa8, 0x1) /tmp/workdir-gnot/go/src/runtime/chan.go:639 +0x41c fp=0x48091f38 sp=0x48091ec0 pc=0x204c9c runtime.chanrecv2(0x0?, 0x0?) /tmp/workdir-gnot/go/src/runtime/chan.go:494 +0x12 fp=0x48091f60 sp=0x48091f38 pc=0x204872 main.main.func2() /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/iter-pull.go:58 +0x9a fp=0x48091fe0 sp=0x48091f60 pc=0x290eda runtime.goexit({}) /tmp/workdir-gnot/go/src/runtime/asm_amd64.s:1700 +0x1 fp=0x48091fe8 sp=0x48091fe0 pc=0x2683e1 created by main.main in goroutine 1 /tmp/workdir-gnot/go/src/internal/trace/testdata/testprog/iter-pull.go:55 +0x1d0 exit status: 'iter-pull 19363: 2' trace_test.go:579: exit status: 'go 19342: 1' FAIL FAIL internal/trace 32.094s FAIL go tool dist: Failed: exit status: 'go 18590: 1'