Description: Ubuntu 11.10
Release: 11.10
When I connect my Novatel MIFI 2372 on my computer sometime is configured on TTYUSB0 and sometine on TTYUSB3. When it on TTYUSB0 I can connect to Internet but when it on TTYUSB3 I not able to connect to Internet. I have to disconnect the device and reconnect until is set to TTYUSB0...
When it not working the /var/syslog report
Feb 21 08:51:07 2007-0020 NetworkManager[783]: <info> (ttyUSB3): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
Feb 21 08:51:53 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) starting connection 'Bell Mobility Internet'
Feb 21 08:51:53 2007-0020 NetworkManager[783]: <info> (ttyUSB3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Feb 21 08:51:53 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
Feb 21 08:51:53 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
Feb 21 08:51:53 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
Feb 21 08:51:53 2007-0020 modem-manager[768]: <info> (ttyUSB3) opening serial port...
Feb 21 08:51:53 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/22: state changed (disabled -> enabling)
Feb 21 08:51:53 2007-0020 modem-manager[768]: <info> (ttyUSB0) opening serial port...
Feb 21 08:51:53 2007-0020 modem-manager[768]: Invalid error code: 303
Feb 21 08:51:53 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/22: state changed (enabling -> enabled)
Feb 21 08:51:53 2007-0020 NetworkManager[783]: <info> WWAN now enabled by management service
Feb 21 08:51:53 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/22: state changed (enabled -> registered)
Feb 21 08:51:54 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/22: state changed (registered -> connecting)
Feb 21 08:51:54 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/22: state changed (connecting -> connected)
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) scheduled...
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) starting...
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> (ttyUSB3): device state change: prepare -> config (reason 'none') [40 50 0]
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) successful.
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 3 of 5 (IP Configure Start) scheduled.
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) complete.
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 3 of 5 (IP Configure Start) started...
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> (ttyUSB3): device state change: config -> ip-config (reason 'none') [50 70 0]
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> starting PPP connection
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> pppd started with pid 20795
Feb 21 08:51:54 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB3) Stage 3 of 5 (IP Configure Start) complete.
Feb 21 08:51:54 2007-0020 pppd[20795]: Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded.
Feb 21 08:51:54 2007-0020 pppd[20795]: pppd 2.4.5 started by root, uid 0
Feb 21 08:51:54 2007-0020 pppd[20795]: Using interface ppp0
Feb 21 08:51:54 2007-0020 pppd[20795]: Connect: ppp0 <--> /dev/ttyUSB3
Feb 21 08:51:54 2007-0020 NetworkManager[783]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Feb 21 08:51:54 2007-0020 NetworkManager[783]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Feb 21 08:52:14 2007-0020 NetworkManager[783]: <warn> pppd timed out or didn't initialize our dbus module
Feb 21 08:52:14 2007-0020 NetworkManager[783]: <info> (ttyUSB3): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Feb 21 08:52:14 2007-0020 NetworkManager[783]: <warn> Activation (ttyUSB3) failed.
Feb 21 08:52:14 2007-0020 NetworkManager[783]: <info> (ttyUSB3): device state change: failed -> disconnected (reason 'none') [120 30 0]
Feb 21 08:52:14 2007-0020 NetworkManager[783]: <info> (ttyUSB3): deactivating device (reason 'none') [0]
Feb 21 08:52:14 2007-0020 NetworkManager[783]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
Feb 21 08:52:14 2007-0020 NetworkManager[783]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
Feb 21 08:52:14 2007-0020 pppd[20795]: Terminating on signal 15
Feb 21 08:52:14 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/22: state changed (connected -> disconnecting)
Feb 21 08:52:15 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/22: state changed (disconnecting -> registered)
Feb 21 08:52:16 2007-0020 NetworkManager[783]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
When it working :
Feb 21 08:53:44 2007-0020 NetworkManager[783]: <info> (ttyUSB0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
Feb 21 08:54:12 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) starting connection 'Bell Mobility Internet'
Feb 21 08:54:12 2007-0020 NetworkManager[783]: <info> (ttyUSB0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Feb 21 08:54:12 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 21 08:54:12 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Feb 21 08:54:12 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Feb 21 08:54:12 2007-0020 modem-manager[768]: <info> (ttyUSB0) opening serial port...
Feb 21 08:54:12 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/24: state changed (disabled -> enabling)
Feb 21 08:54:12 2007-0020 modem-manager[768]: <info> (ttyUSB3) opening serial port...
Feb 21 08:54:12 2007-0020 modem-manager[768]: Invalid error code: 303
Feb 21 08:54:13 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/24: state changed (enabling -> enabled)
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> WWAN now enabled by management service
Feb 21 08:54:13 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/24: state changed (enabled -> registered)
Feb 21 08:54:13 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/24: state changed (registered -> connecting)
Feb 21 08:54:13 2007-0020 modem-manager[768]: <info> Modem /org/freedesktop/ModemManager/Modems/24: state changed (connecting -> connected)
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> (ttyUSB0): device state change: prepare -> config (reason 'none') [40 50 0]
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> (ttyUSB0): device state change: config -> ip-config (reason 'none') [50 70 0]
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> starting PPP connection
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> pppd started with pid 21290
Feb 21 08:54:13 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
Feb 21 08:54:13 2007-0020 pppd[21290]: Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded.
Feb 21 08:54:13 2007-0020 pppd[21290]: pppd 2.4.5 started by root, uid 0
Feb 21 08:54:13 2007-0020 pppd[21290]: Using interface ppp0
Feb 21 08:54:13 2007-0020 pppd[21290]: Connect: ppp0 <--> /dev/ttyUSB0
Feb 21 08:54:13 2007-0020 NetworkManager[783]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Feb 21 08:54:13 2007-0020 NetworkManager[783]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Feb 21 08:54:13 2007-0020 pppd[21290]: CHAP authentication succeeded
Feb 21 08:54:13 2007-0020 pppd[21290]: CHAP authentication succeeded
Feb 21 08:54:19 2007-0020 pppd[21290]: Could not determine remote IP address: defaulting to 10.64.64.64
Feb 21 08:54:19 2007-0020 pppd[21290]: local IP address 10.29.149.88
Feb 21 08:54:19 2007-0020 pppd[21290]: remote IP address 10.64.64.64
Feb 21 08:54:19 2007-0020 pppd[21290]: primary DNS address 206.47.201.246
Feb 21 08:54:19 2007-0020 pppd[21290]: secondary DNS address 207.164.79.254
Feb 21 08:54:19 2007-0020 NetworkManager[783]: <info> PPP manager(IP Config Get) reply received.
Feb 21 08:54:19 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) scheduled...
Feb 21 08:54:19 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) started...
Feb 21 08:54:19 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) started...
Feb 21 08:54:20 2007-0020 NetworkManager[783]: <info> (ttyUSB0): device state change: ip-config -> activated (reason 'none') [70 100 0]
Feb 21 08:54:20 2007-0020 NetworkManager[783]: <info> Policy set 'Bell Mobility Internet' (ppp0) as default for IPv4 routing and DNS.
Feb 21 08:54:20 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) successful, device activated.
Feb 21 08:54:20 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) complete.
Feb 21 08:54:20 2007-0020 NetworkManager[783]: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) complete.
Feb 21 08:54:20 2007-0020 dbus[751]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
Feb 21 08:54:20 2007-0020 dbus[751]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
This should be simple enough, provided that we can track back down whether there were any changes there (I seem to recall another such bug). I really ought to spend a bit of time debugging this; but for now, reassigning to modemmanager so I can get back to it when I review those bugs.