I dd a fresh install of the following two RPM's on a RHEL3 server:<br>
nx-1.5.0-4.FC1.1.i386.rpm<br>
freenx-0.4.4-2.rh.0.noarch.rpm<br>
<br>
I turned on Loglevel DEBUG3 to sshd_config file and restared the sshd daemon. <br>
<br>
The /etc/ssh/sshd_config had the following commented entry:<br>
#AuthorizedKeysFile .ssh/authorized_keys2<br>
<br>
I imported the /etc/nxserver/client.id_dsa.key from the server to the NX client on WinXP.<br>
<br>
And then I attempted to connect.<br>
The client timed out with the following detail:<br>
NX> 203 NXSSH running with pid: 4088<span><br>
NX> 285 Enabling check on switch command<br>
NX> 285 Enabling skip of SSH config files<br>
NX> 285 Setting the preferred NX options<br></span>
NX> 200 Connected to address: xx.xx.115.94 on port: 22<span><br>
NX> 202 Authenticating user: nx<br>
NX> 208 Using auth method: publickey<br></span>
HELLO NXSERVER - Version 1.4.0-44 OS (GPL)<br>
NX> 105 hello NXCLIENT - Version 1.4.0<br>
NX> 134 Accepted protocol: 1.4.0<br>
NX> 105 SET SHELL_MODE SHELL<br>
NX> 105 SET AUTH_MODE PASSWORD<br>
NX> 105 login<br>
NX> 101 User: joeuser<br>
NX> 102 Password: <br>
NX> 103 Welcome to: server3 user: joeuser<br>
NX> 105 listsession --user="joeuser" --status="suspended,running" --geometry="1024x768x32+render" --type="unix-gnome"<br>
NX> 127 Sessions list of user 'joeuser' for reconnect:<br>
<br>
Display
Type
Session
ID
Options Depth
Screen
Status Session Name<br>
------- ---------------- ------------------------------
<div>-- --------
----- -------------- ----------- ------------------------------<br>
<br>
<br>
NX> 148 Server capacity: not reached for user: joeuser<br>
NX> 105 startsession --link="lan" --backingstore="1"
--nodelay="1" --cache="8M" --images="32M" --media="0"
--session="efernandes" --type="unix-gnome" --cookie="******"
--geometry="fullscreen" --kbtype="pc102/en_US"
--screeninfo="1024x738x32+render" <br>
<br>
NX> 1000 NXNODE - Version 1.4.0-44 OS (GPL)<br>
NX> 700 Session id: server3-1000-A0B1EAEBB4A33EC3BE0946C6D43D73D6<br>
NX> 705 Session display: 1000<br>
NX> 703 Session type: unix-gnome<br>
NX> 701 Proxy cookie: dfd15830e072991f70aa234e39cfa361<br>
NX> 702 Proxy IP: xx.xx.111.212<br>
NX> 706 Agent cookie: 8abd0e15d7faa9d521df5125100ac05b<br>
NX> 704 Session cache: unix-gnome<br>
NX> 707 SSL tunneling: 0<br>
/usr/bin/nxserver: line 1041: 17346
Terminated
( sleep $AGENT_STARTUP_TIMEOUT; exit 1 )<br>
NX> 105 NX> 504 Session startup failed.<br>
NX> 1004 Error: nxagent failed to start with: Unrecognized option: 1<br>
NX> 1001 Bye.<br>
Killed by signal 15.<br>
<br>
<br>
<br>
And, the /var/log/secure output:<br> 0 used once, disabling now<br><br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_answer_pwnamallow: sending MONITOR_ANS_PWNAM: 1<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_send entering: type 7<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug2: monitor_read: 6 used once, disabling now<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_receive entering<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: monitor_read: checking request 41<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug1: Starting up PAM with username "joeuser"<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: Trying to reverse map address <a href="http://127.0.0.1/" target="_blank" onclick="return top.js.OpenExtLink(window,event,this)">127.0.0.1</a>.<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug1: PAM setting rhost to "localhost.localdomain"<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug2: monitor_read: 41 used once, disabling now<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_receive entering<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: monitor_read: checking request 3<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_answer_authserv: service=ssh-connection, style=<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug2: monitor_read: 3 used once, disabling now<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_receive entering<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: monitor_read: checking request 10<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug1: PAM password authentication accepted for joeuser<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_answer_authpassword: sending result 1<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_send entering: type 11<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug2: pam_acct_mgmt() = 0<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: Accepted password for efernandes from <a href="http://127.0.0.1/" target="_blank" onclick="return top.js.OpenExtLink(window,event,this)">127.0.0.1</a> port 53748 ssh2<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug1: monitor_child_preauth: joeuser has been authenticated by privileged process<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_get_keystate: Waiting for new keys<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_receive_expect entering: type 24<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_receive entering<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_newkeys_from_blob: 0x564fa0(122)<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug2: mac_init: found hmac-md5<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_get_keystate: Waiting for second key<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_newkeys_from_blob: 0x564fa0(122)<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug2: mac_init: found hmac-md5<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_get_keystate: Getting compression state<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_get_keystate: Getting Network I/O buffers<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_share_sync: Share sync<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_share_sync: Share sync end<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug2: User child is on pid 17363<br>
Oct 4 18:28:36 lvnc3 sshd[17359]: debug3: mm_request_receive entering<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: PAM establishing creds<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: PAM establishing creds<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: permanently_set_uid: 11338/100<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug2: set_newkeys: mode 0<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug2: set_newkeys: mode 1<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: Entering interactive session for SSH2.<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: fd 5 setting O_NONBLOCK<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: fd 6 setting O_NONBLOCK<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: server_init_dispatch_20<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: server_input_channel_open: ctype session rchan 0 win 131072 max 32768<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: input_session_request<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: channel 0: new [server-session]<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: session_new: init<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: session_new: session 0<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: session_open: channel 0<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: session_open: session 0: link with channel 0<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: server_input_channel_open: confirm session<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: server_input_channel_req: channel 0 request exec reply 0<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: session_by_channel: session 0 channel 0<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: session_input_channel_req: session 0 req exec<br>
Oct 4 18:28:36 lvnc3 sshd[17364]: debug3: channel_close_fds: channel 0: r -1 w -1 e -1<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: fd 8 setting O_NONBLOCK<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug2: fd 8 is O_NONBLOCK<br>
Oct 4 18:28:36 lvnc3 sshd[17363]: debug1: fd 10 setting O_NONBLOCK<br>
Oct 4 18:28:38 lvnc3 sshd[17125]: debug2: channel 0: read 101 from efd 10<br>
Oct 4 18:28:38 lvnc3 sshd[17125]: debug2: channel 0: rwin 129686 elen 101 euse 1<br>
Oct 4 18:28:38 lvnc3 sshd[17125]: debug2: channel 0: sent ext data 101<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: Received SIGCHLD.<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: Connection closed by <a href="http://127.0.0.1/" target="_blank" onclick="return top.js.OpenExtLink(window,event,this)">127.0.0.1</a><br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: session_by_pid: pid 17364<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: session_exit_message: session 0 channel 0 pid 17364<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: channel 0: request exit-status<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: session_exit_message: release channel 0<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: channel 0: write failed<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: channel 0: close_write<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: channel 0: output open -> closed<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: session_close: session 0 pid 17364<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: channel_free: channel 0: server-session, nchannels 1<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug3: channel_free: status:
The following connections are open:\015 #0 server-session
(t4 r0 i0/0 o3/0 fd 8/8)\015 <br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug3: channel_close_fds: channel 0: r 8 w 8 e 10<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug1: krb5_cleanup_proc called<br>
Oct 4 18:28:38 lvnc3 sshd[17363]: Closing connection to <a href="http://127.0.0.1/" target="_blank" onclick="return top.js.OpenExtLink(window,event,this)">127.0.0.1</a><br>
Oct 4 18:28:38 lvnc3 sshd[17363]: debug3: mm_request_send entering: type 42<br>
Oct 4 18:28:38 lvnc3 sshd[17359]: debug3: monitor_read: checking request 42<br>
Oct 4 18:28:38 lvnc3 sshd[17359]: debug3: mm_answer_term: tearing down sessions<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: Connection closed by xx.xx.111.212<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: debug1: channel_free: channel 0: server-session, nchannels 1<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: debug3: channel_free: status:
The following connections are open:\015 #0 server-session
(t4 r0 i0/0 o0/0 fd 8/8)\015 <br>
Oct 4 18:29:37 lvnc3 sshd[17125]: debug3: channel_close_fds: channel 0: r 8 w 8 e 10<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: debug1: session_close: session 0 pid 17127<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: debug1: krb5_cleanup_proc called<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: Closing connection to xx.xx.111.212<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: debug1: Received SIGCHLD.<br>
Oct 4 18:29:37 lvnc3 sshd[17125]: debug3: mm_request_send entering: type 42<br>
Oct 4 18:29:37 lvnc3 sshd[17122]: debug3: monitor_read: checking request 42<br>
Oct 4 18:29:37 lvnc3 sshd[17122]: debug3: mm_answer_term: tearing down sessions<br>
<br>
<br>
Is there somthing wrong with the RPM's that I installed?<br>
<br>
Thanks<br><span>
\Tom<br>
</span></div>
<br>