ModemManager hangs Huawei E220 Modem when probing ttyUSB1

[Joakim Lagergren]

After upgrading the firmware on my Huawei E220 modem to 11.117.10.02.00 I can't connect using NetworkManager. Before the firmware upgrade it was connecting without problems.

My manual pppd scripts still connect without problems.

The problem seems to be that the modem hangs when /dev/ttyUSB1 is being probed by ModemManager. The device used to connect the modem is /dev/ttyUSB0.

If I start the command 'cat /dev/ttyUSB1' in a terminal before ModemManager starts its probing everything works fine. It seems like the connection to /dev/ttyUSB1 is blocked by the cat command and the probing of ttyUSB1 fails.

I've attached a log file of a failed connection with ModemManager started in debug mode: "ModemManager Failure On E220 Connect Full (From modem attached).txt".

I will also attach a log file of a successful connection (with 'cat /dev/ttyUSB1' running in a terminal).

ProblemType: Bug
DistroRelease: Ubuntu 11.10
Package: modemmanager 0.5-1ubuntu1
ProcVersionSignature: Ubuntu 3.0.0-15.26-generic-pae 3.0.13
Uname: Linux 3.0.0-15-generic-pae i686
NonfreeKernelModules: nvidia
ApportVersion: 1.23-0ubuntu4
Architecture: i386
Date: Wed Feb 15 15:05:49 2012
EcryptfsInUse: Yes
InstallationMedia: Ubuntu 10.04 LTS "Lucid Lynx" - Release i386 (20100429)
ProcEnviron:
 LANGUAGE=en_GB:en
 PATH=(custom, user)
 LANG=sv_SE.utf8
 SHELL=/bin/bash
SourcePackage: modemmanager
UpgradeStatus: Upgraded to oneiric on 2011-10-18 (120 days ago)

[Joakim Lagergren (jb-lager)]

I just found a newer firmware version (11.313.02.00.01). After fimware upgrade the problems (and workaround) still persist.

Some more details:

When ModemManager is allowed to probe /dev/ttyUSB1:

Feb 15 14:51:12 jbls-xps modem-manager[595]: <debug> [mm-plugin-base.c:850] try_open(): (ttyUSB1): probe requested by plugin 'Huawei'
...
Feb 15 14:51:12 jbls-xps modem-manager[595]: <debug> [mm-modem-base.c:155] mm_modem_base_add_port(): (ttyUSB1) type secondary claimed by /sys/devices/pci0000:00/0000:00:1d.0/usb5/5-1
Feb 15 14:51:12 jbls-xps modem-manager[595]: <info> [mm-manager.c:564] do_grab_port(): (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb5/5-1 claimed port ttyUSB1

Then, when trying to connect ttyUSB0, both ttyUSB0 and ttyUSB1 get the commands AT+CREG=2 and AT+CGREG=2. ttyUSB1 does not seem to like this and responds first with "+CME ERROR: 3" and then "^BOOT:59866241,0,0,0,6":

Feb 15 14:51:15 jbls-xps modem-manager[595]: <debug> [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+CREG=2<CR>'
Feb 15 14:51:15 jbls-xps modem-manager[595]: <debug> [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>+CME ERROR: 3<CR><LF>'
Feb 15 14:51:15 jbls-xps modem-manager[595]: <debug> [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 3: Operation not allowed
Feb 15 14:51:15 jbls-xps modem-manager[595]: <debug> [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): --> 'AT+CGREG=2<CR>'
Feb 15 14:51:15 jbls-xps modem-manager[595]: <debug> [mm-at-serial-port.c:298] debug_log(): (ttyUSB1): <-- '<CR><LF>^BOOT:59866241,0,0,0,6<CR><LF>'

After that the modem does not respond at all. Even my otherwise working pppd scripts fail to communicate with the modem.

When command 'cat /dev/ttyUSB1' is running ModemManager probing fails on ttyUSB1:

Feb 15 14:54:29 jbls-xps modem-manager[595]: <debug> [mm-plugin-base.c:850] try_open(): (ttyUSB1): probe requested by plugin 'Huawei'
...
Feb 15 14:54:46 jbls-xps modem-manager[595]: <debug> [mm-manager.c:624] supports_callback(): (tty/ttyUSB1): ignoring port unsupported by physical modem's plugin

After that ModemManager does not touch /dev/ttyUSB1 and NetworkManager is able to connect using /dev/ttyUSB0.

[Launchpad Janitor (janitor)]

Status changed to 'Confirmed' because the bug affects multiple users.