Skip to content
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.

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

Automatically reply keyboard-interactive password requests with password if available #293

Open
ManPython opened this issue Oct 1, 2021 · 19 comments
Labels
enhancement New feature or request good first issue Issues/features involving simple code changes

Comments

@ManPython
Copy link

There is option to save password:

Password Optional
Password for password-based user authentication. Supports env variables. This gets saved in plaintext! Using prompts or private keys is recommended!

But when saved and when connecting, then addon opening the comand line like ctr+p to type password.
This is no sense.
We need option to use this pass from setting as default, or ask..

I'm suggesting use something like this:
https://docs.openshift.com/container-platform/4.1/authentication/identity_providers/configuring-htpasswd-identity-provider.html

@SchoofsKelvin
Copy link
Owner

Can you post the SSH FS log? It is available under Output > SSH FS. While it should censor passwords/passphrases, I recommend checking it for (other) sensitive data first.


If I configure a (plain text) password in the Password field, the extension will use that to authenticate. Isn't this what you want?

@SchoofsKelvin SchoofsKelvin added invalid This doesn't seem right waiting Waiting for confirmation, more information, ... labels Oct 2, 2021
@ManPython
Copy link
Author

But nothing in SSH FS log before paste/type password. And after this shell outputs working normaly. I'm indicating that any connection after VSC is restarted/runned then must paste passwords to the remote shells.

Also password is stored in settings, just not used.
ssh

  • can be hidden here this maybe in case of many remote servers to offer some secure for user owner

@SchoofsKelvin
Copy link
Owner

Did you press Save? It should save it (to your User Settings) and use it every time you connect.

As for hiding the password, you can either set it to prompt for the password, make use of a private key (with passphrase) or ideally make use of an agent, in which you'd only have to add your key to your agent once every boot.

@ManPython
Copy link
Author

of course it's saved, thats is funny

@SchoofsKelvin
Copy link
Owner

I'll see what the logs say. Even though it doesn't log much before the prompt finishes, afterwards it prints a bunch of information, including info about what it thought it should've used as password or why it prompts.

@ManPython
Copy link
Author

But to be clear.. coz not sure. Exist some logs for before logs by SSHFS? Or it's declaration by Your side to check?

@SchoofsKelvin
Copy link
Owner

Use the View: Show SSH FS command or go to the Output > SSH FS pane. Try connecting to your server (including entering your real or even a fake password), then copy all the logs in that pane and post it here. While it should censor passwords/passphrases, I recommend checking it for (other) sensitive data first.

@ManPython
Copy link
Author

ManPython commented Oct 18, 2021

You not understand me well I think.

  1. When clicking icon Open Remonte SSH terminal to connect alwyas have this input.
    ssh fs 1

  2. This have no sense if password is stored, if not type correct or fake then have this popup
    ssh fs 2

Also by this.. no any logs.. coz it is problem with logic or configuration.

@SchoofsKelvin
Copy link
Owner

That's why I'm saying to enter a password so the logs are printed and I can check them for any useful information. It should still print logs after you've gone through all the input prompts.

@ManPython
Copy link
Author

But where to find logs? How to force it? After enter password I have typical shell.. then working normal.
I can add.. when killing terminals and again connecting then password is used and not need to type, only when VSC is restarted. The restart trying to find active connections thats consuming long time in my opinion (around 30 sec, after this dock showing server config that can have prepare connection).

@SchoofsKelvin
Copy link
Owner

But where to find logs?

  • Enter your password until you get a typical shell.
  • Either open the Output pane and select SSH FS from the dropdown, or use the View: Show SSH FS command
  • You should see a bunch of logs you can just copy-and-paste here (after double-checking for sensitive information)

@ManPython
Copy link
Author

Soo.. the first input is "password": "<censored>", not "password": "mypassword",?

[INFO]    
Created output channel for vscode-sshfs
When posting your logs somewhere, keep the following in mind:
  - While the logging tries to censor your passwords/passphrases/..., double check!
    Maybe you also want to censor out e.g. the hostname/IP you're connecting to.
  - If you want to report an issue regarding authentication or something else that
    seems to be more of an issue with the actual SSH2 connection, it might be handy
    to reconnect with this added to your User Settings (settings.json) first:
      "sshfs.flags": [ "DEBUG_SSH2" ],
    This will (for new connections) also enable internal SSH2 logging.

[INFO]    Loading configurations...
[INFO]    Calculated config flags: {}
[DEBUG]   	Added configuration myserver.com from [1]
[INFO]    Found 1 configurations
[INFO]    Extension activated, version 1.23.1, mode 1
[INFO]    Command received to open a terminal for FileSystemConfig(myserver.com)
[INFO]    [createConnection(myserver.com,config)] Creating a new connection for 'myserver.com'
[INFO]    Calculating actual config
[DEBUG]   	Final configuration:
{
    "name": "myserver.com",
    "host": "myserver.com",
    "password": "<censored>",
    "username": "ManPython",
    "_location": 1,
    "_locations": [
        1
    ],
    "_calculated": {
        "name": "myserver.com",
        "host": "myserver.com",
        "password": "<censored>",
        "username": "ManPython",
        "_location": 1,
        "_locations": [
            1
        ]
    },
    "port": 22
}
[INFO]    [createSocket(myserver.com)] Creating socket
[DEBUG]   [createSocket(myserver.com)] Connecting to myserver.com:22
[DEBUG]   [createSSH(myserver.com)] Received keyboard-interactive request with prompts [{"prompt":"Password for ManPython@myserver.com:","echo":false}]
[INFO]    Command received to configure myserver.com
[DEBUG]   [WebView] Navigation requested: {
    "config": {
        "name": "myserver.com",
        "host": "myserver.com",
        "password": "mypassword",
        "username": "ManPython",
        "_location": 1,
        "_locations": [
            1
        ]
    },
    "type": "editconfig"
}
[DEBUG]   [WebView] Got message: {"type":"navigated","view":"startscreen"}
[DEBUG]   [WebView] Got message: {"type":"requestData"}
[INFO]    Loading configurations...
[DEBUG]   [WebView] Got message: {"type":"requestData"}
[INFO]    Loading configurations...
[DEBUG]   [WebView] Got message: {"type":"navigated","view":"configeditor"}
[INFO]    [createConnection(myserver.com,config)] Remote version: OpenSSH_7.9
[DEBUG]   [createConnection(myserver.com,config)] Home path: /home/ManPython
[DEBUG]   [createConnection(myserver.com,config)] Environment: []
[DEBUG]   Starting shell for myserver.com: $SHELL

@SchoofsKelvin
Copy link
Owner

According to those logs, your server is actually the one asking for the password:

[DEBUG]   [createSSH(myserver.com)] Received keyboard-interactive request with prompts [{"prompt":"Password for ManPython@myserver.com:","echo":false}]

This is quite unusual. If you want more detailed logs (including the underlying ssh2's logs) that log every step of the authentication process, you can use the following instructions:
This issue would be easier to solve with debug logs, so please follow these steps:

  • Add DEBUG_SSH2 to the sshfs.flags array in VS Code's User Settings (settings.json)
    e.g. "sshfs.flags": ["DEBUG_SSH2"]
    • See this issue for more information about adding flags
  • If you already have a connection open, close it completely (or even reload the window)
  • Go to Output > SSH FS and copy the log from there after replicating your bug
  • While it should censor passwords/passphrases, I recommend checking it for (other) sensitive data first.
    (especially since DEBUG_SSH2 activates some internal logging, which is less likely to be censored)

Since this is the first time I've seen an unwanted keyboard-interactive request, I'm assuming it's some weird sshd configuration on your server?

@ManPython
Copy link
Author

Since this is the first time I've seen an unwanted keyboard-interactive request, I'm assuming it's some weird sshd configuration on your server?

Not sure about.

But it's only on my server that this pass is not user 1st time?

[INFO]    
Created output channel for vscode-sshfs
When posting your logs somewhere, keep the following in mind:
  - While the logging tries to censor your passwords/passphrases/..., double check!
    Maybe you also want to censor out e.g. the hostname/IP you're connecting to.
  - If you want to report an issue regarding authentication or something else that
    seems to be more of an issue with the actual SSH2 connection, it might be handy
    to reconnect with this added to your User Settings (settings.json) first:
      "sshfs.flags": [ "DEBUG_SSH2" ],
    This will (for new connections) also enable internal SSH2 logging.

[INFO]    Loading configurations...
[INFO]    Calculated config flags: {}
[DEBUG]   	Added configuration myserver.com from [1]
[INFO]    Found 1 configurations
[INFO]    Extension activated, version 1.23.1, mode 1
[INFO]    Loading configurations...
[DEBUG]   	Added configuration myserver.com from [1]
[INFO]    Found 1 configurations
[INFO]    Loading configurations...
[INFO]    Calculated config flags: {"debug_ssh2":[null,"Global Settings"]}
[DEBUG]   	Added configuration myserver.com from [1]
[INFO]    Found 1 configurations
[INFO]    Command received to open a terminal for FileSystemConfig(myserver.com)
[INFO]    [createConnection(myserver.com,config)] Creating a new connection for 'myserver.com'
[INFO]    Calculating actual config
[DEBUG]   	Final configuration:
{
    "name": "myserver.com",
    "host": "myserver.com",
    "password": "<censored>",
    "username": "ManPython",
    "_location": 1,
    "_locations": [
        1
    ],
    "_calculated": {
        "name": "myserver.com",
        "host": "myserver.com",
        "password": "<censored>",
        "username": "ManPython",
        "_location": 1,
        "_locations": [
            1
        ]
    },
    "port": 22
}
[INFO]    [createSocket(myserver.com)] Creating socket
[DEBUG]   [createSocket(myserver.com)] Connecting to myserver.com:22
[DEBUG]   [ssh2(myserver.com)] DEBUG: Local ident: 'SSH-2.0-ssh2js0.4.10'
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_INIT
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_GREETING
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_HEADER
[DEBUG]   [ssh2(myserver.com)] DEBUG: Remote ident: 'SSH-2.0-OpenSSH_7.9 FreeBSD-20200214'
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing KEXINIT
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 8)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:1140,padLen:4,remainLen:1136
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: KEXINIT
[DEBUG]   [ssh2(myserver.com)] DEBUG: Comparing KEXINITs ...
 
 
 
[DEBUG]   [ssh2(myserver.com)] DEBUG: Server->Client compression algorithm: none
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing KEXECDH_INIT
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 8)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:188,padLen:8,remainLen:184
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: KEXECDH_REPLY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Checking host key format
[DEBUG]   [ssh2(myserver.com)] DEBUG: Checking signature format
[DEBUG]   [ssh2(myserver.com)] DEBUG: Verifying host fingerprint
[DEBUG]   [ssh2(myserver.com)] DEBUG: Host accepted by default (no verification)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Verifying signature
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing NEWKEYS
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 8)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:12,padLen:10,remainLen:8
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: NEWKEYS
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing SERVICE_REQUEST (ssh-userauth)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:28,padLen:10,remainLen:16
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: SERVICE_ACCEPT
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing USERAUTH_REQUEST (none)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:7,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: USERAUTH_FAILURE
[DEBUG]   [ssh2(myserver.com)] DEBUG: Client: none auth failed
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing USERAUTH_REQUEST (password)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:7,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: USERAUTH_FAILURE
[DEBUG]   [ssh2(myserver.com)] DEBUG: Client: password auth failed
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing USERAUTH_REQUEST (keyboard-interactive)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:76,padLen:16,remainLen:64
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: USERAUTH_INFO_REQUEST
[DEBUG]   [createSSH(myserver.com)] Received keyboard-interactive request with prompts [{"prompt":"Password for ManPython@myserver.com:","echo":false}]
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[INFO]    Command received to configure myserver.com
[DEBUG]   [WebView] Navigation requested: {
    "config": {
        "name": "myserver.com",
        "host": "myserver.com",
        "password": "mypassword",
        "username": "ManPython",
        "_location": 1,
        "_locations": [
            1
        ]
    },
    "type": "editconfig"
}
[DEBUG]   [WebView] Got message: {"type":"navigated","view":"startscreen"}
[DEBUG]   [WebView] Got message: {"type":"requestData"}
[INFO]    Loading configurations...
[DEBUG]   [WebView] Got message: {"type":"requestData"}
[INFO]    Loading configurations...
[DEBUG]   [WebView] Got message: {"type":"navigated","view":"configeditor"}
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing USERAUTH_INFO_RESPONSE
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:28,padLen:10,remainLen:16
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: USERAUTH_INFO_REQUEST
[DEBUG]   [ssh2(myserver.com)] DEBUG: Client: Sending automatic USERAUTH_INFO_RESPONSE
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing USERAUTH_INFO_RESPONSE
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:12,padLen:10,remainLen:0
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: USERAUTH_SUCCESS
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[INFO]    [createConnection(myserver.com,config)] Remote version: OpenSSH_7.9
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_OPEN (0, session)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:492,padLen:16,remainLen:480
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: GLOBAL_REQUEST (hostkeys-00@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:28,padLen:10,remainLen:16
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_OPEN_CONFIRMATION
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_REQUEST (0, exec)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:28,padLen:18,remainLen:16
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_WINDOW_ADJUST (0, 2097152)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:12,padLen:6,remainLen:0
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_SUCCESS (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:6,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_DATA (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:12,padLen:6,remainLen:0
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_EOF (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:18,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (0, exit-status)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:12,padLen:6,remainLen:0
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_CLOSE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_CLOSE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [createConnection(myserver.com,config)] Home path: /home/ManPython
[DEBUG]   [createConnection(myserver.com,config)] Environment: []
[DEBUG]   Starting shell for myserver.com: $SHELL
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_OPEN (1, session)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:28,padLen:10,remainLen:16
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_OPEN_CONFIRMATION
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_REQUEST (0, pty-req)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:12,padLen:6,remainLen:0
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_SUCCESS (1)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_REQUEST (0, exec)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:28,padLen:18,remainLen:16
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_WINDOW_ADJUST (1, 2097152)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:12,padLen:6,remainLen:0
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_SUCCESS (1)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:60,padLen:17,remainLen:48
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_DATA (1)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:12,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: CHANNEL_REQUEST (1, keepalive@openssh.com)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing CHANNEL_FAILURE (0)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)

@SchoofsKelvin
Copy link
Owner

It seems like password authentication fails:

[DEBUG]   [ssh2(myserver.com)] DEBUG: Outgoing: Writing USERAUTH_REQUEST (password)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETBEFORE (expecting 16)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKET
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: pktLen:44,padLen:7,remainLen:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATA
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Decrypting
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: HMAC size:32
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: Verifying MAC
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAVERIFY (Valid HMAC)
[DEBUG]   [ssh2(myserver.com)] DEBUG: Parser: IN_PACKETDATAAFTER, packet: USERAUTH_FAILURE
[DEBUG]   [ssh2(myserver.com)] DEBUG: Client: password auth failed

Are you sure you entered the correct password? E.g. the same password you'd use when logging in on that user (or when doing sudo or login ManPython). When password authentication fails, the extension tries other possible authentications, in this case keyboard-interactive. On most servers this isn't configured, but in your case it's basically just asking for the password, as an alternative to the "standard built-in" password authentication. (some servers require e.g. a password and a 2FA one-time use token, hence keyboard-interactive is a thing)

@ManPython
Copy link
Author

Are you sure you entered the correct password?

Sure, note this post #293 (comment) . That this case is only when VSC is restarted.
Also still not sure that can be server config issuer or addon problem.

@SchoofsKelvin
Copy link
Owner

I meant is the correct password configured in the settings? And when you use SSH outside VS Code (e.g. through the ssh command or PuTTY), does it also prompt with Password for ManPython@myserver.com: or does it just use the default password prompt (e.g. ManPython@myserver.com's password:)? I'm curious if you've always unknowingly used the keyboard-interactive authentication instead of password authentication.

@ManPython
Copy link
Author

I meant is the correct password configured in the settings?

Yes. After session is closed and must re-connect the password is used from config as in post I wroted, and it's correct then.
As I wrote, password is typed only when VSC is restarted, not controlling the server command to login.

@SchoofsKelvin
Copy link
Owner

I'm not sure what I can do then. I could try adding an option to auto-reply with the password when the server prompts for something with "password" in the text during authentication (once I figure out how to detect that state, since the underlying ssh2 library hides all of that), although not the cleanest option. Your server is still weirdly configured.

@SchoofsKelvin SchoofsKelvin added enhancement New feature or request good first issue Issues/features involving simple code changes and removed invalid This doesn't seem right waiting Waiting for confirmation, more information, ... labels Oct 21, 2021
@SchoofsKelvin SchoofsKelvin changed the title Password is not used when saved Automatically reply keyboard-interactive password requests with password if available Oct 21, 2021
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
enhancement New feature or request good first issue Issues/features involving simple code changes
Projects
None yet
Development

No branches or pull requests

2 participants