linux-s390x-ibm at 49d6777d87a0abb3eda032da95eff024156835f7 :: Running /data/golang/workdir/go/src/make.bash with args ["/data/golang/workdir/go/src/make.bash" "-force"] and env ["LANG=en_US.UTF-8" "HOME=/root" "LOGNAME=root" "USER=root" "SHELL=/bin/sh" "INVOCATION_ID=82b41292fc8a4f3c96daed445f9dd888" "JOURNAL_STREAM=9:508894" "META_BUILDLET_BINARY_URL=https://storage.googleapis.com/go-builder-data/buildlet.linux-s390x" "GO_STAGE0_NET_DELAY=200ms" "GO_STAGE0_DL_DELAY=400ms" "WORKDIR=/data/golang/workdir" "GO_BUILDER_NAME=linux-s390x-ibm" "GO_BUILDER_FLAKY_NET=1" "GO_TEST_TIMEOUT_SCALE=5" "GOBIN=" "GOROOT_BOOTSTRAP=" "TMPDIR=/data/golang/workdir/tmp" "GOCACHE=/data/golang/workdir/gocache" "GOPLSCACHE=/data/golang/workdir/goplscache" "PATH=/data/golang/workdir/go1.4/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin" "PWD=/data/golang/workdir/go/src"] in dir /data/golang/workdir/go/src WARNING: /root/go1.4/bin/go does not exist, found /data/golang/workdir/go1.4/go/bin/go from env WARNING: set /data/golang/workdir/go1.4/go as GOROOT_BOOTSTRAP Building Go cmd/dist using /data/golang/workdir/go1.4/go. (go1.22.6 linux/s390x) Building Go toolchain1 using /data/golang/workdir/go1.4/go. Building Go bootstrap cmd/go (go_bootstrap) using Go toolchain1. Building Go toolchain2 using go_bootstrap and Go toolchain1. Building Go toolchain3 using go_bootstrap and Go toolchain2. Building packages and commands for linux/s390x. --- Installed Go for linux/s390x in /data/golang/workdir/go Installed commands in /data/golang/workdir/go/bin *** You need to add /data/golang/workdir/go/bin to your PATH. ##### Test execution environment. # GOARCH: s390x # CPU: # GOOS: linux # OS Version: Linux 4.18.0-372.19.1.el8_6.s390x #1 SMP Mon Jul 18 11:11:32 EDT 2022 s390x ##### Testing packages. ok archive/tar 1.166s ok archive/zip 2.067s ok bufio 1.508s ok bytes 0.867s ok cmp 0.058s ok compress/bzip2 0.126s ok compress/flate 4.315s ok compress/gzip 2.856s ok compress/lzw 0.320s ok compress/zlib 3.278s ok container/heap 0.214s ok container/list 0.070s ok container/ring 0.046s ok context 2.116s ok crypto 7.116s ok crypto/aes 0.053s ok crypto/cipher 15.559s ok crypto/des 0.211s ok crypto/dsa 0.059s ok crypto/ecdh 0.058s ok crypto/ecdsa 0.058s ok crypto/ed25519 0.073s ok crypto/elliptic 0.095s ? crypto/fips140 [no test files] ok crypto/hkdf 0.026s ok crypto/hmac 0.016s ok crypto/internal/boring 0.001s ? crypto/internal/boring/bbig [no test files] ok crypto/internal/boring/bcache 1.425s ? crypto/internal/boring/sig [no test files] ? crypto/internal/cryptotest [no test files] ? crypto/internal/entropy [no test files] ? crypto/internal/fips140 [no test files] ok crypto/internal/fips140/aes 0.046s ok crypto/internal/fips140/aes/gcm 0.014s [no tests to run] ? crypto/internal/fips140/alias [no test files] ok crypto/internal/fips140/bigmod 1.715s ? crypto/internal/fips140/check [no test files] ? crypto/internal/fips140/check/checktest [no test files] ok crypto/internal/fips140/drbg 0.256s [no tests to run] ok crypto/internal/fips140/ecdh 0.232s ok crypto/internal/fips140/ecdsa 0.302s ? crypto/internal/fips140/ed25519 [no test files] ok crypto/internal/fips140/edwards25519 0.330s ok crypto/internal/fips140/edwards25519/field 0.050s ? crypto/internal/fips140/hkdf [no test files] ? crypto/internal/fips140/hmac [no test files] ok crypto/internal/fips140/mlkem 3.030s ok crypto/internal/fips140/nistec 0.077s ok crypto/internal/fips140/nistec/fiat 0.062s [no tests to run] ? crypto/internal/fips140/pbkdf2 [no test files] ok crypto/internal/fips140/rsa 0.551s ? crypto/internal/fips140/sha256 [no test files] ? crypto/internal/fips140/sha3 [no test files] ? crypto/internal/fips140/sha512 [no test files] ? crypto/internal/fips140/ssh [no test files] ok crypto/internal/fips140/subtle 0.018s ? crypto/internal/fips140/tls12 [no test files] ? crypto/internal/fips140/tls13 [no test files] ok crypto/internal/fips140deps 0.492s ? crypto/internal/fips140deps/byteorder [no test files] ? crypto/internal/fips140deps/cpu [no test files] ? crypto/internal/fips140deps/godebug [no test files] ? crypto/internal/fips140hash [no test files] ? crypto/internal/fips140only [no test files] ok crypto/internal/fips140test 3.561s ok crypto/internal/hpke 0.423s ? crypto/internal/impl [no test files] ? crypto/internal/randutil [no test files] ok crypto/internal/sysrand 0.377s ? crypto/internal/sysrand/internal/seccomp [no test files] ok crypto/md5 0.138s ok crypto/mlkem 0.547s ok crypto/pbkdf2 0.206s ok crypto/rand 0.726s ok crypto/rc4 0.369s ok crypto/rsa 0.881s ok crypto/sha1 0.034s ok crypto/sha256 0.016s ok crypto/sha3 13.701s ok crypto/sha512 0.310s ok crypto/subtle 0.728s ok crypto/tls 29.357s ? crypto/tls/internal/fips140tls [no test files] ok crypto/x509 3.372s ? crypto/x509/pkix [no test files] ok database/sql 1.780s ok database/sql/driver 0.032s ok debug/buildinfo 0.482s ok debug/dwarf 0.053s ok debug/elf 0.884s ok debug/gosym 3.817s ok debug/macho 1.064s ok debug/pe 0.327s ok debug/plan9obj 0.324s ok embed 0.058s [no tests to run] ok embed/internal/embedtest 0.081s ? encoding [no test files] ok encoding/ascii85 0.028s ok encoding/asn1 0.038s ok encoding/base32 0.077s ok encoding/base64 0.118s ok encoding/binary 0.355s ok encoding/csv 0.138s ok encoding/gob 6.340s ok encoding/hex 0.370s ok encoding/json 1.223s ok encoding/pem 0.931s ok encoding/xml 0.350s ok errors 0.655s ok expvar 0.135s ok flag 0.799s ok fmt 0.241s ok go/ast 0.010s ok go/build 32.540s ok go/build/constraint 0.339s ok go/constant 0.107s ok go/doc 0.087s ok go/doc/comment 9.781s ok go/format 0.030s ok go/importer 3.370s ok go/internal/gccgoimporter 0.010s ok go/internal/gcimporter 43.293s ok go/internal/srcimporter 99.893s ok go/parser 1.597s ok go/printer 1.683s ok go/scanner 0.523s ok go/token 0.063s ok go/types 101.639s ok go/version 0.242s ok hash 0.345s ok hash/adler32 0.070s ok hash/crc32 0.064s ok hash/crc64 0.560s ok hash/fnv 0.580s ok hash/maphash 1.330s ok html 0.332s ok html/template 2.074s ok image 0.278s ok image/color 0.158s ? image/color/palette [no test files] ok image/draw 1.610s ok image/gif 2.939s ? image/internal/imageutil [no test files] ok image/jpeg 3.166s ok image/png 1.504s ok index/suffixarray 1.371s ok internal/abi 1.187s ? internal/asan [no test files] ? internal/bisect [no test files] ok internal/buildcfg 0.030s ? internal/bytealg [no test files] ? internal/byteorder [no test files] ? internal/cfg [no test files] ok internal/chacha8rand 1.551s ok internal/copyright 1.278s ? internal/coverage [no test files] ? internal/coverage/calloc [no test files] ok internal/coverage/cfile 7.151s ok internal/coverage/cformat 0.091s ok internal/coverage/cmerge 0.032s ? internal/coverage/decodecounter [no test files] ? internal/coverage/decodemeta [no test files] ? internal/coverage/encodecounter [no test files] ? internal/coverage/encodemeta [no test files] ok internal/coverage/pods 0.091s ? internal/coverage/rtcov [no test files] ok internal/coverage/slicereader 0.292s ok internal/coverage/slicewriter 0.028s ? internal/coverage/stringtab [no test files] ok internal/coverage/test 0.344s ? internal/coverage/uleb128 [no test files] ok internal/cpu 0.120s ok internal/dag 0.010s ok internal/diff 0.001s ? internal/exportdata [no test files] ? internal/filepathlite [no test files] ok internal/fmtsort 0.279s ok internal/fuzz 0.275s ? internal/goarch [no test files] ok internal/godebug 12.134s ok internal/godebugs 40.769s ? internal/goexperiment [no test files] ? internal/goos [no test files] ? internal/goroot [no test files] ok internal/gover 0.144s ? internal/goversion [no test files] ok internal/itoa 0.006s ? internal/lazyregexp [no test files] ? internal/lazytemplate [no test files] ? internal/msan [no test files] ? internal/nettrace [no test files] ? internal/obscuretestdata [no test files] ? internal/oserror [no test files] ok internal/pkgbits 0.373s ok internal/platform 21.008s ok internal/poll 5.289s ok internal/profile 0.364s ? internal/profilerecord [no test files] ? internal/race [no test files] ok internal/reflectlite 0.162s ok internal/runtime/atomic 0.143s ? internal/runtime/exithook [no test files] ? internal/runtime/gc [no test files] ok internal/runtime/maps 4.549s ok internal/runtime/math 0.006s ok internal/runtime/sys 0.043s ok internal/runtime/syscall 0.886s ok internal/runtime/wasitest 0.089s ok internal/saferio 0.181s ok internal/singleflight 0.890s ? internal/stringslite [no test files] ok internal/sync 4.957s ok internal/synctest 6.989s ? internal/syscall/execenv [no test files] ok internal/syscall/unix 0.452s ok internal/sysinfo 0.578s ? internal/syslist [no test files] ok internal/testenv 4.267s ? internal/testhash [no test files] ? internal/testlog [no test files] ? internal/testpty [no test files] --- FAIL: TestTraceStressStartStop (4.51s) --- FAIL: TestTraceStressStartStop/Default (4.51s) reader_test.go:112: unexpected error while reading the trace: broken trace: failed to advance: frontier: [gen=5] M 544459 [ProcStart time=4959928557120 p=1 p_seq=1377] M 544453 [ProcStart time=4959930997184 p=1 p_seq=1378] G 6 [status=Waiting seq=4 (gen=5)] G 22 [status=Waiting seq=1 (gen=5)] G 39 [status=Waiting seq=0 (gen=5)] G 2 [status=Waiting seq=0 (gen=5)] G 34 [status=Runnable seq=0 (gen=5)] G 35 [status=Waiting seq=0 (gen=5)] G 36 [status=Waiting seq=0 (gen=5)] G 37 [status=Waiting seq=0 (gen=5)] G 4 [status=Waiting seq=0 (gen=5)] G 23 [status=Waiting seq=1 (gen=5)] G 24 [status=Waiting seq=1 (gen=5)] G 20 [status=Waiting seq=1 (gen=5)] G 11 [status=Waiting seq=2 (gen=5)] G 5 [status=Waiting seq=0 (gen=5)] G 38 [status=Waiting seq=0 (gen=5)] G 40 [status=Waiting seq=0 (gen=5)] G 41 [status=Waiting seq=0 (gen=5)] G 42 [status=Waiting seq=0 (gen=5)] G 3 [status=Waiting seq=0 (gen=5)] G 1 [status=Waiting seq=0 (gen=5)] P 2 [status=Idle seq=2 (gen=5)] P 0 [status=Idle seq=17 (gen=5)] M 544459 [g=-1 p=-1] M 544453 [g=-1 p=-1] GC 0 Undetermined trace_test.go:632: found bad trace; dumping to test log... trace_test.go:643: Trace Go1.23 EventBatch gen=5 m=18446744073709551615 time=77498921959 size=5 Frequency freq=15625000 EventBatch gen=5 m=544459 time=77498879933 size=144 ProcStatus dt=81 p=2 pstatus=1 GoStatus dt=3 g=1 m=544459 gstatus=2 ProcsChange dt=115 procs_value=8 stack=1 STWBegin dt=42 kind_string=23 stack=2 HeapGoal dt=3 heapgoal_value=974302555 ProcStatus dt=2 p=0 pstatus=2 GoStatus dt=37 g=6 m=18446744073709551615 gstatus=4 GoUnblock dt=39 g=6 g_seq=1 stack=3 ProcsChange dt=33 procs_value=8 stack=4 STWEnd dt=14 HeapAlloc dt=37 heapalloc_value=489883152 GoCreate dt=85 new_g=22 new_stack=5 stack=6 GoCreate dt=46 new_g=23 new_stack=7 stack=8 GoCreate dt=20 new_g=24 new_stack=9 stack=10 GoBlock dt=24 reason_string=19 stack=11 GoStatus dt=20 g=21 m=18446744073709551615 gstatus=4 GoUnblock dt=2 g=21 g_seq=1 stack=0 GoStart dt=8 g=21 g_seq=2 GoSyscallBegin dt=88 p_seq=1 stack=12 GoSyscallEnd dt=366 GoSyscallBegin dt=84 p_seq=2 stack=13 GoSyscallEnd dt=111 GoDestroy dt=6 GoStatus dt=10 g=20 m=544459 gstatus=1 GoStart dt=1 g=20 g_seq=1 GoBlock dt=20 reason_string=15 stack=14 ProcStop dt=6 ProcStart dt=2469 p=1 p_seq=1377 ProcStop dt=12 EventBatch gen=5 m=544453 time=77498881301 size=574 ProcStart dt=48 p=0 p_seq=1 GoStart dt=26 g=22 g_seq=1 GoBlock dt=41 reason_string=12 stack=15 GoStart dt=3 g=6 g_seq=2 GoSyscallBegin dt=86 p_seq=2 stack=16 GoSyscallEnd dt=30 HeapAlloc dt=17 heapalloc_value=489891120 HeapAlloc dt=37 heapalloc_value=489899312 GoSyscallBegin dt=79 p_seq=3 stack=17 GoSyscallEnd dt=9 HeapAlloc dt=7 heapalloc_value=489907432 GoSyscallBegin dt=74 p_seq=4 stack=18 GoSyscallEnd dt=8 GoSyscallBegin dt=48 p_seq=5 stack=19 GoSyscallEnd dt=7 GoSyscallBegin dt=50 p_seq=6 stack=20 GoSyscallEnd dt=4 GoSyscallBegin dt=51 p_seq=7 stack=21 GoSyscallEnd dt=4 GoSyscallBegin dt=45 p_seq=8 stack=22 GoSyscallEnd dt=45 GoSyscallBegin dt=43 p_seq=9 stack=23 GoSyscallEnd dt=168 HeapAlloc dt=12 heapalloc_value=489908904 GoCreate dt=24 new_g=11 new_stack=24 stack=25 GoSyscallBegin dt=39 p_seq=10 stack=26 GoSyscallEnd dt=113 GoSyscallBegin dt=32 p_seq=11 stack=27 GoSyscallEnd dt=13 GoStatus dt=9 g=62 m=18446744073709551615 gstatus=4 GoUnblock dt=42 g=62 g_seq=1 stack=28 GoStatus dt=2 g=61 m=18446744073709551615 gstatus=4 GoUnblock dt=10 g=61 g_seq=1 stack=28 GoStatus dt=1 g=59 m=18446744073709551615 gstatus=4 GoUnblock dt=8 g=59 g_seq=1 stack=28 GoStatus dt=1 g=58 m=18446744073709551615 gstatus=4 GoUnblock dt=7 g=58 g_seq=1 stack=28 GoStatus dt=1 g=60 m=18446744073709551615 gstatus=4 GoUnblock dt=7 g=60 g_seq=1 stack=28 GoStatus dt=1 g=56 m=18446744073709551615 gstatus=4 GoUnblock dt=6 g=56 g_seq=1 stack=28 GoStatus dt=1 g=55 m=18446744073709551615 gstatus=4 GoUnblock dt=7 g=55 g_seq=1 stack=28 GoStatus dt=1 g=54 m=18446744073709551615 gstatus=4 GoUnblock dt=7 g=54 g_seq=1 stack=28 GoStatus dt=1 g=53 m=18446744073709551615 gstatus=4 GoUnblock dt=7 g=53 g_seq=1 stack=28 GoStatus dt=1 g=57 m=18446744073709551615 gstatus=4 GoUnblock dt=6 g=57 g_seq=1 stack=28 GoStatus dt=1 g=18 m=18446744073709551615 gstatus=4 GoUnblock dt=6 g=18 g_seq=1 stack=28 GoBlock dt=99 reason_string=10 stack=29 GoStart dt=3 g=18 g_seq=2 GoDestroy dt=28 GoStart dt=3 g=11 g_seq=1 GoStop dt=15 reason_string=22 stack=30 GoStart dt=2 g=62 g_seq=2 GoDestroy dt=5 GoStart dt=25 g=61 g_seq=2 GoDestroy dt=3 GoStart dt=9 g=59 g_seq=2 GoDestroy dt=3 GoStart dt=8 g=58 g_seq=2 GoDestroy dt=3 GoStart dt=6 g=60 g_seq=2 GoDestroy dt=4 GoStart dt=7 g=56 g_seq=2 GoDestroy dt=5 GoStart dt=6 g=55 g_seq=2 GoDestroy dt=3 GoStart dt=9 g=54 g_seq=2 GoDestroy dt=3 GoStart dt=6 g=53 g_seq=2 GoDestroy dt=4 GoStart dt=8 g=57 g_seq=2 GoDestroy dt=4 GoStart dt=7 g=11 g_seq=2 GoBlock dt=25 reason_string=6 stack=31 GoStatus dt=18 g=19 m=18446744073709551615 gstatus=4 GoUnblock dt=2 g=19 g_seq=1 stack=0 GoStart dt=2 g=19 g_seq=2 GoSyscallBegin dt=36 p_seq=12 stack=32 GoSyscallEnd dt=20 GoStatus dt=6 g=63 m=18446744073709551615 gstatus=4 GoUnblock dt=80 g=63 g_seq=1 stack=33 GoDestroy dt=3 GoStart dt=3 g=63 g_seq=2 GoSyscallBegin dt=34 p_seq=13 stack=34 GoSyscallEnd dt=10 GoUnblock dt=28 g=6 g_seq=3 stack=35 GoDestroy dt=1 GoStart dt=3 g=6 g_seq=4 GoSyscallBegin dt=49 p_seq=14 stack=36 GoSyscallEnd dt=21 GoSyscallBegin dt=58 p_seq=15 stack=37 GoSyscallEnd dt=17 GoSyscallBegin dt=41 p_seq=16 stack=38 GoSyscallEnd dt=76 GoBlock dt=45 reason_string=11 stack=39 GoStart dt=7 g=23 g_seq=1 GoBlock dt=32 reason_string=12 stack=40 GoStart dt=4 g=24 g_seq=1 GoSyscallBegin dt=55 p_seq=17 stack=41 GoSyscallEnd dt=86 GoBlock dt=16 reason_string=15 stack=42 ProcStop dt=19 ProcStart dt=38159 p=1 p_seq=1378 GoUnblock dt=32 g=1 g_seq=1 stack=0 GoStart dt=39 g=1 g_seq=2 HeapAlloc dt=269 heapalloc_value=489917096 HeapAlloc dt=87 heapalloc_value=489925288 HeapAlloc dt=97 heapalloc_value=489933480 HeapAlloc dt=88 heapalloc_value=489941672 HeapAlloc dt=68 heapalloc_value=489949864 EventBatch gen=5 m=18446744073709551615 time=77498922614 size=195 GoStatusStack dt=48 g=2 m=18446744073709551615 gstatus=4 stack=43 GoStatusStack dt=2 g=3 m=18446744073709551615 gstatus=4 stack=44 GoStatusStack dt=2 g=4 m=18446744073709551615 gstatus=4 stack=45 GoStatusStack dt=1 g=5 m=18446744073709551615 gstatus=4 stack=46 GoStatusStack dt=1 g=34 m=18446744073709551615 gstatus=1 stack=47 GoStatusStack dt=1 g=35 m=18446744073709551615 gstatus=4 stack=48 GoStatusStack dt=1 g=36 m=18446744073709551615 gstatus=4 stack=48 GoStatusStack dt=1 g=37 m=18446744073709551615 gstatus=4 stack=48 GoStatusStack dt=1 g=38 m=18446744073709551615 gstatus=4 stack=48 GoStatusStack dt=1 g=39 m=18446744073709551615 gstatus=4 stack=48 GoStatusStack dt=1 g=40 m=18446744073709551615 gstatus=4 stack=48 GoStatusStack dt=1 g=41 m=18446744073709551615 gstatus=4 stack=48 GoStatusStack dt=1 g=42 m=18446744073709551615 gstatus=4 stack=48 EventBatch gen=5 m=18446744073709551615 time=77498923229 size=1949 Stacks Stack id=1 nframes=4 pc=584910 func=24 file=25 line=287 pc=544163 func=26 file=27 line=283 pc=1190007 func=28 file=29 line=125 pc=1191319 func=30 file=31 line=159 Stack id=3 nframes=5 pc=663535 func=32 file=33 line=236 pc=394081 func=34 file=35 line=1500 pc=544687 func=26 file=27 line=306 pc=1190007 func=28 file=29 line=125 pc=1191319 func=30 file=31 line=159 Stack id=5 nframes=1 pc=577713 func=36 file=37 line=44 Stack id=42 nframes=1 pc=1190377 func=38 file=29 line=130 Stack id=47 nframes=2 pc=1194807 func=22 file=35 line=387 pc=1194788 func=39 file=31 line=67 Stack id=17 nframes=15 pc=810735 func=40 file=41 line=182 pc=880773 func=42 file=43 line=464 pc=880724 func=44 file=45 line=17 pc=1162253 func=46 file=47 line=15 pc=1155571 func=48 file=49 line=290 pc=1159323 func=50 file=51 line=121 pc=1158193 func=52 file=51 line=75 pc=1158212 func=53 file=51 line=71 pc=1059949 func=54 file=55 line=721 pc=1057769 func=56 file=55 line=686 pc=1055435 func=57 file=55 line=587 pc=1053541 func=58 file=55 line=578 pc=1051475 func=59 file=55 line=504 pc=1051500 func=60 file=55 line=471 pc=1193291 func=61 file=31 line=130 Stack id=6 nframes=4 pc=577605 func=62 file=37 line=44 pc=544693 func=26 file=27 line=308 pc=1190007 func=28 file=29 line=125 pc=1191319 func=30 file=31 line=159 Stack id=34 nframes=7 pc=807007 func=63 file=64 line=736 pc=876627 func=65 file=43 line=183 pc=876598 func=66 file=67 line=738 pc=876242 func=68 file=67 line=161 pc=884215 func=69 file=70 line=29 pc=884184 func=71 file=72 line=144 pc=1194443 func=73 file=31 line=98 Stack id=23 nframes=8 pc=806209 func=74 file=64 line=335 pc=875531 func=75 file=76 line=24 pc=875496 func=77 file=67 line=82 pc=872853 func=78 file=79 line=213 pc=875747 func=80 file=67 line=105 pc=1087385 func=81 file=82 line=48 pc=1127285 func=83 file=84 line=220 pc=1193597 func=61 file=31 line=137 Stack id=28 nframes=1 pc=1193705 func=61 file=31 line=147 Stack id=30 nframes=1 pc=1195566 func=85 file=31 line=140 Stack id=26 nframes=7 pc=807535 func=86 file=64 line=964 pc=877905 func=87 file=43 line=211 pc=877888 func=66 file=67 line=738 pc=877388 func=88 file=67 line=374 pc=884471 func=89 file=70 line=46 pc=884440 func=90 file=72 line=215 pc=1193651 func=61 file=31 line=145 Stack id=15 nframes=3 pc=134813 func=91 file=92 line=506 pc=550263 func=93 file=27 line=1023 pc=577805 func=36 file=37 line=56 Stack id=29 nframes=2 pc=694907 func=94 file=95 line=150 pc=1193723 func=61 file=31 line=148 Stack id=2 nframes=3 pc=544191 func=26 file=27 line=284 pc=1190007 func=28 file=29 line=125 pc=1191319 func=30 file=31 line=159 Stack id=7 nframes=1 pc=549745 func=96 file=27 line=957 Stack id=39 nframes=3 pc=129945 func=97 file=92 line=161 pc=1195381 func=98 file=31 line=30 pc=1193789 func=61 file=31 line=149 Stack id=11 nframes=2 pc=658579 func=99 file=100 line=349 pc=1191223 func=30 file=31 line=162 Stack id=35 nframes=3 pc=694587 func=101 file=95 line=107 pc=1194493 func=102 file=95 line=121 pc=1194468 func=73 file=31 line=100 Stack id=46 nframes=4 pc=643837 func=103 file=35 line=458 pc=193855 func=104 file=35 line=464 pc=193818 func=105 file=106 line=416 pc=195981 func=107 file=106 line=576 Stack id=13 nframes=8 pc=806209 func=74 file=64 line=335 pc=875531 func=75 file=76 line=24 pc=875496 func=77 file=67 line=82 pc=872853 func=78 file=79 line=213 pc=875747 func=80 file=67 line=105 pc=1087385 func=81 file=82 line=48 pc=1127285 func=83 file=84 line=220 pc=1194059 func=108 file=31 line=128 Stack id=43 nframes=3 pc=643837 func=103 file=35 line=458 pc=381279 func=104 file=35 line=464 pc=381242 func=109 file=35 line=371 Stack id=12 nframes=7 pc=807535 func=86 file=64 line=964 pc=877905 func=87 file=43 line=211 pc=877888 func=66 file=67 line=738 pc=877388 func=88 file=67 line=374 pc=1087831 func=110 file=82 line=107 pc=1126807 func=111 file=84 line=208 pc=1194029 func=108 file=31 line=127 Stack id=19 nframes=16 pc=810735 func=40 file=41 line=182 pc=880773 func=42 file=43 line=464 pc=880724 func=44 file=45 line=17 pc=1162661 func=112 file=113 line=24 pc=1161089 func=114 file=115 line=20 pc=1155859 func=48 file=49 line=302 pc=1159323 func=50 file=51 line=121 pc=1158193 func=52 file=51 line=75 pc=1158212 func=53 file=51 line=71 pc=1059949 func=54 file=55 line=721 pc=1057769 func=56 file=55 line=686 pc=1055435 func=57 file=55 line=587 pc=1053541 func=58 file=55 line=578 pc=1051475 func=59 file=55 line=504 pc=1051500 func=60 file=55 line=471 pc=1193291 func=61 file=31 line=130 Stack id=22 nframes=7 pc=807007 func=63 file=64 line=736 pc=876627 func=65 file=43 line=183 pc=876598 func=66 file=67 line=738 pc=876242 func=68 file=67 line=161 pc=1087511 func=116 file=82 line=66 pc=1126231 func=117 file=84 line=196 pc=1193567 func=61 file=31 line=136 Stack id=36 nframes=9 pc=806209 func=74 file=64 line=335 pc=875531 func=75 file=76 line=24 pc=875496 func=77 file=67 line=82 pc=872853 func=78 file=79 line=213 pc=875747 func=80 file=67 line=105 pc=1087385 func=81 file=82 line=48 pc=1156501 func=118 file=51 line=167 pc=1156514 func=119 file=49 line=393 pc=1193745 func=61 file=31 line=149 Stack id=44 nframes=3 pc=643837 func=103 file=35 line=458 pc=278221 func=104 file=35 line=464 pc=278184 func=120 file=121 line=319 Stack id=24 nframes=1 pc=1195537 func=85 file=31 line=139 Stack id=10 nframes=2 pc=1190123 func=28 file=29 line=128 pc=1191319 func=30 file=31 line=159 Stack id=14 nframes=1 pc=211427 func=122 file=123 line=198 Stack id=18 nframes=16 pc=810735 func=40 file=41 line=182 pc=880773 func=42 file=43 line=464 pc=880724 func=44 file=45 line=17 pc=1154253 func=124 file=125 line=58 pc=1160741 func=114 file=115 line=17 pc=1155859 func=48 file=49 line=302 pc=1159323 func=50 file=51 line=121 pc=1158193 func=52 file=51 line=75 pc=1158212 func=53 file=51 line=71 pc=1059949 func=54 file=55 line=721 pc=1057769 func=56 file=55 line=686 pc=1055435 func=57 file=55 line=587 pc=1053541 func=58 file=55 line=578 pc=1051475 func=59 file=55 line=504 pc=1051500 func=60 file=55 line=471 pc=1193291 func=61 file=31 line=130 Stack id=16 nframes=16 pc=810539 func=126 file=41 line=174 pc=803973 func=127 file=43 line=315 pc=1089893 func=128 file=129 line=138 pc=1147707 func=130 file=131 line=124 pc=1146441 func=132 file=131 line=70 pc=1115497 func=133 file=134 line=167 pc=1158539 func=50 file=51 line=85 pc=1158193 func=52 file=51 line=75 pc=1158212 func=53 file=51 line=71 pc=1059949 func=54 file=55 line=721 pc=1057769 func=56 file=55 line=686 pc=1055435 func=57 file=55 line=587 pc=1053541 func=58 file=55 line=578 pc=1051475 func=59 file=55 line=504 pc=1051500 func=60 file=55 line=471 pc=1193291 func=61 file=31 line=130 Stack id=27 nframes=7 pc=807535 func=86 file=64 line=964 pc=877905 func=87 file=43 line=211 pc=877888 func=66 file=67 line=738 pc=877388 func=88 file=67 line=374 pc=884471 func=89 file=70 line=46 pc=884440 func=90 file=72 line=215 pc=1193687 func=61 file=31 line=146 Stack id=25 nframes=1 pc=1193615 func=61 file=31 line=139 Stack id=20 nframes=16 pc=810735 func=40 file=41 line=182 pc=880773 func=42 file=43 line=464 pc=880724 func=44 file=45 line=17 pc=1163093 func=135 file=113 line=38 pc=1161437 func=114 file=115 line=23 pc=1155859 func=48 file=49 line=302 pc=1159323 func=50 file=51 line=121 pc=1158193 func=52 file=51 line=75 pc=1158212 func=53 file=51 line=71 pc=1059949 func=54 file=55 line=721 pc=1057769 func=56 file=55 line=686 pc=1055435 func=57 file=55 line=587 pc=1053541 func=58 file=55 line=578 pc=1051475 func=59 file=55 line=504 pc=1051500 func=60 file=55 line=471 pc=1193291 func=61 file=31 line=130 Stack id=4 nframes=4 pc=394081 func=34 file=35 line=1500 pc=544687 func=26 file=27 line=306 pc=1190007 func=28 file=29 line=125 pc=1191319 func=30 file=31 line=159 Stack id=9 nframes=1 pc=1190273 func=38 file=29 line=128 Stack id=38 nframes=9 pc=806209 func=74 file=64 line=335 pc=875531 func=75 file=76 line=24 pc=875496 func=77 file=67 line=82 pc=872853 func=78 file=79 line=213 pc=875747 func=80 file=67 line=105 pc=888173 func=136 file=137 line=316 pc=1195165 func=138 file=70 line=23 pc=1195136 func=139 file=31 line=49 pc=1193767 func=61 file=31 line=149 Stack id=32 nframes=7 pc=807007 func=63 file=64 line=736 pc=876627 func=65 file=43 line=183 pc=876598 func=66 file=67 line=738 pc=876242 func=68 file=67 line=161 pc=884215 func=69 file=70 line=29 pc=884184 func=71 file=72 line=144 pc=1194971 func=140 file=31 line=54 Stack id=31 nframes=2 pc=473659 func=141 file=142 line=104 pc=1195591 func=85 file=31 line=141 Stack id=21 nframes=16 pc=810735 func=40 file=41 line=182 pc=880773 func=42 file=43 line=464 pc=880724 func=44 file=45 line=17 pc=1163457 func=143 file=113 line=50 pc=1161785 func=114 file=115 line=26 pc=1155859 func=48 file=49 line=302 pc=1159323 func=50 file=51 line=121 pc=1158193 func=52 file=51 line=75 pc=1158212 func=53 file=51 line=71 pc=1059949 func=54 file=55 line=721 pc=1057769 func=56 file=55 line=686 pc=1055435 func=57 file=55 line=587 pc=1053541 func=58 file=55 line=578 pc=1051475 func=59 file=55 line=504 pc=1051500 func=60 file=55 line=471 pc=1193291 func=61 file=31 line=130 Stack id=45 nframes=4 pc=643837 func=103 file=35 line=458 pc=266737 func=104 file=35 line=464 pc=266706 func=144 file=145 line=425 pc=268473 func=146 file=145 line=658 Stack id=37 nframes=9 pc=806209 func=74 file=64 line=335 pc=875531 func=75 file=76 line=24 pc=875496 func=77 file=67 line=82 pc=872853 func=78 file=79 line=213 pc=875747 func=80 file=67 line=105 pc=888173 func=136 file=137 line=316 pc=1195129 func=138 file=70 line=23 pc=1195092 func=139 file=31 line=48 pc=1193767 func=61 file=31 line=149 Stack id=41 nframes=7 pc=807535 func=86 file=64 line=964 pc=877905 func=87 file=43 line=211 pc=877888 func=66 file=67 line=738 pc=877388 func=88 file=67 line=374 pc=884471 func=89 file=70 line=46 pc=884440 func=90 file=72 line=215 pc=1190371 func=38 file=29 line=134 Stack id=48 nframes=2 pc=643837 func=103 file=35 line=458 pc=229859 func=147 file=148 line=1503 Stack id=8 nframes=4 pc=549703 func=149 file=27 line=957 pc=544711 func=26 file=27 line=309 pc=1190007 func=28 file=29 line=125 pc=1191319 func=30 file=31 line=159 Stack id=33 nframes=7 pc=649518 func=150 file=151 line=115 pc=872643 func=152 file=79 line=188 pc=873017 func=153 file=79 line=231 pc=876827 func=68 file=67 line=171 pc=884215 func=69 file=70 line=29 pc=884184 func=71 file=72 line=144 pc=1194971 func=140 file=31 line=54 Stack id=40 nframes=3 pc=134813 func=91 file=92 line=506 pc=550263 func=93 file=27 line=1023 pc=549817 func=96 file=27 line=960 EventBatch gen=5 m=18446744073709551615 time=77498816032 size=4548 Strings String id=1 data="Not worker" String id=2 data="GC (dedicated)" String id=3 data="GC (fractional)" String id=4 data="GC (idle)" String id=5 data="unspecified" String id=6 data="forever" String id=7 data="network" String id=8 data="select" String id=9 data="sync.(*Cond).Wait" String id=10 data="sync" String id=11 data="chan send" String id=12 data="chan receive" String id=13 data="GC mark assist wait for work" String id=14 data="GC background sweeper wait" String id=15 data="system goroutine wait" String id=16 data="preempted" String id=17 data="wait for debug call" String id=18 data="wait until GC ends" String id=19 data="sleep" String id=20 data="GC weak to strong wait" String id=21 data="synctest" String id=22 data="runtime.Gosched" String id=23 data="start trace" String id=24 data="runtime.traceLocker.Gomaxprocs" String id=25 data="/data/golang/workdir/go/src/runtime/traceruntime.go" String id=26 data="runtime.StartTrace" String id=27 data="/data/golang/workdir/go/src/runtime/trace.go" String id=28 data="runtime/trace.Start" String id=29 data="/data/golang/workdir/go/src/runtime/trace/trace.go" String id=30 data="main.main" String id=31 data="/data/golang/workdir/go/src/internal/trace/testdata/testprog/stress-start-stop.go" String id=32 data="runtime.systemstack_switch" String id=33 data="/data/golang/workdir/go/src/runtime/asm_s390x.s" String id=34 data="runtime.startTheWorld" String id=35 data="/data/golang/workdir/go/src/runtime/proc.go" String id=36 data="runtime.traceStartReadCPU.func1" String id=37 data="/data/golang/workdir/go/src/runtime/tracecpu.go" String id=38 data="runtime/trace.Start.func1" String id=39 data="main.main.func1.5" String id=40 data="syscall.setsockopt" String id=41 data="/data/golang/workdir/go/src/syscall/syscall_linux_s390x.go" String id=42 data="syscall.SetsockoptInt" String id=43 data="/data/golang/workdir/go/src/syscall/syscall_unix.go" String id=44 data="internal/poll.(*FD).SetsockoptInt" String id=45 data="/data/golang/workdir/go/src/internal/poll/sockopt.go" String id=46 data="net.setNoDelay" String id=47 data="/data/golang/workdir/go/src/net/tcpsockopt_posix.go" String id=48 data="net.newTCPConn" String id=49 data="/data/golang/workdir/go/src/net/tcpsock.go" String id=50 data="net.(*sysDialer).doDialTCPProto" String id=51 data="/data/golang/workdir/go/src/net/tcpsock_posix.go" String id=52 data="net.(*sysDialer).doDialTCP" String id=53 data="net.(*sysDialer).dialTCP" String id=54 data="net.(*sysDialer).dialSingle" String id=55 data="/data/golang/workdir/go/src/net/dial.go" String id=56 data="net.(*sysDialer).dialSerial" String id=57 data="net.(*sysDialer).dialParallel" String id=58 data="net.(*Dialer).DialContext" String id=59 data="net.(*Dialer).Dial" String id=60 data="net.Dial" String id=61 data="main.main.func1" String id=62 data="runtime.traceStartReadCPU" String id=63 data="syscall.read" String id=64 data="/data/golang/workdir/go/src/syscall/zsyscall_linux_s390x.go" String id=65 data="syscall.Read" String id=66 data="internal/poll.ignoringEINTRIO" String id=67 data="/data/golang/workdir/go/src/internal/poll/fd_unix.go" String id=68 data="internal/poll.(*FD).Read" String id=69 data="os.(*File).read" String id=70 data="/data/golang/workdir/go/src/os/file_posix.go" String id=71 data="os.(*File).Read" String id=72 data="/data/golang/workdir/go/src/os/file.go" String id=73 data="main.main.func1.7" String id=74 data="syscall.Close" String id=75 data="internal/poll.(*SysFile).destroy" String id=76 data="/data/golang/workdir/go/src/internal/poll/fd_unixjs.go" String id=77 data="internal/poll.(*FD).destroy" String id=78 data="internal/poll.(*FD).decref" String id=79 data="/data/golang/workdir/go/src/internal/poll/fd_mutex.go" String id=80 data="internal/poll.(*FD).Close" String id=81 data="net.(*netFD).Close" String id=82 data="/data/golang/workdir/go/src/net/fd_posix.go" String id=83 data="net.(*conn).Close" String id=84 data="/data/golang/workdir/go/src/net/net.go" String id=85 data="main.main.func1.10" String id=86 data="syscall.write" String id=87 data="syscall.Write" String id=88 data="internal/poll.(*FD).Write" String id=89 data="os.(*File).write" String id=90 data="os.(*File).Write" String id=91 data="runtime.chanrecv1" String id=92 data="/data/golang/workdir/go/src/runtime/chan.go" String id=93 data="runtime.(*wakeableSleep).sleep" String id=94 data="sync.(*WaitGroup).Wait" String id=95 data="/data/golang/workdir/go/src/sync/waitgroup.go" String id=96 data="runtime.(*traceAdvancerState).start.func1" String id=97 data="runtime.chansend1" String id=98 data="main.main.func1.1" String id=99 data="time.Sleep" String id=100 data="/data/golang/workdir/go/src/runtime/time.go" String id=101 data="sync.(*WaitGroup).Add" String id=102 data="sync.(*WaitGroup).Done" String id=103 data="runtime.gopark" String id=104 data="runtime.goparkunlock" String id=105 data="runtime.(*cleanupQueue).dequeue" String id=106 data="/data/golang/workdir/go/src/runtime/mcleanup.go" String id=107 data="runtime.runCleanups" String id=108 data="main.main.func1.9" String id=109 data="runtime.forcegchelper" String id=110 data="net.(*netFD).Write" String id=111 data="net.(*conn).Write" String id=112 data="net.setKeepAliveIdle" String id=113 data="/data/golang/workdir/go/src/net/tcpsockopt_unix.go" String id=114 data="net.(*TCPConn).SetKeepAliveConfig" String id=115 data="/data/golang/workdir/go/src/net/tcpsock_unix.go" String id=116 data="net.(*netFD).Read" String id=117 data="net.(*conn).Read" String id=118 data="net.(*TCPListener).close" String id=119 data="net.(*TCPListener).Close" String id=120 data="runtime.bgsweep" String id=121 data="/data/golang/workdir/go/src/runtime/mgcsweep.go" String id=122 data="runtime.runFinalizers" String id=123 data="/data/golang/workdir/go/src/runtime/mfinal.go" String id=124 data="net.setKeepAlive" String id=125 data="/data/golang/workdir/go/src/net/sockopt_posix.go" String id=126 data="syscall.getsockopt" String id=127 data="syscall.GetsockoptInt" String id=128 data="net.(*netFD).connect" String id=129 data="/data/golang/workdir/go/src/net/fd_unix.go" String id=130 data="net.(*netFD).dial" String id=131 data="/data/golang/workdir/go/src/net/sock_posix.go" String id=132 data="net.socket" String id=133 data="net.internetSocket" String id=134 data="/data/golang/workdir/go/src/net/ipsock_posix.go" String id=135 data="net.setKeepAliveInterval" String id=136 data="os.(*file).close" String id=137 data="/data/golang/workdir/go/src/os/file_unix.go" String id=138 data="os.(*File).Close" String id=139 data="main.main.func1.3" String id=140 data="main.main.func1.4" String id=141 data="runtime.block" String id=142 data="/data/golang/workdir/go/src/runtime/select.go" String id=143 data="net.setKeepAliveCount" String id=144 data="runtime.(*scavengerState).park" String id=145 data="/data/golang/workdir/go/src/runtime/mgcscavenge.go" String id=146 data="runtime.bgscavenge" String id=147 data="runtime.gcBgMarkWorker" String id=148 data="/data/golang/workdir/go/src/runtime/mgc.go" String id=149 data="runtime.(*traceAdvancerState).start" String id=150 data="internal/poll.runtime_Semrelease" String id=151 data="/data/golang/workdir/go/src/runtime/sema.go" String id=152 data="internal/poll.(*fdMutex).rwunlock" String id=153 data="internal/poll.(*FD).readUnlock" FAIL FAIL internal/trace 155.219s ? internal/trace/internal/testgen [no test files] ok internal/trace/internal/tracev1 0.662s FAIL go tool dist: Failed: exit status 1