Re: u3g and ubsa

From: Vladimir Grebenschikov <vova_at_fbsd.ru>
Date: Wed, 26 Nov 2008 10:41:32 +0300
On Tue, 2008-11-25 at 15:45 +0100, Nick Hibma wrote: 
> Please send me as much info as you can:
> 
> 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=0x1033, dev=0x0035, revid=0x43
        domain=0, bus=22, slot=0, func=0
        class=0c-03-10, hdrtype=0x00, mfdev=1
        cmdreg=0x0000, statreg=0x0210, cachelnsz=0 (dwords)
        lattimer=0x08 (240 ns), mingnt=0x01 (250 ns), maxlat=0x2a (10500 ns)
        intpin=a, irq=16
        powerspec 2  supports D0 D1 D2 D3  current D0
ohci0: <NEC uPD 9210 USB controller> mem 0x88000000-0x88000fff irq 16 at device 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: <NEC uPD 9210 USB controller> on ohci0
usb5: USB revision 1.0
uhub6: <NEC OHCI root hub, class 9/0, rev 1.00/1.00, addr 1> 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=0x1033, dev=0x0035, revid=0x43
        domain=0, bus=22, slot=0, func=1
        class=0c-03-10, hdrtype=0x00, mfdev=0
        cmdreg=0x0000, statreg=0x0210, cachelnsz=0 (dwords)
        lattimer=0x08 (240 ns), mingnt=0x01 (250 ns), maxlat=0x2a (10500 ns)
        intpin=b, irq=16
        powerspec 2  supports D0 D1 D2 D3  current D0
ohci1: <NEC uPD 9210 USB controller> mem 0x88001000-0x88001fff irq 16 at device 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: <NEC uPD 9210 USB controller> on ohci1
usb6: USB revision 1.0
uhub7: <NEC OHCI root hub, class 9/0, rev 1.00/1.00, addr 1> on usb6
uhub7: 1 port with 1 removable, self powered
ucom0: <Huawei Technologies Huawei Mobile, class 0/0, rev 1.10/0.00, addr 2> on uhub6
ucom0: configured 3 serial ports (U0.%d)

cu session on U0.0 port:
============================================
Script started on Wed Nov 26 09:07:09 2008
# cu -s 460800 -l /dev/cuaU0.0
Connected
t
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
============================================

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:
============================================
# cu -s 460800 -l /dev/cuaU0.2
Connected
t 
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]
============================================
Same problem, but looks like modem still returns valid responses.


Now with PPP:
ppp.conf: 
=====================================
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 
 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 
=====================================

This try even chat does not finishes: 

Nov 26 10:21:47 vbook ppp[33873]: tun0: Phase: PPP Started (interactive mode).
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 secs: 0 octets in, 0 octets out
Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase: deflink: 0 packets in, 0 packets out
Nov 26 10:22:53 vbook ppp[33873]: tun0: Phase:  total 0 bytes/sec, peak 0 bytes/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.html

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: 
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 transport
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 = 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, interval 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 = 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, interval 10000ms
Nov 26 10:32:00 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state = 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, interval 10000ms
Nov 26 10:32:03 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state = 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, interval 10000ms
Nov 26 10:32:06 vbook ppp[1990]: tun0: LCP: deflink: SendConfigReq(1) state = 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, interval 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 secs: 0 octets in, 290 octets out
Nov 26 10:32:09 vbook ppp[1990]: tun0: Phase: deflink: 0 packets in, 5 packets 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 transport
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 = 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, interval 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 = 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, interval 10000ms
Nov 26 10:35:19 vbook ppp[2233]: tun0: LCP: deflink: RecvConfigReq(2) state = 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 = 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 bytes 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 IPCP 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 = 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, interval 10000ms
Nov 26 10:35:23 vbook ppp[2233]: tun0: LCP: deflink: RecvConfigReq(1) state = 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 = 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 = 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, interval 10000ms
Nov 26 10:35:27 vbook ppp[2233]: tun0: LCP: deflink: SendConfigReq(2) state = 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, interval 10000ms
Nov 26 10:35:29 vbook ppp[2233]: tun0: LCP: deflink: RecvConfigReq(1) state = 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 = 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 bytes 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�c�`�I��



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 
> symptoms.
> 
> Make sure you have the latest and greatest version of u3g.c from current.

sure
$ cvs -R status dev/usb/u3g.c
===================================================================
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. 
What I can trace/log/debug ?

> Nick
> 
> 
> > 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.
> 
> 
> _______________________________________________
> freebsd-current_at_freebsd.org mailing list
> http://lists.freebsd.org/mailman/listinfo/freebsd-current
> To unsubscribe, send any mail to "freebsd-current-unsubscribe_at_freebsd.org"
-- 
Vladimir B. Grebenschikov
vova_at_fbsd.ru
Received on Wed Nov 26 2008 - 06:41:38 UTC

This archive was generated by hypermail 2.4.0 : Wed May 19 2021 - 11:39:38 UTC