all: “../test” phase fails on netbsd/386 8.0RC1

[bcmills]

Using the i386 builder image from https://golang.org/cl/109035, all.bash seems to hang during the ../test phase.

Here's the tail of output from debugnewvm --staging --host host-netbsd-386-8branch --override-image netbsd-i386-8-0-2018q1 --run-build=netbsd-386-8branch:

                            2018/05/01 17:15:30 [0x18774b00] Running /tmp/workdir/go/src/all.bash with args ["/tmp/workdir/go/src/all.bash"] and env ["PWD=/" "HOME=/" "PATH=/usr/pkg/bin:/usr/pkg/sbin:/sbin:/usr/sbin:/bin:/usr/bin:/usr/pkg/sbin:/usr/pkg/bin:/usr/X11R7/bin:/usr/local/sbin:/usr/local/bin" "_rc_original_stdout_fd=7" "GOROOT_BOOTSTRAP=/tmp/workdir/go1.4" "_rc_original_stderr_fd=8" "RC_PID=  10" "_rc_pid=2" "_rc_postprocessor_fd=9" "WORKDIR=/tmp/workdir" "GO_BUILDER_NAME=netbsd-386-8branch"] in dir /tmp/workdir/go/src
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 netbsd/386.

##### Testing packages.
ok      archive/tar     0.076s
ok      archive/zip     2.814s
ok      bufio   0.268s
ok      bytes   0.604s
ok      compress/bzip2  0.108s
ok      compress/flate  1.841s
ok      compress/gzip   0.283s
ok      compress/lzw    0.183s
ok      compress/zlib   1.431s
ok      container/heap  0.010s
ok      container/list  0.003s
ok      container/ring  0.042s
ok      context 1.282s
ok      crypto  0.003s
ok      crypto/aes      0.066s
ok      crypto/cipher   0.011s
ok      crypto/des      0.027s
ok      crypto/dsa      0.009s
ok      crypto/ecdsa    0.412s
ok      crypto/elliptic 0.068s
ok      crypto/hmac     0.004s
ok      crypto/md5      0.005s
ok      crypto/rand     0.064s
ok      crypto/rc4      0.166s
ok      crypto/rsa      0.178s
ok      crypto/sha1     0.005s
ok      crypto/sha256   0.005s
ok      crypto/sha512   0.010s
ok      crypto/subtle   0.005s
ok      crypto/tls      5.311s
ok      crypto/x509     4.127s
ok      database/sql    0.929s
ok      database/sql/driver     0.003s
ok      debug/dwarf     0.014s
ok      debug/elf       0.036s
ok      debug/gosym     0.012s
ok      debug/macho     0.004s
ok      debug/pe        0.009s
ok      debug/plan9obj  0.003s
ok      encoding/ascii85        0.009s
ok      encoding/asn1   0.005s
ok      encoding/base32 0.006s
ok      encoding/base64 0.008s
ok      encoding/binary 0.010s
ok      encoding/csv    0.008s
ok      encoding/gob    0.034s
ok      encoding/hex    0.006s
ok      encoding/json   0.664s
ok      encoding/pem    0.020s
ok      encoding/xml    0.027s
ok      errors  0.003s
ok      expvar  0.007s
ok      flag    0.003s
ok      fmt     0.142s
ok      go/ast  0.014s
ok      go/build        0.196s
ok      go/constant     0.006s
ok      go/doc  0.043s
ok      go/format       0.007s
ok      go/importer     0.154s
ok      go/internal/gccgoimporter       0.009s
ok      go/internal/gcimporter  2.394s
ok      go/internal/srcimporter 3.002s
ok      go/parser       0.060s
ok      go/printer      0.453s
ok      go/scanner      0.004s
ok      go/token        0.028s
ok      go/types        2.110s
ok      hash    0.004s
ok      hash/adler32    0.021s
ok      hash/crc32      0.014s
ok      hash/crc64      0.006s
ok      hash/fnv        0.003s
ok      html    0.003s
ok      html/template   0.040s
ok      image   0.243s
ok      image/color     0.030s
ok      image/draw      0.081s
ok      image/gif       4.292s
ok      image/jpeg      0.331s
ok      image/png       0.083s
ok      index/suffixarray       0.038s
ok      internal/cpu    0.016s
ok      internal/poll   0.021s
ok      internal/singleflight   0.053s
ok      internal/trace  3.402s
ok      io      0.342s
ok      io/ioutil       0.004s
ok      log     0.005s
ok      log/syslog      1.325s
ok      math    0.006s
ok      math/big        8.865s
ok      math/bits       0.008s
ok      math/cmplx      0.003s
ok      math/rand       1.039s
ok      mime    0.024s
ok      mime/multipart  1.341s
ok      mime/quotedprintable    0.316s
ok      net     42.080s
ok      net/http        6.164s
ok      net/http/cgi    0.180s
ok      net/http/cookiejar      0.008s
ok      net/http/fcgi   0.006s
ok      net/http/httptest       6.060s
ok      net/http/httptrace      0.006s
ok      net/http/httputil       0.049s
ok      net/http/internal       0.003s
ok      net/http/pprof  2.071s
ok      net/internal/socktest   0.003s
ok      net/mail        0.007s
ok      net/rpc 0.043s
ok      net/rpc/jsonrpc 0.008s
ok      net/smtp        0.026s
ok      net/textproto   0.024s
ok      net/url 0.008s
ok      os      1.547s
ok      os/exec 0.752s
ok      os/signal       4.932s
ok      os/user 0.004s
ok      path    0.004s
ok      path/filepath   0.014s
ok      reflect 0.406s
ok      regexp  0.360s
ok      regexp/syntax   0.784s
ok      runtime 57.988s
ok      runtime/debug   0.048s
ok      runtime/internal/atomic 0.126s
ok      runtime/internal/sys    0.009s
ok      runtime/pprof   19.101s
ok      runtime/pprof/internal/profile  0.004s
ok      runtime/trace   7.532s
ok      sort    0.075s
ok      strconv 0.681s
ok      strings 0.234s
ok      sync    1.178s
ok      sync/atomic     0.056s
ok      syscall 0.016s
ok      testing 1.795s
ok      testing/quick   0.131s
ok      text/scanner    0.004s
ok      text/tabwriter  0.004s
ok      text/template   0.294s
ok      text/template/parse     0.008s
ok      time    6.459s
ok      unicode 0.019s
ok      unicode/utf16   0.003s
ok      unicode/utf8    0.006s
ok      vendor/golang_org/x/crypto/chacha20poly1305     0.164s
ok      vendor/golang_org/x/crypto/chacha20poly1305/internal/chacha20   0.002s
ok      vendor/golang_org/x/crypto/cryptobyte   0.005s
ok      vendor/golang_org/x/crypto/curve25519   0.278s
ok      vendor/golang_org/x/crypto/poly1305     0.003s
ok      vendor/golang_org/x/net/dns/dnsmessage  0.201s
ok      vendor/golang_org/x/net/http2/hpack     0.005s
ok      vendor/golang_org/x/net/idna    0.004s
ok      vendor/golang_org/x/net/lex/httplex     0.005s
ok      vendor/golang_org/x/net/nettest 1.070s
ok      vendor/golang_org/x/net/route   0.006s
ok      vendor/golang_org/x/text/transform      0.004s
ok      vendor/golang_org/x/text/unicode/norm   0.003s
ok      cmd/addr2line   2.516s
ok      cmd/api 0.007s
ok      cmd/asm/internal/asm    0.556s
ok      cmd/asm/internal/lex    0.004s
ok      cmd/compile     10.754s
ok      cmd/compile/internal/gc 35.578s
ok      cmd/compile/internal/ssa        0.298s
ok      cmd/compile/internal/syntax     0.012s
ok      cmd/compile/internal/test       0.003s [no tests to run]
ok      cmd/compile/internal/types      0.003s
ok      cmd/cover       1.729s
ok      cmd/doc 0.087s
ok      cmd/fix 3.593s
ok      cmd/go  69.676s
ok      cmd/go/internal/cache   0.493s
ok      cmd/go/internal/generate        0.008s
ok      cmd/go/internal/get     0.015s
ok      cmd/go/internal/load    0.009s
ok      cmd/go/internal/work    0.021s
ok      cmd/gofmt       0.042s
ok      cmd/internal/buildid    0.492s
ok      cmd/internal/dwarf      0.002s
ok      cmd/internal/edit       0.006s
ok      cmd/internal/goobj      0.604s
ok      cmd/internal/obj        0.003s
ok      cmd/internal/obj/arm64  0.021s
ok      cmd/internal/obj/x86    2.815s
ok      cmd/internal/objabi     0.003s
ok      cmd/internal/src        0.003s
ok      cmd/internal/test2json  0.159s
ok      cmd/link        7.742s
ok      cmd/link/internal/ld    33.726s
ok      cmd/nm  6.182s
ok      cmd/objdump     3.325s
ok      cmd/pack        3.629s
ok      cmd/trace       0.138s
ok      cmd/vendor/github.com/google/pprof/internal/binutils    0.009s
ok      cmd/vendor/github.com/google/pprof/internal/driver      1.467s
ok      cmd/vendor/github.com/google/pprof/internal/elfexec     0.003s
ok      cmd/vendor/github.com/google/pprof/internal/graph       0.005s
ok      cmd/vendor/github.com/google/pprof/internal/measurement 0.004s
ok      cmd/vendor/github.com/google/pprof/internal/report      0.009s
ok      cmd/vendor/github.com/google/pprof/internal/symbolizer  0.100s
ok      cmd/vendor/github.com/google/pprof/internal/symbolz     0.007s
ok      cmd/vendor/github.com/google/pprof/profile      0.179s
ok      cmd/vendor/github.com/ianlancetaylor/demangle   0.020s
ok      cmd/vendor/golang.org/x/arch/arm/armasm 0.016s
ok      cmd/vendor/golang.org/x/arch/arm64/arm64asm     0.165s
ok      cmd/vendor/golang.org/x/arch/ppc64/ppc64asm     0.004s
ok      cmd/vendor/golang.org/x/arch/x86/x86asm 0.222s
ok      cmd/vet 3.640s
ok      cmd/vet/internal/cfg    0.003s

##### os/user with tag osusergo
ok      os/user 0.003s

##### GOMAXPROCS=2 runtime -cpu=1,2,4 -quick
ok      runtime 63.514s

##### moved GOROOT
ok      fmt     0.062s

##### Testing without libgcc.
ok      crypto/x509     2.020s
ok      net     0.010s
ok      os/user 0.004s

##### sync -cpu=10
ok      sync    1.356s

##### ../misc/cgo/stdio

##### ../misc/cgo/life

##### ../misc/cgo/test
PASS
ok      _/tmp/workdir/go/misc/cgo/test  1.765s
PASS
ok      _/tmp/workdir/go/misc/cgo/test  1.501s
PASS
ok      _/tmp/workdir/go/misc/cgo/test  1.622s
PASS
ok      _/tmp/workdir/go/misc/cgo/testtls       0.004s
PASS
ok      _/tmp/workdir/go/misc/cgo/testtls       0.003s

##### ../misc/cgo/testgodefs

##### ../misc/cgo/testso

##### ../misc/cgo/testsovar

##### ../misc/cgo/errors
PASS

##### ../doc/progs
        9.50 real        19.45 user         6.45 sys

##### ../doc/articles/wiki
Hmm...  Looks like a unified diff to me...
The text leading up to this was:
--------------------------
|--- final.go   2017-08-31 13:19:00.422925489 -0700
|+++ final-test.go      2017-08-31 13:23:43.381391659 -0700
--------------------------
Patching file final-test.go using Plan A...
Hunk #1 succeeded at 8.
Hunk #2 succeeded at 87.
done
PASS
./test.bash: line 14: 21466 Terminated              ./final-test.bin

##### ../doc/codewalk
        6.19 real         2.96 user         0.72 sys

##### ../test/bench/go1
testing: warning: no tests to run
PASS
ok      _/tmp/workdir/go/test/bench/go1 20.142s

##### ../test

CC: @bsiegert

[bcmills]

See previously #19339.

[bcmills]

It would be nice if we could get this figured out and fixed before Go 1.11. Otherwise, we should document it in the release notes.

[gopherbot]

Change https://golang.org/cl/110626 mentions this issue: dashboard: update netbsd builders to 8.0RC1

[krytarowski]

Hmm CC: @zoulasc who fixed something similar previously.

[bradfitz]

NetBSD folk, any update here? Not critical, but if it's not fixed, we'll just note in the release notes that it's not known to work on i386.

[krytarowski]

I'm personally single-threaded person and fully absorbed with LLDB-related porting (with a short break for fixing virtually all libfuzzer failures in tests)... I will forward this to other developers.

[krytarowski]

I get reports that this works for HEAD. 8.0rc1 might miss a patch.

[bradfitz]

Can you reproduce the problem on 8.0rc1?

[krytarowski]

I don't have enough RAM on my i386 hardware, so I will try out in qemu tonight.

[krytarowski]

I'm still building it, (under qemu softemu dogoofding, as KVM-like style emulation isn't ready).

[krytarowski]

Some tests fail for me in 8.0RC in a qemu guest (softemu). Confirmed.

[krytarowski]

I cannot dedicate time for 8.0 i386. I'm swamped by ptrace(2) kernel fixes and it won't change in few months.

[ianlancetaylor]

NetBSD users: any update on this issue for 1.12?

[bsiegert]

I tried building tip (go version devel +9e0ec5ef59 Thu Dec 6 02:43:14 2018 +0000 netbsd/386) on a daily build of NetBSD-8 stable, and all.bash passed successfully. The "../test" stage passes with no output.

# uname -a
NetBSD instance-1.c.gobuilder-bsiegert.internal 8.0_STABLE NetBSD 8.0_STABLE (GENERIC) #0: Tue Dec  4 12:07:53 UTC 2018  mkrepro@mkrepro.NetBSD.org:/usr/src/sys/arch/i386/compile/GENERIC i386

So this is fixed, as far as I can see.

[ianlancetaylor]

Thanks, closing.