microsoft / microsoft/vscode-remote-release

Wrong result when password input times out

Open
#2,466 0 comments 0 reactions 1 assignee View on GitHub

Nobody has claimed this yet.

bug plan-review ssh
Dominant language
Dockerfile
Stars
4.2k
Forks
470
Avg merge
1d 1h
Merged PRs (30d)
1

Description

  • Connect to a remote with a password
  • Don't enter the password, let the prompt sit for a few minutes
  • Log shows unhandled errors and "can't parse server output"
[10:21:31.739] Log Level: 1
[10:21:31.743] remote-ssh-nightly@2020.3.2402
[10:21:31.743] darwin x64
[10:21:31.746] SSH Resolver called for "ssh-remote+az-win", attempt 1
[10:21:31.746] SSH Resolver called for host: az-win
[10:21:31.746] Setting up SSH remote "az-win"
[10:21:31.750] Acquiring local install lock: /var/folders/tx/p0ycbfpj37786p760wwdg6y80000gn/T/vscode-remote-ssh-az-win-install.lock
[10:21:31.766] Looking for existing server data file at /Users/roblou/Library/Application Support/Code - Insiders/User/globalStorage/ms-vscode-remote.remote-ssh-nightly/vscode-ssh-host-az-win-d1c48c103cabc6e729f59787c0b9c86fb3d39e73/data.json
[10:21:31.768] Using commit id "d1c48c103cabc6e729f59787c0b9c86fb3d39e73" and quality "insider" for server
[10:21:31.770] Install and start server if needed
[10:21:31.778] Checking ssh with "ssh -V"
[10:21:31.794] > OpenSSH_7.9p1, LibreSSL 2.7.3
[10:21:31.798] askpass server listening on /var/folders/tx/p0ycbfpj37786p760wwdg6y80000gn/T/vscode-ssh-askpass-cc49f95f64867e27a29de56a247395e99f160ab8.sock
[10:21:31.798] Spawning local server with {"ipcHandlePath":"/var/folders/tx/p0ycbfpj37786p760wwdg6y80000gn/T/vscode-ssh-askpass-600ae27a9dd49ac49cc695c01b8cf71fa086a91a.sock","sshCommand":"ssh","sshArgs":["-v","-T","-D","64209","-o","ConnectTimeout=15","az-win"],"dataFilePath":"/Users/roblou/Library/Application Support/Code - Insiders/User/globalStorage/ms-vscode-remote.remote-ssh-nightly/vscode-ssh-host-az-win-d1c48c103cabc6e729f59787c0b9c86fb3d39e73/data.json"}
[10:21:31.799] Local server env: {"DISPLAY":"1","ELECTRON_RUN_AS_NODE":"1","SSH_ASKPASS":"/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/local-server/askpass.sh","VSCODE_SSH_ASKPASS_NODE":"/Applications/Visual Studio Code - Insiders.app/Contents/Frameworks/Code - Insiders Helper (Renderer).app/Contents/MacOS/Code - Insiders Helper (Renderer)","VSCODE_SSH_ASKPASS_MAIN":"/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/askpass-main.js","VSCODE_SSH_ASKPASS_HANDLE":"/var/folders/tx/p0ycbfpj37786p760wwdg6y80000gn/T/vscode-ssh-askpass-cc49f95f64867e27a29de56a247395e99f160ab8.sock"}
[10:21:31.803] Spawned 60407
[10:21:31.915] > local-server> Spawned ssh: 60408
[10:21:31.926] stderr> OpenSSH_7.9p1, LibreSSL 2.7.3
[10:21:31.926] stderr> debug1: Reading configuration data /Users/roblou/.ssh/config
[10:21:31.927] stderr> debug1: Reading configuration data /Users/roblou/.ssh/config2
[10:21:31.927] stderr> debug1: Reading configuration data /Users/roblou/.ssh/config3
[10:21:31.927] stderr> debug1: /Users/roblou/.ssh/config line 49: Applying options for az-win
[10:21:31.927] stderr> debug1: /Users/roblou/.ssh/config line 83: Applying options for *
[10:21:31.927] stderr> debug1: Reading configuration data /etc/ssh/ssh_config
[10:21:31.927] stderr> debug1: /etc/ssh/ssh_config line 48: Applying options for *
[10:21:31.928] stderr> debug1: /etc/ssh/ssh_config line 52: Applying options for *
[10:21:31.928] stderr> debug1: Connecting to 13.78.129.63 [13.78.129.63] port 4321.
[10:21:32.057] stderr> debug1: fd 3 clearing O_NONBLOCK
[10:21:32.057] stderr> debug1: Connection established.
[10:21:32.058] stderr> debug1: identity file /Users/roblou/.ssh/id_rsa type 0
[10:21:32.059] stderr> debug1: identity file /Users/roblou/.ssh/id_rsa-cert type -1
[10:21:32.059] stderr> debug1: identity file /Users/roblou/.ssh/id_dsa type -1
[10:21:32.059] stderr> debug1: identity file /Users/roblou/.ssh/id_dsa-cert type -1
[10:21:32.060] stderr> debug1: identity file /Users/roblou/.ssh/id_ecdsa type -1
[10:21:32.060] stderr> debug1: identity file /Users/roblou/.ssh/id_ecdsa-cert type -1
[10:21:32.060] stderr> debug1: identity file /Users/roblou/.ssh/id_ed25519 type -1
[10:21:32.060] stderr> debug1: identity file /Users/roblou/.ssh/id_ed25519-cert type -1
[10:21:32.060] stderr> debug1: identity file /Users/roblou/.ssh/id_xmss type -1
[10:21:32.061] stderr> debug1: identity file /Users/roblou/.ssh/id_xmss-cert type -1
[10:21:32.061] stderr> debug1: Local version string SSH-2.0-OpenSSH_7.9
[10:21:32.061] stderr> debug1: Remote protocol version 2.0, remote software version OpenSSH_for_Windows_7.7
[10:21:32.061] stderr> debug1: match: OpenSSH_for_Windows_7.7 pat OpenSSH* compat 0x04000000
[10:21:32.061] stderr> debug1: Authenticating to 13.78.129.63:4321 as 'roblou'
[10:21:32.062] stderr> debug1: SSH2_MSG_KEXINIT sent
[10:21:32.191] stderr> debug1: SSH2_MSG_KEXINIT received
[10:21:32.192] stderr> debug1: kex: algorithm: curve25519-sha256
[10:21:32.192] stderr> debug1: kex: host key algorithm: ecdsa-sha2-nistp256
[10:21:32.192] stderr> debug1: kex: server->client cipher: chacha20-poly1305@openssh.com MAC: <implicit> compression: none
[10:21:32.193] stderr> debug1: kex: client->server cipher: chacha20-poly1305@openssh.com MAC: <implicit> compression: none
[10:21:32.195] stderr> debug1: expecting SSH2_MSG_KEX_ECDH_REPLY
[10:21:32.231] stderr> debug1: Server host key: ecdsa-sha2-nistp256 SHA256:B5u79nIKTsEPOb8BGU6RUwqUYDxG4pxlhFrvluvrMlA
[10:21:32.233] stderr> debug1: Host '[13.78.129.63]:4321' is known and matches the ECDSA host key.
[10:21:32.233] stderr> debug1: Found key in /Users/roblou/.ssh/known_hosts:2
[10:21:32.236] stderr> debug1: rekey after 134217728 blocks
[10:21:32.237] stderr> debug1: SSH2_MSG_NEWKEYS sent
[10:21:32.237] stderr> debug1: expecting SSH2_MSG_NEWKEYS
[10:21:32.237] stderr> debug1: SSH2_MSG_NEWKEYS received
[10:21:32.237] stderr> debug1: rekey after 134217728 blocks
[10:21:32.238] stderr> debug1: Will attempt key: /Users/roblou/.ssh/id_rsa RSA SHA256:roLWOAd4DY8UlCXthcUaIrEPdgK9nNzs/ixa+eugGJE agent
[10:21:32.238] stderr> debug1: Will attempt key: roblou@microsoft.com RSA SHA256:wu42apo8AMaqpKRVq3HRWtKIOHTUrIDTm9Klp8EiXZA agent
[10:21:32.238] stderr> debug1: Will attempt key: /Users/roblou/.ssh/id_dsa 
[10:21:32.238] stderr> debug1: Will attempt key: /Users/roblou/.ssh/id_ecdsa 
[10:21:32.238] stderr> debug1: Will attempt key: /Users/roblou/.ssh/id_ed25519 
[10:21:32.238] stderr> debug1: Will attempt key: /Users/roblou/.ssh/id_xmss 
[10:21:32.239] stderr> debug1: SSH2_MSG_EXT_INFO received
[10:21:32.239] stderr> debug1: kex_input_ext_info: server-sig-algs=<ssh-ed25519,ssh-rsa,rsa-sha2-256,rsa-sha2-512,ssh-dss,ecdsa-sha2-nistp256,ecdsa-sha2-nistp384,ecdsa-sha2-nistp521>
[10:21:32.342] stderr> debug1: SSH2_MSG_SERVICE_ACCEPT received
[10:21:32.374] stderr> debug1: Authentications that can continue: publickey,password,keyboard-interactive
[10:21:32.375] stderr> debug1: Next authentication method: publickey
[10:21:32.375] stderr> debug1: Offering public key: /Users/roblou/.ssh/id_rsa RSA SHA256:roLWOAd4DY8UlCXthcUaIrEPdgK9nNzs/ixa+eugGJE agent
[10:21:32.406] stderr> debug1: Authentications that can continue: publickey,password,keyboard-interactive
[10:21:32.406] stderr> debug1: Offering public key: roblou@microsoft.com RSA SHA256:wu42apo8AMaqpKRVq3HRWtKIOHTUrIDTm9Klp8EiXZA agent
[10:21:32.437] stderr> debug1: Authentications that can continue: publickey,password,keyboard-interactive
[10:21:32.438] stderr> debug1: Trying private key: /Users/roblou/.ssh/id_dsa
[10:21:32.438] stderr> debug1: Trying private key: /Users/roblou/.ssh/id_ecdsa
[10:21:32.438] stderr> debug1: Trying private key: /Users/roblou/.ssh/id_ed25519
[10:21:32.439] stderr> debug1: Trying private key: /Users/roblou/.ssh/id_xmss
[10:21:32.439] stderr> debug1: Next authentication method: keyboard-interactive
[10:21:32.467] stderr> debug1: Authentications that can continue: publickey,password,keyboard-interactive
[10:21:32.467] stderr> debug1: Next authentication method: password
[10:21:32.467] stderr> debug1: read_passphrase: can't open /dev/tty: Device not configured
[10:21:32.593] Got askpass request: {"request":"roblou@13.78.129.63's password:"}
[10:21:32.594] Showing password prompt
[10:21:32.597] Listening for interwindow password on /var/folders/tx/p0ycbfpj37786p760wwdg6y80000gn/T/vscode-ssh-askpass-5de4bdf9fa469330697718d18d6c9a6edf720995.sock
[10:21:32.597] Writing password prompt to globalState
[10:31:32.576] Askpass request timed out
[10:31:32.579] Cleaning up other-window auth server
[10:31:32.588] Handling auth request failed: Error: Canceled
	at /Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/extension.js:1:90621
	at l.fire (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:48:845)
	at s.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:52:698)
	at t.CancellationTokenSource.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:53:239)
	at /Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/extension.js:1:374793
	at l.fire (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:48:845)
	at s.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:52:698)
	at t.CancellationTokenSource.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:53:239)
	at ServerResponse.<anonymous> (/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/extension.js:1:275664)
	at ServerResponse.emit (events.js:203:13)
	at Socket.socketOnTimeout (_http_server.js:472:33)
	at Socket.emit (events.js:203:13)
	at Socket._onTimeout (net.js:434:8)
	at listOnTimeout (internal/timers.js:531:17)
	at processTimers (internal/timers.js:475:7)
[10:31:32.589] Unhandled rejection: Error: Handling auth request failed: Error: Canceled
	at /Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/extension.js:1:90621
	at l.fire (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:48:845)
	at s.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:52:698)
	at t.CancellationTokenSource.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:53:239)
	at /Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/extension.js:1:374793
	at l.fire (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:48:845)
	at s.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:52:698)
	at t.CancellationTokenSource.cancel (/Applications/Visual Studio Code - Insiders.app/Contents/Resources/app/out/vs/workbench/services/extensions/node/extensionHostProcess.js:53:239)
	at ServerResponse.<anonymous> (/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/extension.js:1:275664)
	at ServerResponse.emit (events.js:203:13)
	at Socket.socketOnTimeout (_http_server.js:472:33)
	at Socket.emit (events.js:203:13)
	at Socket._onTimeout (net.js:434:8)
	at listOnTimeout (internal/timers.js:531:17)
	at processTimers (internal/timers.js:475:7)
	at IncomingMessage.<anonymous> (/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/extension.js:1:275939)
[10:31:32.590] stderr> Failed to get SSH credentials: Error in request: socket hang up
[10:31:32.590] stderr> ["/Applications/Visual Studio Code - Insiders.app/Contents/Frameworks/Code - Insiders Helper (Renderer).app/Contents/MacOS/Code - Insiders Helper (Renderer)","/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/askpass-main.js","roblou@13.78.129.63's","password:"]
[10:31:32.592] stderr> ssh_dispatch_run_fatal: Connection to 13.78.129.63 port 4321: Broken pipe
[10:31:32.594] > local-server> ssh child died, shutting down
[10:31:32.601] Local server exit: 0
[10:31:32.602] Received install output: OpenSSH_7.9p1, LibreSSL 2.7.3
debug1: Server host key: ecdsa-sha2-nistp256 SHA256:B5u79nIKTsEPOb8BGU6RUwqUYDxG4pxlhFrvluvrMlA
Failed to get SSH credentials: Error in request: socket hang up
["/Applications/Visual Studio Code - Insiders.app/Contents/Frameworks/Code - Insiders Helper (Renderer).app/Contents/MacOS/Code - Insiders Helper (Renderer)","/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/askpass-main.js","roblou@13.78.129.63's","password:"]
ssh_dispatch_run_fatal: Connection to 13.78.129.63 port 4321: Broken pipe

[10:31:32.603] Stopped parsing output early. Remaining text: OpenSSH_7.9p1, LibreSSL 2.7.3debug1: Server host key: ecdsa-sha2-nistp256 SHA256:B5u79nIKTsEPOb8BGU6RUwqUYDxG4pxlhFrvluvrMlAFailed to get SSH credentials: Error in request: socket hang up["/Applications/Visual Studio Code - Insiders.app/Contents/Frameworks/Code - Insiders Helper (Renderer).app/Contents/MacOS/Code - Insiders Helper (Renderer)","/Users/roblou/.vscode-insiders/extensions/ms-vscode-remote.remote-ssh-nightly-2020.3.2402/out/askpass-main.js","roblou@13.78.129.63's","password:"]ssh_dispatch_run_fatal: Connection to 13.78.129.63 port 4321: Broken pipe
[10:31:32.604] Failed to parse remote port from server output
[10:31:32.605] Resolver error: 
[10:31:32.608] TELEMETRY: {"eventName":"resolver","properties":{"outcome":"failure","reason":"UnparsableOutput","askedPw":"0","askedPassphrase":"0","asked2fa":"0","askedHostKey":"0","gotUnrecognizedPrompt":"0","remoteInConfigFile":"1"},"measures":{"resolveAttempts":1,"retries":1}}
[10:31:32.610] ------



Contributor guide

Open the contributing guide

First steps

  1. Read the whole issue, then the project's contributing guide.
  2. Comment on the issue to say you are picking it up — it saves two people doing the same work.
  3. Fork the repository and make your change on a branch.
  4. Open a pull request that references the issue number.

Assessment

This issue has not been assessed yet.

Get new issues in your inbox

A short digest of beginner-friendly GitHub issues.