openbsd-386-62 at f75ab2d5a61f1a5aabaffe7752110e2dcd581236 building tools at 16b2c8703f0724ad926b96688c79694244f278ff

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/net v0.0.0-20201021035429-f5854403a974
go: downloading golang.org/x/sys v0.0.0-20210124154548-22da62e12c0c
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/xerrors v0.0.0-20200804184101-5ec99f83aff1
ok  	golang.org/x/tools/benchmark/parse	0.040s
ok  	golang.org/x/tools/blog	0.077s
?   	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.098s
ok  	golang.org/x/tools/cmd/bundle	3.071s
ok  	golang.org/x/tools/cmd/callgraph	15.917s
?   	golang.org/x/tools/cmd/compilebench	[no test files]
ok  	golang.org/x/tools/cmd/cover	5.326s
ok  	golang.org/x/tools/cmd/digraph	0.047s
?   	golang.org/x/tools/cmd/eg	[no test files]
ok  	golang.org/x/tools/cmd/fiximports	30.649s
ok  	golang.org/x/tools/cmd/getgo	0.168s
?   	golang.org/x/tools/cmd/getgo/server	[no test files]
ok  	golang.org/x/tools/cmd/go-contrib-init	0.053s
?   	golang.org/x/tools/cmd/godex	[no test files]
ok  	golang.org/x/tools/cmd/godoc	37.352s
?   	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	31.843s
?   	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.142s
?   	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.047s
?   	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	58.715s
?   	golang.org/x/tools/cmd/toolstash	[no test files]
ok  	golang.org/x/tools/container/intsets	0.790s
ok  	golang.org/x/tools/copyright	2.102s
ok  	golang.org/x/tools/cover	0.057s
ok  	golang.org/x/tools/go/analysis	0.049s
ok  	golang.org/x/tools/go/analysis/analysistest	4.208s
ok  	golang.org/x/tools/go/analysis/internal/analysisflags	0.062s
ok  	golang.org/x/tools/go/analysis/internal/checker	1.201s
ok  	golang.org/x/tools/go/analysis/internal/facts	1.305s
ok  	golang.org/x/tools/go/analysis/multichecker	0.051s
ok  	golang.org/x/tools/go/analysis/passes/asmdecl	2.285s
ok  	golang.org/x/tools/go/analysis/passes/assign	4.531s
ok  	golang.org/x/tools/go/analysis/passes/atomic	0.531s
ok  	golang.org/x/tools/go/analysis/passes/atomicalign	2.843s
ok  	golang.org/x/tools/go/analysis/passes/bools	5.106s
ok  	golang.org/x/tools/go/analysis/passes/buildssa	0.433s
ok  	golang.org/x/tools/go/analysis/passes/buildtag	0.053s
ok  	golang.org/x/tools/go/analysis/passes/cgocall	8.440s
ok  	golang.org/x/tools/go/analysis/passes/composite	4.559s
ok  	golang.org/x/tools/go/analysis/passes/copylock	3.510s
ok  	golang.org/x/tools/go/analysis/passes/ctrlflow	3.745s
ok  	golang.org/x/tools/go/analysis/passes/deepequalerrors	4.272s
ok  	golang.org/x/tools/go/analysis/passes/errorsas	3.657s
ok  	golang.org/x/tools/go/analysis/passes/fieldalignment	0.265s
?   	golang.org/x/tools/go/analysis/passes/fieldalignment/cmd/fieldalignment	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/findcall	1.343s
?   	golang.org/x/tools/go/analysis/passes/findcall/cmd/findcall	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/framepointer	0.052s
ok  	golang.org/x/tools/go/analysis/passes/httpresponse	7.125s
ok  	golang.org/x/tools/go/analysis/passes/ifaceassert	2.368s
?   	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.467s
ok  	golang.org/x/tools/go/analysis/passes/lostcancel	5.423s
?   	golang.org/x/tools/go/analysis/passes/lostcancel/cmd/lostcancel	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/nilfunc	0.334s
ok  	golang.org/x/tools/go/analysis/passes/nilness	0.461s
?   	golang.org/x/tools/go/analysis/passes/nilness/cmd/nilness	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/pkgfact	0.455s
ok  	golang.org/x/tools/go/analysis/passes/printf	4.439s
ok  	golang.org/x/tools/go/analysis/passes/shadow	3.731s
?   	golang.org/x/tools/go/analysis/passes/shadow/cmd/shadow	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/shift	0.388s
ok  	golang.org/x/tools/go/analysis/passes/sigchanyzer	3.380s
ok  	golang.org/x/tools/go/analysis/passes/sortslice	2.640s
ok  	golang.org/x/tools/go/analysis/passes/stdmethods	7.748s
ok  	golang.org/x/tools/go/analysis/passes/stringintconv	0.333s
?   	golang.org/x/tools/go/analysis/passes/stringintconv/cmd/stringintconv	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/structtag	4.076s
ok  	golang.org/x/tools/go/analysis/passes/testinggoroutine	5.207s
ok  	golang.org/x/tools/go/analysis/passes/tests	5.892s
ok  	golang.org/x/tools/go/analysis/passes/unmarshal	4.581s
?   	golang.org/x/tools/go/analysis/passes/unmarshal/cmd/unmarshal	[no test files]
ok  	golang.org/x/tools/go/analysis/passes/unreachable	0.464s
ok  	golang.org/x/tools/go/analysis/passes/unsafeptr	3.259s
ok  	golang.org/x/tools/go/analysis/passes/unusedresult	4.062s
ok  	golang.org/x/tools/go/analysis/passes/unusedwrite	0.349s
?   	golang.org/x/tools/go/analysis/singlechecker	[no test files]
ok  	golang.org/x/tools/go/analysis/unitchecker	0.058s
ok  	golang.org/x/tools/go/ast/astutil	0.124s
ok  	golang.org/x/tools/go/ast/inspector	0.379s
ok  	golang.org/x/tools/go/buildutil	3.151s
?   	golang.org/x/tools/go/callgraph	[no test files]
ok  	golang.org/x/tools/go/callgraph/cha	0.087s
ok  	golang.org/x/tools/go/callgraph/rta	0.078s
ok  	golang.org/x/tools/go/callgraph/static	0.063s
ok  	golang.org/x/tools/go/cfg	0.031s
ok  	golang.org/x/tools/go/expect	0.053s
ok  	golang.org/x/tools/go/gccgoexportdata	0.068s
ok  	golang.org/x/tools/go/gcexportdata	0.164s
?   	golang.org/x/tools/go/internal/cgo	[no test files]
ok  	golang.org/x/tools/go/internal/gccgoimporter	0.057s
ok  	golang.org/x/tools/go/internal/gcimporter	93.631s
?   	golang.org/x/tools/go/internal/packagesdriver	[no test files]
ok  	golang.org/x/tools/go/loader	14.340s
ok  	golang.org/x/tools/go/packages	338.720s
?   	golang.org/x/tools/go/packages/gopackages	[no test files]
ok  	golang.org/x/tools/go/packages/packagestest	1.494s
ok  	golang.org/x/tools/go/pointer	6.775s
ok  	golang.org/x/tools/go/ssa	15.710s
ok  	golang.org/x/tools/go/ssa/interp	2.108s
ok  	golang.org/x/tools/go/ssa/ssautil	6.279s
ok  	golang.org/x/tools/go/types/objectpath	0.164s
ok  	golang.org/x/tools/go/types/typeutil	4.286s
ok  	golang.org/x/tools/go/vcs	0.147s
ok  	golang.org/x/tools/godoc	5.522s
?   	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.123s
ok  	golang.org/x/tools/godoc/static	3.716s
?   	golang.org/x/tools/godoc/util	[no test files]
ok  	golang.org/x/tools/godoc/vfs	0.051s
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.064s
ok  	golang.org/x/tools/godoc/vfs/zipfs	0.037s
?   	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.932s
ok  	golang.org/x/tools/internal/event	0.073s [no tests to run]
?   	golang.org/x/tools/internal/event/core	[no test files]
ok  	golang.org/x/tools/internal/event/export	0.076s
?   	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.067s
ok  	golang.org/x/tools/internal/event/export/ocagent/wire	0.158s
?   	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.046s
?   	golang.org/x/tools/internal/fakenet	[no test files]
ok  	golang.org/x/tools/internal/fastwalk	0.198s
ok  	golang.org/x/tools/internal/gocommand	0.198s
ok  	golang.org/x/tools/internal/gopathwalk	0.079s
ok  	golang.org/x/tools/internal/imports	59.377s
ok  	golang.org/x/tools/internal/jsonrpc2	0.426s
ok  	golang.org/x/tools/internal/jsonrpc2/servertest	0.061s
ok  	golang.org/x/tools/internal/lsp	72.299s
ok  	golang.org/x/tools/internal/lsp/analysis/fillreturns	6.731s
ok  	golang.org/x/tools/internal/lsp/analysis/fillstruct	3.541s
ok  	golang.org/x/tools/internal/lsp/analysis/nonewvars	3.824s
ok  	golang.org/x/tools/internal/lsp/analysis/noresultvalues	0.273s
ok  	golang.org/x/tools/internal/lsp/analysis/simplifycompositelit	0.384s
ok  	golang.org/x/tools/internal/lsp/analysis/simplifyrange	4.766s
ok  	golang.org/x/tools/internal/lsp/analysis/simplifyslice	0.303s
ok  	golang.org/x/tools/internal/lsp/analysis/undeclaredname	0.211s
ok  	golang.org/x/tools/internal/lsp/analysis/unusedparams	7.136s
?   	golang.org/x/tools/internal/lsp/browser	[no test files]
ok  	golang.org/x/tools/internal/lsp/cache	0.349s
ok  	golang.org/x/tools/internal/lsp/cmd	88.048s
?   	golang.org/x/tools/internal/lsp/cmd/test	[no test files]
ok  	golang.org/x/tools/internal/lsp/command	8.262s
?   	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.058s
ok  	golang.org/x/tools/internal/lsp/diff/difftest	0.080s
ok  	golang.org/x/tools/internal/lsp/diff/myers	0.064s
ok  	golang.org/x/tools/internal/lsp/fake	0.196s
ok  	golang.org/x/tools/internal/lsp/fuzzy	0.067s
?   	golang.org/x/tools/internal/lsp/helper	[no test files]
ok  	golang.org/x/tools/internal/lsp/lsprpc	6.701s
ok  	golang.org/x/tools/internal/lsp/mod	0.365s
?   	golang.org/x/tools/internal/lsp/protocol	[no test files]
ok  	golang.org/x/tools/internal/lsp/snippet	0.039s
ok  	golang.org/x/tools/internal/lsp/source	72.808s
ok  	golang.org/x/tools/internal/lsp/source/completion	0.095s
?   	golang.org/x/tools/internal/lsp/tests	[no test files]
ok  	golang.org/x/tools/internal/memoize	0.140s
?   	golang.org/x/tools/internal/packagesinternal	[no test files]
ok  	golang.org/x/tools/internal/proxydir	0.078s
ok  	golang.org/x/tools/internal/span	0.118s
ok  	golang.org/x/tools/internal/stack	0.042s
?   	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.172s
ok  	golang.org/x/tools/present	0.181s
ok  	golang.org/x/tools/refactor/eg	10.390s
ok  	golang.org/x/tools/refactor/importgraph	6.728s
ok  	golang.org/x/tools/refactor/rename	0.249s
?   	golang.org/x/tools/refactor/satisfy	[no test files]
ok  	golang.org/x/tools/txtar	0.044s
:: 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/jba/templatecheck v0.5.0
go: downloading honnef.co/go/tools v0.1.1
go: downloading github.com/sanity-io/litter v1.3.0
go: downloading mvdan.cc/gofumpt v0.1.0
go: downloading mvdan.cc/xurls/v2 v2.2.0
go: downloading github.com/google/safehtml v0.0.2
go: downloading github.com/sergi/go-diff v1.1.0
go: downloading golang.org/x/text v0.3.3
go: downloading github.com/google/go-cmp v0.5.4
go: downloading github.com/BurntSushi/toml v0.3.1
?   	golang.org/x/tools/gopls	[no test files]
ok  	golang.org/x/tools/gopls/doc	15.897s
?   	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.411s
ok  	golang.org/x/tools/gopls/internal/regtest	0.379s
ok  	golang.org/x/tools/gopls/internal/regtest/bench	0.319s
ok  	golang.org/x/tools/gopls/internal/regtest/codelens	31.216s
ok  	golang.org/x/tools/gopls/internal/regtest/completion	30.659s
#### Start Gopls Test Logs for "TestQuickFixEmptyFiles/full/singleton"
[Trace - 09:50:48.172 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":"/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/gopath","GOPROXY":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/proxy","GOSUMDB":"off"},"expandWorkspaceToModule":true,"experimentalDiagnosticsDelay":"10ms","verboseWorkDoneProgress":true},"trace":"messages","workspaceFolders":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work","name":"work"}]}


[Trace - 09:50:48.173 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 - 09:50:48.174 AM] Sending notification 'initialized'.
Params: {}


[Trace - 09:50:48.175 AM] Received request 'window/workDoneProgress/create - (1)'.
Params: {"token":"534275443587623213"}


[Trace - 09:50:48.175 AM] Sending response 'window/workDoneProgress/create - (1)' in 0ms.
Result: 


[Trace - 09:50:48.176 AM] Received notification '$/progress'.
Params: {"token":"534275443587623213","value":{"kind":"begin","title":"diagnosing initial workspace load","message":"Calculating diagnostics for initial workspace load..."}}


[Trace - 09:50:48.177 AM] Received request 'window/workDoneProgress/create - (2)'.
Params: {"token":"9215619702456294450"}


[Trace - 09:50:48.178 AM] Sending response 'window/workDoneProgress/create - (2)' in 0ms.
Result: 


[Trace - 09:50:48.178 AM] Received notification '$/progress'.
Params: {"token":"9215619702456294450","value":{"kind":"begin","title":"Setting up workspace","message":"Loading packages..."}}


[Trace - 09:50:48.180 AM] Received request 'workspace/configuration - (3)'.
Params: {"items":[{"scopeUri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work","section":"gopls"}]}


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


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


[Trace - 09:50:48.805 AM] Received notification '$/progress'.
Params: {"token":"9215619702456294450","value":{"kind":"end","message":"Finished loading packages."}}


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


[Trace - 09:50:48.836 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:48 go/packages.Load\n\tsnapshot=0\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[builtin mod.com/...]\n\tpackages=1\n"}


[Trace - 09:50:48.837 AM] Sending response 'client/registerCapability - (4)' in 11ms.
Result: 


[Trace - 09:50:48.912 AM] Received notification '$/progress'.
Params: {"token":"534275443587623213","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:48.917 AM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","type":1}]}


[Trace - 09:50:48.918 AM] Received request 'window/workDoneProgress/create - (5)'.
Params: {"token":"3795789878164796056"}


[Trace - 09:50:48.919 AM] Sending response 'window/workDoneProgress/create - (5)' in 1ms.
Result: 


[Trace - 09:50:48.920 AM] Received notification '$/progress'.
Params: {"token":"3795789878164796056","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 09:50:48.922 AM] 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-151981377/TestQuickFixEmptyFiles/full/singleton/work/p}","kind":7}]}}]}


[Trace - 09:50:48.923 AM] Sending response 'client/registerCapability - (6)' in 0ms.
Result: 


[Trace - 09:50:48.924 AM] Received request 'client/unregisterCapability - (7)'.
Params: {"unregisterations":[{"id":"workspace/didChangeWatchedFiles-0","method":"workspace/didChangeWatchedFiles"}]}


[Trace - 09:50:48.925 AM] Sending response 'client/unregisterCapability - (7)' in 0ms.
Result: 


[Trace - 09:50:49.193 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=1\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n\tpackages=1\n"}


[Trace - 09:50:49.223 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=1\n\tpackage=\"mod.com/p\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n"}


[Trace - 09:50:49.308 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:49.310 AM] Received notification '$/progress'.
Params: {"token":"3795789878164796056","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:49.312 AM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 09:50:49.313 AM] Received request 'window/workDoneProgress/create - (8)'.
Params: {"token":"1030016721962416240"}


[Trace - 09:50:49.314 AM] Sending response 'window/workDoneProgress/create - (8)' in 0ms.
Result: 


[Trace - 09:50:49.315 AM] Received notification '$/progress'.
Params: {"token":"1030016721962416240","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:49.319 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:49.345 AM] Received notification '$/progress'.
Params: {"token":"1030016721962416240","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:49.358 AM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":2,"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:49.391 AM] Received request 'window/workDoneProgress/create - (9)'.
Params: {"token":"7201185391176950035"}


[Trace - 09:50:49.402 AM] Sending response 'window/workDoneProgress/create - (9)' in 10ms.
Result: 


[Trace - 09:50:49.403 AM] Received notification '$/progress'.
Params: {"token":"7201185391176950035","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:49.612 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=3\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n\tpackages=1\n"}


[Trace - 09:50:49.618 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=3\n\tpackage=\"mod.com/p\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n"}


[Trace - 09:50:49.630 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go","version":2,"diagnostics":[]}


[Trace - 09:50:49.820 AM] Received notification '$/progress'.
Params: {"token":"7201185391176950035","value":{"kind":"end","message":"Done."}}


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


[Trace - 09:50:49.831 AM] Received request 'window/workDoneProgress/create - (10)'.
Params: {"token":"849635121368231514"}


[Trace - 09:50:49.832 AM] Sending response 'window/workDoneProgress/create - (10)' in 1ms.
Result: 


[Trace - 09:50:49.833 AM] Received notification '$/progress'.
Params: {"token":"849635121368231514","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:49.874 AM] Received notification '$/progress'.
Params: {"token":"849635121368231514","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:49.876 AM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go","type":1}]}


[Trace - 09:50:49.877 AM] Received request 'window/workDoneProgress/create - (11)'.
Params: {"token":"493400823683765929"}


[Trace - 09:50:49.879 AM] Sending response 'window/workDoneProgress/create - (11)' in 1ms.
Result: 


[Trace - 09:50:49.880 AM] Received notification '$/progress'.
Params: {"token":"493400823683765929","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 09:50:50.182 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=5\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n\tpackages=1\n"}


[Trace - 09:50:50.201 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=5\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 09:50:50.265 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:50.269 AM] Received notification '$/progress'.
Params: {"token":"493400823683765929","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:50.271 AM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 09:50:50.274 AM] Received request 'window/workDoneProgress/create - (12)'.
Params: {"token":"6591905403151965609"}


[Trace - 09:50:50.276 AM] Sending response 'window/workDoneProgress/create - (12)' in 1ms.
Result: 


[Trace - 09:50:50.277 AM] Received notification '$/progress'.
Params: {"token":"6591905403151965609","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:50.284 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:50.303 AM] Received notification '$/progress'.
Params: {"token":"6591905403151965609","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:50.316 AM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":2,"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:50.317 AM] Received request 'window/workDoneProgress/create - (13)'.
Params: {"token":"2312873759091576466"}


[Trace - 09:50:50.318 AM] Sending response 'window/workDoneProgress/create - (13)' in 0ms.
Result: 


[Trace - 09:50:50.319 AM] Received notification '$/progress'.
Params: {"token":"2312873759091576466","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:50.827 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=7\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n\tpackages=1\n"}


[Trace - 09:50:50.836 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=7\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 09:50:50.838 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:50.930 AM] Received notification '$/progress'.
Params: {"token":"2312873759091576466","value":{"kind":"end","message":"Done."}}


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


[Trace - 09:50:50.936 AM] Received request 'window/workDoneProgress/create - (14)'.
Params: {"token":"7827257152212568400"}


[Trace - 09:50:50.937 AM] Sending response 'window/workDoneProgress/create - (14)' in 1ms.
Result: 


[Trace - 09:50:50.938 AM] Received notification '$/progress'.
Params: {"token":"7827257152212568400","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:50.946 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:50.962 AM] Received notification '$/progress'.
Params: {"token":"7827257152212568400","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:50.963 AM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go","type":1}]}


[Trace - 09:50:50.965 AM] Received request 'window/workDoneProgress/create - (15)'.
Params: {"token":"8982474844503167665"}


[Trace - 09:50:50.966 AM] Sending response 'window/workDoneProgress/create - (15)' in 0ms.
Result: 


[Trace - 09:50:50.967 AM] Received notification '$/progress'.
Params: {"token":"8982474844503167665","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 09:50:51.301 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9\n\tpackage=\"mod.com/p\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go]\n"}


[Trace - 09:50:51.303 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[mod.com mod.com/p]\n\tpackages=2\n"}


[Trace - 09:50:51.304 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 09:50:51.713 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 09:50:51.720 AM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/02 09:50:51 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


[Trace - 09:50:51.842 AM] Received notification '$/progress'.
Params: {"token":"8982474844503167665","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:51.861 AM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 09:50:51.863 AM] Received request 'window/workDoneProgress/create - (16)'.
Params: {"token":"1960528713598030433"}


[Trace - 09:50:51.870 AM] Sending response 'window/workDoneProgress/create - (16)' in 6ms.
Result: 


[Trace - 09:50:51.874 AM] Received notification '$/progress'.
Params: {"token":"1960528713598030433","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:52.246 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:52 go/packages.Load\n\tsnapshot=10\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 09:50:52.841 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:52 go/packages.Load\n\tsnapshot=10\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 09:50:52.847 AM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/02 09:50:52 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


[Trace - 09:50:53.330 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:53 go/packages.Load\n\tsnapshot=10\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=0\n"}


[Trace - 09:50:53.333 AM] Received notification '$/progress'.
Params: {"token":"1960528713598030433","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:53.343 AM] Sending notification 'textDocument/didChange'.
Params: {"textDocument":{"version":2,"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:53.374 AM] Received request 'window/workDoneProgress/create - (17)'.
Params: {"token":"198614094973075395"}


[Trace - 09:50:53.376 AM] Sending response 'window/workDoneProgress/create - (17)' in 4ms.
Result: 


[Trace - 09:50:53.382 AM] Received notification '$/progress'.
Params: {"token":"198614094973075395","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:55.393 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:55 go/packages.Load\n\tsnapshot=11\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n\tpackages=1\n"}


[Trace - 09:50:55.401 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:55 go/packages.Load\n\tsnapshot=11\n\tpackage=\"mod.com/p [mod.com/p.test]\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go /tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


[Trace - 09:50:56.463 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:58.761 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:58 go/packages.Load\n\tsnapshot=11\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[mod.com]\n\tpackages=1\n"}


[Trace - 09:50:58.763 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:50:58 go/packages.Load\n\tsnapshot=11\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 09:50:59.010 AM] Received notification '$/progress'.
Params: {"token":"198614094973075395","value":{"kind":"end","message":"Done."}}


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


[Trace - 09:50:59.016 AM] Received request 'window/workDoneProgress/create - (18)'.
Params: {"token":"8717882922351946713"}


[Trace - 09:50:59.017 AM] Sending response 'window/workDoneProgress/create - (18)' in 0ms.
Result: 


[Trace - 09:50:59.018 AM] Received notification '$/progress'.
Params: {"token":"8717882922351946713","value":{"kind":"begin","title":"diagnosing changed files","message":"Calculating file diagnostics..."}}


[Trace - 09:50:59.063 AM] Received notification 'textDocument/publishDiagnostics'.
Params: {"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/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 - 09:50:59.136 AM] Received notification '$/progress'.
Params: {"token":"8717882922351946713","value":{"kind":"end","message":"Done."}}


[Trace - 09:50:59.144 AM] Sending notification 'workspace/didChangeWatchedFiles'.
Params: {"changes":[{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go","type":1}]}


[Trace - 09:50:59.145 AM] Received request 'window/workDoneProgress/create - (19)'.
Params: {"token":"857498332500047840"}


[Trace - 09:50:59.182 AM] Sending response 'window/workDoneProgress/create - (19)' in 37ms.
Result: 


[Trace - 09:50:59.184 AM] Received notification '$/progress'.
Params: {"token":"857498332500047840","value":{"kind":"begin","title":"diagnosing files changed on disk","message":"Calculating file diagnostics..."}}


[Trace - 09:51:01.528 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:51:01 go/packages.Load\n\tsnapshot=13\n\tpackage=\"mod.com\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/main.go]\n"}


[Trace - 09:51:01.546 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:51:01 go/packages.Load\n\tsnapshot=13\n\tpackage=\"mod.com/p [mod.com/p.test]\"\n\tfiles=[/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p.go /tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/p_test.go]\n"}


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


[Trace - 09:51:01.567 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:51:01 go/packages.Load\n\tsnapshot=13\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[mod.com mod.com/p]\n\tpackages=3\n"}


[Trace - 09:51:03.002 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:51:02 go/packages.Load\n\tsnapshot=13\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n\tpackages=0\n"}


[Trace - 09:51:03.006 AM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/02 09:51:03 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n"}


[Trace - 09:51:03.113 AM] Received notification '$/progress'.
Params: {"token":"857498332500047840","value":{"kind":"end","message":"Done."}}


[Trace - 09:51:03.116 AM] Sending notification 'textDocument/didOpen'.
Params: {"textDocument":{"uri":"file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go","languageId":"go","version":1,"text":"\n"}}


[Trace - 09:51:03.117 AM] Received request 'window/workDoneProgress/create - (20)'.
Params: {"token":"5956761487052003905"}


[Trace - 09:51:03.119 AM] Sending response 'window/workDoneProgress/create - (20)' in 1ms.
Result: 


[Trace - 09:51:03.119 AM] Received notification '$/progress'.
Params: {"token":"5956761487052003905","value":{"kind":"begin","title":"diagnosing opened files","message":"Calculating file diagnostics..."}}


[Trace - 09:51:04.727 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:51:04 go/packages.Load\n\tsnapshot=14\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n\tpackages=0\n"}


[Trace - 09:51:06.325 AM] Received notification 'window/logMessage'.
Params: {"type":3,"message":"2021/03/02 09:51:06 go/packages.Load\n\tsnapshot=14\n\tdirectory=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work\n\tquery=[file=/tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n\tpackages=0\n"}


[Trace - 09:51:06.328 AM] Received notification 'window/logMessage'.
Params: {"type":1,"message":"2021/03/02 09:51:06 reloadOrphanedFiles: failed to load: no packages returned: packages.Load error\n\tquery=[file:///tmp/workdir/tmp/gopls-regtest-151981377/TestQuickFixEmptyFiles/full/singleton/work/p/x_test.go]\n"}


#### End Gopls Test Logs for "TestQuickFixEmptyFiles/full/singleton"
--- FAIL: TestQuickFixEmptyFiles (22.84s)
    --- FAIL: TestQuickFixEmptyFiles/full (20.02s)
        --- FAIL: TestQuickFixEmptyFiles/full/singleton (20.02s)
            diagnostics_test.go:1000: 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/02 09:50:48 go env for /tmp/workdir/tmp/go...
                	Info: "2021/03/02 09:50:48 go/packages.Load\n\tsnapshot=0...
                	Info: "2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=3...
                	Info: "2021/03/02 09:50:49 go/packages.Load\n\tsnapshot=3...
                	Info: "2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=5...
                	Info: "2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=5...
                	Info: "2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=7...
                	Info: "2021/03/02 09:50:50 go/packages.Load\n\tsnapshot=7...
                	Info: "2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9...
                	Info: "2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9...
                	Info: "2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9...
                	Info: "2021/03/02 09:50:51 go/packages.Load\n\tsnapshot=9...
                	Error: "2021/03/02 09:50:51 reloadOrphanedFiles: failed t...
                	Info: "2021/03/02 09:50:52 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:50:52 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/02 09:50:52 reloadOrphanedFiles: failed t...
                	Info: "2021/03/02 09:50:53 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:50:55 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:50:55 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:50:58 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:50:58 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:51:01 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:51:01 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:51:01 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:51:01 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:51:02 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/02 09:51:03 reloadOrphanedFiles: failed t...
                	Info: "2021/03/02 09:51:04 go/packages.Load\n\tsnapshot=1...
                	Info: "2021/03/02 09:51:06 go/packages.Load\n\tsnapshot=1...
                	Error: "2021/03/02 09:51:06 reloadOrphanedFiles: failed t...
                
                #### 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:
                	diagnosing files changed on disk: 4
                	diagnosing opened files: 3
                	diagnosing changed files: 6
                	Setting up workspace: 1
                	diagnosing initial workspace load: 1
            runner.go:286: Shutdown: context deadline exceeded
FAIL
FAIL	golang.org/x/tools/gopls/internal/regtest/diagnostics	206.289s
ok  	golang.org/x/tools/gopls/internal/regtest/misc	111.224s
ok  	golang.org/x/tools/gopls/internal/regtest/modfile	135.094s
ok  	golang.org/x/tools/gopls/internal/regtest/watch	49.213s
ok  	golang.org/x/tools/gopls/internal/regtest/workspace	63.366s
?   	golang.org/x/tools/gopls/release	[no test files]
ok  	golang.org/x/tools/gopls/test	121.049s
ok  	golang.org/x/tools/gopls/test/debug	10.346s
FAIL