linux-ppc64-sid-buildlet at aa9dd50095efd2bb0e3b6fcf75859904f3f80d03 :: Running /workdir/go/src/make.bash with args ["/workdir/go/src/make.bash"] and env ["PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin" "HOSTNAME=power_03" "GO_BUILDER_ENV=host-linux-ppc64-sid" "GO_BUILD_KEY_PATH=/buildkey/gobuildkey" "GO_BUILD_KEY_DELETE_AFTER_READ=true" "DEBIAN_FRONTEND=noninteractive" "GOMAXPROCS=4" "HOME=/root" "USER=root" "GO_STAGE0_NET_DELAY=100ms" "GO_STAGE0_DL_DELAY=400ms" "WORKDIR=/workdir" "GOROOT_BOOTSTRAP=/workdir/go1.4" "GO_BUILDER_NAME=linux-ppc64-sid-buildlet" "GO_BUILDER_FLAKY_NET=1" "GO_TEST_TIMEOUT_SCALE=2" "GOBIN=" "TMPDIR=/workdir/tmp" "GOCACHE=/workdir/gocache" "GOPLSCACHE=/workdir/goplscache" "PWD=/workdir/go/src"] in dir /workdir/go/src Building Go cmd/dist using /workdir/go1.4. (go1.20.6 linux/ppc64) Building Go toolchain1 using /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/ppc64. --- Installed Go for linux/ppc64 in /workdir/go Installed commands in /workdir/go/bin *** You need to add /workdir/go/bin to your PATH. ##### Test execution environment. # GOARCH: ppc64 # CPU: POWER8 # GOOS: linux # OS Version: Linux 6.5.0-4-powerpc64 #1 SMP Debian 6.5.10-1 (2023-11-03) ppc64 ##### Testing packages. ok archive/tar 0.260s ok archive/zip 0.502s ok bufio 0.088s ok bytes 0.388s ok cmp 0.003s ok compress/bzip2 0.078s ok compress/flate 1.263s ok compress/gzip 2.632s ok compress/lzw 0.086s ok compress/zlib 0.467s ok container/heap 0.021s ok container/list 0.003s ok container/ring 0.010s ok context 0.021s ok crypto 0.005s ok crypto/aes 0.090s ok crypto/cipher 0.012s ok crypto/des 0.007s ok crypto/dsa 0.020s ok crypto/ecdh 0.038s ok crypto/ecdsa 0.032s ok crypto/ed25519 0.086s ok crypto/elliptic 0.026s ok crypto/hmac 0.004s ok crypto/internal/alias 0.005s ok crypto/internal/bigmod 0.245s ok crypto/internal/boring 0.007s ok crypto/internal/boring/bcache 0.184s ok crypto/internal/edwards25519 0.135s ok crypto/internal/edwards25519/field 0.027s ok crypto/internal/nistec 0.137s ok crypto/internal/nistec/fiat 0.004s [no tests to run] ok crypto/md5 0.005s ok crypto/rand 0.115s ok crypto/rc4 0.055s ok crypto/rsa 0.571s ok crypto/sha1 0.018s ok crypto/sha256 0.005s ok crypto/sha512 0.019s ok crypto/subtle 0.295s ok crypto/tls 0.638s ok crypto/x509 0.770s ok database/sql 0.535s ok database/sql/driver 0.003s ok debug/buildinfo 0.008s ok debug/dwarf 0.020s ok debug/elf 0.220s ok debug/gosym 0.037s ok debug/macho 0.033s ok debug/pe 0.022s ok debug/plan9obj 0.003s ok embed 0.003s [no tests to run] ok embed/internal/embedtest 0.004s ok encoding/ascii85 0.005s ok encoding/asn1 0.009s ok encoding/base32 0.042s ok encoding/base64 0.007s ok encoding/binary 0.012s ok encoding/csv 0.012s ok encoding/gob 2.619s ok encoding/hex 0.008s ok encoding/json 0.226s ok encoding/pem 0.436s ok encoding/xml 0.056s ok errors 0.004s ok expvar 0.004s ok flag 0.107s ok fmt 0.143s ok go/ast 0.006s ok go/build 3.037s ok go/build/constraint 0.004s ok go/constant 0.005s ok go/doc 0.047s ok go/doc/comment 1.094s ok go/format 0.007s ok go/importer 0.265s ok go/internal/gccgoimporter 0.021s ok go/internal/gcimporter 1.167s ok go/internal/srcimporter 2.253s ok go/parser 0.289s ok go/printer 0.339s ok go/scanner 0.023s ok go/token 0.018s ok go/types 10.840s ok go/version 0.004s ok hash 0.007s ok hash/adler32 0.009s ok hash/crc32 0.007s ok hash/crc64 0.006s ok hash/fnv 0.003s ok hash/maphash 0.081s ok html 0.009s ok html/template 0.065s ok image 0.059s ok image/color 0.019s ok image/draw 0.151s ok image/gif 0.332s ok image/jpeg 0.272s ok image/png 0.391s ok index/suffixarray 0.180s ok internal/abi 0.050s ok internal/buildcfg 0.003s ok internal/coverage/cformat 0.003s ok internal/coverage/cmerge 0.003s ok internal/coverage/pods 0.004s ok internal/coverage/slicereader 0.014s ok internal/coverage/slicewriter 0.014s ok internal/coverage/test 0.009s ok internal/cpu 0.005s ok internal/dag 0.003s ok internal/diff 0.004s ok internal/fmtsort 0.003s ok internal/fuzz 0.008s ok internal/godebug 0.352s ok internal/godebugs 0.016s ok internal/gover 0.003s ok internal/intern 0.234s ok internal/itoa 0.023s ok internal/platform 1.353s ok internal/poll 0.180s ok internal/profile 0.056s ok internal/reflectlite 0.004s ok internal/safefilepath 0.003s ok internal/saferio 0.064s ok internal/singleflight 0.030s ok internal/testenv 0.150s ok internal/trace 0.065s ok internal/trace/v2 13.077s ok internal/types/errors 0.573s ok internal/unsafeheader 0.032s ok internal/xcoff 0.010s ok internal/zstd 0.027s ok io 0.027s ok io/fs 0.398s ok io/ioutil 0.007s ok log 0.052s ok log/slog 0.025s ok log/slog/internal/benchmarks 0.002s ok log/slog/internal/buffer 0.027s ok log/syslog 1.216s ok maps 0.004s ok math 0.011s ok math/big 2.193s ok math/bits 0.007s ok math/cmplx 0.008s ok math/rand 0.341s ok math/rand/v2 0.487s ok mime 0.008s ok mime/multipart 0.761s ok mime/quotedprintable 0.071s ok net 9.980s ok net/http 6.500s ok net/http/cgi 0.204s ok net/http/cookiejar 0.007s ok net/http/fcgi 0.213s ok net/http/httptest 0.064s ok net/http/httptrace 0.017s ok net/http/httputil 0.602s ok net/http/internal 0.017s ok net/http/internal/ascii 0.015s ok net/http/pprof 5.093s ok net/internal/socktest 0.004s ok net/mail 0.023s ok net/netip 0.376s ok net/rpc 0.041s ok net/rpc/jsonrpc 0.006s ok net/smtp 0.026s ok net/textproto 0.068s ok net/url 0.033s ok os 0.578s ok os/exec 0.259s ok os/exec/internal/fdtest 0.003s ok os/signal 75.535s ok os/user 0.013s ok path 0.020s ok path/filepath 0.018s ok plugin 0.003s ok reflect 0.655s ok regexp 0.738s ok regexp/syntax 2.046s --- FAIL: TestRuntimeLockMetricsAndProfile (0.05s) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock (0.02s) --- FAIL: TestRuntimeLockMetricsAndProfile/runtime.lock/sample-1 (0.01s) metrics_test.go:1048: lock contention growth in runtime/pprof's view (0.006736s) metrics_test.go:1049: lock contention growth in runtime/metrics' view (0.006734s) metrics_test.go:1077: stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] has samples totaling n=99 value=6736102 metrics_test.go:1156: mutex profile reported contention count different from the known true count (99 != 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: PeriodType: contentions count Period: 1 Time: 2023-11-19 02:25:03.936920263 +0000 UTC Samples: contentions/count delay/nanoseconds 99 6736102: 1 2 3 -99 -6736102: 4 5 6 Locations 1: 0x20368 M=1 runtime.unlock /workdir/go/src/runtime/lock_futex.go:117 s=116 2: 0x3620e7 M=1 runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 /workdir/go/src/runtime/metrics_test.go:1129 s=1112 3: 0x362fe7 M=1 runtime_test.(*contentionWorker).run /workdir/go/src/runtime/metrics_test.go:1247 s=1243 4: 0x20368 M=3 runtime.unlock /workdir/go/src/runtime/lock_futex.go:117 s=116 5: 0x3620e7 M=3 runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 /workdir/go/src/runtime/metrics_test.go:1129 s=1112 6: 0x362fe7 M=3 runtime_test.(*contentionWorker).run /workdir/go/src/runtime/metrics_test.go:1247 s=1243 Mappings 1: 0x10000/0x3d0000/0x0 /workdir/tmp/go-build171969372/b016/runtime.test [FN] 2: 0x7fff99ec0000/0x7fff99ed0000/0x0 [vdso] 3: 0x10000/0x3d0000/0x0 /workdir/tmp/go-build171969372/b016/runtime.test [FN] 4: 0x7fff99ec0000/0x7fff99ed0000/0x0 [vdso] metrics_test.go:1081: have stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] metrics_test.go:1081: have stack [runtime.unlock runtime_test.TestRuntimeLockMetricsAndProfile.func5.1 runtime_test.(*contentionWorker).run] 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 24.213s ok runtime/coverage 0.004s ok runtime/debug 0.059s FAIL go tool dist: Failed: exit status 1