freebsd-amd64-race at 09300d89e94da7b1f32742e80768acc711b5c590 :: Running /tmp/workdir/go/src/make.bash with args ["/tmp/workdir/go/src/make.bash"] and env ["PATH=/bin:/sbin:/usr/bin:/usr/local/bin" "LANG=C.UTF-8" "HOME=/" "MM_CHARSET=UTF-8" "RC_PID=16" "BLOCKSIZE=K" "WORKDIR=/tmp/workdir" "GOROOT_BOOTSTRAP=/tmp/workdir/go1.4" "GO_BUILDER_NAME=freebsd-amd64-race" "GOBIN=" "TMPDIR=/tmp/workdir/tmp" "GOCACHE=/tmp/workdir/gocache" "GOPLSCACHE=/tmp/workdir/goplscache" "PWD=/tmp/workdir/go/src"] in dir /tmp/workdir/go/src Building Go cmd/dist using /tmp/workdir/go1.4. (go1.20.6 freebsd/amd64) Building Go toolchain1 using /tmp/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 freebsd/amd64. --- Installed Go for freebsd/amd64 in /tmp/workdir/go Installed commands in /tmp/workdir/go/bin *** You need to add /tmp/workdir/go/bin to your PATH. :: Running /tmp/workdir/go/bin/go with args ["/tmp/workdir/go/bin/go" "install" "-race" "std"] and env ["PATH=/bin:/sbin:/usr/bin:/usr/local/bin" "LANG=C.UTF-8" "HOME=/" "MM_CHARSET=UTF-8" "RC_PID=16" "BLOCKSIZE=K" "WORKDIR=/tmp/workdir" "GOROOT_BOOTSTRAP=/tmp/workdir/go1.4" "GO_BUILDER_NAME=freebsd-amd64-race" "GOBIN=" "TMPDIR=/tmp/workdir/tmp" "GOCACHE=/tmp/workdir/gocache" "GOPLSCACHE=/tmp/workdir/goplscache" "PWD=/tmp/workdir/go/bin"] in dir /tmp/workdir/go/bin ##### Test execution environment. # GOARCH: amd64 # CPU: AMD EPYC 7B12 # GOOS: freebsd # OS Version: FreeBSD 13.0-STABLE FreeBSD 13.0-STABLE #0 stable/13-n248759-3684bb89d52: Thu Dec 30 02:37:49 UTC 2021 root@releng3.nyi.freebsd.org:/usr/obj/usr/src/amd64.amd64/sys/GENERIC amd64 ##### Testing packages. ok archive/tar 1.526s ok archive/zip 2.329s ok bufio 1.293s ok bytes 1.863s ok cmp 1.080s ok compress/bzip2 1.367s ok compress/flate 4.801s ok compress/gzip 9.774s ok compress/lzw 1.875s ok compress/zlib 4.561s ok container/heap 1.018s ok container/list 1.024s ok container/ring 1.056s ok context 1.081s ok crypto 1.079s ok crypto/aes 1.048s ok crypto/cipher 1.094s ok crypto/des 1.093s ok crypto/dsa 1.075s ok crypto/ecdh 1.214s ok crypto/ecdsa 1.168s ok crypto/ed25519 1.350s ok crypto/elliptic 1.047s ok crypto/hmac 1.047s ok crypto/internal/alias 1.017s ok crypto/internal/bigmod 3.469s ok crypto/internal/boring 1.017s ok crypto/internal/boring/bcache 1.342s ok crypto/internal/edwards25519 1.629s ok crypto/internal/edwards25519/field 1.128s ok crypto/internal/nistec 1.674s ok crypto/internal/nistec/fiat 1.032s [no tests to run] ok crypto/md5 1.032s ok crypto/rand 1.189s ok crypto/rc4 1.341s ok crypto/rsa 2.382s ok crypto/sha1 1.065s ok crypto/sha256 1.016s ok crypto/sha512 1.085s ok crypto/subtle 1.348s ok crypto/tls 3.233s ok crypto/x509 2.041s ok database/sql 1.565s ok database/sql/driver 1.034s ok debug/buildinfo 1.033s ok debug/dwarf 1.075s ok debug/elf 1.882s ok debug/gosym 1.079s ok debug/macho 1.085s ok debug/pe 1.087s ok debug/plan9obj 1.023s ok embed 1.049s [no tests to run] ok embed/internal/embedtest 1.048s ok encoding/ascii85 1.048s ok encoding/asn1 1.068s ok encoding/base32 1.069s ok encoding/base64 1.077s ok encoding/binary 1.053s ok encoding/csv 1.053s ok encoding/gob 12.507s ok encoding/hex 1.044s ok encoding/json 1.893s ok encoding/pem 2.254s ok encoding/xml 1.186s ok errors 1.034s ok expvar 1.033s ok flag 3.203s ok fmt 1.510s ok go/ast 1.071s ok go/build 4.059s ok go/build/constraint 1.027s ok go/constant 1.027s ok go/doc 1.183s ok go/doc/comment 2.433s ok go/format 1.108s ok go/importer 1.602s ok go/internal/gccgoimporter 1.096s ok go/internal/gcimporter 7.888s ok go/internal/srcimporter 9.459s ok go/parser 1.717s ok go/printer 2.194s ok go/scanner 1.066s ok go/token 1.089s ok go/types 26.038s ok hash 1.063s ok hash/adler32 1.041s ok hash/crc32 1.075s ok hash/crc64 1.066s ok hash/fnv 1.026s ok hash/maphash 1.026s ok html 1.046s ok html/template 1.221s ok image 1.303s ok image/color 1.086s ok image/draw 1.430s ok image/gif 1.687s ok image/jpeg 2.116s ok image/png 3.059s ok index/suffixarray 1.913s ok internal/abi 1.075s ok internal/buildcfg 1.075s ok internal/coverage/cformat 1.075s ok internal/coverage/cmerge 1.043s ok internal/coverage/pods 1.041s ok internal/coverage/slicereader 1.031s ok internal/coverage/slicewriter 1.076s ok internal/coverage/test 1.074s ok internal/cpu 3.196s ok internal/dag 1.076s ok internal/diff 1.076s ok internal/fmtsort 1.075s ok internal/fuzz 1.053s ok internal/godebug 11.891s ok internal/godebugs 1.053s ok internal/intern 1.267s ok internal/itoa 1.077s ok internal/platform 1.507s ok internal/poll 1.284s ok internal/profile 1.044s ok internal/reflectlite 1.014s ok internal/safefilepath 1.066s ok internal/saferio 1.124s ok internal/singleflight 1.101s ok internal/testenv 1.179s ok internal/trace 1.193s ok internal/types/errors 1.353s ok internal/unsafeheader 1.073s ok internal/xcoff 1.051s ok internal/zstd 1.232s ok io 1.076s ok io/fs 1.236s ok io/ioutil 1.076s ok log 1.086s ok log/slog 1.145s ok log/slog/internal/benchmarks 1.016s ok log/slog/internal/buffer 1.074s ok log/syslog 2.362s ok maps 1.077s ok math 1.036s ok math/big 3.162s ok math/bits 1.029s ok math/cmplx 1.050s ok math/rand 3.646s ok mime 1.036s ok mime/multipart 4.018s ok mime/quotedprintable 1.058s ok net 8.995s panic: test timed out after 3m0s running tests: TestHandlerFinishSkipBigContentLengthRead (2m59s) goroutine 16678 [running]: panic({0xafed40?, 0xc001114e90?}) /tmp/workdir/go/src/runtime/panic.go:774 +0x158 fp=0xc000286f18 sp=0xc000286e68 pc=0x48db38 testing.(*M).startAlarm.func1() /tmp/workdir/go/src/testing/testing.go:2257 +0x214 fp=0xc000286fe0 sp=0xc000286f18 pc=0x5b4cd4 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000286fe8 sp=0xc000286fe0 pc=0x4c5201 created by time.goFunc /tmp/workdir/go/src/time/sleep.go:177 +0x45 goroutine 1 [chan receive, 2 minutes]: runtime.gopark(0xc00007a000?, 0x0?, 0x72?, 0x32?, 0xc00011d618?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc00011d588 sp=0xc00011d568 pc=0x49162e runtime.chanrecv(0xc0003383f0, 0x0, 0x1) /tmp/workdir/go/src/runtime/chan.go:583 +0x36d fp=0xc00011d600 sp=0xc00011d588 pc=0x45d26d runtime.chanrecv1(0xc00007c1e0?, 0xfc2020?) /tmp/workdir/go/src/runtime/chan.go:442 +0x12 fp=0xc00011d628 sp=0xc00011d600 pc=0x45ced2 testing.tRunner.func1() /tmp/workdir/go/src/testing/testing.go:1559 +0x8d2 fp=0xc00011d800 sp=0xc00011d628 pc=0x5ae452 runtime.deferreturn() /tmp/workdir/go/src/runtime/panic.go:595 +0x5e fp=0xc00011d890 sp=0xc00011d800 pc=0x48d6be testing.tRunner(0xc0001641a0, 0xc00011daa0) /tmp/workdir/go/src/testing/testing.go:1599 +0x24e fp=0xc00011d970 sp=0xc00011d890 pc=0x5ada8e testing.runTests(0xc00010ac80?, {0xfbde00, 0x216, 0x216}, {0xc0000145f0?, 0x10?, 0xfc27c0?}) /tmp/workdir/go/src/testing/testing.go:2050 +0x897 fp=0xc00011dad0 sp=0xc00011d970 pc=0x5b2d37 testing.(*M).Run(0xc00010ac80) /tmp/workdir/go/src/testing/testing.go:1923 +0xb58 fp=0xc00011de28 sp=0xc00011dad0 pc=0x5b0498 net/http_test.TestMain(0x8028fee5bc81d16a?) /tmp/workdir/go/src/net/http/main_test.go:24 +0x65 fp=0xc00011de58 sp=0xc00011de28 pc=0x9d4bc5 main.main() _testmain.go:1181 +0x308 fp=0xc00011df40 sp=0xc00011de58 pc=0xad2ba8 runtime.main() /tmp/workdir/go/src/runtime/proc.go:267 +0x2b2 fp=0xc00011dfe0 sp=0xc00011df40 pc=0x4911d2 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc00011dfe8 sp=0xc00011dfe0 pc=0x4c5201 goroutine 2 [force gc (idle), 2 minutes]: runtime.gopark(0xf69360?, 0xfc3460?, 0x0?, 0x0?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc0002dbfa8 sp=0xc0002dbf88 pc=0x49162e runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:404 runtime.forcegchelper() /tmp/workdir/go/src/runtime/proc.go:322 +0xa5 fp=0xc0002dbfe0 sp=0xc0002dbfa8 pc=0x4914a5 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc0002dbfe8 sp=0xc0002dbfe0 pc=0x4c5201 created by runtime.init.6 in goroutine 1 /tmp/workdir/go/src/runtime/proc.go:310 +0x1a goroutine 3 [GC sweep wait, 2 minutes]: runtime.gopark(0xfc2201?, 0x0?, 0x0?, 0x0?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc00006af78 sp=0xc00006af58 pc=0x49162e runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:404 runtime.bgsweep(0x0?) /tmp/workdir/go/src/runtime/mgcsweep.go:321 +0xdf fp=0xc00006afc8 sp=0xc00006af78 pc=0x47c4ff runtime.gcenable.gowrap1() /tmp/workdir/go/src/runtime/mgc.go:203 +0x25 fp=0xc00006afe0 sp=0xc00006afc8 pc=0x4715a5 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc00006afe8 sp=0xc00006afe0 pc=0x4c5201 created by runtime.gcenable in goroutine 1 /tmp/workdir/go/src/runtime/mgc.go:203 +0x66 goroutine 4 [GC scavenge wait]: runtime.gopark(0x673c3a?, 0x608e38?, 0x0?, 0x0?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc00006ef70 sp=0xc00006ef50 pc=0x49162e runtime.goparkunlock(...) /tmp/workdir/go/src/runtime/proc.go:404 runtime.(*scavengerState).park(0xfc2940) /tmp/workdir/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0xc00006efa0 sp=0xc00006ef70 pc=0x479de9 runtime.bgscavenge(0x0?) /tmp/workdir/go/src/runtime/mgcscavenge.go:658 +0x59 fp=0xc00006efc8 sp=0xc00006efa0 pc=0x47a359 runtime.gcenable.gowrap2() /tmp/workdir/go/src/runtime/mgc.go:204 +0x25 fp=0xc00006efe0 sp=0xc00006efc8 pc=0x471545 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc00006efe8 sp=0xc00006efe0 pc=0x4c5201 created by runtime.gcenable in goroutine 1 /tmp/workdir/go/src/runtime/mgc.go:204 +0xa5 goroutine 5 [finalizer wait, 2 minutes]: runtime.gopark(0x0?, 0xc001639ef0?, 0x40?, 0x80?, 0x1000000010?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000068e28 sp=0xc000068e08 pc=0x49162e runtime.runfinq() /tmp/workdir/go/src/runtime/mfinal.go:193 +0x145 fp=0xc000068fe0 sp=0xc000068e28 pc=0x470645 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000068fe8 sp=0xc000068fe0 pc=0x4c5201 created by runtime.createfing in goroutine 1 /tmp/workdir/go/src/runtime/mfinal.go:163 +0x3d goroutine 66 [GC worker (idle), 2 minutes]: runtime.gopark(0xc000515fb8?, 0x1?, 0x3c?, 0xf6?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000515f50 sp=0xc000515f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000515fe0 sp=0xc000515f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000515fe8 sp=0xc000515fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 51 [GC worker (idle), 2 minutes]: runtime.gopark(0xc000512fb8?, 0x3?, 0xcd?, 0x29?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000512f50 sp=0xc000512f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000512fe0 sp=0xc000512f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000512fe8 sp=0xc000512fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 50 [GC worker (idle), 2 minutes]: runtime.gopark(0xc000516fb8?, 0x3?, 0x48?, 0xd5?, 0xc000057790?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000516f50 sp=0xc000516f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000516fe0 sp=0xc000516f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000516fe8 sp=0xc000516fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 40 [GC worker (idle), 2 minutes]: runtime.gopark(0xff3020?, 0x1?, 0x92?, 0x97?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000517f50 sp=0xc000517f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000517fe0 sp=0xc000517f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000517fe8 sp=0xc000517fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 41 [GC worker (idle), 2 minutes]: runtime.gopark(0xc000514fb8?, 0x3?, 0x51?, 0x5c?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000514f50 sp=0xc000514f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000514fe0 sp=0xc000514f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000514fe8 sp=0xc000514fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 67 [GC worker (idle), 2 minutes]: runtime.gopark(0xc000513fb8?, 0x1?, 0x2?, 0xf1?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000513f50 sp=0xc000513f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000513fe0 sp=0xc000513f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000513fe8 sp=0xc000513fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 42 [GC worker (idle), 2 minutes]: runtime.gopark(0xff3020?, 0x1?, 0x2b?, 0xc4?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000511f50 sp=0xc000511f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000511fe0 sp=0xc000511f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000511fe8 sp=0xc000511fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 43 [GC worker (idle), 2 minutes]: runtime.gopark(0xc000510fb8?, 0x3?, 0x38?, 0x96?, 0x0?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000510f50 sp=0xc000510f30 pc=0x49162e runtime.gcBgMarkWorker() /tmp/workdir/go/src/runtime/mgc.go:1313 +0xe5 fp=0xc000510fe0 sp=0xc000510f50 pc=0x473205 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000510fe8 sp=0xc000510fe0 pc=0x4c5201 created by runtime.gcBgMarkStartWorkers in goroutine 39 /tmp/workdir/go/src/runtime/mgc.go:1237 +0x1c goroutine 1042 [chan receive, 2 minutes]: runtime.gopark(0x0?, 0x0?, 0x0?, 0xc0?, 0x30?) /tmp/workdir/go/src/runtime/proc.go:398 +0xce fp=0xc000537d80 sp=0xc000537d60 pc=0x49162e runtime.chanrecv(0xc0003aea20, 0x0, 0x1) /tmp/workdir/go/src/runtime/chan.go:583 +0x36d fp=0xc000537df8 sp=0xc000537d80 pc=0x45d26d runtime.chanrecv1(0xc0002f8008?, 0xc000930000?) /tmp/workdir/go/src/runtime/chan.go:442 +0x12 fp=0xc000537e20 sp=0xc000537df8 pc=0x45ced2 net/http_test.TestHandlerFinishSkipBigContentLengthRead(0xc0004b7ba0) /tmp/workdir/go/src/net/http/serve_test.go:4605 +0x355 fp=0xc000537ed0 sp=0xc000537e20 pc=0xa27c35 testing.tRunner(0xc0004b7ba0, 0xbe52a0) /tmp/workdir/go/src/testing/testing.go:1593 +0x21b fp=0xc000537fb0 sp=0xc000537ed0 pc=0x5ada5b testing.(*T).Run.gowrap1() /tmp/workdir/go/src/testing/testing.go:1646 +0x45 fp=0xc000537fe0 sp=0xc000537fb0 pc=0x5af545 runtime.goexit({}) /tmp/workdir/go/src/runtime/asm_amd64.s:1650 +0x1 fp=0xc000537fe8 sp=0xc000537fe0 pc=0x4c5201 created by testing.(*T).Run in goroutine 1 /tmp/workdir/go/src/testing/testing.go:1646 +0x82b FAIL net/http 180.349s FAIL go tool dist: Failed: exit status 1