Dear All,
I have a strange issue with modemmanager/networkmanager in debian testing.
Everything seems working (modem, nm-applet, broadband, vpn, route etc.), but 100% packet loss and no vpn connection. The pppd is suspicious for me. I expected that, after this kind of situation modem hangs up and pppd exits.
My primary goal: keep the mobile network up in any case, keep it online all the time, reconnect after any problems, automatically. I use nm-applet and a script, which runs every 60 seconds and check it is necessary to force restart connection (enable mobile broadband, force start vpn is necessary).
Any hints?
Details:
USB modem: 19d2:0117 ZTE WCDMA Technologies MSM
Symptoms:
Mobile network settings:
[connection]
id=Telenor mobilinternet
uuid=2c99285c-a11e-4af8-9b74-fa9483b34d25
type=gsm
timestamp=1339966631
[gsm]
number=*99#
apn=net
network-type=1
[ipv4]
method=auto
[serial]
baud=115200
(I turned off echo packets, probably this cause that pppd will not hang up in this situation).
Kernel IP routing table
Destination Gateway Genmask Flags Metric Ref Use Iface 0.0.0.0 10.64.64.64 0.0.0.0 UG 0 0 0 ppp0 10.8.0.0 10.8.0.217 255.255.255.0 UG 0 0 0 tun0 10.8.0.217 0.0.0.0 255.255.255.255 UH 0 0 0 tun0 10.64.64.64 0.0.0.0 255.255.255.255 UH 0 0 0 ppp0 89.132.252.194 10.64.64.64 255.255.255.255 UGH 0 0 0 ppp0 192.0.0.0 0.0.0.0 255.0.0.0 U 0 0 0 eth0 192.168.0.0 0.0.0.0 255.255.255.0 U 0 0 0 eth0 192.168.1.0 0.0.0.0 255.255.255.0 U 0 0 0 eth0 192.168.2.0 10.8.0.217 255.255.255.0 UG 0 0 0 tun0 192.168.127.0 0.0.0.0 255.255.255.0 U 0 0 0 eth0
Other things:
# nmcli dev
DEVICE TYPE STATUS
ttyUSB2 gsm connected
eth0 802-3-ethernet unmanaged
nmcli con status
NAME UUID DEVICES DEFAULT VPN MASTER-PATH gfs.vpn fd6ac13d-ed20-49a7-976c-8ed69934042f ttyUSB2 no yes /org/freedesktop/NetworkManager/Devices/4 Telenor mobilinternet 2c99285c-a11e-4af8-9b74-fa9483b34d25 ttyUSB2 yes no not set
nmcli nm status
RUNNING STATE WIFI-HARDWARE WIFI WWAN-HARDWARE WWAN running connected enabled enabled enabled enabled
ping -c 1 8.8.8.8
ING 8.8.8.8 (8.8.8.8) 56(84) bytes of data. --- 8.8.8.8 ping statistics --- 1 packets transmitted, 0 received, 100% packet loss, time 0ms
After killall modem-manager and network-manager restart
No mobile network device, check the following:
nmcli con status
NAME UUID DEVICES DEFAULT VPN MASTER-PATH
nmcli dev status
DEVICE TYPE STATE
eth0 802-3-ethernet unmanaged
nmcli nm status
RUNNING STATE WIFI-HARDWARE WIFI WWAN-HARDWARE WWAN
running disconnected enabled enabled enabled disabled
dmesg: nothing
ls /dev/ttyUSB* -al
crw-rw---T 1 root dialout 188, 0 jún 21 11:16 /dev/ttyUSB0
crw-rw---T 1 root dialout 188, 1 jún 21 11:15 /dev/ttyUSB1
crw-rw---T 1 root dialout 188, 2 jún 21 11:16 /dev/ttyUSB2
syslog
Jun 21 11:15:51 antiX12base modem-manager[1587]: <info> (ttyUSB1) closing serial port...
Jun 21 11:15:51 antiX12base modem-manager[1587]: <info> (ttyUSB1) serial port closed
Jun 21 11:15:51 antiX12base modem-manager[1587]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed
(registered -> disabling)
Jun 21 11:15:51 antiX12base modem-manager[1587]: <info> (ttyUSB2) closing serial port...
Jun 21 11:15:51 antiX12base modem-manager[1587]: <info> (ttyUSB2) serial port closed
Jun 21 11:15:51 antiX12base modem-manager[1587]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed
(disabling -> disabled)
Jun 21 11:15:51 antiX12base NetworkManager[30907]: <info> (ttyUSB2): device state change: activated -> disconnected (
reason 'none') [100 30 0]
Jun 21 11:15:51 antiX12base NetworkManager[30907]: <info> (ttyUSB2): deactivating device (reason 'none') [0]
Jun 21 11:15:51 antiX12base pppd[3888]: Terminating on signal 15
Jun 21 11:15:51 antiX12base pppd[3888]: Connect time 1070.3 minutes.
Jun 21 11:15:51 antiX12base pppd[3888]: Sent 1197635 bytes, received 1020544 bytes.
Jun 21 11:15:51 antiX12base NetworkManager[30907]: nm_system_iface_flush_routes: assertion `ifindex > 0' failed
Jun 21 11:15:51 antiX12base NetworkManager[30907]: nm_system_iface_flush_addresses: assertion `ifindex > 0' failed
Jun 21 11:15:51 antiX12base pppd[3888]: Connection terminated.
Jun 21 11:15:51 antiX12base NetworkManager[30907]: <info> (ttyUSB2): writing resolv.conf to /sbin/resolvconf
Jun 21 11:15:52 antiX12base pppd[3888]: Exit.
Jun 21 11:15:52 antiX12base dbus[1682]: [system] Activating service name='org.freedesktop.ModemManager' (using servic
ehelper)
Jun 21 11:15:52 antiX12base nm-openvpn[3989]: SIGTERM[hard,] received, process exiting
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <warn> (51) failed to find interface name for index
Jun 21 11:15:52 antiX12base NetworkManager[30907]: nm_system_iface_flush_routes: assertion `iface != NULL' failed
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <warn> (51) failed to find interface name for index
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> (tun0): removing resolv.conf from /sbin/resolvconf
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> ModemManager (version 0.5.2.0) starting...
Jun 21 11:15:52 antiX12base dbus[1682]: [system] Successfully activated service 'org.freedesktop.ModemManager'
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin ZTE
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Gobi
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin X22X
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Novatel
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Sierra
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Option
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Huawei
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin MotoC
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin AnyData
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Linktop
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Option High-Speed
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Generic
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Nokia
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Ericsson MBM
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Longcheer
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Samsung
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin Wavecom
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> Loaded plugin SimTech
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> (ttyUSB0) opening serial port...
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> (ttyUSB1) opening serial port...
Jun 21 11:15:52 antiX12base modem-manager[5504]: <info> (ttyUSB2) opening serial port...
Jun 21 11:15:52 antiX12base dbus[1682]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> WWAN now disabled by management service
Jun 21 11:15:52 antiX12base NetworkManager[30907]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Jun 21 11:15:52 antiX12base NetworkManager[30907]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/tun0, iface: tun0)
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> (ttyUSB2): now unmanaged
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> (ttyUSB2): device state change: disconnected -> unmanaged (reason 'removed') [30 10 36]
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> (ttyUSB2): cleaning up...
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> (ttyUSB2): taking down device.
Jun 21 11:15:52 antiX12base dbus[1682]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> the modem manager disappeared
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> trying to start the modem manager...
Jun 21 11:15:52 antiX12base NetworkManager[30907]: <info> modem-manager is now available
Jun 21 11:15:54 antiX12base modem-manager[5504]: <info> (ttyUSB1) closing serial port...
Jun 21 11:15:54 antiX12base modem-manager[5504]: <info> (ttyUSB1) serial port closed
Jun 21 11:15:54 antiX12base modem-manager[5504]: <info> (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:0b.1/usb2/2-1 claimed port ttyUSB1
Jun 21 11:15:58 antiX12base NetworkManager[30907]: <info> VPN service 'openvpn' disappearedJun 21 11:16:25 antiX12base modem-manager[5504]: <info> (ttyUSB0) closing serial port...
Jun 21 11:16:25 antiX12base modem-manager[5504]: <info> (ttyUSB0) serial port closed
Jun 21 11:16:25 antiX12base modem-manager[5504]: <info> (ttyUSB0) opening serial port...
Jun 21 11:16:25 antiX12base modem-manager[5504]: <info> (ttyUSB2) closing serial port...
Jun 21 11:16:25 antiX12base modem-manager[5504]: <info> (ttyUSB2) serial port closed
Jun 21 11:16:25 antiX12base modem-manager[5504]: <info> (ttyUSB2) opening serial port...
Jun 21 11:16:28 antiX12base modem-manager[5504]: <info> (ttyUSB0) closing serial port...
Jun 21 11:16:28 antiX12base modem-manager[5504]: <info> (ttyUSB0) serial port closed
Jun 21 11:16:28 antiX12base modem-manager[5504]: <info> (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:0b.1/usb2/2-1 claimed port ttyUSB0
Jun 21 11:16:31 antiX12base modem-manager[5504]: <info> (ttyUSB2) closing serial port...
Jun 21 11:16:31 antiX12base modem-manager[5504]: <info> (ttyUSB2) serial port closed
Jun 21 11:17:01 antiX12base /USR/SBIN/CRON[5653]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)