openbsd-386-62 at 6bb96000b3215a84d0a5193e387cf809d2fa2800 building tools at 7a079fcd7976efee71404a62f2b2be0bbc34f3a5

:: Running /tmp/workdir/go/src/make.bash with args ["/tmp/workdir/go/src/make.bash"] and env ["HOME=/" "PATH=/sbin:/bin:/usr/sbin:/usr/bin:/usr/local/bin" "INRC=1" "_=/bin/sh" "WORKDIR=/tmp/workdir" "GOROOT_BOOTSTRAP=/tmp/workdir/go1.4" "GO_BUILDER_NAME=openbsd-386-62" "GO_TEST_TIMEOUT_SCALE=2" "GOBIN=" "TMPDIR=/tmp/workdir/tmp" "GOCACHE=/tmp/workdir/gocache"] in dir /tmp/workdir/go/src

Building Go cmd/dist using /tmp/workdir/go1.4. (go1.12 openbsd/386)
Building Go toolchain1 using /tmp/workdir/go1.4.
Building Go bootstrap cmd/go (go_bootstrap) using Go toolchain1.
Building Go toolchain2 using go_bootstrap and Go toolchain1.
Building Go toolchain3 using go_bootstrap and Go toolchain2.
Building packages and commands for openbsd/386.
---
Installed Go for openbsd/386 in /tmp/workdir/go
Installed commands in /tmp/workdir/go/bin
testing in module mode; GOMOD=/tmp/workdir/gopath/src/golang.org/x/tools/go.mod

:: Running /tmp/workdir/go/bin/go with args ["/tmp/workdir/go/bin/go" "test" "-short" "golang.org/x/tools/..."] and env ["HOME=/" "PATH=/tmp/workdir/go/bin:/sbin:/bin:/usr/sbin:/usr/bin:/usr/local/bin" "INRC=1" "_=/bin/sh" "WORKDIR=/tmp/workdir" "GOROOT_BOOTSTRAP=/tmp/workdir/go1.4" "GO_BUILDER_NAME=openbsd-386-62" "GO_TEST_TIMEOUT_SCALE=2" "GOROOT=/tmp/workdir/go" "GOPATH=/tmp/workdir/gopath" "GOPROXY=http://10.240.0.31:30157" "TMPDIR=/tmp/workdir/tmp" "GOCACHE=/tmp/workdir/gocache"] in dir /tmp/workdir/gopath/src/golang.org/x/tools

go: downloading golang.org/x/xerrors v0.0.0-20200804184101-5ec99f83aff1
go: downloading golang.org/x/net v0.0.0-20201021035429-f5854403a974
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
go: downloading golang.org/x/sys v0.0.0-20210124154548-22da62e12c0c
ok  	golang.org/x/tools/benchmark/parse	0.038s
ok  	golang.org/x/tools/blog	0.069s
?   	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.106s
ok  	golang.org/x/tools/cmd/bundle	3.220s
ok  	golang.org/x/tools/cmd/callgraph	15.204s
?   	golang.org/x/tools/cmd/compilebench	[no test files]
ok  	golang.org/x/tools/cmd/cover	5.870s
ok  	golang.org/x/tools/cmd/digraph	0.115s
?   	golang.org/x/tools/cmd/eg	[no test files]
ok  	golang.org/x/tools/cmd/fiximports	29.694s
ok  	golang.org/x/tools/cmd/getgo	0.107s
?   	golang.org/x/tools/cmd/getgo/server	[no test files]
ok  	golang.org/x/tools/cmd/go-contrib-init	0.049s
?   	golang.org/x/tools/cmd/godex	[no test files]
ok  	golang.org/x/tools/cmd/godoc	37.293s
?   	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	32.162s
?   	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.211s
?   	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.036s
?   	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	60.783s
?   	golang.org/x/tools/cmd/toolstash	[no test files]
ok  	golang.org/x/tools/container/intsets	0.947s
ok  	golang.org/x/tools/copyright	2.276s
ok  	golang.org/x/tools/cover	0.062s
ok  	golang.org/x/tools/go/analysis	0.089s
ok  	golang.org/x/tools/go/analysis/analysistest	4.517s
ok  	golang.org/x/tools/go/analysis/internal/analysisflags	0.062s
ok  	golang.org/x/tools/go/analysis/internal/checker	1.118s
ok  	golang.org/x/tools/go/analysis/internal/facts	1.392s
ok  	golang.org/x/tools/go/analysis/multichecker	0.050s
ok  	golang.org/x/tools/go/analysis/passes/asmdecl	2.307s
ok  	golang.org/x/tools/go/analysis/passes/assign	3.586s
ok  	golang.org/x/tools/go/analysis/passes/atomic	0.612s
ok  	golang.org/x/tools/go/analysis/passes/atomicalign	3.347s
ok  	golang.org/x/tools/go/analysis/passes/bools	4.250s
ok  	golang.org/x/tools/go/analysis/passes/buildssa	0.219s
ok  	golang.org/x/tools/go/analysis/passes/buildtag	0.030s
ok  	golang.org/x/tools/go/analysis/passes/cgocall	8.027s
ok  	golang.org/x/tools/go/analysis/passes/composite	3.062s
ok  	golang.org/x/tools/go/analysis/passes/copylock	2.947s
ok  	golang.org/x/tools/go/analysis/passes/ctrlflow	3.844s
ok  	golang.org/x/tools/go/analysis/passes/deepequalerrors	4.002s
ok  	golang.org/x/tools/go/analysis/passes/errorsas	2.077s
ok  	golang.org/x/tools/go/analysis/passes/fieldalignment	0.412s
?   	golang.org/x/tools/go/analysis/passes/fieldalignment/cmd/fieldalignment	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/findcall	1.641s
?   	golang.org/x/tools/go/analysis/passes/findcall/cmd/findcall	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/framepointer	0.056s
ok  	golang.org/x/tools/go/analysis/passes/httpresponse	7.515s
ok  	golang.org/x/tools/go/analysis/passes/ifaceassert	3.230s
?   	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.314s
ok  	golang.org/x/tools/go/analysis/passes/lostcancel	4.616s
?   	golang.org/x/tools/go/analysis/passes/lostcancel/cmd/lostcancel	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/nilfunc	0.337s
ok  	golang.org/x/tools/go/analysis/passes/nilness	0.363s
?   	golang.org/x/tools/go/analysis/passes/nilness/cmd/nilness	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/pkgfact	0.289s
ok  	golang.org/x/tools/go/analysis/passes/printf	4.529s
ok  	golang.org/x/tools/go/analysis/passes/shadow	2.962s
?   	golang.org/x/tools/go/analysis/passes/shadow/cmd/shadow	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/shift	0.406s
ok  	golang.org/x/tools/go/analysis/passes/sigchanyzer	4.792s
ok  	golang.org/x/tools/go/analysis/passes/sortslice	3.707s
ok  	golang.org/x/tools/go/analysis/passes/stdmethods	8.263s
ok  	golang.org/x/tools/go/analysis/passes/stringintconv	0.211s
?   	golang.org/x/tools/go/analysis/passes/stringintconv/cmd/stringintconv	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/structtag	5.487s
ok  	golang.org/x/tools/go/analysis/passes/testinggoroutine	4.914s
ok  	golang.org/x/tools/go/analysis/passes/tests	7.097s
ok  	golang.org/x/tools/go/analysis/passes/unmarshal	5.137s
?   	golang.org/x/tools/go/analysis/passes/unmarshal/cmd/unmarshal	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/unreachable	0.532s
ok  	golang.org/x/tools/go/analysis/passes/unsafeptr	2.991s
ok  	golang.org/x/tools/go/analysis/passes/unusedresult	4.636s
ok  	golang.org/x/tools/go/analysis/passes/unusedwrite	0.317s
?   	golang.org/x/tools/go/analysis/singlechecker	[no test files]
ok  	golang.org/x/tools/go/analysis/unitchecker	0.035s
ok  	golang.org/x/tools/go/ast/astutil	0.179s
ok  	golang.org/x/tools/go/ast/inspector	0.317s
ok  	golang.org/x/tools/go/buildutil	2.843s
?   	golang.org/x/tools/go/callgraph	[no test files]
ok  	golang.org/x/tools/go/callgraph/cha	0.077s
ok  	golang.org/x/tools/go/callgraph/rta	0.082s
ok  	golang.org/x/tools/go/callgraph/static	0.123s
ok  	golang.org/x/tools/go/cfg	0.054s
ok  	golang.org/x/tools/go/expect	0.085s
ok  	golang.org/x/tools/go/gccgoexportdata	0.105s
ok  	golang.org/x/tools/go/gcexportdata	0.121s
?   	golang.org/x/tools/go/internal/cgo	[no test files]
ok  	golang.org/x/tools/go/internal/gccgoimporter	0.076s
ok  	golang.org/x/tools/go/internal/gcimporter	91.119s
?   	golang.org/x/tools/go/internal/packagesdriver	[no test files]
ok  	golang.org/x/tools/go/loader	13.467s
ok  	golang.org/x/tools/go/packages	332.485s
?   	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	13.047s
ok  	golang.org/x/tools/go/ssa	14.061s
ok  	golang.org/x/tools/go/ssa/interp	2.100s
ok  	golang.org/x/tools/go/ssa/ssautil	7.824s
ok  	golang.org/x/tools/go/types/objectpath	0.070s
ok  	golang.org/x/tools/go/types/typeutil	2.825s
ok  	golang.org/x/tools/go/vcs	0.068s
ok  	golang.org/x/tools/godoc	4.213s
?   	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.350s
ok  	golang.org/x/tools/godoc/static	4.438s
?   	golang.org/x/tools/godoc/util	[no test files]
ok  	golang.org/x/tools/godoc/vfs	0.026s
ok  	golang.org/x/tools/godoc/vfs/gatefs	0.048s
?   	golang.org/x/tools/godoc/vfs/httpfs	[no test files]
ok  	golang.org/x/tools/godoc/vfs/mapfs	0.029s
ok  	golang.org/x/tools/godoc/vfs/zipfs	0.043s
?   	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.671s
ok  	golang.org/x/tools/internal/event	0.028s [no tests to run]
?   	golang.org/x/tools/internal/event/core	[no test files]
ok  	golang.org/x/tools/internal/event/export	0.148s
?   	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.180s
ok  	golang.org/x/tools/internal/event/export/ocagent/wire	0.050s
?   	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.059s
?   	golang.org/x/tools/internal/fakenet	[no test files]
ok  	golang.org/x/tools/internal/fastwalk	0.052s
ok  	golang.org/x/tools/internal/gocommand	0.101s
ok  	golang.org/x/tools/internal/gopathwalk	0.048s
ok  	golang.org/x/tools/internal/imports	59.070s
ok  	golang.org/x/tools/internal/jsonrpc2	0.511s
ok  	golang.org/x/tools/internal/jsonrpc2/servertest	0.062s
ok  	golang.org/x/tools/internal/lsp	73.433s
ok  	golang.org/x/tools/internal/lsp/analysis/fillreturns	8.091s
ok  	golang.org/x/tools/internal/lsp/analysis/fillstruct	4.767s
ok  	golang.org/x/tools/internal/lsp/analysis/nonewvars	5.037s
ok  	golang.org/x/tools/internal/lsp/analysis/noresultvalues	0.477s
ok  	golang.org/x/tools/internal/lsp/analysis/simplifycompositelit	0.290s
ok  	golang.org/x/tools/internal/lsp/analysis/simplifyrange	4.725s
ok  	golang.org/x/tools/internal/lsp/analysis/simplifyslice	0.280s
ok  	golang.org/x/tools/internal/lsp/analysis/undeclaredname	0.237s
ok  	golang.org/x/tools/internal/lsp/analysis/unusedparams	7.392s
?   	golang.org/x/tools/internal/lsp/browser	[no test files]
ok  	golang.org/x/tools/internal/lsp/cache	0.218s
ok  	golang.org/x/tools/internal/lsp/cmd	84.784s
?   	golang.org/x/tools/internal/lsp/cmd/test	[no test files]
ok  	golang.org/x/tools/internal/lsp/command	4.789s
?   	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.061s
ok  	golang.org/x/tools/internal/lsp/diff/difftest	0.095s
ok  	golang.org/x/tools/internal/lsp/diff/myers	0.045s
ok  	golang.org/x/tools/internal/lsp/fake	0.168s
ok  	golang.org/x/tools/internal/lsp/fuzzy	0.062s
?   	golang.org/x/tools/internal/lsp/helper	[no test files]
ok  	golang.org/x/tools/internal/lsp/lsprpc	6.452s
ok  	golang.org/x/tools/internal/lsp/mod	0.426s
?   	golang.org/x/tools/internal/lsp/protocol	[no test files]
ok  	golang.org/x/tools/internal/lsp/snippet	0.031s
ok  	golang.org/x/tools/internal/lsp/source	73.057s
ok  	golang.org/x/tools/internal/lsp/source/completion	0.192s
?   	golang.org/x/tools/internal/lsp/tests	[no test files]
ok  	golang.org/x/tools/internal/memoize	0.051s
?   	golang.org/x/tools/internal/packagesinternal	[no test files]
ok  	golang.org/x/tools/internal/proxydir	0.071s
ok  	golang.org/x/tools/internal/span	0.068s
ok  	golang.org/x/tools/internal/stack	0.161s
?   	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.098s
ok  	golang.org/x/tools/present	0.257s
ok  	golang.org/x/tools/refactor/eg	11.164s
ok  	golang.org/x/tools/refactor/importgraph	5.504s
ok  	golang.org/x/tools/refactor/rename	0.329s
?   	golang.org/x/tools/refactor/satisfy	[no test files]
ok  	golang.org/x/tools/txtar	0.035s
:: Running /tmp/workdir/go/bin/go with args ["/tmp/workdir/go/bin/go" "test" "-short" "golang.org/x/tools/gopls/..."] and env ["HOME=/" "PATH=/tmp/workdir/go/bin:/sbin:/bin:/usr/sbin:/usr/bin:/usr/local/bin" "INRC=1" "_=/bin/sh" "WORKDIR=/tmp/workdir" "GOROOT_BOOTSTRAP=/tmp/workdir/go1.4" "GO_BUILDER_NAME=openbsd-386-62" "GO_TEST_TIMEOUT_SCALE=2" "GOROOT=/tmp/workdir/go" "GOPATH=/tmp/workdir/gopath" "GOPROXY=http://10.240.0.31:30157" "TMPDIR=/tmp/workdir/tmp" "GOCACHE=/tmp/workdir/gocache"] in dir /tmp/workdir/gopath/src/golang.org/x/tools/gopls

go: downloading github.com/sergi/go-diff v1.1.0
go: downloading mvdan.cc/gofumpt v0.1.0
go: downloading honnef.co/go/tools v0.1.1
go: downloading github.com/sanity-io/litter v1.3.0
go: downloading github.com/jba/templatecheck v0.5.0
go: downloading mvdan.cc/xurls/v2 v2.2.0
go: downloading github.com/google/safehtml v0.0.2
go: downloading github.com/google/go-cmp v0.5.4
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	13.481s
?   	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	0.192s
ok  	golang.org/x/tools/gopls/internal/regtest	0.781s
ok  	golang.org/x/tools/gopls/internal/regtest/bench	0.360s
ok  	golang.org/x/tools/gopls/internal/regtest/codelens	30.373s
ok  	golang.org/x/tools/gopls/internal/regtest/completion	30.650s
#### Start Gopls Test Logs for "TestQuickFixEmptyFiles/full/singleton"
[Trace - 15:36:08.060 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":{"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":"/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/gopath","GOPROXY":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true},"trace":"messages","workspaceFolders":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work","name":"work"}]}


[Trace - 15:36:08.061 PM] Received response 'initialize - (1)' in 1ms.
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 - 15:36:08.062 PM] Sending notification 'initialized'.
Params: {}


[Trace - 15:36:08.063 PM] Received request 'window/workDoneProgress/create - (1)'.
Params: {"token":"3795789878164796056"}


[Trace - 15:36:08.064 PM] Sending response 'window/workDoneProgress/create - (1)' in 0ms.
Result: 


[Trace - 15:36:08.065 PM] Received notification '$/progress'.
Params: {"token":"3795789878164796056","value":{"kind":"begin","title":"diagnosing initial workspace load","message":"Calculating diagnostics for initial workspace load..."}}


[Trace - 15:36:08.066 PM] Received request 'window/workDoneProgress/create - (2)'.
Params: {"token":"1030016721962416240"}


[Trace - 15:36:08.066 PM] Sending response 'window/workDoneProgress/create - (2)' in 0ms.
Result: 


[Trace - 15:36:08.067 PM] Received notification '$/progress'.
Params: {"token":"1030016721962416240","value":{"kind":"begin","title":"Setting up workspace","message":"Loading packages..."}}


[Trace - 15:36:08.068 PM] Received request 'workspace/configuration - (3)'.
Params: {"items":[{"scopeUri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work","section":"gopls"}]}


[Trace - 15:36:08.069 PM] Sending response 'workspace/configuration - (3)' in 0ms.
Result: [{"completionBudget":"10s","env":{"GO111MODULE":"","GOMODCACHE":"","GOPACKAGESDRIVER":"off","GOPATH":"/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/gopath","GOPROXY":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true}]


[Trace - 15:36:08.519 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:08 go env for /tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n(root /tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work)\n(go version go version go1.15.8 openbsd/386)\n(valid build configuration = true)\n(build flags: [])\nGOCACHE=/tmp/workdir/gocache\nGOFLAGS=\nGONOSUMDB=\nGOROOT=/tmp/workdir/go\nGO111MODULE=\nGOMODCACHE=\nGOINSECURE=\nGOPRIVATE=\nGOPROXY=file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/proxy\nGOSUMDB=off\nGOMOD=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/go.mod\nGONOPROXY=\nGOPATH=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/gopath\n\n"}


[Trace - 15:36:08.690 PM] Received notification '$/progress'.
Params: {"token":"1030016721962416240","value":{"kind":"end","message":"Finished loading packages."}}


[Trace - 15:36:08.696 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:08 go/packages.Load\n\tsnapshot=0\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[builtin mod.com/...]\n\tpackages=1\n"}


[Trace - 15:36:08.745 PM] Received request 'client/registerCapability - (4)'.
Params: {"registrations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.{go,mod,sum}","kind":7}]}}]}


[Trace - 15:36:08.746 PM] Sending response 'client/registerCapability - (4)' in 1ms.
Result: 


[Trace - 15:36:08.787 PM] Received notification '$/progress'.
Params: {"token":"3795789878164796056","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:08.798 PM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","type":1}]}


[Trace - 15:36:08.819 PM] Received request 'window/workDoneProgress/create - (5)'.
Params: {"token":"7201185391176950035"}


[Trace - 15:36:08.821 PM] Sending response 'window/workDoneProgress/create - (5)' in 1ms.
Result: 


[Trace - 15:36:08.822 PM] Received notification '$/progress'.
Params: {"token":"7201185391176950035","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 15:36:08.827 PM] Received request 'client/registerCapability - (6)'.
Params: {"registrations":[{"id":"workspace/didChangeWatchedFiles-1","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.{go,mod,sum}","kind":7},{"globPattern":"{/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p}","kind":7}]}}]}


[Trace - 15:36:08.827 PM] Sending response 'client/registerCapability - (6)' in 0ms.
Result: 


[Trace - 15:36:08.829 PM] Received request 'client/unregisterCapability - (7)'.
Params: {"unregisterations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles"}]}


[Trace - 15:36:08.830 PM] Sending response 'client/unregisterCapability - (7)' in 0ms.
Result: 


[Trace - 15:36:09.192 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=1\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n\tpackages=1\n"}


[Trace - 15:36:09.217 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=1\n\tpackage=\"mod.com/p\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n"}


[Trace - 15:36:09.220 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:09 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:09.272 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"severity":1,"source":"syntax","message":"expected ';', found 'EOF'"}]}


[Trace - 15:36:09.274 PM] Received notification '$/progress'.
Params: {"token":"7201185391176950035","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:09.275 PM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 15:36:09.277 PM] Received request 'window/workDoneProgress/create - (8)'.
Params: {"token":"849635121368231514"}


[Trace - 15:36:09.278 PM] Sending response 'window/workDoneProgress/create - (8)' in 1ms.
Result: 


[Trace - 15:36:09.279 PM] Received notification '$/progress'.
Params: {"token":"849635121368231514","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:09.286 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:09 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:09.289 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","version":1,"diagnostics":[{"range":{"start":{"line":1,"character":0},"end":{"line":1,"character":0}},"severity":1,"source":"syntax","message":"expected ';', found 'EOF'"}]}


[Trace - 15:36:09.311 PM] Received notification '$/progress'.
Params: {"token":"849635121368231514","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:09.327 PM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":2,"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go"},"contentChanges":[{"range":{"start":{"line":1,"character":0},"end":{"line":1,"character":0}},"text":"package p; func DoIt(s string) {};"}]}


[Trace - 15:36:09.329 PM] Received request 'window/workDoneProgress/create - (9)'.
Params: {"token":"493400823683765929"}


[Trace - 15:36:09.330 PM] Sending response 'window/workDoneProgress/create - (9)' in 1ms.
Result: 


[Trace - 15:36:09.332 PM] Received notification '$/progress'.
Params: {"token":"493400823683765929","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:09.551 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=3\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n\tpackages=1\n"}


[Trace - 15:36:09.562 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=3\n\tpackage=\"mod.com/p\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n"}


[Trace - 15:36:09.564 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:09 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:09.570 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","version":2,"diagnostics":[]}


[Trace - 15:36:09.699 PM] Received notification '$/progress'.
Params: {"token":"493400823683765929","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:09.702 PM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":3,"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go"},"contentChanges":[{"range":{"start":{"line":0,"character":0},"end":{"line":1,"character":0}},"text":""}]}


[Trace - 15:36:09.703 PM] Received request 'window/workDoneProgress/create - (10)'.
Params: {"token":"6591905403151965609"}


[Trace - 15:36:09.705 PM] Sending response 'window/workDoneProgress/create - (10)' in 1ms.
Result: 


[Trace - 15:36:09.706 PM] Received notification '$/progress'.
Params: {"token":"6591905403151965609","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:09.713 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:09 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:09.733 PM] Received notification '$/progress'.
Params: {"token":"6591905403151965609","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:09.734 PM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go","type":1}]}


[Trace - 15:36:09.735 PM] Received request 'window/workDoneProgress/create - (11)'.
Params: {"token":"2312873759091576466"}


[Trace - 15:36:09.736 PM] Sending response 'window/workDoneProgress/create - (11)' in 1ms.
Result: 


[Trace - 15:36:09.737 PM] Received notification '$/progress'.
Params: {"token":"2312873759091576466","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 15:36:10.296 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=5\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n\tpackages=1\n"}


[Trace - 15:36:10.312 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=5\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 15:36:10.326 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:10 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:10.417 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":0}},"severity":1,"source":"syntax","message":"expected ';', found 'EOF'"}]}


[Trace - 15:36:10.420 PM] Received notification '$/progress'.
Params: {"token":"2312873759091576466","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:10.425 PM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 15:36:10.427 PM] Received request 'window/workDoneProgress/create - (12)'.
Params: {"token":"7827257152212568400"}


[Trace - 15:36:10.429 PM] Sending response 'window/workDoneProgress/create - (12)' in 1ms.
Result: 


[Trace - 15:36:10.437 PM] Received notification '$/progress'.
Params: {"token":"7827257152212568400","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:10.447 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go","version":1,"diagnostics":[{"range":{"start":{"line":1,"character":0},"end":{"line":1,"character":0}},"severity":1,"source":"syntax","message":"expected ';', found 'EOF'"}]}


[Trace - 15:36:10.449 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:10 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:10.491 PM] Received notification '$/progress'.
Params: {"token":"7827257152212568400","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:10.492 PM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":2,"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go"},"contentChanges":[{"range":{"start":{"line":1,"character":0},"end":{"line":1,"character":0}},"text":"package main\n\nimport \"mod.com/p\"\n\nfunc main() {\n\tp.DoIt(5)\n}\n"}]}


[Trace - 15:36:10.493 PM] Received request 'window/workDoneProgress/create - (13)'.
Params: {"token":"8982474844503167665"}


[Trace - 15:36:10.495 PM] Sending response 'window/workDoneProgress/create - (13)' in 1ms.
Result: 


[Trace - 15:36:10.496 PM] Received notification '$/progress'.
Params: {"token":"8982474844503167665","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:10.947 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=7\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n\tpackages=1\n"}


[Trace - 15:36:10.954 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=7\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 15:36:10.955 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go","version":2,"diagnostics":[{"range":{"start":{"line":6,"character":8},"end":{"line":6,"character":9}},"severity":1,"source":"compiler","message":"cannot convert 5 (untyped int constant) to string"}]}


[Trace - 15:36:10.957 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:10 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:11.073 PM] Received notification '$/progress'.
Params: {"token":"8982474844503167665","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:11.076 PM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":3,"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go"},"contentChanges":[{"range":{"start":{"line":0,"character":0},"end":{"line":1,"character":0}},"text":""}]}


[Trace - 15:36:11.077 PM] Received request 'window/workDoneProgress/create - (14)'.
Params: {"token":"1960528713598030433"}


[Trace - 15:36:11.078 PM] Sending response 'window/workDoneProgress/create - (14)' in 1ms.
Result: 


[Trace - 15:36:11.080 PM] Received notification '$/progress'.
Params: {"token":"1960528713598030433","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:11.089 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:11 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:11.091 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go","version":3,"diagnostics":[{"range":{"start":{"line":5,"character":8},"end":{"line":5,"character":9}},"severity":1,"source":"compiler","message":"cannot convert 5 (untyped int constant) to string"}]}


[Trace - 15:36:11.113 PM] Received notification '$/progress'.
Params: {"token":"1960528713598030433","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:11.115 PM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go","type":1}]}


[Trace - 15:36:11.116 PM] Received request 'window/workDoneProgress/create - (15)'.
Params: {"token":"198614094973075395"}


[Trace - 15:36:11.117 PM] Sending response 'window/workDoneProgress/create - (15)' in 1ms.
Result: 


[Trace - 15:36:11.118 PM] Received notification '$/progress'.
Params: {"token":"198614094973075395","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 15:36:11.479 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9\n\tpackage=\"mod.com/p\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n"}


[Trace - 15:36:11.525 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 15:36:11.528 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[mod.com mod.com/p]\n\tpackages=2\n"}


[Trace - 15:36:11.790 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 15:36:11.796 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:11 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


[Trace - 15:36:11.799 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:11 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:11.822 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:11 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:11.908 PM] Received notification '$/progress'.
Params: {"token":"198614094973075395","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:11.910 PM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 15:36:11.912 PM] Received request 'window/workDoneProgress/create - (16)'.
Params: {"token":"8717882922351946713"}


[Trace - 15:36:11.914 PM] Sending response 'window/workDoneProgress/create - (16)' in 2ms.
Result: 


[Trace - 15:36:11.915 PM] Received notification '$/progress'.
Params: {"token":"8717882922351946713","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:12.327 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:12 go/packages.Load\n\tsnapshot=10\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 15:36:12.596 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:12 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


[Trace - 15:36:12.611 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:12 go/packages.Load\n\tsnapshot=10\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 15:36:12.615 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:12 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:12.618 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:12 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:13.131 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:13 go/packages.Load\n\tsnapshot=10\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 15:36:13.137 PM] Received notification '$/progress'.
Params: {"token":"8717882922351946713","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:13.140 PM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":2,"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go"},"contentChanges":[{"range":{"start":{"line":1,"character":0},"end":{"line":1,"character":0}},"text":"package p\n\nimport \"testing\"\n\nfunc TestDoIt(t *testing.T) {\n\tDoIt(5)\n}\n"}]}


[Trace - 15:36:13.141 PM] Received request 'window/workDoneProgress/create - (17)'.
Params: {"token":"857498332500047840"}


[Trace - 15:36:13.143 PM] Sending response 'window/workDoneProgress/create - (17)' in 1ms.
Result: 


[Trace - 15:36:13.144 PM] Received notification '$/progress'.
Params: {"token":"857498332500047840","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:15.039 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:15 go/packages.Load\n\tsnapshot=11\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=1\n"}


[Trace - 15:36:15.057 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:15 go/packages.Load\n\tsnapshot=11\n\tpackage=\"mod.com/p [mod.com/p.test]\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go /tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


[Trace - 15:36:16.352 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go","version":2,"diagnostics":[{"range":{"start":{"line":6,"character":6},"end":{"line":6,"character":7}},"severity":1,"source":"compiler","message":"cannot convert 5 (untyped int constant) to string"}]}


[Trace - 15:36:18.387 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:18 go/packages.Load\n\tsnapshot=11\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[mod.com]\n\tpackages=1\n"}


[Trace - 15:36:18.395 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:18 go/packages.Load\n\tsnapshot=11\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 15:36:18.397 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:18 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:18.549 PM] Received notification '$/progress'.
Params: {"token":"857498332500047840","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:18.552 PM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":3,"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go"},"contentChanges":[{"range":{"start":{"line":0,"character":0},"end":{"line":1,"character":0}},"text":""}]}


[Trace - 15:36:18.554 PM] Received request 'window/workDoneProgress/create - (18)'.
Params: {"token":"5956761487052003905"}


[Trace - 15:36:18.555 PM] Sending response 'window/workDoneProgress/create - (18)' in 1ms.
Result: 


[Trace - 15:36:18.556 PM] Received notification '$/progress'.
Params: {"token":"5956761487052003905","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:18.576 PM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go","version":3,"diagnostics":[{"range":{"start":{"line":5,"character":6},"end":{"line":5,"character":7}},"severity":1,"source":"compiler","message":"cannot convert 5 (untyped int constant) to string"}]}


[Trace - 15:36:18.614 PM] Received notification '$/progress'.
Params: {"token":"5956761487052003905","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:18.616 PM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go","type":1}]}


[Trace - 15:36:18.618 PM] Received request 'window/workDoneProgress/create - (19)'.
Params: {"token":"2876636394410322752"}


[Trace - 15:36:18.619 PM] Sending response 'window/workDoneProgress/create - (19)' in 1ms.
Result: 


[Trace - 15:36:18.620 PM] Received notification '$/progress'.
Params: {"token":"2876636394410322752","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 15:36:20.596 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=13\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[mod.com mod.com/p]\n\tpackages=3\n"}


[Trace - 15:36:20.601 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=13\n\tpackage=\"mod.com/p [mod.com/p.test]\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go /tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


[Trace - 15:36:20.603 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=13\n\tpackage=\"mod.com/p\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n"}


[Trace - 15:36:20.606 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=13\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 15:36:23.435 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:23 go/packages.Load\n\tsnapshot=13\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n\tpackages=0\n"}


[Trace - 15:36:23.443 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:23 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n"}


[Trace - 15:36:23.469 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:23 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:23.470 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:23 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


[Trace - 15:36:23.603 PM] Received notification '$/progress'.
Params: {"token":"2876636394410322752","value":{"kind":"end","message":"Done."}}


[Trace - 15:36:23.606 PM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 15:36:23.608 PM] Received request 'window/workDoneProgress/create - (20)'.
Params: {"token":"4136353673894269217"}


[Trace - 15:36:23.609 PM] Sending response 'window/workDoneProgress/create - (20)' in 1ms.
Result: 


[Trace - 15:36:23.610 PM] Received notification '$/progress'.
Params: {"token":"4136353673894269217","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 15:36:25.037 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:25 go/packages.Load\n\tsnapshot=14\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n\tpackages=0\n"}


[Trace - 15:36:27.161 PM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/01 15:36:27 go/packages.Load\n\tsnapshot=14\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n\tpackages=0\n"}


[Trace - 15:36:27.167 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:27 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-175016698/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n"}


[Trace - 15:36:27.173 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:27 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/p/p.go in mod.com/p\n\tpackage=\"mod.com/p\"\n"}


[Trace - 15:36:27.176 PM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/01 15:36:27 unable to compute error positions: no parsed file for file:///tmp/workdir/gopath/src/golang.org/x/tools/gopls/internal/regtest/diagnostics/main.go in mod.com\n\tpackage=\"mod.com\"\n"}


#### End Gopls Test Logs for "TestQuickFixEmptyFiles/full/singleton"
--- FAIL: TestQuickFixEmptyFiles (23.21s)
    --- FAIL: TestQuickFixEmptyFiles/full (20.02s)
        --- FAIL: TestQuickFixEmptyFiles/full/singleton (20.02s)
            diagnostics_test.go:1009: waiting on:
                	Unmet: completed work "diagnosing opened files" at least 4 time(s)
                
                err:context deadline exceeded
                
                state:
                #### log messages (see RPC logs for full text):
                	Info: "2021/03/01 15:36:08 go env for /tmp/workdir/tmp/go...
                	Info: "2021/03/01 15:36:08 go/packages.Load\n\tsnapshot=0...
                	Info: "2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/01 15:36:09 unable to compute error posit...
                	Error: "2021/03/01 15:36:09 unable to compute error posit...
                	Info: "2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=3...
                	Info: "2021/03/01 15:36:09 go/packages.Load\n\tsnapshot=3...
                	Error: "2021/03/01 15:36:09 unable to compute error posit...
                	Error: "2021/03/01 15:36:09 unable to compute error posit...
                	Info: "2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=5...
                	Info: "2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=5...
                	Error: "2021/03/01 15:36:10 unable to compute error posit...
                	Error: "2021/03/01 15:36:10 unable to compute error posit...
                	Info: "2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=7...
                	Info: "2021/03/01 15:36:10 go/packages.Load\n\tsnapshot=7...
                	Error: "2021/03/01 15:36:10 unable to compute error posit...
                	Error: "2021/03/01 15:36:11 unable to compute error posit...
                	Info: "2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9...
                	Info: "2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9...
                	Info: "2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9...
                	Info: "2021/03/01 15:36:11 go/packages.Load\n\tsnapshot=9...
                	Error: "2021/03/01 15:36:11 reloadOrphanedFiles: failed t...
                	Error: "2021/03/01 15:36:11 unable to compute error posit...
                	Error: "2021/03/01 15:36:11 unable to compute error posit...
                	Info: "2021/03/01 15:36:12 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/01 15:36:12 reloadOrphanedFiles: failed t...
                	Info: "2021/03/01 15:36:12 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/01 15:36:12 unable to compute error posit...
                	Error: "2021/03/01 15:36:12 unable to compute error posit...
                	Info: "2021/03/01 15:36:13 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:15 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:15 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:18 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:18 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/01 15:36:18 unable to compute error posit...
                	Info: "2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:20 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:23 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/01 15:36:23 reloadOrphanedFiles: failed t...
                	Error: "2021/03/01 15:36:23 unable to compute error posit...
                	Error: "2021/03/01 15:36:23 unable to compute error posit...
                	Info: "2021/03/01 15:36:25 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/01 15:36:27 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/01 15:36:27 reloadOrphanedFiles: failed t...
                	Error: "2021/03/01 15:36:27 unable to compute error posit...
                	Error: "2021/03/01 15:36:27 unable to compute error posit...
                
                #### diagnostics:
                	p/p.go (version 2):
                	main.go (version 3):
                		(5, 8): cannot convert 5 (untyped int constant) to string
                	p/p_test.go (version 3):
                		(5, 6): cannot convert 5 (untyped int constant) to string
                
                #### outstanding work:
                	diagnosing opened files: 0.00
                #### completed work:
                	Setting up workspace: 1
                	diagnosing initial workspace load: 1
                	diagnosing files changed on disk: 4
                	diagnosing opened files: 3
                	diagnosing changed files: 6
            runner.go:286: Shutdown: context deadline exceeded
FAIL
FAIL	golang.org/x/tools/gopls/internal/regtest/diagnostics	207.971s
ok  	golang.org/x/tools/gopls/internal/regtest/misc	110.236s
ok  	golang.org/x/tools/gopls/internal/regtest/modfile	133.540s
ok  	golang.org/x/tools/gopls/internal/regtest/watch	49.092s
ok  	golang.org/x/tools/gopls/internal/regtest/workspace	65.290s
?   	golang.org/x/tools/gopls/release	[no test files]
ok  	golang.org/x/tools/gopls/test	131.659s
ok  	golang.org/x/tools/gopls/test/debug	11.044s
FAIL