[I2024-07-26T18:25:50.499735Z 524424 0 sink.go:276] SinkServer: warm-up started
[I2024-07-26T18:25:50.499784Z 524424 0 sink.go:346] SinkServer: starting HTTP server...
[I2024-07-26T18:25:50.501489Z 524424 0 sink.go:281] SinkServer: warm-up ended
[I2024-07-26T18:25:50.501729Z 524424 0 cmd_stream.go:492] rdb-stream: starting the test command - ["/home/swarming/.swarming/w/ir/cache/tools/bin/result_adapter" "go" "-v=false" "-dump-json" "/home/swarming/.swarming/w/ir/x/w/go.testjson" "--" "/home/swarming/.swarming/w/ir/x/w/goroot/bin/go" "test" "-json" "-short" "./..."]
ok golang.org/x/tools/benchmark/parse 0.007s
ok golang.org/x/tools/blog 0.015s
ok golang.org/x/tools/cmd/benchcmp 0.010s
ok golang.org/x/tools/cmd/bisect 0.055s
ok golang.org/x/tools/cmd/bundle 0.737s
ok golang.org/x/tools/cmd/callgraph 6.207s
ok golang.org/x/tools/cmd/deadcode 4.400s
ok golang.org/x/tools/cmd/digraph 0.007s
ok golang.org/x/tools/cmd/file2fuzz 0.066s
ok golang.org/x/tools/cmd/fiximports 10.784s
ok golang.org/x/tools/cmd/go-contrib-init 0.014s
ok golang.org/x/tools/cmd/godoc 5.029s
ok golang.org/x/tools/cmd/gonew 0.041s
ok golang.org/x/tools/cmd/gorename 9.341s
ok golang.org/x/tools/cmd/signature-fuzzer/fuzz-driver 1.211s
ok golang.org/x/tools/cmd/signature-fuzzer/fuzz-runner 23.717s
ok golang.org/x/tools/cmd/signature-fuzzer/internal/fuzz-generator 4.880s
ok golang.org/x/tools/cmd/splitdwarf/internal/macho 0.006s
ok golang.org/x/tools/cmd/stringer 12.038s
ok golang.org/x/tools/container/intsets 0.499s
ok golang.org/x/tools/copyright 1.581s
ok golang.org/x/tools/cover 0.018s
ok golang.org/x/tools/go/analysis 0.067s
ok golang.org/x/tools/go/analysis/analysistest 1.469s
ok golang.org/x/tools/go/analysis/internal/analysisflags 0.134s
ok golang.org/x/tools/go/analysis/internal/checker 8.035s
ok golang.org/x/tools/go/analysis/internal/versiontest 2.391s
ok golang.org/x/tools/go/analysis/multichecker 10.081s
ok golang.org/x/tools/go/analysis/passes/appends 0.453s
ok golang.org/x/tools/go/analysis/passes/asmdecl 4.749s
ok golang.org/x/tools/go/analysis/passes/assign 1.186s
ok golang.org/x/tools/go/analysis/passes/atomic 0.458s
ok golang.org/x/tools/go/analysis/passes/atomicalign 0.468s
ok golang.org/x/tools/go/analysis/passes/bools 1.304s
ok golang.org/x/tools/go/analysis/passes/buildssa 0.427s
ok golang.org/x/tools/go/analysis/passes/buildtag 0.461s
ok golang.org/x/tools/go/analysis/passes/cgocall 11.295s
ok golang.org/x/tools/go/analysis/passes/composite 1.145s
ok golang.org/x/tools/go/analysis/passes/copylock 0.764s
ok golang.org/x/tools/go/analysis/passes/ctrlflow 1.167s
ok golang.org/x/tools/go/analysis/passes/deepequalerrors 1.020s
ok golang.org/x/tools/go/analysis/passes/defers 1.032s
ok golang.org/x/tools/go/analysis/passes/directive 1.212s
ok golang.org/x/tools/go/analysis/passes/errorsas 0.704s
ok golang.org/x/tools/go/analysis/passes/fieldalignment 0.239s
ok golang.org/x/tools/go/analysis/passes/findcall 0.534s
ok golang.org/x/tools/go/analysis/passes/framepointer 0.275s
ok golang.org/x/tools/go/analysis/passes/httpmux 1.731s
ok golang.org/x/tools/go/analysis/passes/httpresponse 1.632s
ok golang.org/x/tools/go/analysis/passes/ifaceassert 1.105s
ok golang.org/x/tools/go/analysis/passes/internal/analysisutil 0.027s
ok golang.org/x/tools/go/analysis/passes/loopclosure 1.205s
ok golang.org/x/tools/go/analysis/passes/lostcancel 1.736s
ok golang.org/x/tools/go/analysis/passes/nilfunc 0.644s
ok golang.org/x/tools/go/analysis/passes/nilness 0.256s
ok golang.org/x/tools/go/analysis/passes/pkgfact 0.226s
ok golang.org/x/tools/go/analysis/passes/printf 1.341s
ok golang.org/x/tools/go/analysis/passes/reflectvaluecompare 1.004s
ok golang.org/x/tools/go/analysis/passes/shadow 1.182s
ok golang.org/x/tools/go/analysis/passes/shift 0.269s
ok golang.org/x/tools/go/analysis/passes/sigchanyzer 1.177s
ok golang.org/x/tools/go/analysis/passes/slog 1.236s
ok golang.org/x/tools/go/analysis/passes/sortslice 0.842s
ok golang.org/x/tools/go/analysis/passes/stdmethods 2.607s
ok golang.org/x/tools/go/analysis/passes/stdversion 1.531s
ok golang.org/x/tools/go/analysis/passes/stringintconv 0.331s
ok golang.org/x/tools/go/analysis/passes/structtag 1.489s
ok golang.org/x/tools/go/analysis/passes/testinggoroutine 1.572s
ok golang.org/x/tools/go/analysis/passes/tests 1.708s
ok golang.org/x/tools/go/analysis/passes/timeformat 1.313s
ok golang.org/x/tools/go/analysis/passes/unmarshal 1.499s
ok golang.org/x/tools/go/analysis/passes/unreachable 0.301s
ok golang.org/x/tools/go/analysis/passes/unsafeptr 0.977s
ok golang.org/x/tools/go/analysis/passes/unusedresult 1.092s
ok golang.org/x/tools/go/analysis/passes/unusedwrite 0.358s
ok golang.org/x/tools/go/analysis/passes/usesgenerics 0.401s
--- FAIL: TestIntegration (3.03s)
--- FAIL: TestIntegration/GOPATH (1.62s)
unitchecker_test.go:195: -json golang.org/fake/a: got <<# golang.org/fake/a
{
"golang.org/fake/a": {
"findcall": [
{
"posn": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_GOPATH378214514/fake/src/golang.org/fake/a/a.go:4:11",
"end_posn": "-",
"message": "call of MyFunc123(...)",
"suggested_fixes": [
{
"message": "Add '_TEST_'",
"edits": [
{
"filename": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_GOPATH378214514/fake/src/golang.org/fake/a/a.go",
"start": 32,
"end": 32,
"new": "_TEST_"
}
]
}
]
}
]
}
}
>>, want match of regexp <<# golang.org/fake/a
\{
"golang.org/fake/a": \{
"findcall": \[
\{
"posn": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?a/a.go:4:11",
"message": "call of MyFunc123\(...\)",
"suggested_fixes": \[
\{
"message": "Add '_TEST_'",
"edits": \[
\{
"filename": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?a/a.go",
"start": 32,
"end": 32,
"new": "_TEST_"
\}
\]
\}
\]
\}
\]
\}
\}
>>
unitchecker_test.go:195: -json golang.org/fake/c: got <<# golang.org/fake/c
{
"golang.org/fake/c": {
"assign": [
{
"posn": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_GOPATH378214514/fake/src/golang.org/fake/c/c.go:5:5",
"end_posn": "-",
"message": "self-assignment of i to i",
"suggested_fixes": [
{
"message": "Remove",
"edits": [
{
"filename": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_GOPATH378214514/fake/src/golang.org/fake/c/c.go",
"start": 37,
"end": 42,
"new": ""
}
]
}
]
}
]
}
}
>>, want match of regexp <<# golang.org/fake/c
\{
"golang.org/fake/c": \{
"assign": \[
\{
"posn": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?c/c.go:5:5",
"message": "self-assignment of i to i",
"suggested_fixes": \[
\{
"message": "Remove",
"edits": \[
\{
"filename": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?c/c.go",
"start": 37,
"end": 42,
"new": ""
\}
\]
\}
\]
\}
\]
\}
\}
>>
--- FAIL: TestIntegration/Modules (1.41s)
unitchecker_test.go:195: -json golang.org/fake/a: got <<# golang.org/fake/a
{
"golang.org/fake/a": {
"findcall": [
{
"posn": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_Modules3250204485/fake/a/a.go:4:11",
"end_posn": "-",
"message": "call of MyFunc123(...)",
"suggested_fixes": [
{
"message": "Add '_TEST_'",
"edits": [
{
"filename": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_Modules3250204485/fake/a/a.go",
"start": 32,
"end": 32,
"new": "_TEST_"
}
]
}
]
}
]
}
}
>>, want match of regexp <<# golang.org/fake/a
\{
"golang.org/fake/a": \{
"findcall": \[
\{
"posn": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?a/a.go:4:11",
"message": "call of MyFunc123\(...\)",
"suggested_fixes": \[
\{
"message": "Add '_TEST_'",
"edits": \[
\{
"filename": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?a/a.go",
"start": 32,
"end": 32,
"new": "_TEST_"
\}
\]
\}
\]
\}
\]
\}
\}
>>
unitchecker_test.go:195: -json golang.org/fake/c: got <<# golang.org/fake/c
{
"golang.org/fake/c": {
"assign": [
{
"posn": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_Modules3250204485/fake/c/c.go:5:5",
"end_posn": "-",
"message": "self-assignment of i to i",
"suggested_fixes": [
{
"message": "Remove",
"edits": [
{
"filename": "/home/swarming/.swarming/w/ir/x/t/TestIntegration_Modules3250204485/fake/c/c.go",
"start": 37,
"end": 42,
"new": ""
}
]
}
]
}
]
}
}
>>, want match of regexp <<# golang.org/fake/c
\{
"golang.org/fake/c": \{
"assign": \[
\{
"posn": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?c/c.go:5:5",
"message": "self-assignment of i to i",
"suggested_fixes": \[
\{
"message": "Remove",
"edits": \[
\{
"filename": "([/._\-a-zA-Z0-9]+[\\/]fake[\\/])?c/c.go",
"start": 37,
"end": 42,
"new": ""
\}
\]
\}
\]
\}
\]
\}
\}
>>
FAIL
FAIL golang.org/x/tools/go/analysis/unitchecker 5.525s
ok golang.org/x/tools/go/ast/astutil 0.032s
ok golang.org/x/tools/go/ast/inspector 0.109s
ok golang.org/x/tools/go/buildutil 1.042s
ok golang.org/x/tools/go/callgraph 0.005s [no tests to run]
ok golang.org/x/tools/go/callgraph/cha 0.011s
ok golang.org/x/tools/go/callgraph/rta 0.913s
ok golang.org/x/tools/go/callgraph/static 0.010s
ok golang.org/x/tools/go/callgraph/vta 0.367s
ok golang.org/x/tools/go/callgraph/vta/internal/trie 0.677s
ok golang.org/x/tools/go/cfg 0.012s
ok golang.org/x/tools/go/expect 0.028s
ok golang.org/x/tools/go/gccgoexportdata 0.004s
ok golang.org/x/tools/go/gcexportdata 0.560s
ok golang.org/x/tools/go/internal/gccgoimporter 0.025s
ok golang.org/x/tools/go/loader 4.064s
ok golang.org/x/tools/go/packages 16.136s
ok golang.org/x/tools/go/packages/packagestest 0.445s
ok golang.org/x/tools/go/ssa 4.104s
ok golang.org/x/tools/go/ssa/interp 1.913s
ok golang.org/x/tools/go/ssa/ssautil 1.472s
ok golang.org/x/tools/go/types/objectpath 0.021s
ok golang.org/x/tools/go/types/typeutil 0.014s
ok golang.org/x/tools/godoc 0.631s
ok golang.org/x/tools/godoc/redirect 0.014s
ok golang.org/x/tools/godoc/static 1.050s
ok golang.org/x/tools/godoc/vfs 0.014s
ok golang.org/x/tools/godoc/vfs/gatefs 0.022s
ok golang.org/x/tools/godoc/vfs/mapfs 0.039s
ok golang.org/x/tools/godoc/vfs/zipfs 0.023s
ok golang.org/x/tools/internal/aliases 0.085s
ok golang.org/x/tools/internal/analysisinternal 0.220s
ok golang.org/x/tools/internal/apidiff 1.839s
ok golang.org/x/tools/internal/bisect 0.069s
ok golang.org/x/tools/internal/diff 0.153s
ok golang.org/x/tools/internal/diff/difftest 0.389s
ok golang.org/x/tools/internal/diff/lcs 0.186s
ok golang.org/x/tools/internal/diff/myers 0.045s
ok golang.org/x/tools/internal/diffp 0.060s
ok golang.org/x/tools/internal/drivertest 2.574s
ok golang.org/x/tools/internal/edit 0.022s
ok golang.org/x/tools/internal/event 0.040s [no tests to run]
ok golang.org/x/tools/internal/event/export 0.085s
ok golang.org/x/tools/internal/event/export/ocagent 0.037s
ok golang.org/x/tools/internal/event/export/ocagent/wire 0.072s
ok golang.org/x/tools/internal/event/keys 0.034s
ok golang.org/x/tools/internal/event/label 0.026s
ok golang.org/x/tools/internal/facts 1.449s
ok golang.org/x/tools/internal/gcimporter 11.270s
ok golang.org/x/tools/internal/gocommand 0.558s
ok golang.org/x/tools/internal/gopathwalk 0.027s
ok golang.org/x/tools/internal/imports 10.721s
ok golang.org/x/tools/internal/jsonrpc2 0.196s
ok golang.org/x/tools/internal/jsonrpc2/servertest 0.030s
ok golang.org/x/tools/internal/jsonrpc2_v2 0.103s
ok golang.org/x/tools/internal/memoize 0.008s
ok golang.org/x/tools/internal/pprof 0.049s
ok golang.org/x/tools/internal/proxydir 0.051s
ok golang.org/x/tools/internal/refactor/inline 2.242s
ok golang.org/x/tools/internal/refactor/inline/analyzer 0.240s
ok golang.org/x/tools/internal/robustio 2.013s
ok golang.org/x/tools/internal/stack 0.007s
ok golang.org/x/tools/internal/testfiles 0.218s
ok golang.org/x/tools/internal/tokeninternal 0.025s
ok golang.org/x/tools/internal/typeparams 0.020s
ok golang.org/x/tools/internal/typesinternal 0.004s
ok golang.org/x/tools/internal/versions 0.017s
ok golang.org/x/tools/playground/socket 0.034s
ok golang.org/x/tools/present 0.040s
ok golang.org/x/tools/refactor/eg 1.596s
ok golang.org/x/tools/refactor/importgraph 1.318s
ok golang.org/x/tools/refactor/rename 0.537s
ok golang.org/x/tools/refactor/satisfy 0.070s
ok golang.org/x/tools/txtar 0.005s
Warning: no '=' in invocation-link-artifacts pair: "", ignoring
[I2024-07-26T18:26:59.303074Z 524424 0 cmd_stream.go:488] rdb-stream: the test process terminated
[I2024-07-26T18:26:59.303202Z 524424 0 sink.go:371] SinkServer: shutdown started
[I2024-07-26T18:26:59.303271Z 524424 0 sink.go:349] SinkServer: HTTP server stopped with "http: Server closed"
[I2024-07-26T18:26:59.303293Z 524424 0 sink_server.go:96] SinkServer: draining TestResult channel started
[I2024-07-26T18:26:59.896017Z 524424 0 sink_server.go:98] SinkServer: draining TestResult channel ended
[I2024-07-26T18:26:59.896062Z 524424 0 sink_server.go:100] SinkServer: draining Artifact channel started
[I2024-07-26T18:27:00.083676Z 524424 0 sink_server.go:102] SinkServer: draining Artifact channel ended
[I2024-07-26T18:27:00.083721Z 524424 0 sink.go:374] SinkServer: shutdown completed successfully
[I2024-07-26T18:27:00.083741Z 524424 0 cmd_stream.go:420] rdb-stream: exiting with 1