(no subject)

classic Classic list List threaded Threaded
14 messages Options
Reply | Threaded
Open this post in threaded view
|

(no subject)

patrick kristensen
Hi

I have 4.6-RELEASE on a lenovo x200s system with Ericsson F3507g
Mobile Broadband Module installed (mini-pci express wwan adapter).
On FreeBSD the device is detected by the cdce(4) driver which creates
an ue0 ethernet interface. On 4.6-RELEASE install this does not
happen.
The cdce(4) appeared in openBSD 4.1 and following the changelog from
4.1 to -current, cdce(4) should be in generic.
Do I need to modload anything for cdce to load?

Thanks for helping
Kind regards,
Patrick

Reply | Threaded
Open this post in threaded view
|

Re:

J.C. Roberts-3
On Fri, 14 May 2010 17:11:16 +0200 patrick kristensen
<[hidden email]> wrote:

> Hi
>
> I have 4.6-RELEASE on a lenovo x200s system with Ericsson F3507g
> Mobile Broadband Module installed (mini-pci express wwan adapter).
> On FreeBSD the device is detected by the cdce(4) driver which creates
> an ue0 ethernet interface. On 4.6-RELEASE install this does not
> happen.
> The cdce(4) appeared in openBSD 4.1 and following the changelog from
> 4.1 to -current, cdce(4) should be in generic.
> Do I need to modload anything for cdce to load?


It seems you forgot to post your dmesg and the output of `usbdevs -vd`


--
The OpenBSD Journal - http://www.undeadly.org

Reply | Threaded
Open this post in threaded view
|

Re:

patrick kristensen
2010/5/17 J.C. Roberts <[hidden email]>:

> On Fri, 14 May 2010 17:11:16 +0200 patrick kristensen
> <[hidden email]> wrote:
>> Hi
>>
>> I have 4.6-RELEASE on a lenovo x200s system with Ericsson F3507g
>> Mobile Broadband Module installed (mini-pci express wwan adapter).
>> On FreeBSD the device is detected by the cdce(4) driver which creates
>> an ue0 ethernet interface. On 4.6-RELEASE install this does not
>> happen.
>> The cdce(4) appeared in openBSD 4.1 and following the changelog from
>> 4.1 to -current, cdce(4) should be in generic.
>> Do I need to modload anything for cdce to load?
>
>
> It seems you forgot to post your dmesg and the output of `usbdevs -vd`
>
>
> --
> The OpenBSD Journal - http://www.undeadly.org
>

I have  upgraded to 4.7-release and later 4.7-current but cdce does not load.
The output from dmesg and usbdevs for -release and -current is:


dmesg on 4.7-release

LITY>
wd0: 1-sector PIO, LBA48, 61057MB, 125045424 sectors
wd0(pciide0:0:0): using PIO mode 4, Ultra-DMA mode 6
atapiscsi0 at pciide0 channel 1 drive 0
scsibus0 at atapiscsi0: 2 targets
cd0 at scsibus0 targ 0 lun 0: <HL-DT-ST, DVDRAM GSA-U20N, HX12> ATAPI
5/cdrom removable
cd0(pciide0:1:0): using PIO mode 4, Ultra-DMA mode 6
"Intel 82801I SMBus" rev 0x03 at pci0 dev 31 function 3 not configured
usb2 at uhci0: USB revision 1.0
uhub2 at usb2 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb3 at uhci1: USB revision 1.0
uhub3 at usb3 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb4 at uhci2: USB revision 1.0
uhub4 at usb4 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb5 at uhci3: USB revision 1.0
uhub5 at usb5 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb6 at uhci4: USB revision 1.0
uhub6 at usb6 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb7 at uhci5: USB revision 1.0
uhub7 at usb7 "Intel UHCI root hub" rev 1.00/1.00 addr 1
isa0 at mainbus0
pckbc0 at isa0 port 0x60/5
pckbd0 at pckbc0 (kbd slot)
pckbc0: using irq 1 for kbd slot
wskbd0 at pckbd0: console keyboard, using wsdisplay0
rd0: fixed, 4480 blocks
"Ericsson Ericsson F3507g Mobile Broadband Minicard Composite Device"
rev 2.00/0.00 addr 2 at uhub1 port 4 not configured
uhub8 at uhub0 port 5 "vendor 0x17ef product 0x1005" rev 2.00/0.01 addr 2
"Chicony Electronics Co., Ltd. product 0x480c" rev 2.00/31.34 addr 3
at uhub0 port 6 not configured
"vendor 0x08ff Fingerprint Sensor" rev 2.00/17.03 addr 2 at uhub3 port
1 not configured
softraid0 at root
root on rd0a swap on rd0b dump on rd0b
syncing disks... done
rebooting...
OpenBSD 4.7 (GENERIC.MP) #130: Wed Mar 17 20:48:50 MDT 2010
   [hidden email]:/usr/src/sys/arch/amd64/compile/GENERIC.MP
real mem = 3175813120 (3028MB)
avail mem = 3083743232 (2940MB)
mainbus0 at root
bios0 at mainbus0: SMBIOS rev. 2.4 @ 0xe0010 (68 entries)
bios0: vendor LENOVO version "6DET58WW (3.08 )" date 08/20/2009
bios0: LENOVO 74663RG
acpi0 at bios0: rev 2
acpi0: tables DSDT FACP SSDT ECDT APIC MCFG HPET SLIC BOOT ASF! SSDT
SSDT TCPA DMAR SSDT SSDT SSDT
acpi0: wakeup devices LID_(S3) SLPB(S3) IGBE(S4) EXP0(S4) EXP1(S4)
EXP2(S4) EXP3(S4) USB0(S3) USB3(S3) USB5(S3) EHC0(S3) EHC1(S3)
HDEF(S4)
acpitimer0 at acpi0: 3579545 Hz, 24 bits
acpimadt0 at acpi0 addr 0xfee00000: PC-AT compat
cpu0 at mainbus0: apid 0 (boot processor)
cpu0: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz, 1862.24 MHz
cpu0:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUS
H,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,SSE3,MWAIT,DS-CPL,VMX,SMX,EST,TM2,C
X16,xTPR,NXE,LONG
cpu0: 6MB 64b/line 16-way L2 cache
cpu0: apic clock running at 265MHz
cpu1 at mainbus0: apid 1 (application processor)
cpu1: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz, 1862.00 MHz
cpu1:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUS
H,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,SSE3,MWAIT,DS-CPL,VMX,SMX,EST,TM2,C
X16,xTPR,NXE,LONG
cpu1: 6MB 64b/line 16-way L2 cache
ioapic0 at mainbus0: apid 1 pa 0xfec00000, version 20, 24 pins
ioapic0: misconfigured as apic 2, remapped to apid 1
acpihpet0 at acpi0: 14318179 Hz
acpiprt0 at acpi0: bus 0 (PCI0)
acpiprt1 at acpi0: bus -1 (AGP_)
acpiprt2 at acpi0: bus 2 (EXP0)
acpiprt3 at acpi0: bus 3 (EXP1)
acpiprt4 at acpi0: bus 4 (EXP2)
acpiprt5 at acpi0: bus 5 (EXP3)
acpiec0 at acpi0
acpicpu0 at acpi0: C3, C2, C1, PSS
acpicpu1 at acpi0: C3, C2, C1, PSS
acpipwrres0 at acpi0: PUBS
acpitz0 at acpi0: critical temperature 127 degC
acpitz1 at acpi0: critical temperature 104 degC
acpibtn0 at acpi0: LID_
acpibtn1 at acpi0: SLPB
acpibat0 at acpi0: BAT0 model "42T4649" serial    72 type LION oem "SANYO"
acpibat1 at acpi0: BAT1 not present
acpiac0 at acpi0: AC unit online
acpithinkpad0 at acpi0
acpidock0 at acpi0: GDCK docked (15)
cpu0: Enhanced SpeedStep 1862 MHz: speeds: 1867, 1866, 1600, 800 MHz
pci0 at mainbus0 bus 0
pchb0 at pci0 dev 0 function 0 "Intel GM45 Host" rev 0x07
vga1 at pci0 dev 2 function 0 "Intel GM45 Video" rev 0x07
wsdisplay0 at vga1 mux 1: console (80x25, vt100 emulation)
wsdisplay0: screen 1-5 added (80x25, vt100 emulation)
intagp0 at vga1
agp0 at intagp0: aperture at 0xd0000000, size 0x10000000
inteldrm0 at vga1: apic 1 int 16 (irq 11)
drm0 at inteldrm0
"Intel GM45 Video" rev 0x07 at pci0 dev 2 function 1 not configured
"Intel GM45 HECI" rev 0x07 at pci0 dev 3 function 0 not configured
"Intel GM45 AMT SOL" rev 0x07 at pci0 dev 3 function 3 not configured
em0 at pci0 dev 25 function 0 "Intel ICH9 IGP M AMT" rev 0x03: apic 1
int 20 (irq 11), address 00:1f:16:11:12:8f
uhci0 at pci0 dev 26 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 20 (irq 11)
uhci1 at pci0 dev 26 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 21 (irq 11)
uhci2 at pci0 dev 26 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 22 (irq 11)
ehci0 at pci0 dev 26 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 23 (irq 11)
usb0 at ehci0: USB revision 2.0
uhub0 at usb0 "Intel EHCI root hub" rev 2.00/1.00 addr 1
azalia0 at pci0 dev 27 function 0 "Intel 82801I HD Audio" rev 0x03:
apic 1 int 17 (irq 11)
azalia0: codecs: Conexant CX20561
audio0 at azalia0
ppb0 at pci0 dev 28 function 0 "Intel 82801I PCIE" rev 0x03: apic 1
int 20 (irq 11)
pci1 at ppb0 bus 2
ppb1 at pci0 dev 28 function 1 "Intel 82801I PCIE" rev 0x03: apic 1
int 21 (irq 11)
pci2 at ppb1 bus 3
iwn0 at pci2 dev 0 function 0 "Intel WiFi Link 5300" rev 0x00: apic 1
int 17 (irq 11), MIMO 3T3R, MoW, address 00:16:ea:e4:a3:ce
ppb2 at pci0 dev 28 function 2 "Intel 82801I PCIE" rev 0x03: apic 1
int 22 (irq 11)
pci3 at ppb2 bus 4
"Intel Turbo Memory" rev 0x11 at pci3 dev 0 function 0 not configured
ppb3 at pci0 dev 28 function 3 "Intel 82801I PCIE" rev 0x03: apic 1
int 23 (irq 11)
pci4 at ppb3 bus 5
uhci3 at pci0 dev 29 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 16 (irq 11)
uhci4 at pci0 dev 29 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 17 (irq 11)
uhci5 at pci0 dev 29 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 18 (irq 11)
ehci1 at pci0 dev 29 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 19 (irq 11)
usb1 at ehci1: USB revision 2.0
uhub1 at usb1 "Intel EHCI root hub" rev 2.00/1.00 addr 1
ppb4 at pci0 dev 30 function 0 "Intel 82801BAM Hub-to-PCI" rev 0x93
pci5 at ppb4 bus 13
pcib0 at pci0 dev 31 function 0 "Intel 82801IEM LPC" rev 0x03
pciide0 at pci0 dev 31 function 2 "Intel 82801I SATA" rev 0x03: DMA,
channel 0 configured to native-PCI, channel 1 configured to native-PCI
pciide0: using apic 1 int 16 (irq 255) for native-PCI interrupt
wd0 at pciide0 channel 0 drive 0: <OCZ AGILITY>
wd0: 1-sector PIO, LBA48, 61057MB, 125045424 sectors
wd0(pciide0:0:0): using PIO mode 4, Ultra-DMA mode 6
atapiscsi0 at pciide0 channel 1 drive 0
scsibus0 at atapiscsi0: 2 targets
cd0 at scsibus0 targ 0 lun 0: <HL-DT-ST, DVDRAM GSA-U20N, HX12> ATAPI
5/cdrom removable
cd0(pciide0:1:0): using PIO mode 4, Ultra-DMA mode 6
ichiic0 at pci0 dev 31 function 3 "Intel 82801I SMBus" rev 0x03: apic
1 int 23 (irq 11)
iic0 at ichiic0
usb2 at uhci0: USB revision 1.0
uhub2 at usb2 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb3 at uhci1: USB revision 1.0
uhub3 at usb3 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb4 at uhci2: USB revision 1.0
uhub4 at usb4 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb5 at uhci3: USB revision 1.0
uhub5 at usb5 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb6 at uhci4: USB revision 1.0
uhub6 at usb6 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb7 at uhci5: USB revision 1.0
uhub7 at usb7 "Intel UHCI root hub" rev 1.00/1.00 addr 1
isa0 at pcib0
isadma0 at isa0
pckbc0 at isa0 port 0x60/5
pckbd0 at pckbc0 (kbd slot)
pckbc0: using irq 1 for kbd slot
wskbd0 at pckbd0: console keyboard, using wsdisplay0
pms0 at pckbc0 (aux slot)
pckbc0: using irq 12 for aux slot
wsmouse0 at pms0 mux 0
pcppi0 at isa0 port 0x61
midi0 at pcppi0: <PC speaker>
spkr0 at pcppi0
aps0 at isa0 port 0x1600/31
mtrr: Pentium Pro MTRR support
umodem0 at uhub1 port 4 configuration 1 interface 1 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem0: data interface 2, has CM over data, has break
umodem0: status change notification available
ucom0 at umodem0
umodem1 at uhub1 port 4 configuration 1 interface 3 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem1: data interface 4, has CM over data, has break
umodem1: status change notification available
ucom1 at umodem1
umodem2 at uhub1 port 4 configuration 1 interface 9 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem2: data interface 12, has CM over data, has break
umodem2: no data interface
uhub8 at uhub0 port 5 "vendor 0x17ef product 0x1005" rev 2.00/0.01 addr 2
uvideo0 at uhub0 port 6 configuration 1 interface 0 "Chicony
Electronics Co., Ltd. product 0x480c" rev 2.00/31.34 addr 3
video0 at uvideo0
ugen0 at uhub3 port 1 "AuthenTec Fingerprint Sensor" rev 2.00/17.03 addr 2
vscsi0 at root
scsibus1 at vscsi0: 256 targets
softraid0 at root
root on wd0a swap on wd0b dump on wd0b
syncing disks... done
rebooting...
OpenBSD 4.7 (GENERIC.MP) #130: Wed Mar 17 20:48:50 MDT 2010
   [hidden email]:/usr/src/sys/arch/amd64/compile/GENERIC.MP
real mem = 3175813120 (3028MB)
avail mem = 3083743232 (2940MB)
mainbus0 at root
bios0 at mainbus0: SMBIOS rev. 2.4 @ 0xe0010 (68 entries)
bios0: vendor LENOVO version "6DET58WW (3.08 )" date 08/20/2009
bios0: LENOVO 74663RG
acpi0 at bios0: rev 2
acpi0: tables DSDT FACP SSDT ECDT APIC MCFG HPET SLIC BOOT ASF! SSDT
SSDT TCPA DMAR SSDT SSDT SSDT
acpi0: wakeup devices LID_(S3) SLPB(S3) IGBE(S4) EXP0(S4) EXP1(S4)
EXP2(S4) EXP3(S4) USB0(S3) USB3(S3) USB5(S3) EHC0(S3) EHC1(S3)
HDEF(S4)
acpitimer0 at acpi0: 3579545 Hz, 24 bits
acpimadt0 at acpi0 addr 0xfee00000: PC-AT compat
cpu0 at mainbus0: apid 0 (boot processor)
cpu0: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz, 1862.31 MHz
cpu0:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUS
H,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,SSE3,MWAIT,DS-CPL,VMX,SMX,EST,TM2,C
X16,xTPR,NXE,LONG
cpu0: 6MB 64b/line 16-way L2 cache
cpu0: apic clock running at 265MHz
cpu1 at mainbus0: apid 1 (application processor)
cpu1: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz, 1862.00 MHz
cpu1:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUS
H,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,SSE3,MWAIT,DS-CPL,VMX,SMX,EST,TM2,C
X16,xTPR,NXE,LONG
cpu1: 6MB 64b/line 16-way L2 cache
ioapic0 at mainbus0: apid 1 pa 0xfec00000, version 20, 24 pins
ioapic0: misconfigured as apic 2, remapped to apid 1
acpihpet0 at acpi0: 14318179 Hz
acpiprt0 at acpi0: bus 0 (PCI0)
acpiprt1 at acpi0: bus -1 (AGP_)
acpiprt2 at acpi0: bus 2 (EXP0)
acpiprt3 at acpi0: bus 3 (EXP1)
acpiprt4 at acpi0: bus 4 (EXP2)
acpiprt5 at acpi0: bus 5 (EXP3)
acpiec0 at acpi0
acpicpu0 at acpi0: C3, C2, C1, PSS
acpicpu1 at acpi0: C3, C2, C1, PSS
acpipwrres0 at acpi0: PUBS
acpitz0 at acpi0: critical temperature 127 degC
acpitz1 at acpi0: critical temperature 104 degC
acpibtn0 at acpi0: LID_
acpibtn1 at acpi0: SLPB
acpibat0 at acpi0: BAT0 model "42T4649" serial    72 type LION oem "SANYO"
acpibat1 at acpi0: BAT1 not present
acpiac0 at acpi0: AC unit online
acpithinkpad0 at acpi0
acpidock0 at acpi0: GDCK not docked (0)
cpu0: Enhanced SpeedStep 1862 MHz: speeds: 1867, 1866, 1600, 800 MHz
pci0 at mainbus0 bus 0
pchb0 at pci0 dev 0 function 0 "Intel GM45 Host" rev 0x07
vga1 at pci0 dev 2 function 0 "Intel GM45 Video" rev 0x07
wsdisplay0 at vga1 mux 1: console (80x25, vt100 emulation)
wsdisplay0: screen 1-5 added (80x25, vt100 emulation)
intagp0 at vga1
agp0 at intagp0: aperture at 0xd0000000, size 0x10000000
inteldrm0 at vga1: apic 1 int 16 (irq 11)
drm0 at inteldrm0
"Intel GM45 Video" rev 0x07 at pci0 dev 2 function 1 not configured
"Intel GM45 HECI" rev 0x07 at pci0 dev 3 function 0 not configured
"Intel GM45 AMT SOL" rev 0x07 at pci0 dev 3 function 3 not configured
em0 at pci0 dev 25 function 0 "Intel ICH9 IGP M AMT" rev 0x03: apic 1
int 20 (irq 11), address 00:1f:16:11:12:8f
uhci0 at pci0 dev 26 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 20 (irq 11)
uhci1 at pci0 dev 26 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 21 (irq 11)
uhci2 at pci0 dev 26 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 22 (irq 11)
ehci0 at pci0 dev 26 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 23 (irq 11)
usb0 at ehci0: USB revision 2.0
uhub0 at usb0 "Intel EHCI root hub" rev 2.00/1.00 addr 1
azalia0 at pci0 dev 27 function 0 "Intel 82801I HD Audio" rev 0x03:
apic 1 int 17 (irq 11)
azalia0: codecs: Conexant CX20561
audio0 at azalia0
ppb0 at pci0 dev 28 function 0 "Intel 82801I PCIE" rev 0x03: apic 1
int 20 (irq 11)
pci1 at ppb0 bus 2
ppb1 at pci0 dev 28 function 1 "Intel 82801I PCIE" rev 0x03: apic 1
int 21 (irq 11)
pci2 at ppb1 bus 3
iwn0 at pci2 dev 0 function 0 "Intel WiFi Link 5300" rev 0x00: apic 1
int 17 (irq 11), MIMO 3T3R, MoW, address 00:16:ea:e4:a3:ce
ppb2 at pci0 dev 28 function 2 "Intel 82801I PCIE" rev 0x03: apic 1
int 22 (irq 11)
pci3 at ppb2 bus 4
"Intel Turbo Memory" rev 0x11 at pci3 dev 0 function 0 not configured
ppb3 at pci0 dev 28 function 3 "Intel 82801I PCIE" rev 0x03: apic 1
int 23 (irq 11)
pci4 at ppb3 bus 5
uhci3 at pci0 dev 29 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 16 (irq 11)
uhci4 at pci0 dev 29 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 17 (irq 11)
uhci5 at pci0 dev 29 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 18 (irq 11)
ehci1 at pci0 dev 29 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 19 (irq 11)
usb1 at ehci1: USB revision 2.0
uhub1 at usb1 "Intel EHCI root hub" rev 2.00/1.00 addr 1
ppb4 at pci0 dev 30 function 0 "Intel 82801BAM Hub-to-PCI" rev 0x93
pci5 at ppb4 bus 13
pcib0 at pci0 dev 31 function 0 "Intel 82801IEM LPC" rev 0x03
pciide0 at pci0 dev 31 function 2 "Intel 82801I SATA" rev 0x03: DMA,
channel 0 configured to native-PCI, channel 1 configured to native-PCI
pciide0: using apic 1 int 16 (irq 255) for native-PCI interrupt
wd0 at pciide0 channel 0 drive 0: <OCZ AGILITY>
wd0: 1-sector PIO, LBA48, 61057MB, 125045424 sectors
wd0(pciide0:0:0): using PIO mode 4, Ultra-DMA mode 6
ichiic0 at pci0 dev 31 function 3 "Intel 82801I SMBus" rev 0x03: apic
1 int 23 (irq 11)
iic0 at ichiic0
usb2 at uhci0: USB revision 1.0
uhub2 at usb2 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb3 at uhci1: USB revision 1.0
uhub3 at usb3 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb4 at uhci2: USB revision 1.0
uhub4 at usb4 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb5 at uhci3: USB revision 1.0
uhub5 at usb5 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb6 at uhci4: USB revision 1.0
uhub6 at usb6 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb7 at uhci5: USB revision 1.0
uhub7 at usb7 "Intel UHCI root hub" rev 1.00/1.00 addr 1
isa0 at pcib0
isadma0 at isa0
pckbc0 at isa0 port 0x60/5
pckbd0 at pckbc0 (kbd slot)
pckbc0: using irq 1 for kbd slot
wskbd0 at pckbd0: console keyboard, using wsdisplay0
pms0 at pckbc0 (aux slot)
pckbc0: using irq 12 for aux slot
wsmouse0 at pms0 mux 0
pcppi0 at isa0 port 0x61
midi0 at pcppi0: <PC speaker>
spkr0 at pcppi0
aps0 at isa0 port 0x1600/31
mtrr: Pentium Pro MTRR support
umodem0 at uhub1 port 4 configuration 1 interface 1 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem0: data interface 2, has CM over data, has break
umodem0: status change notification available
ucom0 at umodem0
umodem1 at uhub1 port 4 configuration 1 interface 3 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem1: data interface 4, has CM over data, has break
umodem1: status change notification available
ucom1 at umodem1
umodem2 at uhub1 port 4 configuration 1 interface 9 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem2: data interface 12, has CM over data, has break
umodem2: no data interface
uvideo0 at uhub0 port 6 configuration 1 interface 0 "Chicony
Electronics Co., Ltd. product 0x480c" rev 2.00/31.34 addr 2
video0 at uvideo0
ugen0 at uhub3 port 1 "AuthenTec Fingerprint Sensor" rev 2.00/17.03 addr 2
ubt0 at uhub3 port 2 "Lenovo Computer Corp ThinkPad Bluetooth with
Enhanced Data Rate II" rev 2.00/3.99 addr 3
vscsi0 at root
scsibus0 at vscsi0: 256 targets
softraid0 at root
root on wd0a swap on wd0b dump on wd0b


usbdevs -vd (4.7-release)

Controller /dev/usb0:
addr 1: high speed, self powered, config 1, EHCI root hub(0x0000),
Intel(0x8086), rev 1.00
 uhub0
port 1 powered
port 2 powered
port 3 powered
port 4 powered
port 5 powered
port 6 addr 2: high speed, power 100 mA, config 1, product
0x480c(0x480c), Chicony Electronics Co., Ltd.(0x17ef), rev 31.34
  uvideo0
Controller /dev/usb1:
addr 1: high speed, self powered, config 1, EHCI root hub(0x0000),
Intel(0x8086), rev 1.00
 uhub1
port 1 powered
port 2 powered
port 3 powered
port 4 addr 2: high speed, power 20 mA, config 1, Ericsson F3507g
Mobile Broadband Minicard Composite Device(0x1900), Ericsson(0x0bdb),
rev 0.00, iSerialNumber 3541430209963360
  umodem0
  umodem1
  umodem2
port 5 powered
port 6 powered
Controller /dev/usb2:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
 uhub2
port 1 powered
port 2 powered
Controller /dev/usb3:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
 uhub3
port 1 addr 2: full speed, power 100 mA, config 1, Fingerprint
Sensor(0x2810), AuthenTec(0x08ff), rev 17.03
  ugen0
port 2 addr 3: full speed, self powered, config 1, ThinkPad Bluetooth
with Enhanced Data Rate II(0x2145), Lenovo Computer Corp(0x0a5c), rev
3.99
  ubt0
Controller /dev/usb4:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
 uhub4
port 1 powered
port 2 powered
Controller /dev/usb5:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
 uhub5
port 1 powered
port 2 powered


dmesg (4.7-current)

OpenBSD 4.7-current (RAMDISK_CD) #426: Wed May 12 02:08:20 MDT 2010
    [hidden email]:/usr/src/sys/arch/amd64/compile/RAMDISK_CD
real mem = 3175813120 (3028MB)
avail mem = 3079421952 (2936MB)
mainbus0 at root
bios0 at mainbus0: SMBIOS rev. 2.4 @ 0xe0010 (68 entries)
bios0: vendor LENOVO version "6DET58WW (3.08 )" date 08/20/2009
bios0: LENOVO 74663RG
acpi0 at bios0: rev 2
acpi0: tables DSDT FACP SSDT ECDT APIC MCFG HPET SLIC BOOT ASF! SSDT
SSDT TCPA DMAR SSDT SSDT SSDT
acpimadt0 at acpi0 addr 0xfee00000: PC-AT compat
cpu0 at mainbus0: apid 0 (boot processor)
cpu0: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz, 1862.26 MHz
cpu0:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUS
H,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,SSE3,MWAIT,DS-CPL,VMX,SMX,EST,TM2,S
SSE3,CX16,xTPR,PDCM,SSE4.1,NXE,LONG
cpu0: 6MB 64b/line 16-way L2 cache
cpu0: apic clock running at 266MHz
cpu at mainbus0: not configured
ioapic0 at mainbus0: apid 1 pa 0xfec00000, version 20, 24 pins
ioapic0: misconfigured as apic 2, remapped to apid 1
acpiprt0 at acpi0: bus 0 (PCI0)
acpiprt1 at acpi0: bus -1 (AGP_)
acpiprt2 at acpi0: bus 2 (EXP0)
acpiprt3 at acpi0: bus 3 (EXP1)
acpiprt4 at acpi0: bus 4 (EXP2)
acpiprt5 at acpi0: bus 5 (EXP3)
pci0 at mainbus0 bus 0
pchb0 at pci0 dev 0 function 0 "Intel GM45 Host" rev 0x07
vga1 at pci0 dev 2 function 0 "Intel GM45 Video" rev 0x07
wsdisplay0 at vga1 mux 1: console (80x25, vt100 emulation)
"Intel GM45 Video" rev 0x07 at pci0 dev 2 function 1 not configured
"Intel GM45 HECI" rev 0x07 at pci0 dev 3 function 0 not configured
"Intel GM45 AMT SOL" rev 0x07 at pci0 dev 3 function 3 not configured
em0 at pci0 dev 25 function 0 "Intel ICH9 IGP M AMT" rev 0x03: apic 1
int 20 (irq 11), address 00:1f:16:11:12:8f
uhci0 at pci0 dev 26 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 20 (irq 11)
uhci1 at pci0 dev 26 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 21 (irq 11)
uhci2 at pci0 dev 26 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 22 (irq 11)
ehci0 at pci0 dev 26 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 23 (irq 11)
usb0 at ehci0: USB revision 2.0
uhub0 at usb0 "Intel EHCI root hub" rev 2.00/1.00 addr 1
"Intel 82801I HD Audio" rev 0x03 at pci0 dev 27 function 0 not configured
ppb0 at pci0 dev 28 function 0 "Intel 82801I PCIE" rev 0x03: apic 1
int 20 (irq 11)
pci1 at ppb0 bus 2
ppb1 at pci0 dev 28 function 1 "Intel 82801I PCIE" rev 0x03: apic 1
int 21 (irq 11)
pci2 at ppb1 bus 3
iwn0 at pci2 dev 0 function 0 "Intel WiFi Link 5300" rev 0x00: apic 1
int 17 (irq 11), MIMO 3T3R, MoW, address 00:16:ea:e4:a3:ce
ppb2 at pci0 dev 28 function 2 "Intel 82801I PCIE" rev 0x03: apic 1
int 22 (irq 11)
pci3 at ppb2 bus 4
"Intel Turbo Memory" rev 0x11 at pci3 dev 0 function 0 not configured
ppb3 at pci0 dev 28 function 3 "Intel 82801I PCIE" rev 0x03: apic 1
int 23 (irq 11)
pci4 at ppb3 bus 5
uhci3 at pci0 dev 29 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 16 (irq 11)
uhci4 at pci0 dev 29 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 17 (irq 11)
uhci5 at pci0 dev 29 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 18 (irq 11)
ehci1 at pci0 dev 29 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 19 (irq 11)
usb1 at ehci1: USB revision 2.0
uhub1 at usb1 "Intel EHCI root hub" rev 2.00/1.00 addr 1
ppb4 at pci0 dev 30 function 0 "Intel 82801BAM Hub-to-PCI" rev 0x93
pci5 at ppb4 bus 13
"Intel 82801IEM LPC" rev 0x03 at pci0 dev 31 function 0 not configured
pciide0 at pci0 dev 31 function 2 "Intel 82801I SATA" rev 0x03: DMA,
channel 0 configured to native-PCI, channel 1 configured to native-PCI
pciide0: using apic 1 int 16 (irq 255) for native-PCI interrupt
wd0 at pciide0 channel 0 drive 0: <OCZ AGILITY>
wd0: 1-sector PIO, LBA48, 61057MB, 125045424 sectors
wd0(pciide0:0:0): using PIO mode 4, Ultra-DMA mode 6
atapiscsi0 at pciide0 channel 1 drive 0
scsibus0 at atapiscsi0: 2 targets
cd0 at scsibus0 targ 0 lun 0: <HL-DT-ST, DVDRAM GSA-U20N, HX12> ATAPI
5/cdrom removable
cd0(pciide0:1:0): using PIO mode 4, Ultra-DMA mode 6
"Intel 82801I SMBus" rev 0x03 at pci0 dev 31 function 3 not configured
usb2 at uhci0: USB revision 1.0
uhub2 at usb2 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb3 at uhci1: USB revision 1.0
uhub3 at usb3 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb4 at uhci2: USB revision 1.0
uhub4 at usb4 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb5 at uhci3: USB revision 1.0
uhub5 at usb5 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb6 at uhci4: USB revision 1.0
uhub6 at usb6 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb7 at uhci5: USB revision 1.0
uhub7 at usb7 "Intel UHCI root hub" rev 1.00/1.00 addr 1
isa0 at mainbus0
pckbc0 at isa0 port 0x60/5
pckbd0 at pckbc0 (kbd slot)
pckbc0: using irq 1 for kbd slot
wskbd0 at pckbd0: console keyboard, using wsdisplay0
rd0: fixed, 4480 blocks
"Ericsson Ericsson F3507g Mobile Broadband Minicard Composite Device"
rev 2.00/0.00 addr 2 at uhub1 port 4 not configured
uhub8 at uhub0 port 5 "vendor 0x17ef product 0x1005" rev 2.00/0.01 addr 2
"Chicony Electronics Co., Ltd. product 0x480c" rev 2.00/31.34 addr 3
at uhub0 port 6 not configured
"vendor 0x08ff Fingerprint Sensor" rev 2.00/17.03 addr 2 at uhub3 port
1 not configured
"Lenovo Computer Corp ThinkPad Bluetooth with Enhanced Data Rate II"
rev 2.00/3.99 addr 3 at uhub3 port 2 not configured
softraid0 at root
root on rd0a swap on rd0b dump on rd0b
syncing disks... done
rebooting...
OpenBSD 4.7-current (GENERIC.MP) #229: Wed May 12 02:02:27 MDT 2010
    [hidden email]:/usr/src/sys/arch/amd64/compile/GENERIC.MP
real mem = 3175813120 (3028MB)
avail mem = 3077472256 (2934MB)
mainbus0 at root
bios0 at mainbus0: SMBIOS rev. 2.4 @ 0xe0010 (68 entries)
bios0: vendor LENOVO version "6DET58WW (3.08 )" date 08/20/2009
bios0: LENOVO 74663RG
acpi0 at bios0: rev 2
acpi0: tables DSDT FACP SSDT ECDT APIC MCFG HPET SLIC BOOT ASF! SSDT
SSDT TCPA DMAR SSDT SSDT SSDT
acpi0: wakeup devices LID_(S3) SLPB(S3) IGBE(S4) EXP0(S4) EXP1(S4)
EXP2(S4) EXP3(S4) USB0(S3) USB3(S3) USB5(S3) EHC0(S3) EHC1(S3)
HDEF(S4)
acpitimer0 at acpi0: 3579545 Hz, 24 bits
acpimadt0 at acpi0 addr 0xfee00000: PC-AT compat
cpu0 at mainbus0: apid 0 (boot processor)
cpu0: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz, 1862.25 MHz
cpu0:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUS
H,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,SSE3,MWAIT,DS-CPL,VMX,SMX,EST,TM2,S
SSE3,CX16,xTPR,PDCM,SSE4.1,NXE,LONG
cpu0: 6MB 64b/line 16-way L2 cache
cpu0: apic clock running at 266MHz
cpu1 at mainbus0: apid 1 (application processor)
cpu1: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz, 1862.00 MHz
cpu1:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUS
H,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,SSE3,MWAIT,DS-CPL,VMX,SMX,EST,TM2,S
SSE3,CX16,xTPR,PDCM,SSE4.1,NXE,LONG
cpu1: 6MB 64b/line 16-way L2 cache
ioapic0 at mainbus0: apid 1 pa 0xfec00000, version 20, 24 pins
ioapic0: misconfigured as apic 2, remapped to apid 1
acpihpet0 at acpi0: 14318179 Hz
acpiprt0 at acpi0: bus 0 (PCI0)
acpiprt1 at acpi0: bus -1 (AGP_)
acpiprt2 at acpi0: bus 2 (EXP0)
acpiprt3 at acpi0: bus 3 (EXP1)
acpiprt4 at acpi0: bus 4 (EXP2)
acpiprt5 at acpi0: bus 5 (EXP3)
acpiec0 at acpi0
acpicpu0 at acpi0: C3, C2, C1, PSS
acpicpu1 at acpi0: C3, C2, C1, PSS
acpipwrres0 at acpi0: PUBS
acpitz0 at acpi0: critical temperature 127 degC
acpitz1 at acpi0: critical temperature 104 degC
acpibtn0 at acpi0: LID_
acpibtn1 at acpi0: SLPB
acpibat0 at acpi0: BAT0 model "42T4649" serial    72 type LION oem "SANYO"
acpibat1 at acpi0: BAT1 not present
acpiac0 at acpi0: AC unit online
acpithinkpad0 at acpi0
acpidock0 at acpi0: GDCK docked (15)
cpu0: Enhanced SpeedStep 1862 MHz: speeds: 1867, 1866, 1600, 800 MHz
pci0 at mainbus0 bus 0
pchb0 at pci0 dev 0 function 0 "Intel GM45 Host" rev 0x07
vga1 at pci0 dev 2 function 0 "Intel GM45 Video" rev 0x07
wsdisplay0 at vga1 mux 1: console (80x25, vt100 emulation)
wsdisplay0: screen 1-5 added (80x25, vt100 emulation)
intagp0 at vga1
agp0 at intagp0: aperture at 0xd0000000, size 0x10000000
inteldrm0 at vga1: apic 1 int 16 (irq 11)
drm0 at inteldrm0
"Intel GM45 Video" rev 0x07 at pci0 dev 2 function 1 not configured
"Intel GM45 HECI" rev 0x07 at pci0 dev 3 function 0 not configured
"Intel GM45 AMT SOL" rev 0x07 at pci0 dev 3 function 3 not configured
em0 at pci0 dev 25 function 0 "Intel ICH9 IGP M AMT" rev 0x03: apic 1
int 20 (irq 11), address 00:1f:16:11:12:8f
uhci0 at pci0 dev 26 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 20 (irq 11)
uhci1 at pci0 dev 26 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 21 (irq 11)
uhci2 at pci0 dev 26 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 22 (irq 11)
ehci0 at pci0 dev 26 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 23 (irq 11)
usb0 at ehci0: USB revision 2.0
uhub0 at usb0 "Intel EHCI root hub" rev 2.00/1.00 addr 1
azalia0 at pci0 dev 27 function 0 "Intel 82801I HD Audio" rev 0x03:
apic 1 int 17 (irq 11)
azalia0: codecs: Conexant CX20561
audio0 at azalia0
ppb0 at pci0 dev 28 function 0 "Intel 82801I PCIE" rev 0x03: apic 1
int 20 (irq 11)
pci1 at ppb0 bus 2
ppb1 at pci0 dev 28 function 1 "Intel 82801I PCIE" rev 0x03: apic 1
int 21 (irq 11)
pci2 at ppb1 bus 3
iwn0 at pci2 dev 0 function 0 "Intel WiFi Link 5300" rev 0x00: apic 1
int 17 (irq 11), MIMO 3T3R, MoW, address 00:16:ea:e4:a3:ce
ppb2 at pci0 dev 28 function 2 "Intel 82801I PCIE" rev 0x03: apic 1
int 22 (irq 11)
pci3 at ppb2 bus 4
"Intel Turbo Memory" rev 0x11 at pci3 dev 0 function 0 not configured
ppb3 at pci0 dev 28 function 3 "Intel 82801I PCIE" rev 0x03: apic 1
int 23 (irq 11)
pci4 at ppb3 bus 5
uhci3 at pci0 dev 29 function 0 "Intel 82801I USB" rev 0x03: apic 1
int 16 (irq 11)
uhci4 at pci0 dev 29 function 1 "Intel 82801I USB" rev 0x03: apic 1
int 17 (irq 11)
uhci5 at pci0 dev 29 function 2 "Intel 82801I USB" rev 0x03: apic 1
int 18 (irq 11)
ehci1 at pci0 dev 29 function 7 "Intel 82801I USB" rev 0x03: apic 1
int 19 (irq 11)
usb1 at ehci1: USB revision 2.0
uhub1 at usb1 "Intel EHCI root hub" rev 2.00/1.00 addr 1
ppb4 at pci0 dev 30 function 0 "Intel 82801BAM Hub-to-PCI" rev 0x93
pci5 at ppb4 bus 13
pcib0 at pci0 dev 31 function 0 "Intel 82801IEM LPC" rev 0x03
pciide0 at pci0 dev 31 function 2 "Intel 82801I SATA" rev 0x03: DMA,
channel 0 configured to native-PCI, channel 1 configured to native-PCI
pciide0: using apic 1 int 16 (irq 255) for native-PCI interrupt
wd0 at pciide0 channel 0 drive 0: <OCZ AGILITY>
wd0: 1-sector PIO, LBA48, 61057MB, 125045424 sectors
wd0(pciide0:0:0): using PIO mode 4, Ultra-DMA mode 6
atapiscsi0 at pciide0 channel 1 drive 0
scsibus0 at atapiscsi0: 2 targets
cd0 at scsibus0 targ 0 lun 0: <HL-DT-ST, DVDRAM GSA-U20N, HX12> ATAPI
5/cdrom removable
cd0(pciide0:1:0): using PIO mode 4, Ultra-DMA mode 6
ichiic0 at pci0 dev 31 function 3 "Intel 82801I SMBus" rev 0x03: apic
1 int 23 (irq 11)
iic0 at ichiic0
usb2 at uhci0: USB revision 1.0
uhub2 at usb2 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb3 at uhci1: USB revision 1.0
uhub3 at usb3 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb4 at uhci2: USB revision 1.0
uhub4 at usb4 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb5 at uhci3: USB revision 1.0
uhub5 at usb5 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb6 at uhci4: USB revision 1.0
uhub6 at usb6 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb7 at uhci5: USB revision 1.0
uhub7 at usb7 "Intel UHCI root hub" rev 1.00/1.00 addr 1
isa0 at pcib0
isadma0 at isa0
pckbc0 at isa0 port 0x60/5
pckbd0 at pckbc0 (kbd slot)
pckbc0: using irq 1 for kbd slot
wskbd0 at pckbd0: console keyboard, using wsdisplay0
pms0 at pckbc0 (aux slot)
pckbc0: using irq 12 for aux slot
wsmouse0 at pms0 mux 0
pcppi0 at isa0 port 0x61
midi0 at pcppi0: <PC speaker>
spkr0 at pcppi0
aps0 at isa0 port 0x1600/31
mtrr: Pentium Pro MTRR support
umodem0 at uhub1 port 4 configuration 1 interface 1 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem0: data interface 2, has CM over data, has break
umodem0: status change notification available
ucom0 at umodem0
umodem1 at uhub1 port 4 configuration 1 interface 3 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem1: data interface 4, has CM over data, has break
umodem1: status change notification available
ucom1 at umodem1
umodem2 at uhub1 port 4 configuration 1 interface 9 "Ericsson Ericsson
F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
2
umodem2: data interface 12, has CM over data, has break
umodem2: no data interface
uhub8 at uhub0 port 5 "vendor 0x17ef product 0x1005" rev 2.00/0.01 addr 2
uvideo0 at uhub0 port 6 configuration 1 interface 0 "Chicony
Electronics Co., Ltd. product 0x480c" rev 2.00/31.34 addr 3
video0 at uvideo0
ugen0 at uhub3 port 1 "AuthenTec Fingerprint Sensor" rev 2.00/17.03 addr 2
ubt0 at uhub3 port 2 "Lenovo Computer Corp ThinkPad Bluetooth with
Enhanced Data Rate II" rev 2.00/3.99 addr 3
vscsi0 at root
scsibus1 at vscsi0: 256 targets
softraid0 at root
root on wd0a swap on wd0b dump on wd0b


usbdevs -vd (4.7-current)

Controller /dev/usb0:
addr 1: high speed, self powered, config 1, EHCI root hub(0x0000),
Intel(0x8086), rev 1.00
  uhub0
 port 1 powered
 port 2 powered
 port 3 powered
 port 4 powered
 port 5 addr 2: high speed, self powered, config 1, product
0x1005(0x1005), vendor 0x17ef(0x17ef), rev 0.01
   uhub8
  port 1 powered
  port 2 powered
  port 3 powered
  port 4 powered
 port 6 addr 3: high speed, power 100 mA, config 1, product
0x480c(0x480c), Chicony Electronics Co., Ltd.(0x17ef), rev 31.34
   uvideo0
Controller /dev/usb1:
addr 1: high speed, self powered, config 1, EHCI root hub(0x0000),
Intel(0x8086), rev 1.00
  uhub1
 port 1 powered
 port 2 powered
 port 3 powered
 port 4 addr 2: high speed, power 20 mA, config 1, Ericsson F3507g
Mobile Broadband Minicard Composite Device(0x1900), Ericsson(0x0bdb),
rev 0.00, iSerialNumber 3541430209963360
   umodem0
   umodem1
   umodem2
 port 5 powered
 port 6 powered
Controller /dev/usb2:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
  uhub2
 port 1 powered
 port 2 powered
Controller /dev/usb3:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
  uhub3
 port 1 addr 2: full speed, power 100 mA, config 1, Fingerprint
Sensor(0x2810), AuthenTec(0x08ff), rev 17.03
   ugen0
 port 2 addr 3: full speed, self powered, config 1, ThinkPad Bluetooth
with Enhanced Data Rate II(0x2145), Lenovo Computer Corp(0x0a5c), rev
3.99
   ubt0
Controller /dev/usb4:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
  uhub4
 port 1 powered
 port 2 powered
Controller /dev/usb5:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000),
Intel(0x8086), rev 1.00
  uhub5
 port 1 powered
 port 2 powered

Reply | Threaded
Open this post in threaded view
|

Re:

J.C. Roberts-3
On Thu, 20 May 2010 23:17:25 +0200 patrick kristensen
<[hidden email]> wrote:

> 2010/5/17 J.C. Roberts <[hidden email]>:
> > On Fri, 14 May 2010 17:11:16 +0200 patrick kristensen
> > <[hidden email]> wrote:
> >> Hi
> >>
> >> I have 4.6-RELEASE on a lenovo x200s system with Ericsson F3507g
> >> Mobile Broadband Module installed (mini-pci express wwan adapter).
> >> On FreeBSD the device is detected by the cdce(4) driver which
> >> creates an ue0 ethernet interface. On 4.6-RELEASE install this
> >> does not happen.
> >> The cdce(4) appeared in openBSD 4.1 and following the changelog
> >> from 4.1 to -current, cdce(4) should be in generic.
> >> Do I need to modload anything for cdce to load?
> >
> >
> > It seems you forgot to post your dmesg and the output of `usbdevs
> > -vd`
> >
> >
> > --
> > The OpenBSD Journal - http://www.undeadly.org
> >
>
> I have  upgraded to 4.7-release and later 4.7-current but cdce does
> not load. The output from dmesg and usbdevs for -release and -current
> is:
>
>
...
> OpenBSD 4.7-current (GENERIC.MP) #229: Wed May 12 02:02:27 MDT 2010
>     [hidden email]:/usr/src/sys/arch/amd64/compile/GENERIC.MP
...

> umodem0 at uhub1 port 4 configuration 1 interface 1 "Ericsson Ericsson
> F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
> 2
> umodem0: data interface 2, has CM over data, has break
> umodem0: status change notification available
> ucom0 at umodem0
> umodem1 at uhub1 port 4 configuration 1 interface 3 "Ericsson Ericsson
> F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
> 2
> umodem1: data interface 4, has CM over data, has break
> umodem1: status change notification available
> ucom1 at umodem1
> umodem2 at uhub1 port 4 configuration 1 interface 9 "Ericsson Ericsson
> F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
> 2
> umodem2: data interface 12, has CM over data, has break
> umodem2: no data interface
...
>
> usbdevs -vd (4.7-current)
...

> Controller /dev/usb1:
> addr 1: high speed, self powered, config 1, EHCI root hub(0x0000),
> Intel(0x8086), rev 1.00
>   uhub1
>  port 1 powered
>  port 2 powered
>  port 3 powered
>  port 4 addr 2: high speed, power 20 mA, config 1, Ericsson F3507g
> Mobile Broadband Minicard Composite Device(0x1900), Ericsson(0x0bdb),
> rev 0.00, iSerialNumber 3541430209963360
>    umodem0
>    umodem1
>    umodem2
>  port 5 powered
>  port 6 powered


Though I have and have read the mostly useless marketing material
touting the features of the Erricsson F3507g, I haven't been able to
find any real specs. It seems to be very similar feature-wise to the
Qalcomm Gobi-1000 and Gobi-2000 (MDM1000 and MDM2000 chipsets), but I
am yet to find any claim that the Erricson F3507g uses Qaulcom parts,
or for that matter, uses Qualcomm logic cores. It doesn't matter all
that much since the above tells me the device is most likely usable in
OpenBSD as is.

Two of the three umodem(4) have serial ports attached (ucom(4)) so all
you need to do is configure ppp(8) or pppd(8) to talk to one of those
serial ports (/dev/cuaU?). You should probably read the umsm(4) for
more info and an example chat script.

A lot of similar EVDO/HSPA devices are built in the same way in the
sense of providing more than one serial port, but only one of them is
usable with ppp/pppd. The other supposed serial port speaks a
proprietary protocol and is used for "management" purposes. Typically,
the proprietary protocol is either Qualcomm QMI or Qualcomm DM. Due to
various "leaks" (read: google android), portions of the proprietary
protocol have been figured out by the linux camp, but it's still a work
in progress. Some details were posted here:
http://blogs.gnome.org/dcbw/2010/04/

        jcr

--
The OpenBSD Journal - http://www.undeadly.org

Reply | Threaded
Open this post in threaded view
|

Re:

patrick kristensen
2010/5/21 J.C. Roberts <[hidden email]>:

> On Thu, 20 May 2010 23:17:25 +0200 patrick kristensen
> <[hidden email]> wrote:
>> 2010/5/17 J.C. Roberts <[hidden email]>:
>> > On Fri, 14 May 2010 17:11:16 +0200 patrick kristensen
>> > <[hidden email]> wrote:
>> >> Hi
>> >>
>> >> I have 4.6-RELEASE on a lenovo x200s system with Ericsson F3507g
>> >> Mobile Broadband Module installed (mini-pci express wwan adapter).
>> >> On FreeBSD the device is detected by the cdce(4) driver which
>> >> creates an ue0 ethernet interface. On 4.6-RELEASE install this
>> >> does not happen.
>> >> The cdce(4) appeared in openBSD 4.1 and following the changelog
>> >> from 4.1 to -current, cdce(4) should be in generic.
>> >> Do I need to modload anything for cdce to load?
>> >
>> >
>> > It seems you forgot to post your dmesg and the output of `usbdevs
>> > -vd`
>> >
>> >
>> > --
>> > The OpenBSD Journal - http://www.undeadly.org
>> >
>>
>> I have  upgraded to 4.7-release and later 4.7-current but cdce does
>> not load. The output from dmesg and usbdevs for -release and -current
>> is:
>>
>>
> ...
>> OpenBSD 4.7-current (GENERIC.MP) #229: Wed May 12 02:02:27 MDT 2010
>>     [hidden email]:/usr/src/sys/arch/amd64/compile/GENERIC.MP
> ...
>> umodem0 at uhub1 port 4 configuration 1 interface 1 "Ericsson Ericsson
>> F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
>> 2
>> umodem0: data interface 2, has CM over data, has break
>> umodem0: status change notification available
>> ucom0 at umodem0
>> umodem1 at uhub1 port 4 configuration 1 interface 3 "Ericsson Ericsson
>> F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
>> 2
>> umodem1: data interface 4, has CM over data, has break
>> umodem1: status change notification available
>> ucom1 at umodem1
>> umodem2 at uhub1 port 4 configuration 1 interface 9 "Ericsson Ericsson
>> F3507g Mobile Broadband Minicard Composite Device" rev 2.00/0.00 addr
>> 2
>> umodem2: data interface 12, has CM over data, has break
>> umodem2: no data interface
> ...
>>
>> usbdevs -vd (4.7-current)
> ...
>> Controller /dev/usb1:
>> addr 1: high speed, self powered, config 1, EHCI root hub(0x0000),
>> Intel(0x8086), rev 1.00
>>   uhub1
>>  port 1 powered
>>  port 2 powered
>>  port 3 powered
>>  port 4 addr 2: high speed, power 20 mA, config 1, Ericsson F3507g
>> Mobile Broadband Minicard Composite Device(0x1900), Ericsson(0x0bdb),
>> rev 0.00, iSerialNumber 3541430209963360
>>    umodem0
>>    umodem1
>>    umodem2
>>  port 5 powered
>>  port 6 powered
>
>
> Though I have and have read the mostly useless marketing material
> touting the features of the Erricsson F3507g, I haven't been able to
> find any real specs. It seems to be very similar feature-wise to the
> Qalcomm Gobi-1000 and Gobi-2000 (MDM1000 and MDM2000 chipsets), but I
> am yet to find any claim that the Erricson F3507g uses Qaulcom parts,
> or for that matter, uses Qualcomm logic cores. It doesn't matter all
> that much since the above tells me the device is most likely usable in
> OpenBSD as is.
>
> Two of the three umodem(4) have serial ports attached (ucom(4)) so all
> you need to do is configure ppp(8) or pppd(8) to talk to one of those
> serial ports (/dev/cuaU?). You should probably read the umsm(4) for
> more info and an example chat script.
>
> A lot of similar EVDO/HSPA devices are built in the same way in the
> sense of providing more than one serial port, but only one of them is
> usable with ppp/pppd. The other supposed serial port speaks a
> proprietary protocol and is used for "management" purposes. Typically,
> the proprietary protocol is either Qualcomm QMI or Qualcomm DM. Due to
> various "leaks" (read: google android), portions of the proprietary
> protocol have been figured out by the linux camp, but it's still a work
> in progress. Some details were posted here:
> http://blogs.gnome.org/dcbw/2010/04/
>
>        jcr
>
> --
> The OpenBSD Journal - http://www.undeadly.org
>

Thanks for taking the time to answer and your fast replies.
In absence of cdce (using ue0 as ethernet interface (and minicom) to
connect to isp) i have tried several ppp and pppd configurations to
get a working internet connection on -release with no success.

The following is my ppp (# ppp -auto movistar) and pppd (# pppd call
movistar) attempts.

/etc/ppp/ppp.conf  (appended to ppp.conf.sample)

movistar:
        set device /dev/cuaU0
        set speed 460800
        set timeout 0
        set dial "ABORT BUSY TIMEOUT 5 \
                \"\" \
                AT OK-AT-OK \
                AT+CFUN=1 OK-AT-OK \
                AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\\"7291"\\\"-OK \
                AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK \
                "ATDT*99***1#"


        set mtu maximum 750
        resolv rewrite
        set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
        add default HISADDR
        enable dns

# ./.



/var/log/ppp.log

May 22 17:57:51 x200s ppp[8742]: Phase: Using interface: tun0
May 22 17:57:51 x200s ppp[8742]: Phase: deflink: Created in closed state
May 22 17:57:51 x200s ppp[8742]: tun0: Command: default: set device
/dev/cuaU0
May 22 17:57:51 x200s ppp[8742]: tun0: Command: default: set speed 460800
May 22 17:57:51 x200s ppp[8742]: tun0: Command: default: set dial
ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK
\\dATDT\\T TIMEOUT 40 CONNECT
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set device
/dev/cuaU0
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set speed 460800
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set timeout 0
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set dial
ABORT BUSY TIMEOUT 5 "" AT OK-AT-OK AT+CFUN=1 OK-AT-OK
                AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\"7291\\"-OK
AT+CGDCONT=1,\\"IP\\",\\"movistar.es\\" OK ATDT*99***1#
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set mtu maximum 750
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: resolv rewrite
May 22 17:57:51 x200s ppp[8742]: tun0: IPCP: Primary nameserver set to
255.255.255.255
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set ifaddr
10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: add default HISADDR
May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: enable dns
May 22 17:57:51 x200s ppp[3315]: tun0: Phase: PPP Started (auto mode).
May 22 17:57:51 x200s ppp[3315]: tun0: Phase: bundle: Establish
May 22 17:57:51 x200s ppp[3315]: tun0: Phase: deflink: closed -> opening
May 22 17:57:51 x200s ppp[3315]: tun0: Phase: deflink: Connected!
May 22 17:57:51 x200s ppp[3315]: tun0: Phase: deflink: opening -> dial
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: deflink: Dial attempt 1 of 1
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): OK
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received:
May 22 17:57:51 x200s last message repeated 2 times
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT\^M\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CFUN=1\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): OK
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CFUN=1\^M\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN?\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): +CPIN: READY
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CPIN?\^M\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: +CPIN: SIM PIN\^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Expect timeout
May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN"7291"\^M
May 22 17:57:56 x200s ppp[3315]: tun0: Phase: deflink: dial -> carrier
May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: carrier -> login
May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: login -> lcp
May 22 17:57:57 x200s ppp[3315]: tun0: LCP: FSM: Using "deflink" as a
transport
May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change
Initial --> Closed
May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change
Closed --> Stopped
May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: LayerStart
May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1)
state = Stopped
May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: State change
Stopped --> Req-Sent
May 22 17:58:01 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
May 22 17:58:01 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
May 22 17:58:01 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
May 22 17:58:01 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
May 22 17:58:01 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
May 22 17:58:01 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
May 22 17:58:04 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
May 22 17:58:04 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
May 22 17:58:04 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
May 22 17:58:04 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
May 22 17:58:04 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
May 22 17:58:04 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
May 22 17:58:07 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
May 22 17:58:07 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
May 22 17:58:07 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
May 22 17:58:07 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
May 22 17:58:07 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
May 22 17:58:07 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
May 22 17:58:10 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
May 22 17:58:10 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
May 22 17:58:10 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
May 22 17:58:10 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
May 22 17:58:10 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
May 22 17:58:10 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
May 22 17:58:13 x200s ppp[3315]: tun0: LCP: deflink: LayerFinish
May 22 17:58:13 x200s ppp[3315]: tun0: LCP: deflink: State change
Req-Sent --> Stopped
May 22 17:58:13 x200s ppp[3315]: tun0: LCP: deflink: State change
Stopped --> Closed
May 22 17:58:13 x200s ppp[3315]: tun0: LCP: deflink: State change
Closed --> Initial
May 22 17:58:13 x200s ppp[3315]: tun0: Phase: deflink: Disconnected!
May 22 17:58:13 x200s ppp[3315]: tun0: Phase: deflink: lcp -> logout
May 22 17:58:13 x200s ppp[3315]: tun0: Phase: deflink: logout -> hangup
May 22 17:58:13 x200s ppp[3315]: tun0: Phase: deflink: Disconnected!
May 22 17:58:14 x200s ppp[3315]: tun0: Phase: deflink: Connect time:
23 secs: 288 octets in, 265 octets out
May 22 17:58:14 x200s ppp[3315]: tun0: Phase: deflink: 6 packets in, 5
packets out
May 22 17:58:14 x200s ppp[3315]: tun0: Phase:  total 24 bytes/sec,
peak 46 bytes/sec on Sat May 22 17:58:02 2010
May 22 17:58:14 x200s ppp[3315]: tun0: Phase: deflink: hangup -> closed
May 22 17:58:14 x200s ppp[3315]: tun0: Phase: bundle: Dead
May 22 17:58:37 x200s ppp[3315]: tun0: Phase: Signal 15, terminate.
May 22 17:58:37 x200s ppp[3315]: tun0: Phase: PPP Terminated (normal).

And using pppd:

/etc/ppp/peers/chat/movistar.chat

TIMEOUT 120
ABORT "BUSY"
ABORT "NO CARRIER"
ABORT "ERROR"
ABORT "VOICE"
ABORT "NO DIALTONE"
OK AT+CPIN="7291"
OK AT+CFUN=1
OK AT+CGDCONT=1,"IP","movistar.es"
OK AT*ENAP=1,1
OK "ATD*99***1#"
CONNECT \c

/etc/ppp/peers/movistar

debug
cuaU0
460800
defaultroute
noauth
persist
noipdefault
connect '/usr/sbin/chat -v -f /etc/ppp/peers/chat/movistar.chat'

/var/log/chat

May 22 17:05:55 x200s chat[13931]: timeout set to 120 seconds
May 22 17:05:55 x200s chat[13931]: abort on (BUSY)
May 22 17:05:55 x200s chat[13931]: abort on (NO CARRIER)
May 22 17:05:55 x200s chat[13931]: abort on (ERROR)
May 22 17:05:55 x200s chat[13931]: abort on (VOICE)
May 22 17:05:55 x200s chat[13931]: abort on (NO DIALTONE)
May 22 17:05:55 x200s chat[13931]: expect (OK)
May 22 17:07:55 x200s chat[13931]: alarm
May 22 17:07:55 x200s chat[13931]: Failed
May 22 17:08:28 x200s chat[5761]: timeout set to 120 seconds
May 22 17:08:28 x200s chat[5761]: abort on (BUSY)
May 22 17:08:28 x200s chat[5761]: abort on (NO CARRIER)
May 22 17:08:28 x200s chat[5761]: abort on (ERROR)
May 22 17:08:28 x200s chat[5761]: abort on (VOICE)
May 22 17:08:28 x200s chat[5761]: abort on (NO DIALTONE)
May 22 17:08:28 x200s chat[5761]: expect (OK)
May 22 17:09:39 x200s chat[5761]: SIGTERM

In minicom(1) i get the following responses to the AT commands

AT+CPIN="7291"
OK
AT+CFUN=1
OK

*ESTKSMENU: movistar,0,3
6,Chat movistar
7,Correo movil
8,Copiagenda


*EMWI: 1,0

+PACSP0

(wwan antenna light turns on)

AT+CGDCONT=1,"IP","movistar.es"
OK
AT*ENAP=1,1
OK

(wwan antenna light starts blinking)
(At this stage with cdce i '# dhclient ue0' to get an ip adress)

My sources for creating the above configurations are
pppd(8)
ppp(8)
umsm(4)
http://old.nabble.com/umts-need-help-td22360780.html
http://projects.thiemo.net/moin.cgi/FreeBSD_on_ThinkPad_W500
http://www.thinkwiki.org/wiki/Ericsson_F3507g_Mobile_Broadband_Module

Reply | Threaded
Open this post in threaded view
|

Re:

J.C. Roberts-3
On Sat, 22 May 2010 22:08:57 +0200 patrick kristensen
<[hidden email]> wrote:
> Thanks for taking the time to answer and your fast replies.
>

Actually, ppp and TDMA/CDMA are nice break from the other headaches I've
been trying to solve. ;)

First of all, you either haven't mentioned the name of your service
provider, or I forgot what it was. Either way, it matters.

From what I can tell, you're in Spain, and I'm not familiar with the
providers there.

Ted Roby recently posted his config for Virgin Mobile:
http://marc.info/?l=openbsd-tech&m=127285929411780&w=2

The above may not help, but it's nice to see working examples.

> In absence of cdce (using ue0 as ethernet interface (and minicom) to
> connect to isp) i have tried several ppp and pppd configurations to
> get a working internet connection on -release with no success.
>
> The following is my ppp (# ppp -auto movistar) and pppd (# pppd call
> movistar) attempts.

Since pppd(8) is in the kernel, it can be faster, but since ppp(8) is
in userland, it can be much easier to work with when figuring things
out. Once you figure out how to make things work with ppp(8), you can
easily write a new config for pppd(8).


>
> /etc/ppp/ppp.conf  (appended to ppp.conf.sample)
>
> movistar:
> set device /dev/cuaU0
> set speed 460800
> set timeout 0
> set dial "ABORT BUSY TIMEOUT 5 \
> \"\" \
> AT OK-AT-OK \
> AT+CFUN=1 OK-AT-OK \
> AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\\"****"\\\"-OK \

The above looks wrong. Not all wireless service providers and not
all cellular wireless devices require using the Personal Identification
Number (PIN) when making a connection. And worse, the responses you
can get varies from device to device. (see below)

Also, it is unwise to post your PIN to a public mailing list. It's not
too dangerous without the IMEI and MEID device, but it's still not a
good idea.

> AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK \

The above is most likely wrong. The AT+CGDCONT= command sets the primary
CONText of the device and the network it is attaching to. The first
value argument states whether or not the device can be reconfigured (1),
or cannot be reconfigured (3). The second argument is a string which
defines the protocol used on the network. The third argument is also
a string and it defines the Packet Data Network (PDN) name or Access
Point Name (APN).

As far as I know "movistar.es" is not the proper name of any Packet Data
Network (PDN) or Access Point Name (APN). For example Virgin Mobile uses
"VDATA" as the APN/PDN name, while AirTel uses "airtelgprs.com" as the name
and of course, what your provider uses is unknown.

You need to be careful with this setting since many providers have multiple
data networks. With Verizon here in the silicon valley, I can choose from
three different data networks (actually four if you count EVDO Rel. 0 as a
different network than EVDO Rev. A).

> "ATDT*99***1#"
>

The above is wrong because it has no timeout or 'CONNECT'. Also, you should
have noticed the leading double quote (") which is prematurely ending
your chat script *BEFORE* the required number is dialed. The above should be:

        \\dATDT*99***1# TIMEOUT 30 CONNECT"

The leading "\\d" gives a two second delay before calling. It may or may not
be necessary with your hardware/provider.

>
> set mtu maximum 750

The above is most likely wrong.

> resolv rewrite

The above is often unnecessary to get things working, but rewriting
/etc/resolv.conf is mostly a matter of personal choice/needs. The
command you have below, namely `enable dns` should suffice.

> set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
> add default HISADDR
> enable dns
>
> # ./.
>
>
>
> /var/log/ppp.log
>
> May 22 17:57:51 x200s ppp[8742]: Phase: Using interface: tun0
> May 22 17:57:51 x200s ppp[8742]: Phase: deflink: Created in closed
> state May 22 17:57:51 x200s ppp[8742]: tun0: Command: default: set
> device /dev/cuaU0 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
> default: set speed 460800 May 22 17:57:51 x200s ppp[8742]: tun0:
> Command: default: set dial ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 ""
> AT OK-AT-OK ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT
> May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set
> device /dev/cuaU0 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
> movistar: set speed 460800 May 22 17:57:51 x200s ppp[8742]: tun0:
> Command: movistar: set timeout 0 May 22 17:57:51 x200s ppp[8742]:
> tun0: Command: movistar: set dial ABORT BUSY TIMEOUT 5
> "" AT OK-AT-OK AT
> +CFUN=1 OK-AT-OK AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\"7291\\"-OK AT
> +CGDCONT=1,\\"IP\\",\\"movistar.es\\" OK ATDT*99***1# May 22 17:57:51
> x200s ppp[8742]: tun0: Command: movistar: set mtu maximum 750 May 22
> 17:57:51 x200s ppp[8742]: tun0: Command: movistar: resolv rewrite May
> 22 17:57:51 x200s ppp[8742]: tun0: IPCP: Primary nameserver set to
> 255.255.255.255 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
> movistar: set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
> May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: add default
> HISADDR May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar:
> enable dns May 22 17:57:51 x200s ppp[3315]: tun0: Phase: PPP Started
> (auto mode). May 22 17:57:51 x200s ppp[3315]: tun0: Phase: bundle:
> Establish May 22 17:57:51 x200s ppp[3315]: tun0: Phase: deflink:
> closed -> opening May 22 17:57:51 x200s ppp[3315]: tun0: Phase:
> deflink: Connected! May 22 17:57:51 x200s ppp[3315]: tun0: Phase:
> deflink: opening -> dial May 22 17:57:51 x200s ppp[3315]: tun0: Chat:
> deflink: Dial attempt 1 of 1 May 22 17:57:51 x200s ppp[3315]: tun0:
> Chat: Send: AT\^M May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect
> (5): OK May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received:
> May 22 17:57:51 x200s last message repeated 2 times
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT\^M\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CFUN=1\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): OK
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CFUN=1\^M\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN?\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): +CPIN: READY
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CPIN?\^M\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: +CPIN: SIM PIN\^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
> May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Expect timeout
> May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN"****"\^M

Yep. Here's (one of) your problem(s). Your chat script is telling ppp
to expect "+CPIN: READY" but the device is actually sending
you "+CPIN: SIM PIN" so you get the dreaded "Expect timeout"

Your original chat line from above reads:
> AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\\"****"\\\"-OK \

It should read something like this:
> AT+CPIN? +CPIN:\\sSIM\\sPIN-AT+CPIN\\\"****"\\\"-OK \

As mentioned above, I do not know whether or not sending your PIN to the
device/carrier is necessary to unlock the device/account. Sometimes it
is necessary, and sometimes it is not necessary.

> May 22 17:57:56 x200s ppp[3315]: tun0: Phase: deflink: dial -> carrier
> May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: carrier -> login
> May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: login -> lcp
> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: FSM: Using "deflink" as a transport
> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change Initial --> Closed
> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change Closed --> Stopped
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: LayerStart
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: State change Stopped --> Req-Sent
> May 22 17:58:01 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1) state = Req-Sent
...
> May 22 17:58:37 x200s ppp[3315]: tun0: Phase: Signal 15, terminate.
> May 22 17:58:37 x200s ppp[3315]: tun0: Phase: PPP Terminated (normal).

The above made absolutely no sense to me until I realized you had an
extra double quote in your chat script which prevented it from dialing.

        jcr

--
The OpenBSD Journal - http://www.undeadly.org

Reply | Threaded
Open this post in threaded view
|

Re:

patrick kristensen
2010/5/23 J.C. Roberts <[hidden email]>:

> On Sat, 22 May 2010 22:08:57 +0200 patrick kristensen
> <[hidden email]> wrote:
>> Thanks for taking the time to answer and your fast replies.
>>
>
> Actually, ppp and TDMA/CDMA are nice break from the other headaches I've
> been trying to solve. ;)
>
> First of all, you either haven't mentioned the name of your service
> provider, or I forgot what it was. Either way, it matters.
>
> From what I can tell, you're in Spain, and I'm not familiar with the
> providers there.
>
> Ted Roby recently posted his config for Virgin Mobile:
> http://marc.info/?l=openbsd-tech&m=127285929411780&w=2
>
> The above may not help, but it's nice to see working examples.
>
>> In absence of cdce (using ue0 as ethernet interface (and minicom) to
>> connect to isp) i have tried several ppp and pppd configurations to
>> get a working internet connection on -release with no success.
>>
>> The following is my ppp (# ppp -auto movistar) and pppd (# pppd call
>> movistar) attempts.
>
> Since pppd(8) is in the kernel, it can be faster, but since ppp(8) is
> in userland, it can be much easier to work with when figuring things
> out. Once you figure out how to make things work with ppp(8), you can
> easily write a new config for pppd(8).
>
>
>>
>> /etc/ppp/ppp.conf  (appended to ppp.conf.sample)
>>
>> movistar:
>>       set device /dev/cuaU0
>>       set speed 460800
>>       set timeout 0
>>       set dial "ABORT BUSY TIMEOUT 5 \
>>               \"\" \
>>               AT OK-AT-OK \
>>               AT+CFUN=1 OK-AT-OK \
>>               AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\\"****"\\\"-OK \
>
> The above looks wrong. Not all wireless service providers and not
> all cellular wireless devices require using the Personal Identification
> Number (PIN) when making a connection. And worse, the responses you
> can get varies from device to device. (see below)
>
> Also, it is unwise to post your PIN to a public mailing list. It's not
> too dangerous without the IMEI and MEID device, but it's still not a
> good idea.
>
>>               AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK \
>
> The above is most likely wrong. The AT+CGDCONT= command sets the primary
> CONText of the device and the network it is attaching to. The first
> value argument states whether or not the device can be reconfigured (1),
> or cannot be reconfigured (3). The second argument is a string which
> defines the protocol used on the network. The third argument is also
> a string and it defines the Packet Data Network (PDN) name or Access
> Point Name (APN).
>
> As far as I know "movistar.es" is not the proper name of any Packet Data
> Network (PDN) or Access Point Name (APN). For example Virgin Mobile uses
> "VDATA" as the APN/PDN name, while AirTel uses "airtelgprs.com" as the name
> and of course, what your provider uses is unknown.
>
> You need to be careful with this setting since many providers have multiple
> data networks. With Verizon here in the silicon valley, I can choose from
> three different data networks (actually four if you count EVDO Rel. 0 as a
> different network than EVDO Rev. A).
>
>>               "ATDT*99***1#"
>>
>
> The above is wrong because it has no timeout or 'CONNECT'. Also, you should
> have noticed the leading double quote (") which is prematurely ending
> your chat script *BEFORE* the required number is dialed. The above should
be:
>
>        \\dATDT*99***1# TIMEOUT 30 CONNECT"
>
> The leading "\\d" gives a two second delay before calling. It may or may
not

> be necessary with your hardware/provider.
>
>>
>>       set mtu maximum 750
>
> The above is most likely wrong.
>
>>       resolv rewrite
>
> The above is often unnecessary to get things working, but rewriting
> /etc/resolv.conf is mostly a matter of personal choice/needs. The
> command you have below, namely `enable dns` should suffice.
>
>>       set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
>>       add default HISADDR
>>       enable dns
>>
>> #     ./.
>>
>>
>>
>> /var/log/ppp.log
>>
>> May 22 17:57:51 x200s ppp[8742]: Phase: Using interface: tun0
>> May 22 17:57:51 x200s ppp[8742]: Phase: deflink: Created in closed
>> state May 22 17:57:51 x200s ppp[8742]: tun0: Command: default: set
>> device /dev/cuaU0 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
>> default: set speed 460800 May 22 17:57:51 x200s ppp[8742]: tun0:
>> Command: default: set dial ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 ""
>> AT OK-AT-OK ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT
>> May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set
>> device /dev/cuaU0 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
>> movistar: set speed 460800 May 22 17:57:51 x200s ppp[8742]: tun0:
>> Command: movistar: set timeout 0 May 22 17:57:51 x200s ppp[8742]:
>> tun0: Command: movistar: set dial ABORT BUSY TIMEOUT 5
>>               ""              AT OK-AT-OK             AT
>> +CFUN=1 OK-AT-OK AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\"7291\\"-OK AT
>> +CGDCONT=1,\\"IP\\",\\"movistar.es\\" OK ATDT*99***1# May 22 17:57:51
>> x200s ppp[8742]: tun0: Command: movistar: set mtu maximum 750 May 22
>> 17:57:51 x200s ppp[8742]: tun0: Command: movistar: resolv rewrite May
>> 22 17:57:51 x200s ppp[8742]: tun0: IPCP: Primary nameserver set to
>> 255.255.255.255 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
>> movistar: set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
>> May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: add default
>> HISADDR May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar:
>> enable dns May 22 17:57:51 x200s ppp[3315]: tun0: Phase: PPP Started
>> (auto mode). May 22 17:57:51 x200s ppp[3315]: tun0: Phase: bundle:
>> Establish May 22 17:57:51 x200s ppp[3315]: tun0: Phase: deflink:
>> closed -> opening May 22 17:57:51 x200s ppp[3315]: tun0: Phase:
>> deflink: Connected! May 22 17:57:51 x200s ppp[3315]: tun0: Phase:
>> deflink: opening -> dial May 22 17:57:51 x200s ppp[3315]: tun0: Chat:
>> deflink: Dial attempt 1 of 1 May 22 17:57:51 x200s ppp[3315]: tun0:
>> Chat: Send: AT\^M May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect
>> (5): OK May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received:
>> May 22 17:57:51 x200s last message repeated 2 times
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT\^M\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CFUN=1\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): OK
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CFUN=1\^M\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN?\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): +CPIN: READY
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CPIN?\^M\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: +CPIN: SIM PIN\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
>> May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Expect timeout
>> May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN"****"\^M
>
> Yep. Here's (one of) your problem(s). Your chat script is telling ppp
> to expect "+CPIN: READY" but the device is actually sending
> you "+CPIN: SIM PIN" so you get the dreaded "Expect timeout"
>
> Your original chat line from above reads:
>>               AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\\"****"\\\"-OK \
>
> It should read something like this:
>>               AT+CPIN? +CPIN:\\sSIM\\sPIN-AT+CPIN\\\"****"\\\"-OK \
>
> As mentioned above, I do not know whether or not sending your PIN to the
> device/carrier is necessary to unlock the device/account. Sometimes it
> is necessary, and sometimes it is not necessary.
>
>> May 22 17:57:56 x200s ppp[3315]: tun0: Phase: deflink: dial -> carrier
>> May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: carrier -> login
>> May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: login -> lcp
>> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: FSM: Using "deflink" as a
transport
>> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change Initial
--> Closed
>> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change Closed
--> Stopped
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: LayerStart
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1) state
= Stopped
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: State change Stopped
--> Req-Sent
>> May 22 17:58:01 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1) state
= Req-Sent

> ...
>> May 22 17:58:37 x200s ppp[3315]: tun0: Phase: Signal 15, terminate.
>> May 22 17:58:37 x200s ppp[3315]: tun0: Phase: PPP Terminated (normal).
>
> The above made absolutely no sense to me until I realized you had an
> extra double quote in your chat script which prevented it from dialing.
>
>        jcr
>
> --
> The OpenBSD Journal - http://www.undeadly.org
>

I have managed to get a working connection with the following script


/etc/ppp/ppp.conf

default:
 set log Phase Chat LCP IPCP CCP tun command
 set device /dev/cuaU0
 set speed 460800
 set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \"\" AT OK-AT-OK
ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT"

esp:
        set device /dev/cuaU0
        set speed 460800
        set timeout 0
        set dial "ABORT BUSY TIMEOUT 5 \
                \"\" \
                AT OK-AT-OK \
                AT+CPIN=\\\"7291\\\" OK-AT-OK \
                AT+CFUN=1 OK-AT-OK \
                AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK-AT-OK \
                \\dATDT*99***1# TIMEOUT 30 CONNECT"


        set ifaddr 0 81.47.192.13 255.255.255.255
        add default HISADDR
        enable dns

# ./.

Setting 'set ifaddr to 0.0.0.0/0 0.0.0.0/0 255.255.255.255' gave me an
ipadress to MYADDR but i did not get a route.
Setting 'set ifaddr 0.0.0.0/0 194.179.1.100 (which was DNS)
255.255.255.255' made it possible to nslookup movistar.es.
After nslookup the APN and hardcoding the ip to HISADDR i got a
working connection.
The APN (Movistar (Telefonica) Spain) is correct
(http://www.vysoo.com/apn.php#415 and other sources). (I have not been
able to find other data networks for movistar as with your example
with Verizon)
This setup works so far (i can ping external addresses).
My understanding of ppp(8) is that it should have been enough to 'set
ifaddr 0 0 255.255.255.255 (0)' and 'add default HISADDR' (if the
CGDCONT is correct).
I appreciate any input on the script and log.


/var/log/ppp.log

May 24 00:56:20 x200s ppp[5489]: Phase: Using interface: tun0
May 24 00:56:20 x200s ppp[5489]: Phase: deflink: Created in closed state
May 24 00:56:20 x200s ppp[5489]: tun0: Command: default: set device
/dev/cuaU0
May 24 00:56:20 x200s ppp[5489]: tun0: Command: default: set speed 460800
May 24 00:56:20 x200s ppp[5489]: tun0: Command: default: set dial
ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK
\\dATDT\\T TIMEOUT 40 CONNECT
May 24 00:56:20 x200s ppp[5489]: tun0: Command: esp: set device /dev/cuaU0
May 24 00:56:20 x200s ppp[5489]: tun0: Command: esp: set speed 460800
May 24 00:56:20 x200s ppp[5489]: tun0: Command: esp: set timeout 0
May 24 00:56:20 x200s ppp[5489]: tun0: Command: esp: set dial ABORT
BUSY TIMEOUT 5 "" AT OK-AT-OK AT+CPIN=\\"7291\\" OK-AT-OK
                AT+CFUN=1 OK-AT-OK AT+CGDCONT=1,\\"IP\\",\\"movistar.es\\"
OK-AT-OK \\dATDT*99***1# TIMEOUT 30 CONNECT
May 24 00:56:20 x200s ppp[5489]: tun0: Command: esp: set ifaddr 0
81.47.192.13 255.255.255.255
May 24 00:56:20 x200s ppp[5489]: tun0: Command: esp: add default HISADDR
May 24 00:56:20 x200s ppp[5489]: tun0: Command: esp: enable dns
May 24 00:56:20 x200s ppp[14071]: tun0: Phase: PPP Started (auto mode).
May 24 00:56:20 x200s ppp[14071]: tun0: Phase: bundle: Establish
May 24 00:56:20 x200s ppp[14071]: tun0: Phase: deflink: closed -> opening
May 24 00:56:20 x200s ppp[14071]: tun0: Phase: deflink: Connected!
May 24 00:56:20 x200s ppp[14071]: tun0: Phase: deflink: opening -> dial
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: deflink: Dial attempt 1 of 1
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Send: AT\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Expect(5): OK
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Received: AT\^M\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Received: OK\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Send: AT+CPIN="7291"\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Expect(5): OK
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Received: AT+CPIN="7291"\^M\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Received: OK\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Send: AT+CFUN=1\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Expect(5): OK
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Received: AT+CFUN=1\^M\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Received: OK\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Send:
AT+CGDCONT=1,"IP","movistar.es"\^M
May 24 00:56:20 x200s ppp[14071]: tun0: Chat: Expect(5): OK
May 24 00:56:22 x200s ppp[14071]: tun0: Chat: Received:
AT+CGDCONT=1,"IP","movistar.es"\^M\^M
May 24 00:56:22 x200s ppp[14071]: tun0: Chat: Received: OK\^M
May 24 00:56:22 x200s ppp[14071]: tun0: Chat: Send: ATDT*99***1#\^M
May 24 00:56:24 x200s ppp[14071]: tun0: Chat: Expect(30): CONNECT
May 24 00:56:24 x200s ppp[14071]: tun0: Chat: Received:
ATDT*99***1#\^M~\M^?}#\M-@!}!}!} }9}#}%\M-B#}%}(}"}'}"}"}&} } } }
}%}&)\M^R\M^?f\M-.*~\^M
May 24 00:56:24 x200s ppp[14071]: tun0: Chat: Received: CONNECT\^M
May 24 00:56:24 x200s ppp[14071]: tun0: Phase: deflink: dial -> carrier
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: deflink: carrier -> login
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: deflink: login -> lcp
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: FSM: Using "deflink" as a
transport
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: State change
Initial --> Closed
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: State change
Closed --> Stopped
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: RecvConfigReq(2)
state = Stopped
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACFCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  PROTOCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MAGICNUM[6] 0x2992ff66
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: SendConfigReq(1)
state = Stopped
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACFCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  PROTOCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MRU[4] 1500
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MAGICNUM[6] 0x2c9987fd
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: SendConfigAck(2)
state = Stopped
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACFCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  PROTOCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MAGICNUM[6] 0x2992ff66
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: LayerStart
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: State change
Stopped --> Ack-Sent
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: RecvConfigReq(3)
state = Ack-Sent
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACFCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  PROTOCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MAGICNUM[6] 0x2992ff66
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: SendConfigAck(3)
state = Ack-Sent
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACFCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  PROTOCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MAGICNUM[6] 0x2992ff66
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: RecvConfigAck(1)
state = Ack-Sent
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACFCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  PROTOCOMP[2]
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MRU[4] 1500
May 24 00:56:25 x200s ppp[14071]: tun0: LCP:  MAGICNUM[6] 0x2c9987fd
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: State change
Ack-Sent --> Opened
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: LayerUp
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: bundle: Authenticate
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: deflink: his = CHAP
0x05, mine = none
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: Chap Input: CHALLENGE
(48 bytes from Kermit)
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: Chap Output: RESPONSE ()
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: Chap Input: SUCCESS
(Congratulations!)
May 24 00:56:25 x200s ppp[14071]: tun0: CCP: FSM: Using "deflink" as a
transport
May 24 00:56:25 x200s ppp[14071]: tun0: CCP: deflink: State change
Initial --> Closed
May 24 00:56:25 x200s ppp[14071]: tun0: CCP: deflink: LayerStart.
May 24 00:56:25 x200s ppp[14071]: tun0: CCP: MPPE: Not usable without CHAP81
May 24 00:56:25 x200s ppp[14071]: tun0: CCP: deflink: SendConfigReq(1)
state = Closed
May 24 00:56:25 x200s ppp[14071]: tun0: CCP:  DEFLATE[4] win 15
May 24 00:56:25 x200s ppp[14071]: tun0: CCP:  PRED1[2]
May 24 00:56:25 x200s ppp[14071]: tun0: CCP: deflink: State change
Closed --> Req-Sent
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: deflink: lcp -> open
May 24 00:56:25 x200s ppp[14071]: tun0: Phase: bundle: Network
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP: FSM: Using "deflink" as
a transport
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP: deflink: State change
Initial --> Closed
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP: deflink: LayerStart.
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigReq(1) state = Closed
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.101
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 00:56:25 x200s ppp[14071]: tun0: IPCP: deflink: State change
Closed --> Req-Sent
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink:
RecvProtocolRej(1) state = Opened
May 24 00:56:25 x200s ppp[14071]: tun0: LCP: deflink: -- Protocol
0x80fd (Compression Control Protocol) was rejected!
May 24 00:56:25 x200s ppp[14071]: tun0: CCP: deflink: State change
Req-Sent --> Stopped
May 24 00:56:28 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigReq(1) state = Req-Sent
May 24 00:56:28 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 00:56:28 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:28 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.101
May 24 00:56:28 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 00:56:31 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigReq(1) state = Req-Sent
May 24 00:56:31 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 00:56:31 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:31 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.101
May 24 00:56:31 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 00:56:34 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigReq(1) state = Req-Sent
May 24 00:56:34 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 00:56:34 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:34 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.101
May 24 00:56:34 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 00:56:37 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigReq(1) state = Req-Sent
May 24 00:56:37 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 00:56:37 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:37 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.101
May 24 00:56:37 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 00:56:40 x200s ppp[14071]: tun0: IPCP: deflink: LayerFinish.
May 24 00:56:40 x200s ppp[14071]: tun0: IPCP: Connect time: 15 secs: 0
octets in, 0 octets out
May 24 00:56:40 x200s ppp[14071]: tun0: IPCP: 0 packets in, 0 packets out
May 24 00:56:40 x200s ppp[14071]: tun0: IPCP:  total 0 bytes/sec, peak
0 bytes/sec on Mon May 24 00:56:25 2010
May 24 00:56:40 x200s ppp[14071]: tun0: IPCP: deflink: State change
Req-Sent --> Stopped
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
RecvConfigReq(1) state = Stopped
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:   [EMPTY]
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigReq(1) state = Stopped
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.101
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigNak(1) state = Stopped
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 81.47.192.13
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink: LayerStart.
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink: State change
Stopped --> Req-Sent
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
RecvConfigNak(1) state = Req-Sent
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 95.124.29.225
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] changing
address: 0.0.0.0  --> 95.124.29.225
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.100
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 194.179.1.101
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: Primary nameserver set
to 194.179.1.100
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: Secondary nameserver set
to 194.179.1.101
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigReq(2) state = Req-Sent
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 95.124.29.225
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.100
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 194.179.1.101
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
RecvConfigReq(2) state = Req-Sent
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:   [EMPTY]
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigNak(2) state = Req-Sent
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 81.47.192.13
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
RecvConfigAck(2) state = Req-Sent
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  IPADDR[6] 95.124.29.225
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  COMPPROTO[6] 16 VJ
slots with slot compression
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  PRIDNS[6] 194.179.1.100
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:  SECDNS[6] 194.179.1.101
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink: State change
Req-Sent --> Ack-Rcvd
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
RecvConfigReq(3) state = Ack-Rcvd
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:   [EMPTY]
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink:
SendConfigAck(3) state = Ack-Rcvd
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP:   [EMPTY]
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink: State change
Ack-Rcvd --> Opened
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: deflink: LayerUp.
May 24 00:56:58 x200s ppp[14071]: tun0: IPCP: myaddr 95.124.29.225
hisaddr = 81.47.192.13
May 24 00:56:58 x200s ppp[14071]: tun0: Warning: 0.0.0.0: Change route
failed: errno: No such process
May 24 00:56:58 x200s ppp[14071]: tun0: Warning: ff01:6::: Change
route failed: errno: Network is unreachable
May 24 00:56:58 x200s ppp[14071]: tun0: Warning: ff02:6::: Change
route failed: errno: Network is unreachable
May 24 00:56:58 x200s ppp[14071]: tun0: Warning: ff02:6::: Change
route failed: errno: Network is unreachable
May 24 01:00:20 x200s ppp[14071]: tun0: Phase: Signal 15, terminate.
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: deflink: LayerDown:
95.124.29.225
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: deflink:
SendTerminateReq(3) state = Opened
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: deflink: State change
Opened --> Closing
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: deflink:
RecvTerminateAck(3) state = Closing
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: deflink: LayerFinish.
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: Connect time: 202 secs:
5977 octets in, 4063 octets out
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: 64 packets in, 75 packets out
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP:  total 49 bytes/sec,
peak 416 bytes/sec on Mon May 24 00:58:29 2010
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: deflink: State change
Closing --> Closed
May 24 01:00:20 x200s ppp[14071]: tun0: Phase: bundle: Terminate
May 24 01:00:20 x200s ppp[14071]: tun0: CCP: deflink: State change
Stopped --> Closed
May 24 01:00:20 x200s ppp[14071]: tun0: CCP: deflink: State change
Closed --> Initial
May 24 01:00:20 x200s ppp[14071]: tun0: LCP: deflink: LayerDown
May 24 01:00:20 x200s ppp[14071]: tun0: LCP: deflink:
SendTerminateReq(2) state = Opened
May 24 01:00:20 x200s ppp[14071]: tun0: LCP: deflink: State change
Opened --> Closing
May 24 01:00:20 x200s ppp[14071]: tun0: Phase: deflink: open -> lcp
May 24 01:00:20 x200s ppp[14071]: tun0: Warning: 0.0.0.0: Change route
failed: errno: No such process
May 24 01:00:20 x200s ppp[14071]: tun0: Warning: ff01:6::: Change
route failed: errno: Network is unreachable
May 24 01:00:20 x200s ppp[14071]: tun0: Warning: ff02:6::: Change
route failed: errno: Network is unreachable
May 24 01:00:20 x200s ppp[14071]: tun0: Warning: ff02:6::: Change
route failed: errno: Network is unreachable
May 24 01:00:20 x200s ppp[14071]: tun0: IPCP: deflink: State change
Closed --> Initial
May 24 01:00:20 x200s ppp[14071]: tun0: LCP: deflink:
RecvTerminateAck(2) state = Closing
May 24 01:00:20 x200s ppp[14071]: tun0: LCP: deflink: LayerFinish
May 24 01:00:20 x200s ppp[14071]: tun0: LCP: deflink: State change
Closing --> Closed
May 24 01:00:20 x200s ppp[14071]: tun0: LCP: deflink: State change
Closed --> Initial
May 24 01:00:20 x200s ppp[14071]: tun0: Phase: deflink: Disconnected!
May 24 01:00:20 x200s ppp[14071]: tun0: Phase: deflink: lcp -> logout
May 24 01:00:20 x200s ppp[14071]: tun0: Phase: deflink: logout -> hangup
May 24 01:00:20 x200s ppp[14071]: tun0: Phase: deflink: Disconnected!
May 24 01:00:21 x200s ppp[14071]: tun0: Phase: deflink: Connect time:
241 secs: 6484 octets in, 5053 octets out
May 24 01:00:21 x200s ppp[14071]: tun0: Phase: deflink: 82 packets in,
97 packets out
May 24 01:00:21 x200s ppp[14071]: tun0: Phase:  total 47 bytes/sec,
peak 444 bytes/sec on Mon May 24 00:58:29 2010
May 24 01:00:21 x200s ppp[14071]: tun0: Phase: deflink: hangup -> closed
May 24 01:00:21 x200s ppp[14071]: tun0: Phase: bundle: Dead
May 24 01:00:21 x200s ppp[14071]: tun0: Phase: PPP Terminated (normal).

Reply | Threaded
Open this post in threaded view
|

Re:

J.C. Roberts-3
On Mon, 24 May 2010 00:00:07 +0200 patrick kristensen
<[hidden email]> wrote:

> I have managed to get a working connection with the following script
>
>
> /etc/ppp/ppp.conf
>
> default:
>  set log Phase Chat LCP IPCP CCP tun command
>  set device /dev/cuaU0
>  set speed 460800
>  set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \"\" AT OK-AT-OK
> ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT"
>
> esp:
> set device /dev/cuaU0
> set speed 460800
> set timeout 0
> set dial "ABORT BUSY TIMEOUT 5 \
> \"\" \
> AT OK-AT-OK \
> AT+CPIN=\\\"7291\\\" OK-AT-OK \
> AT+CFUN=1 OK-AT-OK \
> AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK-AT-OK \
> \\dATDT*99***1# TIMEOUT 30 CONNECT"
>
>
> set ifaddr 0 81.47.192.13 255.255.255.255
> add default HISADDR
> enable dns
>
> # ./.
>
> Setting 'set ifaddr to 0.0.0.0/0 0.0.0.0/0 255.255.255.255' gave me an
> ipadress to MYADDR but i did not get a route.
> Setting 'set ifaddr 0.0.0.0/0 194.179.1.100 (which was DNS)
> 255.255.255.255' made it possible to nslookup movistar.es.
> After nslookup the APN and hardcoding the ip to HISADDR i got a
> working connection.
> The APN (Movistar (Telefonica) Spain) is correct
> (http://www.vysoo.com/apn.php#415 and other sources). (I have not been
> able to find other data networks for movistar as with your example
> with Verizon)
> This setup works so far (i can ping external addresses).
> My understanding of ppp(8) is that it should have been enough to 'set
> ifaddr 0 0 255.255.255.255 (0)' and 'add default HISADDR' (if the
> CGDCONT is correct).
> I appreciate any input on the script and log.

It seems your routing is hosed. As the ppp(8) manual states, if you
use "add" it will not overwrite your default route (typically stored
in /etc/mygate). When you want to overwrite the default route, you need
to use "add!" such as:

    add! default HISADDR

Typically, you want to overwrite the default route, but note, you'll
probably see some harmless warnings for routes that ppp cannot
overwrite (such as IPv6 when it's not supported by your provider).

As for setting up the interface addresses, you should define all four
parts, rather than defining only three as you have done above.

    set ifaddr 10.0.0.1/0 10.0.0.2/0 0.0.0.0 0.0.0.0
               part#1     part#2     part#3  part#4

In your script above, your part#1 of "0" is *DEMANDING* that your
address be 0.0.0.0/32 and nothing else, or in other words, you are
*DEMANDING* that you become the default route for the remote system.
Needless to say the remote system will just laugh at you and refuse
to change it's default route (i.e. address your end as 0.0.0.0).

Setting the netmask (part#3) to 0.0.0.0 forces ppp to assign an
appropriate netmask. Since it is a point-to-point link and some
operating systems/kernels do not understand a POINTTOPOINT netmask,
you'll typically end up with 255.255.255.255 or 255.255.255.0 for the
netmask of your tun0 interface *even* if the remote gateway address is
outside of the netmask.

Using part#4 is important. This the address you *SUGGEST* that your
side should be, but you *DEMAND* your side gets and address defined by
part#1 (the /0 netmask on part#1 says any IP address).

Additionally, part#4 is also the "trigger" address when using '-auto'
mode to connect or reconnect.

Lastly, there's no point in defining 'device' 'speed' and 'dial' in the
"default:" section of your config file since you are redefining them in
the "esp:" section.

Once you have the above corrected, look at your CHAP settings. Though
you were able to negotiate IP addresses (according to the log), it
seems your provider wanted to use CHAP authentication. If you made the
previous corrections and you still cannot connect, then you may need
to use CHAP:

        set authname myusername
        set authkey mypassword
        set login

Not all providers require PAP/CHAP authentication through 'authname'
'authkey' and 'login' because the real authentication is being done by
device identifiers (MEID and/or IMEI).

        jcr

--
The OpenBSD Journal - http://www.undeadly.org

Reply | Threaded
Open this post in threaded view
|

Re:

patrick kristensen
2010/5/24 J.C. Roberts <[hidden email]>:

> On Mon, 24 May 2010 00:00:07 +0200 patrick kristensen
> <[hidden email]> wrote:
>> I have managed to get a working connection with the following script
>>
>>
>> /etc/ppp/ppp.conf
>>
>> default:
>>  set log Phase Chat LCP IPCP CCP tun command
>>  set device /dev/cuaU0
>>  set speed 460800
>>  set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \"\" AT OK-AT-OK
>> ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT"
>>
>> esp:
>>       set device /dev/cuaU0
>>       set speed 460800
>>       set timeout 0
>>       set dial "ABORT BUSY TIMEOUT 5 \
>>               \"\" \
>>               AT OK-AT-OK \
>>               AT+CPIN=\\\"7291\\\" OK-AT-OK \
>>               AT+CFUN=1 OK-AT-OK \
>>               AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK-AT-OK \
>>               \\dATDT*99***1# TIMEOUT 30 CONNECT"
>>
>>
>>       set ifaddr 0 81.47.192.13 255.255.255.255
>>       add default HISADDR
>>       enable dns
>>
>> #     ./.
>>
>> Setting 'set ifaddr to 0.0.0.0/0 0.0.0.0/0 255.255.255.255' gave me an
>> ipadress to MYADDR but i did not get a route.
>> Setting 'set ifaddr 0.0.0.0/0 194.179.1.100 (which was DNS)
>> 255.255.255.255' made it possible to nslookup movistar.es.
>> After nslookup the APN and hardcoding the ip to HISADDR i got a
>> working connection.
>> The APN (Movistar (Telefonica) Spain) is correct
>> (http://www.vysoo.com/apn.php#415 and other sources). (I have not been
>> able to find other data networks for movistar as with your example
>> with Verizon)
>> This setup works so far (i can ping external addresses).
>> My understanding of ppp(8) is that it should have been enough to 'set
>> ifaddr 0 0 255.255.255.255 (0)' and 'add default HISADDR' (if the
>> CGDCONT is correct).
>> I appreciate any input on the script and log.
>
> It seems your routing is hosed. As the ppp(8) manual states, if you
> use "add" it will not overwrite your default route (typically stored
> in /etc/mygate). When you want to overwrite the default route, you need
> to use "add!" such as:
>
>    add! default HISADDR
>
> Typically, you want to overwrite the default route, but note, you'll
> probably see some harmless warnings for routes that ppp cannot
> overwrite (such as IPv6 when it's not supported by your provider).
>
> As for setting up the interface addresses, you should define all four
> parts, rather than defining only three as you have done above.
>
>    set ifaddr 10.0.0.1/0 10.0.0.2/0 0.0.0.0 0.0.0.0
>               part#1     part#2     part#3  part#4
>
> In your script above, your part#1 of "0" is *DEMANDING* that your
> address be 0.0.0.0/32 and nothing else, or in other words, you are
> *DEMANDING* that you become the default route for the remote system.
> Needless to say the remote system will just laugh at you and refuse
> to change it's default route (i.e. address your end as 0.0.0.0).
>
> Setting the netmask (part#3) to 0.0.0.0 forces ppp to assign an
> appropriate netmask. Since it is a point-to-point link and some
> operating systems/kernels do not understand a POINTTOPOINT netmask,
> you'll typically end up with 255.255.255.255 or 255.255.255.0 for the
> netmask of your tun0 interface *even* if the remote gateway address is
> outside of the netmask.
>
> Using part#4 is important. This the address you *SUGGEST* that your
> side should be, but you *DEMAND* your side gets and address defined by
> part#1 (the /0 netmask on part#1 says any IP address).
>
> Additionally, part#4 is also the "trigger" address when using '-auto'
> mode to connect or reconnect.
>
> Lastly, there's no point in defining 'device' 'speed' and 'dial' in the
> "default:" section of your config file since you are redefining them in
> the "esp:" section.
>
> Once you have the above corrected, look at your CHAP settings. Though
> you were able to negotiate IP addresses (according to the log), it
> seems your provider wanted to use CHAP authentication. If you made the
> previous corrections and you still cannot connect, then you may need
> to use CHAP:
>
>        set authname myusername
>        set authkey mypassword
>        set login
>
> Not all providers require PAP/CHAP authentication through 'authname'
> 'authkey' and 'login' because the real authentication is being done by
> device identifiers (MEID and/or IMEI).
>
>        jcr
>
> --
> The OpenBSD Journal - http://www.undeadly.org
>

I used the 'add! default' and the 'TRIGGER ADDR' in several attempts
but removed them when they didnt seem to change anything, however i
understand that they should be there.

Setting 'set ifaddr 0.0.0.0/0 0.0.0.0-255.255.255.254 0.0.0.0 0.0.0.0'
works however i can still not set HISADDR to '0.0.0.0/0' to get an
ipaddres offer to HISADDR. I assume setting a range has the same
affect as setting HISADDR with changeable bits but i dont understand
why 0.0.0.0/0 or any variation doesnt give me an address.

These set ifaddr does not work
0.0.0.0/0 0.0.0.0/0 0.0.0.0 0.0.0.0
0.0.0.0/0 0.0.0.0/32 0.0.0.0 0.0.0.0
0.0.0.0 0.0.0.0 0.0.0.0.0 0.0.0.0
0.0.0.0/0 0.0.0.0/0 0.0.0.0 0.0.0.0/0
etc

These works
0.0.0.0/0 81.47.192.13 0.0.0.0 0.0.0.0
0.0.0.0/0 0.0.0.0-255.255.255.254 0.0.0.0 0.0.0.0


/etc/ppp/ppp.conf

default:
 set log Phase Chat LCP IPCP CCP tun command

esp:
        set device /dev/cuaU0
        set speed 460800
        set timeout 0
        set authname movistar
        set authkey movistar
        set login
        set dial "ABORT BUSY TIMEOUT 5 \
                \"\" \
                AT OK-AT-OK \
                AT+CPIN=\\\"7291\\\" OK-AT-OK \
                AT+CFUN=1 OK-AT-OK \
                AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK-AT-OK \
                \\dATDT*99***1# TIMEOUT 30 CONNECT"


        set ifaddr 0.0.0.0/0 0.0.0.0-255.255.255.254 0.0.0.0 0.0.0.0
        add! default HISADDR
        enable dns

# ./.

/var/log/ppp.log

May 24 15:58:04 x200s ppp[1494]: Phase: Using interface: tun0
May 24 15:58:04 x200s ppp[1494]: Phase: deflink: Created in closed state
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set device /dev/cuaU0
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set speed 460800
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set timeout 0
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set authname movistar
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set authkey ********
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set login
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set dial ABORT
BUSY TIMEOUT 5 "" AT OK-AT-OK AT+CPIN=\\"7291\\" OK-AT-OK
                AT+CFUN=1 OK-AT-OK AT+CGDCONT=1,\\"IP\\",\\"movistar.es\\"
OK-AT-OK \\dATDT*99***1# TIMEOUT 30 CONNECT
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: set ifaddr
0.0.0.0/0 0.0.0.0-255.255.255.254 0.0.0.0 0.0.0.0
May 24 15:58:04 x200s ppp[1494]: tun0: IPCP: Selected IP address 88.161.80.31
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: add default HISADDR
May 24 15:58:04 x200s ppp[1494]: tun0: Command: esp: enable dns
May 24 15:58:04 x200s ppp[6277]: tun0: Phase: PPP Started (auto mode).
May 24 15:58:04 x200s ppp[6277]: tun0: Phase: bundle: Establish
May 24 15:58:04 x200s ppp[6277]: tun0: Phase: deflink: closed -> opening
May 24 15:58:04 x200s ppp[6277]: tun0: Phase: deflink: Connected!
May 24 15:58:04 x200s ppp[6277]: tun0: Phase: deflink: opening -> dial
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: deflink: Dial attempt 1 of 1
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Send: AT\^M
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Expect(5): OK
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Received: \^M
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Received: *EMRDY: 1\^M
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Received: AT\^M\^M
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Received: OK\^M
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Send: AT+CPIN="7291"\^M
May 24 15:58:04 x200s ppp[6277]: tun0: Chat: Expect(5): OK
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Received: AT+CPIN="7291"\^M\^M
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Received: OK\^M
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Send: AT+CFUN=1\^M
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Expect(5): OK
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Received: AT+CFUN=1\^M\^M
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Received: OK\^M
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Send:
AT+CGDCONT=1,"IP","movistar.es"\^M
May 24 15:58:05 x200s ppp[6277]: tun0: Chat: Expect(5): OK
May 24 15:58:06 x200s ppp[6277]: tun0: Chat: Received:
AT+CGDCONT=1,"IP","movistar.es"\^M\^M
May 24 15:58:06 x200s ppp[6277]: tun0: Chat: Received: OK\^M
May 24 15:58:06 x200s ppp[6277]: tun0: Chat: Send: ATDT*99***1#\^M
May 24 15:58:08 x200s ppp[6277]: tun0: Chat: Expect(30): CONNECT
May 24 15:58:08 x200s ppp[6277]: tun0: Chat: Received:
ATDT*99***1#\^M~\M^?}#\M-@!}!}!} }9}#}%\M-B#}%}(}"}'}"}"}&} } } }
}%}&\M-*\M-A&\M-KF\M-8~\^M
May 24 15:58:08 x200s ppp[6277]: tun0: Chat: Received: CONNECT\^M
May 24 15:58:08 x200s ppp[6277]: tun0: Phase: deflink: dial -> carrier
May 24 15:58:09 x200s ppp[6277]: tun0: Phase: deflink: carrier -> login
May 24 15:58:09 x200s ppp[6277]: tun0: Phase: deflink: login -> lcp
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: FSM: Using "deflink" as a
transport
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: State change
Initial --> Closed
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: State change
Closed --> Stopped
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: RecvConfigReq(2)
state = Stopped
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACFCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  PROTOCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MAGICNUM[6] 0xaac126cb
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: SendConfigReq(1)
state = Stopped
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACFCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  PROTOCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MRU[4] 1500
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MAGICNUM[6] 0x2adc6148
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: SendConfigAck(2)
state = Stopped
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACFCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  PROTOCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MAGICNUM[6] 0xaac126cb
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: LayerStart
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: State change
Stopped --> Ack-Sent
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: RecvConfigReq(3)
state = Ack-Sent
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACFCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  PROTOCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MAGICNUM[6] 0xaac126cb
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: SendConfigAck(3)
state = Ack-Sent
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACFCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  PROTOCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MAGICNUM[6] 0xaac126cb
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: RecvConfigAck(1)
state = Ack-Sent
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACFCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  PROTOCOMP[2]
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MRU[4] 1500
May 24 15:58:09 x200s ppp[6277]: tun0: LCP:  MAGICNUM[6] 0x2adc6148
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: State change
Ack-Sent --> Opened
May 24 15:58:09 x200s ppp[6277]: tun0: LCP: deflink: LayerUp
May 24 15:58:09 x200s ppp[6277]: tun0: Phase: bundle: Authenticate
May 24 15:58:09 x200s ppp[6277]: tun0: Phase: deflink: his = CHAP
0x05, mine = none
May 24 15:58:09 x200s ppp[6277]: tun0: Phase: Chap Input: CHALLENGE
(34 bytes from Kermit)
May 24 15:58:09 x200s ppp[6277]: tun0: Phase: Chap Output: RESPONSE
(movistar)
May 24 15:58:09 x200s ppp[6277]: tun0: Phase: Chap Input: SUCCESS
(Congratulations!)
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP: Using trigger address 0.0.0.0
May 24 15:58:18 x200s ppp[6277]: tun0: CCP: FSM: Using "deflink" as a
transport
May 24 15:58:18 x200s ppp[6277]: tun0: CCP: deflink: State change
Initial --> Closed
May 24 15:58:18 x200s ppp[6277]: tun0: CCP: deflink: LayerStart.
May 24 15:58:18 x200s ppp[6277]: tun0: CCP: MPPE: Not usable without CHAP81
May 24 15:58:18 x200s ppp[6277]: tun0: CCP: deflink: SendConfigReq(1)
state = Closed
May 24 15:58:18 x200s ppp[6277]: tun0: CCP:  DEFLATE[4] win 15
May 24 15:58:18 x200s ppp[6277]: tun0: CCP:  PRED1[2]
May 24 15:58:18 x200s ppp[6277]: tun0: CCP: deflink: State change
Closed --> Req-Sent
May 24 15:58:18 x200s ppp[6277]: tun0: Phase: deflink: lcp -> open
May 24 15:58:18 x200s ppp[6277]: tun0: Phase: bundle: Network
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP: FSM: Using "deflink" as a
transport
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP: deflink: State change
Initial --> Closed
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP: deflink: LayerStart.
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigReq(1)
state = Closed
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.61.250
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 15:58:18 x200s ppp[6277]: tun0: IPCP: deflink: State change
Closed --> Req-Sent
May 24 15:58:18 x200s ppp[6277]: tun0: LCP: deflink:
RecvProtocolRej(1) state = Opened
May 24 15:58:18 x200s ppp[6277]: tun0: LCP: deflink: -- Protocol
0x80fd (Compression Control Protocol) was rejected!
May 24 15:58:18 x200s ppp[6277]: tun0: CCP: deflink: State change
Req-Sent --> Stopped
May 24 15:58:21 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigReq(1)
state = Req-Sent
May 24 15:58:21 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 15:58:21 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:58:21 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.61.250
May 24 15:58:21 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 15:58:24 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigReq(1)
state = Req-Sent
May 24 15:58:24 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 15:58:24 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:58:24 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.61.250
May 24 15:58:24 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 15:58:27 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigReq(1)
state = Req-Sent
May 24 15:58:27 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 15:58:27 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:58:27 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.61.250
May 24 15:58:27 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 15:58:30 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigReq(1)
state = Req-Sent
May 24 15:58:30 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 15:58:30 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:58:30 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.61.250
May 24 15:58:30 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 15:58:34 x200s ppp[6277]: tun0: IPCP: deflink: LayerFinish.
May 24 15:58:34 x200s ppp[6277]: tun0: IPCP: Connect time: 16 secs: 0
octets in, 0 octets out
May 24 15:58:34 x200s ppp[6277]: tun0: IPCP: 0 packets in, 0 packets out
May 24 15:58:34 x200s ppp[6277]: tun0: IPCP:  total 0 bytes/sec, peak
0 bytes/sec on Mon May 24 15:58:18 2010
May 24 15:58:34 x200s ppp[6277]: tun0: IPCP: deflink: State change
Req-Sent --> Stopped
May 24 15:58:44 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigReq(1)
state = Stopped
May 24 15:58:44 x200s ppp[6277]: tun0: IPCP: 0.0.0.0: Address invalid
or already in use
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigReq(1)
state = Stopped
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.61.250
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigNak(1)
state = Stopped
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 88.161.80.31
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP: deflink: LayerStart.
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP: deflink: State change
Stopped --> Req-Sent
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigReq(2)
state = Req-Sent
May 24 15:58:53 x200s ppp[6277]: tun0: IPCP: 0.0.0.0: Address invalid
or already in use
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigNak(2)
state = Req-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 88.161.80.31
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigReq(3)
state = Req-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigAck(3)
state = Req-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: State change
Req-Sent --> Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigReq(4)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigAck(4)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigReq(5)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigAck(5)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigReq(6)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigAck(6)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigReq(7)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigAck(7)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:   [EMPTY]
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigNak(1)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 88.28.33.87
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] changing
address: 0.0.0.0  --> 88.28.33.87
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.4.97
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 80.58.61.250
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: Primary nameserver set to
80.58.4.97
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: Secondary nameserver set
to 80.58.61.250
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: SendConfigReq(2)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 88.28.33.87
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.4.97
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 80.58.61.250
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: RecvConfigAck(2)
state = Ack-Sent
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  IPADDR[6] 88.28.33.87
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  PRIDNS[6] 80.58.4.97
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP:  SECDNS[6] 80.58.61.250
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: State change
Ack-Sent --> Opened
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: deflink: LayerUp.
May 24 15:59:03 x200s ppp[6277]: tun0: IPCP: myaddr 88.28.33.87
hisaddr = 88.161.80.31
May 24 15:59:03 x200s ppp[6277]: tun0: Warning: 0.0.0.0: Change route
failed: errno: No such process
May 24 15:59:03 x200s ppp[6277]: tun0: Warning: ff01:6::: Change route
failed: errno: Network is unreachable
May 24 15:59:03 x200s ppp[6277]: tun0: Warning: ff02:6::: Change route
failed: errno: Network is unreachable
May 24 15:59:03 x200s ppp[6277]: tun0: Warning: ff02:6::: Change route
failed: errno: Network is unreachable



using HISADDR 0.0.0.0/0
/var/log/ppp.log

May 24 16:02:03 x200s ppp[18052]: Phase: Using interface: tun0
May 24 16:02:03 x200s ppp[18052]: Phase: deflink: Created in closed state
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set device /dev/cuaU0
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set speed 460800
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set timeout 0
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set authname movistar
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set authkey ********
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set login
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set dial ABORT
BUSY TIMEOUT 5 "" AT OK-AT-OK AT+CPIN=\\"7291\\" OK-AT-OK
                AT+CFUN=1 OK-AT-OK AT+CGDCONT=1,\\"IP\\",\\"movistar.es\\"
OK-AT-OK \\dATDT*99***1# TIMEOUT 30 CONNECT
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: set ifaddr
0.0.0.0/0 0.0.0.0/0 0.0.0.0 0.0.0.0
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: add default HISADDR
May 24 16:02:03 x200s ppp[18052]: tun0: Command: esp: enable dns
May 24 16:02:03 x200s ppp[8641]: tun0: Phase: PPP Started (auto mode).
May 24 16:02:03 x200s ppp[8641]: tun0: Phase: bundle: Establish
May 24 16:02:03 x200s ppp[8641]: tun0: Phase: deflink: closed -> opening
May 24 16:02:03 x200s ppp[8641]: tun0: Phase: deflink: Connected!
May 24 16:02:03 x200s ppp[8641]: tun0: Phase: deflink: opening -> dial
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: deflink: Dial attempt 1 of 1
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Send: AT\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Expect(5): OK
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: \^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: *EMRDY: 1\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: AT\^M\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: OK\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Send: AT+CPIN="7291"\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Expect(5): OK
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: AT+CPIN="7291"\^M\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: OK\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Send: AT+CFUN=1\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Expect(5): OK
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: AT+CFUN=1\^M\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Received: OK\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Send:
AT+CGDCONT=1,"IP","movistar.es"\^M
May 24 16:02:03 x200s ppp[8641]: tun0: Chat: Expect(5): OK
May 24 16:02:05 x200s ppp[8641]: tun0: Chat: Received:
AT+CGDCONT=1,"IP","movistar.es"\^M\^M
May 24 16:02:05 x200s ppp[8641]: tun0: Chat: Received: OK\^M
May 24 16:02:05 x200s ppp[8641]: tun0: Chat: Send: ATDT*99***1#\^M
May 24 16:02:07 x200s ppp[8641]: tun0: Chat: Expect(30): CONNECT
May 24 16:02:07 x200s ppp[8641]: tun0: Chat: Received:
ATDT*99***1#\^M~\M^?}#\M-@!}!}!} }9}#}%\M-B#}%}(}"}'}"}"}&} } } }
}%}&}6}^w\M-Y\M-Ww~\^M
May 24 16:02:07 x200s ppp[8641]: tun0: Chat: Received: CONNECT\^M
May 24 16:02:07 x200s ppp[8641]: tun0: Phase: deflink: dial -> carrier
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: deflink: carrier -> login
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: deflink: login -> lcp
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: FSM: Using "deflink" as a
transport
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: State change
Initial --> Closed
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: State change
Closed --> Stopped
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: RecvConfigReq(2)
state = Stopped
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACFCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  PROTOCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MAGICNUM[6] 0x167e77d9
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: SendConfigReq(1)
state = Stopped
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACFCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  PROTOCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MRU[4] 1500
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MAGICNUM[6] 0x0c1c002c
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: SendConfigAck(2)
state = Stopped
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACFCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  PROTOCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MAGICNUM[6] 0x167e77d9
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: LayerStart
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: State change
Stopped --> Ack-Sent
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: RecvConfigReq(3)
state = Ack-Sent
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACFCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  PROTOCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MAGICNUM[6] 0x167e77d9
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: SendConfigAck(3)
state = Ack-Sent
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACFCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  PROTOCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MAGICNUM[6] 0x167e77d9
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: RecvConfigAck(1)
state = Ack-Sent
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACFCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  PROTOCOMP[2]
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  ACCMAP[6] 0x00000000
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MRU[4] 1500
May 24 16:02:08 x200s ppp[8641]: tun0: LCP:  MAGICNUM[6] 0x0c1c002c
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: State change
Ack-Sent --> Opened
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: LayerUp
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: bundle: Authenticate
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: deflink: his = CHAP
0x05, mine = none
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: Chap Input: CHALLENGE
(52 bytes from Kermit)
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: Chap Output: RESPONSE
(movistar)
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: Chap Input: SUCCESS
(Congratulations!)
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: Using trigger address 0.0.0.0
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: FSM: Using "deflink" as a
transport
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: deflink: State change
Initial --> Closed
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: deflink: LayerStart.
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: MPPE: Not usable without CHAP81
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: deflink: SendConfigReq(1)
state = Closed
May 24 16:02:08 x200s ppp[8641]: tun0: CCP:  DEFLATE[4] win 15
May 24 16:02:08 x200s ppp[8641]: tun0: CCP:  PRED1[2]
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: deflink: State change
Closed --> Req-Sent
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: deflink: lcp -> open
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: bundle: Network
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: FSM: Using "deflink" as a
transport
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: deflink: State change
Initial --> Closed
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: deflink: LayerStart.
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: deflink: SendConfigReq(1)
state = Closed
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP:  IPADDR[6] 0.0.0.0
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots
with slot compression
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP:  PRIDNS[6] 80.58.61.250
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP:  SECDNS[6] 255.255.255.255
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: deflink: State change
Closed --> Req-Sent
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink:
RecvProtocolRej(1) state = Opened
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: -- Protocol
0x80fd (Compression Control Protocol) was rejected!
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: deflink: State change
Req-Sent --> Stopped
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink:
RecvTerminateReq(1) state = Opened
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: LayerDown
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink:
SendTerminateAck(1) state = Opened
May 24 16:02:08 x200s ppp[8641]: tun0: LCP: deflink: State change
Opened --> Stopping
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: deflink: State change
Stopped --> Closed
May 24 16:02:08 x200s ppp[8641]: tun0: CCP: deflink: State change
Closed --> Initial
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: deflink: open -> lcp
May 24 16:02:08 x200s ppp[8641]: tun0: Warning: ff01:6::: Change route
failed: errno: Network is unreachable
May 24 16:02:08 x200s ppp[8641]: tun0: Warning: ff02:6::: Change route
failed: errno: Network is unreachable
May 24 16:02:08 x200s ppp[8641]: tun0: Warning: ff02:6::: Change route
failed: errno: Network is unreachable
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: deflink: State change
Req-Sent --> Starting
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: deflink: LayerFinish.
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: Connect time: 0 secs: 0
octets in, 0 octets out
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: 0 packets in, 0 packets out
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP:  total 0 bytes/sec, peak
0 bytes/sec on Mon May 24 16:02:08 2010
May 24 16:02:08 x200s ppp[8641]: tun0: IPCP: deflink: State change
Starting --> Initial
May 24 16:02:08 x200s ppp[8641]: tun0: Phase: bundle: Terminate
May 24 16:02:11 x200s ppp[8641]: tun0: LCP: deflink: LayerFinish
May 24 16:02:11 x200s ppp[8641]: tun0: LCP: deflink: State change
Stopping --> Stopped
May 24 16:02:11 x200s ppp[8641]: tun0: LCP: deflink: State change
Stopped --> Closed
May 24 16:02:11 x200s ppp[8641]: tun0: LCP: deflink: State change
Closed --> Initial
May 24 16:02:11 x200s ppp[8641]: tun0: Phase: deflink: Disconnected!
May 24 16:02:11 x200s ppp[8641]: tun0: Phase: deflink: lcp -> logout
May 24 16:02:11 x200s ppp[8641]: tun0: Phase: deflink: logout -> hangup
May 24 16:02:11 x200s ppp[8641]: tun0: Phase: deflink: Disconnected!
May 24 16:02:12 x200s ppp[8641]: tun0: Phase: deflink: Connect time: 9
secs: 346 octets in, 287 octets out
May 24 16:02:12 x200s ppp[8641]: tun0: Phase: deflink: 11 packets in,
8 packets out
May 24 16:02:12 x200s ppp[8641]: tun0: Phase:  total 70 bytes/sec,
peak 121 bytes/sec on Mon May 24 16:02:08 2010
May 24 16:02:12 x200s ppp[8641]: tun0: Phase: deflink: hangup -> closed
May 24 16:02:12 x200s ppp[8641]: tun0: Phase: bundle: Dead

Reply | Threaded
Open this post in threaded view
|

Re:

J.C. Roberts-3
I realize you must be frustrated while learning something new, but I am
frustrated by you not paying attention. Now let's look at what I wrote
one more time:

>>      set ifaddr  10.0.0.1/0  10.0.0.2/0  0.0.0.0  0.0.0.0
>>                  part#1      part#2      part#3   part#4

The first chunk of part#1, namely '10.0.0.1', says I want my IP address
to be 10.0.0.1 but the second chunk of part#1, namely the '/0', is a
netmask which says I will accept any IP address the remote system wants
me to use on my side.

The first chunk of part#2, namely '10.0.0.2', says I want the remote
side to use IP address 10.0.0.2 but the second chunk of part#2, namely
the '/0', says I will accept any IP address the remote system wants to
use on their side.

The IP addresses (and netmasks) stated in part#1 and part#2 are
important. They should never be the same, and they should never be set
to default route address ('0.0.0.0'). This is why two separate private
IP addresses are used in the above (10.0.0.1 and 10.0.0.2), and also why
the netmask '/0' in CIDR notation allows for the remote side to pick any
address it wants to use for *both* your IP address and its IP address.

If you forget the CIDR notation netmask on part#1 or part#2, you are
DEMANDING that the specified address be used, and if the other side
disagrees, your side will disconnect.

The part#3 is the netmask assigned on my side to the resulting
connection after we negotiate addresses. Links between two systems made
with Point to Point Protocol (ppp) are "weird" in comparison to typical
network links, and some operating systems do not have a specific
PointToPoint netmask in the network stack, so the netmask must be
faked. Using '0.0.0.0' as the part#3 netmask tells the ppp program to
use what is available and the result is ppp will typically set the
netmask to '255.255.255.255' automatically.

The part#4 is the trigger address which controls when ppp will try to
establish a connection. Since we set part#4 to the equivalent of "any
address" namely '0.0.0.0' any attempt to contact another system will
result in ppp automatically establishing the connection. The thing to
realize is 0.0.0.0 is roughly equivalent to a default route.

The stuff you are doing is just plain wrong:

>  set ifaddr 0.0.0.0/0  0.0.0.0-255.255.255.254  0.0.0.0  0.0.0.0
>>            part#1      part#2                  part#3   part#4

Prior to negotiating address, you are saying your IP address will
initially be 0.0.0.0 and the remote IP address will also initially be
0.0.0.0  The problem is, when two systems have the same IP address you
have a conflict. Additionally, since 0.0.0.0 equates to the default
route, this is very bad. Needless to say, the ppp(8) software is
compensating for your mistakes and doing the best it can with your
broken config.

In the second chunk of your part#1, namely '/0', this netmask says that
you will accept any IP address the other side wants you to use. This is
good.

In the second chunk of part#3, namely '-255.255.255.254' is using the
wrong syntax. The ppp(8) program might interpret this as a range of
addresses, or might interpret it as a pair of addresses, or it might
interpret it as a netmask. You should use simple CIDR notation as
described in the ppp man page.

If ppp(8) is interpreting this bad second chunk of part#3 as a netmask,
the you are *DEMANDING* that the remote system use 0.0.0.0 or 0.0.0.1 as
its IP address, and if the remote side refuses to use one of those two
addresses, then you will disconnect.


        jcr

Reply | Threaded
Open this post in threaded view
|

Re:

patrick kristensen
I didn't get the importance of having different addresses in part#1
and #2 and assumed from 'ifconfig tun0' [ ... ] inet 95.124.11.167 -->
10.0.0.2 netmask 0xfffffff [ ... ] that HISADDR did not change to a
valid one. I should have understood you were telling me the correct
syntax literally. I see that this configuration works and i understand
the syntax.
Sorry this took longer time than it should and thanks for following through.
I have found a great resource in 'Absolute OpenBSD: UNIX for the
Practical Paranoid' (ISBN 1886411999) and of course this was a great
first impression from this mailing list. I will try not to abuse it.
All the best to you

2010/5/24, J.C. Roberts <[hidden email]>:

>
> I realize you must be frustrated while learning something new, but I am
> frustrated by you not paying attention. Now let's look at what I wrote
> one more time:
>
>>>      set ifaddr  10.0.0.1/0  10.0.0.2/0  0.0.0.0  0.0.0.0
>>>                  part#1      part#2      part#3   part#4
>
> The first chunk of part#1, namely '10.0.0.1', says I want my IP address
> to be 10.0.0.1 but the second chunk of part#1, namely the '/0', is a
> netmask which says I will accept any IP address the remote system wants
> me to use on my side.
>
> The first chunk of part#2, namely '10.0.0.2', says I want the remote
> side to use IP address 10.0.0.2 but the second chunk of part#2, namely
> the '/0', says I will accept any IP address the remote system wants to
> use on their side.
>
> The IP addresses (and netmasks) stated in part#1 and part#2 are
> important. They should never be the same, and they should never be set
> to default route address ('0.0.0.0'). This is why two separate private
> IP addresses are used in the above (10.0.0.1 and 10.0.0.2), and also why
> the netmask '/0' in CIDR notation allows for the remote side to pick any
> address it wants to use for *both* your IP address and its IP address.
>
> If you forget the CIDR notation netmask on part#1 or part#2, you are
> DEMANDING that the specified address be used, and if the other side
> disagrees, your side will disconnect.
>
> The part#3 is the netmask assigned on my side to the resulting
> connection after we negotiate addresses. Links between two systems made
> with Point to Point Protocol (ppp) are "weird" in comparison to typical
> network links, and some operating systems do not have a specific
> PointToPoint netmask in the network stack, so the netmask must be
> faked. Using '0.0.0.0' as the part#3 netmask tells the ppp program to
> use what is available and the result is ppp will typically set the
> netmask to '255.255.255.255' automatically.
>
> The part#4 is the trigger address which controls when ppp will try to
> establish a connection. Since we set part#4 to the equivalent of "any
> address" namely '0.0.0.0' any attempt to contact another system will
> result in ppp automatically establishing the connection. The thing to
> realize is 0.0.0.0 is roughly equivalent to a default route.
>
> The stuff you are doing is just plain wrong:
>
>>  set ifaddr 0.0.0.0/0  0.0.0.0-255.255.255.254  0.0.0.0  0.0.0.0
>>>            part#1      part#2                  part#3   part#4
>
> Prior to negotiating address, you are saying your IP address will
> initially be 0.0.0.0 and the remote IP address will also initially be
> 0.0.0.0  The problem is, when two systems have the same IP address you
> have a conflict. Additionally, since 0.0.0.0 equates to the default
> route, this is very bad. Needless to say, the ppp(8) software is
> compensating for your mistakes and doing the best it can with your
> broken config.
>
> In the second chunk of your part#1, namely '/0', this netmask says that
> you will accept any IP address the other side wants you to use. This is
> good.
>
> In the second chunk of part#3, namely '-255.255.255.254' is using the
> wrong syntax. The ppp(8) program might interpret this as a range of
> addresses, or might interpret it as a pair of addresses, or it might
> interpret it as a netmask. You should use simple CIDR notation as
> described in the ppp man page.
>
> If ppp(8) is interpreting this bad second chunk of part#3 as a netmask,
> the you are *DEMANDING* that the remote system use 0.0.0.0 or 0.0.0.1 as
> its IP address, and if the remote side refuses to use one of those two
> addresses, then you will disconnect.
>
>
> jcr

Reply | Threaded
Open this post in threaded view
|

Re:

J.C. Roberts-3
On Tue, 25 May 2010 00:54:53 +0200 patrick kristensen
<[hidden email]> wrote:

> 2010/5/24, J.C. Roberts <[hidden email]>:
> >
> > I realize you must be frustrated while learning something new, but
> > I am frustrated by you not paying attention. Now let's look at what
> > I wrote one more time:
> >
> >>>      set ifaddr  10.0.0.1/0  10.0.0.2/0  0.0.0.0  0.0.0.0
> >>>                  part#1      part#2      part#3   part#4
> >
> > The first chunk of part#1, namely '10.0.0.1', says I want my IP
> > address to be 10.0.0.1 but the second chunk of part#1, namely the
> > '/0', is a netmask which says I will accept any IP address the
> > remote system wants me to use on my side.
> >
> > The first chunk of part#2, namely '10.0.0.2', says I want the remote
> > side to use IP address 10.0.0.2 but the second chunk of part#2,
> > namely the '/0', says I will accept any IP address the remote
> > system wants to use on their side.
> >
> > The IP addresses (and netmasks) stated in part#1 and part#2 are
> > important. They should never be the same, and they should never be
> > set to default route address ('0.0.0.0'). This is why two separate
> > private IP addresses are used in the above (10.0.0.1 and 10.0.0.2),
> > and also why the netmask '/0' in CIDR notation allows for the
> > remote side to pick any address it wants to use for *both* your IP
> > address and its IP address.
> >
> > If you forget the CIDR notation netmask on part#1 or part#2, you are
> > DEMANDING that the specified address be used, and if the other side
> > disagrees, your side will disconnect.
> >
> > The part#3 is the netmask assigned on my side to the resulting
> > connection after we negotiate addresses. Links between two systems
> > made with Point to Point Protocol (ppp) are "weird" in comparison
> > to typical network links, and some operating systems do not have a
> > specific PointToPoint netmask in the network stack, so the netmask
> > must be faked. Using '0.0.0.0' as the part#3 netmask tells the ppp
> > program to use what is available and the result is ppp will
> > typically set the netmask to '255.255.255.255' automatically.
> >
> > The part#4 is the trigger address which controls when ppp will try
> > to establish a connection. Since we set part#4 to the equivalent of
> > "any address" namely '0.0.0.0' any attempt to contact another
> > system will result in ppp automatically establishing the
> > connection. The thing to realize is 0.0.0.0 is roughly equivalent
> > to a default route.
> >
> > The stuff you are doing is just plain wrong:
> >
> >>  set ifaddr 0.0.0.0/0  0.0.0.0-255.255.255.254  0.0.0.0  0.0.0.0
> >>>            part#1      part#2                  part#3   part#4
> >
> > Prior to negotiating address, you are saying your IP address will
> > initially be 0.0.0.0 and the remote IP address will also initially
> > be 0.0.0.0  The problem is, when two systems have the same IP
> > address you have a conflict. Additionally, since 0.0.0.0 equates to
> > the default route, this is very bad. Needless to say, the ppp(8)
> > software is compensating for your mistakes and doing the best it
> > can with your broken config.
> >
> > In the second chunk of your part#1, namely '/0', this netmask says
> > that you will accept any IP address the other side wants you to
> > use. This is good.
> >
> > In the second chunk of part#2, namely '-255.255.255.254' is using
> > the wrong syntax. The ppp(8) program might interpret this as a
> > range of addresses, or might interpret it as a pair of addresses,
> > or it might interpret it as a netmask. You should use simple CIDR
> > notation as described in the ppp man page.
> >
> > If ppp(8) is interpreting this bad second chunk of part#2 as a
> > netmask, the you are *DEMANDING* that the remote system use 0.0.0.0
> > or 0.0.0.1 as its IP address, and if the remote side refuses to use
> > one of those two addresses, then you will disconnect.
> >
> >
> > jcr
> >
>
> I didn't get the importance of having different addresses in part#1
> and #2 and assumed from 'ifconfig tun0' [ ... ] inet 95.124.11.167 -->
> 10.0.0.2 netmask 0xfffffff [ ... ] that HISADDR did not change to a
> valid one. I should have understood you were telling me the correct
> syntax literally. I see that this configuration works and i understand
> the syntax.
>
> Sorry this took longer time than it should and thanks for following
> through. I have found a great resource in 'Absolute OpenBSD: UNIX for
> the Practical Paranoid' (ISBN 1886411999) and of course this was a
> great first impression from this mailing list. I will try not to
> abuse it. All the best to you
>

Heck, in my last two paragraphs I put part#3 instead of part#2
(corrected above) but you still understood it. ;)

The Absolute OpenBSD is good but parts of it are now outdated, but this
is to be expected.

As for ppp(8), the ppp.conf file gives you full control of a a fairly
complex Finite State Machine (FSM), so the man page is long and takes
some effort to understand. Once you know the basics, ppp(8) becomes
*REALLY* useful for debugging and monitoring connections.


There are still a few minor problems with your chat script, but they do
not effect operation.

> set dial "ABORT BUSY TIMEOUT 5 \
> \"\" \
> AT OK-AT-OK \
> AT+CPIN=\\\"7291\\\" OK-AT-OK \
> AT+CFUN=1 OK-AT-OK \
> AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK-AT-OK \
> \\dATDT*99***1# TIMEOUT 30 CONNECT"


When you sent a command like "AT" modems which are in echo mode will
repeat the command you sent to it, and then give you the response to
the command. You send "AT" and the modem replies with:

        AT
        OK

If echo mode is turned off, the modem will just give you the response,
if any, followed by OK (in most situations). So with echo mode off, if
you sent "AT" (an abbreviation for "ATtention") to the modem, it would
reply with

        OK

Some modems default to having echo mode turned on, but others default
to having echo mode turned off, and worse, whether or not the command
to turn echo mode on and off (ATE1 or ATE0 respectively) was implemented
also depends on the device itself, so you just don't know what to expect
(without testing). It's even more retarded than this... --Some devices
will not send an "OK" at all, and instead send reply with something
else.

The expected replies in the ppp(8) man page are written assuming you do
not know if the modem is in echo mode or not, but do expect the device
to give a trailing "OK<newline>" after other output, if any.

This line from your chat script is correct:

> AT OK-AT-OK \

The above says, send "AT" to the modem, and expect the response to
be either just "OK<newline>" or "AT<newline>OK<newline>" and ppp will
ignore any other output until it gets what it is expecting or times out
waiting for the correct response. Since all you really care about is
the trailing "OK<newline>" you could simplify the above as:

> AT OK \

And ppp will keep reading whatever is received from the modem until it
gets the "OK<newline>" it wants.

As you can see from your logs, your modem is in echo mode, so expecting
the 'AT+CPIN' 'AT+CFUN' and 'AT+CGDCONT' to be echoed back to you as
"AT<newline>OK<newline>" is wrong. Since you also accept just
"OK<newline>" ppp still accepts the response as correct.

You may want to add the following to your chat script:
        AT+CTA=0 OK \
        AT+CSQ OK \

The first, CTA ("Connect/Call Timer Activity"), *should* shut off the
internal activity timeout inside of the device itself.

The second, CSQ ("Connect/Call Signal Quality"), *should* give you
signal quality information.

Of course, unless you test them and look at your logs, you will not
know if those commands will work with your Ericsson F3500g device.

Also, you should test your ATDT dialing line without the leading '\\d'
since you may not need the two second delay. Some devices/providers
need the delay, but others do not, so if you can save 2 seconds on each
connect, go for it.

If you decide to use the auto mode of ppp (e.g. `ppp -auto esp`),
you'll need to have at least a 'timeout' set for the connection, but
it's also helpful to set your 'redial' to get past intermittent
failures.

        set timeout 600
        set redial 3+0-1 0

When you're testing/debugging stuff, you don't want to use the 'redial'
or 'timeout' above. If your config is wrong, the 'redial' will result in
an endless loop of trying to connect and failing. If you're using the
'timeout' you'll disconnect after the specified time and wonder why. ;)

Mobile Data Networks (a.k.a. Cellular Data Networks) are really
annoying in a number of ways, and each provider has it's own
esoteric (inane) idea of the "right" way to do things. Worse yet,
there's tons of little-known know-how on making mobile data network
connections reasonably stable.

1.) Make sure to occasionally update the PRL (Preferred Roaming List) on
the device. If you start having constant disconnects, it could be
caused by your PRL being out of date, so your provider cuts disconnects
you very quickly after you connect (5-120 seconds). Though you can
configure ppp(8) to automatically dial the PRL update number (typically
'*228' or '*22899') the time it takes to update the PRL (read TIMEOUT)
and the text of the response from the device (read "Expect:") varies a
whole lot, so getting it right is a real pain.

On *some* (read: "not all") devices, you can put the
        AT+CDV=*228 TIMEOUT 120 OK \
or
        AT+CDV=*22899 TIMEOUT 120 OK \

2.) Occasionally, keep an eye on your ability to ping other systems.
Many providers will allow ping at the start of a connection, and then
later block it. Disconnecting and reconnecting will usually fix this.
Many mobile data network providers do all sorts of wicked things to
connections for the sake of saving network/tower resources, and killing
off ICMP is just one of the many rotten tricks. The reason why they
kill ICMP is some idiots set their systems to continuously ping yahoo or
google to keep their connection alive. For this reason, make sure you
have your /etc/hosts correct so you don't create any spurious dns
lookups.

And don't be too surprised if you cannot reach mozilla.org. The
fucktards at mozilla have firefox configured by default to continuously
check for "news" at mozilla.org. This continuous tcp traffic can set
off alarms at your provider (like an auto ping of yahoo), and they will
block access to it.

Similar is true for various types of chat networks and programs,
particularly those which do any sort of "pinging" (ICMP, TCP, UDP) to
maintain the connection status to the server.

3.) Below is a nice addition to use as your /etc/ppp/ppp.linkdown

        MYADDR:
          set ifaddr  10.0.0.1/0  10.0.0.2/0  0.0.0.0  0.0.0.0

Any time your connection is closed, your tun0 interface is reset, so
the results of `ifconfig tun0` are actually meaningful. There nothing
worse than looking at `ifconfig tun0` and seeing a public IP address
(as if it's connected) even though the connection has died.

4.) IPv6 traffic will cause ppp(8) and pppd(8) to attempt a connection
even if your provider doesn't support IPv6. You can use pf to fix this
by setting the following in your /etc/pf.conf

        block quick inet6

Additionally, you probably want to set the following in your
/etc/ppp/ppp.conf

        default:
                set log ...
                disable ipv6cp

You can (and should) go further by using ppp(8) filters to set up
specific conditions for what traffic should cause ppp to"dial" (make
a connection) or stay "alive" (remain connected). If you look at the
".sample" files in /etc/ppp/ and the ppp(8) man page, you'll see how to
use the 'set filter dial ...' and 'set filter alive ...' commands.

Since most providers have bandwidth caps measuring all network
traffic, preventing your system from connecting when it doesn't need to
be connected is fairly important. Unlike the old POTS (land line)
modems, these new mobile data network devices (EVDO, HSPA, ...) can
establish a connection *very* quickly. This means only connecting when
you need to is pretty fast and will help save your bandwidth.

Now that you know all this great stuff about ppp, I expect you to be
able to assist the next person who asks for help with it on the list. ;)

Welcome To OpenBSD!

        jcr

--
The OpenBSD Journal - http://www.undeadly.org

Reply | Threaded
Open this post in threaded view
|

Re:

Jussi Peltola
On Mon, May 24, 2010 at 09:56:45PM -0700, J.C. Roberts wrote:
> Since most providers have bandwidth caps measuring all network
> traffic, preventing your system from connecting when it doesn't need to
> be connected is fairly important. Unlike the old POTS (land line)
> modems, these new mobile data network devices (EVDO, HSPA, ...) can
> establish a connection *very* quickly. This means only connecting when
> you need to is pretty fast and will help save your bandwidth.
 
But beware, some providers charge for each time you open the connection.
Here in Finland it's masked in the pricing as a "minimum amount" of
100KB; so they will charge you the (abhorrent) price for 100KB for each
time you open the connection.

Thankfully flat-rate 3G is very cheap here - and unusable in densely
populated areas as a result...

Reply | Threaded
Open this post in threaded view
|

Re:

Pete Vickers-2
In reply to this post by J.C. Roberts-3
This works for me with kernel ppp:

http://archive.psg.com/gprs-vickers.txt


/Pete


On 23. mai 2010, at 02.52, J.C. Roberts wrote:

> On Sat, 22 May 2010 22:08:57 +0200 patrick kristensen
> <[hidden email]> wrote:
>> Thanks for taking the time to answer and your fast replies.
>>
>
> Actually, ppp and TDMA/CDMA are nice break from the other headaches I've
> been trying to solve. ;)
>
> First of all, you either haven't mentioned the name of your service
> provider, or I forgot what it was. Either way, it matters.
>
> From what I can tell, you're in Spain, and I'm not familiar with the
> providers there.
>
> Ted Roby recently posted his config for Virgin Mobile:
> http://marc.info/?l=openbsd-tech&m=127285929411780&w=2
>
> The above may not help, but it's nice to see working examples.
>
>> In absence of cdce (using ue0 as ethernet interface (and minicom) to
>> connect to isp) i have tried several ppp and pppd configurations to
>> get a working internet connection on -release with no success.
>>
>> The following is my ppp (# ppp -auto movistar) and pppd (# pppd call
>> movistar) attempts.
>
> Since pppd(8) is in the kernel, it can be faster, but since ppp(8) is
> in userland, it can be much easier to work with when figuring things
> out. Once you figure out how to make things work with ppp(8), you can
> easily write a new config for pppd(8).
>
>
>>
>> /etc/ppp/ppp.conf  (appended to ppp.conf.sample)
>>
>> movistar:
>> set device /dev/cuaU0
>> set speed 460800
>> set timeout 0
>> set dial "ABORT BUSY TIMEOUT 5 \
>> \"\" \
>> AT OK-AT-OK \
>> AT+CFUN=1 OK-AT-OK \
>> AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\\"****"\\\"-OK \
>
> The above looks wrong. Not all wireless service providers and not
> all cellular wireless devices require using the Personal Identification
> Number (PIN) when making a connection. And worse, the responses you
> can get varies from device to device. (see below)
>
> Also, it is unwise to post your PIN to a public mailing list. It's not
> too dangerous without the IMEI and MEID device, but it's still not a
> good idea.
>
>> AT+CGDCONT=1,\\\"IP\\\",\\\"movistar.es\\\" OK \
>
> The above is most likely wrong. The AT+CGDCONT= command sets the primary
> CONText of the device and the network it is attaching to. The first
> value argument states whether or not the device can be reconfigured (1),
> or cannot be reconfigured (3). The second argument is a string which
> defines the protocol used on the network. The third argument is also
> a string and it defines the Packet Data Network (PDN) name or Access
> Point Name (APN).
>
> As far as I know "movistar.es" is not the proper name of any Packet Data
> Network (PDN) or Access Point Name (APN). For example Virgin Mobile uses
> "VDATA" as the APN/PDN name, while AirTel uses "airtelgprs.com" as the name
> and of course, what your provider uses is unknown.
>
> You need to be careful with this setting since many providers have multiple
> data networks. With Verizon here in the silicon valley, I can choose from
> three different data networks (actually four if you count EVDO Rel. 0 as a
> different network than EVDO Rev. A).
>
>> "ATDT*99***1#"
>>
>
> The above is wrong because it has no timeout or 'CONNECT'. Also, you should
> have noticed the leading double quote (") which is prematurely ending
> your chat script *BEFORE* the required number is dialed. The above should
be:
>
> \\dATDT*99***1# TIMEOUT 30 CONNECT"
>
> The leading "\\d" gives a two second delay before calling. It may or may
not

> be necessary with your hardware/provider.
>
>>
>> set mtu maximum 750
>
> The above is most likely wrong.
>
>> resolv rewrite
>
> The above is often unnecessary to get things working, but rewriting
> /etc/resolv.conf is mostly a matter of personal choice/needs. The
> command you have below, namely `enable dns` should suffice.
>
>> set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
>> add default HISADDR
>> enable dns
>>
>> # ./.
>>
>>
>>
>> /var/log/ppp.log
>>
>> May 22 17:57:51 x200s ppp[8742]: Phase: Using interface: tun0
>> May 22 17:57:51 x200s ppp[8742]: Phase: deflink: Created in closed
>> state May 22 17:57:51 x200s ppp[8742]: tun0: Command: default: set
>> device /dev/cuaU0 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
>> default: set speed 460800 May 22 17:57:51 x200s ppp[8742]: tun0:
>> Command: default: set dial ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 ""
>> AT OK-AT-OK ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT
>> May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: set
>> device /dev/cuaU0 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
>> movistar: set speed 460800 May 22 17:57:51 x200s ppp[8742]: tun0:
>> Command: movistar: set timeout 0 May 22 17:57:51 x200s ppp[8742]:
>> tun0: Command: movistar: set dial ABORT BUSY TIMEOUT 5
>> "" AT OK-AT-OK AT
>> +CFUN=1 OK-AT-OK AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\"7291\\"-OK AT
>> +CGDCONT=1,\\"IP\\",\\"movistar.es\\" OK ATDT*99***1# May 22 17:57:51
>> x200s ppp[8742]: tun0: Command: movistar: set mtu maximum 750 May 22
>> 17:57:51 x200s ppp[8742]: tun0: Command: movistar: resolv rewrite May
>> 22 17:57:51 x200s ppp[8742]: tun0: IPCP: Primary nameserver set to
>> 255.255.255.255 May 22 17:57:51 x200s ppp[8742]: tun0: Command:
>> movistar: set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0.
>> May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar: add default
>> HISADDR May 22 17:57:51 x200s ppp[8742]: tun0: Command: movistar:
>> enable dns May 22 17:57:51 x200s ppp[3315]: tun0: Phase: PPP Started
>> (auto mode). May 22 17:57:51 x200s ppp[3315]: tun0: Phase: bundle:
>> Establish May 22 17:57:51 x200s ppp[3315]: tun0: Phase: deflink:
>> closed -> opening May 22 17:57:51 x200s ppp[3315]: tun0: Phase:
>> deflink: Connected! May 22 17:57:51 x200s ppp[3315]: tun0: Phase:
>> deflink: opening -> dial May 22 17:57:51 x200s ppp[3315]: tun0: Chat:
>> deflink: Dial attempt 1 of 1 May 22 17:57:51 x200s ppp[3315]: tun0:
>> Chat: Send: AT\^M May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect
>> (5): OK May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received:
>> May 22 17:57:51 x200s last message repeated 2 times
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT\^M\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CFUN=1\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): OK
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CFUN=1\^M\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN?\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Expect(5): +CPIN: READY
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: AT+CPIN?\^M\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: +CPIN: SIM PIN\^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: \^M
>> May 22 17:57:51 x200s ppp[3315]: tun0: Chat: Received: OK\^M
>> May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Expect timeout
>> May 22 17:57:56 x200s ppp[3315]: tun0: Chat: Send: AT+CPIN"****"\^M
>
> Yep. Here's (one of) your problem(s). Your chat script is telling ppp
> to expect "+CPIN: READY" but the device is actually sending
> you "+CPIN: SIM PIN" so you get the dreaded "Expect timeout"
>
> Your original chat line from above reads:
>> AT+CPIN? +CPIN:\\sREADY-AT+CPIN\\\"****"\\\"-OK \
>
> It should read something like this:
>> AT+CPIN? +CPIN:\\sSIM\\sPIN-AT+CPIN\\\"****"\\\"-OK \
>
> As mentioned above, I do not know whether or not sending your PIN to the
> device/carrier is necessary to unlock the device/account. Sometimes it
> is necessary, and sometimes it is not necessary.
>
>> May 22 17:57:56 x200s ppp[3315]: tun0: Phase: deflink: dial -> carrier
>> May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: carrier -> login
>> May 22 17:57:57 x200s ppp[3315]: tun0: Phase: deflink: login -> lcp
>> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: FSM: Using "deflink" as a
transport
>> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change Initial
--> Closed
>> May 22 17:57:57 x200s ppp[3315]: tun0: LCP: deflink: State change Closed
--> Stopped
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: LayerStart
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1) state
= Stopped
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACFCOMP[2]
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  PROTOCOMP[2]
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  ACCMAP[6] 0x00000000
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MRU[4] 1500
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP:  MAGICNUM[6] 0x1081a7d5
>> May 22 17:57:58 x200s ppp[3315]: tun0: LCP: deflink: State change Stopped
--> Req-Sent
>> May 22 17:58:01 x200s ppp[3315]: tun0: LCP: deflink: SendConfigReq(1) state
= Req-Sent

> ...
>> May 22 17:58:37 x200s ppp[3315]: tun0: Phase: Signal 15, terminate.
>> May 22 17:58:37 x200s ppp[3315]: tun0: Phase: PPP Terminated (normal).
>
> The above made absolutely no sense to me until I realized you had an
> extra double quote in your chat script which prevented it from dialing.
>
> jcr
>
> --
> The OpenBSD Journal - http://www.undeadly.org