Re: Default-Routing problems



On Wed, 2009-03-18 at 13:00 -0400, Dan Williams wrote:
> To track this down further, try the following:
> 
> service NetworkManager stop
> NM_SERIAL_DEBUG=1 /usr/sbin/NetworkManager --no-daemon
> 
> then make the connection (or try anyway), and wait for failure.  Then
> copy the NM output and reply with it.  That'll show exactly what
> statement the modem is locking on.

OK, here's the scenario

1. boot system without GSM modem, login, kill NM service
2. start NM with debug options.
3. Insert GSM modem. NM detects it, tries to activate, fails.
   NOTE: NM applet menu has a single Mobile Broadband entry
5. Remove modem, wait a while, re-insert.
   NOTE: NM does not try to activate the modem this time.
6. Activate the modem from NM applet menu -- success.
7. kill NM, save output file 'serial-debug-1.txt'.
8. remove modem, repeat from #2
   NOTE - this time its different, there are *two* entries in the menu,
   each saying "Mobile Broadband (Huawei Technologies E220 HSDPA Modem /
E270 HSDPS/HSUPA Modem)". I attach the udevadm output in case that is
interesting.
8. Click the 1st menu entry - no success.
9. Click the 2nd menu entry - success.
10. save output file 'serial-debug-2.txt'.

 

[root heron colinc]# NM_SERIAL_DEBUG=1 /usr/sbin/NetworkManager --no-daemon
NetworkManager: <info>  starting...
-- Error received: File exists
-- Original message: type=0x14 length=56 flags=<REQUEST,ACK,ATOMIC> sequence-nr=1237399108 pid=4198266
NetworkManager: <WARN>  nm_generic_enable_loopback(): error -17 returned from rtnl_addr_add():
Sucess

NetworkManager: <info>  (eth0): new Ethernet device (driver: 'sis190')
NetworkManager: <info>  (eth0): exported as /org/freedesktop/Hal/devices/net_00_03_0d_90_44_e8
NetworkManager: <info>  (eth0): device state change: 1 -> 2
NetworkManager: <info>  (eth0): bringing up device.
NetworkManager: <info>  (eth0): preparing device.
NetworkManager: <info>  (eth0): deactivating device (reason: 2).
NetworkManager: <info>  (ttyUSB0): detected GSM modem via udev capabilities
NetworkManager: <info>  (ttyUSB0): new Modem device (driver: 'option')
NetworkManager: <info>  (ttyUSB0): exported as /org/freedesktop/Hal/devices/usb_device_12d1_1003_noserial_if0_serial_usb_0
NetworkManager: <info>  (ttyUSB0): device state change: 1 -> 2
NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 2).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  (ttyUSB0): device state change: 2 -> 3
NetworkManager: <info>  Activation (ttyUSB0) starting connection '3 UK Broadband'
NetworkManager: <info>  (ttyUSB0): device state change: 3 -> 4
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <debug> [1237399154.397917] nm_serial_device_open(): (ttyUSB0) opening device...
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1237399154.518597] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237399154.573359] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS'
NetworkManager: <debug> [1237399154.574292] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237399154.613400] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0


OK

'
NetworkManager: <debug> [1237399154.613906] nm_serial_debug(): Sending: 'AT+CPIN?
'
NetworkManager: <WARN>  check_pin_done(): PIN checking timed out
NetworkManager: <info>  (ttyUSB0): device state change: 4 -> 9
NetworkManager: <debug> [1237399158.334273] nm_serial_device_close(): Closing device 'ttyUSB0'
NetworkManager: <info>  Marking connection '3 UK Broadband' invalid.
NetworkManager: <info>  Activation (ttyUSB0) failed.
NetworkManager: <info>  (ttyUSB0): device state change: 9 -> 3
NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 0).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  (ttyUSB0): now unmanaged
NetworkManager: <info>  (ttyUSB0): device state change: 3 -> 1
NetworkManager: <info>  (ttyUSB0): cleaning up...
NetworkManager: <info>  (ttyUSB0): taking down device.
NetworkManager: <info>  (ttyUSB0): detected GSM modem via udev capabilities
NetworkManager: <info>  (ttyUSB0): new Modem device (driver: 'option')
NetworkManager: <info>  (ttyUSB0): exported as /org/freedesktop/Hal/devices/usb_device_12d1_1003_noserial_if0_serial_usb_0
NetworkManager: <info>  (ttyUSB0): device state change: 1 -> 2
NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 2).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  (ttyUSB0): device state change: 2 -> 3
NetworkManager: <info>  Activation (ttyUSB0) starting connection '3 UK Broadband'
NetworkManager: <info>  (ttyUSB0): device state change: 3 -> 4
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <debug> [1237399280.235421] nm_serial_device_open(): (ttyUSB0) opening device...
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1237399280.356352] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237399280.416212] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237399280.440156] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0


OK

'
NetworkManager: <debug> [1237399280.442692] nm_serial_debug(): Sending: 'AT+CPIN?
'
NetworkManager: <debug> [1237399280.460407] nm_serial_debug(): Got: '

+CPIN: READY



OK

'
NetworkManager: <debug> [1237399280.461038] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237399280.539372] nm_serial_debug(): Got: '

OK

'
NetworkManager: <info>  (ttyUSB0): powering up...
NetworkManager: <debug> [1237399280.539832] nm_serial_debug(): Sending: 'AT+CFUN=1
'
NetworkManager: <debug> [1237399280.561353] nm_serial_debug(): Got: '

OK

'
NetworkManager: <debug> [1237399280.561622] nm_serial_debug(): Sending: 'AT+CGMM
'
NetworkManager: <debug> [1237399280.582394] nm_serial_debug(): Got: '

E220



OK

'
NetworkManager: <debug> [1237399280.582756] nm_serial_debug(): Sending: 'AT+CREG?
'
NetworkManager: <debug> [1237399280.600352] nm_serial_debug(): Got: '

+CREG: 0,1



OK

'
NetworkManager: <info>  Registered on Home network
NetworkManager: <debug> [1237399280.602477] nm_serial_debug(): Sending: 'AT+COPS?
'
NetworkManager: <debug> [1237399280.621346] nm_serial_debug(): Got: '

+COPS: 0,0,"3 UK",2



OK

'
NetworkManager: <info>  Associated with network: +COPS: 0,0,"3 UK",2
NetworkManager: <debug> [1237399280.621491] nm_serial_debug(): Sending: 'ATDT*99#
'
NetworkManager: <debug> [1237399280.644445] nm_serial_debug(): Got: '

CONNECT 3600000

'
NetworkManager: <info>  Connected, Woo!
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
NetworkManager: <info>  (ttyUSB0): device state change: 4 -> 5
NetworkManager: <info>  Starting pppd connection
NetworkManager: <debug> [1237399280.679209] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute ttyUSB0 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/0 plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so
NetworkManager: <debug> [1237399280.714473] nm_ppp_manager_start(): ppp started with pid 4211
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
Using interface ppp0
Connect: ppp0 <--> /dev/ttyUSB0
NetworkManager: <info>  (ttyUSB0): device state change: 5 -> 6
CHAP authentication succeeded
CHAP authentication succeeded
NetworkManager: <info>  (ttyUSB0): device state change: 6 -> 7
Could not determine remote IP address: defaulting to 10.64.64.64
local  IP address 92.40.77.239
remote IP address 10.64.64.64
primary   DNS address 4.2.2.4
secondary DNS address 4.2.2.3
NetworkManager: <info>  PPP manager(IP Config Get) reply received.
NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) started...
NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) complete.
NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) started...
NetworkManager: <info>  (ttyUSB0): device state change: 7 -> 8
NetworkManager: <info>  Policy set '3 UK Broadband' (ppp0) as default for routing and DNS.
NetworkManager: <info>  Activation (ttyUSB0) successful, device activated.
NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) complete.
NetworkManager: <info>  Sleeping...
NetworkManager: <info>  (eth0): now unmanaged
NetworkManager: <info>  (eth0): device state change: 2 -> 1
NetworkManager: <info>  (eth0): cleaning up...
NetworkManager: <info>  (eth0): taking down device.
NetworkManager: <info>  (ttyUSB0): now unmanaged
NetworkManager: <info>  (ttyUSB0): device state change: 8 -> 1
NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 37).
Terminating on signal 15
Connect time 0.3 minutes.
Sent 0 bytes, received 0 bytes.
NetworkManager: <debug> [1237399297.303614] nm_serial_device_close(): Closing device 'ttyUSB0'
Connection terminated.
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  (ttyUSB0): cleaning up...
NetworkManager: <info>  (ttyUSB0): taking down device.
NetworkManager: <debug> [1237399299.333311] ensure_killed(): waiting for ppp pid 4211 to exit
NetworkManager: <debug> [1237399299.333621] ensure_killed(): ppp pid 4211 cleaned up

^CNetworkManager: <WARN>  nm_signal_handler(): Caught signal 2, shutting down normally.
NetworkManager: <info>  exiting (success)
[root heron colinc]# 


P: /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0/event0
N: input/event0

P: /devices/LNXSYSTM:00/device:00/PNP0A03:00/device:0c/device:0d/input/input9/event9
N: input/event9

P: /devices/LNXSYSTM:00/device:00/PNP0C0C:00/input/input1/event1
N: input/event1

P: /devices/LNXSYSTM:00/device:00/PNP0C0D:00/input/input3/event3
N: input/event3

P: /devices/LNXSYSTM:00/device:00/PNP0C0E:00/input/input2/event2
N: input/event2

P: /devices/pci0000:00/0000:00:02.5/host0/target0:0:0/0:0:0:0/block/sr0
N: sr0
S: scd0
S: disk/by-path/pci-0000:00:02.5-scsi-0:0:0:0
S: cdrom
S: cdrw
S: dvd
S: dvdrw
E: ID_CDROM=1
E: ID_CDROM_CD_R=1
E: ID_CDROM_CD_RW=1
E: ID_CDROM_DVD=1
E: ID_CDROM_DVD_R=1
E: ID_CDROM_DVD_RW=1
E: ID_CDROM_DVD_RAM=1
E: ID_CDROM_DVD_PLUS_R=1
E: ID_CDROM_DVD_PLUS_RW=1
E: ID_CDROM_DVD_PLUS_R_DL=1
E: ID_CDROM_MRW=1
E: ID_CDROM_MRW_W=1
E: ID_PATH=pci-0000:00:02.5-scsi-0:0:0:0
E: GENERATED=1

P: /devices/pci0000:00/0000:00:02.5/host0/target0:0:0/0:0:0:0/bsg/0:0:0:0
N: bsg/0:0:0:0

P: /devices/pci0000:00/0000:00:02.5/host0/target0:0:0/0:0:0:0/scsi_generic/sg0
N: sg0

P: /devices/pci0000:00/0000:00:03.0/usb2
N: bus/usb/002/001

P: /devices/pci0000:00/0000:00:03.0/usb2/2-0:1.0/usb_endpoint/usbdev2.1_ep81
N: usbdev2.1_ep81

P: /devices/pci0000:00/0000:00:03.0/usb2/2-2
N: bus/usb/002/002

P: /devices/pci0000:00/0000:00:03.0/usb2/2-2/2-2:1.0/input/input7/event7
N: input/event7
S: input/by-id/usb-PIXART_USB_OPTICAL_MOUSE-event-mouse
S: input/by-path/pci-0000:00:03.0-usb-0:2:1.0-event-mouse
E: ID_VENDOR=PIXART
E: ID_MODEL=USB_OPTICAL_MOUSE
E: ID_REVISION=0100
E: ID_SERIAL=PIXART_USB_OPTICAL_MOUSE
E: ID_TYPE=hid
E: ID_BUS=usb
E: ID_CLASS=mouse
E: ID_PATH=pci-0000:00:03.0-usb-0:2:1.0

P: /devices/pci0000:00/0000:00:03.0/usb2/2-2/2-2:1.0/input/input7/mouse2
N: input/mouse2
S: input/by-id/usb-PIXART_USB_OPTICAL_MOUSE-mouse
S: input/by-path/pci-0000:00:03.0-usb-0:2:1.0-mouse
E: ID_VENDOR=PIXART
E: ID_MODEL=USB_OPTICAL_MOUSE
E: ID_REVISION=0100
E: ID_SERIAL=PIXART_USB_OPTICAL_MOUSE
E: ID_TYPE=hid
E: ID_BUS=usb
E: ID_CLASS=mouse
E: ID_PATH=pci-0000:00:03.0-usb-0:2:1.0

P: /devices/pci0000:00/0000:00:03.0/usb2/2-2/2-2:1.0/usb_endpoint/usbdev2.2_ep81
N: usbdev2.2_ep81

P: /devices/pci0000:00/0000:00:03.0/usb2/2-2/usb_endpoint/usbdev2.2_ep00
N: usbdev2.2_ep00

P: /devices/pci0000:00/0000:00:03.0/usb2/usb_endpoint/usbdev2.1_ep00
N: usbdev2.1_ep00

P: /devices/pci0000:00/0000:00:03.0/usbmon/usbmon2
N: usbmon2

P: /devices/pci0000:00/0000:00:03.1/usb3
N: bus/usb/003/001

P: /devices/pci0000:00/0000:00:03.1/usb3/3-0:1.0/usb_endpoint/usbdev3.1_ep81
N: usbdev3.1_ep81

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2
N: bus/usb/003/007

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.0/ttyUSB0/tty/ttyUSB0
N: ttyUSB0
E: ID_NM_MODEM_GSM=1
E: ID_NM_MODEM_PROBED=1

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.0/usb_endpoint/usbdev3.7_ep02
N: usbdev3.7_ep02

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.0/usb_endpoint/usbdev3.7_ep81
N: usbdev3.7_ep81

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.0/usb_endpoint/usbdev3.7_ep82
N: usbdev3.7_ep82

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.1/ttyUSB1/tty/ttyUSB1
N: ttyUSB1
E: ID_NM_MODEM_GSM=1
E: ID_NM_MODEM_PROBED=1

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.1/usb_endpoint/usbdev3.7_ep05
N: usbdev3.7_ep05

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.1/usb_endpoint/usbdev3.7_ep85
N: usbdev3.7_ep85

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.2/host16/target16:0:0/16:0:0:0/block/sr1
N: sr1
S: scd1
S: disk/by-id/usb-HUAWEI_Mass_Storage-0:0
S: disk/by-path/pci-0000:00:03.1-usb-0:2:1.2-scsi-0:0:0:0
S: cdrom1
E: ID_CDROM=1
E: ID_VENDOR=HUAWEI
E: ID_MODEL=Mass_Storage
E: ID_REVISION=2.31
E: ID_SERIAL=HUAWEI_Mass_Storage-0:0
E: ID_TYPE=cd
E: ID_INSTANCE=0:0
E: ID_BUS=usb
E: ID_PATH=pci-0000:00:03.1-usb-0:2:1.2-scsi-0:0:0:0
E: GENERATED=1

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.2/host16/target16:0:0/16:0:0:0/bsg/16:0:0:0
N: bsg/16:0:0:0

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.2/host16/target16:0:0/16:0:0:0/scsi_generic/sg3
N: sg3

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.2/usb_endpoint/usbdev3.7_ep04
N: usbdev3.7_ep04

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/3-2:1.2/usb_endpoint/usbdev3.7_ep83
N: usbdev3.7_ep83

P: /devices/pci0000:00/0000:00:03.1/usb3/3-2/usb_endpoint/usbdev3.7_ep00
N: usbdev3.7_ep00

P: /devices/pci0000:00/0000:00:03.1/usb3/usb_endpoint/usbdev3.1_ep00
N: usbdev3.1_ep00

P: /devices/pci0000:00/0000:00:03.1/usbmon/usbmon3
N: usbmon3

P: /devices/pci0000:00/0000:00:03.3/usb1
N: bus/usb/001/001

P: /devices/pci0000:00/0000:00:03.3/usb1/1-0:1.0/usb_endpoint/usbdev1.1_ep81
N: usbdev1.1_ep81

P: /devices/pci0000:00/0000:00:03.3/usb1/1-6
N: bus/usb/001/003

P: /devices/pci0000:00/0000:00:03.3/usb1/1-6/1-6:1.0/host4/target4:0:0/4:0:0:0/block/sdb
N: sdb
S: disk/by-id/usb-Generic-_Multi-Card_20060413092100000-0:0
S: disk/by-path/pci-0000:00:03.3-usb-0:6:1.0-scsi-0:0:0:0
E: ID_VENDOR=Generic-
E: ID_MODEL=Multi-Card
E: ID_REVISION=1.00
E: ID_SERIAL=Generic-_Multi-Card_20060413092100000-0:0
E: ID_SERIAL_SHORT=20060413092100000
E: ID_TYPE=disk
E: ID_INSTANCE=0:0
E: ID_BUS=usb
E: ID_PATH=pci-0000:00:03.3-usb-0:6:1.0-scsi-0:0:0:0

P: /devices/pci0000:00/0000:00:03.3/usb1/1-6/1-6:1.0/host4/target4:0:0/4:0:0:0/bsg/4:0:0:0
N: bsg/4:0:0:0

P: /devices/pci0000:00/0000:00:03.3/usb1/1-6/1-6:1.0/host4/target4:0:0/4:0:0:0/scsi_generic/sg2
N: sg2

P: /devices/pci0000:00/0000:00:03.3/usb1/1-6/1-6:1.0/usb_endpoint/usbdev1.3_ep01
N: usbdev1.3_ep01

P: /devices/pci0000:00/0000:00:03.3/usb1/1-6/1-6:1.0/usb_endpoint/usbdev1.3_ep82
N: usbdev1.3_ep82

P: /devices/pci0000:00/0000:00:03.3/usb1/1-6/usb_endpoint/usbdev1.3_ep00
N: usbdev1.3_ep00

P: /devices/pci0000:00/0000:00:03.3/usb1/usb_endpoint/usbdev1.1_ep00
N: usbdev1.1_ep00

P: /devices/pci0000:00/0000:00:03.3/usbmon/usbmon1
N: usbmon1

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda
N: sda
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda1
N: sda1
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part1
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part1
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part1
S: disk/by-uuid/A0A80370A803446E
S: disk/by-label/Recovery
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0
E: ID_FS_USAGE=filesystem
E: ID_FS_TYPE=ntfs
E: ID_FS_VERSION=3.1
E: ID_FS_UUID=A0A80370A803446E
E: ID_FS_UUID_ENC=A0A80370A803446E
E: ID_FS_LABEL=Recovery
E: ID_FS_LABEL_ENC=Recovery
E: ID_FS_LABEL_SAFE=Recovery

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda2
N: sda2
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part2
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part2
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part2
S: disk/by-uuid/02A0065FA0065995
S: disk/by-label/System
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0
E: ID_FS_USAGE=filesystem
E: ID_FS_TYPE=ntfs
E: ID_FS_VERSION=3.1
E: ID_FS_UUID=02A0065FA0065995
E: ID_FS_UUID_ENC=02A0065FA0065995
E: ID_FS_LABEL=System
E: ID_FS_LABEL_ENC=System
E: ID_FS_LABEL_SAFE=System

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda3
N: sda3
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part3
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part3
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part3
S: disk/by-uuid/486C0C326C0C1D76
S: disk/by-label/Vista
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0
E: ID_FS_USAGE=filesystem
E: ID_FS_TYPE=ntfs
E: ID_FS_VERSION=3.1
E: ID_FS_UUID=486C0C326C0C1D76
E: ID_FS_UUID_ENC=486C0C326C0C1D76
E: ID_FS_LABEL=Vista
E: ID_FS_LABEL_ENC=Vista
E: ID_FS_LABEL_SAFE=Vista

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda4
N: sda4
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part4
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part4
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part4
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda5
N: sda5
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part5
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part5
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part5
S: disk/by-uuid/e8c1cc77-8e1c-407d-a02b-39d8511229a2
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0
E: ID_FS_USAGE=other
E: ID_FS_TYPE=swap
E: ID_FS_VERSION=2
E: ID_FS_UUID=e8c1cc77-8e1c-407d-a02b-39d8511229a2
E: ID_FS_UUID_ENC=e8c1cc77-8e1c-407d-a02b-39d8511229a2
E: ID_FS_LABEL=
E: ID_FS_LABEL_ENC=
E: ID_FS_LABEL_SAFE=

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda6
N: sda6
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part6
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part6
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part6
S: disk/by-uuid/2237bfcb-e203-41d2-ae9f-316338ae7408
S: disk/by-label/\x2f
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0
E: ID_FS_USAGE=filesystem
E: ID_FS_TYPE=ext2
E: ID_FS_VERSION=1.0
E: ID_FS_UUID=2237bfcb-e203-41d2-ae9f-316338ae7408
E: ID_FS_UUID_ENC=2237bfcb-e203-41d2-ae9f-316338ae7408
E: ID_FS_LABEL=/
E: ID_FS_LABEL_ENC=\x2f
E: ID_FS_LABEL_SAFE=

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda7
N: sda7
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part7
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part7
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part7
S: disk/by-uuid/eaf22d92-ba1c-402d-8ffd-044673753b9e
S: disk/by-label/\x2f1
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0
E: ID_FS_USAGE=filesystem
E: ID_FS_TYPE=ext3
E: ID_FS_VERSION=1.0
E: ID_FS_UUID=eaf22d92-ba1c-402d-8ffd-044673753b9e
E: ID_FS_UUID_ENC=eaf22d92-ba1c-402d-8ffd-044673753b9e
E: ID_FS_LABEL=/1
E: ID_FS_LABEL_ENC=\x2f1
E: ID_FS_LABEL_SAFE=1

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/block/sda/sda8
N: sda8
S: disk/by-id/scsi-SATA_WDC_WD2500BEVS-_WD-WXC208776085-part8
S: disk/by-id/ata-WDC_WD2500BEVS-22UST0_WD-WXC208776085-part8
S: disk/by-path/pci-0000:00:05.0-scsi-0:0:0:0-part8
E: ID_VENDOR=ATA
E: ID_MODEL=WDC_WD2500BEVS-2
E: ID_REVISION=01.0
E: ID_SERIAL=SATA_WDC_WD2500BEVS-_WD-WXC208776085
E: ID_SERIAL_SHORT=WD-WXC208776085
E: ID_TYPE=disk
E: ID_BUS=scsi
E: ID_ATA_COMPAT=WDC_WD2500BEVS-22UST0_WD-WXC208776085
E: ID_PATH=pci-0000:00:05.0-scsi-0:0:0:0
E: ID_FS_USAGE=raid
E: ID_FS_TYPE=LVM2_member
E: ID_FS_VERSION=LVM2 001
E: ID_FS_UUID=m04SQv-JHhI-XEk4-oYJS-XlNw-e1BT-zqjkiw
E: ID_FS_UUID_ENC=m04SQv-JHhI-XEk4-oYJS-XlNw-e1BT-zqjkiw
E: ID_FS_LABEL=
E: ID_FS_LABEL_ENC=
E: ID_FS_LABEL_SAFE=

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/bsg/2:0:0:0
N: bsg/2:0:0:0

P: /devices/pci0000:00/0000:00:05.0/host2/target2:0:0/2:0:0:0/scsi_generic/sg1
N: sg1

P: /devices/pci0000:00/0000:00:0f.0/sound/card0/audio
N: audio

P: /devices/pci0000:00/0000:00:0f.0/sound/card0/controlC0
N: snd/controlC0

P: /devices/pci0000:00/0000:00:0f.0/sound/card0/dsp
N: dsp

P: /devices/pci0000:00/0000:00:0f.0/sound/card0/hwC0D0
N: snd/hwC0D0

P: /devices/pci0000:00/0000:00:0f.0/sound/card0/mixer
N: mixer

P: /devices/pci0000:00/0000:00:0f.0/sound/card0/pcmC0D0c
N: snd/pcmC0D0c

P: /devices/pci0000:00/0000:00:0f.0/sound/card0/pcmC0D0p
N: snd/pcmC0D0p

P: /devices/platform/i8042/serio0/input/input5/event5
N: input/event5
S: input/by-path/platform-i8042-serio-0-event-kbd
E: ID_CLASS=kbd
E: ID_SERIAL=noserial
E: ID_PATH=platform-i8042-serio-0

P: /devices/platform/i8042/serio4/input/input6/event6
N: input/event6
S: input/by-path/platform-i8042-serio-4-event-mouse
E: ID_CLASS=mouse
E: ID_SERIAL=noserial
E: ID_PATH=platform-i8042-serio-4

P: /devices/platform/i8042/serio4/input/input6/mouse1
N: input/mouse1
S: input/by-path/platform-i8042-serio-4-mouse
E: ID_CLASS=mouse
E: ID_SERIAL=noserial
E: ID_PATH=platform-i8042-serio-4

P: /devices/platform/pcspkr/input/input8/event8
N: input/event8
S: input/by-path/platform-pcspkr-event-spkr
E: ID_CLASS=spkr
E: ID_SERIAL=noserial
E: ID_PATH=platform-pcspkr

P: /devices/platform/serial8250/tty/ttyS0
N: ttyS0

P: /devices/platform/serial8250/tty/ttyS1
N: ttyS1

P: /devices/platform/serial8250/tty/ttyS2
N: ttyS2

P: /devices/platform/serial8250/tty/ttyS3
N: ttyS3

P: /devices/pnp0/00:02/rtc/rtc0
N: rtc0
S: rtc

P: /devices/virtual/block/dm-0
N: dm-0

P: /devices/virtual/block/dm-1
N: dm-1

P: /devices/virtual/block/dm-2
N: dm-2

P: /devices/virtual/block/ram0
N: ram0
S: ramdisk

P: /devices/virtual/block/ram1
N: ram1
S: ram

P: /devices/virtual/block/ram10
N: ram10

P: /devices/virtual/block/ram11
N: ram11

P: /devices/virtual/block/ram12
N: ram12

P: /devices/virtual/block/ram13
N: ram13

P: /devices/virtual/block/ram14
N: ram14

P: /devices/virtual/block/ram15
N: ram15

P: /devices/virtual/block/ram2
N: ram2

P: /devices/virtual/block/ram3
N: ram3

P: /devices/virtual/block/ram4
N: ram4

P: /devices/virtual/block/ram5
N: ram5

P: /devices/virtual/block/ram6
N: ram6

P: /devices/virtual/block/ram7
N: ram7

P: /devices/virtual/block/ram8
N: ram8

P: /devices/virtual/block/ram9
N: ram9

P: /devices/virtual/cpuid/cpu0
N: cpu/0/cpuid

P: /devices/virtual/cpuid/cpu1
N: cpu/1/cpuid

P: /devices/virtual/hidraw/hidraw0
N: hidraw0

P: /devices/virtual/input/input4/event4
N: input/event4

P: /devices/virtual/input/input4/mouse0
N: input/mouse0

P: /devices/virtual/input/mice
N: input/mice

P: /devices/virtual/mem/full
N: full

P: /devices/virtual/mem/kmsg
N: kmsg

P: /devices/virtual/mem/mem
N: mem

P: /devices/virtual/mem/null
N: null
S: XOR

P: /devices/virtual/mem/oldmem
N: oldmem

P: /devices/virtual/mem/port
N: port

P: /devices/virtual/mem/random
N: random

P: /devices/virtual/mem/urandom
N: urandom

P: /devices/virtual/mem/zero
N: zero

P: /devices/virtual/misc/agpgart
N: agpgart

P: /devices/virtual/misc/cpu_dma_latency
N: cpu_dma_latency

P: /devices/virtual/misc/device-mapper
N: mapper/control

P: /devices/virtual/misc/fuse
N: fuse

P: /devices/virtual/misc/hpet
N: hpet

P: /devices/virtual/misc/network_latency
N: network_latency

P: /devices/virtual/misc/network_throughput
N: network_throughput

P: /devices/virtual/misc/nvram
N: nvram

P: /devices/virtual/misc/snapshot
N: snapshot

P: /devices/virtual/msr/msr0
N: cpu/0/msr

P: /devices/virtual/msr/msr1
N: cpu/1/msr

P: /devices/virtual/ppp/ppp
N: ppp
R:1

P: /devices/virtual/raw/rawctl
N: raw/rawctl

P: /devices/virtual/sound/seq
N: snd/seq

P: /devices/virtual/sound/sequencer
N: sequencer

P: /devices/virtual/sound/sequencer2
N: sequencer2

P: /devices/virtual/sound/timer
N: snd/timer

P: /devices/virtual/tty/console
N: console

P: /devices/virtual/tty/ptmx
N: ptmx

P: /devices/virtual/tty/tty
N: tty

P: /devices/virtual/tty/tty0
N: tty0

P: /devices/virtual/tty/tty1
N: tty1

P: /devices/virtual/tty/tty10
N: tty10

P: /devices/virtual/tty/tty11
N: tty11

P: /devices/virtual/tty/tty12
N: tty12

P: /devices/virtual/tty/tty13
N: tty13

P: /devices/virtual/tty/tty14
N: tty14

P: /devices/virtual/tty/tty15
N: tty15

P: /devices/virtual/tty/tty16
N: tty16

P: /devices/virtual/tty/tty17
N: tty17

P: /devices/virtual/tty/tty18
N: tty18

P: /devices/virtual/tty/tty19
N: tty19

P: /devices/virtual/tty/tty2
N: tty2

P: /devices/virtual/tty/tty20
N: tty20

P: /devices/virtual/tty/tty21
N: tty21

P: /devices/virtual/tty/tty22
N: tty22

P: /devices/virtual/tty/tty23
N: tty23

P: /devices/virtual/tty/tty24
N: tty24

P: /devices/virtual/tty/tty25
N: tty25

P: /devices/virtual/tty/tty26
N: tty26

P: /devices/virtual/tty/tty27
N: tty27

P: /devices/virtual/tty/tty28
N: tty28

P: /devices/virtual/tty/tty29
N: tty29

P: /devices/virtual/tty/tty3
N: tty3

P: /devices/virtual/tty/tty30
N: tty30

P: /devices/virtual/tty/tty31
N: tty31

P: /devices/virtual/tty/tty32
N: tty32

P: /devices/virtual/tty/tty33
N: tty33

P: /devices/virtual/tty/tty34
N: tty34

P: /devices/virtual/tty/tty35
N: tty35

P: /devices/virtual/tty/tty36
N: tty36

P: /devices/virtual/tty/tty37
N: tty37

P: /devices/virtual/tty/tty38
N: tty38

P: /devices/virtual/tty/tty39
N: tty39

P: /devices/virtual/tty/tty4
N: tty4

P: /devices/virtual/tty/tty40
N: tty40

P: /devices/virtual/tty/tty41
N: tty41

P: /devices/virtual/tty/tty42
N: tty42

P: /devices/virtual/tty/tty43
N: tty43

P: /devices/virtual/tty/tty44
N: tty44

P: /devices/virtual/tty/tty45
N: tty45

P: /devices/virtual/tty/tty46
N: tty46

P: /devices/virtual/tty/tty47
N: tty47

P: /devices/virtual/tty/tty48
N: tty48

P: /devices/virtual/tty/tty49
N: tty49

P: /devices/virtual/tty/tty5
N: tty5

P: /devices/virtual/tty/tty50
N: tty50

P: /devices/virtual/tty/tty51
N: tty51

P: /devices/virtual/tty/tty52
N: tty52

P: /devices/virtual/tty/tty53
N: tty53

P: /devices/virtual/tty/tty54
N: tty54

P: /devices/virtual/tty/tty55
N: tty55

P: /devices/virtual/tty/tty56
N: tty56

P: /devices/virtual/tty/tty57
N: tty57

P: /devices/virtual/tty/tty58
N: tty58

P: /devices/virtual/tty/tty59
N: tty59

P: /devices/virtual/tty/tty6
N: tty6

P: /devices/virtual/tty/tty60
N: tty60

P: /devices/virtual/tty/tty61
N: tty61

P: /devices/virtual/tty/tty62
N: tty62

P: /devices/virtual/tty/tty63
N: tty63

P: /devices/virtual/tty/tty7
N: tty7

P: /devices/virtual/tty/tty8
N: tty8

P: /devices/virtual/tty/tty9
N: tty9

P: /devices/virtual/usbmon/usbmon0
N: usbmon0

P: /devices/virtual/vc/vcs
N: vcs

P: /devices/virtual/vc/vcs1
N: vcs1

P: /devices/virtual/vc/vcs2
N: vcs2

P: /devices/virtual/vc/vcs3
N: vcs3

P: /devices/virtual/vc/vcs4
N: vcs4

P: /devices/virtual/vc/vcs5
N: vcs5

P: /devices/virtual/vc/vcs6
N: vcs6

P: /devices/virtual/vc/vcs7
N: vcs7

P: /devices/virtual/vc/vcsa
N: vcsa

P: /devices/virtual/vc/vcsa1
N: vcsa1

P: /devices/virtual/vc/vcsa2
N: vcsa2

P: /devices/virtual/vc/vcsa3
N: vcsa3

P: /devices/virtual/vc/vcsa4
N: vcsa4

P: /devices/virtual/vc/vcsa5
N: vcsa5

P: /devices/virtual/vc/vcsa6
N: vcsa6

P: /devices/virtual/vc/vcsa7
N: vcsa7

[root heron colinc]# NM_SERIAL_DEBUG=1 /usr/sbin/NetworkManager --no-daemon
NetworkManager: <info>  starting...
-- Error received: File exists
-- Original message: type=0x14 length=56 flags=<REQUEST,ACK,ATOMIC> sequence-nr=1237399876 pid=4199975
NetworkManager: <WARN>  nm_generic_enable_loopback(): error -17 returned from rtnl_addr_add():
Sucess

NetworkManager: <info>  (eth0): new Ethernet device (driver: 'sis190')
NetworkManager: <info>  (eth0): exported as /org/freedesktop/Hal/devices/net_00_03_0d_90_44_e8
NetworkManager: <info>  (eth0): device state change: 1 -> 2
NetworkManager: <info>  (eth0): bringing up device.
NetworkManager: <info>  (eth0): preparing device.
NetworkManager: <info>  (eth0): deactivating device (reason: 2).
NetworkManager: <info>  (ttyUSB1): detected GSM modem via udev capabilities
NetworkManager: <info>  (ttyUSB1): new Modem device (driver: 'option')
NetworkManager: <info>  (ttyUSB1): exported as /org/freedesktop/Hal/devices/usb_device_12d1_1003_noserial_if1_serial_usb_1
NetworkManager: <info>  (ttyUSB0): detected GSM modem via udev capabilities
NetworkManager: <info>  (ttyUSB0): new Modem device (driver: 'option')
NetworkManager: <info>  (ttyUSB0): exported as /org/freedesktop/Hal/devices/usb_device_12d1_1003_noserial_if0_serial_usb_0
NetworkManager: <info>  (ttyUSB1): device state change: 1 -> 2
NetworkManager: <info>  (ttyUSB1): deactivating device (reason: 2).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  (ttyUSB1): device state change: 2 -> 3
NetworkManager: <info>  Activation (ttyUSB1) starting connection '3 UK Broadband'
NetworkManager: <info>  (ttyUSB1): device state change: 3 -> 4
NetworkManager: <info>  Activation (ttyUSB1) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info>  Activation (ttyUSB1) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <debug> [1237399899.400671] nm_serial_device_open(): (ttyUSB1) opening device...
NetworkManager: <info>  Activation (ttyUSB1) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1237399899.521283] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237399899.575185] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <debug> [1237399906.595996] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed



^RSSI:12

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (1)
NetworkManager: <debug> [1237399910.000767] nm_serial_debug(): Sending: 'ATZ E0 V1 &C1
'
NetworkManager: <info>  (ttyUSB0): device state change: 1 -> 2
NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 2).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <debug> [1237399910.096518] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (2)
NetworkManager: <debug> [1237399921.001103] nm_serial_debug(): Sending: 'AT&F E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237399921.056948] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <debug> [1237399922.502580] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed



^BOOT:82600852,0,0,0,6

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (3)
NetworkManager: <debug> [1237399932.000624] nm_serial_debug(): Sending: 'AT&F E0 V1 &C1
'
NetworkManager: <debug> [1237399932.036398] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (4)
NetworkManager: <debug> [1237399943.000746] nm_serial_debug(): Sending: 'AT&F E0 V1
'
NetworkManager: <debug> [1237399943.022509] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <debug> [1237399952.501019] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed



^BOOT:82600852,0,0,0,6

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (5)
NetworkManager: <debug> [1237399954.001227] nm_serial_debug(): Sending: '
AT&F E0 V1 X4 &C1 +CREG=0 +FCLASS=0
'
NetworkManager: <debug> [1237399954.076836] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <WARN>  init_done(): Modem initialization failed
NetworkManager: <info>  (ttyUSB1): device state change: 4 -> 9
NetworkManager: <debug> [1237399965.000637] nm_serial_device_close(): Closing device 'ttyUSB1'
NetworkManager: <info>  Marking connection '3 UK Broadband' invalid.
NetworkManager: <info>  Activation (ttyUSB1) failed.
NetworkManager: <info>  (ttyUSB0): device state change: 2 -> 3
NetworkManager: <info>  (ttyUSB1): device state change: 9 -> 3
NetworkManager: <info>  (ttyUSB1): deactivating device (reason: 0).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  Activation (ttyUSB1) starting connection '3 UK Broadband'
NetworkManager: <info>  (ttyUSB1): device state change: 3 -> 4
NetworkManager: <info>  Activation (ttyUSB1) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info>  Activation (ttyUSB1) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <debug> [1237400312.536730] nm_serial_device_open(): (ttyUSB1) opening device...
NetworkManager: <info>  Activation (ttyUSB1) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1237400312.658422] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237400312.723303] nm_serial_debug(): Got: '

^BOOT:82600852,0,0,0,6

'
NetworkManager: <debug> [1237400312.724245] nm_serial_debug(): Got: '

^BOOT:82600852,0,0,0,6



+CME ERROR: operation not allowed

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (1)
NetworkManager: <debug> [1237400323.000876] nm_serial_debug(): Sending: 'ATZ E0 V1 &C1
'
NetworkManager: <debug> [1237400323.028803] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (2)
NetworkManager: <debug> [1237400334.001267] nm_serial_debug(): Sending: 'AT&F E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237400334.057419] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <debug> [1237400342.478740] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed



^BOOT:82600852,0,0,0,6

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (3)
NetworkManager: <debug> [1237400345.001617] nm_serial_debug(): Sending: 'AT&F E0 V1 &C1
'
NetworkManager: <debug> [1237400345.031577] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (4)
NetworkManager: <debug> [1237400356.000931] nm_serial_debug(): Sending: 'AT&F E0 V1
'
NetworkManager: <debug> [1237400356.025747] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (5)
NetworkManager: <debug> [1237400367.001187] nm_serial_debug(): Sending: '
AT&F E0 V1 X4 &C1 +CREG=0 +FCLASS=0
'
NetworkManager: <debug> [1237400367.075047] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed

'
NetworkManager: <debug> [1237400372.477183] nm_serial_debug(): Got: '

+CME ERROR: operation not allowed



^BOOT:82600852,0,0,0,6

'
NetworkManager: <WARN>  init_done(): Modem initialization failed
NetworkManager: <info>  (ttyUSB1): device state change: 4 -> 9
NetworkManager: <debug> [1237400378.000752] nm_serial_device_close(): Closing device 'ttyUSB1'
NetworkManager: <info>  Marking connection '3 UK Broadband' invalid.
NetworkManager: <info>  Activation (ttyUSB1) failed.
NetworkManager: <info>  (ttyUSB1): device state change: 9 -> 3
NetworkManager: <info>  (ttyUSB1): deactivating device (reason: 0).
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  Activation (ttyUSB0) starting connection '3 UK Broadband'
NetworkManager: <info>  (ttyUSB0): device state change: 3 -> 4
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <debug> [1237400388.136668] nm_serial_device_open(): (ttyUSB0) opening device...
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <debug> [1237400388.258453] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237400388.315829] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237400388.338532] nm_serial_debug(): Got: 'ATZ E0 V1 X4 &C1 +FCLASS=0


OK

'
NetworkManager: <debug> [1237400388.338798] nm_serial_debug(): Sending: 'AT+CPIN?
'
NetworkManager: <debug> [1237400388.356813] nm_serial_debug(): Got: '

+CPIN: READY



OK

'
NetworkManager: <debug> [1237400388.356971] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'
NetworkManager: <debug> [1237400388.434524] nm_serial_debug(): Got: '

OK

'
NetworkManager: <info>  (ttyUSB0): powering up...
NetworkManager: <debug> [1237400388.434892] nm_serial_debug(): Sending: 'AT+CFUN=1
'
NetworkManager: <debug> [1237400388.456492] nm_serial_debug(): Got: '

OK

'
NetworkManager: <debug> [1237400388.456987] nm_serial_debug(): Sending: 'AT+CGMM
'
NetworkManager: <debug> [1237400388.474459] nm_serial_debug(): Got: '

E220



OK

'
NetworkManager: <debug> [1237400388.474937] nm_serial_debug(): Sending: 'AT+CREG?
'
NetworkManager: <debug> [1237400388.497108] nm_serial_debug(): Got: '

+CREG: 0,1



OK

'
NetworkManager: <info>  Registered on Home network
NetworkManager: <debug> [1237400388.497525] nm_serial_debug(): Sending: 'AT+COPS?
'
NetworkManager: <debug> [1237400388.516555] nm_serial_debug(): Got: '

+COPS: 0,0,"3 UK",2



OK

'
NetworkManager: <info>  Associated with network: +COPS: 0,0,"3 UK",2
NetworkManager: <debug> [1237400388.517482] nm_serial_debug(): Sending: 'ATDT*99#
'
NetworkManager: <debug> [1237400388.540513] nm_serial_debug(): Got: '

CONNECT 3600000

'
NetworkManager: <info>  Connected, Woo!
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
NetworkManager: <info>  (ttyUSB0): device state change: 4 -> 5
NetworkManager: <info>  Starting pppd connection
NetworkManager: <debug> [1237400388.580743] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute ttyUSB0 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/0 plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so
NetworkManager: <debug> [1237400388.583114] nm_ppp_manager_start(): ppp started with pid 5850
Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Using interface ppp0
Connect: ppp0 <--> /dev/ttyUSB0
NetworkManager: <info>  (ttyUSB0): device state change: 5 -> 6
CHAP authentication succeeded
CHAP authentication succeeded
NetworkManager: <info>  (ttyUSB0): device state change: 6 -> 7
Could not determine remote IP address: defaulting to 10.64.64.64
local  IP address 92.40.15.152
remote IP address 10.64.64.64
primary   DNS address 4.2.2.4
secondary DNS address 4.2.2.3
NetworkManager: <info>  PPP manager(IP Config Get) reply received.
NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) started...
NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP Configure Get) complete.
NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) started...
NetworkManager: <info>  (ttyUSB0): device state change: 7 -> 8
NetworkManager: <info>  Policy set '3 UK Broadband' (ppp0) as default for routing and DNS.
NetworkManager: <info>  Activation (ttyUSB0) successful, device activated.
NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) complete.
NetworkManager: <info>  Sleeping...
NetworkManager: <info>  (eth0): now unmanaged
NetworkManager: <info>  (eth0): device state change: 2 -> 1
NetworkManager: <info>  (eth0): cleaning up...
NetworkManager: <info>  (eth0): taking down device.
NetworkManager: <info>  (ttyUSB1): now unmanaged
NetworkManager: <info>  (ttyUSB1): device state change: 3 -> 1
NetworkManager: <info>  (ttyUSB1): cleaning up...
NetworkManager: <info>  (ttyUSB1): taking down device.
NetworkManager: <info>  (ttyUSB0): now unmanaged
NetworkManager: <info>  (ttyUSB0): device state change: 8 -> 1
NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 37).
Terminating on signal 15
Connect time 0.1 minutes.
Sent 0 bytes, received 0 bytes.
NetworkManager: <debug> [1237400396.106597] nm_serial_device_close(): Closing device 'ttyUSB0'
Connection terminated.
NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
NetworkManager: <info>  (ttyUSB0): cleaning up...
NetworkManager: <info>  (ttyUSB0): taking down device.
NetworkManager: <debug> [1237400398.332256] ensure_killed(): waiting for ppp pid 5850 to exit
NetworkManager: <debug> [1237400398.332597] ensure_killed(): ppp pid 5850 cleaned up
^CNetworkManager: <WARN>  nm_signal_handler(): Caught signal 2, shutting down normally.
NetworkManager: <info>  exiting (success)
[root heron colinc]# 




[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]