linux-s390x-ibm at 0b31a46f1fd89b1ede02be9fae920dca6172ffaf :: 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=813f6e399a4345f995ad642126837c7f" "JOURNAL_STREAM=9:230466130" "META_BUILDLET_BINARY_URL=https://storage.googleapis.com/go-builder-data/buildlet.linux-s390x" "GO_STAGE0_NET_DELAY=0s" "GO_STAGE0_DL_DELAY=100ms" "WORKDIR=/data/golang/workdir" "GOROOT_BOOTSTRAP=/data/golang/workdir/go1.4" "GO_BUILDER_NAME=linux-s390x-ibm" "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. ##### 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 0.775s ok archive/zip 2.540s ok bufio 0.378s ok bytes 0.473s ok cmp 0.086s ok compress/bzip2 0.225s ok compress/flate 3.656s ok compress/gzip 5.909s ok compress/lzw 0.803s ok compress/zlib 1.995s ok container/heap 0.026s ok container/list 0.015s ok container/ring 0.013s ok context 0.079s ok crypto 0.247s ok crypto/aes 0.046s ok crypto/cipher 0.574s ok crypto/des 0.320s ok crypto/dsa 0.129s ok crypto/ecdh 0.152s ok crypto/ecdsa 0.175s ok crypto/ed25519 0.191s ok crypto/elliptic 0.017s ok crypto/hmac 0.822s ok crypto/internal/alias 0.478s ok crypto/internal/bigmod 0.458s ok crypto/internal/boring 0.171s ok crypto/internal/boring/bcache 0.437s ok crypto/internal/edwards25519 0.417s ok crypto/internal/edwards25519/field 0.416s ok crypto/internal/nistec 0.240s ok crypto/internal/nistec/fiat 0.012s [no tests to run] ok crypto/md5 0.083s ok crypto/rand 0.100s ok crypto/rc4 0.119s ok crypto/rsa 1.260s ok crypto/sha1 0.007s ok crypto/sha256 0.005s ok crypto/sha512 0.013s ok crypto/subtle 0.667s ok crypto/tls 2.060s ok crypto/x509 0.964s ok database/sql 0.693s ok database/sql/driver 0.007s ok debug/buildinfo 0.029s ok debug/dwarf 0.399s ok debug/elf 0.431s ok debug/gosym 0.039s ok debug/macho 0.018s ok debug/pe 0.008s ok debug/plan9obj 0.005s ok embed 0.561s [no tests to run] ok embed/internal/embedtest 0.010s ok encoding/ascii85 0.423s ok encoding/asn1 0.012s ok encoding/base32 0.038s ok encoding/base64 0.010s ok encoding/binary 0.128s ok encoding/csv 0.136s ok encoding/gob 7.141s ok encoding/hex 0.872s ok encoding/json 0.546s ok encoding/pem 2.079s ok encoding/xml 0.080s ok errors 0.013s ok expvar 0.012s ok flag 0.331s ok fmt 0.059s ok go/ast 0.022s ok go/build 7.845s ok go/build/constraint 0.084s ok go/constant 0.085s ok go/doc 0.058s ok go/doc/comment 3.065s ok go/format 0.021s ok go/importer 3.251s ok go/internal/gccgoimporter 0.955s ok go/internal/gcimporter 7.535s ok go/internal/srcimporter 20.518s ok go/parser 0.744s ok go/printer 0.537s ok go/scanner 0.152s ok go/token 0.010s ok go/types 25.682s ok go/version 0.017s ok hash 0.017s ok hash/adler32 0.048s ok hash/crc32 0.024s ok hash/crc64 0.003s ok hash/fnv 0.014s ok hash/maphash 0.825s ok html 0.005s ok html/template 0.188s ok image 0.126s ok image/color 0.031s ok image/draw 0.136s ok image/gif 1.687s ok image/jpeg 0.317s ok image/png 1.740s ok index/suffixarray 0.565s ok internal/abi 0.130s ok internal/buildcfg 0.005s ok internal/coverage/cformat 0.016s ok internal/coverage/cmerge 0.008s ok internal/coverage/pods 0.005s ok internal/coverage/slicereader 0.022s ok internal/coverage/slicewriter 0.023s ok internal/coverage/test 0.017s ok internal/cpu 0.082s ok internal/dag 0.014s ok internal/diff 0.013s ok internal/fmtsort 0.026s ok internal/fuzz 0.071s ok internal/godebug 2.470s ok internal/godebugs 0.024s ok internal/gover 0.009s ok internal/intern 4.964s ok internal/itoa 0.040s ok internal/platform 9.082s ok internal/poll 0.632s ok internal/profile 0.661s ok internal/reflectlite 0.032s ok internal/safefilepath 0.011s ok internal/saferio 0.260s ok internal/singleflight 0.023s ok internal/testenv 1.117s ok internal/trace 0.160s ok internal/trace/v2 49.494s ok internal/types/errors 3.169s ok internal/unsafeheader 0.003s ok internal/xcoff 0.137s ok internal/zstd 0.206s ok io 0.339s ok io/fs 0.216s ok io/ioutil 0.032s ok log 0.009s ok log/slog 0.396s ok log/slog/internal/benchmarks 0.003s ok log/slog/internal/buffer 0.015s ok log/syslog 1.336s ok maps 0.032s ok math 0.557s ok math/big 10.051s ok math/bits 0.017s ok math/cmplx 0.071s ok math/rand 1.106s ok math/rand/v2 1.327s ok mime 0.171s ok mime/multipart 4.307s ok mime/quotedprintable 0.203s ok net 17.573s ok net/http 20.854s ok net/http/cgi 0.797s ok net/http/cookiejar 0.010s ok net/http/fcgi 0.364s ok net/http/httptest 0.159s ok net/http/httptrace 0.024s ok net/http/httputil 1.102s ok net/http/internal 0.008s ok net/http/internal/ascii 0.003s ok net/http/pprof 5.483s ok net/internal/socktest 0.041s ok net/mail 0.009s ok net/netip 1.503s ok net/rpc 0.113s ok net/rpc/jsonrpc 0.037s ok net/smtp 0.015s ok net/textproto 1.383s ok net/url 0.016s ok os 2.341s ok os/exec 1.027s ok os/exec/internal/fdtest 0.006s ok os/signal 12.392s ok os/user 0.159s ok path 0.077s ok path/filepath 0.224s ok plugin 0.251s ok reflect 7.127s ok regexp 0.614s ok regexp/syntax 3.751s --- FAIL: TestRuntimeLockMetricsAndProfile (0.03s) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock (0.01s) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock/sample-1 (0.01s) metrics_test.go:1038: no increase in mutex profile metrics_test.go:1041: no increase in /sync/mutex/wait/total:seconds metric metrics_test.go:1048: lock contention growth in runtime/pprof's view (0.000000s) metrics_test.go:1049: lock contention growth in runtime/metrics' view (0.000000s) metrics_test.go:1077: stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] has samples totaling n=0 value=0 metrics_test.go:1079: profile: Period: 1 Time: 2023-11-18 00:01:43.615287736 -0500 EST Samples: / / Locations Mappings 1: 0x10000/0x496000/0x0 2: 0x3ff7fa00000/0x3ff7fb9a000/0x0 3: 0x3ff7fc00000/0x3ff7fc1c000/0x0 4: 0x3ff7fc80000/0x3ff7fc96000/0x0 5: 0x3ff7fd80000/0x3ff7fda8000/0x0 6: 0x3ff7fdfe000/0x3ff7fe00000/0x0 metrics_test.go:1083: want stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] metrics_test.go:1153: runtime/metrics reported less than the known minimum contention duration (0.000000s < 0.001000s) metrics_test.go:1156: mutex profile reported contention count different from the known true count (0 != 100) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock/sample-2 (0.01s) metrics_test.go:1038: no increase in mutex profile metrics_test.go:1041: no increase in /sync/mutex/wait/total:seconds metric metrics_test.go:1048: lock contention growth in runtime/pprof's view (0.000000s) metrics_test.go:1049: lock contention growth in runtime/metrics' view (0.000000s) metrics_test.go:1077: stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] has samples totaling n=0 value=0 metrics_test.go:1079: profile: Period: 1 Time: 2023-11-18 00:01:43.621852436 -0500 EST Samples: / / Locations Mappings 1: 0x10000/0x496000/0x0 2: 0x3ff7fa00000/0x3ff7fb9a000/0x0 3: 0x3ff7fc00000/0x3ff7fc1c000/0x0 4: 0x3ff7fc80000/0x3ff7fc96000/0x0 5: 0x3ff7fd80000/0x3ff7fda8000/0x0 6: 0x3ff7fdfe000/0x3ff7fe00000/0x0 metrics_test.go:1083: want stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] metrics_test.go:1183: runtime/metrics reported less than the known minimum contention duration (2.500000 * 0.000000s < 0.001000s) metrics_test.go:1186: mutex profile reported contention count too different from the expected count (0 far from 100) FAIL FAIL runtime 145.060s FAIL go tool dist: Failed: exit status 1