Skip to content

flake: TestExpMcpServer/NoCredentials #625

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
Open
deansheather opened this issue May 9, 2025 · 0 comments
Open

flake: TestExpMcpServer/NoCredentials #625

deansheather opened this issue May 9, 2025 · 0 comments
Assignees
@ThomasK33

Comments

@deansheather
Copy link
Member

This consistently fails for me in my dogfood workspace with a clean main checkout. Haven't seen this happen in CI. I wonder if the test is flaking due to persistent data in my workspace or something.

Running tool: /usr/local/go/bin/go test -timeout 30s -tags linux -run ^(TestExpMcpServer|TestExpMcpConfigureClaudeCode|TestExpMcpServerOptionalUserToken)$ github.com/coder/coder/v2/cli -short -coverpkg=./...

2025/05/09 05:04:20 Error reading input: context canceled
2025/05/09 05:04:20 Error reading input: context canceled
2025/05/09 05:04:20 Error reading input: context canceled
2025/05/09 05:04:30 Error reading input: context deadline exceeded
--- FAIL: TestExpMcpServer (0.00s)
    --- FAIL: TestExpMcpServer/NoCredentials (10.06s)
        /home/coder/coder/cli/coderdtest.go:591: coderdtest server listening on 127.0.0.1:44955
        /home/coder/coder/cli/coderdtest.go:591: coderdtest server started on http://127.0.0.1:44955
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.139 [debu]  coderd.metrics_cache: metrics refreshed  name="deployment stats"  interval=5m0s  took=3.817µs
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.140 [debu]  coderd.dbrollup: rolling up data
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.140 [debu]  coderd.dbrollup: rolled up data  took=660.405µs  event={"template_usage_stats":true}
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.140 [debu]  coderd.dbrollup: next rollup at  next="2025-05-09T05:05:00Z"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.140 [debu]  coderd.keyrotator: no valid keys detected, inserting new key  feature=oidc_convert
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: inserted new key for feature  feature=oidc_convert
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: no valid keys detected, inserting new key  feature=tailnet_resume
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: inserted new key for feature  feature=tailnet_resume
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: no valid keys detected, inserting new key  feature=workspace_apps_token
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: inserted new key for feature  feature=workspace_apps_token
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: no valid keys detected, inserting new key  feature=workspace_apps_api_key
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: inserted new key for feature  feature=workspace_apps_api_key
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.acquirer: subscribed to job postings
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.keyrotator: ctx canceled, stopping key rotation
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [warn]  coderd.site: could not parse install.sh, it will be unavailable  error="open install.sh: file does not exist"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.141 [debu]  coderd.metrics_cache: metrics refreshed  name="template build times"  interval=1h0m0s  took=1.594385ms
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: [v1] using fake (no-op) tun device
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: [v1] using fake (no-op) OS network configurator
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: [v1] using fake (no-op) DNS configurator
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: dns: using dns.noopManager
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: link state: interfaces.State{defaultRoute=eth0 ifs={docker0:[172.17.0.1/16] eth0:[172.20.0.2/16]} v4=true v6=false}
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: magicsock: [warning] failed to force-set UDP read buffer size to 7340032: operation not permitted; using kernel default values (impacts throughput only)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: magicsock: [warning] failed to force-set UDP write buffer size to 7340032: operation not permitted; using kernel default values (impacts throughput only)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: magicsock: [warning] failed to force-set UDP read buffer size to 7340032: operation not permitted; using kernel default values (impacts throughput only)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: magicsock: [warning] failed to force-set UDP write buffer size to 7340032: operation not permitted; using kernel default values (impacts throughput only)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: [v1] couldn't create raw v4 disco listener, using regular listener instead: raw disco listening disabled, SO_MARK unavailable
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: [v1] couldn't create raw v6 disco listener, using regular listener instead: raw disco listening disabled, SO_MARK unavailable
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: magicsock: disco key = d:9a6daa66208f8029
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: Creating WireGuard device...
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: Bringing WireGuard device up...
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] UDP bind has been updated
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Interface state was Down, requested Up, now Up
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Routine: receive incoming receiveDERP - started
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Routine: receive incoming mkReceiveFunc - started
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Routine: receive incoming mkReceiveFunc - started
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.142 [debu]  coderd.servertailnet.net.wgengine: Bringing router up...
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.143 [debu]  coderd.servertailnet.net.wgengine: [v1] warning: fakeRouter.Up: not implemented.
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.143 [debu]  coderd.servertailnet.net.wgengine: Clearing router settings...
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.143 [debu]  coderd.servertailnet.net.wgengine: [v1] warning: fakeRouter.Set: not implemented.
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.143 [debu]  coderd.servertailnet.net.wgengine: Starting network monitor...
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.143 [debu]  coderd.servertailnet.net.wgengine: Engine created.
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.143 [debu]  coderd.servertailnet: magicsock debug logging disabled, use CODER_MAGICSOCK_DEBUG_LOGGING=true to enable
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.143 [debu]  coderd.servertailnet.net.wgengine: magicsock: SetPrivateKey called (init)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.144 [debu]  coderd.servertailnet: updating engine network map  network_map="netmap: self: [aP9tG] auth=machine-unknown u=? [fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128]\n"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.144 [debu]  coderd.servertailnet.net.wgengine: [v1] magicsock: got updated network map; 0 peers
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.144 [debu]  coderd.servertailnet.net.netstack: [v2] netstack: registered IP fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.144 [debu]  coderd.servertailnet.net.wgengine: wgengine: Reconfig: configuring userspace WireGuard config (with 0/0 peers)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.144 [debu]  coderd.coord: initPeer  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  peer_name=inmemory10e06780-871c-4a1e-b15c-1ec78278b542
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.144 [debu]  coderd.coord: initial tunnel peers  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  peer_name=inmemory10e06780-871c-4a1e-b15c-1ec78278b542  tunnel_peers=[]
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet: skipped sending node; no node callback
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet: obtained tailnet API v2+ client
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.144 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] UAPI: Updating private key
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet.net.wgengine: wgengine: Reconfig: configuring router
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet.net.wgengine: [v1] warning: fakeRouter.Set: not implemented.
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet.net.wgengine: wgengine: Reconfig: configuring DNS
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet.net.wgengine: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet.net.wgengine: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet.net.wgengine: dns: OScfg: {Nameservers:[] SearchDomains:[] MatchDomains:[] Hosts:[]}
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet.net.wgengine: [v1] wgengine: Reconfig done
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.145 [debu]  coderd.servertailnet: updating engine filter  filter="&{logf:0x2233960 local:0xc001d5c0d8 logIPs:0xc001d5c0f0 matches4:[{IPProto:[6 17 1 58 132] Srcs:[{ip:{addr:{hi:0 lo:281470681743360} z:{value:0xc000307c38}} bitsPlusOne:1}] Dsts:[{Net:{ip:{addr:{hi:0 lo:281470681743360} z:{value:0xc000307c38}} bitsPlusOne:1} Ports:{First:0 Last:65535}}] Caps:[]}] matches6:[{IPProto:[6 17 1 58 132] Srcs:[{ip:{addr:{hi:0 lo:0} z:{value:0xc000307c50}} bitsPlusOne:1}] Dsts:[{Net:{ip:{addr:{hi:0 lo:0} z:{value:0xc000307c50}} bitsPlusOne:1} Ports:{First:0 Last:65535}}] Caps:[]}] cap4:[] cap6:[] state:0xc001d46080 shieldsUp:false}"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.146 [debu]  coderd.servertailnet: serving coordinator
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.146 [debu]  coderd.servertailnet: skipped sending node; no PreferredDERP  node="&{ID:nodeid:6e3a69bc7ca22992 AsOf:2025-05-09 05:04:20.146128 +0000 UTC Key:nodekey:68ff6d1859494ba2f8f88526415c91226311e8e7c364cab4d2bc952baf5eef5b DiscoKey:discokey:9a6daa66208f802958b89fb3a007b6748c5f933e3804efb8b9691e10c995415c PreferredDERP:0 DERPLatency:map[] DERPForcedWebsocket:map[] Addresses:[fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128] AllowedIPs:[fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128] Endpoints:[]}"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.146 [debu]  coderd.workspaceapps.stats_collector: workspace app stats collector started
        /home/coder/coder/cli/clitest.go:75: invoking command: coder --global-config /tmp/TestExpMcpServerNoCredentials2710564636/002 exp mcp server
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: Starting MCP server
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: Authentication : None
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: URL            : http://localhost:44955
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: Instructions   : ""
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: Press Ctrl+C to stop the server
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: Agent URL      : http://localhost:44955
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: CODER_MCP_APP_STATUS_SLUG is not set, task reporting will not be available.
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_create_template" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_create_template_version" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_create_workspace" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_create_workspace_build" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_delete_template" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_list_templates" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_template_version_parameters" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_list_workspaces" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_get_authenticated_user" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_get_template_version_logs" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_get_workspace" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_get_workspace_agent_logs" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_get_workspace_build_logs" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_upload_tar_file" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:20.154 [info]  cli: stderr: WARN: Tool "coder_update_template_active_version" requires authentication and will not be available
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.145 [debu]  coderd.servertailnet: got new DERP Map  derp_map="&{HomeParams:<nil> Regions:map[999:0xc0054c9810 1000:0xc0054c9860] OmitDefaultRegions:false}"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.145 [debu]  coderd.servertailnet: updating engine DERP map  derp_map="{\"Regions\":{\"1000\":{\"EmbeddedRelay\":false,\"RegionID\":1000,\"RegionCode\":\"coder_stun_1000\",\"RegionName\":\"Coder STUN 1000\",\"Nodes\":[{\"Name\":\"1000stun0\",\"RegionID\":1000,\"HostName\":\"127.0.0.1\",\"STUNPort\":56982,\"STUNOnly\":true}]},\"999\":{\"EmbeddedRelay\":true,\"RegionID\":999,\"RegionCode\":\"coder\",\"RegionName\":\"Coder Embedded Relay\",\"Nodes\":[{\"Name\":\"999b\",\"RegionID\":999,\"HostName\":\"\",\"IPv4\":\"127.0.0.1\",\"STUNPort\":-1,\"DERPPort\":44955,\"InsecureForTests\":true,\"ForceHTTP\":true}]}}}"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.146 [debu]  coderd.servertailnet.net.wgengine: netcheck: netcheck.runProbe: got STUN response for 1000stun0 from 127.0.0.1:53319 (5c820141f227d9911e965b56) in 147.468µs
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.146 [debu]  coderd.servertailnet.net.wgengine: netcheck: netcheck.runProbe: got STUN response for 1000stun0 from 127.0.0.1:53319 (85035ce417ffefae6773c423) in 208.182µs
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.146 [debu]  coderd.servertailnet.net.wgengine: netcheck: netcheck.runProbe: got STUN response for 1000stun0 from 127.0.0.1:53319 (f2b1034b0a40425983845ba1) in 236.466µs
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.197 [debu]  coderd.servertailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no address for node 999b
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.197 [debu]  coderd: GET  host=127.0.0.1:44955  path=/derp/latency-check  proto=HTTP/1.1  remote_addr=127.0.0.1  start="2025-05-09T05:04:25.197522195Z"  took=94.899µs  status_code=200  latency_ms=0  request_id=078317b1-ccc3-4ddd-b548-49e50c5d8d50
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.197 [debu]  coderd.servertailnet.net.wgengine: netcheck: [v1] report: udp=true v6=false v6os=true mapvarydest=false hair= portmap= v4a=127.0.0.1:53319 derp=999 derpdist=999v4:0s
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet.net.wgengine: magicsock: home is now derp-999 (coder)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet.net.wgengine: magicsock: adding connection to derp-999 for home-keep-alive
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet: new preferred DERP  preferred_derp=999
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet.net.wgengine: magicsock: 1 active derp conns: derp-999=cr0s,wr0s
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet: connecting to embedded DERP via in-memory pipe
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet: calling nodeUpdater callback  node="&{ID:nodeid:6e3a69bc7ca22992 AsOf:2025-05-09 05:04:25.19822 +0000 UTC Key:nodekey:68ff6d1859494ba2f8f88526415c91226311e8e7c364cab4d2bc952baf5eef5b DiscoKey:discokey:9a6daa66208f802958b89fb3a007b6748c5f933e3804efb8b9691e10c995415c PreferredDERP:999 DERPLatency:map[999-v4:0.000386048] DERPForcedWebsocket:map[] Addresses:[fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128] AllowedIPs:[fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128] Endpoints:[]}"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet: wireguard status  status="&{AsOf:2025-05-09 05:04:25.198240198 +0000 UTC m=+5.229270483 Peers:[] LocalAddrs:[] DERPs:1}"  error=<nil>
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.coord: peerReadLoop got request  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  peer_name=inmemory10e06780-871c-4a1e-b15c-1ec78278b542
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet.net.wgengine: magicsock: endpoints changed: 127.0.0.1:53319 (stun), 172.17.0.1:53319 (local), 172.20.0.2:53319 (local)
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet: wireguard status  status="&{AsOf:2025-05-09 05:04:25.198528893 +0000 UTC m=+5.229559177 Peers:[] LocalAddrs:[{Addr:127.0.0.1:53319 Type:stun} {Addr:172.17.0.1:53319 Type:local} {Addr:172.20.0.2:53319 Type:local}] DERPs:1}"  error=<nil>
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.servertailnet: calling nodeUpdater callback  node="&{ID:nodeid:6e3a69bc7ca22992 AsOf:2025-05-09 05:04:25.198579 +0000 UTC Key:nodekey:68ff6d1859494ba2f8f88526415c91226311e8e7c364cab4d2bc952baf5eef5b DiscoKey:discokey:9a6daa66208f802958b89fb3a007b6748c5f933e3804efb8b9691e10c995415c PreferredDERP:999 DERPLatency:map[999-v4:0.000386048] DERPForcedWebsocket:map[] Addresses:[fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128] AllowedIPs:[fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128] Endpoints:[127.0.0.1:53319 172.17.0.1:53319 172.20.0.2:53319]}"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.coord: processing node update  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  node="id:7942777151087061394  as_of:{seconds:1746767065  nanos:198220000}  key:\"nph\\xffm\\x18YIK\\xa2\\xf8\\xf8\\x85&A\\\\\\x91\\\"c\\x11\\xe8\\xe7\\xc3dʴҼ\\x95+\\xaf^\\xef[\"  disco:\"discokey:9a6daa66208f802958b89fb3a007b6748c5f933e3804efb8b9691e10c995415c\"  preferred_derp:999  derp_latency:{key:\"999-v4\"  value:0.000386048}  addresses:\"fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128\"  allowed_ips:\"fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128\""
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.coord: got tunnel peers  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  tunnel_peers=[]
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.coord: peerReadLoop got request  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  peer_name=inmemory10e06780-871c-4a1e-b15c-1ec78278b542
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.198 [debu]  coderd.coord: processing node update  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  node="id:7942777151087061394  as_of:{seconds:1746767065  nanos:198579000}  key:\"nph\\xffm\\x18YIK\\xa2\\xf8\\xf8\\x85&A\\\\\\x91\\\"c\\x11\\xe8\\xe7\\xc3dʴҼ\\x95+\\xaf^\\xef[\"  disco:\"discokey:9a6daa66208f802958b89fb3a007b6748c5f933e3804efb8b9691e10c995415c\"  preferred_derp:999  derp_latency:{key:\"999-v4\"  value:0.000386048}  addresses:\"fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128\"  allowed_ips:\"fd7a:115c:a1e0:4d22:b80b:4e7:2f84:a610/128\"  endpoints:\"127.0.0.1:53319\"  endpoints:\"172.17.0.1:53319\"  endpoints:\"172.20.0.2:53319\""
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.199 [debu]  coderd.coord: got tunnel peers  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  tunnel_peers=[]
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:25.199 [debu]  coderd.servertailnet.net.wgengine: magicsock: derp-999 connected; connGen=1
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [info]  cli: stderr: ERROR: Failed to start the MCP server: context deadline exceeded
        /home/coder/coder/cli/exp_mcp_test.go:154: 
            	Error Trace:	/home/coder/coder/cli/exp_mcp_test.go:154
            	Error:      	Error "running command \"coder exp mcp server\": context deadline exceeded" does not contain "are not logged in"
            	Test:       	TestExpMcpServer/NoCredentials
        /home/coder/coder/cli/ptytest.go:96: 2025-05-09 05:04:30.141: cmd: closing expecter: PTY close
        /home/coder/coder/cli/ptytest.go:121: 2025-05-09 05:04:30.141: cmd: copy done: <nil>
        /home/coder/coder/cli/ptytest.go:122: 2025-05-09 05:04:30.141: cmd: closing out
        /home/coder/coder/cli/ptytest.go:124: 2025-05-09 05:04:30.141: cmd: closed out: <nil>
        /home/coder/coder/cli/ptytest.go:87: 2025-05-09 05:04:30.141: cmd: closing logw
        /home/coder/coder/cli/ptytest.go:89: 2025-05-09 05:04:30.141: cmd: closed logw: <nil>
        /home/coder/coder/cli/ptytest.go:87: 2025-05-09 05:04:30.141: cmd: closing logr
        /home/coder/coder/cli/ptytest.go:89: 2025-05-09 05:04:30.141: cmd: closed logr: <nil>
        /home/coder/coder/cli/ptytest.go:113: 2025-05-09 05:04:30.141: cmd: closed expecter
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet: main context canceled; do graceful disconnect
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd: polling DERPMap exited
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet: sent disconnect
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet: stopped expiring old agents
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet: failed to receive DERP message  error="context canceled"
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.derp: derp: internal: client [aP9tG]: readFrameHeader: io: read/write on closed pipe
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.coord: peerReadLoop got request  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  peer_name=inmemory10e06780-871c-4a1e-b15c-1ec78278b542
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.coord: got tunnel peers  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  tunnel_peers=[]
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet: failed to read from protocol  error=EOF
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet: responses closed after disconnect
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.workspaceapps.stats_collector: flushing workspace app stats
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet: tailnet API v2+ connection lost
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.workspaceapps.stats_collector: flushed workspace app stats
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.workspaceapps.stats_collector: workspace app stats collector stopped
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.servertailnet.net.wgengine: magicsock: [0xc004e30780] derp.Recv(derp-999): derp.Recv: EOF
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [info]  coderd.servertailnet: closing server tailnet
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.141 [debu]  coderd.coord: peerReadLoop channel closed  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542  peer_name=inmemory10e06780-871c-4a1e-b15c-1ec78278b542
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [info]  coderd.servertailnet: closing tailnet Conn
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet: closing configMaps configLoop
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.coord: lostPeer  peer_id=10e06780-871c-4a1e-b15c-1ec78278b542
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet.net.wgengine: derp-999: [v1] backoff: 5 msec
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet: closing nodeUpdater updateLoop
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet: closed netstack
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet.net.wgengine: magicsock: closing connection to derp-999 (conn-close), age 5s
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet.net.wgengine: magicsock: 0 active derp conns
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Routine: receive incoming mkReceiveFunc - stopped
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet.net.wgengine: netcheck: netcheck.runProbe: got STUN response for 1000stun0 from 127.0.0.1:53319 (59d63e10d98b8e6892af693a) in 121.259µs
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.142 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Routine: receive incoming mkReceiveFunc - stopped
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.192 [debu]  coderd.servertailnet.net.wgengine: netcheck: [v1] report: udp=true v6=false v6os=true mapvarydest= hair= portmap= v4a=127.0.0.1:53319 derp=0
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.193 [debu]  coderd.servertailnet.net.wgengine: [v1] warning: fakeRouter.Close: not implemented.
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.193 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Device closing
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.193 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Routine: receive incoming receiveDERP - stopped
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.193 [debu]  coderd.servertailnet.net.wgengine: wg: [v2] Device closed
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.193 [debu]  coderd.servertailnet: server tailnet close complete
        /home/coder/coder/cli/t.go:106: 2025-05-09 05:04:30.193 [debu]  coderd.workspace_usage_tracker: workspace usage tracker loop exited
        /home/coder/coder/cli/stuntest.go:63: STUN server shutdown
        /home/coder/coder/cli/coderdtest.go:439: closing coderdtest server on 127.0.0.1:44955
        /home/coder/coder/cli/coderdtest.go:441: closed coderdtest server on 127.0.0.1:44955
FAIL
coverage: 10.7% of statements in ./...
FAIL	github.com/coder/coder/v2/cli	10.283s
FAIL
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@ThomasK33 ThomasK33

Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@ThomasK33 @deansheather