Network Connection drops when Serial Console is disconnected/interrupted
Ok, here's the situation. I cannot use networking unless the serial console is activated. Not sure what details will help find a solution, but I'll give it my best.
Sun Enterprise 250 running Debian Linux 'Etch' on a sparc platform. ~300MHz dual processor, 2GB RAM, NIC, video card, serial com.
Step by step:
1. Boot system, success
2. Attempt connect via SSH, fail
3. Attempt connect via Serial, success
4. Attempt connect via SSH, success
5. Disconnect Serial, All network function cease, SSH drops, ifconfig reports the adapter is live and function and not dropping or colliding
6. Attempt connect via Serial, success
7. Upon Serial reconnection, network jumps back to life
8. The following error pops up on Serial Console: eth0: Happy Meal out of receive descriptors, packet dropped.
Here's a dump of /var/log/auth.log during the process:
May 2 12:32:27 newerjersey login[4683]: (pam_unix) session openedfor user root by (uid=0)
May 2 12:32:27 newerjersey login[4685]: ROOT LOGIN on'ttyS0'
May 2 12:32:56 newerjersey sshd[3992]: debug3: fd 4 is not O_NONBLOCK
May 2 12:32:56 newerjersey sshd[4699]: debug1: rexec start in 4 out 4 newsock 4 pipe 6 sock 7
May 2 12:32:56 newerjersey sshd[3992]: debug1: Forked child 4699.
May 2 12:32:56 newerjersey sshd[3992]: debug3: send_rexec_state: entering fd = 7 config len 640
May 2 12:32:56 newerjersey sshd[3992]: debug3: ssh_msg_send: type 0
May 2 12:32:56 newerjersey sshd[3992]: debug3: send_rexec_state: done
May 2 12:32:56 newerjersey sshd[4699]: debug1: inetd sockets after dupping: 3, 3
May 2 12:32:56 newerjersey sshd[4699]: debug3: Normalising mapped IPv4 in IPv6 address
May 2 12:32:56 newerjersey sshd[4699]: Connection from 10.16.0.186 port 1919
May 2 12:32:56 newerjersey sshd[4699]: debug1: Client protocol version 2.0; client software version PuTTY_Release_0.59
May 2 12:32:56 newerjersey sshd[4699]: debug1: no match: PuTTY_Release_0.59
May 2 12:32:56 newerjersey sshd[4699]: debug1: Enabling compatibility modefor protocol 2.0
May 2 12:32:56 newerjersey sshd[4699]: debug1: Local version string SSH-2.0-OpenSSH_4.3p2 Debian-9
May 2 12:32:56 newerjersey sshd[4699]: debug2: fd 3 setting O_NONBLOCK
May 2 12:32:56 newerjersey sshd[4699]: debug2: Network child is on pid 4700
May 2 12:32:56 newerjersey sshd[4699]: debug3: preauth child monitor started
May 2 12:32:56 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:32:56 newerjersey sshd[4699]: debug3: monitor_read: checking request 0
May 2 12:32:56 newerjersey sshd[4699]: debug3: mm_answer_moduli: got parameters: 1024 2048 8192
May 2 12:32:56 newerjersey sshd[4699]: debug3: mm_request_send entering: type 1
May 2 12:32:56 newerjersey sshd[4699]: debug2: monitor_read: 0 used once, disabling now
May 2 12:32:56 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:32:56 newerjersey sshd[4699]: debug3: monitor_read: checking request 5
May 2 12:32:56 newerjersey sshd[4699]: debug3: mm_answer_sign
May 2 12:32:57 newerjersey sshd[4699]: debug3: mm_answer_sign: signature 0x7ecd0(271)
May 2 12:32:57 newerjersey sshd[4699]: debug3: mm_request_send entering: type 6
May 2 12:32:57 newerjersey sshd[4699]: debug2: monitor_read: 5 used once, disabling now
May 2 12:32:57 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:32:59 newerjersey sshd[4699]: debug3: monitor_read: checking request 7
May 2 12:32:59 newerjersey sshd[4699]: debug3: mm_answer_pwnamallow
May 2 12:32:59 newerjersey sshd[4699]: debug3: mm_answer_pwnamallow: sending MONITOR_ANS_PWNAM: 1
May 2 12:32:59 newerjersey sshd[4699]: debug3: mm_request_send entering: type 8
May 2 12:32:59 newerjersey sshd[4699]: debug2: monitor_read: 7 used once, disabling now
May 2 12:32:59 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:32:59 newerjersey sshd[4699]: debug3: monitor_read: checking request 48
May 2 12:32:59 newerjersey sshd[4699]: debug1: PAM: initializingfor"root"
May 2 12:32:59 newerjersey sshd[4699]: debug3: Normalising mapped IPv4 in IPv6 address
May 2 12:32:59 newerjersey sshd[4699]: debug3: Trying to reverse map address 10.16.0.186.
May 2 12:33:04 newerjersey sshd[4699]: debug1: PAM: setting PAM_RHOST to"10.16.0.186"
May 2 12:33:04 newerjersey sshd[4699]: debug1: PAM: setting PAM_TTY to"ssh"
May 2 12:33:04 newerjersey sshd[4699]: debug2: monitor_read: 48 used once, disabling now
May 2 12:33:04 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:33:04 newerjersey sshd[4699]: debug3: monitor_read: checking request 3
May 2 12:33:04 newerjersey sshd[4699]: debug3: mm_answer_authserv: service=ssh-connection, style=, role=
May 2 12:33:04 newerjersey sshd[4699]: debug2: monitor_read: 3 used once, disabling now
May 2 12:33:04 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:33:04 newerjersey sshd[4699]: debug3: monitor_read: checking request 11
May 2 12:33:04 newerjersey sshd[4699]: debug3: mm_answer_authpassword: sending result 0
May 2 12:33:04 newerjersey sshd[4699]: debug3: mm_request_send entering: type 12
May 2 12:33:04 newerjersey sshd[4699]: debug3: Normalising mapped IPv4 in IPv6 address
May 2 12:33:04 newerjersey sshd[4699]: Failed nonefor root from 10.16.0.186 port 1919 ssh2
May 2 12:33:04 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:33:11 newerjersey sshd[4699]: debug3: monitor_read: checking request 11
May 2 12:33:11 newerjersey sshd[4699]: debug3: PAM: sshpam_passwd_conv called with 1 messages
May 2 12:33:11 newerjersey sshd[4699]: debug1: PAM: password authentication acceptedfor root
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_answer_authpassword: sending result 1
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_request_send entering: type 12
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_request_receive_expect entering: type 49
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:33:11 newerjersey sshd[4699]: debug1: do_pam_account: called
May 2 12:33:11 newerjersey sshd[4699]: debug3: PAM: do_pam_account pam_acct_mgmt = 0 (Success)
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_request_send entering: type 50
May 2 12:33:11 newerjersey sshd[4699]: Accepted passwordfor root from 10.16.0.186 port 1919 ssh2
May 2 12:33:11 newerjersey sshd[4699]: debug1: monitor_child_preauth: root has been authenticated by privileged process
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_get_keystate: Waitingfornew keys
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_request_receive_expect entering: type 25
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_request_receive entering
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_newkeys_from_blob: 0x7de30(139)
May 2 12:33:11 newerjersey sshd[4699]: debug2: mac_init: found hmac-sha1
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_get_keystate: Waitingfor second key
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_newkeys_from_blob: 0x7de30(139)
May 2 12:33:11 newerjersey sshd[4699]: debug2: mac_init: found hmac-sha1
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_get_keystate: Getting compression state
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_get_keystate: Getting Network I/O buffers
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_share_sync: Share sync
May 2 12:33:11 newerjersey sshd[4699]: debug3: mm_share_sync: Share sync end
May 2 12:33:11 newerjersey sshd[4699]: debug2: set_newkeys: mode 0
May 2 12:33:11 newerjersey sshd[4699]: debug2: cipher_init: set keylen (16 -> 32)
May 2 12:33:11 newerjersey sshd[4699]: debug2: set_newkeys: mode 1
May 2 12:33:11 newerjersey sshd[4699]: debug2: cipher_init: set keylen (16 -> 32)
May 2 12:33:11 newerjersey sshd[4699]: debug1: Entering interactive sessionfor SSH2.
May 2 12:33:11 newerjersey sshd[4699]: debug2: fd 4 setting O_NONBLOCK
May 2 12:33:11 newerjersey sshd[4699]: debug2: fd 5 setting O_NONBLOCK
May 2 12:33:12 newerjersey sshd[4699]: debug1: server_init_dispatch_20
May 2 12:33:12 newerjersey sshd[4699]: debug1: server_input_channel_open: ctype session rchan 256 win 16384 max 16384
May 2 12:33:12 newerjersey sshd[4699]: debug1: input_session_request
May 2 12:33:12 newerjersey sshd[4699]: debug1: channel 0:new [server-session]
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_new: init
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_new: session 0
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_open: channel 0
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_open: session 0: link with channel 0
May 2 12:33:12 newerjersey sshd[4699]: debug1: server_input_channel_open: confirm session
May 2 12:33:12 newerjersey sshd[4699]: debug1: server_input_channel_req: channel 0 request pty-req reply 1
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_by_channel: session 0 channel 0
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_input_channel_req: session 0 req pty-req
May 2 12:33:12 newerjersey sshd[4699]: debug1: Allocating pty.
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_pty_req: session 0 alloc /dev/pts/2
May 2 12:33:12 newerjersey sshd[4699]: debug3: tty_parse_modes: SSH2 n_bytes 16
May 2 12:33:12 newerjersey sshd[4699]: debug3: tty_parse_modes: 3 127
May 2 12:33:12 newerjersey sshd[4699]: debug3: tty_parse_modes: ispeed 38400
May 2 12:33:12 newerjersey sshd[4699]: debug3: tty_parse_modes: ospeed 38400
May 2 12:33:12 newerjersey sshd[4699]: debug1: server_input_channel_req: channel 0 request shell reply 1
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_by_channel: session 0 channel 0
May 2 12:33:12 newerjersey sshd[4699]: debug1: session_input_channel_req: session 0 req shell
May 2 12:33:12 newerjersey sshd[4699]: debug1: PAM: setting PAM_TTY to"/dev/pts/2"
May 2 12:33:12 newerjersey sshd[4699]: debug1: PAM: establishing credentials
May 2 12:33:12 newerjersey sshd[4701]: debug1: Setting controlling tty using TIOCSCTTY.
May 2 12:33:12 newerjersey sshd[4699]: debug2: fd 3 setting TCP_NODELAY
May 2 12:33:12 newerjersey sshd[4701]: debug3: PAM: opening session
May 2 12:33:12 newerjersey sshd[4699]: debug2: channel 0: rfd 7 isatty
May 2 12:33:12 newerjersey sshd[4701]: (pam_unix) session openedfor user root by root(uid=0)
May 2 12:33:12 newerjersey sshd[4699]: debug2: fd 7 setting O_NONBLOCK
May 2 12:33:12 newerjersey sshd[4701]: debug3: PAM: sshpam_store_conv called with 1 messages
May 2 12:33:12 newerjersey sshd[4699]: debug3: fd 6 is O_NONBLOCK
May 2 12:33:12 newerjersey sshd[4701]: debug1: PAM: reinitializing credentials
May 2 12:33:12 newerjersey sshd[4701]: debug1: permanently_set_uid: 0/0
May 2 12:33:13 newerjersey sshd[4701]: debug3: Normalising mapped IPv4 in IPv6 address
May 2 12:33:13 newerjersey sshd[4701]: debug3: Copy environment: LANG=en_US.UTF-8
May 2 12:33:13 newerjersey sshd[4701]: debug3: channel 0: close_fds r -1 w -1 e -1 c -1
May 2 12:33:31 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 8208
May 2 12:34:00 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9967
May 2 12:34:00 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9574
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9974
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9705
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 10017
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9811
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 8396
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9836
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9882
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 8304
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9450
May 2 12:34:01 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 8276
May 2 12:34:08 newerjersey sshd[4699]: debug1: server_input_channel_req: channel 0 request window-change reply 0
May 2 12:34:08 newerjersey sshd[4699]: debug1: session_by_channel: session 0 channel 0
May 2 12:34:08 newerjersey sshd[4699]: debug1: session_input_channel_req: session 0 req window-change
May 2 12:34:08 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9368
May 2 12:34:10 newerjersey sshd[4699]: debug1: server_input_channel_req: channel 0 request window-change reply 0
May 2 12:34:10 newerjersey sshd[4699]: debug1: session_by_channel: session 0 channel 0
May 2 12:34:10 newerjersey sshd[4699]: debug1: session_input_channel_req: session 0 req window-change
May 2 12:34:10 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 8746
May 2 12:34:15 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 10038
May 2 12:34:23 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 8203
May 2 12:34:31 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 8238
May 2 12:34:48 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9766
May 2 12:34:48 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9751
May 2 12:34:49 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9021
May 2 12:34:51 newerjersey sshd[4699]: debug2: channel 0: rcvd adjust 9638
