Skip to content

x/tools/gopls: slow when typing imports #34414

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom
Closed
tbhartman opened this issue Sep 19, 2019 · 5 comments
Closed

x/tools/gopls: slow when typing imports #34414

tbhartman opened this issue Sep 19, 2019 · 5 comments
Labels
FrozenDueToAge gopls Issues related to the Go language server, gopls. Tools This label describes issues relating to any tools in the x/tools repository.
Milestone
Unreleased

Comments

@tbhartman
Copy link

I am observing a long delay for each character typed in response from gopls. Output from gopls in VSCode sometimes shows an especially long time in go list:

go pls output
[Info  - 11:14:17 AM] 2019/09/18 11:14:17 345.9982ms for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "builtin", stderr: <<>>
[Info  - 11:14:17 AM] 2019/09/18 11:14:17 628.9988ms for [redacted] go "list" "-m" "-json" "all", stderr: <<>>
[Info  - 11:14:18 AM] 2019/09/18 11:14:18 845.9969ms for [redacted] go "env" "GOMOD", stderr: <<>>
[Info  - 11:14:18 AM] 2019/09/18 11:14:18 319.9983ms for [redacted] go "env" "GOMOD", stderr: <<>>
[Info  - 11:14:19 AM] 2019/09/18 11:14:19 832.9994ms for [redacted] go "list" "-m" "-json" "all", stderr: <<>>
[Info  - 11:14:23 AM] 2019/09/18 11:14:23 5.0190297s for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" [redacted], stderr: <<>>
[Info  - 11:14:23 AM] 2019/09/18 11:14:23 go/packages.Load
[Info  - 11:14:23 AM] 2019/09/18 11:14:23 go/packages.Load
[Info  - 11:14:23 AM] 2019/09/18 11:14:23 go/packages.Load
[Info  - 11:14:24 AM] 2019/09/18 11:14:24 275.9977ms for [redacted] go "env" "GOMOD", stderr: <<>>
[Info  - 11:14:24 AM] 2019/09/18 11:14:24 520.0013ms for [redacted] go "list" "-m" "-json" "all", stderr: <<>>
[Info  - 11:14:29 AM] 2019/09/18 11:14:29 4.2761617s for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" [redacted], stderr: <<>>
[Info  - 11:14:29 AM] 2019/09/18 11:14:29 go/packages.Load
[Info  - 11:14:29 AM] 2019/09/18 11:14:29 go/packages.Load
[Info  - 11:14:29 AM] 2019/09/18 11:14:29 go/packages.Load
[Info  - 11:14:34 AM] 2019/09/18 11:14:34 280.9992ms for [redacted] go "list" "-m" "-json" "all", stderr: <<>>
[Info  - 11:14:34 AM] 2019/09/18 11:14:34 739.0044ms for [redacted] go "env" "GOMOD", stderr: <<>>
[Info  - 11:14:39 AM] 2019/09/18 11:14:39 4.6301423s for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" [redacted], stderr: <<>>
[Info  - 11:14:39 AM] 2019/09/18 11:14:39 292.9698ms for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "-mod=readonly" "--" "fm", stderr: <<>>
[Info  - 11:14:39 AM] 2019/09/18 11:14:39 go/packages.Load
[Info  - 11:14:39 AM] 2019/09/18 11:14:39 go/packages.Load
[Info  - 11:14:39 AM] 2019/09/18 11:14:39 go/packages.Load
[Info  - 11:14:39 AM] 2019/09/18 11:14:39 503.0017ms for [redacted] go "list" "-m" "-json" "all", stderr: <<>>
[Info  - 11:14:40 AM] 2019/09/18 11:14:40 726.0504ms for [redacted] go "env" "GOMOD", stderr: <<>>
[Info  - 11:14:43 AM] 2019/09/18 11:14:43 4.0372971s for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" [redacted], stderr: <<>>
[Info  - 11:14:43 AM] 2019/09/18 11:14:43 265.0874ms for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "-mod=readonly" "--" "fm", stderr: <<>>
[Info  - 11:14:43 AM] 2019/09/18 11:14:43 go/packages.Load
[Info  - 11:14:43 AM] 2019/09/18 11:14:43 go/packages.Load
[Info  - 11:14:43 AM] 2019/09/18 11:14:43 go/packages.Load
[Info  - 11:14:44 AM] 2019/09/18 11:14:44 272.0332ms for [redacted] go "env" "GOMOD", stderr: <<>>
[Info  - 11:14:44 AM] 2019/09/18 11:14:44 718.0346ms for [redacted] go "list" "-m" "-json" "all", stderr: <<>>
[Info  - 11:14:48 AM] 2019/09/18 11:14:48 4.2415797s for [redacted] go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" [redacted], stderr: <<>>
[Info  - 11:14:48 AM] 2019/09/18 11:14:48 go/packages.Load
[Info  - 11:14:48 AM] 2019/09/18 11:14:48 go/packages.Load
[Info  - 11:14:48 AM] 2019/09/18 11:14:48 go/packages.Load

I am not familiar with the language server concept, so I'm not sure if this is a gopls issue or a VSCode issue, although I have occasionally observed a delay using vim (though not repeatable, and it appears to mainly query gopls on save, whereas VSCode seems to query gopls on every keystroke).

What version of Go are you using (go version)?

$ go version
go version go1.13 windows/amd64

Does this issue reproduce with the latest release?

Yes

What operating system and processor architecture are you using (go env)?

go env Output
$ go env
set GO111MODULE=
set GOARCH=amd64
set GOBIN=
set GOCACHE=C:\Users\[redacted]\AppData\Local\go-build
set GOENV=C:\Users\[redacted]\AppData\Roaming\go\env
set GOEXE=.exe
set GOFLAGS=
set GOHOSTARCH=amd64
set GOHOSTOS=windows
set GONOPROXY=
set GONOSUMDB=
set GOOS=windows
set GOPATH=C:\Users\[redacted]\go
set GOPRIVATE=
set GOPROXY=https://proxy.golang.org,direct
set GOROOT=C:\ProgramFiles\Go
set GOSUMDB=sum.golang.org
set GOTMPDIR=
set GOTOOLDIR=C:\ProgramFiles\Go\pkg\tool\windows_amd64
set GCCGO=gccgo
set AR=ar
set CC=gcc
set CXX=g++
set CGO_ENABLED=1
set GOMOD=
set CGO_CFLAGS=-g -O2
set CGO_CPPFLAGS=
set CGO_CXXFLAGS=-g -O2
set CGO_FFLAGS=-g -O2
set CGO_LDFLAGS=-g -O2
set PKG_CONFIG=pkg-config
set GOGCCFLAGS=-m64 -mthreads -fmessage-length=0 -fdebug-prefix-map=C:\Users\[redacted]\AppData\Local\Temp\go-build109731834=/tmp/go-build -gno-record-gcc-switches
go: failed to remove work dir: GetFileInformationByHandle C:\Users\[redacted]\AppData\Local\Temp\go-build109731834\NUL: Incorrect function.

What did you do?

Type the following into VSCode, (not copy/paste):

package main

func main() {
	var a
}

What did you expect to see?

Quick feedback of: missing variable type or initialization

What did you see instead?

A long delay, many errors, and finally missing variable type or initialization. The following replays 82 seconds at 10x:

screenreplay
@gopherbot gopherbot added this to the Unreleased milestone Sep 19, 2019
@gopherbot gopherbot added Tools This label describes issues relating to any tools in the x/tools repository. gopls Issues related to the Go language server, gopls. labels Sep 19, 2019
@gopherbot
Copy link
Contributor

Thank you for filing a gopls issue! Please take a look at the Troubleshooting section of the gopls Wiki page, and make sure that you have provided all of the relevant information here.

@stamblerre
Copy link
Contributor

It seems like gopls is just re-running go list on every keystroke, which it shouldn't be doing (it's meant to only run it when imports have changed, etc.). Are using these calls to go list succeed or fail? If they succeed, you will see it print out something like package = X, files = [ X.go ]. Is this file on disk or is it entirely unsaved?

@tbhartman
Copy link
Author

@stamblerre thanks for the help. I hope this isn't due to some wierd setup I have going. I'm also not sure if it is a VSCode issue rather than gopls.

I treid to recreate in a more controlled setting...

I created a new directory at %GOPATH%\src\tbhartman.com\test with an empty file main.go (an empty file, but saved to disk). I open VSCode and restart the language server. It runs go list -m twice, go list -e twice, then reports correctly that Request textDocument/documentSymbol failed with Message: go/packages.Load: no packages found for [redacted]\go\src\tbhartman.com\test\main.go. go list runs three more times, then reports Request textDocument/foldingRange failed with expected ';', found 'EOF' (and 2 more errors). These seem reasonable.

go pls initial output


[Info  - 11:45:50 AM] 2019/09/20 11:45:50 Build info
----------
golang.org/x/tools/gopls v0.1.7
    golang.org/x/tools/gopls@v0.1.7 h1:YwKf8t9h69++qCtVmc2q6fVuetFXmmu9LKoPMYLZid4=
    golang.org/x/sync@v0.0.0-20190423024810-112230192c58 h1:8gQV6CLnAEikrhgkHFbMAEhagSSnXWGV915qUMm9mrU=
    golang.org/x/tools@v0.0.0-20190918214516-5a1a30219888 h1:ER45Jz0UDQ3e6em1lwXVwuPf96lvyQogb7m+gEbsoPg=
    golang.org/x/xerrors@v0.0.0-20190717185122-a985d3407aa7 h1:9zdDQZ7Thm29KFXgAX/+yaf3eVbP7djjWp/dXAppNCc=


Go info
-------
go version go1.13 windows/amd64


set GO111MODULE=
set GOARCH=amd64
set GOBIN=
set GOCACHE=C:\Users\[redacted]\AppData\Local\go-build
set GOENV=C:\Users\[redacted]\AppData\Roaming\go\env
set GOEXE=.exe
set GOFLAGS=
set GOHOSTARCH=amd64
set GOHOSTOS=windows
set GONOPROXY=
set GONOSUMDB=
set GOOS=windows
set GOPATH=C:\Users\[redacted]\go
set GOPRIVATE=
set GOPROXY=https://proxy.golang.org,direct
set GOROOT=C:\p\f\Go
set GOSUMDB=sum.golang.org
set GOTMPDIR=
set GOTOOLDIR=C:\p\f\Go\pkg\tool\windows_amd64
set GCCGO=gccgo
set AR=ar
set CC=gcc
set CXX=g++
set CGO_ENABLED=1
set GOMOD=
set CGO_CFLAGS=-g -O2
set CGO_CPPFLAGS=
set CGO_CXXFLAGS=-g -O2
set CGO_FFLAGS=-g -O2
set CGO_LDFLAGS=-g -O2
set PKG_CONFIG=pkg-config
set GOGCCFLAGS=-m64 -mthreads -fmessage-length=0 -fdebug-prefix-map=C:\Users\[redacted]\AppData\Local\Temp\go-build721871066=/tmp/go-build -gno-record-gcc-switches


[Info  - 11:45:50 AM] 2019/09/20 11:45:50 284.0336ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 11:45:50 AM] 2019/09/20 11:45:50 518.0355ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 11:45:50 AM] 2019/09/20 11:45:50 538.0313ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "builtin", stderr: <<>>


[Info  - 11:45:50 AM] 2019/09/20 11:45:50 84.9998ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 11:45:50 AM] 2019/09/20 11:45:50 78.0017ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 11:45:51 AM] 2019/09/20 11:45:51 305.9979ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 11:45:51 AM] 2019/09/20 11:45:51 211.9971ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 11:45:51 AM] 2019/09/20 11:45:51 379.0013ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 11:45:51 AM] 2019/09/20 11:45:51 383.0958ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Error - 11:45:51 AM] Request textDocument/documentSymbol failed.
  Message: go/packages.Load: no packages found for c:\Users\[redacted]\go\src\tbhartman.com\test\main.go
  Code: 0 
[Info  - 11:45:51 AM] 2019/09/20 11:45:51 273.0409ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 11:45:52 AM] 2019/09/20 11:45:52 706.031ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 11:45:52 AM] 2019/09/20 11:45:52 197.9905ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 11:45:52 AM] 2019/09/20 11:45:52 419.1393ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


2019/09/20 11:45:52 failed to compute diagnostics: go/packages.Load: no packages found for c:\Users\[redacted]\go\src\tbhartman.com\test\main.go
	file = file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Info  - 11:45:52 AM] 2019/09/20 11:45:52 322.0631ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Error - 11:45:52 AM] 2019/09/20 11:45:52 failed to compute diagnostics: go/packages.Load: no packages found for c:\Users\[redacted]\go\src\tbhartman.com\test\main.go
	file = file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 11:45:52 AM] Request textDocument/foldingRange failed.
  Message: c:\Users\[redacted]\go\src\tbhartman.com\test\main.go:1:1: expected ';', found 'EOF' (and 2 more errors)
  Code: 0

I then type package main, without saving. The following set of commands (hereafter referred to as "THE COMMANDS") are run nine times, totaling about 10 seconds:

  • go env GOMOD
  • go env GOPATH
  • go list -m
  • go list -e
  • go list -e
go pls output after package main


[Info  - 12:01:27 PM] 2019/09/20 12:01:27 289.9982ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:27 PM] 2019/09/20 12:01:27 519.0331ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:28 PM] 2019/09/20 12:01:28 82.9796ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:28 PM] 2019/09/20 12:01:28 308.0529ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:28 PM] 2019/09/20 12:01:28 300.1349ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Info  - 12:01:28 PM] 2019/09/20 12:01:28 go/packages.Load
	packages = 1
2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Info  - 12:01:28 PM] 2019/09/20 12:01:28 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Error - 12:01:28 PM] 2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Info  - 12:01:28 PM] 2019/09/20 12:01:28 no completions found
	At = {0 1}
	Failure = no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:28 PM] Request textDocument/foldingRange failed.
  Message: c:\Users\[redacted]\go\src\tbhartman.com\test\main.go:1:1: expected 'package', found pa (and 2 more errors)
  Code: 0 
[Error - 12:01:28 PM] 2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:28 PM] Request textDocument/foldingRange failed.
  Message: c:\Users\[redacted]\go\src\tbhartman.com\test\main.go:1:1: expected 'package', found pac (and 2 more errors)
  Code: 0 
2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:28 PM] 2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:28 PM] 2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:28 PM] 2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:28 PM] 2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:28 PM] Request textDocument/foldingRange failed.
  Message: c:\Users\[redacted]\go\src\tbhartman.com\test\main.go:1:8: expected ';', found 'EOF' (and 1 more errors)
  Code: 0 
[Error - 12:01:28 PM] 2019/09/20 12:01:28 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:29 PM] Request textDocument/codeAction failed.
  Message: c:\Users\[redacted]\go\src\tbhartman.com\test\main.go:1:8: expected ';', found 'EOF' (and 1 more errors)
  Code: 0 
2019/09/20 12:01:29 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:29 PM] 2019/09/20 12:01:29 failed to convert span to range: no token.File for file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Info  - 12:01:30 PM] 2019/09/20 12:01:30 290.0006ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:30 PM] 2019/09/20 12:01:30 202.0338ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:30 PM] 2019/09/20 12:01:30 516.0023ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:30 PM] 2019/09/20 12:01:30 417.0631ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:30 PM] 2019/09/20 12:01:30 83.0033ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:30 PM] 2019/09/20 12:01:30 go/packages.Load
	packages = 1
[Info  - 12:01:30 PM] 2019/09/20 12:01:30 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:01:30 PM] 2019/09/20 12:01:30 88.9812ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:30 PM] 2019/09/20 12:01:30 95.981ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:31 PM] 2019/09/20 12:01:31 286.038ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:31 PM] 2019/09/20 12:01:31 286.0273ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:31 PM] 2019/09/20 12:01:31 78.9722ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:31 PM] 2019/09/20 12:01:31 go/packages.Load
	packages = 1
[Info  - 12:01:31 PM] 2019/09/20 12:01:31 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:01:31 PM] 2019/09/20 12:01:31 no completions found
	At = {0 9}
	Failure = this is a definition
[Info  - 12:01:31 PM] 2019/09/20 12:01:31 288.983ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:31 PM] 2019/09/20 12:01:31 501.9988ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:32 PM] 2019/09/20 12:01:32 204.998ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:32 PM] 2019/09/20 12:01:32 424.0062ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:32 PM] 2019/09/20 12:01:32 307.001ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:32 PM] 2019/09/20 12:01:32 go/packages.Load
	packages = 1
[Info  - 12:01:32 PM] 2019/09/20 12:01:32 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:01:32 PM] 2019/09/20 12:01:32 287.0016ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:33 PM] 2019/09/20 12:01:33 746.0027ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:33 PM] 2019/09/20 12:01:33 653.9988ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:33 PM] 2019/09/20 12:01:33 411.0627ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:33 PM] 2019/09/20 12:01:33 80.9733ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:33 PM] 2019/09/20 12:01:33 go/packages.Load
	packages = 1
[Info  - 12:01:33 PM] 2019/09/20 12:01:33 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:01:33 PM] 2019/09/20 12:01:33 67.0019ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:34 PM] 2019/09/20 12:01:34 300.9791ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:34 PM] 2019/09/20 12:01:34 221.0022ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:34 PM] 2019/09/20 12:01:34 286.0982ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:34 PM] 2019/09/20 12:01:34 281.0604ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:34 PM] 2019/09/20 12:01:34 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:01:34 PM] 2019/09/20 12:01:34 go/packages.Load
	packages = 1
[Info  - 12:01:35 PM] 2019/09/20 12:01:35 286.9795ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:35 PM] 2019/09/20 12:01:35 504.0002ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:35 PM] 2019/09/20 12:01:35 417.0307ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:35 PM] 2019/09/20 12:01:35 419.9885ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:35 PM] 2019/09/20 12:01:35 295.9645ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:35 PM] 2019/09/20 12:01:35 go/packages.Load
	packages = 1
[Info  - 12:01:35 PM] 2019/09/20 12:01:35 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
2019/09/20 12:01:35 failed to run analyses: context canceled
	file = file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Error - 12:01:35 PM] 2019/09/20 12:01:35 failed to run analyses: context canceled
	file = file:///c:/Users/[redacted]/go/src/tbhartman.com/test/main.go
[Info  - 12:01:36 PM] 2019/09/20 12:01:36 308ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:36 PM] 2019/09/20 12:01:36 316.0044ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:36 PM] 2019/09/20 12:01:36 71.003ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:36 PM] 2019/09/20 12:01:36 296.0215ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:36 PM] 2019/09/20 12:01:36 301.0281ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:36 PM] 2019/09/20 12:01:36 go/packages.Load
	packages = 1
[Info  - 12:01:36 PM] 2019/09/20 12:01:36 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:01:37 PM] 2019/09/20 12:01:37 291.0346ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:01:37 PM] 2019/09/20 12:01:37 292.0342ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:01:37 PM] 2019/09/20 12:01:37 200.0067ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:01:37 PM] 2019/09/20 12:01:37 85.0361ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:01:37 PM] 2019/09/20 12:01:37 298.0026ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:01:37 PM] 2019/09/20 12:01:37 go/packages.Load
	packages = 1
[Info  - 12:01:37 PM] 2019/09/20 12:01:37 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]

Now I hit the enter key twice and type import "fmt". THE COMMANDS ran 28 times; took about 47 seconds:

go pls output after import "fmt"


[Info  - 12:10:24 PM] 2019/09/20 12:10:24 284.0336ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:24 PM] 2019/09/20 12:10:24 286.0072ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:24 PM] 2019/09/20 12:10:24 437.0075ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:24 PM] 2019/09/20 12:10:24 219.0995ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:25 PM] 2019/09/20 12:10:25 300.0315ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:25 PM] 2019/09/20 12:10:25 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:25 PM] 2019/09/20 12:10:25 go/packages.Load
	packages = 1
[Info  - 12:10:25 PM] 2019/09/20 12:10:25 302.002ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:25 PM] 2019/09/20 12:10:25 512.0018ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:26 PM] 2019/09/20 12:10:26 414.0063ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:26 PM] 2019/09/20 12:10:26 405.0019ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:26 PM] 2019/09/20 12:10:26 190.101ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:26 PM] 2019/09/20 12:10:26 go/packages.Load
	packages = 1
[Info  - 12:10:26 PM] 2019/09/20 12:10:26 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:26 PM] 2019/09/20 12:10:26 290.0306ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:26 PM] 2019/09/20 12:10:26 505.9982ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:27 PM] 2019/09/20 12:10:27 417.9926ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:27 PM] 2019/09/20 12:10:27 80.1083ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:27 PM] 2019/09/20 12:10:27 291.9714ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:27 PM] 2019/09/20 12:10:27 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:27 PM] 2019/09/20 12:10:27 go/packages.Load
	packages = 1
[Info  - 12:10:27 PM] 2019/09/20 12:10:27 69.9981ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:27 PM] 2019/09/20 12:10:27 301.0337ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:28 PM] 2019/09/20 12:10:28 78.0025ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:28 PM] 2019/09/20 12:10:28 87.0683ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:28 PM] 2019/09/20 12:10:28 309.2141ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:28 PM] 2019/09/20 12:10:28 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:28 PM] 2019/09/20 12:10:28 go/packages.Load
	packages = 1
[Info  - 12:10:28 PM] 2019/09/20 12:10:28 78.0159ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:28 PM] 2019/09/20 12:10:28 298.0011ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:29 PM] 2019/09/20 12:10:29 413.0017ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:29 PM] 2019/09/20 12:10:29 634.0643ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:29 PM] 2019/09/20 12:10:29 293.0113ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:29 PM] 2019/09/20 12:10:29 go/packages.Load
	packages = 1
[Info  - 12:10:29 PM] 2019/09/20 12:10:29 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:29 PM] 2019/09/20 12:10:29 278.0307ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:30 PM] 2019/09/20 12:10:30 515.9952ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:30 PM] 2019/09/20 12:10:30 424.0206ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:30 PM] 2019/09/20 12:10:30 414.0133ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:30 PM] 2019/09/20 12:10:30 85.0403ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:30 PM] 2019/09/20 12:10:30 go/packages.Load
	packages = 1
[Info  - 12:10:30 PM] 2019/09/20 12:10:30 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:31 PM] 2019/09/20 12:10:31 301.0224ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:31 PM] 2019/09/20 12:10:31 303.0168ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:31 PM] 2019/09/20 12:10:31 271.0323ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:31 PM] 2019/09/20 12:10:31 493.0864ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:31 PM] 2019/09/20 12:10:31 296.0576ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:31 PM] 2019/09/20 12:10:31 go/packages.Load
	packages = 1
[Info  - 12:10:31 PM] 2019/09/20 12:10:31 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:32 PM] 2019/09/20 12:10:32 510.9979ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:32 PM] 2019/09/20 12:10:32 752.0652ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:32 PM] 2019/09/20 12:10:32 433.0321ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:32 PM] 2019/09/20 12:10:32 75.0289ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:33 PM] 2019/09/20 12:10:33 311.0354ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:33 PM] 2019/09/20 12:10:33 go/packages.Load
	packages = 1
[Info  - 12:10:33 PM] 2019/09/20 12:10:33 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:33 PM] 2019/09/20 12:10:33 493.0324ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:33 PM] 2019/09/20 12:10:33 495.0314ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:33 PM] 2019/09/20 12:10:33 205.0121ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:33 PM] 2019/09/20 12:10:33 430.0945ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:34 PM] 2019/09/20 12:10:34 290.0321ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:34 PM] 2019/09/20 12:10:34 go/packages.Load
	packages = 1
[Info  - 12:10:34 PM] 2019/09/20 12:10:34 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:34 PM] 2019/09/20 12:10:34 64.0364ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:34 PM] 2019/09/20 12:10:34 292.0254ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:35 PM] 2019/09/20 12:10:35 648.9722ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:35 PM] 2019/09/20 12:10:35 436.0879ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:35 PM] 2019/09/20 12:10:35 289.0295ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:35 PM] 2019/09/20 12:10:35 go/packages.Load
	packages = 1
[Info  - 12:10:35 PM] 2019/09/20 12:10:35 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:35 PM] 2019/09/20 12:10:35 298.0347ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:35 PM] 2019/09/20 12:10:35 300.0351ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:36 PM] 2019/09/20 12:10:36 298.9631ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:36 PM] 2019/09/20 12:10:36 299.9755ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:36 PM] 2019/09/20 12:10:36 292.0226ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:36 PM] 2019/09/20 12:10:36 go/packages.Load
	packages = 1
[Info  - 12:10:36 PM] 2019/09/20 12:10:36 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:36 PM] 2019/09/20 12:10:36 286.9984ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:37 PM] 2019/09/20 12:10:37 506.9978ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:37 PM] 2019/09/20 12:10:37 421.0354ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:37 PM] 2019/09/20 12:10:37 80.0607ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:37 PM] 2019/09/20 12:10:37 78.0948ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:37 PM] 2019/09/20 12:10:37 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:37 PM] 2019/09/20 12:10:37 go/packages.Load
	packages = 1
[Info  - 12:10:38 PM] 2019/09/20 12:10:38 299.0111ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:38 PM] 2019/09/20 12:10:38 522.0017ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:38 PM] 2019/09/20 12:10:38 71.0309ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:38 PM] 2019/09/20 12:10:38 289.088ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:38 PM] 2019/09/20 12:10:38 83.0608ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:38 PM] 2019/09/20 12:10:38 go/packages.Load
	packages = 1
[Info  - 12:10:38 PM] 2019/09/20 12:10:38 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:38 PM] 2019/09/20 12:10:38 67.029ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:39 PM] 2019/09/20 12:10:39 287.033ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:39 PM] 2019/09/20 12:10:39 278.9986ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:39 PM] 2019/09/20 12:10:39 491.0501ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:39 PM] 2019/09/20 12:10:39 285.0735ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:39 PM] 2019/09/20 12:10:39 go/packages.Load
	packages = 1
[Info  - 12:10:39 PM] 2019/09/20 12:10:39 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:40 PM] 2019/09/20 12:10:40 96.022ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:40 PM] 2019/09/20 12:10:40 100.0527ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:40 PM] 2019/09/20 12:10:40 283.9892ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:40 PM] 2019/09/20 12:10:40 500.0033ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:40 PM] 2019/09/20 12:10:40 89.9718ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:40 PM] 2019/09/20 12:10:40 go/packages.Load
	packages = 1
[Info  - 12:10:40 PM] 2019/09/20 12:10:40 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:41 PM] 2019/09/20 12:10:41 511.9941ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:41 PM] 2019/09/20 12:10:41 723.0007ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:41 PM] 2019/09/20 12:10:41 412.0366ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:41 PM] 2019/09/20 12:10:41 636.0946ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:41 PM] 2019/09/20 12:10:41 78.0353ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:41 PM] 2019/09/20 12:10:41 go/packages.Load
	packages = 1
[Info  - 12:10:41 PM] 2019/09/20 12:10:41 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:42 PM] 2019/09/20 12:10:42 495.0262ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:42 PM] 2019/09/20 12:10:42 711.9998ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:42 PM] 2019/09/20 12:10:42 418.9683ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:42 PM] 2019/09/20 12:10:42 71.0126ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:42 PM] 2019/09/20 12:10:42 294.0977ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:42 PM] 2019/09/20 12:10:42 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:42 PM] 2019/09/20 12:10:42 go/packages.Load
	packages = 1
[Info  - 12:10:43 PM] 2019/09/20 12:10:43 66.998ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:43 PM] 2019/09/20 12:10:43 293.9962ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:43 PM] 2019/09/20 12:10:43 417.0317ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:43 PM] 2019/09/20 12:10:43 403.0974ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:43 PM] 2019/09/20 12:10:43 82.0642ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:43 PM] 2019/09/20 12:10:43 go/packages.Load
	packages = 1
[Info  - 12:10:43 PM] 2019/09/20 12:10:43 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Error - 12:10:43 PM] Request textDocument/foldingRange failed.
  Message: c:\Users\[redacted]\go\src\tbhartman.com\test\main.go:3:8: expected ';', found 'EOF' (and 1 more errors)
  Code: 0 
[Info  - 12:10:44 PM] 2019/09/20 12:10:44 291.0388ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:44 PM] 2019/09/20 12:10:44 294.035ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:44 PM] 2019/09/20 12:10:44 203.0036ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:44 PM] 2019/09/20 12:10:44 80.0382ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:44 PM] 2019/09/20 12:10:44 79.3244ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:44 PM] 2019/09/20 12:10:44 go/packages.Load
	packages = 1
[Info  - 12:10:44 PM] 2019/09/20 12:10:44 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:44 PM] 2019/09/20 12:10:44 70.9847ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:44 PM] 2019/09/20 12:10:44 75.0025ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:45 PM] 2019/09/20 12:10:45 202.9997ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:45 PM] 2019/09/20 12:10:45 291.0247ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:45 PM] 2019/09/20 12:10:45 281.0879ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:45 PM] 2019/09/20 12:10:45 go/packages.Load
	packages = 1
[Info  - 12:10:45 PM] 2019/09/20 12:10:45 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:45 PM] 2019/09/20 12:10:45 71.0338ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:46 PM] 2019/09/20 12:10:46 286.0291ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:46 PM] 2019/09/20 12:10:46 200.0067ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:46 PM] 2019/09/20 12:10:46 281.0005ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:46 PM] 2019/09/20 12:10:46 495.0346ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:46 PM] 2019/09/20 12:10:46 302.1962ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "f", stderr: <<>>


[Info  - 12:10:46 PM] 2019/09/20 12:10:46 go/packages.Load
	packages = 1
[Info  - 12:10:46 PM] 2019/09/20 12:10:46 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:47 PM] 2019/09/20 12:10:47 531.0001ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:47 PM] 2019/09/20 12:10:47 531.0001ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:47 PM] 2019/09/20 12:10:47 231.9986ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:47 PM] 2019/09/20 12:10:47 71.9953ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:47 PM] 2019/09/20 12:10:47 82.0939ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:47 PM] 2019/09/20 12:10:47 289.1914ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "f", stderr: <<>>


[Info  - 12:10:47 PM] 2019/09/20 12:10:47 go/packages.Load
	packages = 1
[Info  - 12:10:47 PM] 2019/09/20 12:10:47 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:48 PM] 2019/09/20 12:10:48 73.0351ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:48 PM] 2019/09/20 12:10:48 505.9965ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:48 PM] 2019/09/20 12:10:48 411.9643ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:48 PM] 2019/09/20 12:10:48 415.0145ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:48 PM] 2019/09/20 12:10:48 202.0723ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:49 PM] 2019/09/20 12:10:49 78.0963ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "fm", stderr: <<>>


[Info  - 12:10:49 PM] 2019/09/20 12:10:49 go/packages.Load
	packages = 1
[Info  - 12:10:49 PM] 2019/09/20 12:10:49 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:49 PM] 2019/09/20 12:10:49 298.0008ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:49 PM] 2019/09/20 12:10:49 302.0319ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:49 PM] 2019/09/20 12:10:49 281.0018ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:49 PM] 2019/09/20 12:10:49 500.0647ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:50 PM] 2019/09/20 12:10:50 292.0642ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:50 PM] 2019/09/20 12:10:50 74.0842ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "fm", stderr: <<>>


[Info  - 12:10:50 PM] 2019/09/20 12:10:50 go/packages.Load
	packages = 1
[Info  - 12:10:50 PM] 2019/09/20 12:10:50 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:50 PM] 2019/09/20 12:10:50 285.0266ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:50 PM] 2019/09/20 12:10:50 497.0273ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:51 PM] 2019/09/20 12:10:51 626.9999ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:51 PM] 2019/09/20 12:10:51 626.9798ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:51 PM] 2019/09/20 12:10:51 416.0956ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:53 PM] 2019/09/20 12:10:53 1.5550618s for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "fmt", stderr: <<>>


[Info  - 12:10:53 PM] 2019/09/20 12:10:53 go/packages.Load
	packages = 1
[Info  - 12:10:53 PM] 2019/09/20 12:10:53 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:53 PM] 2019/09/20 12:10:53 277.0342ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:53 PM] 2019/09/20 12:10:53 492.0327ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:54 PM] 2019/09/20 12:10:54 279.9754ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:54 PM] 2019/09/20 12:10:54 519.965ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:54 PM] 2019/09/20 12:10:54 87.0524ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:56 PM] 2019/09/20 12:10:56 1.5717303s for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "fmt", stderr: <<>>


[Info  - 12:10:56 PM] 2019/09/20 12:10:56 go/packages.Load
	packages = 1
[Info  - 12:10:56 PM] 2019/09/20 12:10:56 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:56 PM] 2019/09/20 12:10:56 286.0217ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:56 PM] 2019/09/20 12:10:56 286.0027ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:56 PM] 2019/09/20 12:10:56 202.0064ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:56 PM] 2019/09/20 12:10:56 82.9994ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:57 PM] 2019/09/20 12:10:57 83.9885ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:10:58 PM] 2019/09/20 12:10:58 1.5700557s for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "fmt", stderr: <<>>


[Info  - 12:10:58 PM] 2019/09/20 12:10:58 go/packages.Load
	packages = 1
[Info  - 12:10:58 PM] 2019/09/20 12:10:58 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]
[Info  - 12:10:58 PM] 2019/09/20 12:10:58 275.0324ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-m" "-json" "all", stderr: <>


[Info  - 12:10:59 PM] 2019/09/20 12:10:59 406.0009ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOPATH", stderr: <<>>


[Info  - 12:10:59 PM] 2019/09/20 12:10:59 704.9967ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "env" "GOMOD", stderr: <<>>


[Info  - 12:10:59 PM] 2019/09/20 12:10:59 407.083ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test", stderr: <<>>


[Info  - 12:10:59 PM] 2019/09/20 12:10:59 81.1383ms for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "c:\\Users\\[redacted]\\go\\src\\tbhartman.com\\test\\main.go", stderr: <<>>


[Info  - 12:11:01 PM] 2019/09/20 12:11:01 2.1472266s for GOROOT=C:\p\f\Go GOPATH=C:\Users\[redacted]\go GO111MODULE= PWD=c:\Users\[redacted]\go\src\tbhartman.com\test go "list" "-e" "-json" "-compiled=true" "-test=true" "-export=false" "-deps=true" "-find=false" "--" "fmt", stderr: <<>>


[Info  - 12:11:01 PM] 2019/09/20 12:11:01 go/packages.Load
	packages = 1
[Info  - 12:11:01 PM] 2019/09/20 12:11:01 go/packages.Load
	package = command-line-arguments
	files = [c:\Users\[redacted]\go\src\tbhartman.com\test\main.go]

I hit enter two more times (THE COMMANDS run 4 times...takes 13 seconds), then type func main() { and hit enter so that I have (due to VSCode expansion):

func main() {
	
}

THE COMMANDS run 27 times and take 96 seconds. I saved the file.

I now tried to type fmt. and run auto-complete but it was taking a long time. I closed out VSCode, re-opened, waited for gopls to startup. Once it was started (took about 10 seconds for first pass), I was able to type fmt.Println("hi"). gopls seemed to work great and did not run THE COMMANDS while I typed many characters so that my (unsaved) file contained:

package main

import "fmt"

func main() {
	fmt.Println("hi")
	err := fmt.Errorf("hi %q", "")
	if err != nil {
		fmt.Println("hi")
	}
}

func main3() {

}

I copy/pasted the import "fmt" line so that I had two of them (commands ran 2x). I then highlighted fmt and typed net/http; THE COMMANDS ran 16x (twice for each character typed)...took about 91 seconds.

@stamblerre stamblerre changed the title x/tools/gopls: long delay on each character typed for live errors x/tools/gopls: slow when typing imports Sep 20, 2019
@stamblerre
Copy link
Contributor

Thank you for the detailed report! I think the issue here is basically that we run go/packages.Load (which runs these commands) when your imports change. So as you type and your imports change, we keep running these commands. We will need some handling to avoid running go/packages until the user has finished typing. In the meantime, as a workaround, I would recommend using automatic import organization as much as possible.

@gopherbot
Copy link
Contributor

Change https://golang.org/cl/200058 mentions this issue: internal/lsp: include context in go/packages config

@golang golang locked and limited conversation to collaborators Oct 10, 2020
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
FrozenDueToAge gopls Issues related to the Go language server, gopls. Tools This label describes issues relating to any tools in the x/tools repository.
Projects
None yet
Milestone
Unreleased
Development

No branches or pull requests
3 participants
@tbhartman @stamblerre @gopherbot