darwin-amd64-10_15 at 18e5d75ffb3c8d2be8c92f801aded70321e0b84b building tools at 7a079fcd7976efee71404a62f2b2be0bbc34f3a5 :: Running /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/src/make.bash with args ["/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/src/make.bash"] and env ["TERM_PROGRAM=Apple_Terminal" "TERM=xterm-256color" "SHELL=/bin/zsh" "TMPDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/" "TERM_PROGRAM_VERSION=433" "TERM_SESSION_ID=F745E033-A725-46AC-995D-38FD559F3388" "USER=gopher" "SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.czn4LcTOIK/Listeners" "PATH=/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin" "GO_BUILDER_ENV=macstadium_vm" "LaunchInstanceID=0B1C8618-4B61-4CBA-BFDA-D347A52E9850" "PWD=/Users/gopher" "LANG=en_US.UTF-8" "XPC_FLAGS=0x0" "XPC_SERVICE_NAME=0" "SHLVL=4" "HOME=/Users/gopher" "LOGNAME=gopher" "SECURITYSESSIONID=186a6" "_=./buildlet" "WORKDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15" "GOROOT_BOOTSTRAP=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go1.4" "GO_BUILDER_NAME=darwin-amd64-10_15" "GOROOT_BOOTSTRAP=/Users/gopher/goboot" "GOBIN=" "TMPDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp" "GOCACHE=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gocache"] in dir /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/src Building Go cmd/dist using /Users/gopher/goboot. (go1.13.4 darwin/amd64) Building Go toolchain1 using /Users/gopher/goboot. 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 darwin/amd64. --- Installed Go for darwin/amd64 in /private/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go Installed commands in /private/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/bin testing in module mode; GOMOD=/private/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gopath/src/golang.org/x/tools/go.mod :: Running /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/bin/go with args ["/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/bin/go" "test" "-short" "golang.org/x/tools/..."] and env ["TERM_PROGRAM=Apple_Terminal" "TERM=xterm-256color" "SHELL=/bin/zsh" "TMPDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/" "TERM_PROGRAM_VERSION=433" "TERM_SESSION_ID=F745E033-A725-46AC-995D-38FD559F3388" "USER=gopher" "SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.czn4LcTOIK/Listeners" "PATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/bin:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin" "GO_BUILDER_ENV=macstadium_vm" "LaunchInstanceID=0B1C8618-4B61-4CBA-BFDA-D347A52E9850" "PWD=/Users/gopher" "LANG=en_US.UTF-8" "XPC_FLAGS=0x0" "XPC_SERVICE_NAME=0" "SHLVL=4" "HOME=/Users/gopher" "LOGNAME=gopher" "SECURITYSESSIONID=186a6" "_=./buildlet" "WORKDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15" "GOROOT_BOOTSTRAP=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go1.4" "GO_BUILDER_NAME=darwin-amd64-10_15" "GOROOT_BOOTSTRAP=/Users/gopher/goboot" "GOROOT=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go" "GOPATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gopath" "GOPROXY=http://10.240.0.31:30157" "GOPROXY=https://proxy.golang.org" "TMPDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp" "GOCACHE=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gocache"] in dir /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gopath/src/golang.org/x/tools go: downloading golang.org/x/sys v0.0.0-20210124154548-22da62e12c0c go: downloading golang.org/x/net v0.0.0-20201021035429-f5854403a974 go: downloading golang.org/x/xerrors v0.0.0-20200804184101-5ec99f83aff1 go: downloading golang.org/x/mod v0.4.1 go: downloading github.com/yuin/goldmark v1.2.1 go: downloading golang.org/x/sync v0.0.0-20201020160332-67f06af15bc9 ok golang.org/x/tools/benchmark/parse 0.120s ok golang.org/x/tools/blog 0.194s ? 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 0.117s ok golang.org/x/tools/cmd/bundle 1.303s ok golang.org/x/tools/cmd/callgraph 12.519s ? golang.org/x/tools/cmd/compilebench [no test files] ok golang.org/x/tools/cmd/cover 2.587s ok golang.org/x/tools/cmd/digraph 0.186s ? golang.org/x/tools/cmd/eg [no test files] ok golang.org/x/tools/cmd/fiximports 20.866s ok golang.org/x/tools/cmd/getgo 0.161s ? golang.org/x/tools/cmd/getgo/server [no test files] ok golang.org/x/tools/cmd/go-contrib-init 0.135s ? golang.org/x/tools/cmd/godex [no test files] ok golang.org/x/tools/cmd/godoc 18.790s ? 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 13.461s ? 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 0.360s ? 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 0.137s ? 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 25.546s ? golang.org/x/tools/cmd/toolstash [no test files] ok golang.org/x/tools/container/intsets 1.391s ok golang.org/x/tools/copyright 2.127s ok golang.org/x/tools/cover 0.201s ok golang.org/x/tools/go/analysis 0.104s ok golang.org/x/tools/go/analysis/analysistest 5.035s ok golang.org/x/tools/go/analysis/internal/analysisflags 0.561s ok golang.org/x/tools/go/analysis/internal/checker 1.006s ok golang.org/x/tools/go/analysis/internal/facts 0.586s ok golang.org/x/tools/go/analysis/multichecker 0.175s ok golang.org/x/tools/go/analysis/passes/asmdecl 1.031s ok golang.org/x/tools/go/analysis/passes/assign 3.862s ok golang.org/x/tools/go/analysis/passes/atomic 0.268s ok golang.org/x/tools/go/analysis/passes/atomicalign 0.282s ok golang.org/x/tools/go/analysis/passes/bools 2.425s ok golang.org/x/tools/go/analysis/passes/buildssa 0.260s ok golang.org/x/tools/go/analysis/passes/buildtag 0.231s ok golang.org/x/tools/go/analysis/passes/cgocall 4.507s ok golang.org/x/tools/go/analysis/passes/composite 3.094s ok golang.org/x/tools/go/analysis/passes/copylock 2.599s ok golang.org/x/tools/go/analysis/passes/ctrlflow 4.041s ok golang.org/x/tools/go/analysis/passes/deepequalerrors 3.225s ok golang.org/x/tools/go/analysis/passes/errorsas 1.769s ok golang.org/x/tools/go/analysis/passes/fieldalignment 0.244s ? golang.org/x/tools/go/analysis/passes/fieldalignment/cmd/fieldalignment [no test files] ok golang.org/x/tools/go/analysis/passes/findcall 0.672s ? golang.org/x/tools/go/analysis/passes/findcall/cmd/findcall [no test files] ok golang.org/x/tools/go/analysis/passes/framepointer 0.296s ok golang.org/x/tools/go/analysis/passes/httpresponse 4.724s ok golang.org/x/tools/go/analysis/passes/ifaceassert 3.709s ? 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 0.264s ok golang.org/x/tools/go/analysis/passes/lostcancel 7.111s ? golang.org/x/tools/go/analysis/passes/lostcancel/cmd/lostcancel [no test files] ok golang.org/x/tools/go/analysis/passes/nilfunc 0.289s ok golang.org/x/tools/go/analysis/passes/nilness 0.241s ? golang.org/x/tools/go/analysis/passes/nilness/cmd/nilness [no test files] ok golang.org/x/tools/go/analysis/passes/pkgfact 0.226s ok golang.org/x/tools/go/analysis/passes/printf 3.392s ok golang.org/x/tools/go/analysis/passes/shadow 4.096s ? golang.org/x/tools/go/analysis/passes/shadow/cmd/shadow [no test files] ok golang.org/x/tools/go/analysis/passes/shift 0.248s ok golang.org/x/tools/go/analysis/passes/sigchanyzer 4.094s ok golang.org/x/tools/go/analysis/passes/sortslice 2.698s ok golang.org/x/tools/go/analysis/passes/stdmethods 5.531s ok golang.org/x/tools/go/analysis/passes/stringintconv 0.264s ? golang.org/x/tools/go/analysis/passes/stringintconv/cmd/stringintconv [no test files] ok golang.org/x/tools/go/analysis/passes/structtag 5.281s ok golang.org/x/tools/go/analysis/passes/testinggoroutine 7.206s ok golang.org/x/tools/go/analysis/passes/tests 2.596s ok golang.org/x/tools/go/analysis/passes/unmarshal 2.565s ? golang.org/x/tools/go/analysis/passes/unmarshal/cmd/unmarshal [no test files] ok golang.org/x/tools/go/analysis/passes/unreachable 0.253s ok golang.org/x/tools/go/analysis/passes/unsafeptr 3.323s ok golang.org/x/tools/go/analysis/passes/unusedresult 5.234s ok golang.org/x/tools/go/analysis/passes/unusedwrite 0.282s ? golang.org/x/tools/go/analysis/singlechecker [no test files] ok golang.org/x/tools/go/analysis/unitchecker 4.272s ok golang.org/x/tools/go/ast/astutil 0.139s ok golang.org/x/tools/go/ast/inspector 0.264s ok golang.org/x/tools/go/buildutil 2.354s ? golang.org/x/tools/go/callgraph [no test files] ok golang.org/x/tools/go/callgraph/cha 0.148s ok golang.org/x/tools/go/callgraph/rta 0.149s ok golang.org/x/tools/go/callgraph/static 0.158s ok golang.org/x/tools/go/cfg 0.220s ok golang.org/x/tools/go/expect 0.232s ok golang.org/x/tools/go/gccgoexportdata 0.162s ok golang.org/x/tools/go/gcexportdata 0.160s ? golang.org/x/tools/go/internal/cgo [no test files] ok golang.org/x/tools/go/internal/gccgoimporter 0.163s ok golang.org/x/tools/go/internal/gcimporter 57.031s ? golang.org/x/tools/go/internal/packagesdriver [no test files] ok golang.org/x/tools/go/loader 21.912s ok golang.org/x/tools/go/packages 176.826s ? golang.org/x/tools/go/packages/gopackages [no test files] ok golang.org/x/tools/go/packages/packagestest 0.634s ok golang.org/x/tools/go/pointer 9.901s ok golang.org/x/tools/go/ssa 19.462s ok golang.org/x/tools/go/ssa/interp 0.758s ok golang.org/x/tools/go/ssa/ssautil 8.372s ok golang.org/x/tools/go/types/objectpath 0.418s ok golang.org/x/tools/go/types/typeutil 1.728s ok golang.org/x/tools/go/vcs 0.181s ok golang.org/x/tools/godoc 2.539s ? golang.org/x/tools/godoc/analysis [no test files] ? golang.org/x/tools/godoc/golangorgenv [no test files] ok golang.org/x/tools/godoc/redirect 1.603s ok golang.org/x/tools/godoc/static 2.741s ? golang.org/x/tools/godoc/util [no test files] ok golang.org/x/tools/godoc/vfs 0.138s ok golang.org/x/tools/godoc/vfs/gatefs 0.128s ? golang.org/x/tools/godoc/vfs/httpfs [no test files] ok golang.org/x/tools/godoc/vfs/mapfs 0.170s ok golang.org/x/tools/godoc/vfs/zipfs 0.130s ? golang.org/x/tools/imports [no test files] ? golang.org/x/tools/internal/analysisinternal [no test files] ok golang.org/x/tools/internal/apidiff 1.523s ok golang.org/x/tools/internal/event 0.169s [no tests to run] ? golang.org/x/tools/internal/event/core [no test files] ok golang.org/x/tools/internal/event/export 0.158s ? 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 0.213s ok golang.org/x/tools/internal/event/export/ocagent/wire 0.125s ? 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.118s ? golang.org/x/tools/internal/fakenet [no test files] ok golang.org/x/tools/internal/fastwalk 0.152s ok golang.org/x/tools/internal/gocommand 0.147s ok golang.org/x/tools/internal/gopathwalk 0.211s ok golang.org/x/tools/internal/imports 35.489s ok golang.org/x/tools/internal/jsonrpc2 0.236s ok golang.org/x/tools/internal/jsonrpc2/servertest 0.146s ok golang.org/x/tools/internal/lsp 40.127s ok golang.org/x/tools/internal/lsp/analysis/fillreturns 8.048s ok golang.org/x/tools/internal/lsp/analysis/fillstruct 2.356s ok golang.org/x/tools/internal/lsp/analysis/nonewvars 3.629s ok golang.org/x/tools/internal/lsp/analysis/noresultvalues 0.287s ok golang.org/x/tools/internal/lsp/analysis/simplifycompositelit 0.250s ok golang.org/x/tools/internal/lsp/analysis/simplifyrange 3.789s ok golang.org/x/tools/internal/lsp/analysis/simplifyslice 0.245s ok golang.org/x/tools/internal/lsp/analysis/undeclaredname 0.238s ok golang.org/x/tools/internal/lsp/analysis/unusedparams 5.783s ? golang.org/x/tools/internal/lsp/browser [no test files] ok golang.org/x/tools/internal/lsp/cache 0.216s ok golang.org/x/tools/internal/lsp/cmd 36.487s ? golang.org/x/tools/internal/lsp/cmd/test [no test files] ok golang.org/x/tools/internal/lsp/command 4.859s ? 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 0.169s ok golang.org/x/tools/internal/lsp/diff/difftest 0.277s ok golang.org/x/tools/internal/lsp/diff/myers 0.118s ok golang.org/x/tools/internal/lsp/fake 0.165s ok golang.org/x/tools/internal/lsp/fuzzy 0.177s ? golang.org/x/tools/internal/lsp/helper [no test files] ok golang.org/x/tools/internal/lsp/lsprpc 2.460s ok golang.org/x/tools/internal/lsp/mod 0.291s ? golang.org/x/tools/internal/lsp/protocol [no test files] ok golang.org/x/tools/internal/lsp/snippet 0.110s ok golang.org/x/tools/internal/lsp/source 34.280s ok golang.org/x/tools/internal/lsp/source/completion 0.135s ? golang.org/x/tools/internal/lsp/tests [no test files] ok golang.org/x/tools/internal/memoize 0.147s ? golang.org/x/tools/internal/packagesinternal [no test files] ok golang.org/x/tools/internal/proxydir 0.110s ok golang.org/x/tools/internal/span 0.100s ok golang.org/x/tools/internal/stack 0.111s ? 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] ? 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 0.177s ok golang.org/x/tools/present 0.168s ok golang.org/x/tools/refactor/eg 6.445s ok golang.org/x/tools/refactor/importgraph 5.116s ok golang.org/x/tools/refactor/rename 0.337s ? golang.org/x/tools/refactor/satisfy [no test files] ok golang.org/x/tools/txtar 0.158s :: Running /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/bin/go with args ["/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/bin/go" "test" "-short" "golang.org/x/tools/gopls/..."] and env ["TERM_PROGRAM=Apple_Terminal" "TERM=xterm-256color" "SHELL=/bin/zsh" "TMPDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/" "TERM_PROGRAM_VERSION=433" "TERM_SESSION_ID=F745E033-A725-46AC-995D-38FD559F3388" "USER=gopher" "SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.czn4LcTOIK/Listeners" "PATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go/bin:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin" "GO_BUILDER_ENV=macstadium_vm" "LaunchInstanceID=0B1C8618-4B61-4CBA-BFDA-D347A52E9850" "PWD=/Users/gopher" "LANG=en_US.UTF-8" "XPC_FLAGS=0x0" "XPC_SERVICE_NAME=0" "SHLVL=4" "HOME=/Users/gopher" "LOGNAME=gopher" "SECURITYSESSIONID=186a6" "_=./buildlet" "WORKDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15" "GOROOT_BOOTSTRAP=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go1.4" "GO_BUILDER_NAME=darwin-amd64-10_15" "GOROOT_BOOTSTRAP=/Users/gopher/goboot" "GOROOT=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go" "GOPATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gopath" "GOPROXY=http://10.240.0.31:30157" "GOPROXY=https://proxy.golang.org" "TMPDIR=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp" "GOCACHE=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gocache"] in dir /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gopath/src/golang.org/x/tools/gopls go: downloading github.com/sergi/go-diff v1.1.0 go: downloading honnef.co/go/tools v0.1.1 go: downloading mvdan.cc/gofumpt v0.1.0 go: downloading mvdan.cc/xurls/v2 v2.2.0 go: downloading github.com/sanity-io/litter v1.3.0 go: downloading github.com/jba/templatecheck v0.5.0 go: downloading github.com/google/go-cmp v0.5.4 go: downloading github.com/google/safehtml v0.0.2 go: downloading golang.org/x/text v0.3.3 go: downloading github.com/BurntSushi/toml v0.3.1 ? golang.org/x/tools/gopls [no test files] ok golang.org/x/tools/gopls/doc 12.092s ? golang.org/x/tools/gopls/integration/govim [no test files] ? golang.org/x/tools/gopls/integration/parse [no test files] ? golang.org/x/tools/gopls/integration/replay [no test files] ok golang.org/x/tools/gopls/internal/hooks 1.280s ok golang.org/x/tools/gopls/internal/regtest 0.330s ok golang.org/x/tools/gopls/internal/regtest/bench 0.584s ok golang.org/x/tools/gopls/internal/regtest/codelens 16.543s ok golang.org/x/tools/gopls/internal/regtest/completion 21.039s #### Start Gopls Test Logs for "TestResolveDiagnosticWithDownload/singleton" [Trace - 06:52:20.582 AM] 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":{"tagSupport":{"valueSet":null},"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","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true},"trace":"messages","workspaceFolders":[{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/work","name":"work"}]} [Trace - 06:52:20.582 AM] Received response 'initialize - (1)' in 0ms. Result: {"capabilities":{"textDocumentSync":{"openClose":true,"change":2,"save":{}},"completionProvider":{"triggerCharacters":["."]},"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.test","gopls.tidy","gopls.toggle_gc_details","gopls.update_go_sum","gopls.upgrade_dependency","gopls.vendor"]},"callHierarchyProvider":true,"workspace":{"workspaceFolders":{"supported":true,"changeNotifications":"workspace/didChangeWorkspaceFolders"}}},"serverInfo":{"name":"gopls","version":"{\"path\":\"gopls, built in GOPATH mode\",\"version\":\"master\"}"}} [Trace - 06:52:20.584 AM] Sending notification 'initialized'. Params: {} [Trace - 06:52:20.585 AM] Received request 'window/workDoneProgress/create - (1)'. Params: {"token":"9029029644282286269"} [Trace - 06:52:20.586 AM] Sending response 'window/workDoneProgress/create - (1)' in 0ms. Result: [Trace - 06:52:20.586 AM] Received notification '$/progress'. Params: {"token":"9029029644282286269","value":{"kind":"begin","title":"diagnosing initial workspace load","message":"Calculating diagnostics for initial workspace load..."}} [Trace - 06:52:20.588 AM] Received request 'window/workDoneProgress/create - (2)'. Params: {"token":"8505906760983331750"} [Trace - 06:52:20.589 AM] Sending response 'window/workDoneProgress/create - (2)' in 0ms. Result: [Trace - 06:52:20.591 AM] Received notification '$/progress'. Params: {"token":"8505906760983331750","value":{"kind":"begin","title":"Setting up workspace","message":"Loading packages..."}} [Trace - 06:52:20.592 AM] Received request 'workspace/configuration - (3)'. Params: {"items":[{"scopeUri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/work","section":"gopls"}]} [Trace - 06:52:20.592 AM] Sending response 'workspace/configuration - (3)' in 0ms. Result: [{"completionBudget":"10s","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true}] [Trace - 06:52:27.479 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:27 go env for /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/work\n(root /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/work)\n(go version go version go1.16 darwin/amd64)\n(valid build configuration = true)\n(build flags: [])\nGOPROXY=file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/proxy\nGO111MODULE=\nGOMOD=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/work/go.mod\nGOMODCACHE=\nGOINSECURE=\nGOPATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/gopath\nGOPRIVATE=\nGONOPROXY=\nGONOSUMDB=\nGOROOT=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go\nGOCACHE=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gocache\nGOSUMDB=off\nGOFLAGS=\n\n"} [Trace - 06:52:39.701 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:39 go/packages.Load\n\tsnapshot=0\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-618647063/TestResolveDiagnosticWithDownload/singleton/work\n\tquery=[builtin mod.com/...]\n\tpackages=2\n"} [Trace - 06:52:40.100 AM] Received notification '$/progress'. Params: {"token":"8505906760983331750","value":{"kind":"end","message":"Finished loading packages."}} [Trace - 06:52:40.121 AM] Received request 'client/registerCapability - (4)'. Params: {"registrations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.{go,mod,sum}","kind":7}]}}]} [Trace - 06:52:40.121 AM] Sending response 'client/registerCapability - (4)' in 0ms. Result: #### End Gopls Test Logs for "TestResolveDiagnosticWithDownload/singleton" --- FAIL: TestResolveDiagnosticWithDownload (20.00s) --- FAIL: TestResolveDiagnosticWithDownload/singleton (20.00s) runner.go:289: waiting on: Unmet: completed work "diagnosing initial workspace load" at least 1 time(s) err:context deadline exceeded state: #### log messages (see RPC logs for full text): Info: "2021/03/02 06:52:27 go env for /var/folders/kh/5zz... Info: "2021/03/02 06:52:39 go/packages.Load\n\tsnapshot=0... #### diagnostics: #### outstanding work: diagnosing initial workspace load: 0.00 #### completed work: Setting up workspace: 1 runner.go:286: Shutdown: context deadline exceeded FAIL FAIL golang.org/x/tools/gopls/internal/regtest/diagnostics 135.041s ok golang.org/x/tools/gopls/internal/regtest/misc 103.815s #### Start Gopls Test Logs for "TestBadlyVersionedModule/nested/singleton" [Trace - 06:52:05.752 AM] 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":{"tagSupport":{"valueSet":null},"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","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true},"trace":"messages","workspaceFolders":[{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work","name":"work"}]} [Trace - 06:52:05.752 AM] Received response 'initialize - (1)' in 0ms. Result: {"capabilities":{"textDocumentSync":{"openClose":true,"change":2,"save":{}},"completionProvider":{"triggerCharacters":["."]},"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.test","gopls.tidy","gopls.toggle_gc_details","gopls.update_go_sum","gopls.upgrade_dependency","gopls.vendor"]},"callHierarchyProvider":true,"workspace":{"workspaceFolders":{"supported":true,"changeNotifications":"workspace/didChangeWorkspaceFolders"}}},"serverInfo":{"name":"gopls","version":"{\"path\":\"gopls, built in GOPATH mode\",\"version\":\"master\"}"}} [Trace - 06:52:05.753 AM] Sending notification 'initialized'. Params: {} [Trace - 06:52:05.753 AM] Received request 'window/workDoneProgress/create - (1)'. Params: {"token":"6556961545928831643"} [Trace - 06:52:05.755 AM] Sending response 'window/workDoneProgress/create - (1)' in 1ms. Result: [Trace - 06:52:05.755 AM] Received notification '$/progress'. Params: {"token":"6556961545928831643","value":{"kind":"begin","title":"diagnosing initial workspace load","message":"Calculating diagnostics for initial workspace load..."}} [Trace - 06:52:05.755 AM] Received request 'window/workDoneProgress/create - (2)'. Params: {"token":"5199948958991797301"} [Trace - 06:52:05.756 AM] Sending response 'window/workDoneProgress/create - (2)' in 0ms. Result: [Trace - 06:52:05.756 AM] Received notification '$/progress'. Params: {"token":"5199948958991797301","value":{"kind":"begin","title":"Setting up workspace","message":"Loading packages..."}} [Trace - 06:52:05.756 AM] Received request 'workspace/configuration - (3)'. Params: {"items":[{"scopeUri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work","section":"gopls"}]} [Trace - 06:52:05.756 AM] Sending response 'workspace/configuration - (3)' in 0ms. Result: [{"completionBudget":"10s","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true}] [Trace - 06:52:05.927 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:05 go env for /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work\n(root /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a)\n(go version go version go1.16 darwin/amd64)\n(valid build configuration = true)\n(build flags: [])\nGOFLAGS=\nGOPROXY=file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/proxy\nGOINSECURE=\nGO111MODULE=\nGOCACHE=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gocache\nGOMOD=/dev/null\nGOMODCACHE=\nGONOSUMDB=\nGOROOT=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go\nGOSUMDB=off\nGONOPROXY=\nGOPATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/gopath\nGOPRIVATE=\n\n"} [Trace - 06:52:20.029 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:20 go/packages.Load\n\tsnapshot=0\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a\n\tquery=[builtin mod.com/...]\n\tpackages=2\n"} [Trace - 06:52:20.030 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:20 example.com/blah/v2: no dep handle for example.com/blah: no metadata for example.com/blah\n\tsnapshot=0\n"} [Trace - 06:52:20.030 AM] Received notification '$/progress'. Params: {"token":"5199948958991797301","value":{"kind":"end","message":"Finished loading packages."}} [Trace - 06:52:20.031 AM] Received request 'client/registerCapability - (4)'. Params: {"registrations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.{go,mod,sum}","kind":7}]}}]} [Trace - 06:52:20.031 AM] Sending response 'client/registerCapability - (4)' in 0ms. Result: [Trace - 06:52:20.060 AM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a/go.mod","diagnostics":[{"range":{"start":{"line":4,"character":0},"end":{"line":4,"character":34}},"severity":1,"source":"compiler","message":"error while importing example.com/blah/v2: cannot find module providing package example.com/blah: import lookup disabled by -mod=readonly"},{"range":{"start":{"line":4,"character":0},"end":{"line":4,"character":34}},"severity":1,"source":"compiler","message":"error while importing example.com/blah/v2: cannot find module providing package example.com/blah: import lookup disabled by -mod=readonly"}]} [Trace - 06:52:20.061 AM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a/main.go","diagnostics":[{"range":{"start":{"line":2,"character":7},"end":{"line":2,"character":28}},"severity":1,"source":"compiler","message":"error while importing example.com/blah/v2: cannot find module providing package example.com/blah: import lookup disabled by -mod=readonly"}]} [Trace - 06:52:20.061 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:20 diagnosing go.mod: err: exit status 1: stderr: go: finding module for package example.com/blah\nmod.com imports\n\texample.com/blah/v2 imports\n\texample.com/blah: cannot find module providing package example.com/blah: module lookup disabled by GOPROXY=off\n\n"} [Trace - 06:52:20.061 AM] Received notification '$/progress'. Params: {"token":"6556961545928831643","value":{"kind":"end","message":"Done."}} [Trace - 06:52:20.062 AM] Sending notification 'textDocument/didOpen'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a/main.go","languageId":"go","version":1,"text":"package main\n\nimport \"example.com/blah/v2\"\n\nvar _ = blah.Name\n"}} [Trace - 06:52:20.062 AM] Received request 'window/workDoneProgress/create - (5)'. Params: {"token":"5990482929064819019"} [Trace - 06:52:20.062 AM] Sending response 'window/workDoneProgress/create - (5)' in 0ms. Result: [Trace - 06:52:20.062 AM] Sending notification 'textDocument/didOpen'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a/go.mod","languageId":"","version":1,"text":"module mod.com\n\ngo 1.12\n\nrequire example.com/blah/v2 v2.0.0\n"}} [Trace - 06:52:20.062 AM] Received notification '$/progress'. Params: {"token":"5990482929064819019","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}} [Trace - 06:52:20.063 AM] Sending request 'textDocument/codeAction - (2)'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a/go.mod"},"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"context":{"diagnostics":[{"range":{"start":{"line":4,"character":0},"end":{"line":4,"character":34}},"severity":1,"source":"compiler","message":"error while importing example.com/blah/v2: cannot find module providing package example.com/blah: import lookup disabled by -mod=readonly"},{"range":{"start":{"line":4,"character":0},"end":{"line":4,"character":34}},"severity":1,"source":"compiler","message":"error while importing example.com/blah/v2: cannot find module providing package example.com/blah: import lookup disabled by -mod=readonly"}],"only":["quickfix","source.fixAll"]}} [Trace - 06:52:20.064 AM] Received request 'window/workDoneProgress/create - (6)'. Params: {"token":"5089134323978233018"} [Trace - 06:52:20.064 AM] Sending response 'window/workDoneProgress/create - (6)' in 0ms. Result: [Trace - 06:52:20.065 AM] Received notification '$/progress'. Params: {"token":"5089134323978233018","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}} [Trace - 06:52:20.078 AM] Received notification '$/progress'. Params: {"token":"5990482929064819019","value":{"kind":"end","message":"Done."}} [Trace - 06:52:20.808 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:20 go/packages.Load\n\tsnapshot=2\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a\n\tquery=[builtin mod.com/...]\n\tpackages=2\n"} [Trace - 06:52:20.808 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:20 example.com/blah/v2: no dep handle for example.com/blah: no metadata for example.com/blah\n\tsnapshot=2\n"} [Trace - 06:52:20.838 AM] Received response 'textDocument/codeAction - (2)' in 774ms. Result: [{"title":"go get package example.com/blah","kind":"quickfix","diagnostics":[{"range":{"start":{"line":4,"character":0},"end":{"line":4,"character":34}},"severity":1,"source":"compiler","message":"error while importing example.com/blah/v2: cannot find module providing package example.com/blah: import lookup disabled by -mod=readonly"}],"edit":{},"command":{"title":"go get package example.com/blah","command":"gopls.go_get_package","arguments":[{"URI":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a/main.go","Pkg":"example.com/blah","AddRequire":false}]}}] [Trace - 06:52:20.838 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:20 diagnosing go.mod: err: exit status 1: stderr: go: finding module for package example.com/blah\nmod.com imports\n\texample.com/blah/v2 imports\n\texample.com/blah: cannot find module providing package example.com/blah: module lookup disabled by GOPROXY=off\n\n"} [Trace - 06:52:20.838 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:20 diagnosing go.mod: err: exit status 1: stderr: go: finding module for package example.com/blah\nmod.com imports\n\texample.com/blah/v2 imports\n\texample.com/blah: cannot find module providing package example.com/blah: module lookup disabled by GOPROXY=off\n\n"} [Trace - 06:52:20.838 AM] Sending request 'workspace/executeCommand - (3)'. Params: {"command":"gopls.go_get_package","arguments":[{"URI":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestBadlyVersionedModule/nested/singleton/work/a/main.go","Pkg":"example.com/blah","AddRequire":false}]} [Trace - 06:52:20.838 AM] Received notification '$/progress'. Params: {"token":"5089134323978233018","value":{"kind":"end","message":"Done."}} [Trace - 06:52:20.839 AM] Received request 'window/workDoneProgress/create - (7)'. Params: {"token":"6971241403795498694"} [Trace - 06:52:20.839 AM] Sending response 'window/workDoneProgress/create - (7)' in 0ms. Result: [Trace - 06:52:20.840 AM] Received notification '$/progress'. Params: {"token":"6971241403795498694","value":{"kind":"begin","title":"Running go get","cancellable":true,"message":"Running..."}} [Trace - 06:52:25.702 AM] Sending notification '$/cancelRequest'. Params: {"id":3} #### End Gopls Test Logs for "TestBadlyVersionedModule/nested/singleton" --- FAIL: TestBadlyVersionedModule (24.40s) --- FAIL: TestBadlyVersionedModule/nested (20.00s) --- FAIL: TestBadlyVersionedModule/nested/singleton (20.00s) modfile_test.go:495: no quick fixes were applied runner.go:286: Shutdown: context deadline exceeded #### Start Gopls Test Logs for "TestUnknownRevision/bad/default/singleton" [Trace - 06:52:34.508 AM] 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":{"tagSupport":{"valueSet":null},"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","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true},"trace":"messages","workspaceFolders":[{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a","name":"a"}]} [Trace - 06:52:34.508 AM] Received response 'initialize - (1)' in 0ms. Result: {"capabilities":{"textDocumentSync":{"openClose":true,"change":2,"save":{}},"completionProvider":{"triggerCharacters":["."]},"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.test","gopls.tidy","gopls.toggle_gc_details","gopls.update_go_sum","gopls.upgrade_dependency","gopls.vendor"]},"callHierarchyProvider":true,"workspace":{"workspaceFolders":{"supported":true,"changeNotifications":"workspace/didChangeWorkspaceFolders"}}},"serverInfo":{"name":"gopls","version":"{\"path\":\"gopls, built in GOPATH mode\",\"version\":\"master\"}"}} [Trace - 06:52:34.509 AM] Sending notification 'initialized'. Params: {} [Trace - 06:52:34.509 AM] Received request 'window/workDoneProgress/create - (1)'. Params: {"token":"3724427934598140041"} [Trace - 06:52:34.509 AM] Sending response 'window/workDoneProgress/create - (1)' in 0ms. Result: [Trace - 06:52:34.509 AM] Received notification '$/progress'. Params: {"token":"3724427934598140041","value":{"kind":"begin","title":"diagnosing initial workspace load","message":"Calculating diagnostics for initial workspace load..."}} [Trace - 06:52:34.510 AM] Received request 'window/workDoneProgress/create - (2)'. Params: {"token":"1205043859388862788"} [Trace - 06:52:34.510 AM] Sending response 'window/workDoneProgress/create - (2)' in 0ms. Result: [Trace - 06:52:34.510 AM] Received notification '$/progress'. Params: {"token":"1205043859388862788","value":{"kind":"begin","title":"Setting up workspace","message":"Loading packages..."}} [Trace - 06:52:34.511 AM] Received request 'workspace/configuration - (3)'. Params: {"items":[{"scopeUri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a","section":"gopls"}]} [Trace - 06:52:34.511 AM] Sending response 'workspace/configuration - (3)' in 0ms. Result: [{"completionBudget":"10s","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true}] [Trace - 06:52:36.017 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:36 go env for /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n(root /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a)\n(go version go version go1.16 darwin/amd64)\n(valid build configuration = true)\n(build flags: [])\nGOPRIVATE=\nGOSUMDB=off\nGO111MODULE=\nGOMODCACHE=\nGOCACHE=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gocache\nGOINSECURE=\nGOPROXY=file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/proxy\nGOROOT=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go\nGOFLAGS=\nGOPATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/gopath\nGONOPROXY=\nGONOSUMDB=\nGOMOD=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod\n\n"} [Trace - 06:52:37.333 AM] Received notification '$/progress'. Params: {"token":"1205043859388862788","value":{"kind":"end","message":"Finished loading packages."}} [Trace - 06:52:37.335 AM] Received request 'client/registerCapability - (5)'. Params: {"registrations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.{go,mod,sum}","kind":7}]}}]} [Trace - 06:52:37.335 AM] Sending response 'client/registerCapability - (5)' in 0ms. Result: [Trace - 06:52:37.335 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:37 diagnosing go.mod: err: exit status 1: stderr: go: example.com@v1.2.2: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:37.336 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:37 initial workspace load failed: err: exit status 1: stderr: go: example.com@v1.2.2: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:37.337 AM] Received request 'window/workDoneProgress/create - (4)'. Params: {"token":"9093919513921919021"} [Trace - 06:52:37.338 AM] Sending response 'window/workDoneProgress/create - (4)' in 0ms. Result: [Trace - 06:52:37.338 AM] Received notification '$/progress'. Params: {"token":"9093919513921919021","value":{"kind":"begin","title":"Error loading workspace","message":"err: exit status 1: stderr: go: example.com@v1.2.2: missing go.sum entry; to add it: \tgo mod download example.com : packages.Load error"}} [Trace - 06:52:37.338 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:37 errors loading workspace: err: exit status 1: stderr: go: example.com@v1.2.2: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n\tsnapshot=0\n\tdirectory=file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n"} [Trace - 06:52:37.339 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:37 go/packages.Load: err: exit status 1: stderr: go: example.com@v1.2.2: missing go.sum entry; to add it:\n\tgo mod download example.com\n\n\tsnapshot=0\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n\tquery=[builtin mod.com/...]\n\tpackages=0\n"} [Trace - 06:52:37.339 AM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod","diagnostics":[{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":19}},"severity":1,"source":"go list","message":"go.sum is out of sync with go.mod: entry for example.com@v1.2.2 is missing. Please updating it by applying the quick fix."}]} [Trace - 06:52:37.340 AM] Received notification '$/progress'. Params: {"token":"3724427934598140041","value":{"kind":"end","message":"Done."}} [Trace - 06:52:37.341 AM] Sending notification 'textDocument/didOpen'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod","languageId":"","version":1,"text":"module mod.com\n\nrequire (\n\texample.com v1.2.2\n)\n"}} [Trace - 06:52:37.341 AM] Received request 'window/workDoneProgress/create - (6)'. Params: {"token":"8267293389953062911"} [Trace - 06:52:37.342 AM] Sending notification 'textDocument/didChange'. Params: {"textDocument":{"version":2,"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"},"contentChanges":[{"range":{"start":{"line":3,"character":13},"end":{"line":3,"character":19}},"text":"v1.2.3"}]} [Trace - 06:52:37.342 AM] Sending request 'textDocument/codeAction - (2)'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"},"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"context":{"diagnostics":null,"only":["source.organizeImports"]}} [Trace - 06:52:37.343 AM] Sending response 'window/workDoneProgress/create - (6)' in 1ms. Result: [Trace - 06:52:37.343 AM] Received notification '$/progress'. Params: {"token":"8267293389953062911","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}} [Trace - 06:52:37.344 AM] Received request 'window/workDoneProgress/create - (7)'. Params: {"token":"2970700287221458280"} [Trace - 06:52:37.344 AM] Sending response 'window/workDoneProgress/create - (7)' in 0ms. Result: [Trace - 06:52:37.347 AM] Received notification '$/progress'. Params: {"token":"2970700287221458280","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}} [Trace - 06:52:37.380 AM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod","version":1,"diagnostics":[]} [Trace - 06:52:37.380 AM] Received notification '$/progress'. Params: {"token":"8267293389953062911","value":{"kind":"end","message":"Done."}} [Trace - 06:52:38.387 AM] Received response 'textDocument/codeAction - (2)' in 1045ms. Result: null [Trace - 06:52:38.388 AM] Sending request 'textDocument/formatting - (3)'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"},"options":{"tabSize":0,"insertSpaces":false}} [Trace - 06:52:38.388 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:38 initial workspace load failed: err: exit status 1: stderr: go: example.com@v1.2.2: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:38.389 AM] Received response 'textDocument/formatting - (3)' in 1ms. Result: [] [Trace - 06:52:38.389 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:38 go/packages.Load: err: exit status 1: stderr: go: example.com@v1.2.2: missing go.sum entry; to add it:\n\tgo mod download example.com\n\n\tsnapshot=1\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n\tquery=[builtin mod.com/...]\n\tpackages=0\n"} [Trace - 06:52:38.389 AM] Sending notification 'textDocument/willSave'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"},"reason":1} [Trace - 06:52:38.391 AM] Sending notification 'textDocument/didSave'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"}} [Trace - 06:52:38.396 AM] Sending notification 'textDocument/didChange'. Params: {"textDocument":{"version":3,"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"},"contentChanges":[{"text":"module mod.com\n\nrequire (\n\texample.com v1.2.3\n)\n"}]} [Trace - 06:52:38.396 AM] Sending notification 'workspace/didChangeWatchedFiles'. Params: {"changes":[{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod","type":2}]} [Trace - 06:52:38.396 AM] Received request 'window/workDoneProgress/create - (8)'. Params: {"token":"6651414131918424343"} [Trace - 06:52:38.397 AM] Sending response 'window/workDoneProgress/create - (8)' in 0ms. Result: [Trace - 06:52:38.397 AM] Received notification '$/progress'. Params: {"token":"6651414131918424343","value":{"kind":"begin","title":"diagnosing saved files","message":"Calculating file diagnostics..."}} [Trace - 06:52:38.397 AM] Received request 'window/workDoneProgress/create - (9)'. Params: {"token":"5944830206637008055"} [Trace - 06:52:38.397 AM] Sending response 'window/workDoneProgress/create - (9)' in 0ms. Result: [Trace - 06:52:38.398 AM] Received notification '$/progress'. Params: {"token":"2970700287221458280","value":{"kind":"end","message":"Done."}} [Trace - 06:52:38.398 AM] Received notification '$/progress'. Params: {"token":"5944830206637008055","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}} [Trace - 06:52:38.422 AM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod","version":2,"diagnostics":[]} [Trace - 06:52:38.423 AM] Received notification '$/progress'. Params: {"token":"6651414131918424343","value":{"kind":"end","message":"Done."}} [Trace - 06:52:39.711 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:39 go/packages.Load: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n\n\tsnapshot=3\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n\tquery=[builtin mod.com/...]\n\tpackages=0\n"} [Trace - 06:52:39.712 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:39 initial workspace load failed: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:39.712 AM] Received request 'window/workDoneProgress/create - (10)'. Params: {"token":"788787457839692041"} [Trace - 06:52:39.712 AM] Sending response 'window/workDoneProgress/create - (10)' in 0ms. Result: [Trace - 06:52:39.713 AM] Received notification '$/progress'. Params: {"token":"788787457839692041","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}} [Trace - 06:52:39.734 AM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod","version":3,"diagnostics":[]} [Trace - 06:52:39.734 AM] Received notification '$/progress'. Params: {"token":"5944830206637008055","value":{"kind":"end","message":"Done."}} [Trace - 06:52:39.999 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:39 go/packages.Load: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n\n\tsnapshot=4\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n\tquery=[builtin mod.com/...]\n\tpackages=0\n"} [Trace - 06:52:39.999 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:39 initial workspace load failed: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:40.348 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:40 go/packages.Load: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n\n\tsnapshot=5\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n\tquery=[builtin mod.com/...]\n\tpackages=0\n"} [Trace - 06:52:40.348 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:40 initial workspace load failed: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:40.349 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:40 diagnosing go.mod: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:40.350 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:40 errors loading workspace: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n\tsnapshot=5\n\tdirectory=file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a\n"} [Trace - 06:52:40.350 AM] Received notification '$/progress'. Params: {"token":"9093919513921919021","value":{"kind":"report","message":"err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it: \tgo mod download example.com : packages.Load error"}} [Trace - 06:52:40.350 AM] Received notification 'textDocument/publishDiagnostics'. Params: {"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod","version":3,"diagnostics":[{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":19}},"severity":1,"source":"go list","message":"go.sum is out of sync with go.mod: entry for example.com@v1.2.3 is missing. Please updating it by applying the quick fix."}]} [Trace - 06:52:40.352 AM] Received notification '$/progress'. Params: {"token":"788787457839692041","value":{"kind":"end","message":"Done."}} [Trace - 06:52:40.353 AM] Sending request 'textDocument/codeAction - (4)'. Params: {"textDocument":{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"},"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"context":{"diagnostics":[{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":19}},"severity":1,"source":"go list","message":"go.sum is out of sync with go.mod: entry for example.com@v1.2.3 is missing. Please updating it by applying the quick fix."}],"only":["quickfix","source.fixAll"]}} [Trace - 06:52:40.354 AM] Received notification 'window/logMessage'. Params: {"type":1,"message":"2021/03/02 06:52:40 diagnosing go.mod: err: exit status 1: stderr: go: example.com@v1.2.3: missing go.sum entry; to add it:\n\tgo mod download example.com\n: packages.Load error\n"} [Trace - 06:52:40.354 AM] Received response 'textDocument/codeAction - (4)' in 0ms. Result: [{"title":"Run go mod tidy","kind":"quickfix","diagnostics":[{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":19}},"severity":1,"source":"go list","message":"go.sum is out of sync with go.mod: entry for example.com@v1.2.3 is missing. Please updating it by applying the quick fix."}],"edit":{},"command":{"title":"Run go mod tidy","command":"gopls.tidy","arguments":[{"URIs":["file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"]}]}},{"title":"Update go.sum","kind":"quickfix","diagnostics":[{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":19}},"severity":1,"source":"go list","message":"go.sum is out of sync with go.mod: entry for example.com@v1.2.3 is missing. Please updating it by applying the quick fix."}],"edit":{},"command":{"title":"Update go.sum","command":"gopls.update_go_sum","arguments":[{"URIs":["file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"]}]}}] [Trace - 06:52:40.354 AM] Sending request 'workspace/executeCommand - (5)'. Params: {"command":"gopls.tidy","arguments":[{"URIs":["file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"]}]} [Trace - 06:52:40.357 AM] Received request 'window/workDoneProgress/create - (11)'. Params: {"token":"6175742077372812453"} [Trace - 06:52:40.357 AM] Sending response 'window/workDoneProgress/create - (11)' in 0ms. Result: [Trace - 06:52:40.358 AM] Received notification '$/progress'. Params: {"token":"6175742077372812453","value":{"kind":"begin","title":"Running go mod tidy","cancellable":true,"message":"Running..."}} [Trace - 06:52:45.721 AM] Sending notification '$/cancelRequest'. Params: {"id":5} [Trace - 06:52:45.721 AM] Received request 'workspace/applyEdit - (12)'. Params: {"edit":{"documentChanges":[{"textDocument":{"version":3,"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-371557275/TestUnknownRevision/bad/default/singleton/work/a/go.mod"},"edits":[{"range":{"start":{"line":2,"character":0},"end":{"line":2,"character":0}},"newText":"go 1.16\n\n"},{"range":{"start":{"line":2,"character":8},"end":{"line":3,"character":1}},"newText":""},{"range":{"start":{"line":4,"character":0},"end":{"line":5,"character":0}},"newText":""}]}]}} [Trace - 06:52:45.725 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:45 Shutdown session\n\tshutdown_session=17\n"} #### End Gopls Test Logs for "TestUnknownRevision/bad/default/singleton" --- FAIL: TestUnknownRevision (42.85s) --- FAIL: TestUnknownRevision/bad (28.55s) --- FAIL: TestUnknownRevision/bad/default (20.02s) --- FAIL: TestUnknownRevision/bad/default/singleton (20.02s) modfile_test.go:556: no quick fixes were applied runner.go:286: Shutdown: context deadline exceeded FAIL FAIL golang.org/x/tools/gopls/internal/regtest/modfile 111.460s #### Start Gopls Test Logs for "TestNewSymbolInTestVariant/singleton" [Trace - 06:52:05.738 AM] 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":{"tagSupport":{"valueSet":null},"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","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true},"trace":"messages","workspaceFolders":[{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work","name":"work"}]} [Trace - 06:52:05.742 AM] Received response 'initialize - (1)' in 3ms. Result: {"capabilities":{"textDocumentSync":{"openClose":true,"change":2,"save":{}},"completionProvider":{"triggerCharacters":["."]},"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.test","gopls.tidy","gopls.toggle_gc_details","gopls.update_go_sum","gopls.upgrade_dependency","gopls.vendor"]},"callHierarchyProvider":true,"workspace":{"workspaceFolders":{"supported":true,"changeNotifications":"workspace/didChangeWorkspaceFolders"}}},"serverInfo":{"name":"gopls","version":"{\"path\":\"gopls, built in GOPATH mode\",\"version\":\"master\"}"}} [Trace - 06:52:05.742 AM] Sending notification 'initialized'. Params: {} [Trace - 06:52:05.743 AM] Received request 'window/workDoneProgress/create - (1)'. Params: {"token":"6971241403795498694"} [Trace - 06:52:05.743 AM] Sending response 'window/workDoneProgress/create - (1)' in 0ms. Result: [Trace - 06:52:05.743 AM] Received notification '$/progress'. Params: {"token":"6971241403795498694","value":{"kind":"begin","title":"diagnosing initial workspace load","message":"Calculating diagnostics for initial workspace load..."}} [Trace - 06:52:05.743 AM] Received request 'window/workDoneProgress/create - (2)'. Params: {"token":"3724427934598140041"} [Trace - 06:52:05.744 AM] Sending response 'window/workDoneProgress/create - (2)' in 0ms. Result: [Trace - 06:52:05.744 AM] Received notification '$/progress'. Params: {"token":"3724427934598140041","value":{"kind":"begin","title":"Setting up workspace","message":"Loading packages..."}} [Trace - 06:52:05.744 AM] Received request 'workspace/configuration - (3)'. Params: {"items":[{"scopeUri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work","section":"gopls"}]} [Trace - 06:52:05.745 AM] Sending response 'workspace/configuration - (3)' in 0ms. Result: [{"completionBudget":"10s","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/gopath","GOPROXY":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true}] [Trace - 06:52:05.867 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:05 go env for /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work\n(root /var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work)\n(go version go version go1.16 darwin/amd64)\n(valid build configuration = true)\n(build flags: [])\nGOINSECURE=\nGOMOD=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work/go.mod\nGONOSUMDB=\nGO111MODULE=\nGOROOT=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/go\nGOPATH=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/gopath\nGOPROXY=file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/proxy\nGOCACHE=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/gocache\nGOFLAGS=\nGOMODCACHE=\nGONOPROXY=\nGOPRIVATE=\nGOSUMDB=off\n\n"} [Trace - 06:52:19.861 AM] Received notification 'window/logMessage'. Params: {"type":3,"message":"2021/03/02 06:52:19 go/packages.Load\n\tsnapshot=0\n\tdirectory=/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work\n\tquery=[builtin mod.com/...]\n\tpackages=4\n"} [Trace - 06:52:20.127 AM] Received notification '$/progress'. Params: {"token":"3724427934598140041","value":{"kind":"end","message":"Finished loading packages."}} [Trace - 06:52:20.138 AM] Received request 'client/registerCapability - (4)'. Params: {"registrations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.{go,mod,sum}","kind":7},{"globPattern":"{/var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work/a}","kind":7}]}}]} [Trace - 06:52:20.160 AM] Sending response 'client/registerCapability - (4)' in 22ms. Result: [Trace - 06:52:20.802 AM] Received notification '$/progress'. Params: {"token":"6971241403795498694","value":{"kind":"end","message":"Done."}} [Trace - 06:52:20.804 AM] Sending notification 'workspace/didChangeWatchedFiles'. Params: {"changes":[{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work/a/a.go","type":2},{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work/a/a_test.go","type":2}]} [Trace - 06:52:20.805 AM] Received request 'window/workDoneProgress/create - (5)'. Params: {"token":"1205043859388862788"} [Trace - 06:52:20.805 AM] Sending response 'window/workDoneProgress/create - (5)' in 0ms. Result: [Trace - 06:52:20.805 AM] Received notification '$/progress'. Params: {"token":"1205043859388862788","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}} [Trace - 06:52:22.279 AM] Received notification '$/progress'. Params: {"token":"1205043859388862788","value":{"kind":"end","message":"Done."}} [Trace - 06:52:25.281 AM] Sending notification 'workspace/didChangeWatchedFiles'. Params: {"changes":[{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work/a/a_test.go","type":2},{"uri":"file:///var/folders/kh/5zzynz152r94t18yzstnrwx80000gn/T/workdir-host-darwin-10_15/tmp/gopls-regtest-322320695/TestNewSymbolInTestVariant/singleton/work/a/a2_test.go","type":1}]} [Trace - 06:52:25.281 AM] Received request 'window/workDoneProgress/create - (6)'. Params: {"token":"9093919513921919021"} [Trace - 06:52:25.282 AM] Sending response 'window/workDoneProgress/create - (6)' in 0ms. Result: [Trace - 06:52:25.282 AM] Received notification '$/progress'. Params: {"token":"9093919513921919021","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}} #### End Gopls Test Logs for "TestNewSymbolInTestVariant/singleton" --- FAIL: TestNewSymbolInTestVariant (20.00s) --- FAIL: TestNewSymbolInTestVariant/singleton (20.00s) watch_test.go:749: waiting on: Unmet: once "completed work \"diagnosing files changed on disk\" at least 2 time(s)" is met, must have "no diagnostics" Unmet: once "completed work \"diagnosing files changed on disk\" at least 2 time(s)" is met, must have "no diagnostics" err:context deadline exceeded state: #### log messages (see RPC logs for full text): Info: "2021/03/02 06:52:05 go env for /var/folders/kh/5zz... Info: "2021/03/02 06:52:19 go/packages.Load\n\tsnapshot=0... #### diagnostics: #### outstanding work: diagnosing files changed on disk: 0.00 #### completed work: Setting up workspace: 1 diagnosing initial workspace load: 1 diagnosing files changed on disk: 1 runner.go:286: Shutdown: context deadline exceeded FAIL FAIL golang.org/x/tools/gopls/internal/regtest/watch 57.190s ok golang.org/x/tools/gopls/internal/regtest/workspace 77.312s ? golang.org/x/tools/gopls/release [no test files] ok golang.org/x/tools/gopls/test 102.654s ok golang.org/x/tools/gopls/test/debug 12.361s FAIL