x/tools/gopls: changing package names returns an error

[ianthehat]

Originally reported in microsoft/vscode-go#2520

If you edit the package name, something in the caching causes persistent errors until a gopls restart.

[gopherbot]

Change https://golang.org/cl/178162 mentions this issue: internal/lsp: re-run go/packages.Load when the package name changes

[stamblerre]

Re-opening because this doesn't work if you don't save the file. I imagine that's likely because go/packages needs to be looking at the overlay for the package name, but I'm not certain.

[stamblerre]

/cc @matloob

[stamblerre]

This issue persists. It takes saving the file and then editing it for the diagnostic to go away.

Logs

[Trace - 6:19:46 PM] Received notification 'window/logMessage' in 0ms. Params: {"type":3,"message":"14.588171ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go \"list\" \"-e\" \"-json\" \"-compiled=true\" \"-test=true\" \"-export=false\" \"-deps=true\" \"-find=false\" \"--\" \"builtin\", stderr: \u003c\u003c\u003e\u003e\n"}

[Trace - 6:19:46 PM] Received response 'initialize - (0)' in 0ms.
Params: {"capabilities":{"textDocumentSync":{"openClose":true,"change":2,"save":{}},"hoverProvider":true,"completionProvider":{"triggerCharacters":["."]},"signatureHelpProvider":{"triggerCharacters":["(",","]},"definitionProvider":true,"referencesProvider":true,"documentHighlightProvider":true,"documentSymbolProvider":true,"codeActionProvider":true,"documentFormattingProvider":true,"renameProvider":true,"documentLinkProvider":{},"typeDefinitionProvider":true,"workspace":{"workspaceFolders":{"supported":true,"changeNotifications":"workspace/didChangeWorkspaceFolders"}}},"custom":null}

[Trace - 6:19:46 PM] Sending notification 'initialize' in 16ms.
Params: {"processId":70062,"rootPath":"$HOME/mod1","rootUri":"file://$HOME/mod1","capabilities":{"workspace":{"applyEdit":true,"workspaceEdit":{"documentChanges":true},"didChangeConfiguration":{"dynamicRegistration":true},"didChangeWatchedFiles":{"dynamicRegistration":true},"symbol":{"dynamicRegistration":true,"symbolKind":{"valueSet":[1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26]}},"executeCommand":{"dynamicRegistration":true},"configuration":true,"workspaceFolders":true},"textDocument":{"publishDiagnostics":{"relatedInformation":true},"synchronization":{"dynamicRegistration":true,"willSave":true,"willSaveWaitUntil":true,"didSave":true},"completion":{"dynamicRegistration":true,"contextSupport":true,"completionItem":{"snippetSupport":true,"commitCharactersSupport":true,"documentationFormat":["markdown","plaintext"],"deprecatedSupport":true,"preselectSupport":true},"completionItemKind":{"valueSet":[1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25]}},"hover":{"dynamicRegistration":true,"contentFormat":["markdown","plaintext"]},"signatureHelp":{"dynamicRegistration":true,"signatureInformation":{"documentationFormat":["markdown","plaintext"]}},"definition":{"dynamicRegistration":true},"references":{"dynamicRegistration":true},"documentHighlight":{"dynamicRegistration":true},"documentSymbol":{"dynamicRegistration":true,"symbolKind":{"valueSet":[1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26]},"hierarchicalDocumentSymbolSupport":true},"codeAction":{"dynamicRegistration":true,"codeActionLiteralSupport":{"codeActionKind":{"valueSet":["","quickfix","refactor","refactor.extract","refactor.inline","refactor.rewrite","source","source.organizeImports"]}}},"codeLens":{"dynamicRegistration":true},"formatting":{"dynamicRegistration":true},"rangeFormatting":{"dynamicRegistration":true},"onTypeFormatting":{"dynamicRegistration":true},"rename":{"dynamicRegistration":true},"documentLink":{"dynamicRegistration":true},"typeDefinition":{"dynamicRegistration":true},"implementation":{"dynamicRegistration":true},"colorProvider":{"dynamicRegistration":true},"foldingRange":{"dynamicRegistration":true,"rangeLimit":5000,"lineFoldingOnly":true}}},"initializationOptions":{"funcSnippetEnabled":false,"gocodeCompletionEnabled":true},"trace":"off","workspaceFolders":[{"uri":"file://$HOME/mod1","name":"mod1"}]}

[Info - 6:19:46 PM] 14.588171ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "builtin", stderr: <<>>

[Trace - 6:19:46 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"15.678206ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:46 PM] 15.678206ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:46 PM] Sending response 'client/registerCapability - (1)' in 0ms.
Params: {}

[Trace - 6:19:46 PM] Received notification 'client/registerCapability' in 2ms.
Params: {"registrations":[{"id":"workspace/didChangeConfiguration","method":"workspace/didChangeConfiguration"},{"id":"workspace/didChangeWorkspaceFolders","method":"workspace/didChangeWorkspaceFolders"}]}

[Trace - 6:19:46 PM] Sending response 'workspace/configuration - (2)' in 0ms.
Params: [{"wantCompletionDocumentation":false,"useDeepCompletions":true,"hoverKind":"FullDocumentation"},null]

[Trace - 6:19:46 PM] Received notification 'workspace/configuration' in 2ms.
Params: {"items":[{"scopeUri":"file://$HOME/mod1","section":"gopls"},{"scopeUri":"file://$HOME/mod1","section":"mod1"}]}

[Trace - 6:19:46 PM] Sending notification 'initialized' in 206ms.
Params: {}

[Trace - 6:19:46 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"Build info\n----------\ngolang.org/x/tools/cmd/gopls v0.1.3-cmd.gopls\n golang.org/x/tools@(devel)\n golang.org/x/[email protected] h1:8gQV6CLnAEikrhgkHFbMAEhagSSnXWGV915qUMm9mrU=\n golang.org/x/[email protected] h1:9zdDQZ7Thm29KFXgAX/+yaf3eVbP7djjWp/dXAppNCc=\n\nGo info\n-------\ngo version go1.12.5 linux/amd64\n\nGOARCH="amd64"\nGOBIN="$HOME/code/bin"\nGOCACHE="$HOME/.cache/go-build"\nGOEXE=""\nGOFLAGS=""\nGOHOSTARCH="amd64"\nGOHOSTOS="linux"\nGOOS="linux"\nGOPATH="$HOME/code"\nGOPROXY="https://proxy.golang.org\"\nGORACE=\"\"\nGOROOT=\"$GOROOT\"\nGOTMPDIR=\"\"\nGOTOOLDIR=\"$GOROOTpkg/tool/linux_amd64\"\nGCCGO=\"gccgo\"\nCC=\"clang\"\nCXX=\"clang++\"\nCGO_ENABLED=\"1\"\nGOMOD=\"$HOME/mod1/go.mod\"\nCGO_CFLAGS=\"-g -O2"\nCGO_CPPFLAGS=""\nCGO_CXXFLAGS="-g -O2"\nCGO_FFLAGS="-g -O2"\nCGO_LDFLAGS="-g -O2"\nPKG_CONFIG="pkg-config"\nGOGCCFLAGS="-fPIC -m64 -pthread -fno-caret-diagnostics -Qunused-arguments -fmessage-length=0 -fdebug-prefix-map=/tmp/go-build007804254=/tmp/go-build -gno-record-gcc-switches"\n"}

[Trace - 6:19:46 PM] Sending notification 'textDocument/didOpen' in 206ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","languageId":"go","version":1,"text":"package bob\n\nimport (\n\t"fmt"\n\n\t"rsc.io/quote"\n)\n\nfunc _() {\n\tfmt.Println("hello")\n\tquote.Glass()\n\tquote.Glass()\n}\n"}}

[Info - 6:19:46 PM] Build info

golang.org/x/tools/cmd/gopls v0.1.3-cmd.gopls
golang.org/x/tools@(devel)
golang.org/x/[email protected] h1:8gQV6CLnAEikrhgkHFbMAEhagSSnXWGV915qUMm9mrU=
golang.org/x/[email protected] h1:9zdDQZ7Thm29KFXgAX/+yaf3eVbP7djjWp/dXAppNCc=

Go info

go version go1.12.5 linux/amd64

GOARCH="amd64"
GOBIN="$HOME/code/bin"
GOCACHE="$HOME/.cache/go-build"
GOEXE=""
GOFLAGS=""
GOHOSTARCH="amd64"
GOHOSTOS="linux"
GOOS="linux"
GOPATH="$HOME/code"
GOPROXY="https://proxy.golang.org"
GORACE=""
GOROOT="$GOROOT"
GOTMPDIR=""
GOTOOLDIR="$GOROOTpkg/tool/linux_amd64"
GCCGO="gccgo"
CC="clang"
CXX="clang++"
CGO_ENABLED="1"
GOMOD="$HOME/mod1/go.mod"
CGO_CFLAGS="-g -O2"
CGO_CPPFLAGS=""
CGO_CXXFLAGS="-g -O2"
CGO_FFLAGS="-g -O2"
CGO_LDFLAGS="-g -O2"
PKG_CONFIG="pkg-config"
GOGCCFLAGS="-fPIC -m64 -pthread -fno-caret-diagnostics -Qunused-arguments -fmessage-length=0 -fdebug-prefix-map=/tmp/go-build007804254=/tmp/go-build -gno-record-gcc-switches"

[Info - 6:19:47 PM] 22.072739ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:47 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"22.072739ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:47 PM] 107.067768ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:47 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"107.067768ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:47 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:19:47 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:47 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 1"}

[Info - 6:19:47 PM] go/packages.Load
packages = 1
[Trace - 6:19:47 PM] Received response 'textDocument/documentSymbol - (1)' in 0ms.
Params: [{"name":"_","detail":"()","kind":12,"range":{"start":{"line":8,"character":0},"end":{"line":12,"character":1}},"selectionRange":{"start":{"line":8,"character":5},"end":{"line":8,"character":6}}}]

[Trace - 6:19:47 PM] Sending notification 'textDocument/documentSymbol' in 435ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:19:47 PM] Received response 'textDocument/documentLink - (2)' in 0ms.
Params: [{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":6}},"target":"https://godoc.org/fmt"},{"range":{"start":{"line":5,"character":1},"end":{"line":5,"character":15}},"target":"https://godoc.org/rsc.io/quote"}]

[Trace - 6:19:47 PM] Sending notification 'textDocument/documentLink' in 435ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:19:47 PM] Received response 'textDocument/documentHighlight - (3)' in 0ms.
Params: []

[Trace - 6:19:47 PM] Sending notification 'textDocument/documentHighlight' in 69ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"position":{"line":9,"character":19}}

[Error - 6:19:47 PM] no highlight: $HOME/mod1/mod1.go:10:20 is not an identifier
Span = $HOME/mod1/mod1.go:10:20
[Trace - 6:19:47 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":1,"message":"no highlight: $HOME/mod1/mod1.go:10:20 is not an identifier\n\tSpan = $HOME/mod1/mod1.go:10:20"}

[Trace - 6:19:47 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[]}

[Trace - 6:19:47 PM] Received response 'textDocument/codeAction - (4)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:19:47 PM] Sending notification 'textDocument/codeAction' in 23ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":9,"character":19},"end":{"line":9,"character":19}},"context":{"diagnostics":[]}}

[Trace - 6:19:49 PM] Received response 'textDocument/codeAction - (5)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:19:49 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":8,"character":10},"end":{"line":8,"character":10}},"context":{"diagnostics":[]}}

[Trace - 6:19:51 PM] Received response 'textDocument/documentHighlight - (6)' in 0ms.
Params: []

[Trace - 6:19:51 PM] Sending notification 'textDocument/documentHighlight' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"position":{"line":0,"character":8}}

[Trace - 6:19:51 PM] Received response 'textDocument/codeAction - (7)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:19:51 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":0,"character":8},"end":{"line":0,"character":11}},"context":{"diagnostics":[]}}

[Trace - 6:19:51 PM] Received response 'textDocument/hover - (8)' in 0ms.
Params: {}

[Trace - 6:19:51 PM] Sending notification 'textDocument/hover' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"position":{"line":0,"character":7}}

[Trace - 6:19:52 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":2},"contentChanges":[{"range":{"start":{"line":0,"character":8},"end":{"line":0,"character":11}},"rangeLength":3,"text":"m"}]}

[Info - 6:19:52 PM] 16.733987ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"16.733987ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:52 PM] 136.121199ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"136.121199ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:52 PM] go/packages.Load
packages = 1
[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 1"}

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:52 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"severity":1,"source":"LSP","message":"package m; expected bob"}]}

[Info - 6:19:52 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:19:52 PM] Received response 'textDocument/completion - (9)' in 0ms.
Params: {"isIncomplete":false,"items":[{"label":"make","kind":3,"detail":"func(t Type, size ...int) Type","sortText":"00022","filterText":"make","insertTextFormat":2,"textEdit":{"range":{"start":{"line":0,"character":8},"end":{"line":0,"character":9}},"newText":"make(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}}]}

[Trace - 6:19:52 PM] Sending notification 'textDocument/completion' in 156ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"position":{"line":0,"character":9},"context":{"triggerKind":1}}

[Trace - 6:19:52 PM] Sending notification 'textDocument/didChange' in 12ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":3},"contentChanges":[{"range":{"start":{"line":0,"character":9},"end":{"line":0,"character":9}},"rangeLength":0,"text":"o"}]}

[Info - 6:19:52 PM] 17.462686ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"17.462686ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:52 PM] 114.314513ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"114.314513ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:52 PM] go/packages.Load
package = ../../../mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = ../../../mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 2"}

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:52 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"severity":1,"source":"LSP","message":"package mo; expected bob"}]}

[Trace - 6:19:52 PM] Sending notification 'textDocument/didChange' in 64ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":4},"contentChanges":[{"range":{"start":{"line":0,"character":10},"end":{"line":0,"character":10}},"rangeLength":0,"text":"d"}]}

[Info - 6:19:52 PM] go/packages.Load
packages = 2
[Info - 6:19:52 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Info - 6:19:52 PM] 15.866529ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"15.866529ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:52 PM] 118.592841ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"118.592841ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:52 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 1"}

[Trace - 6:19:52 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"severity":1,"source":"LSP","message":"package mod; expected bob"}]}

[Info - 6:19:52 PM] go/packages.Load
packages = 1
[Trace - 6:19:52 PM] Received response 'textDocument/completion - (10)' in 0ms.
Params: {"isIncomplete":false,"items":[]}

[Trace - 6:19:52 PM] Sending notification 'textDocument/completion' in 202ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"position":{"line":0,"character":11},"context":{"triggerKind":1}}

[Trace - 6:19:52 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":5},"contentChanges":[{"range":{"start":{"line":0,"character":11},"end":{"line":0,"character":11}},"rangeLength":0,"text":"1"}]}

[Info - 6:19:52 PM] 18.394222ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"18.394222ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:52 PM] 110.972576ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"110.972576ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:52 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 1"}

[Trace - 6:19:52 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"severity":1,"source":"LSP","message":"package mod1; expected bob"}]}

[Info - 6:19:52 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Info - 6:19:52 PM] go/packages.Load
packages = 1
[Trace - 6:19:52 PM] Received response 'textDocument/documentSymbol - (11)' in 0ms.
Params: []

[Trace - 6:19:52 PM] Sending notification 'textDocument/documentSymbol' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:19:52 PM] Received response 'textDocument/codeAction - (12)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:19:52 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":0,"character":12},"end":{"line":0,"character":12}},"context":{"diagnostics":[]}}

[Trace - 6:19:53 PM] Received response 'textDocument/documentLink - (13)' in 0ms.
Params: [{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":6}},"target":"https://godoc.org/fmt"},{"range":{"start":{"line":5,"character":1},"end":{"line":5,"character":15}},"target":"https://godoc.org/rsc.io/quote"}]

[Trace - 6:19:53 PM] Sending notification 'textDocument/documentLink' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:19:54 PM] Received response 'textDocument/codeAction - (14)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:19:54 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":8,"character":10},"end":{"line":8,"character":10}},"context":{"diagnostics":[]}}

[Trace - 6:19:54 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":6},"contentChanges":[{"range":{"start":{"line":8,"character":10},"end":{"line":8,"character":10}},"rangeLength":0,"text":"\n\t"}]}

[Info - 6:19:54 PM] 21.153288ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:54 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"21.153288ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:54 PM] 109.559605ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:54 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"109.559605ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:54 PM] go/packages.Load
package = ../../../mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:19:54 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = ../../../mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:54 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:54 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 2"}

[Trace - 6:19:54 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"severity":1,"source":"LSP","message":"package mod1; expected bob"}]}

[Info - 6:19:54 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Info - 6:19:54 PM] go/packages.Load
packages = 2
[Trace - 6:19:55 PM] Received response 'textDocument/completion - (15)' in 0ms.
Params: {"isIncomplete":false,"items":[{"label":"append","kind":3,"detail":"func(slice []Type, elems ...Type) []Type","preselect":true,"sortText":"00000","filterText":"append","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"append(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"bool","kind":25,"sortText":"00001","filterText":"bool","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"bool"}},{"label":"byte","kind":25,"sortText":"00002","filterText":"byte","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"byte"}},{"label":"cap","kind":3,"detail":"func(v Type) int","sortText":"00003","filterText":"cap","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"cap(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"close","kind":3,"detail":"func(c chan\u003c- Type)","sortText":"00004","filterText":"close","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"close(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"complex","kind":3,"detail":"func(r float64, i float64) complex128","sortText":"00005","filterText":"complex","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"complex(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"complex128","kind":25,"sortText":"00006","filterText":"complex128","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"complex128"}},{"label":"complex64","kind":25,"sortText":"00007","filterText":"complex64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"complex64"}},{"label":"copy","kind":3,"detail":"func(dst []Type, src []Type) int","sortText":"00008","filterText":"copy","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"copy(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"delete","kind":3,"detail":"func(m map[Type]Type1, key Type)","sortText":"00009","filterText":"delete","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"delete(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"error","kind":8,"sortText":"00010","filterText":"error","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"error"}},{"label":"false","kind":21,"sortText":"00011","filterText":"false","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"false"}},{"label":"float32","kind":25,"sortText":"00012","filterText":"float32","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"float32"}},{"label":"float64","kind":25,"sortText":"00013","filterText":"float64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"float64"}},{"label":"imag","kind":3,"detail":"func(c complex128) float64","sortText":"00014","filterText":"imag","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"imag(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"int","kind":25,"sortText":"00015","filterText":"int","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int"}},{"label":"int16","kind":25,"sortText":"00016","filterText":"int16","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int16"}},{"label":"int32","kind":25,"sortText":"00017","filterText":"int32","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int32"}},{"label":"int64","kind":25,"sortText":"00018","filterText":"int64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int64"}},{"label":"int8","kind":25,"sortText":"00019","filterText":"int8","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int8"}},{"label":"iota","kind":21,"sortText":"00020","filterText":"iota","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"iota"}},{"label":"len","kind":3,"detail":"func(v Type) int","sortText":"00021","filterText":"len","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"len(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"make","kind":3,"detail":"func(t Type, size ...int) Type","sortText":"00022","filterText":"make","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"make(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"new","kind":3,"detail":"func(Type) *Type","sortText":"00023","filterText":"new","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"new(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"nil","kind":6,"sortText":"00024","filterText":"nil","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"nil"}},{"label":"panic","kind":3,"detail":"func(v interface{})","sortText":"00025","filterText":"panic","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"panic(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"print","kind":3,"detail":"func(args ...Type)","sortText":"00026","filterText":"print","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"print(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"println","kind":3,"detail":"func(args ...Type)","sortText":"00027","filterText":"println","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"println(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"real","kind":3,"detail":"func(c complex128) float64","sortText":"00028","filterText":"real","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"real(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"recover","kind":3,"detail":"func() interface{}","sortText":"00029","filterText":"recover","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"recover()"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"rune","kind":25,"sortText":"00030","filterText":"rune","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"rune"}},{"label":"string","kind":25,"sortText":"00031","filterText":"string","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"string"}},{"label":"true","kind":21,"sortText":"00032","filterText":"true","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"true"}},{"label":"uint","kind":25,"sortText":"00033","filterText":"uint","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint"}},{"label":"uint16","kind":25,"sortText":"00034","filterText":"uint16","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint16"}},{"label":"uint32","kind":25,"sortText":"00035","filterText":"uint32","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint32"}},{"label":"uint64","kind":25,"sortText":"00036","filterText":"uint64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint64"}},{"label":"uint8","kind":25,"sortText":"00037","filterText":"uint8","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint8"}},{"label":"uintptr","kind":25,"sortText":"00038","filterText":"uintptr","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uintptr"}}]}

[Trace - 6:19:55 PM] Sending notification 'textDocument/completion' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"position":{"line":9,"character":1},"context":{"triggerKind":1}}

[Trace - 6:19:55 PM] Received response 'textDocument/documentSymbol - (16)' in 0ms.
Params: []

[Trace - 6:19:55 PM] Sending notification 'textDocument/documentSymbol' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:19:55 PM] Received response 'textDocument/documentLink - (17)' in 0ms.
Params: [{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":6}},"target":"https://godoc.org/fmt"},{"range":{"start":{"line":5,"character":1},"end":{"line":5,"character":15}},"target":"https://godoc.org/rsc.io/quote"}]

[Trace - 6:19:55 PM] Sending notification 'textDocument/documentLink' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:19:57 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":7},"contentChanges":[{"range":{"start":{"line":9,"character":0},"end":{"line":9,"character":1}},"rangeLength":1,"text":""}]}

[Info - 6:19:57 PM] 22.26769ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"22.26769ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:57 PM] 121.611526ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"121.611526ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:57 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 1"}

[Trace - 6:19:57 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"severity":1,"source":"LSP","message":"package mod1; expected bob"}]}

[Info - 6:19:57 PM] go/packages.Load
packages = 1
[Trace - 6:19:57 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":8},"contentChanges":[{"range":{"start":{"line":8,"character":10},"end":{"line":9,"character":0}},"rangeLength":1,"text":""}]}

[Info - 6:19:57 PM] 22.680322ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"22.680322ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:57 PM] 109.957074ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"109.957074ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:19:57 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:19:57 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 1"}

[Trace - 6:19:57 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"severity":1,"source":"LSP","message":"package mod1; expected bob"}]}

[Info - 6:19:57 PM] go/packages.Load
packages = 1
[Trace - 6:19:57 PM] Received response 'textDocument/documentSymbol - (18)' in 0ms.
Params: []

[Trace - 6:19:57 PM] Sending notification 'textDocument/documentSymbol' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:19:57 PM] Received response 'textDocument/codeAction - (19)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:19:57 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":8,"character":10},"end":{"line":8,"character":10}},"context":{"diagnostics":[]}}

[Trace - 6:19:58 PM] Received response 'textDocument/documentLink - (20)' in 0ms.
Params: [{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":6}},"target":"https://godoc.org/fmt"},{"range":{"start":{"line":5,"character":1},"end":{"line":5,"character":15}},"target":"https://godoc.org/rsc.io/quote"}]

[Trace - 6:19:58 PM] Sending notification 'textDocument/documentLink' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:20:00 PM] Received response 'textDocument/codeAction - (21)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:20:00 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":0,"character":0},"end":{"line":13,"character":0}},"context":{"diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"message":"package mod1; expected bob","severity":1,"source":"LSP"}]}}

[Trace - 6:20:00 PM] Received response 'textDocument/codeAction - (22)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:20:00 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":0,"character":0},"end":{"line":13,"character":0}},"context":{"diagnostics":[{"range":{"start":{"line":0,"character":0},"end":{"line":0,"character":7}},"message":"package mod1; expected bob","severity":1,"source":"LSP"}]}}

[Trace - 6:20:00 PM] Sending notification 'textDocument/didSave' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":8}}

[Trace - 6:20:02 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":9},"contentChanges":[{"range":{"start":{"line":8,"character":10},"end":{"line":8,"character":10}},"rangeLength":0,"text":"\n\t"}]}

[Info - 6:20:02 PM] 17.667562ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: <<>>

[Trace - 6:20:02 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"17.667562ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-m" "-json" "all", stderr: \u003c\u003c\u003e\u003e\n"}

[Info - 6:20:02 PM] 100.155585ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: <<>>

[Trace - 6:20:02 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"100.155585ms for GOROOT=$GOROOT GOPATH=$HOME/code GO111MODULE=on PWD=$HOME/mod1 go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "$HOME/mod1", stderr: \u003c\u003c\u003e\u003e\n"}

[Trace - 6:20:02 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackage = mod1\n\tfiles = [$HOME/mod1/mod1.go]"}

[Trace - 6:20:02 PM] Received notification 'window/logMessage' in 0ms.
Params: {"type":3,"message":"go/packages.Load\n\tpackages = 1"}

[Info - 6:20:02 PM] go/packages.Load
package = mod1
files = [$HOME/mod1/mod1.go]
[Trace - 6:20:02 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[]}

[Info - 6:20:02 PM] go/packages.Load
packages = 1
[Trace - 6:20:02 PM] Received response 'textDocument/completion - (23)' in 0ms.
Params: {"isIncomplete":false,"items":[{"label":"fmt","kind":9,"detail":""fmt"","preselect":true,"sortText":"00000","filterText":"fmt","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"fmt"}},{"label":"quote","kind":9,"detail":""rsc.io/quote"","sortText":"00001","filterText":"quote","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"quote"}},{"label":"append","kind":3,"detail":"func(slice []Type, elems ...Type) []Type","sortText":"00002","filterText":"append","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"append(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"bool","kind":25,"sortText":"00003","filterText":"bool","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"bool"}},{"label":"byte","kind":25,"sortText":"00004","filterText":"byte","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"byte"}},{"label":"cap","kind":3,"detail":"func(v Type) int","sortText":"00005","filterText":"cap","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"cap(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"close","kind":3,"detail":"func(c chan\u003c- Type)","sortText":"00006","filterText":"close","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"close(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"complex","kind":3,"detail":"func(r float64, i float64) complex128","sortText":"00007","filterText":"complex","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"complex(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"complex128","kind":25,"sortText":"00008","filterText":"complex128","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"complex128"}},{"label":"complex64","kind":25,"sortText":"00009","filterText":"complex64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"complex64"}},{"label":"copy","kind":3,"detail":"func(dst []Type, src []Type) int","sortText":"00010","filterText":"copy","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"copy(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"delete","kind":3,"detail":"func(m map[Type]Type1, key Type)","sortText":"00011","filterText":"delete","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"delete(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"error","kind":8,"sortText":"00012","filterText":"error","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"error"}},{"label":"false","kind":21,"sortText":"00013","filterText":"false","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"false"}},{"label":"float32","kind":25,"sortText":"00014","filterText":"float32","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"float32"}},{"label":"float64","kind":25,"sortText":"00015","filterText":"float64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"float64"}},{"label":"imag","kind":3,"detail":"func(c complex128) float64","sortText":"00016","filterText":"imag","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"imag(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"int","kind":25,"sortText":"00017","filterText":"int","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int"}},{"label":"int16","kind":25,"sortText":"00018","filterText":"int16","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int16"}},{"label":"int32","kind":25,"sortText":"00019","filterText":"int32","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int32"}},{"label":"int64","kind":25,"sortText":"00020","filterText":"int64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int64"}},{"label":"int8","kind":25,"sortText":"00021","filterText":"int8","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"int8"}},{"label":"iota","kind":21,"sortText":"00022","filterText":"iota","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"iota"}},{"label":"len","kind":3,"detail":"func(v Type) int","sortText":"00023","filterText":"len","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"len(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"make","kind":3,"detail":"func(t Type, size ...int) Type","sortText":"00024","filterText":"make","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"make(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"new","kind":3,"detail":"func(Type) *Type","sortText":"00025","filterText":"new","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"new(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"nil","kind":6,"sortText":"00026","filterText":"nil","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"nil"}},{"label":"panic","kind":3,"detail":"func(v interface{})","sortText":"00027","filterText":"panic","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"panic(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"print","kind":3,"detail":"func(args ...Type)","sortText":"00028","filterText":"print","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"print(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"println","kind":3,"detail":"func(args ...Type)","sortText":"00029","filterText":"println","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"println(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"real","kind":3,"detail":"func(c complex128) float64","sortText":"00030","filterText":"real","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"real(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"recover","kind":3,"detail":"func() interface{}","sortText":"00031","filterText":"recover","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"recover()"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"rune","kind":25,"sortText":"00032","filterText":"rune","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"rune"}},{"label":"string","kind":25,"sortText":"00033","filterText":"string","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"string"}},{"label":"true","kind":21,"sortText":"00034","filterText":"true","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"true"}},{"label":"uint","kind":25,"sortText":"00035","filterText":"uint","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint"}},{"label":"uint16","kind":25,"sortText":"00036","filterText":"uint16","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint16"}},{"label":"uint32","kind":25,"sortText":"00037","filterText":"uint32","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint32"}},{"label":"uint64","kind":25,"sortText":"00038","filterText":"uint64","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint64"}},{"label":"uint8","kind":25,"sortText":"00039","filterText":"uint8","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uint8"}},{"label":"uintptr","kind":25,"sortText":"00040","filterText":"uintptr","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"uintptr"}},{"label":"fmt.Errorf","kind":3,"detail":"func(format string, a ...interface{}) error","sortText":"00041","filterText":"fmt.Errorf","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"fmt.Errorf(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}},{"label":"fmt.Formatter","kind":8,"detail":"interface{...}","sortText":"00042","filterText":"fmt.Formatter","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"fmt.Formatter"}},{"label":"fmt.Fprint","kind":3,"detail":"func(w io.Writer, a ...interface{}) (n int, err error)","sortText":"00043","filterText":"fmt.Fprint","insertTextFormat":2,"textEdit":{"range":{"start":{"line":9,"character":1},"end":{"line":9,"character":1}},"newText":"fmt.Fprint(${1})"},"command":{"title":"","command":"editor.action.triggerParameterHints"}}]}

[Trace - 6:20:02 PM] Sending notification 'textDocument/completion' in 2ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"position":{"line":9,"character":1},"context":{"triggerKind":1}}

[Trace - 6:20:02 PM] Received response 'textDocument/documentSymbol - (24)' in 0ms.
Params: [{"name":"_","detail":"()","kind":12,"range":{"start":{"line":8,"character":0},"end":{"line":13,"character":1}},"selectionRange":{"start":{"line":8,"character":5},"end":{"line":8,"character":6}}}]

[Trace - 6:20:02 PM] Sending notification 'textDocument/documentSymbol' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:20:03 PM] Received response 'textDocument/documentLink - (25)' in 0ms.
Params: [{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":6}},"target":"https://godoc.org/fmt"},{"range":{"start":{"line":5,"character":1},"end":{"line":5,"character":15}},"target":"https://godoc.org/rsc.io/quote"}]

[Trace - 6:20:03 PM] Sending notification 'textDocument/documentLink' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:20:03 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":10},"contentChanges":[{"range":{"start":{"line":9,"character":0},"end":{"line":9,"character":1}},"rangeLength":1,"text":""}]}

[Trace - 6:20:03 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[]}

[Trace - 6:20:03 PM] Sending notification 'textDocument/didChange' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":11},"contentChanges":[{"range":{"start":{"line":8,"character":10},"end":{"line":9,"character":0}},"rangeLength":1,"text":""}]}

[Trace - 6:20:03 PM] Received notification 'textDocument/publishDiagnostics' in 0ms.
Params: {"uri":"file://$HOME/mod1/mod1.go","diagnostics":[]}

[Trace - 6:20:03 PM] Received response 'textDocument/codeAction - (26)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:20:03 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":8,"character":10},"end":{"line":8,"character":10}},"context":{"diagnostics":[]}}

[Trace - 6:20:03 PM] Received response 'textDocument/codeAction - (27)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:20:03 PM] Sending notification 'textDocument/codeAction' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":0,"character":0},"end":{"line":13,"character":0}},"context":{"diagnostics":[]}}

[Trace - 6:20:03 PM] Received response 'textDocument/codeAction - (28)' in 0ms.
Params: [{"title":"Organize Imports","kind":"source.organizeImports","edit":{"changes":{"file://$HOME/mod1/mod1.go":[]}}}]

[Trace - 6:20:03 PM] Sending notification 'textDocument/codeAction' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"},"range":{"start":{"line":0,"character":0},"end":{"line":13,"character":0}},"context":{"diagnostics":[]}}

[Trace - 6:20:03 PM] Sending notification 'textDocument/didSave' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go","version":11}}

[Trace - 6:20:03 PM] Received response 'textDocument/documentSymbol - (29)' in 0ms.
Params: [{"name":"_","detail":"()","kind":12,"range":{"start":{"line":8,"character":0},"end":{"line":12,"character":1}},"selectionRange":{"start":{"line":8,"character":5},"end":{"line":8,"character":6}}}]

[Trace - 6:20:03 PM] Sending notification 'textDocument/documentSymbol' in 0ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}

[Trace - 6:20:04 PM] Received response 'textDocument/documentLink - (30)' in 0ms.
Params: [{"range":{"start":{"line":3,"character":1},"end":{"line":3,"character":6}},"target":"https://godoc.org/fmt"},{"range":{"start":{"line":5,"character":1},"end":{"line":5,"character":15}},"target":"https://godoc.org/rsc.io/quote"}]

[Trace - 6:20:04 PM] Sending notification 'textDocument/documentLink' in 1ms.
Params: {"textDocument":{"uri":"file://$HOME/mod1/mod1.go"}}


[pjweinb]

When typeCheck() in check.go is given the file where the package name has been modified, it calls types.NewChecker(...).Files() to do an incremental check, but of course the type checker doesn't like seeing a new package. Don't know how to recover yet.

[stamblerre]

I've been looking at this a bit because of #37978, so I may add some regression tests for this. The fix will probably look like https://golang.org/cl/225317, but without invalidating package IDs from workspace packages unless a package has been deleted.

[pjweinb]

this appears to be a packages.Load error: If the overlay is in a different package from the file on disk, the wrong package is returned.

[stamblerre]

@pjweinb: Can this issue be closed, or is there other work left for this change? I guess the last step might be to remove the t.Skip from your regression test?

[stamblerre]

I actually just took a look at the test, and it seems we can't enable it because the regression tests don't yet support asserting that no diagnostics (rather than empty diagnostics) come in. @findleyr: this is basically the same case as I mentioned in #36960 (comment).

[gopherbot]

Change https://golang.org/cl/229777 mentions this issue: internal/lsp: instrument work done reporting to use in regtests