[NBLUG/talk] debian sarge ssh problem

[Walter Hansen]

I try to login as whansen using putty, but putty errors out and dies. I
get this in auth.log on debug setting (the Failed none showed up before I
tried to autenticate) :

Feb 16 08:36:14 localhost sshd[21882]: Connection from ::ffff:192.168.33.1
port 1117
Feb 16 08:36:14 localhost sshd[21797]: debug1: Forked child 21882.
Feb 16 08:36:14 localhost sshd[21882]: debug1: Client protocol version
2.0; client software version PuTTY-Release-0.52
Feb 16 08:36:14 localhost sshd[21882]: debug1: no match: PuTTY-Release-0.52
Feb 16 08:36:14 localhost sshd[21882]: debug1: Enabling compatibility mode
for protocol 2.0
Feb 16 08:36:14 localhost sshd[21882]: debug1: Local version string
SSH-2.0-OpenSSH_3.8.1p1 Debian-8.sarge.4
Feb 16 08:36:21 localhost sshd[21882]: debug1: PAM: initializing for
"whansen"
Feb 16 08:36:21 localhost sshd[21882]: debug1: PAM: setting PAM_RHOST to
"192.168.33.1"
Feb 16 08:36:21 localhost sshd[21882]: debug1: PAM: setting PAM_TTY to "ssh"
Feb 16 08:36:21 localhost sshd[21882]: Failed none for whansen from
::ffff:192.168.33.1 port 1117 ssh2
Feb 16 08:36:44 localhost sshd[21882]: debug1: do_cleanup
Feb 16 08:36:44 localhost sshd[21882]: debug1: PAM: cleanup


But if I put in an incorrect first password and then put in the correct
password at the second prompt it lets me in:

Feb 16 08:39:35 localhost sshd[21901]: Connection from ::ffff:192.168.33.1
port 1129
Feb 16 08:39:35 localhost sshd[21797]: debug1: Forked child 21901.
Feb 16 08:39:35 localhost sshd[21901]: debug1: Client protocol version
2.0; client software version PuTTY-Release-0.52
Feb 16 08:39:35 localhost sshd[21901]: debug1: no match: PuTTY-Release-0.52
Feb 16 08:39:36 localhost sshd[21901]: debug1: Enabling compatibility mode
for protocol 2.0
Feb 16 08:39:36 localhost sshd[21901]: debug1: Local version string
SSH-2.0-OpenSSH_3.8.1p1 Debian-8.sarge.4
Feb 16 08:39:45 localhost sshd[21901]: debug1: PAM: initializing for
"whansen"
Feb 16 08:39:45 localhost sshd[21901]: debug1: PAM: setting PAM_RHOST to
"192.168.33.1"
Feb 16 08:39:45 localhost sshd[21901]: debug1: PAM: setting PAM_TTY to "ssh"
Feb 16 08:39:45 localhost sshd[21901]: Failed none for whansen from
::ffff:192.168.33.1 port 1129 ssh2
Feb 16 08:39:49 localhost sshd[21901]: (pam_unix) authentication failure;
logname= uid=0 euid=0 tty=ssh ruser= rhost=192.168.33.1  user=whansen
Feb 16 08:39:50 localhost sshd[21901]: error: PAM: Authentication failure
for whansen from 192.168.33.1
Feb 16 08:39:50 localhost sshd[21901]: Failed keyboard-interactive/pam for
whansen from ::ffff:192.168.33.1 port 1129 ssh2
Feb 16 08:39:58 localhost sshd[21901]: Accepted password for whansen from
::ffff:192.168.33.1 port 1129 ssh2
Feb 16 08:39:58 localhost sshd[21901]: debug1: monitor_child_preauth:
whansen has been authenticated by privileged process
Feb 16 08:39:58 localhost sshd[21904]: (pam_unix) session opened for user
whansen by (uid=0)
Feb 16 08:39:58 localhost sshd[21904]: debug1: PAM: reinitializing
credentials
Feb 16 08:39:58 localhost sshd[21904]: debug1: PAM: pam_setcred():
Permission denied
Feb 16 08:39:58 localhost sshd[21904]: debug1: permanently_set_uid: 1000/1000
Feb 16 08:39:58 localhost sshd[21904]: debug1: Entering interactive
session for SSH2.
Feb 16 08:39:58 localhost sshd[21904]: debug1: server_init_dispatch_20
Feb 16 08:39:58 localhost sshd[21904]: debug1: server_input_channel_open:
ctype session rchan 256 win 16384 max 16384
Feb 16 08:39:58 localhost sshd[21904]: debug1: input_session_request
Feb 16 08:39:58 localhost sshd[21904]: debug1: channel 0: new
[server-session]
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_new: init
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_new: session 0
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_open: channel 0
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_open: session 0:
link with channel 0
Feb 16 08:39:58 localhost sshd[21904]: debug1: server_input_channel_open:
confirm session
Feb 16 08:39:58 localhost sshd[21904]: debug1: server_input_channel_req:
channel 0 request pty-req reply 1
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_by_channel: session
0 channel 0
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_input_channel_req:
session 0 req pty-req
Feb 16 08:39:58 localhost sshd[21904]: debug1: Allocating pty.
Feb 16 08:39:58 localhost sshd[21901]: debug1: session_new: init
Feb 16 08:39:58 localhost sshd[21901]: debug1: session_new: session 0
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_pty_req: session 0
alloc /dev/pts/5
Feb 16 08:39:58 localhost sshd[21904]: debug1: server_input_channel_req:
channel 0 request shell reply 1
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_by_channel: session
0 channel 0
Feb 16 08:39:58 localhost sshd[21904]: debug1: session_input_channel_req:
session 0 req shell
Feb 16 08:39:58 localhost sshd[21904]: debug1: PAM: setting PAM_TTY to
"/dev/pts/5"
Feb 16 08:39:58 localhost sshd[21905]: debug1: Setting controlling tty
using TIOCSCTTY.