Problems upgrading 0.8 to 0.8.1 or higer

["W. van den Akker" <wvdakker wilsoft nl>]

Hi,

I use a Huawei modem (idVendor 12d1, idProd 1465).
This modem works ok with version 0.8.0.
Upgrading to a higher version (last tried 0.8.4 RC1) fails.
I can see the modem polling and I get asked for a PIN.
After that nothing happens.

Downgrading to 0.8 makes the modem work again.

This is the part of the log where I thing it goes wrong:

Apr 19 06:16:36 localhost modem-manager[1196]: <info> (ttyUSB0) opening serial port...
Apr 19 06:16:39 localhost modem-manager[1196]: <info> (ttyUSB0) closing serial port...
Apr 19 06:16:39 localhost modem-manager[1196]: <info> (ttyUSB0) serial port closed
Apr 19 06:16:39 localhost modem-manager[1196]: <info> (ttyUSB0) opening serial port...
Apr 19 06:16:39 localhost modem-manager[1196]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-5 claimed port ttyUSB0
Apr 19 06:16:39 localhost modem-manager[1196]: <info> (ttyUSB0) closing serial port...
Apr 19 06:16:39 localhost modem-manager[1196]: <info> (ttyUSB0) serial port closed
Apr 19 06:16:42 localhost modem-manager[1196]: <info> (ttyUSB1) opening serial port...
Apr 19 06:16:42 localhost modem-manager[1196]: <info> (ttyUSB2) opening serial port...
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB1) closing serial port...
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB1) serial port closed
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB2) closing serial port...
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB2) serial port closed
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-5 claimed port ttyUSB1
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-5 claimed port ttyUSB2
Apr 19 06:16:49 localhost NetworkManager[1179]: <warn> (ttyUSB0): failed to look up interface index
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> WWAN now disabled by radio killswitch
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): new GSM device (driver: 'option1' ifindex: -1)
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/2
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): now managed
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 1 -> 2 (reason 2)
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): deactivating device (reason: 2).
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 2 -> 3 (reason 0)
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> Activation (ttyUSB0) starting connection 'Vodafone Business'
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 3 -> 4 (reason 0)
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 4 -> 6 (reason 0)
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 6 -> 4 (reason 0)
Apr 19 06:16:49 localhost NetworkManager[1179]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Apr 19 06:16:49 localhost NetworkManager[1179]: <warn> GSM modem enable failed: (32) SIM PIN required
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB0) opening serial port...
Apr 19 06:16:49 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required
Apr 19 06:16:49 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/0: # unlock retries is 0
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB0) closing serial port...
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB0) serial port closed
Apr 19 06:16:49 localhost modem-manager[1196]: <info> (ttyUSB0) opening serial port...
Apr 19 06:16:49 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling)
Apr 19 06:16:51 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled)
Apr 19 06:16:51 localhost NetworkManager[1179]: <info> WWAN now enabled by radio killswitch
Apr 19 06:16:51 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> searching)
Apr 19 06:17:00 localhost modem-manager[1196]: <info> (ttyUSB0) closing serial port...
Apr 19 06:17:00 localhost modem-manager[1196]: <info> (ttyUSB0) serial port closed
Apr 19 06:17:00 localhost modem-manager[1196]: mm_serial_port_close: assertion `priv->open_count > 0' failed
Apr 19 06:17:00 localhost NetworkManager[1179]: <warn> GSM connection failed: (32) Serial port is now closed
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 4 -> 9 (reason 1)
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> Marking connection 'Vodafone Business' invalid.
Apr 19 06:17:00 localhost NetworkManager[1179]: <warn> Activation (ttyUSB0) failed.
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 9 -> 3 (reason 0)
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> (ttyUSB0): deactivating device (reason: 0).
Apr 19 06:17:00 localhost modem-manager[1196]: <info> (tty/ttyUSB0): released by modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-5
Apr 19 06:17:00 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (searching -> disabled)
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> (ttyUSB0): now unmanaged
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 3 -> 1 (reason 36)
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> (ttyUSB0): cleaning up...
Apr 19 06:17:00 localhost NetworkManager[1179]: <info> (ttyUSB0): taking down device.
Apr 19 06:17:07 localhost modem-manager[1196]: <info> (ttyUSB0) opening serial port...
Apr 19 06:17:10 localhost modem-manager[1196]: <info> (ttyUSB0) closing serial port...
Apr 19 06:17:10 localhost modem-manager[1196]: <info> (ttyUSB0) serial port closed
Apr 19 06:17:10 localhost modem-manager[1196]: <info> (ttyUSB0) opening serial port...
Apr 19 06:17:10 localhost modem-manager[1196]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-5 claimed port ttyUSB0
Apr 19 06:17:10 localhost modem-manager[1196]: <info> (ttyUSB0) closing serial port...
Apr 19 06:17:10 localhost modem-manager[1196]: <info> (ttyUSB0) serial port closed
Apr 19 06:17:13 localhost modem-manager[1196]: <info> (ttyUSB2) opening serial port...
Apr 19 06:17:13 localhost modem-manager[1196]: <info> (ttyUSB1) opening serial port...
Apr 19 06:17:20 localhost modem-manager[1196]: <info> (ttyUSB2) closing serial port...
Apr 19 06:17:20 localhost modem-manager[1196]: <info> (ttyUSB2) serial port closed
Apr 19 06:17:20 localhost modem-manager[1196]: <info> (ttyUSB1) closing serial port...
Apr 19 06:17:20 localhost modem-manager[1196]: <info> (ttyUSB1) serial port closed
Apr 19 06:17:20 localhost modem-manager[1196]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-5 claimed port ttyUSB2
Apr 19 06:17:20 localhost modem-manager[1196]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-5 claimed port ttyUSB1
Apr 19 06:17:20 localhost NetworkManager[1179]: <warn> (ttyUSB0): failed to look up interface index
Apr 19 06:17:20 localhost NetworkManager[1179]: <info> WWAN now disabled by radio killswitch
Apr 19 06:17:20 localhost NetworkManager[1179]: <info> (ttyUSB0): new GSM device (driver: 'option1' ifindex: -1)
Apr 19 06:17:20 localhost NetworkManager[1179]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/3
Apr 19 06:17:20 localhost NetworkManager[1179]: <info> (ttyUSB0): now managed
Apr 19 06:17:20 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 1 -> 2 (reason 2)
Apr 19 06:17:20 localhost NetworkManager[1179]: <info> (ttyUSB0): deactivating device (reason: 2).
Apr 19 06:17:20 localhost NetworkManager[1179]: <info> (ttyUSB0): device state change: 2 -> 3 (reason 0)
Apr 19 06:17:26 localhost modem-manager[1196]: <info> (ttyUSB0) opening serial port...
Apr 19 06:17:26 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/1: unlock no longer required
Apr 19 06:17:26 localhost modem-manager[1196]: <info> Modem /org/freedesktop/ModemManager/Modems/1: # unlock retries is 0
Apr 19 06:17:26 localhost modem-manager[1196]: <info> (ttyUSB0) closing serial port...
Apr 19 06:17:26 localhost modem-manager[1196]: <info> (ttyUSB0) serial port closed
-- 
This message has been scanned for viruses and
dangerous content by
MailScanner, and is
believed to be clean.