NM crashes w/ "unable to handle kernel NULL pointer" when connection to GSM/UMTS using Option iCon 401 on Jaunty UNR final

[Marc Domachowski]

Binary package hint: network-manager

Hi!

Just installed Jaunty UNR from scratch on a Dell Mini 9. Using "ozerocdoff" from the Lauchpad package to switch the Option iCon 401 into modem mode. Set the security of the SIM card to "no PIN request", so no PIN is required (to circumvent another issue). When trying to connect to the network, NetworkManager crashes, the system might eventually freeze. I was not able to reproduce the later to a 100%. Here is the details:

System: Ubuntu 9.04
Package: 0.7.1~rc4.1.cf199a964.0ubuntu2
Syslog after plugging in the USB modem:

######

Apr 24 12:32:10 ubook kernel: [ 108.476152] usb 1-1: new high speed USB device using ehci_hcd and address 3
Apr 24 12:32:10 ubook kernel: [ 108.610879] usb 1-1: configuration #1 chosen from 1 choice
Apr 24 12:32:10 ubook kernel: [ 108.638692] Initializing USB Mass Storage driver...
Apr 24 12:32:10 ubook kernel: [ 108.639610] scsi2 : SCSI emulation for USB Mass Storage devices
Apr 24 12:32:10 ubook kernel: [ 108.640708] usbcore: registered new interface driver usb-storage
Apr 24 12:32:10 ubook kernel: [ 108.641487] USB Mass Storage support registered.
Apr 24 12:32:10 ubook kernel: [ 108.641950] usb-storage: device found at 3
Apr 24 12:32:10 ubook kernel: [ 108.641962] usb-storage: waiting for device to settle before scanning
Apr 24 12:32:11 ubook kernel: [ 109.782770] usb 1-1: USB disconnect, address 3
Apr 24 12:32:11 ubook kernel: [ 110.028119] usb 1-1: new high speed USB device using ehci_hcd and address 4
Apr 24 12:32:12 ubook kernel: [ 110.163172] usb 1-1: configuration #1 chosen from 1 choice
Apr 24 12:32:12 ubook kernel: [ 110.165893] usb-storage: probe of 1-1:1.0 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.167850] usb-storage: probe of 1-1:1.1 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.170579] usb-storage: probe of 1-1:1.2 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.171983] usb-storage: probe of 1-1:1.3 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.174423] usb-storage: probe of 1-1:1.4 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.176340] usb-storage: probe of 1-1:1.5 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.179742] usb-storage: probe of 1-1:1.6 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.180955] usb-storage: probe of 1-1:1.7 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.182826] usb-storage: probe of 1-1:1.8 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.183757] usb-storage: probe of 1-1:1.9 failed with error -5
Apr 24 12:32:12 ubook kernel: [ 110.184898] scsi13 : SCSI emulation for USB Mass Storage devices
Apr 24 12:32:12 ubook kernel: [ 110.188366] usb-storage: device found at 4
Apr 24 12:32:12 ubook kernel: [ 110.188379] usb-storage: waiting for device to settle before scanning
Apr 24 12:32:12 ubook kernel: [ 110.830949] hso: /build/buildd/linux-2.6.28/drivers/net/usb/hso.c: 1.2 Option Wireless
Apr 24 12:32:12 ubook kernel: [ 110.835817] hso0: Disabled Privacy Extensions
Apr 24 12:32:12 ubook kernel: [ 110.838518] usbcore: registered new interface driver hso
Apr 24 12:32:12 ubook pulseaudio[3211]: module-hal-detect.c: D-Bus error while parsing HAL data: org.freedesktop.Hal.NoSuchDevice: No device with id /org/freedesktop/Hal/devices/usb_device_af0_7401_noserial_if0_scsi_host
Apr 24 12:32:13 ubook NetworkManager: <info> (ttyHS2): found serial port (udev:GSM hal:)
Apr 24 12:32:13 ubook NetworkManager: <info> (ttyHS2): deferring until all ports found
Apr 24 12:32:13 ubook NetworkManager: <info> (ttyHS1): found serial port (udev:GSM hal:)
Apr 24 12:32:13 ubook NetworkManager: <info> (ttyHS1): deferring until all ports found
Apr 24 12:32:13 ubook NetworkManager: <info> (ttyHS3): found serial port (udev:GSM hal:)
Apr 24 12:32:13 ubook NetworkManager: <info> (ttyHS3): deferring until all ports found
Apr 24 12:32:17 ubook kernel: [ 115.188909] usb-storage: device scan complete
Apr 24 12:32:17 ubook kernel: [ 115.189776] scsi 13:0:0:0: Direct-Access ZCOption HSUPA Modem PQ: 0 ANSI: 2
Apr 24 12:32:17 ubook kernel: [ 115.197306] sd 13:0:0:0: [sdb] Attached SCSI removable disk
Apr 24 12:32:17 ubook kernel: [ 115.199564] sd 13:0:0:0: Attached scsi generic sg1 type 0
Apr 24 12:32:17 ubook NetworkManager: <info> Re-checking deferred serial ports
Apr 24 12:32:18 ubook NetworkManager: <info> (ttyHS2): new Modem device (driver: 'hso')
Apr 24 12:32:18 ubook NetworkManager: <info> (ttyHS2): exported as /org/freedesktop/Hal/devices/usb_device_af0_7401_noserial_if6_serial_unknown_2
Apr 24 12:32:19 ubook NetworkManager: <info> (ttyHS0): ignoring due to lack of mobile broadband capabilties
Apr 24 12:32:22 ubook NetworkManager: <info> (ttyHS2): device state change: 1 -> 2
Apr 24 12:32:22 ubook NetworkManager: <info> (ttyHS2): deactivating device (reason: 2).
Apr 24 12:32:22 ubook NetworkManager: nm_system_device_flush_ip4_routes_with_iface: assertion `iface_idx >= 0' failed
Apr 24 12:32:22 ubook NetworkManager: nm_system_device_flush_ip4_addresses_with_iface: assertion `iface_idx >= 0' failed
Apr 24 12:32:22 ubook NetworkManager: <info> (ttyHS2): device state change: 2 -> 3
Apr 24 12:33:02 ubook NetworkManager: <info> Activation (ttyHS2) starting connection 'T-mobile (D1)'
Apr 24 12:33:02 ubook NetworkManager: <info> (ttyHS2): device state change: 3 -> 4
Apr 24 12:33:02 ubook NetworkManager: <info> Activation (ttyHS2) Stage 1 of 5 (Device Prepare) scheduled...
Apr 24 12:33:02 ubook NetworkManager: <info> Activation (ttyHS2) Stage 1 of 5 (Device Prepare) started...
Apr 24 12:33:02 ubook NetworkManager: <debug> [1240569182.753755] nm_serial_device_open(): (ttyHS2) opening device...
Apr 24 12:33:02 ubook NetworkManager: <info> Activation (ttyHS2) Stage 1 of 5 (Device Prepare) complete.
Apr 24 12:33:02 ubook NetworkManager: <info> (ttyHS2): powering up...
Apr 24 12:33:03 ubook NetworkManager: <info> Registered on Home network
Apr 24 12:33:03 ubook NetworkManager: <info> Associated with network: +COPS: 0,0,"T-Mobile D",2
Apr 24 12:33:03 ubook kernel: [ 161.332437] usb 1-1: USB disconnect, address 4
Apr 24 12:33:03 ubook NetworkManager: <WARN> dial_done(): Dialing timed out
Apr 24 12:33:03 ubook NetworkManager: <info> (ttyHS2): device state change: 4 -> 9
Apr 24 12:33:03 ubook NetworkManager: <debug> [1240569183.223636] nm_serial_device_close(): Closing device 'ttyHS2'
Apr 24 12:33:03 ubook kernel: [ 161.340410] BUG: unable to handle kernel NULL pointer dereference at 0000003c
Apr 24 12:33:03 ubook kernel: [ 161.340438] IP: [<c0501a13>] mutex_unlock+0x3/0x10
Apr 24 12:33:03 ubook kernel: [ 161.340466] *pde = 00000000
Apr 24 12:33:03 ubook kernel: [ 161.340482] Oops: 0002 [#1] SMP
Apr 24 12:33:03 ubook kernel: [ 161.340498] last sysfs file: /sys/devices/LNXSYSTM:00/device:00/PNP0A08:00/device:2a/PNP0C0A:00/power_supply/BAT1/charge_full
Apr 24 12:33:03 ubook kernel: [ 161.340520] Dumping ftrace buffer:
Apr 24 12:33:03 ubook kernel: [ 161.340532] (ftrace buffer empty)
Apr 24 12:33:03 ubook kernel: [ 161.340543] Modules linked in: hso usb_storage xt_limit xt_tcpudp ipt_LOG ipt_MASQUERADE xt_DSCP ipt_REJECT nf_conntrack_irc nf_conntrack_ftp xt_state michael_mic arc4 ecb i915 drm binfmt_misc ppdev bridge stp bnep input_polldev joydev lp parport iptable_nat nf_nat nf_conntrack_ipv4 nf_conntrack nf_defrag_ipv4 iptable_mangle iptable_filter ip_tables x_tables snd_hda_intel snd_pcm_oss snd_mixer_oss dcdbas snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi iTCO_wdt iTCO_vendor_support psmouse snd_rawmidi pcspkr serio_raw uvcvideo snd_seq_midi_event compat_ioctl32 videodev v4l1_compat snd_seq snd_timer snd_seq_device ieee80211_crypt_tkip snd wl(P) ieee80211_crypt sdhci_pci sdhci soundcore snd_page_alloc intel_agp agpgart video output r8169 mii fbcon tileblit font bitblit softcursor
Apr 24 12:33:03 ubook kernel: [ 161.340806]
Apr 24 12:33:03 ubook kernel: [ 161.340823] Pid: 2759, comm: NetworkManager Tainted: P (2.6.28-11-generic #42-Ubuntu) Inspiron 910
Apr 24 12:33:03 ubook kernel: [ 161.340842] EIP: 0060:[<c0501a13>] EFLAGS: 00010206 CPU: 0
Apr 24 12:33:03 ubook kernel: [ 161.340860] EIP is at mutex_unlock+0x3/0x10
Apr 24 12:33:03 ubook kernel: [ 161.340873] EAX: 0000003c EBX: ef7370c0 ECX: f67a13c0 EDX: 00000001
Apr 24 12:33:03 ubook kernel: [ 161.340889] ESI: 00000001 EDI: 00000000 EBP: f009de7c ESP: f009de7c
Apr 24 12:33:03 ubook kernel: [ 161.340903] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
Apr 24 12:33:03 ubook kernel: [ 161.340920] Process NetworkManager (pid: 2759, ti=f009c000 task=f0068c90 task.ti=f009c000)
Apr 24 12:33:03 ubook kernel: [ 161.340933] Stack:
Apr 24 12:33:03 ubook kernel: [ 161.340942] f009de98 f8933083 0000007b c062007b ef7000d8 ef70b000 f6340660 f009df40
Apr 24 12:33:03 ubook kernel: [ 161.340977] c032d347 f66ea800 f009dec0 f7e9dd55 00190001 ef70b000 ee43b3c0 00000000
Apr 24 12:33:03 ubook kernel: [ 161.341014] f66ea800 f009dedc f7e9c0ff f009df3c 00000000 f009deec c01529ea 00000000
Apr 24 12:33:03 ubook kernel: [ 161.341051] Call Trace:
Apr 24 12:33:03 ubook kernel: [ 161.341062] [<f8933083>] ? hso_serial_close+0x63/0xf0 [hso]
Apr 24 12:33:03 ubook kernel: [ 161.341097] [<c032d347>] ? tty_release_dev+0x147/0x4d0
Apr 24 12:33:03 ubook kernel: [ 161.341136] [<f7e9dd55>] ? synaptics_process_byte+0x45/0x160 [psmouse]
Apr 24 12:33:03 ubook kernel: [ 161.341193] [<f7e9c0ff>] ? psmouse_handle_byte+0xf/0x110 [psmouse]
Apr 24 12:33:03 ubook kernel: [ 161.341237] [<c01529ea>] ? hrtimer_try_to_cancel+0x3a/0x90
Apr 24 12:33:03 ubook kernel: [ 161.341278] [<c03da965>] ? serio_interrupt+0x45/0x80
Apr 24 12:33:03 ubook kernel: [ 161.341300] [<c032d6e2>] ? tty_release+0x12/0x20
Apr 24 12:33:03 ubook kernel: [ 161.341321] [<c01bea24>] ? __fput+0xb4/0x1c0
Apr 24 12:33:03 ubook kernel: [ 161.341343] [<c01beb4f>] ? fput+0x1f/0x30
Apr 24 12:33:03 ubook kernel: [ 161.341364] [<c01bb539>] ? filp_close+0x49/0x70
Apr 24 12:33:03 ubook kernel: [ 161.341384] [<c01bb5da>] ? sys_close+0x7a/0xc0
Apr 24 12:33:03 ubook kernel: [ 161.341404] [<c0103f6b>] ? sysenter_do_call+0x12/0x2f
Apr 24 12:33:03 ubook kernel: [ 161.341428] Code: 04 24 89 d8 c7 45 e8 00 ed 14 c0 e8 e8 fe ff ff 8b 5d f4 8b 75 f8 8b 7d fc 89 ec 5d c3 00 00 00 00 00 00 00 00 00 00 00 55 89 e5 <f0> ff 00 7f 05 e8 43 01 00 00 5d c3 90 55 ba 01 00 00 00 89 e5
Apr 24 12:33:03 ubook kernel: [ 161.341627] EIP: [<c0501a13>] mutex_unlock+0x3/0x10 SS:ESP 0068:f009de7c
Apr 24 12:33:03 ubook kernel: [ 161.341661] ---[ end trace b62117f14ffd6b64 ]---
Apr 24 12:33:08 ubook kernel: [ 166.125148] usb 1-1: new high speed USB device using ehci_hcd and address 5
Apr 24 12:33:08 ubook kernel: [ 166.259787] usb 1-1: configuration #1 chosen from 1 choice
Apr 24 12:33:08 ubook kernel: [ 166.262568] scsi14 : SCSI emulation for USB Mass Storage devices
Apr 24 12:33:08 ubook kernel: [ 166.265437] usb-storage: device found at 5
Apr 24 12:33:08 ubook kernel: [ 166.265453] usb-storage: waiting for device to settle before scanning
Apr 24 12:33:09 ubook kernel: [ 167.430990] usb 1-1: USB disconnect, address 5
Apr 24 12:33:09 ubook kernel: [ 167.704172] usb 1-1: new high speed USB device using ehci_hcd and address 6
Apr 24 12:33:09 ubook kernel: [ 167.840444] usb 1-1: configuration #1 chosen from 1 choice
Apr 24 12:33:09 ubook kernel: [ 167.843816] usb-storage: probe of 1-1:1.0 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.847752] usb-storage: probe of 1-1:1.1 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.850419] usb-storage: probe of 1-1:1.2 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.853343] usb-storage: probe of 1-1:1.3 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.857236] usb-storage: probe of 1-1:1.4 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.859105] usb-storage: probe of 1-1:1.5 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.862630] usb-storage: probe of 1-1:1.6 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.866510] usb-storage: probe of 1-1:1.7 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.870578] hso0: Disabled Privacy Extensions
Apr 24 12:33:09 ubook kernel: [ 167.874800] usb-storage: probe of 1-1:1.8 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.880232] usb-storage: probe of 1-1:1.9 failed with error -5
Apr 24 12:33:09 ubook kernel: [ 167.883737] scsi25 : SCSI emulation for USB Mass Storage devices
Apr 24 12:33:09 ubook kernel: [ 167.884869] usb-storage: device found at 6
Apr 24 12:33:09 ubook kernel: [ 167.884884] usb-storage: waiting for device to settle before scanning
Apr 24 12:33:10 ubook pulseaudio[3211]: module-hal-detect.c: D-Bus error while parsing HAL data: org.freedesktop.Hal.NoSuchDevice: No device with id /org/freedesktop/Hal/devices/usb_device_af0_7401_noserial_if0
Apr 24 12:33:10 ubook pulseaudio[3211]: module-hal-detect.c: D-Bus error while parsing HAL data: org.freedesktop.Hal.NoSuchDevice: No device with id /org/freedesktop/Hal/devices/usb_device_af0_7401_noserial_if0_scsi_host
Apr 24 12:33:14 ubook kernel: [ 172.884875] usb-storage: device scan complete
Apr 24 12:33:14 ubook kernel: [ 172.885643] scsi 25:0:0:0: Direct-Access ZCOption HSUPA Modem PQ: 0 ANSI: 2
Apr 24 12:33:14 ubook kernel: [ 172.891046] sd 25:0:0:0: [sdb] Attached SCSI removable disk
Apr 24 12:33:14 ubook kernel: [ 172.891371] sd 25:0:0:0: Attached scsi generic sg1 type 0

######

Best regards from Bad Soden,
Marc

[Alexander Sack (asac)]

could be that its using the wrong port. does upgrading to the jaunty packages in network-manager ppa help (https://launchpad.net/~network-manager/+archive/ppa) you?

[Pedro Villavicencio (pedro)]

We are closing this bug report because it lacks the information we need to investigate the problem, as described in the previous comments. Please reopen it if you can give us the missing information, and don't hesitate to submit bug reports in the future. To reopen the bug report you can click on the current status, under the Status column, and change the Status back to New. Thanks again!.