android-386-emu at 7d3d0334f9f58db5a0819da0963abb9ca0cba695 :: Running /workdir/go/src/make.bash with args ["/workdir/go/src/make.bash" "-force"] and env ["HOSTNAME=buildlet-linux-amd64-androidemu-rndc5e52a" "DEBIAN_FRONTEND=noninteractive" "GO_BUILDER_ENV=android-amd64-emu" "ANDROID_HOME=/android/sdk" "CGO_CFLAGS=-I/android/openal-headers" "CC_FOR_android_386=/android/sdk/ndk-bundle/toolchains/llvm/prebuilt/linux-x86_64/bin/i686-linux-android26-clang" "CC_FOR_android_amd64=/android/sdk/ndk-bundle/toolchains/llvm/prebuilt/linux-x86_64/bin/x86_64-linux-android26-clang" "HOME=/root" "USER=root" "GO_STAGE0_NET_DELAY=0s" "GO_STAGE0_DL_DELAY=400ms" "WORKDIR=/workdir" "GO_BUILDER_NAME=android-386-emu" "GOARCH=386" "GOOS=android" "GOHOSTARCH=amd64" "GOHOSTOS=linux" "CGO_ENABLED=1" "GOBIN=" "GOROOT_BOOTSTRAP=" "TMPDIR=/workdir/tmp" "GOCACHE=/workdir/gocache" "GOPLSCACHE=/workdir/goplscache" "PATH=/workdir/go1.4/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/android/sdk/platform-tools:/android/sdk/build-tools/27.0.3:/android/gradle/bin" "PWD=/workdir/go/src"] in dir /workdir/go/src WARNING: /root/go1.4/bin/go does not exist, found /workdir/go1.4/go/bin/go from env WARNING: set /workdir/go1.4/go as GOROOT_BOOTSTRAP Building Go cmd/dist using /workdir/go1.4/go. (go1.22.6 linux/amd64) Building Go toolchain1 using /workdir/go1.4/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 commands for host, linux/amd64. Building packages and commands for target, android/386. --- Installed Go for android/386 in /workdir/go Installed commands in /workdir/go/bin *** You need to add /workdir/go/bin to your PATH. ##### Test execution environment. # GOARCH: 386 # CPU: Android virtual processor # GOOS: android # OS Version: Linux 3.18.91+ #1 SMP PREEMPT Tue Jan 9 20:30:51 UTC 2018 i686 ##### Testing packages. ok archive/tar 0.524s ok archive/zip 0.254s ok bufio 0.692s ok bytes 0.711s ok cmp 0.218s ok compress/bzip2 0.153s ok compress/flate 1.192s ok compress/gzip 2.201s ok compress/lzw 2.282s ok compress/zlib 0.251s ok container/heap 0.143s ok container/list 0.071s ok container/ring 0.077s ok context 0.308s ok crypto 0.183s ok crypto/aes 0.106s ok crypto/cipher 17.410s ok crypto/des 0.115s ok crypto/dsa 0.088s ok crypto/ecdh 0.529s ok crypto/ecdsa 0.318s ok crypto/ed25519 0.446s ok crypto/elliptic 0.547s ? crypto/fips140 [no test files] ok crypto/hkdf 0.222s ok crypto/hmac 0.149s ok crypto/internal/boring 0.095s ? crypto/internal/boring/bbig [no test files] ok crypto/internal/boring/bcache 0.183s ? crypto/internal/boring/sig [no test files] ? crypto/internal/cryptotest [no test files] ? crypto/internal/entropy [no test files] ? crypto/internal/fips140 [no test files] ok crypto/internal/fips140/aes 0.101s ok crypto/internal/fips140/aes/gcm 0.173s [no tests to run] ? crypto/internal/fips140/alias [no test files] ok crypto/internal/fips140/bigmod 0.125s ? crypto/internal/fips140/check [no test files] ? crypto/internal/fips140/check/checktest [no test files] ? crypto/internal/fips140/drbg [no test files] ok crypto/internal/fips140/ecdh 0.080s ok crypto/internal/fips140/ecdsa 0.303s ? crypto/internal/fips140/ed25519 [no test files] ok crypto/internal/fips140/edwards25519 0.675s ok crypto/internal/fips140/edwards25519/field 0.816s ? crypto/internal/fips140/hkdf [no test files] ? crypto/internal/fips140/hmac [no test files] ok crypto/internal/fips140/mlkem 0.267s ok crypto/internal/fips140/nistec 0.226s ok crypto/internal/fips140/nistec/fiat 0.295s [no tests to run] ? crypto/internal/fips140/pbkdf2 [no test files] ok crypto/internal/fips140/rsa 0.076s ? crypto/internal/fips140/sha256 [no test files] ? crypto/internal/fips140/sha3 [no test files] ? crypto/internal/fips140/sha512 [no test files] ? crypto/internal/fips140/ssh [no test files] ? crypto/internal/fips140/subtle [no test files] ? crypto/internal/fips140/tls12 [no test files] ? crypto/internal/fips140/tls13 [no test files] ok crypto/internal/fips140deps 0.072s ? crypto/internal/fips140deps/byteorder [no test files] ? crypto/internal/fips140deps/cpu [no test files] ? crypto/internal/fips140deps/godebug [no test files] ? crypto/internal/fips140only [no test files] ok crypto/internal/fips140test 1.715s ok crypto/internal/hpke 1.858s ? crypto/internal/impl [no test files] ? crypto/internal/randutil [no test files] ok crypto/internal/sysrand 1.984s ? crypto/internal/sysrand/internal/seccomp [no test files] ok crypto/md5 0.086s ok crypto/mlkem 0.275s ok crypto/pbkdf2 0.101s ok crypto/rand 4.125s ok crypto/rc4 4.276s ok crypto/rsa 1.518s ok crypto/sha1 0.089s ok crypto/sha256 1.599s ok crypto/sha3 4.786s ok crypto/sha512 4.873s ok crypto/subtle 5.822s ok crypto/tls 23.574s ? crypto/tls/internal/fips140tls [no test files] ok crypto/x509 26.449s ? crypto/x509/pkix [no test files] ok database/sql 0.807s ok database/sql/driver 0.878s ok debug/buildinfo 0.165s ok debug/dwarf 0.333s ok debug/elf 0.234s ok debug/gosym 0.112s ok debug/macho 0.197s ok debug/pe 0.316s ok debug/plan9obj 0.081s ok embed 0.146s [no tests to run] ok embed/internal/embedtest 0.074s ? encoding [no test files] ok encoding/ascii85 0.071s ok encoding/asn1 0.088s ok encoding/base32 0.135s ok encoding/base64 0.090s ok encoding/binary 0.135s ok encoding/csv 0.128s ok encoding/gob 3.984s ok encoding/hex 0.077s ok encoding/json 1.198s ok encoding/pem 0.740s ok encoding/xml 1.410s ok errors 0.098s ok expvar 0.116s ok flag 0.131s ok fmt 0.195s ok go/ast 0.330s ok go/ast/internal/tests 0.251s ok go/build 7.554s ok go/build/constraint 7.601s ok go/constant 7.437s ok go/doc 0.203s ok go/doc/comment 3.526s ok go/format 0.285s ok go/importer 0.148s ok go/internal/gccgoimporter 0.181s ok go/internal/gcimporter 0.304s ok go/internal/srcimporter 1.648s ok go/parser 1.911s ok go/printer 1.585s ok go/scanner 0.086s ok go/token 0.178s ok go/types 0.582s ok go/version 0.067s ok hash 0.120s ok hash/adler32 0.185s ok hash/crc32 0.211s ok hash/crc64 0.069s ok hash/fnv 0.139s ok hash/maphash 0.335s ok html 0.402s ok html/template 0.373s ok image 0.148s ok image/color 0.226s ? image/color/palette [no test files] ok image/draw 0.174s ok image/gif 0.518s ? image/internal/imageutil [no test files] ok image/jpeg 0.295s ok image/png 1.006s ok index/suffixarray 0.483s ok internal/abi 0.092s ? internal/asan [no test files] ? internal/bisect [no test files] ok internal/buildcfg 0.077s ? internal/bytealg [no test files] ? internal/byteorder [no test files] ? internal/cfg [no test files] ok internal/chacha8rand 0.072s ok internal/copyright 0.612s ? internal/coverage [no test files] ? internal/coverage/calloc [no test files] ok internal/coverage/cfile 0.113s ok internal/coverage/cformat 0.131s ok internal/coverage/cmerge 0.069s ? internal/coverage/decodecounter [no test files] ? internal/coverage/decodemeta [no test files] ? internal/coverage/encodecounter [no test files] ? internal/coverage/encodemeta [no test files] ok internal/coverage/pods 0.071s ? internal/coverage/rtcov [no test files] ok internal/coverage/slicereader 0.139s ok internal/coverage/slicewriter 0.072s ? internal/coverage/stringtab [no test files] ok internal/coverage/test 0.120s ? internal/coverage/uleb128 [no test files] ok internal/cpu 0.066s ok internal/dag 0.146s ok internal/diff 0.078s ? internal/exportdata [no test files] ? internal/filepathlite [no test files] ok internal/fmtsort 0.074s ok internal/fuzz 0.176s ? internal/goarch [no test files] ok internal/godebug 0.093s ok internal/godebugs 0.170s ? internal/goexperiment [no test files] ? internal/goos [no test files] ? internal/goroot [no test files] ok internal/gover 0.066s ? internal/goversion [no test files] ok internal/itoa 0.057s ? internal/lazyregexp [no test files] ? internal/lazytemplate [no test files] ? internal/msan [no test files] ? internal/nettrace [no test files] ? internal/obscuretestdata [no test files] ? internal/oserror [no test files] ok internal/pkgbits 0.103s ok internal/platform 0.096s ok internal/poll 0.129s ok internal/profile 0.203s ? internal/profilerecord [no test files] ? internal/race [no test files] ok internal/reflectlite 0.084s ok internal/runtime/atomic 0.155s ? internal/runtime/exithook [no test files] ok internal/runtime/maps 0.104s ok internal/runtime/math 0.118s ok internal/runtime/sys 0.178s ok internal/runtime/syscall 0.064s ok internal/saferio 0.093s ok internal/singleflight 0.416s ? internal/stringslite [no test files] ok internal/sync 0.388s fatal error: defer on system stack runtime stack: runtime.throw({0xeaffe3ed, 0x15}) /workdir/go/src/runtime/panic.go:1099 +0x3a fp=0xffbc76e8 sp=0xffbc76d4 pc=0xeaf22d0a runtime.deferprocStack(0xffbc76f8) /workdir/go/src/runtime/panic.go:480 +0x64 fp=0xffbc76f4 sp=0xffbc76e8 pc=0xeaee59b4 runtime.synctestidle_c(0xca407568, 0x0) /workdir/go/src/runtime/synctest.go:220 +0x67 fp=0xffbc771c sp=0xffbc76f4 pc=0xeaf0a1b7 runtime.park_m(0xca407568) /workdir/go/src/runtime/proc.go:4120 +0x152 fp=0xffbc7748 sp=0xffbc771c pc=0xeaef2712 runtime.mcall(0x153640) /workdir/go/src/runtime/asm_386.s:329 +0x45 fp=0xffbc7750 sp=0xffbc7748 pc=0xeaf281b5 goroutine 1 gp=0xca406128 m=nil [chan receive]: runtime.gopark(0xeb06dac4, 0xca422274, 0xe, 0x7, 0x2) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xca44dbc0 sp=0xca44dbac pc=0xeaf22e5b runtime.chanrecv(0xca422240, 0xca44dc3f, 0x1) /workdir/go/src/runtime/chan.go:664 +0x42e fp=0xca44dc04 sp=0xca44dbc0 pc=0xeaeb04ce runtime.chanrecv1(0xca422240, 0xca44dc3f) /workdir/go/src/runtime/chan.go:506 +0x1c fp=0xca44dc18 sp=0xca44dc04 pc=0xeaeb009c testing.(*T).Run(0xca407328, {0xeaffa5d1, 0x7}, 0xeb06d998) /workdir/go/src/testing/testing.go:1831 +0x512 fp=0xca44dca8 sp=0xca44dc18 pc=0xeafa1642 testing.runTests.func1(0xca407328) /workdir/go/src/testing/testing.go:2251 +0x46 fp=0xca44dcc8 sp=0xca44dca8 pc=0xeafa3bf6 testing.tRunner(0xca407328, 0xca44ddb4) /workdir/go/src/testing/testing.go:1764 +0x15c fp=0xca44dd4c sp=0xca44dcc8 pc=0xeafa054c testing.runTests(0xca412050, {0xeb150ce0, 0x12, 0x12}, {0xc1c9dfe8a3ed7f92, 0x29e8e37045, 0xeb1534a0}) /workdir/go/src/testing/testing.go:2249 +0x4ae fp=0xca44ddc8 sp=0xca44dd4c pc=0xeafa3aee testing.(*M).Run(0xca478050) /workdir/go/src/testing/testing.go:2114 +0x78e fp=0xca44df40 sp=0xca44ddc8 pc=0xeafa221e main.main() _testmain.go:81 +0xf5 fp=0xca44df98 sp=0xca44df40 pc=0xeafe97d5 runtime.main() /workdir/go/src/runtime/proc.go:283 +0x376 fp=0xca44dff0 sp=0xca44df98 pc=0xeaee9a46 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xca44dff4 sp=0xca44dff0 pc=0xeaf29841 goroutine 2 gp=0xca4067e8 m=nil [force gc (idle)]: runtime.gopark(0xeb06dc38, 0xeb153178, 0x11, 0xa, 0x1) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xca43afdc sp=0xca43afc8 pc=0xeaf22e5b runtime.goparkunlock(...) /workdir/go/src/runtime/proc.go:441 runtime.forcegchelper() /workdir/go/src/runtime/proc.go:348 +0x107 fp=0xca43aff0 sp=0xca43afdc pc=0xeaee9e67 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xca43aff4 sp=0xca43aff0 pc=0xeaf29841 created by runtime.init.6 in goroutine 1 /workdir/go/src/runtime/proc.go:336 +0x29 goroutine 3 gp=0xca406b48 m=nil [GC sweep wait]: runtime.gopark(0xeb06dc38, 0xeb153300, 0xc, 0x9, 0x1) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xca43b7cc sp=0xca43b7b8 pc=0xeaf22e5b runtime.goparkunlock(...) /workdir/go/src/runtime/proc.go:441 runtime.bgsweep(0xca422040) /workdir/go/src/runtime/mgcsweep.go:276 +0xcd fp=0xca43b7e8 sp=0xca43b7cc pc=0xeaed0b9d runtime.gcenable.gowrap1() /workdir/go/src/runtime/mgc.go:204 +0x28 fp=0xca43b7f0 sp=0xca43b7e8 pc=0xeaec0ab8 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xca43b7f4 sp=0xca43b7f0 pc=0xeaf29841 created by runtime.gcenable in goroutine 1 /workdir/go/src/runtime/mgc.go:204 +0x8e goroutine 4 gp=0xca406c68 m=nil [GC scavenge wait]: runtime.gopark(0xeb06dc38, 0xeb1535c0, 0xd, 0xa, 0x2) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xca43bfb8 sp=0xca43bfa4 pc=0xeaf22e5b runtime.goparkunlock(...) /workdir/go/src/runtime/proc.go:441 runtime.(*scavengerState).park(0xeb1535c0) /workdir/go/src/runtime/mgcscavenge.go:425 +0x67 fp=0xca43bfcc sp=0xca43bfb8 pc=0xeaecdee7 runtime.bgscavenge(0xca422040) /workdir/go/src/runtime/mgcscavenge.go:653 +0x5b fp=0xca43bfe8 sp=0xca43bfcc pc=0xeaece5eb runtime.gcenable.gowrap2() /workdir/go/src/runtime/mgc.go:205 +0x28 fp=0xca43bff0 sp=0xca43bfe8 pc=0xeaec0a78 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xca43bff4 sp=0xca43bff0 pc=0xeaf29841 created by runtime.gcenable in goroutine 1 /workdir/go/src/runtime/mgc.go:205 +0xdf goroutine 5 gp=0xca407208 m=nil [finalizer wait]: runtime.gopark(0xeb06dae8, 0xeb15fa44, 0x10, 0xa, 0x1) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xca43c798 sp=0xca43c784 pc=0xeaf22e5b runtime.runfinq() /workdir/go/src/runtime/mfinal.go:196 +0x13b fp=0xca43c7f0 sp=0xca43c798 pc=0xeaebf9ab runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xca43c7f4 sp=0xca43c7f0 pc=0xeaf29841 created by runtime.createfing in goroutine 1 /workdir/go/src/runtime/mfinal.go:166 +0x70 goroutine 6 gp=0xca407568 m=nil [synctest.Run, synctest group 6]: runtime.gopark(0xeb06dc74, 0x0, 0x27, 0x10, 0x0) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xca43a6b0 sp=0xca43a69c pc=0xeaf22e5b internal/synctest.Run(0xca460700) /workdir/go/src/runtime/synctest.go:191 +0x1b6 fp=0xca43a6f8 sp=0xca43a6b0 pc=0xeaf266b6 internal/synctest_test.TestNow(0xca407448) /workdir/go/src/internal/synctest/synctest_test.go:21 +0x194 fp=0xca43a760 sp=0xca43a6f8 pc=0xeafe5314 testing.tRunner(0xca407448, 0xeb06d998) /workdir/go/src/testing/testing.go:1764 +0x15c fp=0xca43a7e4 sp=0xca43a760 pc=0xeafa054c testing.(*T).Run.gowrap1() /workdir/go/src/testing/testing.go:1823 +0x2f fp=0xca43a7f0 sp=0xca43a7e4 pc=0xeafa17af runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xca43a7f4 sp=0xca43a7f0 pc=0xeaf29841 created by testing.(*T).Run in goroutine 1 /workdir/go/src/testing/testing.go:1823 +0x4f0 goroutine 7 gp=0xca407688 m=4 mp=0xca43f808 [running, synctest group 6]: goroutine running on other thread; stack unavailable created by internal/synctest.Run in goroutine 6 /workdir/go/src/runtime/synctest.go:178 +0x12c goroutine 18 gp=0xca502008 m=nil [runnable, synctest group 6]: internal/synctest_test.TestNow.func1.1() /workdir/go/src/internal/synctest/synctest_test.go:26 fp=0xca4367f0 sp=0xca4367ec pc=0xeafe56e0 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xca4367f4 sp=0xca4367f0 pc=0xeaf29841 created by internal/synctest_test.TestNow.func1 in goroutine 7 /workdir/go/src/internal/synctest/synctest_test.go:26 +0x206 FAIL internal/synctest 0.561s ? internal/syscall/execenv [no test files] FAIL go tool dist: Failed: exit status 1