Bug 717017 - NetworkManager can't connect to 3G mobile
Summary: NetworkManager can't connect to 3G mobile
Keywords:
Status: CLOSED NOTABUG
Alias: None
Product: Fedora
Classification: Fedora
Component: NetworkManager
Version: 15
Hardware: x86_64
OS: Linux
unspecified
high
Target Milestone: ---
Assignee: Dan Williams
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2011-06-27 18:24 UTC by Clodoaldo Pinto Neto
Modified: 2011-07-07 07:14 UTC (History)
4 users (show)

Fixed In Version:
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed: 2011-07-04 14:46:52 UTC
Type: ---


Attachments (Terms of Use)
relevant /var/log/messages (6.41 KB, text/x-log)
2011-06-27 18:24 UTC, Clodoaldo Pinto Neto
no flags Details

Description Clodoaldo Pinto Neto 2011-06-27 18:24:14 UTC
Created attachment 510135 [details]
relevant /var/log/messages

Description of problem:
After yum upgrading NetworkManager I can't connect to 3G anymore

Version-Release number of selected component (if applicable):

0.8.9997-4

How reproducible:

Always.

Steps to Reproduce:
1. Click on the Mobile connection at the network shell extension
  
Actual results:

No connection

Expected results:

A connection to the 3G network

Additional info:
The fix is to downgrade NetworkManager
http://forums.fedoraforum.org/showthread.php?p=1489752&posted=1#post1489752

Comment 1 Jirka Klimes 2011-06-28 07:25:40 UTC
Please, ensure that the SELinux error is gone (by running the restorecon or disabling the SELinux). Then follow the steps in section "Debugging NetworkManager 0.8.x 3G connections" on http://live.gnome.org/NetworkManager/Debugging and paste here the logs from NM and MM.

Comment 2 Clodoaldo Pinto Neto 2011-07-04 14:08:19 UTC
After reupdating NetworkManager I can't reproduce it anymore.

Comment 3 arturj 2011-07-05 07:31:34 UTC
I'm affected by this bug too. I followed the debugging instructions and then it worked. After rebooting it stoped working again: here are my /var/log/messages upon first try after reboot and second try to connect to 3G. Also, I'm not prompted the PIN question any more... but can't find the key in keyring manager also. 


############# first try #################

Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) starting connection 'Alice Option Mobile'
Jul  5 09:25:46 eee NetworkManager[611]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Jul  5 09:25:46 eee modem-manager[672]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting)
Jul  5 09:25:46 eee modem-manager[672]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected)
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
Jul  5 09:25:46 eee NetworkManager[611]: <info> (ttyUSB0): device state change: prepare -> config (reason 'none') [40 50 0]
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
Jul  5 09:25:46 eee NetworkManager[611]: <info> (ttyUSB0): device state change: config -> ip-config (reason 'none') [50 70 0]
Jul  5 09:25:46 eee NetworkManager[611]: <info> starting PPP connection
Jul  5 09:25:46 eee NetworkManager[611]: <info> pppd started with pid 1557
Jul  5 09:25:46 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
Jul  5 09:25:46 eee pppd[1557]: Warning: can't open options file /root/.ppprc: Permission denied
Jul  5 09:25:46 eee pppd[1557]: Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded.
Jul  5 09:25:47 eee kernel: [  107.115179] PPP generic driver version 2.4.2
Jul  5 09:25:47 eee pppd[1557]: pppd 2.4.5 started by root, uid 0
Jul  5 09:25:47 eee pppd[1557]: Can't create lock file /var/lock/ppp/LCK..ttyUSB0: Permission denied
Jul  5 09:25:47 eee NetworkManager[611]: <info> (ttyUSB0): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Jul  5 09:25:47 eee pppd[1557]: Exit.
Jul  5 09:25:47 eee NetworkManager[611]: <warn> Activation (ttyUSB0) failed.
Jul  5 09:25:47 eee NetworkManager[611]: <warn> pppd pid 1557 exited with error: Serial port lock failed
Jul  5 09:25:47 eee NetworkManager[611]: <info> (ttyUSB0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Jul  5 09:25:47 eee NetworkManager[611]: <info> (ttyUSB0): deactivating device (reason: 0).
Jul  5 09:25:47 eee modem-manager[672]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
Jul  5 09:25:47 eee dbus: [system] Activating service name='org.fedoraproject.Setroubleshootd' (using servicehelper)
Jul  5 09:25:48 eee modem-manager[672]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> registered)
Jul  5 09:25:51 eee dbus: [system] Successfully activated service 'org.fedoraproject.Setroubleshootd'
Jul  5 09:26:00 eee setroubleshoot: SELinux is preventing /usr/sbin/pppd from read access on the lnk_file /var/lock. For complete SELinux messages. run sealert -l e7b993cb-6bc3-4adc-8777-b1516f09cb27

########### second try ##############

Jul  5 09:26:23 eee NetworkManager[611]: <info> Activation (ttyUSB0) starting connection 'Alice Option Mobile'
Jul  5 09:26:23 eee NetworkManager[611]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Jul  5 09:26:23 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Jul  5 09:26:23 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Jul  5 09:26:23 eee NetworkManager[611]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Jul  5 09:26:49 eee NetworkManager[611]: <warn> GSM connection failed: (32) Serial command timed out
Jul  5 09:26:49 eee NetworkManager[611]: <info> (ttyUSB0): device state change: prepare -> failed (reason 'unknown') [40 120 1]
Jul  5 09:26:49 eee NetworkManager[611]: <warn> Activation (ttyUSB0) failed.
Jul  5 09:26:49 eee NetworkManager[611]: <info> (ttyUSB0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Jul  5 09:26:49 eee NetworkManager[611]: <info> (ttyUSB0): deactivating device (reason: 0).

Comment 4 Jirka Klimes 2011-07-07 07:14:54 UTC
See bug 717161 for the SELinux error.


Note You need to log in before you can comment on or make changes to this bug.