plan9-arm at 6197104c14dc6e72a368f9b5d3d2a14381f5e456 building crypto at 1b76d66859c6111b3d5c3ea6600ea44dc188bf12 testing in module mode; GOMOD=/boot/glenda/workdir-pi3plus1/gopath/src/golang.org/x/crypto/go.mod :: Running /boot/glenda/workdir-pi3plus1/go/bin/go with args ["/boot/glenda/workdir-pi3plus1/go/bin/go" "test" "-short" "golang.org/x/crypto/..."] and env ["home=/usr/glenda" "GOPATH=/usr/glenda/gopath" "path=/boot/glenda/workdir-pi3plus1/go/bin\x00.\x00/bin" "type=host-plan9-arm-0intro" "GOARM=7" "GO_BUILD_KEY_DELETE_AFTER_READ=false" "status=" "GOROOT_BOOTSTRAP=/boot/glenda/workdir-pi3plus1/go1.4" "objtype=arm" "*=" "i=" "WORKDIR=/boot/glenda/workdir-pi3plus1" "GO_BUILDER_NAME=plan9-arm" "GOROOT=/boot/glenda/workdir-pi3plus1/go" "GOPATH=/boot/glenda/workdir-pi3plus1/gopath" "GOPROXY=http://10.240.0.90:30157" "GOPROXY=https://proxy.golang.org" "GOROOT_BOOTSTRAP=/usr/glenda/go"] in dir /boot/glenda/workdir-pi3plus1/gopath/src/golang.org/x/crypto go: downloading golang.org/x/net v0.0.0-20190404232315-eb5bcb51f2a3 go: downloading golang.org/x/text v0.3.0 ok golang.org/x/crypto/acme 12.850s 2020/03/19 05:47:08 GET / 2020/03/19 05:47:08 POST /new-reg 2020/03/19 05:47:08 POST /new-order 2020/03/19 05:47:08 POST /authz/example.org 2020/03/19 05:47:08 POST /challenge/tls-alpn-01/example.org 2020/03/19 05:47:08 POST /authz/example.org 2020/03/19 05:47:08 validated "tls-alpn-01" for "example.org"; authz status is now: valid 2020/03/19 05:47:08 order 0 is now ready 2020/03/19 05:47:09 POST /authz/example.org 2020/03/19 05:47:09 POST /orders/0 2020/03/19 05:47:09 POST /new-cert/0 2020/03/19 05:47:09 HEAD /new-nonce 2020/03/19 05:47:09 POST /authz/example.org 2020/03/19 05:47:09 POST /issued-cert/0 2020/03/19 05:47:14 httptest.Server blocked in Close after 5 seconds, waiting for connections: *tls.Conn 0x10e07000 127.0.0.1:44043 in state active panic: test timed out after 10m0s goroutine 1004 [running]: testing.(*M).startAlarm.func1() /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:1492 +0xbc created by time.goFunc /boot/glenda/workdir-pi3plus1/go/src/time/sleep.go:169 +0x34 goroutine 1 [chan receive, 9 minutes]: testing.(*T).Run(0x10c9e500, 0x3ce36c, 0xc, 0x3ee2d0, 0x301) /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:1045 +0x2d0 testing.runTests.func1(0x10c9e0a0) /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:1313 +0x68 testing.tRunner(0x10c9e0a0, 0x10c28ec8) /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:993 +0xbc testing.runTests(0x10c161d0, 0x6dce08, 0x1a, 0x1a, 0x3ad03bdd, 0xbf94e04c, 0xb4722f9e, 0x8b, 0x6e0a58, 0x10c842d0) /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:1311 +0x258 testing.(*M).Run(0x10c842d0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:1221 +0x16c main.main() _testmain.go:95 +0x120 goroutine 897 [semacquire, 9 minutes]: sync.runtime_Semacquire(0x10ed3e68) /boot/glenda/workdir-pi3plus1/go/src/runtime/sema.go:56 +0x34 sync.(*WaitGroup).Wait(0x10ed3e60) /boot/glenda/workdir-pi3plus1/go/src/sync/waitgroup.go:130 +0x84 net/http/httptest.(*Server).Close(0x10ed3e40) /boot/glenda/workdir-pi3plus1/go/src/net/http/httptest/server.go:249 +0x1cc golang.org/x/crypto/acme/autocert.TestEndToEnd(0x10c9e500) /boot/glenda/workdir-pi3plus1/gopath/src/golang.org/x/crypto/acme/autocert/autocert_test.go:1232 +0x550 testing.tRunner(0x10c9e500, 0x3ee2d0) /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:993 +0xbc created by testing.(*T).Run /boot/glenda/workdir-pi3plus1/go/src/testing/testing.go:1044 +0x2b0 goroutine 1018 [syscall, 9 minutes, locked to thread]: syscall.Syscall6(0x32, 0x9, 0x10d6f000, 0x7b6, 0xffffffff, 0xffffffff, 0x0, 0xe, 0x10fce620, 0x0, ...) /boot/glenda/workdir-pi3plus1/go/src/syscall/asm_plan9_arm.s:51 +0x8 syscall.Pread(0x9, 0x10d6f000, 0x7b6, 0x7b6, 0xffffffff, 0xffffffff, 0x4, 0x18, 0x0) /boot/glenda/workdir-pi3plus1/go/src/syscall/zsyscall_plan9_arm.go:218 +0x58 syscall.Read(...) /boot/glenda/workdir-pi3plus1/go/src/syscall/syscall_plan9.go:166 os.(*File).read(0x10c19608, 0x10d6f000, 0x7b6, 0x7b6, 0x87194, 0x18, 0x0) /boot/glenda/workdir-pi3plus1/go/src/os/file_plan9.go:248 +0x50 os.(*File).Read(0x10c19608, 0x10d6f000, 0x7b6, 0x7b6, 0x1100d254, 0xffffffff, 0x0) /boot/glenda/workdir-pi3plus1/go/src/os/file.go:116 +0x60 internal/poll.newAsyncIO.func1(0x1100d250, 0x10c19e08, 0x10d6f000, 0x7b6, 0x7b6) /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_io_plan9.go:54 +0x6c created by internal/poll.newAsyncIO /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_io_plan9.go:43 +0xa0 goroutine 974 [chan receive, 9 minutes]: internal/poll.(*asyncIO).Wait(...) /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_io_plan9.go:84 internal/poll.(*FD).Read(0x10ee5110, 0x10e05900, 0x10f00240, 0x205, 0x205, 0x0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_plan9.go:73 +0x124 net.(*netFD).Read(0x10ee5110, 0x10f00240, 0x205, 0x205, 0x3f028, 0x10da4208, 0xd1cc) /boot/glenda/workdir-pi3plus1/go/src/net/fd_plan9.go:86 +0xb0 net.(*conn).Read(0x10e05410, 0x10f00240, 0x205, 0x205, 0x0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/net/net.go:184 +0x6c crypto/tls.(*atLeastReader).Read(0x110910a0, 0x10f00240, 0x205, 0x205, 0x9858, 0x1e879c, 0x10ac4d20) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:760 +0x78 bytes.(*Buffer).ReadFrom(0x10e07160, 0x465d68, 0x110910a0, 0x3, 0x1e72b0, 0x37ea10, 0x3bbdd0) /boot/glenda/workdir-pi3plus1/go/src/bytes/buffer.go:204 +0xa8 crypto/tls.(*Conn).readFromUntil(0x10e07000, 0x10ac4d20, 0x10e05410, 0x5, 0x10e05410, 0x731c4) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:782 +0xc4 crypto/tls.(*Conn).readRecordOrCCS(0x10e07000, 0x0, 0x0, 0x63458) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:589 +0xfc crypto/tls.(*Conn).readRecord(...) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:557 crypto/tls.(*Conn).Read(0x10e07000, 0x10f3bc6d, 0x1, 0x1, 0x0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:1233 +0x14c net/http.(*connReader).backgroundRead(0x10f3bc60) /boot/glenda/workdir-pi3plus1/go/src/net/http/server.go:678 +0x44 created by net/http.(*connReader).startBackgroundRead /boot/glenda/workdir-pi3plus1/go/src/net/http/server.go:674 +0xc0 goroutine 1015 [chan receive, 9 minutes]: internal/poll.(*asyncIO).Wait(...) /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_io_plan9.go:84 internal/poll.(*FD).Read(0x10e3e5b0, 0x10c19e08, 0x10d6f000, 0x7b6, 0x7b6, 0x0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_plan9.go:73 +0x124 net.(*netFD).Read(0x10e3e5b0, 0x10d6f000, 0x7b6, 0x7b6, 0x92c18, 0xcb6c, 0xd1cc) /boot/glenda/workdir-pi3plus1/go/src/net/fd_plan9.go:86 +0xb0 net.(*conn).Read(0x10c19620, 0x10d6f000, 0x7b6, 0x7b6, 0x0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/net/net.go:184 +0x6c crypto/tls.(*atLeastReader).Read(0x1100d240, 0x10d6f000, 0x7b6, 0x7b6, 0x9858, 0x1e879c, 0x10ac4d20) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:760 +0x78 bytes.(*Buffer).ReadFrom(0x10d2cb60, 0x465d68, 0x1100d240, 0x11430, 0x1e72b0, 0x37ea10, 0x3bbdd0) /boot/glenda/workdir-pi3plus1/go/src/bytes/buffer.go:204 +0xa8 crypto/tls.(*Conn).readFromUntil(0x10d2ca00, 0x10ac4d20, 0x10c19620, 0x5, 0x10c19620, 0x10ddbc78) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:782 +0xc4 crypto/tls.(*Conn).readRecordOrCCS(0x10d2ca00, 0x0, 0x0, 0x54f0) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:589 +0xfc crypto/tls.(*Conn).readRecord(...) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:557 crypto/tls.(*Conn).Read(0x10d2ca00, 0x10d53000, 0x1000, 0x1000, 0x0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/crypto/tls/conn.go:1233 +0x14c net/http.(*persistConn).Read(0x10c9e5a0, 0x10d53000, 0x1000, 0x1000, 0x10d7ee80, 0x298840, 0x10d7ee80) /boot/glenda/workdir-pi3plus1/go/src/net/http/transport.go:1827 +0x16c bufio.(*Reader).fill(0x1101f4d0) /boot/glenda/workdir-pi3plus1/go/src/bufio/bufio.go:100 +0x108 bufio.(*Reader).Peek(0x1101f4d0, 0x1, 0x0, 0x0, 0x1, 0x10d7ee00, 0x0) /boot/glenda/workdir-pi3plus1/go/src/bufio/bufio.go:138 +0x38 net/http.(*persistConn).readLoop(0x10c9e5a0) /boot/glenda/workdir-pi3plus1/go/src/net/http/transport.go:1980 +0x15c created by net/http.(*Transport).dialConn /boot/glenda/workdir-pi3plus1/go/src/net/http/transport.go:1649 +0x9b8 goroutine 904 [sync.Cond.Wait, 9 minutes]: runtime.goparkunlock(...) /boot/glenda/workdir-pi3plus1/go/src/runtime/proc.go:311 sync.runtime_notifyListWait(0x10f3bc88, 0x0) /boot/glenda/workdir-pi3plus1/go/src/runtime/sema.go:513 +0x154 sync.(*Cond).Wait(0x10f3bc80) /boot/glenda/workdir-pi3plus1/go/src/sync/cond.go:56 +0x6c net/http.(*connReader).abortPendingRead(0x10f3bc60) /boot/glenda/workdir-pi3plus1/go/src/net/http/server.go:726 +0x90 net/http.(*response).finishRequest(0x10d26a20) /boot/glenda/workdir-pi3plus1/go/src/net/http/server.go:1596 +0x90 net/http.(*conn).serve(0x10c8f2c0, 0x4696f0, 0x10f3bc40) /boot/glenda/workdir-pi3plus1/go/src/net/http/server.go:1900 +0x808 created by net/http.(*Server).Serve /boot/glenda/workdir-pi3plus1/go/src/net/http/server.go:2934 +0x2d0 goroutine 899 [syscall, 9 minutes]: syscall.Syscall(0xe, 0x10ea8480, 0x0, 0x0, 0x12, 0x0, 0x0, 0x6c674) /boot/glenda/workdir-pi3plus1/go/src/syscall/asm_plan9_arm.s:16 +0x8 syscall.open(0x10ea8460, 0x11, 0x0, 0x0, 0x12b3a8, 0x6e0688) /boot/glenda/workdir-pi3plus1/go/src/syscall/zsyscall_plan9_arm.go:61 +0x78 syscall.Open(0x10ea8460, 0x11, 0x0, 0x6e0688, 0x3ee864, 0x745a8) /boot/glenda/workdir-pi3plus1/go/src/syscall/syscall_plan9.go:382 +0x64 os.openFileNolog(0x10ea8460, 0x11, 0x0, 0x0, 0x2, 0x10ea8460, 0x11) /boot/glenda/workdir-pi3plus1/go/src/os/file_plan9.go:113 +0x28c os.OpenFile(0x10ea8460, 0x11, 0x0, 0x0, 0x7, 0x10ea8460, 0x11) /boot/glenda/workdir-pi3plus1/go/src/os/file.go:307 +0x48 os.Open(...) /boot/glenda/workdir-pi3plus1/go/src/os/file.go:287 net.(*netFD).acceptPlan9(0x10ee4e00, 0x0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/net/ipsock_plan9.go:250 +0xe0 net.(*TCPListener).accept(0x10f7fff0, 0x46ada0, 0x10d80878, 0x3fd7c) /boot/glenda/workdir-pi3plus1/go/src/net/tcpsock_plan9.go:48 +0x20 net.(*TCPListener).Accept(0x10f7fff0, 0x10e8cf40, 0xc, 0x10e12a80, 0x285530) /boot/glenda/workdir-pi3plus1/go/src/net/tcpsock.go:261 +0x68 net/http.(*Server).Serve(0x10c64e10, 0x468cb0, 0x10f7fff0, 0x0, 0x0) /boot/glenda/workdir-pi3plus1/go/src/net/http/server.go:2902 +0x1fc net/http/httptest.(*Server).goServe.func1(0x10ed3d80) /boot/glenda/workdir-pi3plus1/go/src/net/http/httptest/server.go:308 +0x60 created by net/http/httptest.(*Server).goServe /boot/glenda/workdir-pi3plus1/go/src/net/http/httptest/server.go:306 +0x48 goroutine 1016 [select, 9 minutes]: net/http.(*persistConn).writeLoop(0x10c9e5a0) /boot/glenda/workdir-pi3plus1/go/src/net/http/transport.go:2279 +0xc4 created by net/http.(*Transport).dialConn /boot/glenda/workdir-pi3plus1/go/src/net/http/transport.go:1650 +0x9d4 goroutine 958 [syscall, 9 minutes, locked to thread]: syscall.Syscall6(0x32, 0xb, 0x10f00240, 0x205, 0xffffffff, 0xffffffff, 0x0, 0xe, 0x10eabf77, 0x0, ...) /boot/glenda/workdir-pi3plus1/go/src/syscall/asm_plan9_arm.s:51 +0x8 syscall.Pread(0xb, 0x10f00240, 0x205, 0x205, 0xffffffff, 0xffffffff, 0x4, 0x18, 0x0) /boot/glenda/workdir-pi3plus1/go/src/syscall/zsyscall_plan9_arm.go:218 +0x58 syscall.Read(...) /boot/glenda/workdir-pi3plus1/go/src/syscall/syscall_plan9.go:166 os.(*File).read(0x10e053f8, 0x10f00240, 0x205, 0x205, 0x87194, 0x18, 0x0) /boot/glenda/workdir-pi3plus1/go/src/os/file_plan9.go:248 +0x50 os.(*File).Read(0x10e053f8, 0x10f00240, 0x205, 0x205, 0x110910b4, 0xffffffff, 0x0) /boot/glenda/workdir-pi3plus1/go/src/os/file.go:116 +0x60 internal/poll.newAsyncIO.func1(0x110910b0, 0x10e05900, 0x10f00240, 0x205, 0x205) /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_io_plan9.go:54 +0x6c created by internal/poll.newAsyncIO /boot/glenda/workdir-pi3plus1/go/src/internal/poll/fd_io_plan9.go:43 +0xa0 FAIL golang.org/x/crypto/acme/autocert 600.111s ? golang.org/x/crypto/acme/autocert/internal/acmetest [no test files] ? golang.org/x/crypto/acme/internal/acmeprobe [no test files] ok golang.org/x/crypto/argon2 1.089s ok golang.org/x/crypto/bcrypt 2.392s ok golang.org/x/crypto/blake2b 0.227s ok golang.org/x/crypto/blake2s 0.146s ok golang.org/x/crypto/blowfish 0.075s ok golang.org/x/crypto/bn256 5.778s ok golang.org/x/crypto/cast5 0.073s ok golang.org/x/crypto/chacha20 0.140s ok golang.org/x/crypto/chacha20poly1305 4.208s ok golang.org/x/crypto/cryptobyte 0.069s ? golang.org/x/crypto/cryptobyte/asn1 [no test files] ok golang.org/x/crypto/curve25519 0.981s ok golang.org/x/crypto/ed25519 0.930s ? golang.org/x/crypto/ed25519/internal/edwards25519 [no test files] ok golang.org/x/crypto/hkdf 0.059s ok golang.org/x/crypto/internal/subtle 0.069s ok golang.org/x/crypto/internal/wycheproof 118.423s ? golang.org/x/crypto/internal/wycheproof/internal/dsa [no test files] ? golang.org/x/crypto/internal/wycheproof/internal/ecdsa [no test files] ok golang.org/x/crypto/md4 0.069s ok golang.org/x/crypto/nacl/auth 0.059s ok golang.org/x/crypto/nacl/box 0.471s ok golang.org/x/crypto/nacl/secretbox 0.059s ok golang.org/x/crypto/nacl/sign 0.069s ok golang.org/x/crypto/ocsp 0.418s ok golang.org/x/crypto/openpgp 69.891s ok golang.org/x/crypto/openpgp/armor 0.053s ok golang.org/x/crypto/openpgp/clearsign 0.219s ok golang.org/x/crypto/openpgp/elgamal 0.103s ? golang.org/x/crypto/openpgp/errors [no test files] ok golang.org/x/crypto/openpgp/packet 2.196s ok golang.org/x/crypto/openpgp/s2k 65.128s ok golang.org/x/crypto/otr 4.990s ok golang.org/x/crypto/pbkdf2 0.346s ok golang.org/x/crypto/pkcs12 0.286s ok golang.org/x/crypto/pkcs12/internal/rc2 0.060s ok golang.org/x/crypto/poly1305 0.102s ok golang.org/x/crypto/ripemd160 0.217s ok golang.org/x/crypto/salsa20 0.073s ok golang.org/x/crypto/salsa20/salsa 0.054s ok golang.org/x/crypto/scrypt 3.013s ok golang.org/x/crypto/sha3 0.590s ok golang.org/x/crypto/ssh 88.224s ok golang.org/x/crypto/ssh/agent 16.271s ok golang.org/x/crypto/ssh/internal/bcrypt_pbkdf 0.936s ok golang.org/x/crypto/ssh/knownhosts 0.080s ok golang.org/x/crypto/ssh/terminal 0.075s ok golang.org/x/crypto/ssh/test 1.170s ok golang.org/x/crypto/tea 0.072s ok golang.org/x/crypto/twofish 0.108s ok golang.org/x/crypto/xtea 0.063s ok golang.org/x/crypto/xts 0.056s FAIL