From owner-freebsd-current@FreeBSD.ORG Wed Nov 26 07:41:38 2008 Return-Path: Delivered-To: freebsd-current@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 730411065672 for ; Wed, 26 Nov 2008 07:41:38 +0000 (UTC) (envelope-from vova@sw.ru) Received: from relay.sw.ru (mailhub.sw.ru [195.214.232.25]) by mx1.freebsd.org (Postfix) with ESMTP id B36E08FC13 for ; Wed, 26 Nov 2008 07:41:37 +0000 (UTC) (envelope-from vova@sw.ru) Received: from vbook.fbsd.ru ([10.30.1.111]) (authenticated bits=0) by relay.sw.ru (8.13.4/8.13.4) with ESMTP id mAQ7fXLO029180 (version=TLSv1/SSLv3 cipher=DHE-RSA-AES256-SHA bits=256 verify=NO); Wed, 26 Nov 2008 10:41:34 +0300 (MSK) Received: from vova by vbook.fbsd.ru with local (Exim 4.69 (FreeBSD)) (envelope-from ) id 1L5F1h-0000hb-71; Wed, 26 Nov 2008 10:41:33 +0300 From: Vladimir Grebenschikov To: Nick Hibma In-Reply-To: <200811251545.10807.nick@van-laarhoven.org> References: <492A62EF.7000803@bsdforen.de> <1227608329.1731.70.camel@localhost> <200811251545.10807.nick@van-laarhoven.org> Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Date: Wed, 26 Nov 2008 10:41:32 +0300 Message-Id: <1227685292.1852.12.camel@localhost> Mime-Version: 1.0 X-Mailer: Evolution 2.22.3.1 FreeBSD GNOME Team Port Sender: Vladimir Grebenschikov Cc: freebsd-current@freebsd.org Subject: Re: u3g and ubsa X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Discussions about the use of FreeBSD-current List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Wed, 26 Nov 2008 07:41:38 -0000 On Tue, 2008-11-25 at 15:45 +0100, Nick Hibma wrote:=20 > Please send me as much info as you can: >=20 > ppp.conf > output of dmesg > things you tried, etc. Part of verbose dmesg on card insertion: pcib6: requested memory range 0x88000000-0xffffffff: good found-> vendor=3D0x1033, dev=3D0x0035, revid=3D0x43 domain=3D0, bus=3D22, slot=3D0, func=3D0 class=3D0c-03-10, hdrtype=3D0x00, mfdev=3D1 cmdreg=3D0x0000, statreg=3D0x0210, cachelnsz=3D0 (dwords) lattimer=3D0x08 (240 ns), mingnt=3D0x01 (250 ns), maxlat=3D0x2a (10= 500 ns) intpin=3Da, irq=3D16 powerspec 2 supports D0 D1 D2 D3 current D0 ohci0: mem 0x88000000-0x88000fff irq 16 at de= vice 0.0 on cardbus0 ohci0: Reserved 0x1000 bytes for rid 0x10 type 3 at 0x88000000 cbb0: Opening memory: cbb0: Normal: 0x88000000-0x88000fff ohci0: [GIANT-LOCKED] ohci0: [ITHREAD] usb5: OHCI version 1.0 usb5: on ohci0 usb5: USB revision 1.0 uhub6: on usb5 uhub6: 1 port with 1 removable, self powered map[10]: type Memory, range 32, base 0, size 12, memory disabled pcib6: requested memory range 0x88000000-0xffffffff: good found-> vendor=3D0x1033, dev=3D0x0035, revid=3D0x43 domain=3D0, bus=3D22, slot=3D0, func=3D1 class=3D0c-03-10, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0000, statreg=3D0x0210, cachelnsz=3D0 (dwords) lattimer=3D0x08 (240 ns), mingnt=3D0x01 (250 ns), maxlat=3D0x2a (10= 500 ns) intpin=3Db, irq=3D16 powerspec 2 supports D0 D1 D2 D3 current D0 ohci1: mem 0x88001000-0x88001fff irq 16 at de= vice 0.1 on cardbus0 ohci1: Reserved 0x1000 bytes for rid 0x10 type 3 at 0x88001000 cbb0: Opening memory: cbb0: Normal: 0x88000000-0x88001fff ohci1: [GIANT-LOCKED] ohci1: [ITHREAD] usb6: OHCI version 1.0 usb6: on ohci1 usb6: USB revision 1.0 uhub7: on usb6 uhub7: 1 port with 1 removable, self powered ucom0: on uhub6 ucom0: configured 3 serial ports (U0.%d) cu session on U0.0 port: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D Script started on Wed Nov 26 09:07:09 2008 # cu -s 460800 -l /dev/cuaU0.0 Connected t=04 OK t a Manufacturer: +GMI: HUAWEI TECHNOLOGIES CO., LTD Model: 153 Revision: +GMR: 010.11.05.116sp12D13 ESN: +GSN:a6413fcc +GCAP: +CIS707-A, CIS-856, +MS, +ES, +DS, +FCLASS OK t v &C: 2; &D: 2; &F: 0; E: 1; L: 0; M: 0; Q: 0; V: 1; X: 0; Z: 0; S0: 0; S3: 13; S4: 10; S5: 8; S6: 2; S7: 50; S8: 2; S9: 6; S10: 14; S11: 95; +FCLASS: 0; +ICF: 3,3; +IFC: 2,2; +IPR: 115200; +DR: 0; +DS: 0,0,2048,6; +CDR: 0; +CDS: 0,1,2048,6; +CFC: 0; +CFG: ""; +CMUX: C,2; +CQD: 10; +CRC: 0; +CRM: 0; +CTA: 0; +CXT: 0; +EB: 1,0,30; +EFCS: 1; +ER: 0; +ES: 3,0,2; +ESR: 1; +ETBM: 1,1,20; +ILRR: 0; +MA: ; +MR: 0; +MS: ; +MV18R: 0; +MV18S: 0,0,0; +CLVL: 2; +CMUT: 0; +CPBS: "SM"; +FAA: 0; +FAP: 0,0,0; +FBO: 0; +FBU: 0; +FCQ: 1,0; +FCC: 0,1,0,0,0,0,0,0; +FCR: 0; +FCT: 1E; +FEA: 0; +FFC: 0,0,0,0; +FHS: 0; +FIE: 0; +FIP: 0; +FIS: 0,1,0,0,0,0,0,0; +FLI: ""~ [EOT] # ^D =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D I've typed right things, like 'AT', 'ATI', 'AT&V' But you can see what was returned by modem - only part of message ('t','v' letters and random CRs) and some binary trash. But data, returned by modem looks valid. Similar things happens on other line speeds, like 115200. Now, let's try U0.2: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D # cu -s 460800 -l /dev/cuaU0.2 Connected t=20 OK :t i NO CARRIER Pt a Manufacturer: +GMI: HUAWEI TECHNOLOGIES CO., LTD Model: 153 Revision: +GMR: 010.11.05.116sp12D13 ESN: +GSN:a6413fcc +GCAP: +CIS707-A, CIS-856, +MS, +ES, +DS, +FCLASS OK M ~ [EOT] =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D Same problem, but looks like modem still returns valid responses. Now with PPP: ppp.conf:=20 =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D default: set log Phase Chat LCP IPCP CCP tun command ident user-ppp VERSION (built COMPILATIONDATE) set device /dev/cuau1 set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \ \"\" AT OK-AT-OK ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT" set timeout 0 # 3 minute idle timer (the default) ... skylink: set log Phase Chat LCP IPCP CCP tun command disable pred1 deflate deflate24 protocomp acfcomp shortseq vj deny pred1 deflate deflate24 protocomp acfcomp shortseq vj set speed 460800 enable dns=20 enable lqr set timeout 0 set lqrperiod 10 set device /dev/ttyU0.0 set phone \#777 set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 15 \"\" AT OK-AT-OK ATE1Q0= OK \\dATDT\\T TIMEOUT 40 CONNECT" set authname mobile set authkey internet add default HISADDR=20 =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D This try even chat does not finishes:=20 Nov 26 10:21:47 vbook ppp[33873]: tun0: Phase: PPP Started (interactive mod= e). Nov 26 10:22:23 vbook ppp[33873]: tun0: Command: /dev/pts/2: open Nov 26 10:22:23 vbook ppp[33873]: tun0: Phase: bundle: Establish Nov 26 10:22:23 vbook ppp[33873]: tun0: Phase: deflink: closed -> opening Nov 26 10:22:23 vbook ppp[33873]: tun0: Phase: deflink: Connected! Nov 26 10:22:23 vbook ppp[33873]: tun0: Phase: deflink: opening -> dial Nov 26 10:22:23 vbook ppp[33873]: tun0: Chat: Phone: #777 Nov 26 10:22:23 vbook ppp[33873]: tun0: Chat: deflink: Dial attempt 1 of 1 Nov 26 10:22:23 vbook ppp[33873]: tun0: Chat: Send: AT^M Nov 26 10:22:23 vbook ppp[33873]: tun0: Chat: Expect(15): OK Nov 26 10:22:38 vbook ppp[33873]: tun0: Chat: Expect timeout Nov 26 10:22:38 vbook ppp[33873]: tun0: Chat: Send: AT^M Nov 26 10:22:38 vbook ppp[33873]: tun0: Chat: Expect(15): OK Nov 26 10:22:53 vbook ppp[33873]: tun0: Chat: Expect timeout Nov 26 10:22:53 vbook ppp[33873]: tun0: Warning: Chat script failed Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: deflink: dial -> hangup Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: deflink: Disconnected! Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: deflink: Connect time: 30 se= cs: 0 octets in, 0 octets out Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: deflink: 0 packets in, 0 pac= kets out Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: total 0 bytes/sec, peak 0 b= ytes/sec on Wed Nov 26 10:22:23 2008 Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: deflink: hangup -> closed Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: bundle: Dead Previous time when I tried, it pass chat stage, but fails in PPP: see http://lists.freebsd.org/pipermail/freebsd-current/2008-November/000080.htm= l dmesg has: Nov 26 10:25:49 vbook kernel: ucom0: invalid receive data size, -754491385 chars Nov 26 10:25:49 vbook kernel: ucom0: invalid receive data size, -754491390 chars Nov 26 10:25:51 vbook kernel: ucom0: invalid receive data size, -754491385 chars Nov 26 10:25:52 vbook kernel: ucom0: invalid receive data size, -754491390 chars Nov 26 10:25:56 vbook kernel: ucom0: invalid receive data size, 626606082 chars Nov 26 10:25:59 vbook kernel: ucom0: invalid receive data size, 466214914 chars Nov 26 10:26:00 vbook kernel: ucom0: invalid receive data size, 466214919 chars Nov 26 10:26:01 vbook kernel: ucom0: invalid receive data size, 466214914 chars After reboot it starts to connect again: Nov 26 10:31:49 vbook ppp[1990]: tun0: Phase: PPP Started (background mode)= . Nov 26 10:31:49 vbook ppp[1990]: tun0: Phase: bundle: Establish Nov 26 10:31:49 vbook ppp[1990]: tun0: Phase: deflink: closed -> opening Nov 26 10:31:49 vbook ppp[1990]: tun0: Phase: deflink: Connected! Nov 26 10:31:49 vbook ppp[1990]: tun0: Phase: deflink: opening -> dial Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Phone: #777 Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: deflink: Dial attempt 1 of 1 Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Send: AT^M Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Expect(15): OK Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Received: ^M Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Received: OK^M Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Send: ATE1Q0^M Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Expect(15): OK Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Received:=20 Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Received: OK^M Nov 26 10:31:49 vbook ppp[1990]: tun0: Chat: Send: ATDT#777^M Nov 26 10:31:51 vbook ppp[1990]: tun0: Chat: Expect(40): CONNECT Nov 26 10:31:52 vbook ppp[1990]: tun0: Chat: Received: ^M Nov 26 10:31:52 vbook ppp[1990]: tun0: Chat: Received: CONNECT^M Nov 26 10:31:52 vbook ppp[1990]: tun0: Phase: deflink: dial -> carrier Nov 26 10:31:53 vbook ppp[1990]: tun0: Phase: deflink: /dev/ttyU0.0 doesn't= support CD Nov 26 10:31:53 vbook ppp[1990]: tun0: Phase: deflink: carrier -> login Nov 26 10:31:53 vbook ppp[1990]: tun0: Phase: deflink: login -> lcp Nov 26 10:31:53 vbook ppp[1990]: tun0: LCP: FSM: Using "deflink" as a trans= port Nov 26 10:31:53 vbook ppp[1990]: tun0: LCP: deflink: State change Initial -= -> Closed Nov 26 10:31:53 vbook ppp[1990]: tun0: LCP: deflink: State change Closed --= > Stopped Nov 26 10:31:54 vbook ppp[1990]: tun0: LCP: deflink: LayerStart Nov 26 10:31:54 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state= =3D Stopped Nov 26 10:31:54 vbook ppp[1990]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:31:54 vbook ppp[1990]: tun0: LCP: MRU[4] 1500 Nov 26 10:31:54 vbook ppp[1990]: tun0: LCP: MAGICNUM[6] 0xfdcb5eb5 Nov 26 10:31:54 vbook ppp[1990]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:31:54 vbook ppp[1990]: tun0: LCP: deflink: State change Stopped -= -> Req-Sent Nov 26 10:31:57 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state= =3D Req-Sent Nov 26 10:31:57 vbook ppp[1990]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:31:57 vbook ppp[1990]: tun0: LCP: MRU[4] 1500 Nov 26 10:31:57 vbook ppp[1990]: tun0: LCP: MAGICNUM[6] 0xfdcb5eb5 Nov 26 10:31:57 vbook ppp[1990]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:32:00 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state= =3D Req-Sent Nov 26 10:32:00 vbook ppp[1990]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:32:00 vbook ppp[1990]: tun0: LCP: MRU[4] 1500 Nov 26 10:32:00 vbook ppp[1990]: tun0: LCP: MAGICNUM[6] 0xfdcb5eb5 Nov 26 10:32:00 vbook ppp[1990]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:32:03 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state= =3D Req-Sent Nov 26 10:32:03 vbook ppp[1990]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:32:03 vbook ppp[1990]: tun0: LCP: MRU[4] 1500 Nov 26 10:32:03 vbook ppp[1990]: tun0: LCP: MAGICNUM[6] 0xfdcb5eb5 Nov 26 10:32:03 vbook ppp[1990]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:32:06 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state= =3D Req-Sent Nov 26 10:32:06 vbook ppp[1990]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:32:06 vbook ppp[1990]: tun0: LCP: MRU[4] 1500 Nov 26 10:32:06 vbook ppp[1990]: tun0: LCP: MAGICNUM[6] 0xfdcb5eb5 Nov 26 10:32:06 vbook ppp[1990]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:32:09 vbook ppp[1990]: tun0: LCP: deflink: LayerFinish Nov 26 10:32:09 vbook ppp[1990]: tun0: LCP: deflink: State change Req-Sent = --> Stopped Nov 26 10:32:09 vbook ppp[1990]: tun0: LCP: deflink: State change Stopped -= -> Closed Nov 26 10:32:09 vbook ppp[1990]: tun0: LCP: deflink: State change Closed --= > Initial Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: Disconnected! Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: lcp -> logout Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: logout -> hangup Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: Disconnected! Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: Connect time: 20 sec= s: 0 octets in, 290 octets out Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: 0 packets in, 5 pack= ets out Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: total 14 bytes/sec, peak 23 = bytes/sec on Wed Nov 26 10:31:57 2008 Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: hangup -> closed Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: bundle: Dead Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: PPP Terminated (normal). Nov 26 10:32:09 vbook ppp[1990]: tun0: Chat: Parent notified of failure Nov 26 10:32:09 vbook ppp[1976]: tun0: Phase: Parent: Child failed (errdead= ) another try: Nov 26 10:35:13 vbook ppp[2233]: tun0: Phase: deflink: Connected! Nov 26 10:35:13 vbook ppp[2233]: tun0: Phase: deflink: opening -> dial Nov 26 10:35:13 vbook ppp[2233]: tun0: Chat: deflink: Dial attempt 1 of 10 Nov 26 10:35:13 vbook ppp[2233]: tun0: Phase: deflink: dial -> carrier Nov 26 10:35:14 vbook ppp[2233]: tun0: Phase: deflink: /dev/ttyU0.0 doesn't= support CD Nov 26 10:35:14 vbook ppp[2233]: tun0: Phase: deflink: carrier -> login Nov 26 10:35:14 vbook ppp[2233]: tun0: Phase: deflink: login -> lcp Nov 26 10:35:14 vbook ppp[2233]: tun0: LCP: FSM: Using "deflink" as a trans= port Nov 26 10:35:14 vbook ppp[2233]: tun0: LCP: deflink: State change Initial -= -> Closed Nov 26 10:35:14 vbook ppp[2233]: tun0: LCP: deflink: State change Closed --= > Stopped Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: deflink: LayerStart Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: deflink: SendConfigReq(2) state= =3D Stopped Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: ACFCOMP[2] Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: PROTOCOMP[2] Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: MRU[4] 1500 Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0xb2197a9e Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:35:15 vbook ppp[2233]: tun0: LCP: deflink: State change Stopped -= -> Req-Sent Nov 26 10:35:18 vbook ppp[2233]: tun0: LCP: deflink: SendConfigReq(2) state= =3D Req-Sent Nov 26 10:35:18 vbook ppp[2233]: tun0: LCP: ACFCOMP[2] Nov 26 10:35:18 vbook ppp[2233]: tun0: LCP: PROTOCOMP[2] Nov 26 10:35:18 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:18 vbook ppp[2233]: tun0: LCP: MRU[4] 1500 Nov 26 10:35:18 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0xb2197a9e Nov 26 10:35:18 vbook ppp[2233]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: deflink: RecvConfigReq(2) state= =3D Req-Sent Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05= ) Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0x9cc2570f Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: deflink: SendConfigAck(2) state= =3D Req-Sent Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05= ) Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0x9cc2570f Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: deflink: State change Req-Sent = --> Ack-Sent Nov 26 10:35:19 vbook ppp[2233]: tun0: Phase: Chap Input: CHALLENGE (16 byt= es from pdsn-m22-7cm4) Nov 26 10:35:19 vbook ppp[2233]: tun0: Phase: Chap Output: RESPONSE (mobile= ) Nov 26 10:35:19 vbook ppp[2233]: tun0: Phase: Chap Input: SUCCESS Nov 26 10:35:19 vbook ppp[2233]: tun0: IPCP: deflink: Error: Unexpected IPC= P in phase Authenticate (ignored) Nov 26 10:35:19 vbook ppp[2233]: tun0: CCP: deflink: Error: Unexpected CCP = in phase Authenticate (ignored) Nov 26 10:35:21 vbook ppp[2233]: tun0: LCP: deflink: SendConfigReq(2) state= =3D Ack-Sent Nov 26 10:35:21 vbook ppp[2233]: tun0: LCP: ACFCOMP[2] Nov 26 10:35:21 vbook ppp[2233]: tun0: LCP: PROTOCOMP[2] Nov 26 10:35:21 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:21 vbook ppp[2233]: tun0: LCP: MRU[4] 1500 Nov 26 10:35:21 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0xb2197a9e Nov 26 10:35:21 vbook ppp[2233]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: deflink: RecvConfigReq(1) state= =3D Ack-Sent Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05= ) Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0x9cc26e75 Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: deflink: SendConfigAck(1) state= =3D Ack-Sent Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05= ) Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0x9cc26e75 Nov 26 10:35:24 vbook ppp[2233]: tun0: LCP: deflink: SendConfigReq(2) state= =3D Ack-Sent Nov 26 10:35:24 vbook ppp[2233]: tun0: LCP: ACFCOMP[2] Nov 26 10:35:24 vbook ppp[2233]: tun0: LCP: PROTOCOMP[2] Nov 26 10:35:24 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:24 vbook ppp[2233]: tun0: LCP: MRU[4] 1500 Nov 26 10:35:24 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0xb2197a9e Nov 26 10:35:24 vbook ppp[2233]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: deflink: SendConfigReq(2) state= =3D Ack-Sent Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: ACFCOMP[2] Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: PROTOCOMP[2] Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: MRU[4] 1500 Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0xb2197a9e Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: QUALPROTO[8] proto c025, inter= val 10000ms Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: deflink: RecvConfigReq(1) state= =3D Ack-Sent Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05= ) Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0x9cc285da Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: deflink: SendConfigAck(1) state= =3D Ack-Sent Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: ACCMAP[6] 0x00000000 Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05= ) Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: MAGICNUM[6] 0x9cc285da Nov 26 10:35:29 vbook ppp[2233]: tun0: Phase: Chap Input: CHALLENGE (16 byt= es from pdsn-m22-7cm4) Nov 26 10:35:29 vbook ppp[2233]: tun0: Phase: Chap Output: RESPONSE (mobile= ) Nov 26 10:35:30 vbook ppp[2233]: tun0: LCP: deflink: LayerFinish Nov 26 10:35:30 vbook ppp[2233]: tun0: LCP: deflink: State change Ack-Sent = --> Stopped Nov 26 10:35:30 vbook ppp[2233]: tun0: LCP: deflink: State change Stopped -= -> Closed This time with another ppp.conf entry - without initial chat, modem does not reset connection on hangup and did not handle escape sequences, so you can't reset/disconnect modem in any other way but reboot. (if I disconnect pccard from notebook USB stack crashes kernel, old problem) While I've tried to connect with ppp, on U0.2 following trash was reported: # cu -l /dev/cuaU0.2 Connected t OK ^RSSILVL: 60 T=01=01=EF=BF=BDc=EF=BF=BD`=03=EF=BF=BDI=18=EF=BF=BD=EF=BF=BD No any dmesg messages this time. Same ppp configuration worked before patches with ubsa driver. > I've got a Huawei E220 and any other Huawei card seems to have the same=20 > symptoms. >=20 > Make sure you have the latest and greatest version of u3g.c from current. sure $ cvs -R status dev/usb/u3g.c =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D File: u3g.c Status: Up-to-date Working revision: 1.20 Tue Nov 25 13:19:37 2008 Repository revision: 1.20 /usr/ncvs/src/sys/dev/usb/u3g.c,v > One thing you could try is to reduce the MTU in your ppp configuration. Looks like there is a problem with data delivery on serial link. Any hints will be very appreciated.=20 What I can trace/log/debug ? > Nick >=20 >=20 > > On Mon, 2008-11-24 at 09:16 +0100, Dominic Fandrey wrote: > > > I have recently been pointed to the u3g driver and gave it a try, > > > because UBSA works very unreliable for me. > > > > > > - In combination with PF-NAT I get kernel panics under high load. > > > - I have to hack some buffer sizes in the driver to get the full > > > 3G speed. > > > - Often my USB-3G stick is not detected, sometimes I spent several > > > minutes plugging it in and out until it is detected. > > > - It doesn't let me use the card reader in the stick. > > > > > > The u3g driver has NONE of these problems. Everything just works > > > for me. > > > > > > So obviously I would like to have u3g in base and chose for > > > myself or even take support for devices out of ubsa that work > > > better with u3g. > > > > Unfortunately I am no so lucky. > > > > After moving to u3g I have no more any Internet mobile connection, my > > Huawei EC500 card is detected, but PPP failed on pahase of handshake, > > second port (U0.2) have usual messages with some binaries between text. > > Looks like something wrong with data delivery between card and port. >=20 >=20 > _______________________________________________ > freebsd-current@freebsd.org mailing list > http://lists.freebsd.org/mailman/listinfo/freebsd-current > To unsubscribe, send any mail to "freebsd-current-unsubscribe@freebsd.org= " --=20 Vladimir B. Grebenschikov vova@fbsd.ru