linux-s390x-ibm-race at 631a6c2abfb2cf7a877ea80f98c504fc4e0077be :: Running /data/golang/workdir/go/src/make.bash with args ["/data/golang/workdir/go/src/make.bash"] and env ["LANG=en_US.UTF-8" "PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin" "HOME=/root" "LOGNAME=root" "USER=root" "SHELL=/bin/sh" "INVOCATION_ID=52cdcb5d3775439d9810e080a3de6866" "JOURNAL_STREAM=9:227747766" "META_BUILDLET_BINARY_URL=https://storage.googleapis.com/go-builder-data/buildlet.linux-s390x" "GO_STAGE0_NET_DELAY=100ms" "GO_STAGE0_DL_DELAY=200ms" "WORKDIR=/data/golang/workdir" "GOROOT_BOOTSTRAP=/data/golang/workdir/go1.4" "GO_BUILDER_NAME=linux-s390x-ibm-race" "GO_BUILDER_FLAKY_NET=1" "GO_TEST_TIMEOUT_SCALE=5" "GOBIN=" "TMPDIR=/data/golang/workdir/tmp" "GOCACHE=/data/golang/workdir/gocache" "GOPLSCACHE=/data/golang/workdir/goplscache" "PWD=/data/golang/workdir/go/src"] in dir /data/golang/workdir/go/src Building Go cmd/dist using /data/golang/workdir/go1.4. (go1.20.6 linux/s390x) Building Go toolchain1 using /data/golang/workdir/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 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. :: Running /data/golang/workdir/go/bin/go with args ["/data/golang/workdir/go/bin/go" "install" "-race" "std"] and env ["LANG=en_US.UTF-8" "PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin" "HOME=/root" "LOGNAME=root" "USER=root" "SHELL=/bin/sh" "INVOCATION_ID=52cdcb5d3775439d9810e080a3de6866" "JOURNAL_STREAM=9:227747766" "META_BUILDLET_BINARY_URL=https://storage.googleapis.com/go-builder-data/buildlet.linux-s390x" "GO_STAGE0_NET_DELAY=100ms" "GO_STAGE0_DL_DELAY=200ms" "WORKDIR=/data/golang/workdir" "GOROOT_BOOTSTRAP=/data/golang/workdir/go1.4" "GO_BUILDER_NAME=linux-s390x-ibm-race" "GO_BUILDER_FLAKY_NET=1" "GO_TEST_TIMEOUT_SCALE=5" "GOBIN=" "TMPDIR=/data/golang/workdir/tmp" "GOCACHE=/data/golang/workdir/gocache" "GOPLSCACHE=/data/golang/workdir/goplscache" "PWD=/data/golang/workdir/go/bin"] in dir /data/golang/workdir/go/bin ##### 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.905s ok archive/zip 4.996s ok bufio 1.548s ok bytes 3.533s ok cmp 1.043s ok compress/bzip2 2.780s ok compress/flate 19.658s ok compress/gzip 30.682s ok compress/lzw 4.585s ok compress/zlib 14.370s ok container/heap 1.037s ok container/list 1.038s ok container/ring 1.232s ok context 1.089s ok crypto 1.060s ok crypto/aes 1.144s ok crypto/cipher 1.068s ok crypto/des 1.067s ok crypto/dsa 1.024s ok crypto/ecdh 1.569s ok crypto/ecdsa 1.872s ok crypto/ed25519 3.171s ok crypto/elliptic 1.209s ok crypto/hmac 1.215s ok crypto/internal/alias 1.164s ok crypto/internal/bigmod 11.009s ok crypto/internal/boring 1.011s ok crypto/internal/boring/bcache 2.758s ok crypto/internal/edwards25519 4.624s ok crypto/internal/edwards25519/field 1.520s ok crypto/internal/nistec 3.066s ok crypto/internal/nistec/fiat 1.053s [no tests to run] ok crypto/md5 1.146s ok crypto/rand 1.880s ok crypto/rc4 1.877s ok crypto/rsa 4.474s ok crypto/sha1 1.032s ok crypto/sha256 1.051s ok crypto/sha512 1.037s ok crypto/subtle 1.754s ok crypto/tls 13.823s ok crypto/x509 6.031s ok database/sql 2.060s ok database/sql/driver 1.099s ok debug/buildinfo 1.112s ok debug/dwarf 1.140s ok debug/elf 3.901s ok debug/gosym 1.914s ok debug/macho 1.129s ok debug/pe 1.082s ok debug/plan9obj 1.013s ok embed 1.307s [no tests to run] ok embed/internal/embedtest 1.158s ok encoding/ascii85 1.119s ok encoding/asn1 1.057s ok encoding/base32 1.917s ok encoding/base64 1.331s ok encoding/binary 1.131s ok encoding/csv 1.162s ok encoding/gob 35.303s ok encoding/hex 1.074s ok encoding/json 6.316s ok encoding/pem 4.227s ok encoding/xml 1.249s ok errors 1.018s ok expvar 1.022s ok flag 3.244s ok fmt 1.718s ok go/ast 1.020s ok go/build 12.085s ok go/build/constraint 1.061s ok go/constant 1.072s ok go/doc 1.952s ok go/doc/comment 7.507s ok go/format 1.289s ok go/importer 2.955s ok go/internal/gccgoimporter 1.075s ok go/internal/gcimporter 31.753s ok go/internal/srcimporter 96.504s ok go/parser 4.658s ok go/printer 19.247s ok go/scanner 1.485s ok go/token 1.708s ok go/types 161.040s ok go/version 2.055s ok hash 1.017s ok hash/adler32 1.093s ok hash/crc32 1.260s ok hash/crc64 1.262s ok hash/fnv 1.263s ok hash/maphash 1.379s ok html 2.218s ok html/template 2.516s ok image 3.568s ok image/color 1.136s ok image/draw 3.775s ok image/gif 6.987s ok image/jpeg 5.659s ok image/png 12.830s ok index/suffixarray 5.259s ok internal/abi 1.348s ok internal/buildcfg 1.062s ok internal/coverage/cformat 1.028s ok internal/coverage/cmerge 1.023s ok internal/coverage/pods 1.011s ok internal/coverage/slicereader 1.163s ok internal/coverage/slicewriter 1.148s ok internal/coverage/test 1.141s ok internal/cpu 2.092s ok internal/dag 1.037s ok internal/diff 1.043s ok internal/fmtsort 1.720s ok internal/fuzz 1.712s ok internal/godebug 15.825s ok internal/godebugs 1.022s ok internal/gover 1.165s ok internal/intern 10.125s ok internal/itoa 1.039s ok internal/platform 8.424s ok internal/poll 2.271s ok internal/profile 1.426s ok internal/reflectlite 1.031s ok internal/safefilepath 1.037s ok internal/saferio 1.210s ok internal/singleflight 1.130s ok internal/testenv 1.900s ok internal/trace 1.914s ok internal/trace/v2 82.668s ok internal/types/errors 4.516s ok internal/unsafeheader 1.120s ok internal/xcoff 1.211s ok internal/zstd 1.088s ok io 1.148s ok io/fs 1.413s ok io/ioutil 1.103s ok log 4.066s ok log/slog 4.720s ok log/slog/internal/benchmarks 1.354s ok log/slog/internal/buffer 1.036s ok log/syslog 3.661s ok maps 1.032s ok math 1.652s ok math/big 29.103s ok math/bits 1.286s ok math/cmplx 2.631s ok math/rand 10.103s ok math/rand/v2 8.947s ok mime 1.076s ok mime/multipart 25.798s ok mime/quotedprintable 2.191s ok net 114.254s ok net/http 68.961s ok net/http/cgi 39.036s ok net/http/cookiejar 1.680s ok net/http/fcgi 1.653s ok net/http/httptest 3.980s ok net/http/httptrace 1.160s ok net/http/httputil 3.528s ok net/http/internal 1.634s ok net/http/internal/ascii 1.110s ok net/http/pprof 8.846s ok net/internal/socktest 3.938s ok net/mail 1.020s ok net/netip 10.178s ok net/rpc 1.093s ok net/rpc/jsonrpc 1.040s ok net/smtp 1.301s ok net/textproto 1.621s ok net/url 5.441s ok os 15.428s ok os/exec 15.096s ok os/exec/internal/fdtest 1.418s ok os/signal 29.584s ok os/user 3.287s ok path 1.465s ok path/filepath 1.139s ok plugin 1.138s ok reflect 26.511s ok regexp 20.050s ok regexp/syntax 33.871s --- FAIL: TestRuntimeLockMetricsAndProfile (344.70s) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock (0.23s) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock/sample-1 (0.15s) metrics_test.go:1048: lock contention growth in runtime/pprof's view (0.008194s) metrics_test.go:1049: lock contention growth in runtime/metrics' view (0.008194s) metrics_test.go:1077: stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] has samples totaling n=2 value=8193750 metrics_test.go:1156: mutex profile reported contention count different from the known true count (2 != 100) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock/sample-2 (0.08s) metrics_test.go:1048: lock contention growth in runtime/pprof's view (0.034216s) metrics_test.go:1049: lock contention growth in runtime/metrics' view (0.027861s) metrics_test.go:1077: stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] has samples totaling n=36 value=34216000 metrics_test.go:1186: mutex profile reported contention count too different from the expected count (36 far from 100) FAIL FAIL runtime 844.247s ok runtime/cgo 1.026s ok runtime/coverage 1.039s FAIL go tool dist: Failed: exit status 1