Announcement

Collapse
No announcement yet.

3G Vodafone USB modem not connecting after upgrade

Collapse
This topic is closed.
X
X
 
  • Filter
  • Time
  • Show
Clear All
new posts

    3G Vodafone USB modem not connecting after upgrade

    Hello,

    Last week I decided to upgrade from Kubuntu 11.10 to 12.04. Unfortunately on the 12.04 my USB modem stick ( Vodafone K3765 ) starts connecting and shortly after drops the connection altogether. Has anyone had this kind of problem with their USB modem?

    Below I attached what shows up in syslog from the point where I plugged the modem to the computer until the connection dropped.

    Thank you in advance for your answers!

    Jun 8 22:21:28 alex-desktop kernel: [ 179.064137] usb 2-1: new high-speed USB device number 3 using ehci_hcd
    Jun 8 22:21:28 alex-desktop mtp-probe: checking bus 2, device 3: "/sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1"
    Jun 8 22:21:28 alex-desktop mtp-probe: bus: 2, device: 3 was not an MTP device
    Jun 8 22:21:28 alex-desktop kernel: [ 179.259296] Initializing USB Mass Storage driver...
    Jun 8 22:21:28 alex-desktop kernel: [ 179.259476] scsi4 : usb-storage 2-1:1.0
    Jun 8 22:21:28 alex-desktop kernel: [ 179.259587] usbcore: registered new interface driver usb-storage
    Jun 8 22:21:28 alex-desktop kernel: [ 179.259590] USB Mass Storage support registered.
    Jun 8 22:21:28 alex-desktop kernel: [ 179.297568] usbcore: registered new interface driver uas
    Jun 8 22:21:29 alex-desktop kernel: [ 180.258529] scsi 4:0:0:0: CD-ROM Vodafone CD ROM (Huawei) 2.31 PQ: 0 ANSI: 2
    Jun 8 22:21:29 alex-desktop kernel: [ 180.268626] sr1: scsi-1 drive
    Jun 8 22:21:29 alex-desktop kernel: [ 180.268960] sr 4:0:0:0: Attached scsi CD-ROM sr1
    Jun 8 22:21:29 alex-desktop kernel: [ 180.272470] sr 4:0:0:0: Attached scsi generic sg2 type 5
    Jun 8 22:21:29 alex-desktop usb_modeswitch: switching device 12d1:1520 on 002/003
    Jun 8 22:21:29 alex-desktop kernel: [ 180.699496] usb 2-1: USB disconnect, device number 3
    Jun 8 22:21:34 alex-desktop kernel: [ 185.076091] usb 2-1: new high-speed USB device number 4 using ehci_hcd
    Jun 8 22:21:34 alex-desktop mtp-probe: checking bus 2, device 4: "/sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1"
    Jun 8 22:21:34 alex-desktop kernel: [ 185.215169] scsi5 : usb-storage 2-1:1.5
    Jun 8 22:21:34 alex-desktop kernel: [ 185.215782] scsi6 : usb-storage 2-1:1.6
    Jun 8 22:21:34 alex-desktop mtp-probe: bus: 2, device: 4 was not an MTP device
    Jun 8 22:21:34 alex-desktop kernel: [ 185.283297] usbcore: registered new interface driver usbserial
    Jun 8 22:21:34 alex-desktop kernel: [ 185.283321] USB Serial support registered for generic
    Jun 8 22:21:34 alex-desktop kernel: [ 185.283387] usbcore: registered new interface driver usbserial_generic
    Jun 8 22:21:34 alex-desktop kernel: [ 185.283389] usbserial: USB Serial Driver core
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302339] USB Serial support registered for GSM modem (1-port)
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302446] option 2-1:1.0: GSM modem (1-port) converter detected
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302594] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB0
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302627] option 2-1:1.3: GSM modem (1-port) converter detected
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302708] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB1
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302726] option 2-1:1.4: GSM modem (1-port) converter detected
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302806] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB2
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302838] usbcore: registered new interface driver option
    Jun 8 22:21:34 alex-desktop kernel: [ 185.302840] option: v0.7.2:USB Driver for GSM modems
    Jun 8 22:21:34 alex-desktop kernel: [ 185.339151] cdc_ether 2-1:1.1: wwan0: register 'cdc_ether' at usb-0000:00:1d.7-1, Mobile Broadband Network Device, 02:50:f3:00:00:00
    Jun 8 22:21:34 alex-desktop kernel: [ 185.339193] usbcore: registered new interface driver cdc_ether
    Jun 8 22:21:34 alex-desktop NetworkManager[924]: SCPlugin-Ifupdown: devices added (path: /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.1/net/wwan0, iface: wwan0)
    Jun 8 22:21:34 alex-desktop NetworkManager[924]: SCPlugin-Ifupdown: device added (path: /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.1/net/wwan0, iface: wwan0): no ifupdown configuration found.
    Jun 8 22:21:34 alex-desktop modem-manager[877]: <info> (ttyUSB0) opening serial port...
    Jun 8 22:21:35 alex-desktop kernel: [ 186.214291] scsi 5:0:0:0: CD-ROM Vodafone CD ROM (Huawei) 2.31 PQ: 0 ANSI: 2
    Jun 8 22:21:35 alex-desktop kernel: [ 186.214618] scsi 6:0:0:0: Direct-Access Vodafone Storage (Huawei) 2.31 PQ: 0 ANSI: 2
    Jun 8 22:21:35 alex-desktop usb_modeswitch: switched to 12d1:1465 on 002/003
    Jun 8 22:21:35 alex-desktop kernel: [ 186.221519] sr1: scsi-1 drive
    Jun 8 22:21:35 alex-desktop kernel: [ 186.222469] sr 5:0:0:0: Attached scsi CD-ROM sr1
    Jun 8 22:21:35 alex-desktop kernel: [ 186.223323] sr 5:0:0:0: Attached scsi generic sg2 type 5
    Jun 8 22:21:35 alex-desktop kernel: [ 186.227828] sd 6:0:0:0: Attached scsi generic sg3 type 0
    Jun 8 22:21:35 alex-desktop kernel: [ 186.230112] sd 6:0:0:0: [sdb] Attached SCSI removable disk
    Jun 8 22:21:35 alex-desktop modem-manager[877]: <info> (ttyUSB0) closing serial port...
    Jun 8 22:21:35 alex-desktop modem-manager[877]: <info> (ttyUSB0) serial port closed
    Jun 8 22:21:36 alex-desktop modem-manager[877]: <info> (ttyUSB0) opening serial port...
    Jun 8 22:21:36 alex-desktop modem-manager[877]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1 claimed port ttyUSB0
    Jun 8 22:21:36 alex-desktop usb_modeswitch[2287]: usb_modeswitch: switched to 12d1:1465 on 2/4
    Jun 8 22:21:37 alex-desktop modem-manager[877]: <info> (ttyUSB2) opening serial port...
    Jun 8 22:21:37 alex-desktop modem-manager[877]: <info> (ttyUSB1) opening serial port...
    Jun 8 22:21:38 alex-desktop modem-manager[877]: <info> (ttyUSB0) closing serial port...
    Jun 8 22:21:38 alex-desktop modem-manager[877]: <info> (ttyUSB0) serial port closed
    Jun 8 22:21:40 alex-desktop modem-manager[877]: <info> (ttyUSB2) closing serial port...
    Jun 8 22:21:40 alex-desktop modem-manager[877]: <info> (ttyUSB2) serial port closed
    Jun 8 22:21:40 alex-desktop modem-manager[877]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1 claimed port ttyUSB2
    Jun 8 22:21:45 alex-desktop modem-manager[877]: <info> (ttyUSB1) closing serial port...
    Jun 8 22:21:45 alex-desktop modem-manager[877]: <info> (ttyUSB1) serial port closed
    Jun 8 22:21:45 alex-desktop modem-manager[877]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1 claimed port ttyUSB1
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: <warn> (ttyUSB0): failed to look up interface index
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: <info> (ttyUSB0): new GSM/UMTS device (driver: 'option1' ifindex: 0)
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/2
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: <info> (ttyUSB0): now managed
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: <info> (ttyUSB0): deactivating device (reason 'managed') [2]
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
    Jun 8 22:21:45 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
    Jun 8 22:21:54 alex-desktop modem-manager[877]: <info> (ttyUSB0) opening serial port...
    Jun 8 22:21:54 alex-desktop modem-manager[877]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling)
    Jun 8 22:21:54 alex-desktop modem-manager[877]: <info> (ttyUSB2) opening serial port...
    Jun 8 22:21:54 alex-desktop modem-manager[877]: <info> (ttyUSB0): using text mode for SMS
    Jun 8 22:21:54 alex-desktop modem-manager[877]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled)
    Jun 8 22:21:54 alex-desktop NetworkManager[924]: <info> WWAN now enabled by management service
    Jun 8 22:21:54 alex-desktop modem-manager[877]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered)
    Jun 8 22:22:01 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) starting connection 'Vodafone - Mobile Internet (Prepaid)'
    Jun 8 22:22:01 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
    Jun 8 22:22:01 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
    Jun 8 22:22:01 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
    Jun 8 22:22:01 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: prepare -> need-auth (reason 'none') [40 60 0]
    Jun 8 22:22:01 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
    Jun 8 22:22:04 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
    Jun 8 22:22:04 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
    Jun 8 22:22:04 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
    Jun 8 22:22:04 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
    Jun 8 22:22:04 alex-desktop modem-manager[877]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting)
    Jun 8 22:22:04 alex-desktop modem-manager[877]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected)
    Jun 8 22:22:04 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
    Jun 8 22:22:04 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
    Jun 8 22:22:04 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: prepare -> config (reason 'none') [40 50 0]
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: config -> ip-config (reason 'none') [50 70 0]
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> starting PPP connection
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> pppd started with pid 2372
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv6 Configure Timeout) started...
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
    Jun 8 22:22:05 alex-desktop pppd[2372]: Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded.
    Jun 8 22:22:05 alex-desktop pppd[2372]: pppd 2.4.5 started by root, uid 0
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
    Jun 8 22:22:05 alex-desktop NetworkManager[924]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
    Jun 8 22:22:05 alex-desktop pppd[2372]: Using interface ppp0
    Jun 8 22:22:05 alex-desktop pppd[2372]: Connect: ppp0 <--> /dev/ttyUSB0
    Jun 8 22:22:05 alex-desktop pppd[2372]: CHAP authentication succeeded
    Jun 8 22:22:05 alex-desktop pppd[2372]: CHAP authentication succeeded
    Jun 8 22:22:05 alex-desktop kernel: [ 215.969399] PPP BSD Compression module registered
    Jun 8 22:22:05 alex-desktop kernel: [ 215.990813] PPP Deflate Compression module registered
    Jun 8 22:22:06 alex-desktop pppd[2372]: Modem hangup
    Jun 8 22:22:06 alex-desktop pppd[2372]: Connection terminated.
    Jun 8 22:22:06 alex-desktop avahi-daemon[901]: Withdrawing workstation service for ppp0.
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv4 Configure Timeout) scheduled...
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv4 Configure Timeout) started...
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <warn> Activation (ttyUSB0) failed.
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <info> Activation (ttyUSB0) Stage 4 of 5 (IPv4 Configure Timeout) complete.
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <info> (ttyUSB0): device state change: failed -> disconnected (reason 'none') [120 30 0]
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <info> (ttyUSB0): deactivating device (reason 'none') [0]
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
    Jun 8 22:22:06 alex-desktop modem-manager[877]: <info> (ttyUSB0) closing serial port...
    Jun 8 22:22:06 alex-desktop modem-manager[877]: <info> (ttyUSB0) serial port closed
    Jun 8 22:22:06 alex-desktop modem-manager[877]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
    Jun 8 22:22:06 alex-desktop modem-manager[877]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
    Jun 8 22:22:06 alex-desktop NetworkManager[924]: <info> disconnect failed: (32) The serial port is not open.
    Jun 8 22:22:07 alex-desktop pppd[2372]: Exit.

    #2
    Alex:

    I see you got no answer, and sadly, I don't know either. However I did do a Google search for the last error listed in your log file

    disconnect failed: (32) The serial port is not open.
    and I turned up a lot of hits on that. It is anywhere between a bug, and a configuration issue with some modems, depending. If you haven't already resolved this issue, then Googling that error message may give you a lead.

    Sorry I can't help any further.

    Frank.
    Linux: Powerful, open, elegant. Its all I use.

    Comment

    Working...
    X