refuse to connect over Nokia N85, turns off the handset

Bug #430576 reported by Eugene Crosser
22
This bug affects 3 people
Affects Status Importance Assigned to Milestone
ModemManager
Fix Released
Undecided
Unassigned
NetworkManager
Invalid
Undecided
Unassigned
modemmanager (Ubuntu)
Fix Released
Undecided
Alexander Sack

Bug Description

"Mobile Broadband" used to work well on Jaunty (network-manager 0.7), over Nokia N85 handset connected over USB.
On Karmic alpha, when I select my mobile network from the network-manager applet, I immediately see an indicator notification "Network disconnected", plus since today's update, the handset also switches off.

modemmanager:
  Installed: 0.2.git.20090909t142854.64b7be7-0ubuntu1
network-manager:
  Installed: 0.8~a~git.20090911t130220.4c77fa0-0ubuntu3

modem-manager --debug:

[phone connected]

** Message: (ttyACM0) opening serial device...
** (modem-manager:4154): DEBUG: (ttyACM0): probe requested by plugin 'Nokia'
** (modem-manager:4154): DEBUG: (ttyACM0): --> 'AT+GCAP<CR>'
** (modem-manager:4154): DEBUG: (ttyACM0): <-- 'AT+GCAP<CR><CR><LF>+GCAP:+CGSM,+DS,+W<CR><LF><CR><LF>OK<CR><LF>'
** Message: (ttyACM0) closing serial device...
** Message: (Nokia): GSM modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1 claimed port ttyACM0
** (modem-manager:4154): DEBUG: Added modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1
** (modem-manager:4154): DEBUG: Exported modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1 as /org/freedesktop/ModemManager/Modems/0

[initiate "Mobile broadband" connection from the applet]

** Message: (ttyACM0) opening serial device...
** (modem-manager:4154): DEBUG: (ttyACM0): --> 'ATZ E0 V1 X4 &C1 +CMEE=1<CR>'
** (modem-manager:4154): DEBUG: (ttyACM0): <-- 'ATZ E0 V1 X4 &C1
+CMEE=1<CR><CR><LF>OK<CR><LF>'
** (modem-manager:4154): DEBUG: (ttyACM0): --> 'ATE0 +CMEE=1<CR>'
** (modem-manager:4154): DEBUG: (ttyACM0): <-- 'ATE0 +CMEE=1<CR><CR><LF>OK<CR><LF>'
** (modem-manager:4154): DEBUG: (ttyACM0): --> 'AT+CREG=0<CR>'
** (modem-manager:4154): DEBUG: (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
** (modem-manager:4154): DEBUG: (ttyACM0): --> 'AT+CFUN=1<CR>'
** (modem-manager:4154): DEBUG: (ttyACM0): <-- '<CR><LF>+CME ERROR: 4<CR><LF>'
** (modem-manager:4154): DEBUG: Got failure code 4: Operation not supported
** (modem-manager:4154): DEBUG: (ttyACM0): --> 'AT+CFUN=0<CR>'
** (modem-manager:4154): DEBUG: (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
** Message: (ttyACM0) closing serial device...

[and the phone is black now]

I see that modemmanager tries to power up the handset which it refuses to do (my guess is, because it's already powered up, isn't it?), gets desperate and turns it off (which is not nice).

Please see what can be done about it.

Thanks!

Eugene

Revision history for this message
Eugene Crosser (crosser) wrote :

At least my model (Nokia N85) responds with error to an attempt to turn power on (AT+CFUN=1), and indeed switches off when given "power off" command (AT+CFUN=0). This patch makes the modem manager not try any of these commands on Nokia devices.

Revision history for this message
Bart Cerneels (stecchino) wrote :

Confirmed with a Nokia 5800 as well.
These messages are shown in /var/log/daemon.log

Oct 1 11:06:38 belepl0011 modem-manager: Got failure code 4: Operation not supported
Oct 1 11:06:38 belepl0011 NetworkManager: <WARN> stage1_prepare_done(): GSM modem connection failed: Operation not supported

Could figure out how to kill the already running modem-manager so I could start it in debug mode, so no autoput to confirm the AT+CFUN command.

But this appears to be fixed upstream: http://cgit.freedesktop.org/ModemManager/ModemManager/commit/?id=2bad09403aae95dd25ce03790fce45a85578f677

Considering Nokia's marketshare, can this fix be included in 9.10 final?

Revision history for this message
xens (r-aviolat) wrote :

Same problem with Nokia N97 and Nokia E75

Hope it'll be fixed before 9.10 final!

Revision history for this message
Alexander Sack (asac) wrote :
affects: network-manager (Ubuntu) → modemmanager (Ubuntu)
Changed in modemmanager (Ubuntu):
assignee: nobody → Alexander Sack (asac)
status: New → Fix Committed
Changed in modemmanager:
status: New → Fix Released
Changed in network-manager:
status: New → Invalid
Revision history for this message
Launchpad Janitor (janitor) wrote :

This bug was fixed in the package modemmanager - 0.2.git.20091003t063318.aa78b5f-0ubuntu1

---------------
modemmanager (0.2.git.20091003t063318.aa78b5f-0ubuntu1) karmic; urgency=low

  New upstream snapshot: 2009-10-03 06:33:18 (GMT)
  + aa78b5f5e5319e04f5b57f928bfab69dd4b93d88
  * fixes
    - LP: #430576 - refuse to connect over Nokia N85, turns off the handset
    - LP: #416126 - various unsolicited messages for mbm cause fail on connect

 -- Alexander Sack <email address hidden> Tue, 06 Oct 2009 01:02:12 +0200

Changed in modemmanager (Ubuntu):
status: Fix Committed → Fix Released
Revision history for this message
jfritz (j-fritz) wrote :

still seeing this behavior with Nokia N97 and modemmanager:
  Installed: 0.2.git.20091003t063318.aa78b5f-0ubuntu1

modem-manager: (ttyACM0) opening serial device...
modem-manager: Got failure code 4: Operation not supported
NetworkManager: <WARN> stage1_prepare_done(): GSM modem connection failed: Operation not supported
NetworkManager: <info> (ttyACM0): device state change: 4 -> 9 (reason 1)
NetworkManager: <info> Marking connection 'T-Mobile' invalid.
NetworkManager: Tried to set deprecated property gsm/puk
NetworkManager: <info> Activation (ttyACM0) failed.

Revision history for this message
vulfgar (vulfgar) wrote :

Still got this problem with Nokia 5800.
Installed version Installed: 0.2.git.20091003t171625.a088f12-0ubuntu2~nmt1 (karmic)

Revision history for this message
Alexander Sack (asac) wrote : Re: [Bug 430576] Re: refuse to connect over Nokia N85, turns off the handset

On Sun, Oct 11, 2009 at 10:26:33PM -0000, vulfgar wrote:
> Still got this problem with Nokia 5800.
> Installed version Installed: 0.2.git.20091003t171625.a088f12-0ubuntu2~nmt1 (karmic)
>

If you see this, please follow instructions here:

https://wiki.ubuntu.com/DebuggingModemmanager

the sooner you do that the more likely is a fix for karmic. so hurry ;).

 - Alexander

Revision history for this message
jfritz (j-fritz) wrote :
Revision history for this message
jfritz (j-fritz) wrote :

GSM modem
Driver: 'cdc_acm'
Modem device: '/sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1'
Data device: 'ttyACM0'
Traceback (most recent call last):
  File "./mm-test.py", line 240, in <module>
    modem.Enable(True)
  File "/usr/lib/pymodules/python2.6/dbus/proxies.py", line 140, in __call__
    **keywords)
  File "/usr/lib/pymodules/python2.6/dbus/connection.py", line 620, in call_blocking
    message, timeout)
dbus.exceptions.DBusException: org.freedesktop.ModemManager.Modem.Gsm.OperationNotSupported: Operation not supported

:)

Revision history for this message
Alexander Sack (asac) wrote :

did you run it as root?

On Mon, Oct 12, 2009 at 06:07:28PM -0000, jfritz wrote:
> GSM modem
> Driver: 'cdc_acm'
> Modem device: '/sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1'
> Data device: 'ttyACM0'
> Traceback (most recent call last):
> File "./mm-test.py", line 240, in <module>
> modem.Enable(True)
> File "/usr/lib/pymodules/python2.6/dbus/proxies.py", line 140, in __call__
> **keywords)
> File "/usr/lib/pymodules/python2.6/dbus/connection.py", line 620, in call_blocking
> message, timeout)
> dbus.exceptions.DBusException: org.freedesktop.ModemManager.Modem.Gsm.OperationNotSupported: Operation not supported
>
>
> :)
>
> ** Attachment added: "nm.log.txt"
> http://launchpadlibrarian.net/33552514/nm.log.txt
>

 - Alexander

Revision history for this message
vulfgar (vulfgar) wrote :

Still problem even after todays update. The phone is turned of.

python ./mm-test.py
Traceback (most recent call last):
  File "./mm-test.py", line 214, in <module>
    modems = manager_iface.EnumerateDevices()
  File "/usr/lib/pymodules/python2.6/dbus/proxies.py", line 68, in __call__
    return self._proxy_method(*args, **keywords)
  File "/usr/lib/pymodules/python2.6/dbus/proxies.py", line 140, in __call__
    **keywords)
  File "/usr/lib/pymodules/python2.6/dbus/connection.py", line 620, in call_blocking
    message, timeout)
dbus.exceptions.DBusException: org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.

modem.log.txt:
** Message: Loaded plugin Gobi
** Message: Loaded plugin Generic
** Message: Loaded plugin MotoC
** Message: Loaded plugin Option High-Speed
** Message: Loaded plugin Sierra
** Message: Loaded plugin Novatel
** Message: Loaded plugin Ericsson MBM
** Message: Loaded plugin ZTE
** Message: Loaded plugin Huawei
** Message: Loaded plugin Option
** Message: Loaded plugin Nokia
** Message: (ttyACM0) opening serial device...
** (modem-manager:29758): DEBUG: (ttyACM0): probe requested by plugin 'Nokia'
** (modem-manager:29758): DEBUG: (ttyACM0): --> 'AT+GCAP<CR>'
** (modem-manager:29758): DEBUG: (ttyACM0): <-- 'AT+GCAP<CR><CR><LF>+GCAP: +CGSM,+DS,+W<CR><LF><CR><LF>OK<CR><LF>'
** Message: (ttyACM0) closing serial device...

(modem-manager:29758): GLib-GObject-CRITICAL **: g_object_class_install_property: assertion `class->set_property != NULL' failed

(modem-manager:29758): GLib-GObject-CRITICAL **: g_object_class_install_property: assertion `class->set_property != NULL' failed
** Message: (Nokia): GSM modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 claimed port ttyACM0
** (modem-manager:29758): DEBUG: Added modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3
** (modem-manager:29758): DEBUG: Exported modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 as /org/freedesktop/ModemManager/Modems/0

Revision history for this message
jfritz (j-fritz) wrote :

sudo python ./mm-test.py
[sudo] password for fritz:
GSM modem
Driver: 'cdc_acm'
Modem device: '/sys/devices/pci0000:00/0000:00:1d.7/usb2/2-3'
Data device: 'ttyACM1'
Traceback (most recent call last):
  File "./mm-test.py", line 240, in <module>
    modem.Enable(True)
  File "/usr/lib/pymodules/python2.6/dbus/proxies.py", line 140, in __call__
    **keywords)
  File "/usr/lib/pymodules/python2.6/dbus/connection.py", line 620, in call_blocking
    message, timeout)
dbus.exceptions.DBusException: org.freedesktop.ModemManager.Modem.Gsm.OperationNotSupported: Operation not supported

I did not observe a difference in the log files or the output of mm-test whether i run it as root or not

Revision history for this message
Alexander Sack (asac) wrote :

please try the patch (mm.patch) i am attaching, like:

sudo apt-get build-dep modemmanager
sudo apt-get install devscripts
apt-get source modemmanager
cd modemmanager*/
patch -p1 < /tmp/mm.patch
debuild -b
cd ..
sudo dpkg -i modem*.deb

Revision history for this message
Alexander Sack (asac) wrote :

sorry. previous patch was wrong. use this

Revision history for this message
Alexander Sack (asac) wrote :

i opened bug 450256 for whatever is left.

Revision history for this message
jfritz (j-fritz) wrote :

63318.aa78b5f-0ubuntu1_amd64.deb'.
 dpkg-genchanges -b >../modemmanager_0.2.git.20091003t063318.aa78b5f-0ubuntu1_amd64.changes
dpkg-genchanges: binary-only upload - not including any source code
dpkg-buildpackage: binary only upload (no source included)
Now running lintian...
W: modemmanager: binary-without-manpage usr/sbin/modem-manager
E: modemmanager: pkg-has-shlibs-control-file-but-no-actual-shared-libs
W: modemmanager: postinst-has-useless-call-to-ldconfig
W: modemmanager: postrm-has-useless-call-to-ldconfig
W: modemmanager: wrong-bug-number-in-closes l114:#XXXXXX
Finished running lintian.
Now signing changes and any dsc files...
 signfile modemmanager_0.2.git.20091003t063318.aa78b5f-0ubuntu1_amd64.changes Alexander Sack <email address hidden>
gpg: skipped "Alexander Sack <email address hidden>": secret key not available
gpg: /tmp/debsign.Q4UxojoA/modemmanager_0.2.git.20091003t063318.aa78b5f-0ubuntu1_amd64.changes: clearsign failed: secret key not available
debsign: gpg error occurred! Aborting....
debuild: fatal error at line 1255:
running debsign failed

seems ok.

package installing works too, and connection works now as well on N97

Revision history for this message
Alexander Sack (asac) wrote :
Revision history for this message
vulfgar (vulfgar) wrote :

It works! :)

Revision history for this message
Alexander Sack (asac) wrote :

On Tue, Oct 13, 2009 at 01:52:14PM -0000, vulfgar wrote:
> It works! :)
>

thanks. daily builds should already have this now, so you dont need to
manually patch.

daily builds are here:
https://edge.launchpad.net/~network-manager/+archive/trunk

 - Alexander

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.