Gentoo Websites Logo
Go to: Gentoo Home Documentation Forums Lists Bugs Planet Store Wiki Get Gentoo!
Bug 273741 - net-misc/networkmanager-0.7.1-r4 regression: USB 3G Modem handling broken (working fine with r3)
Summary: net-misc/networkmanager-0.7.1-r4 regression: USB 3G Modem handling broken (wo...
Status: RESOLVED FIXED
Alias: None
Product: Gentoo Linux
Classification: Unclassified
Component: Current packages (show other bugs)
Hardware: AMD64 Linux
: High normal (vote)
Assignee: Steev Klimaszewski (RETIRED)
URL:
Whiteboard:
Keywords:
Depends on:
Blocks:
 
Reported: 2009-06-11 15:55 UTC by Marc Schiffbauer
Modified: 2009-06-19 08:59 UTC (History)
5 users (show)

See Also:
Package list:
Runtime testing required: ---


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Marc Schiffbauer gentoo-dev 2009-06-11 15:55:32 UTC
I upgraded to net-misc/networkmanager-0.7.1-r4 from 0.7.1-r3

After that my USB 3G Modem device (T-Mobile web'n'walk stick III by HUAWEI) stopped working. Its not possible to create a 3G connection anymore.

NM recognizes the device, I can trigger to start my mobile connection, but it fails all the time.

I can see a new log message that I have never seen before while it tries to connect:

17:17:55 NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (1)
17:18:07 NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (2)
17:18:19 NetworkManager: <WARN>  init_done(): Trying alternate modem initialization (3)
...

After downgrading to 0.7.1-r3 again it works fine again.
(which was not too easy because it has already been removed from portage :-(
I had to download ebuild from http://sources.gentoo.org/viewcvs.py/*checkout*/gentoo-x86/net-misc/networkmanager/networkmanager-0.7.1-r3.ebuild?rev=1.2 manually, manifest, emerge, ...)

So I assume that one of the additional patches is causing this breakage.

Reproducible: Always

Steps to Reproduce:
1. Have a USB 3G mobile modem like mine ;)
2. use NM 0.7.1-r4
3. try to bring up a 3G mobile connection

Actual Results:  
conneciton aborts

Expected Results:  
working mobile connection

Please tell me if you need further information
Comment 1 Christian Loosli 2009-06-12 13:35:07 UTC
I confirm this bug also occurring with a Sierra Compass 885, which is using the sierra.ko module. 

With r4 it is broken, with r3 it works. 
Please, if you do such updates (including backported patches) do not remove the old ebuild yet. 

As some people (e.g.: me) only have the UMTS connection and fixing such things without internet is kind of hard ... 
Comment 2 Lars Wendler (Polynomial-C) (RETIRED) gentoo-dev 2009-06-14 01:03:49 UTC
For the sake of completeness, please post your "emerge --info" to this bug.
Comment 3 Robert Piasek (RETIRED) gentoo-dev 2009-06-14 09:08:44 UTC
Hmm. I've tested patches it before updating, but something must be wrong than.

Could you please do (for -r3 and -r4 versions):

1) stop networkmanager
2) killall nm-system-settings
3) run NM_SERIAL_DEBUG=1 /usr/sbin/Networkmanager --no-daemon
4) paste the log

in my case (modem: HUAWEI E169, network: three.co.uk, version: -r4) it looks like:


NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...                                                           
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...                                                             
NetworkManager: <debug> [1244970287.771700] nm_serial_device_open(): (ttyUSB0) opening device...                                                  
NetworkManager: <info>  Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.                                                              
NetworkManager: <debug> [1244970287.900150] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0                                               
'                                                                                                                                                 
NetworkManager: <debug> [1244970287.941257] nm_serial_debug(): Got: '                                                                             

OK

'
NetworkManager: <debug> [1244970287.941355] nm_serial_debug(): Sending: 'AT+CPIN?
'                                                                                
NetworkManager: <debug> [1244970287.960286] nm_serial_debug(): Got: '            

+CPIN: READY


OK

'
NetworkManager: <debug> [1244970287.960378] nm_serial_debug(): Sending: 'ATZ E0 V1 X4 &C1 +FCLASS=0
'                                                                                                  
NetworkManager: <debug> [1244970288.016877] nm_serial_debug(): Got: '                              

OK

'
NetworkManager: <info>  (ttyUSB0): powering up...
NetworkManager: <debug> [1244970288.016984] nm_serial_debug(): Sending: 'AT+CFUN=1
'                                                                                 
NetworkManager: <debug> [1244970288.046914] nm_serial_debug(): Got: '             

OK

'
NetworkManager: <debug> [1244970288.047001] nm_serial_debug(): Sending: 'AT+CGMM
'                                                                               
NetworkManager: <debug> [1244970288.067042] nm_serial_debug(): Got: '           

E169



OK

'
NetworkManager: <debug> [1244970288.067124] nm_serial_debug(): Sending: 'AT+CREG?
'                                                                                
NetworkManager: <debug> [1244970288.089043] nm_serial_debug(): Got: '            

+CREG: 0,1



OK

'
NetworkManager: <info>  Registered on Home network
NetworkManager: <debug> [1244970288.089140] nm_serial_debug(): Sending: 'AT+COPS?
'                                                                                
NetworkManager: <debug> [1244970288.107873] nm_serial_debug(): Got: '            

+COPS: 0,2,"23420",2


OK

'
NetworkManager: <info>  Associated with network: +COPS: 0,2,"23420",2
NetworkManager: <debug> [1244970288.107977] nm_serial_debug(): Sending: 'AT+CGDCONT=1,"IP","three.co.uk"
'
NetworkManager: <debug> [1244970288.156916] nm_serial_debug(): Got: '

OK

'
NetworkManager: <debug> [1244970288.157025] nm_serial_debug(): Sending: 'ATD*99***1#
'
NetworkManager: <debug> [1244970288.181281] nm_serial_debug(): Got: '

CONNECT 3600000

'
NetworkManager: <info>  Connected, Woo!
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <info>  Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
Comment 4 Balazs Nemeth 2009-06-15 11:32:07 UTC
I have a similar issue. After upgraded to -r4 my 3G phone stopped working.

This log is from -r4:

<info>  (ttyACM0): found serial port (udev:GSM  hal:GSM)
<info>  (ttyACM0): new Modem device (driver: 'cdc_acm')
<info>  (ttyACM0): exported as /org/freedesktop/Hal/devices/usb_device_421_2f_noserial_if8_serial_unknown_0
<info>  (ttyACM0): device state change: 1 -> 2
<info>  (ttyACM0): deactivating device (reason: 2).
nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
<info>  (ttyACM0): device state change: 2 -> 3
<info>  Activation (ttyACM0) starting connection 'Automatikus mobil széles sávú (GSM) kapcsolat'
<info>  (ttyACM0): device state change: 3 -> 4
<info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) scheduled...
<info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) started...
<debug> [1245064471.506945] nm_serial_device_open(): (ttyACM0) opening device...
<info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) complete.
<WARN>  wait_for_reply_got_data(): (ttyACM0): response buffer filled before repsonse received
<WARN>  init_done(): Modem initialization timed out
<info>  (ttyACM0): device state change: 4 -> 9
<debug> [1245064472.544906] nm_serial_device_close(): Closing device 'ttyACM0'
<info>  Marking connection 'Automatikus mobil széles sávú (GSM) kapcsolat' invalid.
<info>  Activation (ttyACM0) failed.
<info>  (ttyACM0): device state change: 9 -> 3
<info>  (ttyACM0): deactivating device (reason: 0).
nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed


After downgraded to -r3 it works againt. This log is from -r3.:

<info>  (ttyACM0): found serial port (udev:GSM  hal:GSM)
<info>  (ttyACM0): new Modem device (driver: 'cdc_acm')
<info>  (ttyACM0): exported as /org/freedesktop/Hal/devices/usb_device_421_2f_noserial_if8_serial_unknown_0_0
<info>  (ttyACM0): device state change: 1 -> 2
<info>  (ttyACM0): deactivating device (reason: 2).
nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
<info>  (ttyACM0): device state change: 2 -> 3
<info>  Activation (ttyACM0) starting connection 'Automatikus mobil széles sávú (GSM) kapcsolat'
<info>  (ttyACM0): device state change: 3 -> 4
<info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) scheduled...
<info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) started...
<debug> [1245065215.606992] nm_serial_device_open(): (ttyACM0) opening device...
<info>  Activation (ttyACM0) Stage 1 of 5 (Device Prepare) complete.
<info>  (ttyACM0): powering up...
<info>  Registered on Home network
<info>  Associated with network: +COPS: 0,2,"21630",2
<info>  Connected, Woo!
<info>  Activation (ttyACM0) Stage 2 of 5 (Device Configure) scheduled...
<info>  Activation (ttyACM0) Stage 2 of 5 (Device Configure) starting...
<info>  (ttyACM0): device state change: 4 -> 5
<info>  Starting pppd connection
<debug> [1245065216.480867] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute ttyACM0 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/0 plugin /usr/lib64/pppd/2.4.4/nm-pppd-plugin.so
<debug> [1245065216.485827] nm_ppp_manager_start(): ppp started with pid 25334
<info>  Activation (ttyACM0) Stage 2 of 5 (Device Configure) complete.
<info>  (ttyACM0): device state change: 5 -> 6
<info>  (ttyACM0): device state change: 6 -> 7
<info>  PPP manager(IP Config Get) reply received.
<info>  Activation (ttyACM0) Stage 4 of 5 (IP Configure Get) scheduled...
<info>  Activation (ttyACM0) Stage 4 of 5 (IP Configure Get) started...
<info>  Activation (ttyACM0) Stage 5 of 5 (IP Configure Commit) scheduled...
<info>  Activation (ttyACM0) Stage 4 of 5 (IP Configure Get) complete.
<info>  Activation (ttyACM0) Stage 5 of 5 (IP Configure Commit) started...
<info>  (ttyACM0): device state change: 7 -> 8
<info>  Policy set 'Automatikus mobil széles sávú (GSM) kapcsolat' (ppp0) as default for routing and DNS.
<info>  Activation (ttyACM0) successful, device activated.
<info>  Activation (ttyACM0) Stage 5 of 5 (IP Configure Commit) complete.

my emerge --info

emerge --info
Portage 2.1.6.13 (default/linux/amd64/2008.0, gcc-4.3.2, glibc-2.9_p20081201-r2, 2.6.30-gentoo-r1 x86_64)
=================================================================
System uname: Linux-2.6.30-gentoo-r1-x86_64-Intel-R-_Core-TM-2_Duo_CPU_T8300_@_2.40GHz-with-glibc2.2.5
Timestamp of tree: Mon, 15 Jun 2009 04:20:01 +0000
ccache version 2.4 [enabled]
app-shells/bash:     3.2_p39
dev-java/java-config: 2.1.7
dev-lang/python:     2.5.4-r2
dev-python/pycrypto: 2.0.1-r8
dev-util/ccache:     2.4-r7
dev-util/cmake:      2.6.2-r1
sys-apps/baselayout: 2.0.1
sys-apps/openrc:     0.4.3-r3
sys-apps/sandbox:    1.6-r2
sys-devel/autoconf:  2.13, 2.63
sys-devel/automake:  1.5, 1.9.6-r2, 1.10.2
sys-devel/binutils:  2.18-r3
sys-devel/gcc-config: 1.4.1
sys-devel/libtool:   1.5.26
virtual/os-headers:  2.6.27-r2
ACCEPT_KEYWORDS="amd64"
CBUILD="x86_64-pc-linux-gnu"
CFLAGS="-march=native -O2 -pipe"
CHOST="x86_64-pc-linux-gnu"
CONFIG_PROTECT="/etc"
CONFIG_PROTECT_MASK="/etc/ca-certificates.conf /etc/env.d /etc/env.d/java/ /etc/fonts/fonts.conf /etc/gconf /etc/gentoo-release /etc/php/apache2-php5/ext-active/ /etc/php/cgi-php5/ext-active/ /etc/php/cli-php5/ext-active/ /etc/revdep-rebuild /etc/sandbox.d /etc/splash /etc/terminfo /etc/udev/rules.d"
CXXFLAGS="-march=native -O2 -pipe"
DISTDIR="/home/gentoo/portage/distfiles"
FEATURES="ccache distlocks fixpackages parallel-fetch protect-owned sandbox sfperms strict unmerge-orphans userfetch webrsync-gpg"
GENTOO_MIRRORS="http://gentoo.osuosl.org/ http://de-mirror.org/distro/gentoo/ http://mirror.switch.ch/ftp/mirror/gentoo/"
LANG="hu_HU.UTF-8"
LC_ALL="hu_HU.UTF-8"
LDFLAGS="-Wl,-O1"
LINGUAS="hu"
MAKEOPTS="-j4"
PKGDIR="/home/gentoo/portage/packages"
PORTAGE_CONFIGROOT="/"
PORTAGE_RSYNC_OPTS="--recursive --links --safe-links --perms --times --compress --force --whole-file --delete --stats --timeout=180 --exclude=/distfiles --exclude=/local --exclude=/packages"
PORTAGE_TMPDIR="/home/gentoo/tmp"
PORTDIR="/home/gentoo/portage"
PORTDIR_OVERLAY="/home/gentoo/overlay"
SYNC="rsync://rsync.at.gentoo.org/gentoo-portage"
USE="X acpi alsa amd64 bluetooth bzip2 cli cracklib crypt dbus dri dvd dvdr flac ftp gdbm gif gnome gnome-keyring gstreamer gtk hal howl iconv isdnlog jpeg lcms libnotify midi mmx mmxext mp3 mudflap multilib ncurses networkmanager nls nptl nptlonly ogg opengl openmp pam pch pcre perl png pppd python readline reflection session slang spl sse sse2 sse3 ssl ssse3 sysfs tcpd tiff truetype unicode xinerama xorg zlib" ALSA_CARDS="hda-intel" ALSA_PCM_PLUGINS="adpcm alaw asym copy dmix dshare dsnoop empty extplug file hooks iec958 ioplug ladspa lfloat linear meter mmap_emul mulaw multi null plug rate route share shm softvol" APACHE2_MODULES="actions alias auth_basic auth_digest authn_dbd authn_default authn_file authz_default authz_groupfile authz_host authz_owner authz_user autoindex cache dav dav_fs dav_lock dbd deflate dir env expires ext_filter filter headers ident imagemap include info log_config mem_cache mime mime_magic negotiation rewrite setenvif so speling status userdir usertrack unique_id vhost_alias suexec" APACHE2_MPMS="worker" CAMERAS="canon fuji ptp2" ELIBC="glibc" INPUT_DEVICES="keyboard mouse synaptics evdev" KERNEL="linux" LCD_DEVICES="bayrad cfontz cfontz633 glk hd44780 lb216 lcdm001 mtxorb ncurses text" LINGUAS="hu" USERLAND="GNU" VIDEO_CARDS="radeonhd vesa radeon"
Unset:  CPPFLAGS, CTARGET, EMERGE_DEFAULT_OPTS, FFLAGS, INSTALL_MASK, PORTAGE_COMPRESS, PORTAGE_COMPRESS_FLAGS, PORTAGE_RSYNC_EXTRA_OPTS
Comment 5 Robert Piasek (RETIRED) gentoo-dev 2009-06-15 14:22:46 UTC
Hi,

I need debugging information. Could you please run networkmanager like:

NM_SERIAL_DEBUG=1 /usr/sbin/Networkmanager --no-daemon
Comment 6 Robert Piasek (RETIRED) gentoo-dev 2009-06-15 15:23:57 UTC
I'm assuming there was a problem with upstream patch.

I've think I fixed it. I've uploaded testing version to my overlay. Could you please try it and let me know if that works for you?

layman -a dagger
Comment 7 Christian Loosli 2009-06-15 17:06:13 UTC
Hi, 

sorry for not providing debug information earlier, I am used to receiving mails by default for bugs I commented on, seems this is not the case here. 

I just got -r5 out of your overlay, and it seems to work with the Sierra Compass 885 so far. However, I did not do any extended tests so far due to lack of time. 

Thought I give a first feedback anyway. 

Kind regards
Comment 8 Robert Piasek (RETIRED) gentoo-dev 2009-06-19 08:59:49 UTC
networkmanager-0.7.1-r6 fixes the problem