[pkg-go] Bug#1027551: golang-github-hashicorp-go-plugin: FTBFS: dh_auto_test: error: cd obj-x86_64-linux-gnu && go test -vet=off -v -p 8 github.com/hashicorp/go-plugin github.com/hashicorp/go-plugin/internal/plugin returned exit code 1

Lucas Nussbaum lucas at debian.org
Sun Jan 1 14:33:48 GMT 2023


Source: golang-github-hashicorp-go-plugin
Version: 1.0.1-3
Severity: serious
Justification: FTBFS
Tags: bookworm sid ftbfs
User: lucas at debian.org
Usertags: ftbfs-20230101 ftbfs-bookworm

Hi,

During a rebuild of all packages in sid, your package failed to build
on amd64.


Relevant part (hopefully):
> make[1]: Entering directory '/<<PKGBUILDDIR>>'
> DH_GOLANG_EXCLUDES="examples test/grpc" \
> dh_auto_test
> 	cd obj-x86_64-linux-gnu && go test -vet=off -v -p 8 github.com/hashicorp/go-plugin github.com/hashicorp/go-plugin/internal/plugin
> === RUN   TestClient_testInterfaceReattach
> 2023-01-01T08:54:49.989Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface-daemon]
> 2023-01-01T08:54:49.990Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390733
> 2023-01-01T08:54:49.990Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:49.993Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin1885552887 network=unix timestamp=2023-01-01T08:54:49.993Z
> 2023-01-01T08:54:49.994Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:50.996Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:50 [ERR] plugin: plugin server: accept unix /tmp/plugin1885552887: use of closed network connection
> 2023-01-01T08:54:50.997Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390733
> 2023-01-01T08:54:51.994Z [DEBUG] plugin: reattached plugin process exited
> 2023-01-01T08:54:51.994Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_testInterfaceReattach (2.01s)
> === RUN   TestClient
> 2023-01-01T08:54:51.994Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, mock]
> 2023-01-01T08:54:51.994Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390742
> 2023-01-01T08:54:51.994Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:51.999Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:51.999Z [ERROR] plugin: client: error="dial tcp :1234: connect: connection refused"
> 2023-01-01T08:54:51.999Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:52.000Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390742 error="signal: killed"
> --- PASS: TestClient (0.01s)
> === RUN   TestClient_killStart
> 2023-01-01T08:54:52.000Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, bad-version, /tmp/plugin2951717675/booted]
> 2023-01-01T08:54:52.000Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390748
> 2023-01-01T08:54:52.000Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:52.008Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:52.008Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390748 error="signal: killed"
> --- PASS: TestClient_killStart (0.01s)
> === RUN   TestClient_testCleanup
> 2023-01-01T08:54:52.009Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, cleanup, /tmp/plugin288115145/output]
> 2023-01-01T08:54:52.009Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390755
> 2023-01-01T08:54:52.009Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:52.015Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:52.015Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin3340918480 network=unix timestamp=2023-01-01T08:54:52.015Z
> 2023-01-01T08:54:52.016Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:52 [ERR] plugin: plugin server: accept unix /tmp/plugin3340918480: use of closed network connection
> 2023-01-01T08:54:52.020Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390755
> 2023-01-01T08:54:52.020Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_testCleanup (0.01s)
> === RUN   TestClient_testInterface
> 2023-01-01T08:54:52.020Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface]
> 2023-01-01T08:54:52.021Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390763
> 2023-01-01T08:54:52.021Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:52.027Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin2009386764 network=unix timestamp=2023-01-01T08:54:52.027Z
> 2023-01-01T08:54:52.027Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:52.030Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:52 [ERR] plugin: plugin server: accept unix /tmp/plugin2009386764: use of closed network connection
> 2023-01-01T08:54:52.031Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390763
> 2023-01-01T08:54:52.031Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_testInterface (0.01s)
> === RUN   TestClient_grpc_servercrash
> 2023-01-01T08:54:52.031Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-grpc]
> 2023-01-01T08:54:52.032Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390771
> 2023-01-01T08:54:52.032Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:52.037Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin1708592230 network=unix timestamp=2023-01-01T08:54:52.036Z
> 2023-01-01T08:54:52.037Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:52.038Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390771 error="signal: killed"
> 2023-01-01T08:54:52.038Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_grpc_servercrash (0.01s)
> === RUN   TestClient_grpc
> 2023-01-01T08:54:52.038Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-grpc]
> 2023-01-01T08:54:52.038Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390778
> 2023-01-01T08:54:52.038Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:52.043Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:52.043Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin1695438311 network=unix timestamp=2023-01-01T08:54:52.042Z
> 2023-01-01T08:54:52.046Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390778
> 2023-01-01T08:54:52.046Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_grpc (0.01s)
> === RUN   TestClient_grpcNotAllowed
> 2023-01-01T08:54:52.046Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-grpc]
> 2023-01-01T08:54:52.046Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390787
> 2023-01-01T08:54:52.046Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:52.051Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:52.051Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:52.051Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin2436432757 network=unix timestamp=2023-01-01T08:54:52.051Z
> 2023-01-01T08:54:52.052Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390787 error="signal: killed"
> --- PASS: TestClient_grpcNotAllowed (0.01s)
> === RUN   TestClient_cmdAndReattach
> --- PASS: TestClient_cmdAndReattach (0.00s)
> === RUN   TestClient_reattach
> 2023-01-01T08:54:52.052Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface]
> 2023-01-01T08:54:52.053Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390794
> 2023-01-01T08:54:52.053Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:52.057Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:52.057Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin1299000067 network=unix timestamp=2023-01-01T08:54:52.057Z
> 2023-01-01T08:54:52.059Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:52 [ERR] plugin: plugin server: accept unix /tmp/plugin1299000067: use of closed network connection
> 2023-01-01T08:54:52.060Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390794
> 2023-01-01T08:54:53.058Z [DEBUG] plugin: reattached plugin process exited
> 2023-01-01T08:54:53.058Z [DEBUG] plugin: plugin exited
> 2023-01-01T08:54:53.058Z [WARN]  plugin: error closing client during Kill: err="connection is shut down"
> 2023-01-01T08:54:53.058Z [WARN]  plugin: plugin failed to exit gracefully
> --- PASS: TestClient_reattach (1.01s)
> === RUN   TestClient_reattachNoProtocol
> 2023-01-01T08:54:53.058Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface]
> 2023-01-01T08:54:53.059Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390803
> 2023-01-01T08:54:53.059Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:53.067Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin1523447966 network=unix timestamp=2023-01-01T08:54:53.067Z
> 2023-01-01T08:54:53.067Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:53.070Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:53 [ERR] plugin: plugin server: accept unix /tmp/plugin1523447966: use of closed network connection
> 2023-01-01T08:54:53.071Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390803
> 2023-01-01T08:54:54.068Z [DEBUG] plugin: reattached plugin process exited
> 2023-01-01T08:54:54.068Z [DEBUG] plugin: plugin exited
> 2023-01-01T08:54:54.068Z [WARN]  plugin: error closing client during Kill: err="connection is shut down"
> 2023-01-01T08:54:54.068Z [WARN]  plugin: plugin failed to exit gracefully
> --- PASS: TestClient_reattachNoProtocol (1.01s)
> === RUN   TestClient_reattachGRPC
> 2023-01-01T08:54:54.068Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-grpc]
> 2023-01-01T08:54:54.069Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390812
> 2023-01-01T08:54:54.069Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:54.077Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:54.077Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin3167379759 network=unix timestamp=2023-01-01T08:54:54.076Z
> 2023-01-01T08:54:54.080Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390812
> 2023-01-01T08:54:55.077Z [DEBUG] plugin: reattached plugin process exited
> 2023-01-01T08:54:55.077Z [DEBUG] plugin: plugin exited
> 2023-01-01T08:54:55.078Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_reattachGRPC (1.01s)
> === RUN   TestClient_reattachNotFound
> --- PASS: TestClient_reattachNotFound (0.01s)
> === RUN   TestClientStart_badVersion
> 2023-01-01T08:54:55.087Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, bad-version]
> 2023-01-01T08:54:55.088Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390822
> 2023-01-01T08:54:55.088Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.092Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:55.093Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390822 error="signal: killed"
> --- PASS: TestClientStart_badVersion (0.01s)
> === RUN   TestClientStart_badNegotiatedVersion
> 2023-01-01T08:54:55.093Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-versioned-plugins]
> 2023-01-01T08:54:55.093Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390828
> 2023-01-01T08:54:55.093Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.105Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin2827023705 network=unix timestamp=2023-01-01T08:54:55.104Z
> Incompatible API version with plugin. Plugin version: 2, Client versions: [1]
> 2023-01-01T08:54:55.105Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:55.105Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390828 error="signal: killed"
> --- PASS: TestClientStart_badNegotiatedVersion (0.01s)
> === RUN   TestClient_Start_Timeout
> 2023-01-01T08:54:55.105Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, start-timeout]
> 2023-01-01T08:54:55.106Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390835
> 2023-01-01T08:54:55.106Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.156Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:55.157Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390835 error="signal: killed"
> --- PASS: TestClient_Start_Timeout (0.05s)
> === RUN   TestClient_Stderr
> 2023-01-01T08:54:55.157Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, stderr]
> 2023-01-01T08:54:55.157Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390842
> 2023-01-01T08:54:55.157Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.162Z [DEBUG] plugin.go-plugin.test: HELLO
> 2023-01-01T08:54:55.162Z [DEBUG] plugin.go-plugin.test: WORLD
> 2023-01-01T08:54:55.163Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:55.163Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390842
> 2023-01-01T08:54:55.173Z [ERROR] plugin: client: error="dial tcp :1234: connect: connection refused"
> 2023-01-01T08:54:55.173Z [WARN]  plugin: plugin failed to exit gracefully
> --- PASS: TestClient_Stderr (0.02s)
> === RUN   TestClient_StderrJSON
> --- PASS: TestClient_StderrJSON (0.02s)
> === RUN   TestClient_textLogLevel
> --- PASS: TestClient_textLogLevel (0.02s)
> === RUN   TestClient_Stdin
> 2023-01-01T08:54:55.211Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, stdin]
> 2023-01-01T08:54:55.212Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390861
> 2023-01-01T08:54:55.212Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.221Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:55.221Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390861
> 2023-01-01T08:54:55.272Z [ERROR] plugin: client: error="dial tcp :1234: connect: connection refused"
> 2023-01-01T08:54:55.272Z [WARN]  plugin: plugin failed to exit gracefully
> --- PASS: TestClient_Stdin (0.07s)
> === RUN   TestClient_SecureConfig
> 2023-01-01T08:54:55.372Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface]
> 2023-01-01T08:54:55.372Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390867
> 2023-01-01T08:54:55.372Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.377Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin1382149286 network=unix timestamp=2023-01-01T08:54:55.377Z
> 2023-01-01T08:54:55.377Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:55.378Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:55 [ERR] plugin: plugin server: accept unix /tmp/plugin1382149286: use of closed network connection
> 2023-01-01T08:54:55.381Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390867
> 2023-01-01T08:54:55.381Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_SecureConfig (0.11s)
> === RUN   TestClient_TLS
>     client_test.go:820: DM-skipped
> --- SKIP: TestClient_TLS (0.00s)
> === RUN   TestClient_TLS_grpc
> 2023-01-01T08:54:55.383Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-grpc-tls]
> 2023-01-01T08:54:55.387Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390876
> 2023-01-01T08:54:55.387Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.396Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin2175119938 network=unix timestamp=2023-01-01T08:54:55.396Z
> 2023-01-01T08:54:55.396Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:55.403Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390876
> 2023-01-01T08:54:55.403Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_TLS_grpc (0.02s)
> === RUN   TestClient_secureConfigAndReattach
> --- PASS: TestClient_secureConfigAndReattach (0.00s)
> === RUN   TestClient_ping
> 2023-01-01T08:54:55.403Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface]
> 2023-01-01T08:54:55.404Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390885
> 2023-01-01T08:54:55.404Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.408Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin79457754 network=unix timestamp=2023-01-01T08:54:55.408Z
> 2023-01-01T08:54:55.408Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:55.410Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:55 [ERR] plugin: plugin server: accept unix /tmp/plugin79457754: use of closed network connection
> 2023-01-01T08:54:55.411Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390885
> 2023-01-01T08:54:55.411Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_ping (0.01s)
> === RUN   TestClient_wrongVersion
> 2023-01-01T08:54:55.411Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-proto-upgraded-plugin]
> 2023-01-01T08:54:55.411Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390894
> 2023-01-01T08:54:55.411Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.416Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin1140482954 network=unix timestamp=2023-01-01T08:54:55.416Z
> 2023-01-01T08:54:55.416Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:55.416Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:55.417Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390894 error="signal: killed"
> --- PASS: TestClient_wrongVersion (0.01s)
> === RUN   TestClient_legacyClient
> 2023-01-01T08:54:55.417Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-proto-upgraded-plugin]
> 2023-01-01T08:54:55.417Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390901
> 2023-01-01T08:54:55.418Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.422Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin653214565 network=unix timestamp=2023-01-01T08:54:55.422Z
> 2023-01-01T08:54:55.422Z [DEBUG] plugin: using plugin: version=1
> 2023-01-01T08:54:55.423Z [DEBUG] plugin.go-plugin.test: 2023/01/01 08:54:55 [ERR] plugin: error accepting control connection: tls: first record does not look like a TLS handshake
> 2023-01-01T08:54:55.423Z [WARN]  plugin: error closing client during Kill: err="connection is shut down"
> 2023-01-01T08:54:55.423Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:55.424Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390901 error="signal: killed"
> --- PASS: TestClient_legacyClient (0.01s)
> === RUN   TestClient_legacyServer
> 2023-01-01T08:54:55.424Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-proto-upgraded-client]
> 2023-01-01T08:54:55.425Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390909
> 2023-01-01T08:54:55.425Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:55.429Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin851132097 network=unix timestamp=2023-01-01T08:54:55.429Z
> 2023-01-01T08:54:55.429Z [DEBUG] plugin: using plugin: version=2
> 2023-01-01T08:54:57.431Z [WARN]  plugin: plugin failed to exit gracefully
> 2023-01-01T08:54:57.432Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390909 error="signal: killed"
> --- PASS: TestClient_legacyServer (2.01s)
> === RUN   TestClient_versionedClient
> 2023-01-01T08:54:57.432Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-versioned-plugins]
> 2023-01-01T08:54:57.432Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390916
> 2023-01-01T08:54:57.432Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:57.437Z [DEBUG] plugin: using plugin: version=2
> 2023-01-01T08:54:57.438Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin3524917669 network=unix timestamp=2023-01-01T08:54:57.437Z
> 2023-01-01T08:54:57.438Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390916 error="signal: killed"
> 2023-01-01T08:54:57.438Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_versionedClient (0.01s)
> === RUN   TestClient_mtlsClient
> 2023-01-01T08:54:57.438Z [INFO]  plugin: configuring client automatic mTLS
> 2023-01-01T08:54:57.473Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-mtls]
> 2023-01-01T08:54:57.473Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390923
> 2023-01-01T08:54:57.473Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:57.486Z [INFO]  plugin.go-plugin.test: configuring server automatic mTLS: timestamp=2023-01-01T08:54:57.486Z
> 2023-01-01T08:54:57.531Z [DEBUG] plugin: using plugin: version=2
> 2023-01-01T08:54:57.531Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin912735730 network=unix timestamp=2023-01-01T08:54:57.531Z
> 2023-01-01T08:54:57.559Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390923 error="signal: killed"
> 2023-01-01T08:54:57.559Z [DEBUG] plugin: plugin exited
> --- PASS: TestClient_mtlsClient (0.12s)
> === RUN   TestClient_mtlsNetRPCClient
> 2023-01-01T08:54:57.559Z [INFO]  plugin: configuring client automatic mTLS
> 2023-01-01T08:54:57.568Z [DEBUG] plugin: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface-mtls]
> 2023-01-01T08:54:57.569Z [DEBUG] plugin: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390931
> 2023-01-01T08:54:57.569Z [DEBUG] plugin: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:57.584Z [INFO]  plugin.go-plugin.test: configuring server automatic mTLS: timestamp=2023-01-01T08:54:57.584Z
> 2023-01-01T08:54:57.624Z [DEBUG] plugin: using plugin: version=0
> 2023-01-01T08:54:57.624Z [DEBUG] plugin.go-plugin.test: plugin address: address=/tmp/plugin3407982458 network=unix timestamp=2023-01-01T08:54:57.624Z
> 2023-01-01T08:54:57.647Z [DEBUG] plugin: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390931 error="signal: killed"
> 2023-01-01T08:54:57.647Z [WARN]  plugin: error closing client during Kill: err="connection is shut down"
> 2023-01-01T08:54:57.647Z [WARN]  plugin: plugin failed to exit gracefully
> --- PASS: TestClient_mtlsNetRPCClient (0.09s)
> === RUN   TestClient_logger
> === RUN   TestClient_logger/net/rpc
> 2023-01-01T08:54:57.647Z [DEBUG] test-logger: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface-logger-netrpc]
> 2023-01-01T08:54:57.648Z [DEBUG] test-logger: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390939
> 2023-01-01T08:54:57.648Z [DEBUG] test-logger: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:57.653Z [DEBUG] test-logger.go-plugin.test: plugin address: address=/tmp/plugin1182342450 network=unix timestamp=2023-01-01T08:54:57.652Z
> 2023-01-01T08:54:57.653Z [DEBUG] test-logger: using plugin: version=1
> 2023-01-01T08:54:57.655Z [INFO]  test-logger.go-plugin.test: PrintKV called: foo=bar timestamp=2023-01-01T08:54:57.655Z
> 2023-01-01T08:54:57.756Z [INFO]  test-logger.go-plugin.test: PrintKV called: foo=12 timestamp=2023-01-01T08:54:57.756Z
> 2023-01-01T08:54:57.857Z [DEBUG] test-logger.go-plugin.test: 2023/01/01 08:54:57 [ERR] plugin: plugin server: accept unix /tmp/plugin1182342450: use of closed network connection
> 2023-01-01T08:54:57.858Z [WARN]  test-logger: error closing client during Kill: err="unexpected EOF"
> 2023-01-01T08:54:57.858Z [WARN]  test-logger: plugin failed to exit gracefully
> 2023-01-01T08:54:57.858Z [DEBUG] test-logger: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390939
>     client_test.go:1303: process failed to exit gracefully
> === RUN   TestClient_logger/grpc
> 2023-01-01T08:54:57.858Z [DEBUG] test-logger: starting plugin: path=/tmp/go-build956649883/b001/go-plugin.test args=[/tmp/go-build956649883/b001/go-plugin.test, -test.run=TestHelperProcess, --, test-interface-logger-grpc]
> 2023-01-01T08:54:57.858Z [DEBUG] test-logger: plugin started: path=/tmp/go-build956649883/b001/go-plugin.test pid=390946
> 2023-01-01T08:54:57.858Z [DEBUG] test-logger: waiting for RPC address: path=/tmp/go-build956649883/b001/go-plugin.test
> 2023-01-01T08:54:57.864Z [DEBUG] test-logger.go-plugin.test: plugin address: address=/tmp/plugin3499674156 network=unix timestamp=2023-01-01T08:54:57.863Z
> 2023-01-01T08:54:57.864Z [DEBUG] test-logger: using plugin: version=1
> 2023-01-01T08:54:57.866Z [INFO]  test-logger.go-plugin.test: PrintKV called: foo=bar timestamp=2023-01-01T08:54:57.866Z
> 2023-01-01T08:54:57.967Z [INFO]  test-logger.go-plugin.test: PrintKV called: foo=12 timestamp=2023-01-01T08:54:57.967Z
> 2023-01-01T08:54:58.068Z [DEBUG] test-logger.go-plugin.test: 2023/01/01 08:54:58 [ERR] plugin: plugin server: accept unix /tmp/plugin3499674156: use of closed network connection
> 2023-01-01T08:54:58.070Z [WARN]  test-logger: error closing client during Kill: err="unexpected EOF"
> 2023-01-01T08:54:58.070Z [WARN]  test-logger: plugin failed to exit gracefully
> 2023-01-01T08:54:58.070Z [DEBUG] test-logger: plugin process exited: path=/tmp/go-build956649883/b001/go-plugin.test pid=390946
>     client_test.go:1303: process failed to exit gracefully
> --- FAIL: TestClient_logger (0.42s)
>     --- FAIL: TestClient_logger/net/rpc (0.21s)
>     --- FAIL: TestClient_logger/grpc (0.21s)
> === RUN   TestClient_logStderr
> 2023-01-01T08:54:58.070Z [DEBUG] plugin.test: 
> 2023-01-01T08:54:58.070Z [DEBUG] plugin.test: this line is more than 32 bytes 
> 2023-01-01T08:54:58.070Z [DEBUG] plugin.test: long
> 2023-01-01T08:54:58.070Z [DEBUG] plugin.test: and this line is more than 32 by
> 2023-01-01T08:54:58.070Z [DEBUG] plugin.test: tes long
> 2023-01-01T08:54:58.070Z [DEBUG] plugin.test: : a=b timestamp=0001-01-01T00:00:00.000Z
> 2023-01-01T08:54:58.070Z [DEBUG] plugin.test: this line is short
> --- PASS: TestClient_logStderr (0.00s)
> === RUN   TestBasicError_ImplementsError
> --- PASS: TestBasicError_ImplementsError (0.00s)
> === RUN   TestBasicError_MatchesMessage
> --- PASS: TestBasicError_MatchesMessage (0.00s)
> === RUN   TestNewBasicError_nil
> --- PASS: TestNewBasicError_nil (0.00s)
> === RUN   TestGRPCClient_App
> --- PASS: TestGRPCClient_App (0.00s)
> === RUN   TestGRPCConn_BidirectionalPing
> --- PASS: TestGRPCConn_BidirectionalPing (0.00s)
> === RUN   TestGRPCC_Stream
> --- PASS: TestGRPCC_Stream (0.00s)
> === RUN   TestGRPCClient_Ping
> --- PASS: TestGRPCClient_Ping (0.00s)
> === RUN   TestHelperProcess
> --- PASS: TestHelperProcess (0.00s)
> === RUN   TestClient_App
> --- PASS: TestClient_App (0.00s)
> === RUN   TestClient_syncStreams
>     rpc_client_test.go:47: Disabled unreliable test
> --- SKIP: TestClient_syncStreams (0.00s)
> === RUN   TestRmListener_impl
> --- PASS: TestRmListener_impl (0.00s)
> === RUN   TestRmListener
> --- PASS: TestRmListener (0.00s)
> === RUN   TestProtocolSelection_no_server
> --- PASS: TestProtocolSelection_no_server (0.00s)
> FAIL
> FAIL	github.com/hashicorp/go-plugin	8.098s
> ?   	github.com/hashicorp/go-plugin/internal/plugin	[no test files]
> FAIL
> dh_auto_test: error: cd obj-x86_64-linux-gnu && go test -vet=off -v -p 8 github.com/hashicorp/go-plugin github.com/hashicorp/go-plugin/internal/plugin returned exit code 1


The full build log is available from:
http://qa-logs.debian.net/2023/01/01/golang-github-hashicorp-go-plugin_1.0.1-3_unstable.log

All bugs filed during this archive rebuild are listed at:
https://bugs.debian.org/cgi-bin/pkgreport.cgi?tag=ftbfs-20230101;users=lucas@debian.org
or:
https://udd.debian.org/bugs/?release=na&merged=ign&fnewerval=7&flastmodval=7&fusertag=only&fusertagtag=ftbfs-20230101&fusertaguser=lucas@debian.org&allbugs=1&cseverity=1&ctags=1&caffected=1#results

A list of current common problems and possible solutions is available at
http://wiki.debian.org/qa.debian.org/FTBFS . You're welcome to contribute!

If you reassign this bug to another package, please mark it as 'affects'-ing
this package. See https://www.debian.org/Bugs/server-control#affects

If you fail to reproduce this, please provide a build log and diff it with mine
so that we can identify if something relevant changed in the meantime.



More information about the Pkg-go-maintainers mailing list