Re: NM and Nokia N95
- From: Dan Williams <dcbw redhat com>
- To: Robert Piasek <robert piasek co uk>
- Cc: networkmanager-list gnome org
- Subject: Re: NM and Nokia N95
- Date: Tue, 22 Sep 2009 22:11:06 -0700
On Thu, 2009-09-17 at 12:35 +0100, Robert Piasek wrote:
> On Sunday 13 September 2009 22:47:50 Robert Piasek wrote:
> > Hi,
> >
> > I'm trying to connect my Nokia N95 using phonet driver and NM. Device is
> > picked up by kernel and properly initialized, but it doesn't connect due to
> > some problems with ppp. Please have a look on log below and let me know
> > what can be done to make it work.
> >
>
> I've also tried with trunk version of NM (less than month old) and modem-
> manager. Modem is timing out. Some logs:
>
> modem-manager --debug:
> ** Message: (ttyS1) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyS1): probe requested by plugin 'Generic'
> ** (modem-manager:9049): DEBUG: (ttyS1): --> 'AT+GCAP<CR>'
> ** (modem-manager:9049): DEBUG: (ttyS1): --> 'AT+GCAP<CR>'
> ** (modem-manager:9049): DEBUG: (ttyS1): --> 'AT+GCAP<CR>'
> ** Message: (ttyS1) closing serial device...
> ** Message: (ttyACM2) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyACM2): probe requested by plugin 'Nokia'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+GCAP<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- 'AT+GCAP<CR><CR><LF>+GCAP:
> +CGSM,+DS,+W<CR><LF><CR><LF>OK<CR><LF>'
> ** Message: (ttyACM2) closing serial device...
> ** Message: (Nokia): GSM modem /sys/devices/pci0000:00/0000:00:1a.1/usb4/4-2
> claimed port ttyACM2
> ** (modem-manager:9049): DEBUG: Added modem
> /sys/devices/pci0000:00/0000:00:1a.1/usb4/4-2
> ** (modem-manager:9049): DEBUG: Exported modem
> /sys/devices/pci0000:00/0000:00:1a.1/usb4/4-2 as
> /org/freedesktop/ModemManager/Modems/0
> ** Message: (ttyACM2) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'ATZ E0 V1 X4 &C1 +CMEE=1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- 'ATZ E0 V1 X4 &C1
> +CMEE=1<CR><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'ATE0 +CMEE=1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- 'ATE0 +CMEE='
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CREG=0<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CFUN=1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CPIN?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>+CPIN:
> READY<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+COPS=0,,<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>+CREG:
> 0,1<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: Registration state changed: 1
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+COPS=3,2;+COPS?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>+COPS:
> 0,2,"23420",2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+COPS=3,0;+COPS?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>+COPS: 0,0,"3
> UK",2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CSQ<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>+CSQ:
> 8,99<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CGDCONT?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>+CGDCONT:
> 1,"IP",,,0,0<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CGDCONT=?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>+CGDCONT: (1),"IP",,,
> (0),(0)<CR><LF>+CGDCONT: (1),"IPV6",,,(0),(0)<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CGDCONT=1, "IP",
> "3internet"<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'ATD*99***1#<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <--
> '<CR><LF>CONNECT<CR><LF>~\-1}#\-64!}!} } }2}#}$\-64#}!}$}%\-36}"}&} }*} }
> g}%~'
We might have actually fixed a few bugs in this area, what specific date
are these checkouts of NM and MM from?
Dan
> (networkmanager times out here)
> ** (modem-manager:9049): DEBUG: (ttyACM2): --> 'AT+CEER<CR>'
> ** (modem-manager:9049): DEBUG: (ttyACM2): <-- '<CR><LF>OK<CR><LF>'
>
> and NM logs:
> Sep 17 12:20:00 [kernel] [674137.408270] usb 4-2: new full speed USB device
> using uhci_hcd and address 4
> Sep 17 12:20:00 [kernel] [674137.587094] usb 4-2: New USB device found,
> idVendor=0421, idProduct=0070
> Sep 17 12:20:00 [kernel] [674137.587097] usb 4-2: New USB device strings:
> Mfr=1, Product=2, SerialNumber=0
> Sep 17 12:20:00 [kernel] [674137.587100] usb 4-2: Product: Nokia N95 8GB
> Sep 17 12:20:00 [kernel] [674137.587101] usb 4-2: Manufacturer: Nokia
> Sep 17 12:20:00 [kernel] [674137.587206] usb 4-2: configuration #1 chosen from
> 1 choice
> Sep 17 12:20:00 [kernel] [674137.602190] cdc_acm 4-2:1.10: ttyACM2: USB ACM
> device
> Sep 17 12:20:00 [kernel] [674137.609135] usb 4-2: bad CDC descriptors
> Sep 17 12:20:02 [NetworkManager] <info> (ttyACM2): new GSM device (driver:
> 'cdc_acm')_
> Sep 17 12:20:02 [NetworkManager] <info> (ttyACM2): exported as
> /org/freedesktop/NetworkManager/Devices/1_
> Sep 17 12:20:02 [NetworkManager] <info> (ttyACM2): now managed_
> Sep 17 12:20:02 [NetworkManager] <info> (ttyACM2): device state change: 1 ->
> 2 (reason 2)_
> Sep 17 12:20:02 [NetworkManager] <info> (ttyACM2): deactivating device
> (reason: 2)._
> Sep 17 12:20:02 [NetworkManager] flush_routes: assertion `iface_idx >= 0'
> failed
> Sep 17 12:20:02 [NetworkManager] flush_addresses: assertion `iface_idx >= 0'
> failed
> Sep 17 12:20:02 [NetworkManager] <info> (ttyACM2): device state change: 2 ->
> 3 (reason 0)_
> Sep 17 12:20:02 [NetworkManager] <info> Activation (ttyACM2) starting
> connection '3'_
> Sep 17 12:20:02 [NetworkManager] <info> (ttyACM2): device state change: 3 ->
> 4 (reason 0)_
> Sep 17 12:20:02 [NetworkManager] <info> Activation (ttyACM2) Stage 1 of 5
> (Device Prepare) scheduled..._
> Sep 17 12:20:02 [NetworkManager] <info> Activation (ttyACM2) Stage 1 of 5
> (Device Prepare) started..._
> Sep 17 12:20:02 [NetworkManager] <info> Activation (ttyACM2) Stage 1 of 5
> (Device Prepare) complete._
> Sep 17 12:21:02 [NetworkManager] <WARN> stage1_prepare_done(): GSM modem
> connection failed: Serial command timed out_
> Sep 17 12:21:02 [NetworkManager] <info> (ttyACM2): device state change: 4 ->
> 9 (reason 1)_
> Sep 17 12:21:02 [NetworkManager] <info> Marking connection '3' invalid._
> Sep 17 12:21:02 [NetworkManager] <info> Activation (ttyACM2) failed._
> Sep 17 12:21:02 [NetworkManager] <info> (ttyACM2): device state change: 9 ->
> 3 (reason 0)_
> Sep 17 12:21:02 [NetworkManager] <info> (ttyACM2): deactivating device
> (reason: 0)._
> Sep 17 12:21:02 [NetworkManager] <info> (eth0): writing resolv.conf to
> /sbin/resolvconf_
> Sep 17 12:21:02 [NetworkManager] <info> Policy set 'Auto eth0' (eth0) as
> default for routing and DNS._
> Sep 17 12:21:02 [NetworkManager] flush_routes: assertion `iface_idx >= 0'
> failed
> Sep 17 12:21:02 [NetworkManager] flush_addresses: assertion `iface_idx >= 0'
> failed
>
> The same sim card works ok with Heuwai modem:
>
> modem-manager --debug
> ** Message: (ttyUSB0) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyUSB0): probe requested by plugin 'Huawei'
> ** (modem-manager:9049): DEBUG: (Huawei): (ttyUSB1) deferring support check
> ** (modem-manager:9049): DEBUG: (Huawei): (ttyUSB2) deferring support check
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+GCAP<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- 'AT+GCAP<CR><CR><LF>+GCAP:
> +CGSM,+FCLASS,+DS<CR><LF><CR><LF>OK<CR><LF>'
> ** Message: (ttyUSB0) closing serial device...
> ** Message: (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1a.1/usb4/4-1
> claimed port ttyUSB0
> ** (modem-manager:9049): DEBUG: Added modem
> /sys/devices/pci0000:00/0000:00:1a.1/usb4/4-1
> ** (modem-manager:9049): DEBUG: Exported modem
> /sys/devices/pci0000:00/0000:00:1a.1/usb4/4-1 as
> /org/freedesktop/ModemManager/Modems/1
> ** (modem-manager:9049): DEBUG: (ttyUSB1): re-checking support...
> ** Message: (ttyUSB1) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyUSB2): re-checking support...
> ** Message: (ttyUSB2) opening serial device...
> ** Message: (ttyUSB1) closing serial device...
> ** Message: (ttyUSB1) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyUSB1): probe requested by plugin 'Generic'
> ** Message: (ttyUSB2) closing serial device...
> ** Message: (ttyUSB2) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyUSB2): probe requested by plugin 'Generic'
> ** (modem-manager:9049): DEBUG: (ttyUSB2): <--
> '<CR><LF>^RSSI:31<CR><LF><CR><LF>^SRVST:1<CR><LF><CR><LF>^MODE:5,4<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB1): --> 'AT+GCAP<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB2): --> 'AT+GCAP<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB2): <--
> 'AT+GCAP<CR><LF>^RSSI:7<CR><LF><CR><CR><LF>+GCAP: +CGSM,+DS,
> +ES<CR><LF><CR><LF>OK<CR><LF>'
> ** Message: (ttyUSB2) closing serial device...
> ** Message: (Generic): GSM modem /sys/devices/pci0000:00/0000:00:1a.1/usb4/4-1
> claimed port ttyUSB2
> ** (modem-manager:9049): DEBUG: (ttyUSB1): --> 'AT+GCAP<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB1): --> 'AT+GCAP<CR>'
> ** Message: (ttyUSB1) closing serial device...
> ** Message: (ttyACM2) opening serial device...
> ** Message: (ttyUSB0) opening serial device...
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'ATZ E0 V1 X4 &C1 +CMEE=1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- 'ATZ E0 V1 X4 &C1 +CMEE=1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'ATE0 +CMEE=1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG=0<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CFUN=1<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CPIN?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CPIN:
> READY<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+COPS=0,,<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CREG:
> 0,2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: Registration state changed: 2
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CREG:
> 0,2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CREG:
> 0,2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CREG:
> 0,2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CREG:
> 0,0<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: Registration state changed: 0
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CREG:
> 0,0<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CREG?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CREG:
> 0,1<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: Registration state changed: 1
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+COPS=3,2;+COPS?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+COPS:
> 0,2,"23420",2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+COPS=3,0;+COPS?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+COPS: 0,0,"3
> UK",2<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CSQ<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CSQ:
> 7,99<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'AT+CGDCONT?<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>+CGDCONT:
> 1,"IP","3internet","0.0.0.0",0,0<CR><LF>+CGDCONT:
> 2,"IP","three.co.uk","0.0.0.0",0,0<CR><LF><CR><LF>OK<CR><LF>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): --> 'ATD*99***1#<CR>'
> ** (modem-manager:9049): DEBUG: (ttyUSB0): <-- '<CR><LF>CONNECT
> 3600000<CR><LF>'
>
> and NM logs:
> Sep 17 12:26:41 [kernel] [674538.232464] usb 4-1: new full speed USB device
> using uhci_hcd and address 5
> Sep 17 12:26:41 [kernel] [674538.396104] usb 4-1: New USB device found,
> idVendor=12d1, idProduct=1001
> Sep 17 12:26:41 [kernel] [674538.396108] usb 4-1: New USB device strings:
> Mfr=1, Product=2, SerialNumber=1
> Sep 17 12:26:41 [kernel] [674538.396110] usb 4-1: Product: HUAWEI Mobile
> Sep 17 12:26:41 [kernel] [674538.396112] usb 4-1: Manufacturer:
> ÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿ
> Sep 17 12:26:41 [kernel] [674538.396114] usb 4-1: SerialNumber:
> ÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿ
> Sep 17 12:26:41 [kernel] [674538.396212] usb 4-1: configuration #1 chosen from
> 1 choice
> Sep 17 12:26:41 [kernel] [674538.580048] usb 4-1: USB disconnect, address 5
> Sep 17 12:26:42 [kernel] [674539.312270] usb 4-1: new full speed USB device
> using uhci_hcd and address 6
> Sep 17 12:26:42 [kernel] [674539.478078] usb 4-1: New USB device found,
> idVendor=12d1, idProduct=1001
> Sep 17 12:26:42 [kernel] [674539.478081] usb 4-1: New USB device strings:
> Mfr=1, Product=2, SerialNumber=1
> Sep 17 12:26:42 [kernel] [674539.478083] usb 4-1: Product: HUAWEI Mobile
> Sep 17 12:26:42 [kernel] [674539.478085] usb 4-1: Manufacturer:
> ÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿ
> Sep 17 12:26:42 [kernel] [674539.478087] usb 4-1: SerialNumber:
> ÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿÿ
> Sep 17 12:26:42 [kernel] [674539.478183] usb 4-1: configuration #1 chosen from
> 1 choice
> Sep 17 12:26:42 [kernel] [674539.579069] usbcore: registered new interface
> driver usbserial
> Sep 17 12:26:42 [kernel] [674539.579082] USB Serial support registered for
> generic
> Sep 17 12:26:42 [kernel] [674539.579131] usbcore: registered new interface
> driver usbserial_generic
> Sep 17 12:26:42 [kernel] [674539.579133] usbserial: USB Serial Driver core
> Sep 17 12:26:42 [kernel] [674539.582191] USB Serial support registered for GSM
> modem (1-port)
> Sep 17 12:26:42 [kernel] [674539.582236] option 4-1:1.0: GSM modem (1-port)
> converter detected
> Sep 17 12:26:42 [kernel] [674539.582324] usb 4-1: GSM modem (1-port) converter
> now attached to ttyUSB0
> Sep 17 12:26:42 [kernel] [674539.582335] option 4-1:1.1: GSM modem (1-port)
> converter detected
> Sep 17 12:26:42 [kernel] [674539.582374] usb 4-1: GSM modem (1-port) converter
> now attached to ttyUSB1
> Sep 17 12:26:42 [kernel] [674539.582383] option 4-1:1.2: GSM modem (1-port)
> converter detected
> Sep 17 12:26:42 [kernel] [674539.582424] usb 4-1: GSM modem (1-port) converter
> now attached to ttyUSB2
> Sep 17 12:26:42 [kernel] [674539.582438] usbcore: registered new interface
> driver option
> Sep 17 12:26:42 [kernel] [674539.582440] option: v0.7.2:USB Driver for GSM
> modems
> Sep 17 12:26:43 [NetworkManager] <info> (ttyUSB0): new GSM device (driver:
> 'option1')_
> Sep 17 12:26:43 [NetworkManager] <info> (ttyUSB0): exported as
> /org/freedesktop/NetworkManager/Devices/2_
> Sep 17 12:26:43 [NetworkManager] <info> (ttyUSB0): now managed_
> Sep 17 12:26:43 [NetworkManager] <info> (ttyUSB0): device state change: 1 ->
> 2 (reason 2)_
> Sep 17 12:26:43 [NetworkManager] <info> (ttyUSB0): deactivating device
> (reason: 2)._
> Sep 17 12:26:43 [NetworkManager] flush_routes: assertion `iface_idx >= 0'
> failed
> Sep 17 12:26:43 [NetworkManager] flush_addresses: assertion `iface_idx >= 0'
> failed
> Sep 17 12:26:43 [NetworkManager] <info> (ttyUSB0): device state change: 2 ->
> 3 (reason 0)_
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyACM2) starting
> connection '3'_
> Sep 17 12:29:21 [NetworkManager] <info> (ttyACM2): device state change: 3 ->
> 4 (reason 0)_
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyACM2) Stage 1 of 5
> (Device Prepare) scheduled..._
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyUSB0) starting
> connection '3'_
> Sep 17 12:29:21 [NetworkManager] <info> (ttyUSB0): device state change: 3 ->
> 4 (reason 0)_
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyUSB0) Stage 1 of 5
> (Device Prepare) scheduled..._
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyACM2) Stage 1 of 5
> (Device Prepare) started..._
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyACM2) Stage 1 of 5
> (Device Prepare) complete._
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyUSB0) Stage 1 of 5
> (Device Prepare) started..._
> Sep 17 12:29:21 [NetworkManager] <info> Activation (ttyUSB0) Stage 1 of 5
> (Device Prepare) complete._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 2 of 5
> (Device Configure) scheduled..._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 2 of 5
> (Device Configure) starting..._
> Sep 17 12:29:28 [NetworkManager] <info> (ttyUSB0): device state change: 4 ->
> 5 (reason 0)_
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 2 of 5
> (Device Configure) successful._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 3 of 5 (IP
> Configure Start) scheduled._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 2 of 5
> (Device Configure) complete._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 3 of 5 (IP
> Configure Start) started..._
> Sep 17 12:29:28 [NetworkManager] <info> (ttyUSB0): device state change: 5 ->
> 7 (reason 0)_
> Sep 17 12:29:28 [NetworkManager] <info> Starting pppd connection_
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 4 of 5
> (IP6 Configure Get) scheduled..._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 3 of 5 (IP
> Configure Start) complete._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 4 of 5
> (IP6 Configure Get) started..._
> Sep 17 12:29:28 [NetworkManager] <info> Activation (ttyUSB0) Stage 4 of 5
> (IP6 Configure Get) complete._
> Sep 17 12:29:28 [pppd] Plugin /usr/lib64/pppd/2.4.4/nm-pppd-plugin.so loaded.
> Sep 17 12:29:28 [pppd] pppd 2.4.4 started by root, uid 0
> Sep 17 12:29:28 [pppd] Using interface ppp0
> Sep 17 12:29:28 [pppd] Connect: ppp0 <--> /dev/ttyUSB0
> Sep 17 12:29:28 [NetworkManager] <info> (ttyUSB0): device state change: 7 ->
> 6 (reason 0)_
> Sep 17 12:29:31 [pppd] CHAP authentication succeeded
> - Last output repeated twice -
> Sep 17 12:29:31 [NetworkManager] <info> (ttyUSB0): device state change: 6 ->
> 7 (reason 0)_
> Sep 17 12:29:39 [pppd] Could not determine remote IP address: defaulting to
> 10.64.64.64
> Sep 17 12:29:39 [pppd] local IP address 94.196.32.250
> Sep 17 12:29:39 [pppd] remote IP address 10.64.64.64
> Sep 17 12:29:39 [pppd] primary DNS address 10.11.12.13
> Sep 17 12:29:39 [pppd] secondary DNS address 10.11.12.14
> Sep 17 12:29:39 [NetworkManager] <info> PPP manager(IP Config Get) reply
> received._
> Sep 17 12:29:39 [NetworkManager] <info> Activation (ttyUSB0) Stage 4 of 5
> (IP4 Configure Get) scheduled..._
> Sep 17 12:29:39 [NetworkManager] <info> Activation (ttyUSB0) Stage 4 of 5
> (IP4 Configure Get) started..._
> Sep 17 12:29:39 [NetworkManager] <info> Activation (ttyUSB0) Stage 5 of 5 (IP
> Configure Commit) scheduled..._
> Sep 17 12:29:39 [NetworkManager] <info> Activation (ttyUSB0) Stage 4 of 5
> (IP4 Configure Get) complete._
> Sep 17 12:29:39 [NetworkManager] <info> Activation (ttyUSB0) Stage 5 of 5 (IP
> Configure Commit) started..._
> Sep 17 12:29:40 [NetworkManager] <info> (ppp0): writing resolv.conf to
> /sbin/resolvconf_
> Sep 17 12:29:40 [NetworkManager] <info> (eth0): writing resolv.conf to
> /sbin/resolvconf_
> Sep 17 12:29:40 [NetworkManager] <info> Policy set 'Auto eth0' (eth0) as
> default for routing and DNS._
> Sep 17 12:29:40 [NetworkManager] <info> (ttyUSB0): device state change: 7 ->
> 8 (reason 0)_
> Sep 17 12:29:40 [NetworkManager] <info> Activation (ttyUSB0) successful,
> device activated._
> Sep 17 12:29:40 [NetworkManager] <info> Activation (ttyUSB0) Stage 5 of 5 (IP
> Configure Commit) complete._
>
> I think the problem lies here:
> ** (modem-manager:9049): DEBUG: (ttyACM2): <--
> '<CR><LF>CONNECT<CR><LF>~\-1}#\-64!}!} } }2}#}$\-64#}!}$}%\-36}"}&} }*} }
> g}%~'
>
> Any help appreciated.
>
> Thanks,
> Rob
> _______________________________________________
> NetworkManager-list mailing list
> NetworkManager-list gnome org
> http://mail.gnome.org/mailman/listinfo/networkmanager-list
[
Date Prev][
Date Next] [
Thread Prev][
Thread Next]
[
Thread Index]
[
Date Index]
[
Author Index]
