plan9-arm at f5e5bc1a4281b22c9ca2c75431647638de515ba0 :: Running /usr/glenda/tmp/workdir-pi3plus2/go/src/make.rc with args ["/usr/glenda/tmp/workdir-pi3plus2/go/src/make.rc"] and env ["home=/usr/glenda" "GOPATH=/usr/glenda/gopath" "path=.\x00/bin" "type=host-plan9-arm-0intro" "GOARM=7" "status=" "GOROOT_BOOTSTRAP=/usr/glenda/go" "objtype=arm" "WORKDIR=/usr/glenda/tmp/workdir-pi3plus2" "GO_BUILDER_NAME=plan9-arm" "GOBIN="] in dir /usr/glenda/tmp/workdir-pi3plus2/go/src Building Go cmd/dist using /usr/glenda/go Building Go toolchain1 using /usr/glenda/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 plan9/arm. --- Installed Go for plan9/arm in /usr/glenda/tmp/workdir-pi3plus2/go Installed commands in /usr/glenda/tmp/workdir-pi3plus2/go/bin *** You need to bind /usr/glenda/tmp/workdir-pi3plus2/go/bin before /bin. ##### Testing packages. ok archive/tar 1.164s ok archive/zip 2.400s ok bufio 0.682s ok bytes 28.623s ok compress/bzip2 0.867s ok compress/flate 5.761s ok compress/gzip 13.274s ok compress/lzw 0.889s ok compress/zlib 2.751s ok container/heap 0.183s ok container/list 0.122s ok container/ring 0.116s ok context 1.206s ok crypto 0.109s ok crypto/aes 0.130s ok crypto/cipher 0.123s ok crypto/des 0.194s ok crypto/dsa 0.135s ok crypto/ecdsa 3.834s ok crypto/ed25519 2.042s ok crypto/elliptic 0.443s ok crypto/hmac 0.072s ok crypto/internal/subtle 0.052s ok crypto/md5 0.053s ok crypto/rand 0.343s ok crypto/rc4 0.214s ok crypto/rsa 1.661s ok crypto/sha1 0.190s ok crypto/sha256 0.116s ok crypto/sha512 0.183s ok crypto/subtle 0.128s ok crypto/tls 17.909s ok crypto/x509 12.809s ok database/sql 0.904s ok database/sql/driver 0.133s ok debug/dwarf 0.266s ok debug/elf 0.230s ok debug/gosym 0.133s ok debug/macho 0.157s ok debug/pe 0.154s ok debug/plan9obj 0.086s ok encoding/ascii85 0.067s ok encoding/asn1 0.117s ok encoding/base32 0.280s ok encoding/base64 0.199s ok encoding/binary 0.111s ok encoding/csv 0.127s ok encoding/gob 0.287s ok encoding/hex 0.166s ok encoding/json 0.439s ok encoding/pem 0.116s ok encoding/xml 0.232s ok errors 0.074s ok expvar 0.128s ok flag 0.138s ok fmt 0.821s ok go/ast 0.150s ok go/build 5.816s ok go/constant 0.069s ok go/doc 0.984s ok go/format 0.113s ok go/importer 2.906s ok go/internal/gccgoimporter 0.402s ok go/internal/gcimporter 31.922s ok go/internal/srcimporter 9.997s ok go/parser 0.179s ok go/printer 1.464s ok go/scanner 0.076s ok go/token 0.144s ok go/types 18.242s ok hash 0.143s ok hash/adler32 0.161s ok hash/crc32 0.064s ok hash/crc64 0.083s ok hash/fnv 0.060s ok html 0.078s ok html/template 0.236s ok image 0.615s ok image/color 0.147s ok image/draw 0.693s ok image/gif 2.242s ok image/jpeg 1.427s ok image/png 0.273s ok index/suffixarray 4.853s ok internal/cpu 0.048s ok internal/fmtsort 0.105s ok internal/oserror 0.125s ok internal/poll 0.202s ok internal/reflectlite 0.058s ok internal/singleflight 0.122s ok internal/trace 0.395s ok internal/xcoff 0.623s ok io 0.192s ok io/ioutil 8.652s ok log 0.062s ok math 0.131s ok math/big 3.236s ok math/bits 0.123s ok math/cmplx 0.054s ok math/rand 2.449s ok mime 0.092s ok mime/multipart 1.896s ok mime/quotedprintable 0.078s ok net 35.650s ok net/http 32.697s ok net/http/cgi 0.282s ok net/http/cookiejar 0.187s ok net/http/fcgi 0.077s ok net/http/httptest 0.854s ok net/http/httptrace 0.067s panic: test timed out after 6m0s goroutine 1127 [running]: testing.(*M).startAlarm.func1() /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:1382 +0xbc created by time.goFunc /usr/glenda/tmp/workdir-pi3plus2/go/src/time/sleep.go:169 +0x34 goroutine 1 [chan receive, 5 minutes]: testing.(*T).Run(0x108d2640, 0x2d33c9, 0x1f, 0x2e3f80, 0x1) /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:961 +0x2cc testing.runTests.func1(0x108d2000) /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:1207 +0x68 testing.tRunner(0x108d2000, 0x10828f00) /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:909 +0xa0 testing.runTests(0x108ce000, 0x4ecfe8, 0x19, 0x19, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:1205 +0x238 testing.(*M).Run(0x108501c0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:1122 +0x130 main.main() _testmain.go:104 +0x120 goroutine 1105 [chan receive, 5 minutes]: internal/poll.(*asyncIO).Wait(...) /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_io_plan9.go:84 internal/poll.(*FD).Read(0x10866ee0, 0x109a0738, 0x10953000, 0x1000, 0x1000, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_plan9.go:73 +0x11c net.(*netFD).Read(0x10866ee0, 0x10953000, 0x1000, 0x1000, 0x0, 0x42, 0x56d800) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/fd_plan9.go:86 +0xbc net.(*conn).Read(0x109a06f8, 0x10953000, 0x1000, 0x1000, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/net.go:177 +0x58 net/http.(*persistConn).Read(0x10920280, 0x10953000, 0x1000, 0x1000, 0x2e601, 0x0, 0x48) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transport.go:1609 +0x164 bufio.(*Reader).Read(0x109a8ba0, 0x10a70000, 0x29, 0x8000, 0x108be3a0, 0x5066c0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/bufio/bufio.go:223 +0x21c io.(*LimitedReader).Read(0x109ac450, 0x10a70000, 0x8000, 0x8000, 0xbc80c, 0x225df0, 0x4) /usr/glenda/tmp/workdir-pi3plus2/go/src/io/io.go:448 +0xbc net/http.(*body).readLocked(0x109a8bd0, 0x10a70000, 0x8000, 0x8000, 0x231480, 0x109a8c08, 0xffffffff) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transfer.go:847 +0x4c net/http.(*body).Read(0x109a8bd0, 0x10a70000, 0x8000, 0x8000, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transfer.go:839 +0xc0 net/http.(*bodyEOFSignal).Read(0x109a8c00, 0x10a70000, 0x8000, 0x8000, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transport.go:2441 +0xb0 net/http/httputil.(*ReverseProxy).copyBuffer(0x1081aae0, 0x30844198, 0x10b56000, 0x335c80, 0x109a8c00, 0x10a70000, 0x8000, 0x8000, 0x335c80, 0x2cca21, ...) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/httputil/reverseproxy.go:405 +0x78 net/http/httputil.(*ReverseProxy).copyResponse(0x1081aae0, 0x30844198, 0x10b56000, 0x335c80, 0x109a8c00, 0x0, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/httputil/reverseproxy.go:393 +0xa0 net/http/httputil.(*ReverseProxy).ServeHTTP(0x1081aae0, 0x338438, 0x10b56000, 0x108e2a80) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/httputil/reverseproxy.go:286 +0x6a0 net/http/httputil.TestReverseProxy_PanicBodyError(0x108d2640) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/httputil/reverseproxy_test.go:1010 +0x20c testing.tRunner(0x108d2640, 0x2e3f80) /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:909 +0xa0 created by testing.(*T).Run /usr/glenda/tmp/workdir-pi3plus2/go/src/testing/testing.go:960 +0x2ac goroutine 1093 [select, 5 minutes]: net/http.(*persistConn).writeLoop(0x10920280) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transport.go:2061 +0xb8 created by net/http.(*Transport).dialConn /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transport.go:1432 +0x910 goroutine 1108 [sync.Cond.Wait, 5 minutes]: runtime.goparkunlock(...) /usr/glenda/tmp/workdir-pi3plus2/go/src/runtime/proc.go:310 sync.runtime_notifyListWait(0x108bf548, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/runtime/sema.go:510 +0x150 sync.(*Cond).Wait(0x108bf540) /usr/glenda/tmp/workdir-pi3plus2/go/src/sync/cond.go:56 +0x6c net/http.(*connReader).abortPendingRead(0x108bf520) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/server.go:725 +0x8c net/http.(*response).finishRequest(0x108f82d0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/server.go:1590 +0x90 net/http.(*conn).serve(0x109cc240, 0x338918, 0x108bf4a0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/server.go:1895 +0x804 created by net/http.(*Server).Serve /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/server.go:2925 +0x2dc goroutine 1107 [syscall, 5 minutes]: syscall.Syscall(0xe, 0x108e0a80, 0x0, 0x0, 0x13, 0x0, 0x0, 0xffffffff) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/asm_plan9_arm.s:16 +0x8 syscall.open(0x108e0a60, 0x12, 0x0, 0xffffffff, 0x0, 0x104f14) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/zsyscall_plan9_arm.go:61 +0x78 syscall.Open(0x108e0a60, 0x12, 0x0, 0x6ae48, 0x4ef208, 0x2cab8f) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/syscall_plan9.go:372 +0x64 os.openFileNolog(0x108e0a60, 0x12, 0x0, 0x0, 0x2, 0x108e0a60, 0x12) /usr/glenda/tmp/workdir-pi3plus2/go/src/os/file_plan9.go:113 +0x308 os.OpenFile(0x108e0a60, 0x12, 0x0, 0x0, 0x7, 0x108e0a60, 0x12) /usr/glenda/tmp/workdir-pi3plus2/go/src/os/file.go:296 +0x48 os.Open(...) /usr/glenda/tmp/workdir-pi3plus2/go/src/os/file.go:276 net.(*netFD).acceptPlan9(0x10b70f50, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/ipsock_plan9.go:250 +0xe8 net.(*TCPListener).accept(0x10816550, 0x339808, 0x10818e20, 0x37d88) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/tcpsock_plan9.go:43 +0x20 net.(*TCPListener).Accept(0x10816550, 0x10b02f6c, 0xc, 0x108c5500, 0x21dd0c) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/tcpsock.go:261 +0x48 net/http.(*Server).Serve(0x109b0ab0, 0x338318, 0x10816550, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/server.go:2894 +0x20c net/http/httptest.(*Server).goServe.func1(0x10b632c0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/httptest/server.go:298 +0x5c created by net/http/httptest.(*Server).goServe /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/httptest/server.go:296 +0x48 goroutine 1095 [syscall, 5 minutes, locked to thread]: syscall.Syscall6(0x32, 0x7, 0x10953000, 0x1000, 0xffffffff, 0xffffffff, 0x0, 0x1089c8d0, 0x68fbc, 0xe, ...) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/asm_plan9_arm.s:51 +0x8 syscall.Pread(0x7, 0x10953000, 0x1000, 0x1000, 0xffffffff, 0xffffffff, 0x2e690, 0x68c94, 0x68c98) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/zsyscall_plan9_arm.go:218 +0x58 syscall.Read(...) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/syscall_plan9.go:164 os.(*File).read(0x109a06e0, 0x10953000, 0x1000, 0x1000, 0x0, 0x0, 0x7a384) /usr/glenda/tmp/workdir-pi3plus2/go/src/os/file_plan9.go:248 +0x50 os.(*File).Read(0x109a06e0, 0x10953000, 0x1000, 0x1000, 0x109ac484, 0xffffffff, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/os/file.go:112 +0x60 internal/poll.newAsyncIO.func1(0x109ac480, 0x109a0738, 0x10953000, 0x1000, 0x1000) /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_io_plan9.go:54 +0x6c created by internal/poll.newAsyncIO /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_io_plan9.go:43 +0xa0 goroutine 1078 [syscall, 5 minutes, locked to thread]: syscall.Syscall6(0x32, 0xa, 0x108bf52d, 0x1, 0xffffffff, 0xffffffff, 0x0, 0x10996640, 0x68fbc, 0xe, ...) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/asm_plan9_arm.s:51 +0x8 syscall.Pread(0xa, 0x108bf52d, 0x1, 0x1, 0xffffffff, 0xffffffff, 0x2e690, 0x68c94, 0x68c98) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/zsyscall_plan9_arm.go:218 +0x58 syscall.Read(...) /usr/glenda/tmp/workdir-pi3plus2/go/src/syscall/syscall_plan9.go:164 os.(*File).read(0x10818e08, 0x108bf52d, 0x1, 0x1, 0x0, 0x0, 0x7a384) /usr/glenda/tmp/workdir-pi3plus2/go/src/os/file_plan9.go:248 +0x50 os.(*File).Read(0x10818e08, 0x108bf52d, 0x1, 0x1, 0x1099a3b4, 0xffffffff, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/os/file.go:112 +0x60 internal/poll.newAsyncIO.func1(0x1099a3b0, 0x109904e8, 0x108bf52d, 0x1, 0x1) /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_io_plan9.go:54 +0x6c created by internal/poll.newAsyncIO /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_io_plan9.go:43 +0xa0 goroutine 1092 [select, 5 minutes]: net/http.(*persistConn).readLoop(0x10920280) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transport.go:1883 +0x768 created by net/http.(*Transport).dialConn /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/transport.go:1431 +0x8f4 goroutine 1125 [chan receive, 5 minutes]: internal/poll.(*asyncIO).Wait(...) /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_io_plan9.go:84 internal/poll.(*FD).Read(0x10b71030, 0x109904e8, 0x108bf52d, 0x1, 0x1, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/internal/poll/fd_plan9.go:73 +0x11c net.(*netFD).Read(0x10b71030, 0x108bf52d, 0x1, 0x1, 0x1084f280, 0x10906fc8, 0x1000) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/fd_plan9.go:86 +0xbc net.(*conn).Read(0x10818e20, 0x108bf52d, 0x1, 0x1, 0x0, 0x0, 0x0) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/net.go:177 +0x58 net/http.(*connReader).backgroundRead(0x108bf520) /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/server.go:677 +0x44 created by net/http.(*connReader).startBackgroundRead /usr/glenda/tmp/workdir-pi3plus2/go/src/net/http/server.go:673 +0xb0 FAIL net/http/httputil 360.171s FAIL 2019/06/06 21:52:57 Failed: exit status: 'go 19302: 1'