android-386-emu at 1ffadf146665c52b1d583bb20dc21a1fa6c02ead :: Running /workdir/go/src/make.bash with args ["/workdir/go/src/make.bash" "-force"] and env ["HOSTNAME=buildlet-linux-amd64-androidemu-rnffc5029" "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=300ms" "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.448s ok archive/zip 1.169s ok bufio 0.768s ok bytes 0.577s ok cmp 0.060s ok compress/bzip2 0.721s ok compress/flate 1.320s ok compress/gzip 2.319s ok compress/lzw 2.401s ok compress/zlib 0.111s ok container/heap 0.181s ok container/list 0.233s ok container/ring 0.078s ok context 0.144s ok crypto 0.328s ok crypto/aes 0.109s ok crypto/cipher 17.367s ok crypto/des 17.490s ok crypto/dsa 0.080s ok crypto/ecdh 0.522s ok crypto/ecdsa 0.304s ok crypto/ed25519 0.435s ok crypto/elliptic 0.516s ? crypto/fips140 [no test files] ok crypto/hkdf 0.083s ok crypto/hmac 0.217s ok crypto/internal/boring 0.086s ? 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.094s ok crypto/internal/fips140/aes/gcm 0.167s [no tests to run] ? crypto/internal/fips140/alias [no test files] ok crypto/internal/fips140/bigmod 0.127s ? 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.079s ok crypto/internal/fips140/ecdsa 0.282s ? crypto/internal/fips140/ed25519 [no test files] ok crypto/internal/fips140/edwards25519 0.824s ok crypto/internal/fips140/edwards25519/field 0.151s ? crypto/internal/fips140/hkdf [no test files] ? crypto/internal/fips140/hmac [no test files] ok crypto/internal/fips140/mlkem 0.268s ok crypto/internal/fips140/nistec 0.293s ok crypto/internal/fips140/nistec/fiat 0.072s [no tests to run] ? crypto/internal/fips140/pbkdf2 [no test files] ok crypto/internal/fips140/rsa 0.080s ? 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.090s ? 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.678s ok crypto/internal/hpke 1.802s ? crypto/internal/impl [no test files] ? crypto/internal/randutil [no test files] ok crypto/internal/sysrand 2.003s ? crypto/internal/sysrand/internal/seccomp [no test files] ok crypto/md5 0.090s ok crypto/mlkem 0.285s ok crypto/pbkdf2 0.100s ok crypto/rand 4.001s ok crypto/rc4 4.140s ok crypto/rsa 1.489s ok crypto/sha1 1.580s ok crypto/sha256 0.086s ok crypto/sha3 4.707s ok crypto/sha512 4.810s ok crypto/subtle 5.677s ok crypto/tls 20.019s ? crypto/tls/internal/fips140tls [no test files] ok crypto/x509 22.874s ? crypto/x509/pkix [no test files] ok database/sql 0.829s ok database/sql/driver 0.901s ok debug/buildinfo 0.172s ok debug/dwarf 0.109s ok debug/elf 0.370s ok debug/gosym 0.119s ok debug/macho 0.197s ok debug/pe 0.294s ok debug/plan9obj 0.075s ok embed 0.084s [no tests to run] ok embed/internal/embedtest 0.148s ? encoding [no test files] ok encoding/ascii85 0.074s ok encoding/asn1 0.083s ok encoding/base32 0.129s ok encoding/base64 0.077s ok encoding/binary 0.121s ok encoding/csv 0.104s ok encoding/gob 3.764s ok encoding/hex 3.841s ok encoding/json 0.464s ok encoding/pem 1.430s ok encoding/xml 0.691s ok errors 0.089s ok expvar 0.104s ok flag 0.126s ok fmt 0.270s ok go/ast 0.082s ok go/ast/internal/tests 0.329s ok go/build 7.550s ok go/build/constraint 7.523s ok go/constant 7.595s ok go/doc 0.142s ok go/doc/comment 3.349s ok go/format 3.428s ok go/importer 0.118s ok go/internal/gccgoimporter 0.168s ok go/internal/gcimporter 0.279s ok go/internal/srcimporter 1.603s ok go/parser 1.569s ok go/printer 1.836s ok go/scanner 0.081s ok go/token 0.130s ok go/types 0.556s ok go/version 0.063s ok hash 0.119s ok hash/adler32 0.189s ok hash/crc32 0.077s ok hash/crc64 0.144s ok hash/fnv 0.216s ok hash/maphash 0.338s ok html 0.404s ok html/template 0.383s ok image 0.153s ok image/color 0.224s ? image/color/palette [no test files] ok image/draw 0.173s ok image/gif 0.510s ? image/internal/imageutil [no test files] ok image/jpeg 0.270s ok image/png 0.737s ok index/suffixarray 0.997s ok internal/abi 0.095s ? internal/asan [no test files] ? internal/bisect [no test files] ok internal/buildcfg 0.075s ? internal/bytealg [no test files] ? internal/byteorder [no test files] ? internal/cfg [no test files] ok internal/chacha8rand 0.067s ok internal/copyright 0.595s ? internal/coverage [no test files] ? internal/coverage/calloc [no test files] ok internal/coverage/cfile 0.095s ok internal/coverage/cformat 0.073s ok internal/coverage/cmerge 0.138s ? 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.069s ? internal/coverage/rtcov [no test files] ok internal/coverage/slicereader 0.135s ok internal/coverage/slicewriter 0.071s ? internal/coverage/stringtab [no test files] ok internal/coverage/test 0.118s ? internal/coverage/uleb128 [no test files] ok internal/cpu 0.060s ok internal/dag 0.123s ok internal/diff 0.086s ? internal/exportdata [no test files] ? internal/filepathlite [no test files] ok internal/fmtsort 0.169s ok internal/fuzz 0.099s ? internal/goarch [no test files] ok internal/godebug 0.084s ok internal/godebugs 0.178s ? internal/goexperiment [no test files] ? internal/goos [no test files] ? internal/goroot [no test files] ok internal/gover 0.060s ? internal/goversion [no test files] ok internal/itoa 0.060s ? 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.072s ok internal/platform 0.142s ok internal/poll 0.207s ok internal/profile 0.079s ? internal/profilerecord [no test files] ? internal/race [no test files] ok internal/reflectlite 0.078s ok internal/runtime/atomic 0.163s ? internal/runtime/exithook [no test files] ok internal/runtime/maps 0.123s ok internal/runtime/math 0.062s ok internal/runtime/sys 0.186s ok internal/runtime/syscall 0.125s ok internal/saferio 0.117s ok internal/singleflight 0.393s ? internal/stringslite [no test files] ok internal/sync 0.389s fatal error: defer on system stack runtime stack: runtime.throw({0xf76693ed, 0x15}) /workdir/go/src/runtime/panic.go:1099 +0x3a fp=0xff88e048 sp=0xff88e034 pc=0xf758dd0a runtime.deferprocStack(0xff88e058) /workdir/go/src/runtime/panic.go:480 +0x64 fp=0xff88e054 sp=0xff88e048 pc=0xf75509b4 runtime.synctestidle_c(0xd6c845a8, 0x0) /workdir/go/src/runtime/synctest.go:220 +0x67 fp=0xff88e07c sp=0xff88e054 pc=0xf75751b7 runtime.park_m(0xd6c845a8) /workdir/go/src/runtime/proc.go:4120 +0x152 fp=0xff88e0a8 sp=0xff88e07c pc=0xf755d712 runtime.mcall(0x7be640) /workdir/go/src/runtime/asm_386.s:329 +0x45 fp=0xff88e0b0 sp=0xff88e0a8 pc=0xf75931b5 goroutine 1 gp=0xd6c06128 m=nil [chan receive]: runtime.gopark(0xf76d8ac4, 0xd6c801f4, 0xe, 0x7, 0x2) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xd6c48bc0 sp=0xd6c48bac pc=0xf758de5b runtime.chanrecv(0xd6c801c0, 0xd6c48c3f, 0x1) /workdir/go/src/runtime/chan.go:664 +0x42e fp=0xd6c48c04 sp=0xd6c48bc0 pc=0xf751b4ce runtime.chanrecv1(0xd6c801c0, 0xd6c48c3f) /workdir/go/src/runtime/chan.go:506 +0x1c fp=0xd6c48c18 sp=0xd6c48c04 pc=0xf751b09c testing.(*T).Run(0xd6c84368, {0xf76655d1, 0x7}, 0xf76d8998) /workdir/go/src/testing/testing.go:1831 +0x512 fp=0xd6c48ca8 sp=0xd6c48c18 pc=0xf760c642 testing.runTests.func1(0xd6c84368) /workdir/go/src/testing/testing.go:2251 +0x46 fp=0xd6c48cc8 sp=0xd6c48ca8 pc=0xf760ebf6 testing.tRunner(0xd6c84368, 0xd6c48db4) /workdir/go/src/testing/testing.go:1764 +0x15c fp=0xd6c48d4c sp=0xd6c48cc8 pc=0xf760b54c testing.runTests(0xd6c9a030, {0xf77bbce0, 0x12, 0x12}, {0xc1c9c53436db9d14, 0x29e8e05d83, 0xf77be4a0}) /workdir/go/src/testing/testing.go:2249 +0x4ae fp=0xd6c48dc8 sp=0xd6c48d4c pc=0xf760eaee testing.(*M).Run(0xd6c98050) /workdir/go/src/testing/testing.go:2114 +0x78e fp=0xd6c48f40 sp=0xd6c48dc8 pc=0xf760d21e main.main() _testmain.go:81 +0xf5 fp=0xd6c48f98 sp=0xd6c48f40 pc=0xf76547d5 runtime.main() /workdir/go/src/runtime/proc.go:283 +0x376 fp=0xd6c48ff0 sp=0xd6c48f98 pc=0xf7554a46 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xd6c48ff4 sp=0xd6c48ff0 pc=0xf7594841 goroutine 2 gp=0xd6c067e8 m=nil [force gc (idle)]: runtime.gopark(0xf76d8c38, 0xf77be178, 0x11, 0xa, 0x1) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xd6c3afdc sp=0xd6c3afc8 pc=0xf758de5b runtime.goparkunlock(...) /workdir/go/src/runtime/proc.go:441 runtime.forcegchelper() /workdir/go/src/runtime/proc.go:348 +0x107 fp=0xd6c3aff0 sp=0xd6c3afdc pc=0xf7554e67 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xd6c3aff4 sp=0xd6c3aff0 pc=0xf7594841 created by runtime.init.6 in goroutine 1 /workdir/go/src/runtime/proc.go:336 +0x29 goroutine 3 gp=0xd6c06b48 m=nil [GC sweep wait]: runtime.gopark(0xf76d8c38, 0xf77be300, 0xc, 0x9, 0x1) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xd6c3b7cc sp=0xd6c3b7b8 pc=0xf758de5b runtime.goparkunlock(...) /workdir/go/src/runtime/proc.go:441 runtime.bgsweep(0xd6c22040) /workdir/go/src/runtime/mgcsweep.go:276 +0xcd fp=0xd6c3b7e8 sp=0xd6c3b7cc pc=0xf753bb9d runtime.gcenable.gowrap1() /workdir/go/src/runtime/mgc.go:204 +0x28 fp=0xd6c3b7f0 sp=0xd6c3b7e8 pc=0xf752bab8 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xd6c3b7f4 sp=0xd6c3b7f0 pc=0xf7594841 created by runtime.gcenable in goroutine 1 /workdir/go/src/runtime/mgc.go:204 +0x8e goroutine 4 gp=0xd6c06c68 m=nil [GC scavenge wait]: runtime.gopark(0xf76d8c38, 0xf77be5c0, 0xd, 0xa, 0x2) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xd6c3bfb8 sp=0xd6c3bfa4 pc=0xf758de5b runtime.goparkunlock(...) /workdir/go/src/runtime/proc.go:441 runtime.(*scavengerState).park(0xf77be5c0) /workdir/go/src/runtime/mgcscavenge.go:425 +0x67 fp=0xd6c3bfcc sp=0xd6c3bfb8 pc=0xf7538ee7 runtime.bgscavenge(0xd6c22040) /workdir/go/src/runtime/mgcscavenge.go:653 +0x5b fp=0xd6c3bfe8 sp=0xd6c3bfcc pc=0xf75395eb runtime.gcenable.gowrap2() /workdir/go/src/runtime/mgc.go:205 +0x28 fp=0xd6c3bff0 sp=0xd6c3bfe8 pc=0xf752ba78 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xd6c3bff4 sp=0xd6c3bff0 pc=0xf7594841 created by runtime.gcenable in goroutine 1 /workdir/go/src/runtime/mgc.go:205 +0xdf goroutine 18 gp=0xd6c84248 m=nil [finalizer wait]: runtime.gopark(0xf76d8ae8, 0xf77caa44, 0x10, 0xa, 0x1) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xd6c36798 sp=0xd6c36784 pc=0xf758de5b runtime.runfinq() /workdir/go/src/runtime/mfinal.go:196 +0x13b fp=0xd6c367f0 sp=0xd6c36798 pc=0xf752a9ab runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xd6c367f4 sp=0xd6c367f0 pc=0xf7594841 created by runtime.createfing in goroutine 1 /workdir/go/src/runtime/mfinal.go:166 +0x70 goroutine 19 gp=0xd6c845a8 m=nil [synctest.Run, synctest group 19]: runtime.gopark(0xf76d8c74, 0x0, 0x27, 0x10, 0x0) /workdir/go/src/runtime/proc.go:435 +0x11b fp=0xd6c3a6b0 sp=0xd6c3a69c pc=0xf758de5b internal/synctest.Run(0xd6ca26e0) /workdir/go/src/runtime/synctest.go:191 +0x1b6 fp=0xd6c3a6f8 sp=0xd6c3a6b0 pc=0xf75916b6 internal/synctest_test.TestNow(0xd6c84488) /workdir/go/src/internal/synctest/synctest_test.go:21 +0x194 fp=0xd6c3a760 sp=0xd6c3a6f8 pc=0xf7650314 testing.tRunner(0xd6c84488, 0xf76d8998) /workdir/go/src/testing/testing.go:1764 +0x15c fp=0xd6c3a7e4 sp=0xd6c3a760 pc=0xf760b54c testing.(*T).Run.gowrap1() /workdir/go/src/testing/testing.go:1823 +0x2f fp=0xd6c3a7f0 sp=0xd6c3a7e4 pc=0xf760c7af runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xd6c3a7f4 sp=0xd6c3a7f0 pc=0xf7594841 created by testing.(*T).Run in goroutine 1 /workdir/go/src/testing/testing.go:1823 +0x4f0 goroutine 20 gp=0xd6c846c8 m=3 mp=0xd6c3f008 [running, synctest group 19]: goroutine running on other thread; stack unavailable created by internal/synctest.Run in goroutine 19 /workdir/go/src/runtime/synctest.go:178 +0x12c goroutine 5 gp=0xd6c07208 m=nil [runnable, synctest group 19]: internal/synctest_test.TestNow.func1.1() /workdir/go/src/internal/synctest/synctest_test.go:26 fp=0xd6c3c7f0 sp=0xd6c3c7ec pc=0xf76506e0 runtime.goexit({}) /workdir/go/src/runtime/asm_386.s:1393 +0x1 fp=0xd6c3c7f4 sp=0xd6c3c7f0 pc=0xf7594841 created by internal/synctest_test.TestNow.func1 in goroutine 20 /workdir/go/src/internal/synctest/synctest_test.go:26 +0x206 FAIL internal/synctest 0.529s ? internal/syscall/execenv [no test files] FAIL go tool dist: Failed: exit status 1