linux-s390x-ibm at 677b6cc17544e5e667d4bb67d063f5d775c69e32 :: 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=c58fb9323b5d44e2a4aa829f26330a42" "JOURNAL_STREAM=9:302356198" "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" "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.312s ok archive/zip 3.420s ok bufio 1.299s ok bytes 1.130s ok cmp 0.137s ok compress/bzip2 0.447s ok compress/flate 3.769s ok compress/gzip 4.394s ok compress/lzw 3.771s ok compress/zlib 4.231s ok container/heap 0.303s ok container/list 0.005s ok container/ring 0.189s ok context 0.047s ok crypto 3.065s ok crypto/aes 0.076s ok crypto/cipher 3.468s ok crypto/des 0.027s ok crypto/dsa 0.021s ok crypto/ecdh 0.054s ok crypto/ecdsa 0.052s ok crypto/ed25519 0.556s ok crypto/elliptic 0.532s ok crypto/hmac 0.540s ok crypto/internal/alias 0.049s ok crypto/internal/bigmod 0.201s ok crypto/internal/boring 0.004s ok crypto/internal/boring/bcache 0.642s ok crypto/internal/edwards25519 0.348s ok crypto/internal/edwards25519/field 0.068s ok crypto/internal/hpke 0.051s ok crypto/internal/mlkem768 2.556s ok crypto/internal/nistec 0.488s ok crypto/internal/nistec/fiat 0.370s [no tests to run] ok crypto/md5 0.055s ok crypto/rand 0.066s ok crypto/rc4 0.050s ok crypto/rsa 4.133s ok crypto/sha1 0.020s ok crypto/sha256 0.008s ok crypto/sha512 0.971s ok crypto/subtle 2.420s ok crypto/tls 2.585s ok crypto/x509 2.113s ok database/sql 1.281s ok database/sql/driver 0.017s ok debug/buildinfo 0.105s ok debug/dwarf 0.562s ok debug/elf 0.416s ok debug/gosym 1.070s ok debug/macho 0.009s ok debug/pe 0.039s ok debug/plan9obj 0.012s ok embed 0.011s [no tests to run] ok embed/internal/embedtest 0.040s ok encoding/ascii85 0.068s ok encoding/asn1 0.020s ok encoding/base32 0.218s ok encoding/base64 0.149s ok encoding/binary 0.086s ok encoding/csv 0.020s ok encoding/gob 14.797s ok encoding/hex 0.094s ok encoding/json 1.004s ok encoding/pem 0.995s ok encoding/xml 0.593s ok errors 0.017s ok expvar 0.016s ok flag 0.065s ok fmt 0.073s ok go/ast 0.042s ok go/build 11.586s ok go/build/constraint 0.097s ok go/constant 0.025s ok go/doc 0.226s ok go/doc/comment 6.390s ok go/format 0.331s ok go/importer 1.081s ok go/internal/gccgoimporter 0.103s ok go/internal/gcimporter 13.808s ok go/internal/srcimporter 32.210s ok go/parser 1.362s ok go/printer 2.716s ok go/scanner 0.028s ok go/token 0.035s ok go/types 56.829s ok go/version 0.070s ok hash 0.055s ok hash/adler32 0.054s ok hash/crc32 0.039s ok hash/crc64 0.013s ok hash/fnv 0.020s ok hash/maphash 0.099s ok html 0.953s ok html/template 1.279s ok image 0.543s ok image/color 0.024s ok image/draw 0.127s ok image/gif 4.164s ok image/jpeg 0.951s ok image/png 1.974s ok index/suffixarray 1.111s ok internal/abi 0.268s ok internal/buildcfg 0.014s ok internal/chacha8rand 0.014s ok internal/concurrent 0.119s ok internal/coverage/cfile 4.755s ok internal/coverage/cformat 0.135s ok internal/coverage/cmerge 0.871s ok internal/coverage/pods 0.014s ok internal/coverage/slicereader 0.006s ok internal/coverage/slicewriter 0.379s ok internal/coverage/test 0.036s ok internal/cpu 0.187s ok internal/dag 0.002s ok internal/diff 0.080s ok internal/fmtsort 0.089s ok internal/fuzz 0.053s ok internal/godebug 2.815s ok internal/godebugs 31.231s ok internal/gover 0.012s ok internal/itoa 0.456s ok internal/pkgbits 0.460s ok internal/platform 6.825s ok internal/poll 0.625s ok internal/profile 0.007s ok internal/reflectlite 0.008s ok internal/runtime/atomic 0.012s ok internal/runtime/math 0.011s ok internal/runtime/sys 0.048s ok internal/runtime/syscall 0.068s ok internal/saferio 0.235s ok internal/singleflight 0.125s ok internal/syscall/unix 0.074s ok internal/sysinfo 0.014s ok internal/testenv 5.302s ok internal/trace 71.189s ok internal/trace/internal/oldtrace 0.455s ok internal/types/errors 1.741s ok internal/unsafeheader 0.009s ok internal/weak 0.039s ok internal/xcoff 0.075s ok internal/zstd 1.637s ok io 0.128s ok io/fs 0.637s ok io/ioutil 0.008s ok iter 0.124s ok log 0.096s ok log/slog 0.347s ok log/slog/internal/benchmarks 0.010s ok log/slog/internal/buffer 0.090s ok log/syslog 1.291s ok maps 0.180s ok math 0.032s ok math/big 4.302s ok math/bits 0.010s ok math/cmplx 0.119s ok math/rand 0.832s ok math/rand/v2 1.637s ok mime 0.095s ok mime/multipart 3.148s ok mime/quotedprintable 0.219s ok net 29.744s ok net/http 22.600s ok net/http/cgi 1.146s ok net/http/cookiejar 0.023s ok net/http/fcgi 0.252s ok net/http/httptest 0.058s ok net/http/httptrace 0.075s ok net/http/httputil 0.876s ok net/http/internal 0.481s ok net/http/internal/ascii 0.262s ok net/http/pprof 6.286s ok net/internal/cgotest 0.037s ok net/internal/socktest 0.040s ok net/mail 0.091s ok net/netip 1.374s ok net/rpc 0.168s ok net/rpc/jsonrpc 0.531s ok net/smtp 0.028s ok net/textproto 0.100s ok net/url 0.098s ok os 7.070s ok os/exec 1.827s ok os/exec/internal/fdtest 0.060s ok os/signal 12.179s ok os/user 0.053s ok path 0.218s ok path/filepath 0.129s ok plugin 0.094s ok reflect 9.191s ok regexp 3.606s ok regexp/syntax 2.226s ok runtime 193.819s ok runtime/cgo 0.012s ok runtime/debug 2.507s ok runtime/internal/wasitest 0.006s ok runtime/metrics 0.031s ok runtime/pprof 50.270s ok runtime/trace 0.193s ok slices 0.096s ok sort 0.089s ok strconv 1.496s ok strings 1.945s ok sync 5.300s ok sync/atomic 11.976s ok syscall 7.519s ok testing 13.760s ok testing/fstest 0.284s ok testing/iotest 0.053s ok testing/quick 0.346s ok testing/slogtest 0.003s ok text/scanner 0.024s ok text/tabwriter 0.322s ok text/template 0.081s ok text/template/parse 0.021s ok time 53.684s ok unicode 0.131s ok unicode/utf16 0.097s ok unicode/utf8 1.321s ok unique 1.763s ok cmd/addr2line 2.919s ok cmd/api 80.424s ok cmd/asm/internal/asm 1.959s ok cmd/asm/internal/lex 0.020s ok cmd/cgo/internal/swig 0.043s ok cmd/cgo/internal/test 6.285s ok cmd/cgo/internal/testcarchive 134.184s ok cmd/cgo/internal/testcshared 34.965s ok cmd/cgo/internal/testerrors 67.321s ok cmd/cgo/internal/testfortran 0.031s ok cmd/cgo/internal/testgodefs 3.475s ok cmd/cgo/internal/testlife 2.270s ok cmd/cgo/internal/testnocgo 0.006s ok cmd/cgo/internal/testplugin 244.476s ok cmd/cgo/internal/testsanitizers 1.646s ok cmd/cgo/internal/testshared 288.237s ok cmd/cgo/internal/testso 8.202s ok cmd/cgo/internal/teststdio 6.520s ok cmd/cgo/internal/testtls 0.017s ok cmd/compile 11.822s ok cmd/compile/internal/abt 0.007s ok cmd/compile/internal/amd64 0.005s ok cmd/compile/internal/base 0.011s ok cmd/compile/internal/compare 0.225s ok cmd/compile/internal/devirtualize 0.006s ok cmd/compile/internal/dwarfgen 2.227s ok cmd/compile/internal/importer 4.960s ok cmd/compile/internal/inline/inlheur 2.086s ok cmd/compile/internal/ir 0.016s ok cmd/compile/internal/liveness 0.055s ok cmd/compile/internal/logopt 0.298s ok cmd/compile/internal/loopvar 0.011s ok cmd/compile/internal/noder 0.002s ok cmd/compile/internal/rangefunc 0.018s ok cmd/compile/internal/reflectdata 0.029s [no tests to run] ok cmd/compile/internal/ssa 74.327s ok cmd/compile/internal/ssagen 0.011s ok cmd/compile/internal/syntax 0.270s ok cmd/compile/internal/test 53.195s ok cmd/compile/internal/typecheck 2.640s ok cmd/compile/internal/types 0.006s ok cmd/compile/internal/types2 32.117s ok cmd/covdata 0.391s ok cmd/cover 3.995s ok cmd/dist 0.014s ok cmd/distpack 0.024s ok cmd/doc 1.064s ok cmd/fix 13.553s vcs-test.golang.org rerouted to http://127.0.0.1:45121 https://vcs-test.golang.org rerouted to https://127.0.0.1:46541 go test proxy running at GOPROXY=http://127.0.0.1:34675/mod --- FAIL: TestScript (0.37s) --- FAIL: TestScript/test_regexps (4.32s) script_test.go:139: 2024-09-28T08:34:19Z script_test.go:141: $WORK=/data/golang/workdir/tmp/cmd-go-test-628514422/tmpdir3195849067/test_regexps3054133441 script_test.go:163: > go test -cpu=1 -run=X/Y -bench=X/Y -count=2 -v testregexp [stdout] === RUN TestX x_test.go:6: LOG: X running === RUN TestX/Y x_test.go:8: LOG: Y running --- PASS: TestX (0.00s) --- PASS: TestX/Y (0.00s) === RUN TestXX z_test.go:10: LOG: XX running --- PASS: TestXX (0.00s) === RUN TestX x_test.go:6: LOG: X running === RUN TestX/Y x_test.go:8: LOG: Y running --- PASS: TestX (0.00s) --- PASS: TestX/Y (0.00s) === RUN TestXX z_test.go:10: LOG: XX running --- PASS: TestXX (0.00s) goos: linux goarch: s390x pkg: testregexp BenchmarkX x_test.go:13: LOG: X running N=1 BenchmarkX/Y x_test.go:15: LOG: Y running N=1 BenchmarkX/Y 1 1156137235 ns/op x_test.go:15: LOG: Y running N=1 x_test.go:15: LOG: Y running N=100 x_test.go:15: LOG: Y running N=10000 x_test.go:15: LOG: Y running N=1000000 x_test.go:15: LOG: Y running N=100000000 x_test.go:15: LOG: Y running N=1000000000 BenchmarkX/Y 1000000000 0.0000096 ns/op BenchmarkXX z_test.go:18: LOG: XX running N=1 PASS ok testregexp 1.177s # Test the following: # TestX is run, twice (0.000s) # TestX/Y is run, twice (0.000s) # TestXX is run, twice (0.000s) # TestZ is not run (0.000s) # BenchmarkX is run with N=1 once, only to discover what sub-benchmarks it has, # and should not print a final summary line. (0.000s) # Same for BenchmarkXX. (0.000s) # BenchmarkX/Y is run in full twice due to -count=2. # "Run in full" means that it runs for approximately the default benchtime, # but may cap out at N=1e9. # We don't actually care what the final iteration count is, but it should be # a large number, and the last iteration count prints right before the results. (0.000s) > stdout -count=2 '^ x_test.go:15: LOG: Y running N=[1-9]\d{4,}\nBenchmarkX/Y\s+\d+' script_test.go:163: FAIL: testdata/script/test_regexps.txt:36: stdout -count=2 '^ x_test.go:15: LOG: Y running N=[1-9]\d{4,}\nBenchmarkX/Y\s+\d+': found 1 matches for `(?m)^ x_test.go:15: LOG: Y running N=[1-9]\d{4,}\nBenchmarkX/Y\s+\d+` in stdout FAIL FAIL cmd/go 176.664s FAIL go tool dist: Failed: exit status 1