android-386-emu at ec5170397c724a8ae440b2bc529f857c86f0e6b1 building tools at 10bcabde7ceabfa7ace41aa1e019efd1f7f93371 testing in module mode; GOMOD=/workdir/gopath/src/golang.org/x/tools/go.mod :: Running /workdir/go/bin/go with args ["/workdir/go/bin/go" "test" "-short" "golang.org/x/tools/..."] and env ["PATH=/workdir/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" "HOSTNAME=buildlet-android-amd64-emu-rnd8b13a8" "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=200ms" "GO_STAGE0_DL_DELAY=100ms" "WORKDIR=/workdir" "GOROOT_BOOTSTRAP=/workdir/go1.4" "GO_BUILDER_NAME=android-386-emu" "GOROOT_BOOTSTRAP=/go1.4" "GOARCH=386" "GOOS=android" "GOHOSTARCH=amd64" "GOHOSTOS=linux" "CGO_ENABLED=1" "GOROOT=/workdir/go" "GOPATH=/workdir/gopath" "GOPROXY=http://10.240.0.25:30157" "TMPDIR=/workdir/tmp" "GOCACHE=/workdir/gocache"] in dir /workdir/gopath/src/golang.org/x/tools go: downloading golang.org/x/sys v0.0.0-20210510120138-977fb7262007 go: downloading golang.org/x/xerrors v0.0.0-20200804184101-5ec99f83aff1 go: downloading golang.org/x/net v0.0.0-20210405180319-a5a99cb37ef4 go: downloading golang.org/x/mod v0.4.2 go: downloading github.com/yuin/goldmark v1.3.5 go: downloading golang.org/x/sync v0.0.0-20210220032951-036812b2e83c ok golang.org/x/tools/benchmark/parse 92.624s ok golang.org/x/tools/blog 82.637s ? golang.org/x/tools/blog/atom [no test files] ? golang.org/x/tools/cmd/auth/authtest [no test files] ? golang.org/x/tools/cmd/auth/cookieauth [no test files] ? golang.org/x/tools/cmd/auth/gitauth [no test files] ? golang.org/x/tools/cmd/auth/netrcauth [no test files] ok golang.org/x/tools/cmd/benchcmp 87.129s ok golang.org/x/tools/cmd/bundle 88.012s ? golang.org/x/tools/cmd/callgraph [no test files] ? golang.org/x/tools/cmd/compilebench [no test files] ? golang.org/x/tools/cmd/cover [no test files] ok golang.org/x/tools/cmd/digraph 4.944s ? golang.org/x/tools/cmd/eg [no test files] ok golang.org/x/tools/cmd/file2fuzz 7.750s ? golang.org/x/tools/cmd/fiximports [no test files] ok golang.org/x/tools/cmd/getgo 2.041s ? golang.org/x/tools/cmd/getgo/server [no test files] ok golang.org/x/tools/cmd/go-contrib-init 5.218s ? golang.org/x/tools/cmd/godex [no test files] ok golang.org/x/tools/cmd/godoc 3.286s ? golang.org/x/tools/cmd/goimports [no test files] ? golang.org/x/tools/cmd/gomvpkg [no test files] ok golang.org/x/tools/cmd/gorename 1.959s ? golang.org/x/tools/cmd/gotype [no test files] ? golang.org/x/tools/cmd/goyacc [no test files] ok golang.org/x/tools/cmd/guru 3.318s ? golang.org/x/tools/cmd/guru/serial [no test files] ? golang.org/x/tools/cmd/html2article [no test files] ? golang.org/x/tools/cmd/present [no test files] ? golang.org/x/tools/cmd/present2md [no test files] ? golang.org/x/tools/cmd/splitdwarf [no test files] ok golang.org/x/tools/cmd/splitdwarf/internal/macho 3.377s ? golang.org/x/tools/cmd/ssadump [no test files] ? golang.org/x/tools/cmd/stress [no test files] ok golang.org/x/tools/cmd/stringer 5.301s ? golang.org/x/tools/cmd/toolstash [no test files] ok golang.org/x/tools/container/intsets 11.326s ok golang.org/x/tools/copyright 9.006s ok golang.org/x/tools/cover 4.571s ok golang.org/x/tools/go/analysis 2.808s ok golang.org/x/tools/go/analysis/analysistest 8.658s ok golang.org/x/tools/go/analysis/internal/analysisflags 8.213s ok golang.org/x/tools/go/analysis/internal/checker 9.583s ok golang.org/x/tools/go/analysis/internal/facts 5.996s ok golang.org/x/tools/go/analysis/multichecker 1.014s ok golang.org/x/tools/go/analysis/passes/asmdecl 3.099s ok golang.org/x/tools/go/analysis/passes/assign 5.026s ok golang.org/x/tools/go/analysis/passes/atomic 5.107s ok golang.org/x/tools/go/analysis/passes/atomicalign 7.171s ok golang.org/x/tools/go/analysis/passes/bools 8.203s ok golang.org/x/tools/go/analysis/passes/buildssa 3.301s ok golang.org/x/tools/go/analysis/passes/buildtag 8.818s ok golang.org/x/tools/go/analysis/passes/cgocall 5.515s ok golang.org/x/tools/go/analysis/passes/composite 11.823s ok golang.org/x/tools/go/analysis/passes/copylock 6.357s ok golang.org/x/tools/go/analysis/passes/ctrlflow 9.806s ok golang.org/x/tools/go/analysis/passes/deepequalerrors 15.530s ok golang.org/x/tools/go/analysis/passes/errorsas 8.895s ok golang.org/x/tools/go/analysis/passes/fieldalignment 9.613s ? golang.org/x/tools/go/analysis/passes/fieldalignment/cmd/fieldalignment [no test files] ok golang.org/x/tools/go/analysis/passes/findcall 13.341s ? golang.org/x/tools/go/analysis/passes/findcall/cmd/findcall [no test files] ok golang.org/x/tools/go/analysis/passes/framepointer 3.790s ok golang.org/x/tools/go/analysis/passes/httpresponse 6.494s ok golang.org/x/tools/go/analysis/passes/ifaceassert 8.980s ? golang.org/x/tools/go/analysis/passes/ifaceassert/cmd/ifaceassert [no test files] ? golang.org/x/tools/go/analysis/passes/inspect [no test files] ? golang.org/x/tools/go/analysis/passes/internal/analysisutil [no test files] ok golang.org/x/tools/go/analysis/passes/loopclosure 13.347s ok golang.org/x/tools/go/analysis/passes/lostcancel 6.780s ? golang.org/x/tools/go/analysis/passes/lostcancel/cmd/lostcancel [no test files] ok golang.org/x/tools/go/analysis/passes/nilfunc 6.715s ok golang.org/x/tools/go/analysis/passes/nilness 5.092s ? golang.org/x/tools/go/analysis/passes/nilness/cmd/nilness [no test files] ok golang.org/x/tools/go/analysis/passes/pkgfact 1.273s ok golang.org/x/tools/go/analysis/passes/printf 7.594s ok golang.org/x/tools/go/analysis/passes/reflectvaluecompare 3.042s ok golang.org/x/tools/go/analysis/passes/shadow 10.223s ? golang.org/x/tools/go/analysis/passes/shadow/cmd/shadow [no test files] ok golang.org/x/tools/go/analysis/passes/shift 21.536s ok golang.org/x/tools/go/analysis/passes/sigchanyzer 12.479s ok golang.org/x/tools/go/analysis/passes/sortslice 5.772s ok golang.org/x/tools/go/analysis/passes/stdmethods 10.498s ok golang.org/x/tools/go/analysis/passes/stringintconv 8.011s ? golang.org/x/tools/go/analysis/passes/stringintconv/cmd/stringintconv [no test files] ok golang.org/x/tools/go/analysis/passes/structtag 9.533s ok golang.org/x/tools/go/analysis/passes/testinggoroutine 8.439s ok golang.org/x/tools/go/analysis/passes/tests 16.298s ok golang.org/x/tools/go/analysis/passes/unmarshal 11.944s ? golang.org/x/tools/go/analysis/passes/unmarshal/cmd/unmarshal [no test files] ok golang.org/x/tools/go/analysis/passes/unreachable 12.769s ok golang.org/x/tools/go/analysis/passes/unsafeptr 11.700s ok golang.org/x/tools/go/analysis/passes/unusedresult 10.858s ok golang.org/x/tools/go/analysis/passes/unusedwrite 3.750s ? golang.org/x/tools/go/analysis/singlechecker [no test files] ok golang.org/x/tools/go/analysis/unitchecker 6.536s ok golang.org/x/tools/go/ast/astutil 3.233s ok golang.org/x/tools/go/ast/inspector 3.594s ok golang.org/x/tools/go/buildutil 2.251s ? golang.org/x/tools/go/callgraph [no test files] ? golang.org/x/tools/go/callgraph/cha [no test files] ? golang.org/x/tools/go/callgraph/rta [no test files] ok golang.org/x/tools/go/callgraph/static 2.218s ok golang.org/x/tools/go/callgraph/vta 2.202s ok golang.org/x/tools/go/cfg 1.595s ok golang.org/x/tools/go/expect 0.933s ok golang.org/x/tools/go/gccgoexportdata 0.969s ok golang.org/x/tools/go/gcexportdata 0.621s ? golang.org/x/tools/go/internal/cgo [no test files] ok golang.org/x/tools/go/internal/gccgoimporter 0.962s ok golang.org/x/tools/go/internal/gcimporter 1.749s ? golang.org/x/tools/go/internal/packagesdriver [no test files] ok golang.org/x/tools/go/loader 0.803s ok golang.org/x/tools/go/packages 73.091s ? golang.org/x/tools/go/packages/gopackages [no test files] ok golang.org/x/tools/go/packages/packagestest 2.073s ok golang.org/x/tools/go/pointer 77.403s ok golang.org/x/tools/go/ssa 86.242s ok golang.org/x/tools/go/ssa/interp 77.205s ok golang.org/x/tools/go/ssa/ssautil 17.590s ok golang.org/x/tools/go/types/objectpath 12.337s ok golang.org/x/tools/go/types/typeutil 13.604s ok golang.org/x/tools/go/vcs 3.008s ok golang.org/x/tools/godoc 6.916s ? golang.org/x/tools/godoc/analysis [no test files] ok golang.org/x/tools/godoc/redirect 2.607s ok golang.org/x/tools/godoc/static 3.975s ? golang.org/x/tools/godoc/util [no test files] ok golang.org/x/tools/godoc/vfs 6.305s ok golang.org/x/tools/godoc/vfs/gatefs 4.977s ? golang.org/x/tools/godoc/vfs/httpfs [no test files] ok golang.org/x/tools/godoc/vfs/mapfs 3.980s ok golang.org/x/tools/godoc/vfs/zipfs 0.721s ? golang.org/x/tools/imports [no test files] ? golang.org/x/tools/internal/analysisinternal [no test files] ok golang.org/x/tools/internal/apidiff 3.024s ok golang.org/x/tools/internal/event 3.241s [no tests to run] ? golang.org/x/tools/internal/event/core [no test files] ok golang.org/x/tools/internal/event/export 3.215s ? golang.org/x/tools/internal/event/export/eventtest [no test files] ? golang.org/x/tools/internal/event/export/metric [no test files] ok golang.org/x/tools/internal/event/export/ocagent 2.779s ok golang.org/x/tools/internal/event/export/ocagent/wire 0.634s ? golang.org/x/tools/internal/event/export/prometheus [no test files] ? golang.org/x/tools/internal/event/keys [no test files] ok golang.org/x/tools/internal/event/label 0.561s ? golang.org/x/tools/internal/fakenet [no test files] ok golang.org/x/tools/internal/fastwalk 0.611s ok golang.org/x/tools/internal/gocommand 0.667s ok golang.org/x/tools/internal/gopathwalk 1.124s ok golang.org/x/tools/internal/imports 27.079s ok golang.org/x/tools/internal/jsonrpc2 0.631s ok golang.org/x/tools/internal/jsonrpc2/servertest 0.632s ok golang.org/x/tools/internal/jsonrpc2_v2 27.117s ok golang.org/x/tools/internal/lsp 70.976s ok golang.org/x/tools/internal/lsp/analysis/fillreturns 35.502s ok golang.org/x/tools/internal/lsp/analysis/fillstruct 3.507s ok golang.org/x/tools/internal/lsp/analysis/nonewvars 55.976s ok golang.org/x/tools/internal/lsp/analysis/noresultvalues 48.843s ok golang.org/x/tools/internal/lsp/analysis/simplifycompositelit 46.813s ok golang.org/x/tools/internal/lsp/analysis/simplifyrange 8.618s ok golang.org/x/tools/internal/lsp/analysis/simplifyslice 9.149s ok golang.org/x/tools/internal/lsp/analysis/undeclaredname 6.540s ok golang.org/x/tools/internal/lsp/analysis/unusedparams 12.430s ? golang.org/x/tools/internal/lsp/browser [no test files] ok golang.org/x/tools/internal/lsp/cache 7.650s ok golang.org/x/tools/internal/lsp/cmd 46.068s ? golang.org/x/tools/internal/lsp/cmd/test [no test files] ok golang.org/x/tools/internal/lsp/command 46.306s ? golang.org/x/tools/internal/lsp/command/commandmeta [no test files] ? golang.org/x/tools/internal/lsp/command/gen [no test files] ? golang.org/x/tools/internal/lsp/debug [no test files] ? golang.org/x/tools/internal/lsp/debug/log [no test files] ? golang.org/x/tools/internal/lsp/debug/tag [no test files] ok golang.org/x/tools/internal/lsp/diff 42.852s ok golang.org/x/tools/internal/lsp/diff/difftest 43.241s ok golang.org/x/tools/internal/lsp/diff/myers 1.999s ok golang.org/x/tools/internal/lsp/fake 2.483s ok golang.org/x/tools/internal/lsp/fuzzy 2.945s ? golang.org/x/tools/internal/lsp/helper [no test files] ? golang.org/x/tools/internal/lsp/lsppos [no test files] ok golang.org/x/tools/internal/lsp/lsprpc 4.442s ok golang.org/x/tools/internal/lsp/mod 1.935s ok golang.org/x/tools/internal/lsp/progress 5.426s ? golang.org/x/tools/internal/lsp/protocol [no test files] ok golang.org/x/tools/internal/lsp/regtest 6.323s ok golang.org/x/tools/internal/lsp/snippet 4.446s ok golang.org/x/tools/internal/lsp/source 39.277s ok golang.org/x/tools/internal/lsp/source/completion 1.762s ok golang.org/x/tools/internal/lsp/template 2.750s ? golang.org/x/tools/internal/lsp/tests [no test files] ok golang.org/x/tools/internal/memoize 0.608s ? golang.org/x/tools/internal/mod/lazyregexp [no test files] ? golang.org/x/tools/internal/mod/modfile [no test files] ? golang.org/x/tools/internal/packagesinternal [no test files] ok golang.org/x/tools/internal/proxydir 1.390s ok golang.org/x/tools/internal/span 1.259s ok golang.org/x/tools/internal/stack 39.538s ? golang.org/x/tools/internal/stack/gostacks [no test files] ? golang.org/x/tools/internal/stack/stacktest [no test files] ? golang.org/x/tools/internal/testenv [no test files] ? golang.org/x/tools/internal/tool [no test files] ok golang.org/x/tools/internal/typeparams 39.792s ? golang.org/x/tools/internal/typesinternal [no test files] ? golang.org/x/tools/internal/xcontext [no test files] ? golang.org/x/tools/playground [no test files] ok golang.org/x/tools/playground/socket 38.664s ok golang.org/x/tools/present 0.430s ? golang.org/x/tools/refactor/eg [no test files] ? golang.org/x/tools/refactor/importgraph [no test files] ok golang.org/x/tools/refactor/rename 0.588s ? golang.org/x/tools/refactor/satisfy [no test files] ok golang.org/x/tools/txtar 0.461s :: Running /workdir/go/bin/go with args ["/workdir/go/bin/go" "test" "-short" "golang.org/x/tools/gopls/..."] and env ["PATH=/workdir/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" "HOSTNAME=buildlet-android-amd64-emu-rnd8b13a8" "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=200ms" "GO_STAGE0_DL_DELAY=100ms" "WORKDIR=/workdir" "GOROOT_BOOTSTRAP=/workdir/go1.4" "GO_BUILDER_NAME=android-386-emu" "GOROOT_BOOTSTRAP=/go1.4" "GOARCH=386" "GOOS=android" "GOHOSTARCH=amd64" "GOHOSTOS=linux" "CGO_ENABLED=1" "GOROOT=/workdir/go" "GOPATH=/workdir/gopath" "GOPROXY=http://10.240.0.25:30157" "TMPDIR=/workdir/tmp" "GOCACHE=/workdir/gocache"] in dir /workdir/gopath/src/golang.org/x/tools/gopls go: downloading github.com/sergi/go-diff v1.1.0 go: downloading honnef.co/go/tools v0.2.0 go: downloading mvdan.cc/gofumpt v0.1.1 go: downloading mvdan.cc/xurls/v2 v2.2.0 go: downloading github.com/sanity-io/litter v1.5.0 go: downloading github.com/jba/templatecheck v0.6.0 go: downloading github.com/google/go-cmp v0.5.5 go: downloading github.com/google/safehtml v0.0.2 go: downloading github.com/BurntSushi/toml v0.3.1 go: downloading golang.org/x/text v0.3.6 ? golang.org/x/tools/gopls [no test files] ok golang.org/x/tools/gopls/doc 1.520s ? golang.org/x/tools/gopls/integration/govim [no test files] ok golang.org/x/tools/gopls/internal/hooks 1.112s ok golang.org/x/tools/gopls/internal/regtest/bench 1.036s ok golang.org/x/tools/gopls/internal/regtest/codelens 48.078s ok golang.org/x/tools/gopls/internal/regtest/completion 34.653s #### Start Gopls Test Logs for "TestProgressBarErrors/singleton" [Trace - 21:38:13.500 PM] Sending request 'initialize - (1)'. Params: {"processId":0,"clientInfo":{"name":"fakeclient","version":"v1.0.0"},"rootUri":"","capabilities":{"workspace":{"didChangeConfiguration":{},"didChangeWatchedFiles":{"dynamicRegistration":true},"executeCommand":{},"semanticTokens":{},"codeLens":{},"configuration":true},"textDocument":{"synchronization":{},"completion":{"completionItem":{"snippetSupport":true,"tagSupport":{"valueSet":[1]},"resolveSupport":{"properties":null},"insertTextModeSupport":{"valueSet":null}},"completionItemKind":{}},"hover":{},"signatureHelp":{"signatureInformation":{"parameterInformation":{}}},"declaration":{},"definition":{},"typeDefinition":{},"implementation":{},"references":{},"documentHighlight":{},"documentSymbol":{"symbolKind":{},"tagSupport":{"valueSet":null}},"codeAction":{"codeActionLiteralSupport":{"codeActionKind":{"valueSet":null}},"resolveSupport":{"properties":null}},"codeLens":{},"documentLink":{},"colorProvider":{},"formatting":{},"rangeFormatting":{},"onTypeFormatting":{},"rename":{},"foldingRange":{},"selectionRange":{},"publishDiagnostics":{"tagSupport":{"valueSet":null}},"callHierarchy":{},"semanticTokens":{"requests":{},"tokenTypes":null,"tokenModifiers":null,"formats":null},"linkedEditingRange":{},"moniker":{}},"window":{"workDoneProgress":true,"showMessage":{"messageActionItem":{}},"showDocument":{"support":false}},"general":{"staleRequestSupport":{"cancel":false,"retryOnContentModified":null},"regularExpressions":{"engine":""},"markdown":{"parser":""}}},"initializationOptions":{"completionBudget":"10s","diagnosticsDelay":"10ms","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/gopath","GOPROXY":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"verboseWorkDoneProgress":true},"trace":"messages","workspaceFolders":[{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work","name":"work"}]} [Trace - 21:38:13.501 PM] Received response 'initialize - (1)' in 1ms. Result: {"capabilities":{"textDocumentSync":{"openClose":true,"change":2,"save":{}},"completionProvider":{"triggerCharacters":["."],"completionItem":{}},"hoverProvider":true,"signatureHelpProvider":{"triggerCharacters":["(",","]},"definitionProvider":true,"typeDefinitionProvider":true,"implementationProvider":true,"referencesProvider":true,"documentHighlightProvider":true,"documentSymbolProvider":true,"codeActionProvider":true,"codeLensProvider":{},"documentLinkProvider":{},"workspaceSymbolProvider":true,"documentFormattingProvider":true,"documentOnTypeFormattingProvider":{"firstTriggerCharacter":""},"renameProvider":true,"foldingRangeProvider":true,"executeCommandProvider":{"commands":["gopls.add_dependency","gopls.add_import","gopls.apply_fix","gopls.check_upgrades","gopls.gc_details","gopls.generate","gopls.generate_gopls_mod","gopls.go_get_package","gopls.list_known_packages","gopls.regenerate_cgo","gopls.remove_dependency","gopls.run_tests","gopls.start_debugging","gopls.test","gopls.tidy","gopls.toggle_gc_details","gopls.update_go_sum","gopls.upgrade_dependency","gopls.vendor","gopls.workspace_metadata"]},"callHierarchyProvider":true,"workspace":{"workspaceFolders":{"supported":true,"changeNotifications":"workspace/didChangeWorkspaceFolders"}}},"serverInfo":{"name":"gopls","version":"{\"path\":\"gopls, built in GOPATH mode\",\"version\":\"master\"}"}} [Trace - 21:38:13.502 PM] Sending notification 'initialized'. Params: {} [Trace - 21:38:13.503 PM] Received request 'window/workDoneProgress/create - (1)'. Params: {"token":"2458479177492742947"} [Trace - 21:38:13.504 PM] Sending response 'window/workDoneProgress/create - (1)' in 0ms. Result: [Trace - 21:38:13.505 PM] Received notification '$/progress'. Params: {"token":"2458479177492742947","value":{"kind":"begin","title":"diagnosing initial workspace load","message":"Calculating diagnostics for initial workspace load..."}} [Trace - 21:38:13.507 PM] Received request 'window/workDoneProgress/create - (2)'. Params: {"token":"4125532999287192258"} [Trace - 21:38:13.508 PM] Sending response 'window/workDoneProgress/create - (2)' in 0ms. Result: [Trace - 21:38:13.508 PM] Received notification '$/progress'. Params: {"token":"4125532999287192258","value":{"kind":"begin","title":"Setting up workspace","message":"Loading packages..."}} [Trace - 21:38:13.509 PM] Received request 'workspace/configuration - (3)'. Params: {"items":[{"scopeUri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work","section":"gopls"}]} [Trace - 21:38:13.510 PM] Sending response 'workspace/configuration - (3)' in 1ms. Result: [{"completionBudget":"10s","diagnosticsDelay":"10ms","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/gopath","GOPROXY":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"verboseWorkDoneProgress":true}] [Trace - 21:38:13.557 PM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/08/16 21:38:13 copying workspace dir: /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:1: unknown directive: modul\n"} [Trace - 21:38:13.559 PM] Received notification '$/progress'. Params: {"token":"4125532999287192258","value":{"kind":"end","message":"Finished loading packages."}} [Trace - 21:38:13.585 PM] Received request 'client/registerCapability - (4)'. Params: {"registrations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.*tmpl","kind":7},{"globPattern":"**/*.{go,mod,sum,work,tmpl}","kind":7}]}}]} [Trace - 21:38:13.586 PM] Sending response 'client/registerCapability - (4)' in 1ms. Result: [Trace - 21:38:13.589 PM] Received request 'window/workDoneProgress/create - (5)'. Params: {"token":"1183687854078471674"} [Trace - 21:38:13.590 PM] Sending response 'window/workDoneProgress/create - (5)' in 0ms. Result: [Trace - 21:38:13.591 PM] Received notification '$/progress'. Params: {"token":"1183687854078471674","value":{"kind":"begin","title":"Error loading workspace","message":"/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:1: unknown directive: modul"}} [Trace - 21:38:13.593 PM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/08/16 21:38:13 errors loading workspace: /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:1: unknown directive: modul\n\tsnapshot=0\n\tdirectory=file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work\n"} [Trace - 21:38:13.595 PM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/08/16 21:38:13 go env for /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work\n(root /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work)\n(go version go version go1.17 android/386)\n(valid build configuration = true)\n(build flags: [])\nGOMODCACHE=\nGO111MODULE=\nGOPATH=/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/gopath\nGOPROXY=file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/proxy\nGONOPROXY=\nGONOSUMDB=\nGOPRIVATE=\nGOROOT=/data/local/tmp/go_android_exec/goroot\nGOCACHE=/data/local/tmp/go_android_exec/gocache\nGOMOD=/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod\nGOSUMDB=off\nGOFLAGS=\nGOINSECURE=\n\n"} [Trace - 21:38:13.597 PM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"severity":1,"source":"go list","message":"/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:1: unknown directive: modul"},{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"severity":1,"source":"syntax","message":"unknown directive: modul"}]} [Trace - 21:38:13.607 PM] Received notification '$/progress'. Params: {"token":"2458479177492742947","value":{"kind":"end","message":"Done."}} [Trace - 21:38:13.609 PM] Sending notification 'textDocument/didOpen'. Params: {"textDocument":{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","languageId":"","version":1,"text":"modul mod.com\n\ngo 1.12\n"}} [Trace - 21:38:13.610 PM] Received request 'window/workDoneProgress/create - (6)'. Params: {"token":"7148841212425426054"} [Trace - 21:38:13.611 PM] Sending notification 'textDocument/didChange'. Params: {"textDocument":{"version":2,"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod"},"contentChanges":[{"range":{"start":{"line":0,"character":0},"end":{"line":3,"character":0}},"text":"module mod.com\n\ngo 1.hello\n"}]} [Trace - 21:38:13.612 PM] Sending notification 'textDocument/willSave'. Params: {"textDocument":{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod"},"reason":1} [Trace - 21:38:13.616 PM] Sending response 'window/workDoneProgress/create - (6)' in 5ms. Result: [Trace - 21:38:13.617 PM] Received notification '$/progress'. Params: {"token":"7148841212425426054","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}} [Trace - 21:38:13.619 PM] Sending notification 'textDocument/didSave'. Params: {"textDocument":{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod"}} [Trace - 21:38:13.624 PM] Received request 'window/workDoneProgress/create - (7)'. Params: {"token":"2939110806991874072"} [Trace - 21:38:13.625 PM] Sending notification 'workspace/didChangeWatchedFiles'. Params: {"changes":[{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","type":2}]} [Trace - 21:38:13.626 PM] Sending response 'window/workDoneProgress/create - (7)' in 2ms. Result: [Trace - 21:38:13.627 PM] Received notification '$/progress'. Params: {"token":"2939110806991874072","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}} [Trace - 21:38:13.631 PM] Received request 'window/workDoneProgress/create - (8)'. Params: {"token":"3719685973800884532"} [Trace - 21:38:13.631 PM] Sending response 'window/workDoneProgress/create - (8)' in 0ms. Result: [Trace - 21:38:13.634 PM] Received notification '$/progress'. Params: {"token":"3719685973800884532","value":{"kind":"begin","title":"diagnosing saved files","message":"Calculating file diagnostics..."}} [Trace - 21:38:13.636 PM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/08/16 21:38:13 copying workspace dir: /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:3: invalid go version '1.hello': must match format 1.23\n"} [Trace - 21:38:13.640 PM] Received notification '$/progress'. Params: {"token":"7148841212425426054","value":{"kind":"end","message":"Done."}} [Trace - 21:38:13.643 PM] Received request 'window/workDoneProgress/create - (9)'. Params: {"token":"5219776352469082857"} [Trace - 21:38:13.644 PM] Sending response 'window/workDoneProgress/create - (9)' in 0ms. Result: [Trace - 21:38:13.646 PM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/08/16 21:38:13 copying workspace dir: /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:3: invalid go version '1.hello': must match format 1.23\n"} [Trace - 21:38:13.648 PM] Received notification '$/progress'. Params: {"token":"2939110806991874072","value":{"kind":"end","message":"Done."}} [Trace - 21:38:13.649 PM] Received notification '$/progress'. Params: {"token":"5219776352469082857","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}} [Trace - 21:38:13.653 PM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","version":2,"diagnostics":[]} [Trace - 21:38:13.654 PM] Received notification '$/progress'. Params: {"token":"3719685973800884532","value":{"kind":"end","message":"Done."}} [Trace - 21:38:13.658 PM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/08/16 21:38:13 copying workspace dir: /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:3: invalid go version '1.hello': must match format 1.23\n"} [Trace - 21:38:13.668 PM] Received notification '$/progress'. Params: {"token":"1183687854078471674","value":{"kind":"report","message":"/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:3: invalid go version '1.hello': must match format 1.23"}} [Trace - 21:38:13.670 PM] Sending notification 'textDocument/didChange'. Params: {"textDocument":{"version":3,"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod"},"contentChanges":[{"range":{"start":{"line":2,"character":0},"end":{"line":2,"character":10}},"text":"go 1.12"}]} [Trace - 21:38:13.670 PM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","version":2,"diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"severity":1,"source":"go list","message":"/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:3: invalid go version '1.hello': must match format 1.23"},{"range":{"start":{"line":2,"character":0},"end":{"line":2,"character":0}},"severity":1,"source":"syntax","message":"invalid go version '1.hello': must match format 1.23"}]} [Trace - 21:38:13.672 PM] Sending notification 'textDocument/willSave'. Params: {"textDocument":{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod"},"reason":1} [Trace - 21:38:13.673 PM] Received notification '$/progress'. Params: {"token":"5219776352469082857","value":{"kind":"end","message":"Done."}} [Trace - 21:38:13.674 PM] Sending notification 'textDocument/didSave'. Params: {"textDocument":{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod"}} [Trace - 21:38:13.674 PM] Received request 'window/workDoneProgress/create - (10)'. Params: {"token":"663172221523735513"} [Trace - 21:38:13.676 PM] Sending response 'window/workDoneProgress/create - (10)' in 1ms. Result: [Trace - 21:38:13.676 PM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/08/16 21:38:13 errors loading workspace: /data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod:3: invalid go version '1.hello': must match format 1.23\n\tsnapshot=4\n\tdirectory=file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work\n"} [Trace - 21:38:13.676 PM] Sending notification 'workspace/didChangeWatchedFiles'. Params: {"changes":[{"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","type":2}]} [Trace - 21:38:13.678 PM] Received notification '$/progress'. Params: {"token":"663172221523735513","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}} [Trace - 21:38:13.683 PM] Received request 'window/workDoneProgress/create - (11)'. Params: {"token":"2673644565579601470"} [Trace - 21:38:13.684 PM] Sending response 'window/workDoneProgress/create - (11)' in 1ms. Result: [Trace - 21:38:13.686 PM] Received notification '$/progress'. Params: {"token":"2673644565579601470","value":{"kind":"begin","title":"diagnosing saved files","message":"Calculating file diagnostics..."}} [Trace - 21:38:13.688 PM] Received request 'window/workDoneProgress/create - (12)'. Params: {"token":"5596029706218078403"} [Trace - 21:38:13.689 PM] Sending response 'window/workDoneProgress/create - (12)' in 1ms. Result: [Trace - 21:38:13.690 PM] Received notification '$/progress'. Params: {"token":"5596029706218078403","value":{"kind":"begin","title":"Load","message":"Loading query=[builtin mod.com/...]"}} [Trace - 21:38:13.694 PM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","version":3,"diagnostics":[]} [Trace - 21:38:13.695 PM] Received notification '$/progress'. Params: {"token":"663172221523735513","value":{"kind":"end","message":"Done."}} [Trace - 21:38:13.966 PM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/08/16 21:38:13 go/packages.Load\n\tsnapshot=5\n\tdirectory=/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work\n\tquery=[builtin mod.com/...]\n\tpackages=2\n"} [Trace - 21:38:13.969 PM] Received notification '$/progress'. Params: {"token":"5596029706218078403","value":{"kind":"end","message":"Done."}} [Trace - 21:38:13.984 PM] Received request 'window/workDoneProgress/create - (13)'. Params: {"token":"7620914220791404896"} [Trace - 21:38:13.996 PM] Sending response 'window/workDoneProgress/create - (13)' in 12ms. Result: [Trace - 21:38:13.997 PM] Received request 'window/workDoneProgress/create - (14)'. Params: {"token":"5806921737724242314"} [Trace - 21:38:13.999 PM] Received notification '$/progress'. Params: {"token":"7620914220791404896","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}} [Trace - 21:38:14.001 PM] Received notification '$/cancelRequest'. Params: {"id":14} [Trace - 21:38:14.006 PM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","version":3,"diagnostics":[]} [Trace - 21:38:14.007 PM] Received notification '$/progress'. Params: {"token":"2673644565579601470","value":{"kind":"end","message":"Done."}} [Trace - 21:38:14.014 PM] Sending response 'window/workDoneProgress/create - (14)' in 17ms. Result: [Trace - 21:38:14.024 PM] Received request 'window/workDoneProgress/create - (15)'. Params: {"token":"1486945396868222946"} [Trace - 21:38:14.025 PM] Sending response 'window/workDoneProgress/create - (15)' in 0ms. Result: [Trace - 21:38:14.027 PM] Received notification '$/progress'. Params: {"token":"1486945396868222946","value":{"kind":"begin","title":"Load","message":"Loading query=[builtin mod.com/...]"}} [Trace - 21:38:14.383 PM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/08/16 21:38:14 go/packages.Load\n\tsnapshot=7\n\tdirectory=/data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work\n\tquery=[builtin mod.com/...]\n\tpackages=2\n"} [Trace - 21:38:14.386 PM] Received notification '$/progress'. Params: {"token":"1486945396868222946","value":{"kind":"end","message":"Done."}} [Trace - 21:38:14.418 PM] Received notification '$/progress'. Params: {"token":"1183687854078471674","value":{"kind":"end","message":"Done."}} [Trace - 21:38:14.420 PM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///data/local/tmp/go_android_exec/diagnostics.test-12966/gopls-regtest-1096358050/TestProgressBarErrors/singleton/work/go.mod","version":3,"diagnostics":[]} [Trace - 21:38:14.422 PM] Received notification '$/progress'. Params: {"token":"7620914220791404896","value":{"kind":"end","message":"Done."}} #### End Gopls Test Logs for "TestProgressBarErrors/singleton" --- FAIL: TestProgressBarErrors (26.31s) --- FAIL: TestProgressBarErrors/singleton (25.00s) diagnostics_test.go:1539: waiting on: Unmet: no outstanding work err:context deadline exceeded state: #### log messages (see RPC logs for full text): Error: "2021/08/16 21:38:13 copying workspace dir: /data/... Error: "2021/08/16 21:38:13 errors loading workspace: /da... Info: "2021/08/16 21:38:13 go env for /data/local/tmp/go_... Error: "2021/08/16 21:38:13 copying workspace dir: /data/... Error: "2021/08/16 21:38:13 copying workspace dir: /data/... Error: "2021/08/16 21:38:13 copying workspace dir: /data/... Error: "2021/08/16 21:38:13 errors loading workspace: /da... Info: "2021/08/16 21:38:13 go/packages.Load\n\tsnapshot=5... Info: "2021/08/16 21:38:14 go/packages.Load\n\tsnapshot=7... #### diagnostics: go.mod (version 3): #### outstanding work: !NO NAME(token: 5806921737724242314): 0.00 #### completed work: Load: 2 Error loading workspace: 1 Setting up workspace: 1 diagnosing initial workspace load: 1 diagnosing opened files: 1 diagnosing changed files: 2 diagnosing saved files: 2 diagnosing files changed on disk: 2 runner.go:312: closing editor: Shutdown: context deadline exceeded FAIL exitcode=1FAIL golang.org/x/tools/gopls/internal/regtest/diagnostics 356.044s ok golang.org/x/tools/gopls/internal/regtest/misc 172.164s ok golang.org/x/tools/gopls/internal/regtest/modfile 447.050s ok golang.org/x/tools/gopls/internal/regtest/watch 382.885s ok golang.org/x/tools/gopls/internal/regtest/workspace 223.106s ? golang.org/x/tools/gopls/release [no test files] ok golang.org/x/tools/gopls/test 125.546s ok golang.org/x/tools/gopls/test/debug 85.722s FAIL