plan9-arm at 08bf64a81e4c3e2199d0e879089880f538fafbb9 building crypto at 729f1e841bcca28c2cd9f4034d6f7672604dbeda testing in module mode; GOMOD=/boot/workdir/gopath/src/golang.org/x/crypto/go.mod :: Running /boot/workdir/go/bin/go with args ["/boot/workdir/go/bin/go" "test" "-short" "golang.org/x/crypto/..."] and env ["home=/usr/glenda" "path=/boot/workdir/go/bin\x00.\x00/bin" "type=host-plan9-arm-0intro" "GOARM=7" "GO_BUILD_KEY_DELETE_AFTER_READ=false" "status=" "GO_TEST_TIMEOUT_SCALE=6" "fs=aoe" "GOCACHE=/boot/cache" "GOROOT_BOOTSTRAP=/boot/workdir/go1.4" "workdir=/boot/workdir" "objtype=arm" "*=" "WORKDIR=/boot/workdir" "i=" "GO_BUILDER_NAME=plan9-arm" "GOROOT=/boot/workdir/go" "GOPATH=/boot/workdir/gopath" "GOPROXY=http://10.240.0.39:30157" "GOPROXY=https://proxy.golang.org" "GOROOT_BOOTSTRAP=/usr/glenda/go"] in dir /boot/workdir/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 13.710s 2020/05/02 16:42:28 GET / 2020/05/02 16:42:28 POST /new-reg 2020/05/02 16:42:28 POST /new-order 2020/05/02 16:42:28 POST /authz/example.org 2020/05/02 16:42:28 POST /challenge/tls-alpn-01/example.org 2020/05/02 16:42:28 POST /authz/example.org 2020/05/02 16:42:28 validated "tls-alpn-01" for "example.org"; authz status is now: valid 2020/05/02 16:42:28 order 0 is now ready 2020/05/02 16:42:29 POST /authz/example.org 2020/05/02 16:42:29 POST /orders/0 2020/05/02 16:42:29 POST /new-cert/0 2020/05/02 16:42:29 HEAD /new-nonce 2020/05/02 16:42:29 POST /authz/example.org 2020/05/02 16:42:29 POST /issued-cert/0 2020/05/02 16:42:34 httptest.Server blocked in Close after 5 seconds, waiting for connections: *tls.Conn 0x10d39000 127.0.0.1:58122 in state active panic: test timed out after 10m0s goroutine 1010 [running]: testing.(*M).startAlarm.func1() /boot/workdir/go/src/testing/testing.go:1534 +0xbc created by time.goFunc /boot/workdir/go/src/time/sleep.go:167 +0x34 goroutine 1 [chan receive, 9 minutes]: testing.(*T).Run(0x11228780, 0x3c1781, 0xc, 0x3e1608, 0x301) /boot/workdir/go/src/testing/testing.go:1087 +0x2d0 testing.runTests.func1(0x10cca000) /boot/workdir/go/src/testing/testing.go:1355 +0x68 testing.tRunner(0x10cca000, 0x10c28ec8) /boot/workdir/go/src/testing/testing.go:1035 +0xbc testing.runTests(0x10c161d0, 0x6c8a58, 0x1a, 0x1a, 0x26fe4c6, 0xbfa383ad, 0xb4667592, 0x8b, 0x6cc830, 0x10c862d0) /boot/workdir/go/src/testing/testing.go:1353 +0x258 testing.(*M).Run(0x10c862d0, 0x0) /boot/workdir/go/src/testing/testing.go:1263 +0x16c main.main() _testmain.go:95 +0x120 goroutine 1027 [syscall, 9 minutes, locked to thread]: syscall.Syscall6(0x32, 0x8, 0x10cfe800, 0x7d4, 0xffffffff, 0xffffffff, 0x0, 0xe, 0x10fa9ed0, 0x0, ...) /boot/workdir/go/src/syscall/asm_plan9_arm.s:51 +0x8 syscall.Pread(0x8, 0x10cfe800, 0x7d4, 0x7d4, 0xffffffff, 0xffffffff, 0x4, 0x18, 0x0) /boot/workdir/go/src/syscall/zsyscall_plan9_arm.go:218 +0x58 syscall.Read(...) /boot/workdir/go/src/syscall/syscall_plan9.go:166 os.(*File).read(0x10fcc3c8, 0x10cfe800, 0x7d4, 0x7d4, 0x89958, 0x18, 0x0) /boot/workdir/go/src/os/file_plan9.go:247 +0x50 os.(*File).Read(0x10fcc3c8, 0x10cfe800, 0x7d4, 0x7d4, 0x10da5b74, 0xffffffff, 0x0) /boot/workdir/go/src/os/file.go:116 +0x60 internal/poll.newAsyncIO.func1(0x10da5b70, 0x10fccfa0, 0x10cfe800, 0x7d4, 0x7d4) /boot/workdir/go/src/internal/poll/fd_io_plan9.go:54 +0x6c created by internal/poll.newAsyncIO /boot/workdir/go/src/internal/poll/fd_io_plan9.go:43 +0xa0 goroutine 906 [semacquire, 9 minutes]: sync.runtime_Semacquire(0x10e5c8e8) /boot/workdir/go/src/runtime/sema.go:56 +0x34 sync.(*WaitGroup).Wait(0x10e5c8e0) /boot/workdir/go/src/sync/waitgroup.go:130 +0x84 net/http/httptest.(*Server).Close(0x10e5c8c0) /boot/workdir/go/src/net/http/httptest/server.go:249 +0x1cc golang.org/x/crypto/acme/autocert.TestEndToEnd(0x11228780) /boot/workdir/gopath/src/golang.org/x/crypto/acme/autocert/autocert_test.go:1232 +0x540 testing.tRunner(0x11228780, 0x3e1608) /boot/workdir/go/src/testing/testing.go:1035 +0xbc created by testing.(*T).Run /boot/workdir/go/src/testing/testing.go:1086 +0x2b0 goroutine 1025 [select, 9 minutes]: net/http.(*persistConn).writeLoop(0x10f041e0) /boot/workdir/go/src/net/http/transport.go:2279 +0xc4 created by net/http.(*Transport).dialConn /boot/workdir/go/src/net/http/transport.go:1650 +0x9d4 goroutine 908 [syscall, 9 minutes]: syscall.Syscall(0xe, 0x10d10940, 0x0, 0x0, 0x13, 0x0, 0x0, 0x6d798) /boot/workdir/go/src/syscall/asm_plan9_arm.s:16 +0x8 syscall.open(0x10d10920, 0x12, 0x0, 0x0, 0x12dd5c, 0x6cc450) /boot/workdir/go/src/syscall/zsyscall_plan9_arm.go:61 +0x78 syscall.Open(0x10d10920, 0x12, 0x0, 0x6cc450, 0x3e1b98, 0x75654) /boot/workdir/go/src/syscall/syscall_plan9.go:382 +0x64 os.openFileNolog(0x10d10920, 0x12, 0x0, 0x0, 0x2, 0x10d10920, 0x12) /boot/workdir/go/src/os/file_plan9.go:113 +0x28c os.OpenFile(0x10d10920, 0x12, 0x0, 0x0, 0x7, 0x10d10920, 0x12) /boot/workdir/go/src/os/file.go:307 +0x48 os.Open(...) /boot/workdir/go/src/os/file.go:287 net.(*netFD).acceptPlan9(0x10ebccb0, 0x0, 0x0, 0x0) /boot/workdir/go/src/net/ipsock_plan9.go:250 +0xe0 net.(*TCPListener).accept(0x10f0bc80, 0x460378, 0x11058698, 0x3f420) /boot/workdir/go/src/net/tcpsock_plan9.go:48 +0x20 net.(*TCPListener).Accept(0x10f0bc80, 0x10e04f38, 0xc, 0x10c01a40, 0x27a08c) /boot/workdir/go/src/net/tcpsock.go:261 +0x68 net/http.(*Server).Serve(0x10e94480, 0x45e5b0, 0x10f0bc80, 0x0, 0x0) /boot/workdir/go/src/net/http/server.go:2907 +0x1fc net/http/httptest.(*Server).goServe.func1(0x10fcefc0) /boot/workdir/go/src/net/http/httptest/server.go:308 +0x60 created by net/http/httptest.(*Server).goServe /boot/workdir/go/src/net/http/httptest/server.go:306 +0x48 goroutine 976 [chan receive, 9 minutes]: internal/poll.(*asyncIO).Wait(...) /boot/workdir/go/src/internal/poll/fd_io_plan9.go:84 internal/poll.(*FD).Read(0x10dd81c0, 0x10fccfa0, 0x10cfe800, 0x7d4, 0x7d4, 0x0, 0x0, 0x0) /boot/workdir/go/src/internal/poll/fd_plan9.go:73 +0x124 net.(*netFD).Read(0x10dd81c0, 0x10cfe800, 0x7d4, 0x7d4, 0x0, 0x7cf, 0xce88) /boot/workdir/go/src/net/fd_plan9.go:86 +0xb0 net.(*conn).Read(0x10fcc3e0, 0x10cfe800, 0x7d4, 0x7d4, 0x0, 0x0, 0x0) /boot/workdir/go/src/net/net.go:182 +0x6c crypto/tls.(*atLeastReader).Read(0x10da5b60, 0x10cfe800, 0x7d4, 0x7d4, 0x938c, 0x1dd7a0, 0x10b54310) /boot/workdir/go/src/crypto/tls/conn.go:774 +0x78 bytes.(*Buffer).ReadFrom(0x10cc2164, 0x45b8b8, 0x10da5b60, 0x10cfe805, 0x1db064, 0x371c08, 0x3af570) /boot/workdir/go/src/bytes/buffer.go:204 +0xa4 crypto/tls.(*Conn).readFromUntil(0x10cc2000, 0x10b54310, 0x10fcc3e0, 0x5, 0x10fcc3e0, 0x76) /boot/workdir/go/src/crypto/tls/conn.go:796 +0xc4 crypto/tls.(*Conn).readRecordOrCCS(0x10cc2000, 0x0, 0x0, 0x5440) /boot/workdir/go/src/crypto/tls/conn.go:603 +0xfc crypto/tls.(*Conn).readRecord(...) /boot/workdir/go/src/crypto/tls/conn.go:571 crypto/tls.(*Conn).Read(0x10cc2000, 0x10eb4000, 0x1000, 0x1000, 0x0, 0x0, 0x0) /boot/workdir/go/src/crypto/tls/conn.go:1247 +0x14c net/http.(*persistConn).Read(0x10f041e0, 0x10eb4000, 0x1000, 0x1000, 0x10ead3c0, 0x28d1ac, 0x10ead3c0) /boot/workdir/go/src/net/http/transport.go:1827 +0x16c bufio.(*Reader).fill(0x10c63320) /boot/workdir/go/src/bufio/bufio.go:100 +0x108 bufio.(*Reader).Peek(0x10c63320, 0x1, 0x0, 0x0, 0x1, 0x10ead300, 0x0) /boot/workdir/go/src/bufio/bufio.go:138 +0x38 net/http.(*persistConn).readLoop(0x10f041e0) /boot/workdir/go/src/net/http/transport.go:1980 +0x15c created by net/http.(*Transport).dialConn /boot/workdir/go/src/net/http/transport.go:1649 +0x9b8 goroutine 1002 [syscall, 9 minutes, locked to thread]: syscall.Syscall6(0x32, 0xb, 0x110e8240, 0x205, 0xffffffff, 0xffffffff, 0x0, 0xe, 0x10d974f8, 0x0, ...) /boot/workdir/go/src/syscall/asm_plan9_arm.s:51 +0x8 syscall.Pread(0xb, 0x110e8240, 0x205, 0x205, 0xffffffff, 0xffffffff, 0x4, 0x18, 0x0) /boot/workdir/go/src/syscall/zsyscall_plan9_arm.go:218 +0x58 syscall.Read(...) /boot/workdir/go/src/syscall/syscall_plan9.go:166 os.(*File).read(0x11058220, 0x110e8240, 0x205, 0x205, 0x89958, 0x18, 0x0) /boot/workdir/go/src/os/file_plan9.go:247 +0x50 os.(*File).Read(0x11058220, 0x110e8240, 0x205, 0x205, 0x10c178f4, 0xffffffff, 0x0) /boot/workdir/go/src/os/file.go:116 +0x60 internal/poll.newAsyncIO.func1(0x10c178f0, 0x10e4ccc0, 0x110e8240, 0x205, 0x205) /boot/workdir/go/src/internal/poll/fd_io_plan9.go:54 +0x6c created by internal/poll.newAsyncIO /boot/workdir/go/src/internal/poll/fd_io_plan9.go:43 +0xa0 goroutine 870 [sync.Cond.Wait, 9 minutes]: runtime.goparkunlock(...) /boot/workdir/go/src/runtime/proc.go:312 sync.runtime_notifyListWait(0x10d022a8, 0x0) /boot/workdir/go/src/runtime/sema.go:513 +0x154 sync.(*Cond).Wait(0x10d022a0) /boot/workdir/go/src/sync/cond.go:56 +0x6c net/http.(*connReader).abortPendingRead(0x10d02260) /boot/workdir/go/src/net/http/server.go:726 +0x90 net/http.(*response).finishRequest(0x10d9a510) /boot/workdir/go/src/net/http/server.go:1596 +0x90 net/http.(*conn).serve(0x10eaa120, 0x45ef30, 0x10d02240) /boot/workdir/go/src/net/http/server.go:1900 +0x804 created by net/http.(*Server).Serve /boot/workdir/go/src/net/http/server.go:2939 +0x2d0 goroutine 1041 [chan receive, 9 minutes]: internal/poll.(*asyncIO).Wait(...) /boot/workdir/go/src/internal/poll/fd_io_plan9.go:84 internal/poll.(*FD).Read(0x10d0e0e0, 0x10e4ccc0, 0x110e8240, 0x205, 0x205, 0x0, 0x0, 0x0) /boot/workdir/go/src/internal/poll/fd_plan9.go:73 +0x124 net.(*netFD).Read(0x10d0e0e0, 0x110e8240, 0x205, 0x205, 0x0, 0x0, 0xce88) /boot/workdir/go/src/net/fd_plan9.go:86 +0xb0 net.(*conn).Read(0x11058238, 0x110e8240, 0x205, 0x205, 0x0, 0x0, 0x0) /boot/workdir/go/src/net/net.go:182 +0x6c crypto/tls.(*atLeastReader).Read(0x10c178e0, 0x110e8240, 0x205, 0x205, 0x938c, 0x1dd7a0, 0x10b54310) /boot/workdir/go/src/crypto/tls/conn.go:774 +0x78 bytes.(*Buffer).ReadFrom(0x10d39164, 0x45b8b8, 0x10c178e0, 0x0, 0x1db064, 0x371c08, 0x3af570) /boot/workdir/go/src/bytes/buffer.go:204 +0xa4 crypto/tls.(*Conn).readFromUntil(0x10d39000, 0x10b54310, 0x11058238, 0x5, 0x11058238, 0x0) /boot/workdir/go/src/crypto/tls/conn.go:796 +0xc4 crypto/tls.(*Conn).readRecordOrCCS(0x10d39000, 0x0, 0x0, 0x6451c) /boot/workdir/go/src/crypto/tls/conn.go:603 +0xfc crypto/tls.(*Conn).readRecord(...) /boot/workdir/go/src/crypto/tls/conn.go:571 crypto/tls.(*Conn).Read(0x10d39000, 0x10d0226d, 0x1, 0x1, 0x0, 0x0, 0x0) /boot/workdir/go/src/crypto/tls/conn.go:1247 +0x14c net/http.(*connReader).backgroundRead(0x10d02260) /boot/workdir/go/src/net/http/server.go:678 +0x44 created by net/http.(*connReader).startBackgroundRead /boot/workdir/go/src/net/http/server.go:674 +0xc0 FAIL golang.org/x/crypto/acme/autocert 600.117s ? 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 0.965s ok golang.org/x/crypto/bcrypt 2.395s ok golang.org/x/crypto/blake2b 0.237s ok golang.org/x/crypto/blake2s 0.186s ok golang.org/x/crypto/blowfish 0.076s ok golang.org/x/crypto/bn256 5.962s ok golang.org/x/crypto/cast5 0.073s ok golang.org/x/crypto/chacha20 0.140s ok golang.org/x/crypto/chacha20poly1305 4.103s ok golang.org/x/crypto/cryptobyte 0.089s ? golang.org/x/crypto/cryptobyte/asn1 [no test files] ok golang.org/x/crypto/curve25519 0.949s ok golang.org/x/crypto/ed25519 1.012s ? golang.org/x/crypto/ed25519/internal/edwards25519 [no test files] ok golang.org/x/crypto/hkdf 0.087s ok golang.org/x/crypto/internal/subtle 0.049s ok golang.org/x/crypto/internal/wycheproof 122.218s ? golang.org/x/crypto/internal/wycheproof/internal/dsa [no test files] ok golang.org/x/crypto/md4 0.059s ok golang.org/x/crypto/nacl/auth 0.067s ok golang.org/x/crypto/nacl/box 0.457s ok golang.org/x/crypto/nacl/secretbox 0.063s ok golang.org/x/crypto/nacl/sign 0.072s ok golang.org/x/crypto/ocsp 0.413s ok golang.org/x/crypto/openpgp 62.807s ok golang.org/x/crypto/openpgp/armor 0.053s ok golang.org/x/crypto/openpgp/clearsign 0.243s ok golang.org/x/crypto/openpgp/elgamal 0.104s ? golang.org/x/crypto/openpgp/errors [no test files] ok golang.org/x/crypto/openpgp/packet 2.633s ok golang.org/x/crypto/openpgp/s2k 72.088s ok golang.org/x/crypto/otr 5.376s ok golang.org/x/crypto/pbkdf2 0.392s ok golang.org/x/crypto/pkcs12 0.322s ok golang.org/x/crypto/pkcs12/internal/rc2 0.049s ok golang.org/x/crypto/poly1305 0.165s ok golang.org/x/crypto/ripemd160 0.238s ok golang.org/x/crypto/salsa20 0.073s ok golang.org/x/crypto/salsa20/salsa 0.065s ok golang.org/x/crypto/scrypt 2.925s ok golang.org/x/crypto/sha3 0.458s ok golang.org/x/crypto/ssh 92.681s ok golang.org/x/crypto/ssh/agent 15.301s ok golang.org/x/crypto/ssh/internal/bcrypt_pbkdf 1.044s ok golang.org/x/crypto/ssh/knownhosts 0.072s ok golang.org/x/crypto/ssh/terminal 0.090s ok golang.org/x/crypto/ssh/test 1.171s ok golang.org/x/crypto/tea 0.064s ok golang.org/x/crypto/twofish 0.106s ok golang.org/x/crypto/xtea 0.051s ok golang.org/x/crypto/xts 0.053s FAIL