2006 / february / 05

Workaround for 'LCP ConfReq errors' in mac dialup networking

It seems that there is a nasty error in the PPP implementation that Mac OS X uses, as well as some other BSD-derived operating systems. There are some accounts on the web, but the info was hard to find when I was trying to fix it, so I'm posting it here for google and the greater good.

The problem

With broadband at home and wifi everywhere, I've never had to use the internal modem of my ibook until I was in Italy in december, and I had great trouble in getting it to work. It should have been so simple. There was an old machine running win95, with a working phone line and account. Plugging the phone line into my mac and using PPP with similar settings resulted in an audible modem handshake, but after that, it failed. The PPP error log (pasted in full below) had these lines which seemed to indicate the software PPP handshake was where it was going wrong:

sent [LCP ConfReq id=0x1    ]
LCP: timeout sending Config-Requests

The workaround

In the end, I found a workaround after much googling - there are many phrases in the error log that pop up in various packages, so it wasn't easy. A big hand to Lonesome Amoeba where I finally found a good description, and a workaround.

Fixed; sort of

In short: turn 'Connect using a terminal window' on. This leads to an empty dialog with a single 'ok' button when the modems have done their hardware handshake, but PPP is yet to begin. After clicking ok, the dialog disappears, and PPP succesfully connects. Weird, very un-maclike, but at least it gave me connectivity up there in the mountains.

(and here I am, typing this comfortably on broadband at home, and my providers monthly email has just come in - they've doubled the speed, again. 8Mb/2Mb now. Dialup is beginning to look really, really old.)

The full PPP error log

As promised, the log in full. First, two unsuccesfull tries.

Thu Dec 29 14:50:42 2005 : Version 2.0
Thu Dec 29 14:50:42 2005 : CCLWrite : AT\13
Thu Dec 29 14:50:42 2005 : CCLMatched : OK\13\10
Thu Dec 29 14:50:42 2005 : CCLWrite : ATI4\13
Thu Dec 29 14:50:42 2005 : CCLMatched : Apple Internal Modem\13\10
Thu Dec 29 14:50:42 2005 : CCLWrite : ATI12\13
Thu Dec 29 14:50:42 2005 : CCLMatched : D1\13\10
Thu Dec 29 14:50:42 2005 : CCLWrite : AT&F92L3E0S95=45&D2S7=75W2\13
Thu Dec 29 14:50:42 2005 : CCLMatched : OK\13\10
Thu Dec 29 14:50:42 2005 : Dialing 7020005017
Thu Dec 29 14:50:42 2005 : CCLWrite : ATDT7020005017\13
Thu Dec 29 14:51:12 2005 : CCLMatched : +ER:
Thu Dec 29 14:51:12 2005 : CCLMatched : LAPM
Thu Dec 29 14:51:12 2005 : Modem Reliable Link Established.
Thu Dec 29 14:51:12 2005 : CCLMatched : +DR:
Thu Dec 29 14:51:12 2005 : CCLMatched : V42B\13
Thu Dec 29 14:51:12 2005 : Modem Compression Established.
Thu Dec 29 14:51:12 2005 : CCLMatched : CONNECT 
Thu Dec 29 14:51:12 2005 : CCLMatched : 48000
Thu Dec 29 14:51:15 2005 : Serial connection established.
Thu Dec 29 14:51:15 2005 : using link 0
Thu Dec 29 14:51:15 2005 : Using interface ppp0
Thu Dec 29 14:51:15 2005 : Connect: ppp0 <--> /dev/cu.modem
Thu Dec 29 14:51:16 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:19 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:22 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:25 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:28 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:31 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:34 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:37 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:40 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:43 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 14:51:46 2005 : LCP: timeout sending Config-Requests
Thu Dec 29 14:51:46 2005 : Connection terminated.
Thu Dec 29 14:51:46 2005 : CCLWrite : +++
Thu Dec 29 14:51:50 2005 : CCLWrite : ATH\13
Thu Dec 29 14:51:53 2005 : CCLWrite : +++
Thu Dec 29 14:51:56 2005 : CCLWrite : ATH\13
Thu Dec 29 14:51:59 2005 : CCLWrite : +++
Thu Dec 29 14:52:02 2005 : CCLWrite : ATH\13
Thu Dec 29 14:52:06 2005 : CCLWrite : AT&F\13
Thu Dec 29 14:52:07 2005 : disconnect script failed
Thu Dec 29 16:32:33 2005 : Version 2.0
Thu Dec 29 16:32:33 2005 : CCLWrite : AT\13
Thu Dec 29 16:32:33 2005 : CCLMatched : OK\13\10
Thu Dec 29 16:32:33 2005 : CCLWrite : ATI4\13
Thu Dec 29 16:32:33 2005 : CCLMatched : Apple Internal Modem\13\10
Thu Dec 29 16:32:34 2005 : CCLWrite : ATI12\13
Thu Dec 29 16:32:34 2005 : CCLMatched : D1\13\10
Thu Dec 29 16:32:34 2005 : CCLWrite : AT&F92L3E0S95=45&D2S7=75W2\13
Thu Dec 29 16:32:34 2005 : CCLMatched : OK\13\10
Thu Dec 29 16:32:34 2005 : Dialing 7020005017
Thu Dec 29 16:32:34 2005 : CCLWrite : ATDT7020005017\13
Thu Dec 29 16:33:03 2005 : CCLMatched : +ER:
Thu Dec 29 16:33:03 2005 : CCLMatched : LAPM
Thu Dec 29 16:33:03 2005 : Modem Reliable Link Established.
Thu Dec 29 16:33:03 2005 : CCLMatched : +DR:
Thu Dec 29 16:33:03 2005 : CCLMatched : V42B\13
Thu Dec 29 16:33:03 2005 : Modem Compression Established.
Thu Dec 29 16:33:03 2005 : CCLMatched : CONNECT 
Thu Dec 29 16:33:03 2005 : CCLMatched : 48000
Thu Dec 29 16:33:06 2005 : Serial connection established.
Thu Dec 29 16:33:06 2005 : using link 0
Thu Dec 29 16:33:06 2005 : Using interface ppp0
Thu Dec 29 16:33:06 2005 : Connect: ppp0 <--> /dev/cu.modem
Thu Dec 29 16:33:07 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:10 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:13 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:16 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:19 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:22 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:25 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:28 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:33:30 2005 : Hangup (SIGHUP)
Thu Dec 29 16:33:30 2005 : Modem hangup
Thu Dec 29 16:33:30 2005 : Connection terminated.
Thu Dec 29 16:33:43 2005 : Terminating on signal 15.

Finally, the log with the connect dialog fix.

Thu Dec 29 16:33:56 2005 : Version 2.0
Thu Dec 29 16:33:56 2005 : CCLWrite : AT\13
Thu Dec 29 16:33:56 2005 : CCLMatched : OK\13\10
Thu Dec 29 16:33:56 2005 : CCLWrite : ATI4\13
Thu Dec 29 16:33:56 2005 : CCLMatched : Apple Internal Modem\13\10
Thu Dec 29 16:33:56 2005 : CCLWrite : ATI12\13
Thu Dec 29 16:33:56 2005 : CCLMatched : D1\13\10
Thu Dec 29 16:33:56 2005 : CCLWrite : AT&F92L3E0S95=45&D2S7=75W2\13
Thu Dec 29 16:33:57 2005 : CCLMatched : OK\13\10
Thu Dec 29 16:33:57 2005 : Dialing 7020005017
Thu Dec 29 16:33:57 2005 : CCLWrite : ATDT7020005017\13
Thu Dec 29 16:34:26 2005 : CCLMatched : +ER:
Thu Dec 29 16:34:26 2005 : CCLMatched : LAPM
Thu Dec 29 16:34:26 2005 : Modem Reliable Link Established.
Thu Dec 29 16:34:26 2005 : CCLMatched : +DR:
Thu Dec 29 16:34:26 2005 : CCLMatched : V42B\13
Thu Dec 29 16:34:26 2005 : Modem Compression Established.
Thu Dec 29 16:34:26 2005 : CCLMatched : CONNECT 
Thu Dec 29 16:34:26 2005 : CCLMatched : 48000
Thu Dec 29 16:34:29 2005 : Serial connection established.
Thu Dec 29 16:34:44 2005 : Terminal connection established.
Thu Dec 29 16:34:44 2005 : using link 0
Thu Dec 29 16:34:44 2005 : Using interface ppp0
Thu Dec 29 16:34:44 2005 : Connect: ppp0 <--> /dev/cu.modem
Thu Dec 29 16:34:46 2005 : sent [LCP ConfReq id=0x1    ]
Thu Dec 29 16:34:46 2005 : rcvd [LCP ConfReq id=0xd     ]
Thu Dec 29 16:34:46 2005 : lcp_reqci: returning CONFACK.
Thu Dec 29 16:34:46 2005 : sent [LCP ConfAck id=0xd     ]
Thu Dec 29 16:34:46 2005 : rcvd [LCP ConfAck id=0x1    ]
Thu Dec 29 16:34:46 2005 : sent [LCP EchoReq id=0x0 magic=0x649e03c6]
Thu Dec 29 16:34:46 2005 : sent [PAP AuthReq id=0x1 user="xxx@xxx.net" password=]
Thu Dec 29 16:34:46 2005 : rcvd [LCP EchoRep id=0x0 magic=0xb9a481af]
Thu Dec 29 16:34:46 2005 : rcvd [PAP AuthAck id=0x1 ""]
Thu Dec 29 16:34:46 2005 : sent [IPCP ConfReq id=0x1    ]
Thu Dec 29 16:34:46 2005 : sent [IPV6CP ConfReq id=0x1 ]
Thu Dec 29 16:34:46 2005 : rcvd [IPCP ConfReq id=0x1 ]
Thu Dec 29 16:34:46 2005 : ipcp: returning Configure-ACK
Thu Dec 29 16:34:46 2005 : sent [IPCP ConfAck id=0x1 ]
Thu Dec 29 16:34:46 2005 : rcvd [IPCP ConfRej id=0x1 ]
Thu Dec 29 16:34:46 2005 : sent [IPCP ConfReq id=0x2   ]
Thu Dec 29 16:34:46 2005 : rcvd [LCP ProtRej id=0x1 80 57 01 01 00 0e 01 0a 02 0a 95 ff fe ab fe c8]
Thu Dec 29 16:34:46 2005 : rcvd [IPCP ConfNak id=0x2   ]
Thu Dec 29 16:34:46 2005 : sent [IPCP ConfReq id=0x3   ]
Thu Dec 29 16:34:47 2005 : rcvd [IPCP ConfAck id=0x3   ]
Thu Dec 29 16:34:47 2005 : ipcp: up
Thu Dec 29 16:34:47 2005 : local  IP address 62.94.66.205
Thu Dec 29 16:34:47 2005 : remote IP address 62.94.66.1
Thu Dec 29 16:34:47 2005 : primary   DNS address 62.94.0.1
Thu Dec 29 16:34:47 2005 : secondary DNS address 62.94.0.2
Thu Dec 29 16:35:12 2005 : Terminating on signal 15.
Thu Dec 29 16:35:12 2005 : ipcp: down
Thu Dec 29 16:35:13 2005 : sent [LCP TermReq id=0x2 "User request"]
Thu Dec 29 16:35:13 2005 : rcvd [LCP TermAck id=0x2]
Thu Dec 29 16:35:13 2005 : Connection terminated.
Thu Dec 29 16:35:13 2005 : Connect time 0.5 minutes.
Thu Dec 29 16:35:13 2005 : Sent 2523 bytes, received 16669 bytes.
Thu Dec 29 16:35:14 2005 : CCLWrite : +++
Thu Dec 29 16:35:15 2005 : CCLMatched : OK\13\10
Thu Dec 29 16:35:15 2005 : CCLWrite : ATH\13
Thu Dec 29 16:35:17 2005 : CCLMatched : NO CARRIER\13\10
Thu Dec 29 16:35:18 2005 : CCLWrite : AT&F\13
Thu Dec 29 16:35:18 2005 : CCLMatched : OK\13\10
Thu Dec 29 16:35:18 2005 : Serial link disconnected.

Reflections on 'My life in Orange' by Tim Guest | main | Amnesty International: breng wapens onder controle!

me

categories

archive

popular

links & reads

contact

drie_SPAM_k@xs4all.nl

miscellaneous