Re: Sierra Wireless MC8790V



On Fri, 2011-11-11 at 14:54 +0100, Markus Becker wrote:
> Hi,
> 
> I have been using a Sierra Wireless MC8790V device with NetworkManager on Debian. Many times the connection is successfully performed, but sometimes not and then it fails 
> always (until I forcefully rmmod sierra and modprobe it again).

So what's happening here is that the data port apparently unexpectedly
hangs up.  The modem may have crashed, actually.  Right after this
happens, does the modem re-enumerate itself in syslog?  Is ttyUSB6 still
around?

Dan

> The usual information:
> 
> cat /etc/debian_version
> wheezy/sid 
> 
> uname -r
> 3.0.0-2-686-pae
> 
> dpkg -l | grep network-manager
> ii  network-manager                           0.9.1.95-1                        network management framework (daemon and userspace tools)
> ii  network-manager-gnome                     0.9.1.95-1                        network management framework (GNOME frontend)
> ii  network-manager-openvpn                   0.9.0-3                           network management framework (OpenVPN plugin core)
> ii  network-manager-openvpn-gnome             0.9.0-3                           network management framework (OpenVPN plugin GNOME GUI)
> ii  network-manager-pptp                      0.9.0-3                           network management framework (PPTP plugin core)
> ii  network-manager-pptp-gnome                0.9.0-3                           network management framework (PPTP plugin GNOME GUI)
> ii  network-manager-strongswan                1.1.2-2+b1                        network management framework (strongSwan plugin)
> ii  network-manager-vpnc                      0.9.0-3                           network management framework (VPNC plugin core)
> ii  network-manager-vpnc-gnome                0.9.0-3                           network management framework (VPNC plugin GNOME GUI)
> 
> Here is the daemon.log. I tried to mark the differing log lines with <--------------------*****
> 
> Any help is appreciated!
> 
> Thanks,
> Markus
> --------------------------------
> Manual disconnect:
> 
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: activated -> disconnected (reason 'user-requested') [100 30 39]
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): deactivating device (reason 'user-requested') [39]
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
> Nov 11 14:14:29 vtc6200 modem-manager[2816]: <info>  [1321017269.289212] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:14:29 vtc6200 avahi-daemon[1548]: Withdrawing workstation service for ppp0.
> Nov 11 14:14:29 vtc6200 avahi-daemon[1548]: Withdrawing workstation service for tun0.
> Nov 11 14:14:29 vtc6200 nm-openvpn[3559]: SIGTERM[hard,] received, process exiting
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]: <warn> (16) failed to find interface name for index
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `iface != NULL' failed
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]: <warn> (16) failed to find interface name for index
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
> Nov 11 14:14:29 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/tun0, iface: tun0)
> Nov 11 14:14:30 vtc6200 modem-manager[2816]: <debug> [1321017270.754622] [mm-at-serial-port.c:298] debug_log(): (ttyUSB6): --> 'AT+CGACT=0,1<CR>'
> Nov 11 14:14:30 vtc6200 modem-manager[2816]: <debug> [1321017270.776306] [mm-at-serial-port.c:298] debug_log(): (ttyUSB6): <-- '<CR><LF>ERROR<CR><LF>'
> Nov 11 14:14:30 vtc6200 modem-manager[2816]: <debug> [1321017270.776438] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
> Nov 11 14:14:30 vtc6200 modem-manager[2816]: <debug> [1321017270.833235] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>NO CARRIER<CR><LF>'
> Nov 11 14:14:30 vtc6200 modem-manager[2816]: <debug> [1321017270.833419] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 3: No carrier
> Nov 11 14:14:31 vtc6200 modem-manager[2816]: <debug> [1321017271.780364] [mm-port.c:181] mm_port_set_connected(): (ttyUSB3): port now disconnected
> Nov 11 14:14:31 vtc6200 modem-manager[2816]: <debug> [1321017271.780555] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGACT=0,1<CR>'
> Nov 11 14:14:31 vtc6200 modem-manager[2816]: <debug> [1321017271.796146] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
> Nov 11 14:14:31 vtc6200 modem-manager[2816]: <info>  [1321017271.796747] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> registered)
> 
> Successful connection (with automatic dispatch of VPN service):
> 
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) starting connection 'Vodafone'
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> need-auth (reason 'none') [40 60 0]
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: need-auth -> prepare (reason 'none') [60 40 0]
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802427] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): number => "*99#"
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802532] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): pin => "XXXX"
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802576] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): username => "vodafone"
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802618] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): apn => "web.vodafone.de"
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802667] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): network_mode => 0
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802719] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): password => "vodafone"
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802766] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): allowed_mode => 0
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802830] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 0
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.802979] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 2
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.803160] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CREG?<CR>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.819702] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CREG: 
> 2,1,"059A","025C1E2B",2<CR><LF><CR><LF>OK<CR><LF>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.820008] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 4
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.820189] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGDCONT?<CR>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.841065] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>+CGDCONT: 
> 1,"IP","web.vodafone.de","0.0.0.0",0,0<CR><LF><CR><LF>OK<CR><LF>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.841425] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 5
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <info>  [1321017272.841806] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting)
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.842160] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'AT+CGATT=1<CR>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.854553] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>OK<CR><LF>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.854839] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): --> 'ATD*99***1#<CR>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.868920] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>CONNECT 
> 115200<CR><LF>'
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.869130] [mm-port.c:181] mm_port_set_connected(): (ttyUSB3): port now connected
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <info>  [1321017272.869545] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected)
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.869930] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 6
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) scheduled...
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) starting...
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> config (reason 'none') [40 50 0]
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) successful.
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 3 of 5 (IP Configure Start) scheduled.
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 2 of 5 (Device Configure) complete.
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 3 of 5 (IP Configure Start) started...
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: config -> ip-config (reason 'none') [50 70 0]
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> starting PPP connection
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> pppd started with pid 3647
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 3 of 5 (IP Configure Start) complete.
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
> Nov 11 14:14:32 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
> Nov 11 14:14:32 vtc6200 modem-manager[2816]: <debug> [1321017272.910743] [mm-manager.c:793] device_added(): (net/ppp0): could not get port's parent device
> Nov 11 14:14:34 vtc6200 NetworkManager[2827]: <info> VPN service 'openvpn' disappeared
> Nov 11 14:14:35 vtc6200 NetworkManager[2827]: <info> PPP manager(IP Config Get) reply received.
> Nov 11 14:14:35 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 4 of 5 (IP4 Configure Get) scheduled...
> Nov 11 14:14:35 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 4 of 5 (IP4 Configure Get) started...
> Nov 11 14:14:35 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 5 of 5 (IP Configure Commit) scheduled...
> Nov 11 14:14:35 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 4 of 5 (IP4 Configure Get) complete.
> Nov 11 14:14:35 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 5 of 5 (IP Configure Commit) started...
> Nov 11 14:14:36 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: ip-config -> activated (reason 'none') [70 100 0]
> Nov 11 14:14:36 vtc6200 NetworkManager[2827]: <info> Policy set 'Vodafone' (ppp0) as default for IPv4 routing and DNS.
> Nov 11 14:14:36 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) successful, device activated.
> Nov 11 14:14:36 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 5 of 5 (IP Configure Commit) complete.
> Nov 11 14:14:38 vtc6200 NetworkManager[2827]: <info> Starting VPN service 'openvpn'...
> Nov 11 14:14:38 vtc6200 NetworkManager[2827]: <info> VPN service 'openvpn' started (org.freedesktop.NetworkManager.openvpn), PID 3708
> Nov 11 14:14:38 vtc6200 NetworkManager[2827]: <info> VPN service 'openvpn' appeared; activating connections
> Nov 11 14:14:38 vtc6200 NetworkManager[2827]: <info> VPN plugin state changed: init (1)
> Nov 11 14:14:38 vtc6200 NetworkManager[2827]: <info> VPN plugin state changed: starting (3)
> Nov 11 14:14:38 vtc6200 NetworkManager[2827]: <info> VPN connection 'ComNets VPN' (Connect) reply received.
> Nov 11 14:14:38 vtc6200 nm-openvpn[3711]: OpenVPN 2.2.0 i486-linux-gnu [SSL] [LZO2] [EPOLL] [PKCS11] [eurephia] [MH] [PF_INET6] [IPv6 payload 20110424-2 (2.2RC2)] built 
> on Jun 16 2011
> Nov 11 14:14:38 vtc6200 nm-openvpn[3711]: WARNING: No server certificate verification method has been enabled.  See http://openvpn.net/howto.html#mitm for more info.
> Nov 11 14:14:38 vtc6200 nm-openvpn[3711]: NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
> Nov 11 14:14:38 vtc6200 nm-openvpn[3711]: LZO compression initialized
> Nov 11 14:14:38 vtc6200 nm-openvpn[3711]: UDPv4 link local: [undef]
> Nov 11 14:14:38 vtc6200 nm-openvpn[3711]: UDPv4 link remote: [AF_INET]XX.XX.XX.XX:1194
> Nov 11 14:14:41 vtc6200 nm-openvpn[3711]: [sam] Peer Connection Initiated with [AF_INET]XX.XX.XX.XX:1194
> Nov 11 14:14:45 vtc6200 nm-openvpn[3711]: TUN/TAP device tun0 opened
> Nov 11 14:14:45 vtc6200 nm-openvpn[3711]: /usr/lib/NetworkManager/nm-openvpn-service-openvpn-helper tun0 1500 1542 XX.XX.XX.XX XX.XX.XX.XX init
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/tun0, iface: tun0)
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/tun0, iface: tun0): no ifupdown configuration found.
> Nov 11 14:14:45 vtc6200 modem-manager[2816]: <debug> [1321017285.419277] [mm-manager.c:793] device_added(): (net/tun0): could not get port's parent device
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> VPN connection 'VPN' (IP Config Get) reply received.
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> VPN Gateway: XXXXXXX
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Internal Gateway: XX.XX.XX.XX
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Tunnel Device: tun0
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Internal IP4 Address: XX.XX.XX.XX
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Internal IP4 Prefix: 32
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Internal IP4 Point-to-Point Address: XX.XX.XX.XX
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Maximum Segment Size (MSS): 0
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Static Route: XX.XX.XX.XX/24   Next Hop: XX.XX.XX.XX
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Static Route: XX.XX.XX.XX/32   Next Hop: XX.XX.XX.XX
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Forbid Default Route: no
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> Internal IP4 DNS: XX.XX.XX.XX
> Nov 11 14:14:45 vtc6200 NetworkManager[2827]: <info> DNS Domain: '(none)'
> Nov 11 14:14:45 vtc6200 nm-openvpn[3711]: Initialization Sequence Completed
> Nov 11 14:14:46 vtc6200 NetworkManager[2827]: <info> VPN connection 'ComNets VPN' (IP Config Get) complete.
> Nov 11 14:14:46 vtc6200 NetworkManager[2827]: <info> Policy set 'ComNets VPN' (tun0) as default for IPv4 routing and DNS.
> Nov 11 14:14:46 vtc6200 NetworkManager[2827]: <info> VPN plugin state changed: started (4)
> Nov 11 14:14:54 vtc6200 modem-manager[2816]: <debug> [1321017294.757150] [mm-at-serial-port.c:298] debug_log(): (ttyUSB6): --> 'AT+CIND?<CR>'
> Nov 11 14:14:57 vtc6200 modem-manager[2816]: <debug> [1321017297.756003] [mm-at-serial-port.c:298] debug_log(): (ttyUSB6): --> 'AT*CNTI=0<CR>'
> 
> 
> --------------------------------
> Manual disconnect:
> 
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: activated -> disconnected (reason 'user-requested') [100 30 39]
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): deactivating device (reason 'user-requested') [39]
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
> Nov 11 14:15:00 vtc6200 avahi-daemon[1548]: Withdrawing workstation service for ppp0.
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <info>  [1321017300.175261] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:00 vtc6200 avahi-daemon[1548]: Withdrawing workstation service for tun0.
> Nov 11 14:15:00 vtc6200 nm-openvpn[3711]: SIGTERM[hard,] received, process exiting
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: <warn> (18) failed to find interface name for index
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `iface != NULL' failed
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: <warn> (18) failed to find interface name for index
> Nov 11 14:15:00 vtc6200 dbus[1438]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]:    SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/tun0, iface: tun0)
> Nov 11 14:15:00 vtc6200 dbus[1438]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <debug> [1321017300.662581] [mm-at-serial-port.c:298] debug_log(): (ttyUSB3): <-- '<CR><LF>NO CARRIER<CR><LF>'
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <debug> [1321017300.662743] [mm-serial-parsers.c:412] mm_serial_parser_v1_parse(): Got failure code 3: No carrier
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <debug> [1321017300.665572] [mm-serial-port.c:636] data_available(): (ttyUSB3) unexpected port hangup!  <--------------------
> *****
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <debug> [1321017300.665651] [mm-serial-port.c:844] mm_serial_port_close(): (ttyUSB3) device open count is 0 (close)
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <info>  [1321017300.665720] [mm-serial-port.c:859] mm_serial_port_close(): (ttyUSB3) closing serial port...
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <debug> [1321017300.665810] [mm-port.c:181] mm_port_set_connected(): (ttyUSB3): port now disconnected
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <info>  [1321017300.667232] [mm-serial-port.c:880] mm_serial_port_close(): (ttyUSB3) serial port closed
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <debug> [1321017300.754638] [mm-at-serial-port.c:298] debug_log(): (ttyUSB6): --> 'AT+CGACT=0,1<CR>'
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <debug> [1321017300.777799] [mm-at-serial-port.c:298] debug_log(): (ttyUSB6): <-- '<CR><LF>OK<CR><LF>'
> Nov 11 14:15:00 vtc6200 modem-manager[2816]: <info>  [1321017300.778578] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:00 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.   <--------------------*****
> Nov 11 14:15:05 vtc6200 NetworkManager[2827]: <info> VPN service 'openvpn' disappeared
> 
> Failed try to connect:
> 
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) starting connection 'Vodafone'
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> need-auth (reason 'none') [40 60 0]
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: need-auth -> prepare (reason 'none') [60 40 0]
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <info>  [1321017308.040536] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)  <--------------------*****
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <info>  [1321017308.040986] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)  <--------------------*****
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.  <--------------------*****
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.043917] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): number => "*99#"
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044040] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): pin => "XXXX"
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044102] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): username => "vodafone"
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044163] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): apn => "web.vodafone.de"
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044235] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): network_mode => 0
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044296] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): password => "vodafone"
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044362] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): allowed_mode => 0
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044450] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 0
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <debug> [1321017308.044637] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 2
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <warn> GSM connection failed: (32) Sending command failed: device is not enabled   <--------------------*****
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> failed (reason 'unknown') [40 120 1]
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <warn> Activation (ttyUSB3) failed.
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <info>  [1321017308.048925] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:08 vtc6200 modem-manager[2816]: <info>  [1321017308.049398] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: failed -> disconnected (reason 'none') [120 30 0]
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): deactivating device (reason 'none') [0]
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
> Nov 11 14:15:08 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.
> 
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Auto-activating connection 'Vodafone'.
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) starting connection 'Vodafone'
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> need-auth (reason 'none') [40 60 0]
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: need-auth -> prepare (reason 'none') [60 40 0]
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <info>  [1321017311.763906] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <info>  [1321017311.764436] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765050] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): number => "*99#"
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765146] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): pin => "XXXX"
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765214] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): username => "vodafone"
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765301] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): apn => "web.vodafone.de"
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765372] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): network_mode => 0
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765437] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): password => "vodafone"
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765503] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): allowed_mode => 0
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765599] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 0
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <debug> [1321017311.765966] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 2
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <warn> GSM connection failed: (32) Sending command failed: device is not enabled
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> failed (reason 'unknown') [40 120 1]
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <info>  [1321017311.777111] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:11 vtc6200 modem-manager[2816]: <info>  [1321017311.777706] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <warn> Activation (ttyUSB3) failed.
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: failed -> disconnected (reason 'none') [120 30 0]
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): deactivating device (reason 'none') [0]
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
> Nov 11 14:15:11 vtc6200 NetworkManager[2827]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
> 
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Auto-activating connection 'Vodafone'.
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) starting connection 'Vodafone'
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> need-auth (reason 'none') [40 60 0]
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <info>  [1321017314.761927] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <info>  [1321017314.762458] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: need-auth -> prepare (reason 'none') [60 40 0]
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.767579] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): number => "*99#"
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.767685] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): pin => "XXXX"
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.767744] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): username => "vodafone"
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.767801] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): apn => "web.vodafone.de"
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.767872] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): network_mode => 0
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.767931] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): password => "vodafone"
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.768016] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): allowed_mode => 0
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.768105] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 0
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <debug> [1321017314.768260] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 2
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <warn> GSM connection failed: (32) Sending command failed: device is not enabled
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> failed (reason 'unknown') [40 120 1]
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <warn> Activation (ttyUSB3) failed.
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <info>  [1321017314.773578] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:14 vtc6200 modem-manager[2816]: <info>  [1321017314.774138] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: failed -> disconnected (reason 'none') [120 30 0]
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): deactivating device (reason 'none') [0]
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
> Nov 11 14:15:14 vtc6200 NetworkManager[2827]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
> 
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Auto-activating connection 'Vodafone'.
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) starting connection 'Vodafone'
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: disconnected -> prepare (reason 'none') [30 40 0]
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> need-auth (reason 'none') [40 60 0]
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <info>  [1321017317.761428] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <info>  [1321017317.761769] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) scheduled...
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) started...
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: need-auth -> prepare (reason 'none') [60 40 0]
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Activation (ttyUSB3) Stage 1 of 5 (Device Prepare) complete.
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769139] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): number => "*99#"
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769272] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): pin => "XXXX"
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769332] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): username => "vodafone"
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769395] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): apn => "web.vodafone.de"
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769477] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): network_mode => 0
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769536] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): password => "vodafone"
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769603] [mm-generic-gsm.c:5099] simple_connect(): (ttyUSB3): allowed_mode => 0
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769701] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 0
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <debug> [1321017317.769949] [mm-generic-gsm.c:4988] simple_state_machine(): (ttyUSB3): simple connect state 2
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <warn> GSM connection failed: (32) Sending command failed: device is not enabled
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: prepare -> failed (reason 'unknown') [40 120 1]
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> Marking connection 'Vodafone' invalid.
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <info>  [1321017317.776515] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <warn> Activation (ttyUSB3) failed.
> Nov 11 14:15:17 vtc6200 modem-manager[2816]: <info>  [1321017317.777148] [mm-modem.c:742] mm_modem_set_state(): Modem 
> /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> connected)
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> disconnect failed: (32) The serial port is not open.
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): device state change: failed -> disconnected (reason 'none') [120 30 0]
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: <info> (ttyUSB3): deactivating device (reason 'none') [0]
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
> Nov 11 14:15:17 vtc6200 NetworkManager[2827]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
> 
> For completeness the lsusb -v:
> Bus 001 Device 002: ID 1199:683c Sierra Wireless, Inc. 
> Device Descriptor:
>   bLength                18
>   bDescriptorType         1
>   bcdUSB               2.00
>   bDeviceClass            0 (Defined at Interface level)
>   bDeviceSubClass         0 
>   bDeviceProtocol         0 
>   bMaxPacketSize0        64
>   idVendor           0x1199 Sierra Wireless, Inc.
>   idProduct          0x683c 
>   bcdDevice            0.06
>   iManufacturer           3 Sierra Wireless, Incorporated
>   iProduct                2 MC8790V
>   iSerial                 0 
>   bNumConfigurations      1
>   Configuration Descriptor:
>     bLength                 9
>     bDescriptorType         2
>     wTotalLength          198
>     bNumInterfaces          7
>     bConfigurationValue     1
>     iConfiguration          1 Sierra Configuration
>     bmAttributes         0xe0
>       Self Powered
>       Remote Wakeup
>     MaxPower                0mA
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        0
>       bAlternateSetting       0
>       bNumEndpoints           2
>       bInterfaceClass       255 Vendor Specific Class
>       bInterfaceSubClass    255 Vendor Specific Subclass
>       bInterfaceProtocol    255 Vendor Specific Protocol
>       iInterface              0 
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x81  EP 1 IN
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x01  EP 1 OUT
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        1
>       bAlternateSetting       0
>       bNumEndpoints           2
>       bInterfaceClass       255 Vendor Specific Class
>       bInterfaceSubClass    255 Vendor Specific Subclass
>       bInterfaceProtocol    255 Vendor Specific Protocol
>       iInterface              0 
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x82  EP 2 IN
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x02  EP 2 OUT
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        2
>       bAlternateSetting       0
>       bNumEndpoints           2
>       bInterfaceClass       255 Vendor Specific Class
>       bInterfaceSubClass    255 Vendor Specific Subclass
>       bInterfaceProtocol    255 Vendor Specific Protocol
>       iInterface              0 
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x83  EP 3 IN
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x03  EP 3 OUT
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        3
>       bAlternateSetting       0
>       bNumEndpoints           3
>       bInterfaceClass       255 Vendor Specific Class
>       bInterfaceSubClass    255 Vendor Specific Subclass
>       bInterfaceProtocol    255 Vendor Specific Protocol
>       iInterface              0 
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x84  EP 4 IN
>         bmAttributes            3
>           Transfer Type            Interrupt
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0040  1x 64 bytes
>         bInterval               5
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x85  EP 5 IN
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x04  EP 4 OUT
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        4
>       bAlternateSetting       0
>       bNumEndpoints           3
>       bInterfaceClass       255 Vendor Specific Class
>       bInterfaceSubClass    255 Vendor Specific Subclass
>       bInterfaceProtocol    255 Vendor Specific Protocol
>       iInterface              0 
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x86  EP 6 IN
>         bmAttributes            3
>           Transfer Type            Interrupt
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0040  1x 64 bytes
>         bInterval               5
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x87  EP 7 IN
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x05  EP 5 OUT
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        5
>       bAlternateSetting       0
>       bNumEndpoints           3
>       bInterfaceClass       255 Vendor Specific Class
>       bInterfaceSubClass    255 Vendor Specific Subclass
>       bInterfaceProtocol    255 Vendor Specific Protocol
>       iInterface              0 
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x88  EP 8 IN
>         bmAttributes            3
>           Transfer Type            Interrupt
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0040  1x 64 bytes
>         bInterval               5
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x89  EP 9 IN
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x06  EP 6 OUT
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        6
>       bAlternateSetting       0
>       bNumEndpoints           3
>       bInterfaceClass       255 Vendor Specific Class
>       bInterfaceSubClass    255 Vendor Specific Subclass
>       bInterfaceProtocol    255 Vendor Specific Protocol
>       iInterface              0 
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x8a  EP 10 IN
>         bmAttributes            3
>           Transfer Type            Interrupt
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0040  1x 64 bytes
>         bInterval               5
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x8b  EP 11 IN
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x07  EP 7 OUT
>         bmAttributes            2
>           Transfer Type            Bulk
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0200  1x 512 bytes
>         bInterval              32
> Device Qualifier (for other device speed):
>   bLength                10
>   bDescriptorType         6
>   bcdUSB               2.00
>   bDeviceClass            0 (Defined at Interface level)
>   bDeviceSubClass         0 
>   bDeviceProtocol         0 
>   bMaxPacketSize0        64
>   bNumConfigurations      1
> Device Status:     0x0001
>   Self Powered
> 
> Bus 006 Device 002: ID 045e:00dd Microsoft Corp. Comfort Curve Keyboard 2000 V1.0
> Device Descriptor:
>   bLength                18
>   bDescriptorType         1
>   bcdUSB               2.00
>   bDeviceClass            0 (Defined at Interface level)
>   bDeviceSubClass         0 
>   bDeviceProtocol         0 
>   bMaxPacketSize0         8
>   idVendor           0x045e Microsoft Corp.
>   idProduct          0x00dd Comfort Curve Keyboard 2000 V1.0
>   bcdDevice            1.73
>   iManufacturer           1 Microsoft
>   iProduct                2 Comfort Curve Keyboard 2000
>   iSerial                 0 
>   bNumConfigurations      1
>   Configuration Descriptor:
>     bLength                 9
>     bDescriptorType         2
>     wTotalLength           59
>     bNumInterfaces          2
>     bConfigurationValue     1
>     iConfiguration          0 
>     bmAttributes         0xa0
>       (Bus Powered)
>       Remote Wakeup
>     MaxPower              100mA
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        0
>       bAlternateSetting       0
>       bNumEndpoints           1
>       bInterfaceClass         3 Human Interface Device
>       bInterfaceSubClass      1 Boot Interface Subclass
>       bInterfaceProtocol      1 Keyboard
>       iInterface              0 
>         HID Device Descriptor:
>           bLength                 9
>           bDescriptorType        33
>           bcdHID               1.11
>           bCountryCode            0 Not supported
>           bNumDescriptors         1
>           bDescriptorType        34 Report
>           wDescriptorLength      60
>          Report Descriptors: 
>            ** UNAVAILABLE **
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x81  EP 1 IN
>         bmAttributes            3
>           Transfer Type            Interrupt
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0008  1x 8 bytes
>         bInterval              10
>     Interface Descriptor:
>       bLength                 9
>       bDescriptorType         4
>       bInterfaceNumber        1
>       bAlternateSetting       0
>       bNumEndpoints           1
>       bInterfaceClass         3 Human Interface Device
>       bInterfaceSubClass      0 No Subclass
>       bInterfaceProtocol      0 None
>       iInterface              0 
>         HID Device Descriptor:
>           bLength                 9
>           bDescriptorType        33
>           bcdHID               1.11
>           bCountryCode            0 Not supported
>           bNumDescriptors         1
>           bDescriptorType        34 Report
>           wDescriptorLength      86
>          Report Descriptors: 
>            ** UNAVAILABLE **
>       Endpoint Descriptor:
>         bLength                 7
>         bDescriptorType         5
>         bEndpointAddress     0x82  EP 2 IN
>         bmAttributes            3
>           Transfer Type            Interrupt
>           Synch Type               None
>           Usage Type               Data
>         wMaxPacketSize     0x0008  1x 8 bytes
>         bInterval              10
> Device Status:     0x0000
>   (Bus Powered)
> 
> ------------------------------------------------
> | Dipl.-Ing. Markus Becker
> | Communication Networks
> | TZI - Center for Computing Technologies
> | University Bremen
> | Germany
> ------------------------------------------------
> | web: http://www.comnets.uni-bremen.de/~mab/
> | mailto: mab comnets uni-bremen de
> | telephone: +49 421 218 62379
> | building: NW1 room: N2260
> ------------------------------------------------
> _______________________________________________
> networkmanager-list mailing list
> networkmanager-list gnome org
> http://mail.gnome.org/mailman/listinfo/networkmanager-list




[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]