HUAWEI E220, connection problems.



Hallo, 
i have HUAWEI E220 (Vodafone/Germany) and i have some random problems to
connect it on ubuntu karmik.
First of all, this do not working with 2.6.31. But you probably know it.
I use now recent master git 2.6.32-rc8-00011-ga8a8a66 and it is getting
connected some times. If i plug it, it will take like about 30-60
seconds till NM will start it. 
Normally first time the connection will fail, some times it will work on
second try. If you try too mach, this will not work at all.. only reboot
will help.

I do not know if it's driver or NM problem, so i sent mail to both
directions.

NM log is too big, so it is in attachment.

apt-cache policy network-manager
network-manager:
  Installiert: 0.8~a~git.20091013t193206.679d548-0ubuntu1
  Kandidat: 0.8~a~git.20091013t193206.679d548-0ubuntu1
  Versions-Tabelle:
 *** 0.8~a~git.20091013t193206.679d548-0ubuntu1 0
        500 http://de.archive.ubuntu.com karmic/main Packages
        100 /var/lib/dpkg/status


usb id of modem:
12d1:1003 Huawei Technologies Co., Ltd. E220 HSDPA Modem / E270
HSDPA/HSUPA Modem


dmesg:
[  170.228066] usb 4-2: new full speed USB device using uhci_hcd and
address 2
[  170.384901] usb 4-2: New USB device found, idVendor=12d1,
idProduct=1003
[  170.384915] usb 4-2: New USB device strings: Mfr=1, Product=2,
SerialNumber=0
[  170.384925] usb 4-2: Product: HUAWEI Mobile
[  170.384933] usb 4-2: Manufacturer: HUAWEI Technologies
[  170.386274] usb 4-2: configuration #1 chosen from 1 choice
[  170.457695] Initializing USB Mass Storage driver...
[  170.459952] scsi4 : SCSI emulation for USB Mass Storage devices
[  170.460508] usbcore: registered new interface driver usb-storage
[  170.460524] USB Mass Storage support registered.
[  170.467060] usb-storage: device found at 2
[  170.467072] usb-storage: waiting for device to settle before scanning
[  170.532105] usb 4-2: USB disconnect, address 2
[  171.264076] usb 4-2: new full speed USB device using uhci_hcd and
address 3
[  171.421339] usb 4-2: New USB device found, idVendor=12d1,
idProduct=1003
[  171.421352] usb 4-2: New USB device strings: Mfr=1, Product=2,
SerialNumber=0
[  171.421363] usb 4-2: Product: HUAWEI Mobile
[  171.421370] usb 4-2: Manufacturer: HUAWEI Technologies
[  171.422693] usb 4-2: configuration #1 chosen from 1 choice
[  171.449386] scsi7 : SCSI emulation for USB Mass Storage devices
[  171.457027] usb-storage: device found at 3
[  171.457034] usb-storage: waiting for device to settle before scanning
[  171.467503] USB Serial support registered for GSM modem (1-port)
[  171.467634] option 4-2:1.0: GSM modem (1-port) converter detected
[  171.470219] usb 4-2: GSM modem (1-port) converter now attached to
ttyUSB0
[  171.470260] option 4-2:1.1: GSM modem (1-port) converter detected
[  171.470648] usb 4-2: GSM modem (1-port) converter now attached to
ttyUSB1
[  171.470724] usbcore: registered new interface driver option
[  171.470732] option: v0.7.2:USB Driver for GSM modems
[  176.456719] usb-storage: device scan complete
[  176.459653] scsi 7:0:0:0: CD-ROM            HUAWEI   Mass Storage
2.31 PQ: 0 ANSI: 2
[  176.468424] scsi 7:0:0:0: Attached scsi generic sg1 type 5
[  186.888602] PPP generic driver version 2.4.2
[  187.006529] PPP BSD Compression module registered
[  187.078045] PPP Deflate Compression module registered
==========> modep pluged in and first try<==========================================================
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): new GSM device (driver: 'option1')
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/2
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): now managed
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): device state change: 1 -> 2 (reason 2)
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 2).
Nov 23 21:38:37 mini NetworkManager: flush_routes: assertion `iface_idx >= 0' failed
Nov 23 21:38:37 mini NetworkManager: flush_addresses: assertion `iface_idx >= 0' failed
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): device state change: 2 -> 3 (reason 0)
Nov 23 21:38:37 mini NetworkManager: <info>  Activation (ttyUSB0) starting connection 'Vodafone (D2) Vorgabe'
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): device state change: 3 -> 4 (reason 0)
Nov 23 21:38:37 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Nov 23 21:38:37 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): device state change: 4 -> 6 (reason 0)
Nov 23 21:38:37 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Nov 23 21:38:37 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Nov 23 21:38:37 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Nov 23 21:38:37 mini NetworkManager: <info>  (ttyUSB0): device state change: 6 -> 4 (reason 0)
Nov 23 21:38:37 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
Nov 23 21:38:40 mini NetworkManager: <info>  (ttyUSB0): device state change: 4 -> 5 (reason 0)
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
Nov 23 21:38:40 mini NetworkManager: <info>  (ttyUSB0): device state change: 5 -> 7 (reason 0)
Nov 23 21:38:40 mini NetworkManager: <info>  Starting pppd connection
Nov 23 21:38:40 mini NetworkManager: <debug> [1259008720.334980] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute user vodafone 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
Nov 23 21:38:40 mini NetworkManager: <debug> [1259008720.347969] nm_ppp_manager_start(): ppp started with pid 3141
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) started...
Nov 23 21:38:40 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) complete.
Nov 23 21:38:40 mini NetworkManager:    SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Nov 23 21:38:40 mini NetworkManager:    SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Nov 23 21:39:01 mini NetworkManager: <WARN>  pppd_timed_out(): Looks like pppd didn't initialize our dbus module
Nov 23 21:39:01 mini NetworkManager: <info>  (ttyUSB0): device state change: 7 -> 9 (reason 14)
Nov 23 21:39:01 mini NetworkManager: <info>  Marking connection 'Vodafone (D2) Vorgabe' invalid.
Nov 23 21:39:01 mini NetworkManager: <info>  Activation (ttyUSB0) failed.
Nov 23 21:39:01 mini NetworkManager: <info>  (ttyUSB0): device state change: 9 -> 3 (reason 0)
Nov 23 21:39:01 mini NetworkManager: <info>  (ttyUSB0): deactivating device (reason: 0).
Nov 23 21:39:01 mini NetworkManager: flush_routes: assertion `iface_idx >= 0' failed
Nov 23 21:39:01 mini NetworkManager: flush_addresses: assertion `iface_idx >= 0' failed
Nov 23 21:39:01 mini NetworkManager: <info>  Policy set 'Auto eth0' (eth0) as default for routing and DNS.
Nov 23 21:39:01 mini NetworkManager:    SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Nov 23 21:39:03 mini NetworkManager: <debug> [1259008743.001408] ensure_killed(): waiting for ppp pid 3141 to exit
Nov 23 21:39:03 mini NetworkManager: <debug> [1259008743.001731] ensure_killed(): ppp pid 3141 cleaned up

=========> second try <=============================================================================

Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) starting connection 'Vodafone (D2) Vorgabe'
Nov 23 21:40:53 mini NetworkManager: <info>  (ttyUSB0): device state change: 3 -> 4 (reason 0)
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Nov 23 21:40:53 mini NetworkManager: <info>  (ttyUSB0): device state change: 4 -> 6 (reason 0)
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Nov 23 21:40:53 mini NetworkManager: <info>  (ttyUSB0): device state change: 6 -> 4 (reason 0)
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
Nov 23 21:40:53 mini NetworkManager: <info>  (ttyUSB0): device state change: 4 -> 5 (reason 0)
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
Nov 23 21:40:53 mini NetworkManager: <info>  (ttyUSB0): device state change: 5 -> 7 (reason 0)
Nov 23 21:40:53 mini NetworkManager: <info>  Starting pppd connection
Nov 23 21:40:53 mini NetworkManager: <debug> [1259008853.626299] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute user vodafone ttyUSB0 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/1 plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so
Nov 23 21:40:53 mini NetworkManager: <debug> [1259008853.630095] nm_ppp_manager_start(): ppp started with pid 3165
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) started...
Nov 23 21:40:53 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) complete.
Nov 23 21:40:53 mini NetworkManager:    SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Nov 23 21:40:53 mini NetworkManager:    SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Nov 23 21:41:02 mini NetworkManager: <info>  PPP manager(IP Config Get) reply received.
Nov 23 21:41:02 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) scheduled...
Nov 23 21:41:02 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) started...
Nov 23 21:41:02 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) scheduled...
Nov 23 21:41:02 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) complete.
Nov 23 21:41:02 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) started...
Nov 23 21:41:03 mini NetworkManager: <info>  Policy set 'Auto eth0' (eth0) as default for routing and DNS.
Nov 23 21:41:03 mini NetworkManager: <info>  (ttyUSB0): device state change: 7 -> 8 (reason 0)
Nov 23 21:41:03 mini NetworkManager: <info>  Activation (ttyUSB0) successful, device activated.
Nov 23 21:41:03 mini NetworkManager: <info>  Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) complete.
Nov 23 21:41:04 mini NetworkManager: Tried to set deprecated property gsm/band
Nov 23 21:41:04 mini NetworkManager: Tried to set deprecated property gsm/band

====================> connected <=====================================================================



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