組み込みのDebian 8で3Gモデムを自動的に接続

私はシステムが起動したときに3Gモデムに自動的に接続するように設計されたARM926ベースのカスタムハードウェアで動作するDebian 8システムを開発しています。私はRaspberry PiとRaspbianを参照設定として使用し、ほぼ即座に動作し、mmcli接続を確立するためにスクリプトだけが必要でした。両方のシステムのカーネルバージョンは4.1.18で、デフォルトはRaspbianで、カスタムシステムは私が修正しました。

テストに使用したモデムはHuawei E3131でしたが、ハードウェアサポートを一部の特定のモデムに制限する意図はありません。目的は、問題のある特定のモデルを除いて、カーネルとModemManagerがサポートするすべてのモデムをサポートすることです。

現在のシステムで起こっていることの唯一の明らかな違いは、インターフェースに関連していますwwan0。 Piシステムでは、モデムが接続されると（またはモデムがすでに接続されている場合はシステム起動後）、インターフェイスが自動的に表示され、しばらくするとIPが割り当てられます。しかし、カスタムシステムでは、ifconfigコマンドを実行すると、存在するように見えるインターフェイスが引数なしでコマンドするリストにインターフェイスが表示されませんifconfig wwan0。

インターフェイスが表示されなくてもmmcli接続設定を使用できますが、接続を使用する方法はないようです。ログと出力内容を比較すると、mmcli -m 0モデムがPiシステムに接続されているように見えます。ログの間に微妙な違いがありますが、私にとっては非常にマイナーな違いです。 Piシステムでも報告された問題があります。

編集：両方のシステムで異なるモデムTelewell TW-LTE / 4G / 3G +を試してみました。ドライバを追加し、カスタムシステムのカーネルにlibqmi-proxyをインストールする必要がありましたが、Huawei E3131でも同じことが起こりました。

ここに関連システムログ（Huawei E3131関連）を添付し、必要に応じて他の情報も提供できます。私は他に何が関係しているのかわかりません。

Pi syslogに存在するカスタムsyslogに欠けているものの1つは、dhcpcdとavahi-daemonの印刷です。このログが作成された時点ではインストールされませんでしたが、少なくともインストールするだけでは何も変更されませんでした。

カスタムシステムSylog：

Feb 10 13:10:52 kernel: usb 1-1.3: new full-speed USB device number 4 using at91_ohci
Feb 10 13:10:53 kernel: usb 1-1.3: New USB device found, idVendor=12d1, idProduct=1506
Feb 10 13:10:53 kernel: usb 1-1.3: New USB device strings: Mfr=3, Product=2, SerialNumber=0
Feb 10 13:10:53 kernel: usb 1-1.3: Product: HUAWEI Mobile
Feb 10 13:10:53 kernel: usb 1-1.3: Manufacturer: HUAWEI
Feb 10 13:10:53 kernel: usb-storage 1-1.3:1.4: USB Mass Storage device detected
Feb 10 13:10:53 kernel: scsi host2: usb-storage 1-1.3:1.4
Feb 10 13:10:53 kernel: usb-storage 1-1.3:1.5: USB Mass Storage device detected
Feb 10 13:10:53 kernel: scsi host3: usb-storage 1-1.3:1.5
Feb 10 13:10:54 kernel: scsi 2:0:0:0: CD-ROM            HUAWEI   Mass Storage     2.31 PQ: 0 ANSI: 2
Feb 10 13:10:54 kernel: scsi 2:0:0:0: Attached scsi generic sg0 type 5
Feb 10 13:10:54 kernel: scsi 3:0:0:0: Direct-Access     HUAWEI   SD Storage       2.31 PQ: 0 ANSI: 2
Feb 10 13:10:54 kernel: sd 3:0:0:0: Attached scsi generic sg1 type 0
Feb 10 13:10:54 kernel: usbcore: registered new interface driver option
Feb 10 13:10:54 kernel: usbserial: USB Serial support registered for GSM modem (1-port)
Feb 10 13:10:54 kernel: option 1-1.3:1.0: GSM modem (1-port) converter detected
Feb 10 13:10:54 kernel: sd 3:0:0:0: [sda] Attached SCSI removable disk
Feb 10 13:10:54 kernel: usbcore: registered new interface driver cdc_ncm
Feb 10 13:10:54 kernel: usb 1-1.3: GSM modem (1-port) converter now attached to ttyUSB0
Feb 10 13:10:54 kernel: option 1-1.3:1.2: GSM modem (1-port) converter detected
Feb 10 13:10:54 kernel: usbcore: registered new interface driver cdc_wdm
Feb 10 13:10:54 systemd[1]: Starting user-0.slice.
Feb 10 13:10:54 systemd[1]: Created slice user-0.slice.
Feb 10 13:10:54 kernel: usb 1-1.3: GSM modem (1-port) converter now attached to ttyUSB1
Feb 10 13:10:54 kernel: option 1-1.3:1.3: GSM modem (1-port) converter detected
Feb 10 13:10:54 kernel: usb 1-1.3: GSM modem (1-port) converter now attached to ttyUSB2
Feb 10 13:10:54 kernel: huawei_cdc_ncm 1-1.3:1.1: MAC-Address: 58:2c:80:13:92:63
Feb 10 13:10:54 kernel: huawei_cdc_ncm 1-1.3:1.1: setting rx_max = 16384
Feb 10 13:10:54 kernel: huawei_cdc_ncm 1-1.3:1.1: setting tx_max = 16384
Feb 10 13:10:54 kernel: huawei_cdc_ncm 1-1.3:1.1: cdc-wdm0: USB WDM device
Feb 10 13:10:54 kernel: huawei_cdc_ncm 1-1.3:1.1 wwan0: register 'huawei_cdc_ncm' at usb-at91-1.3, Huawei CDC NCM device, 58:2c:80:13:92:63
Feb 10 13:10:54 kernel: usbcore: registered new interface driver huawei_cdc_ncm
Feb 10 13:10:54 logger: usb_modeswitch: switched to 12d1:1506 on 001/004
Feb 10 13:10:55 NetworkManager[957]: <info> devices added (path: /sys/devices/soc0/ahb/500000.ohci/usb1/1-1/1-1.3/1-1.3:1.1/net/wwan0, iface: wwan0)
Feb 10 13:10:55 NetworkManager[957]: <info> device added (path: /sys/devices/soc0/ahb/500000.ohci/usb1/1-1/1-1.3/1-1.3:1.1/net/wwan0, iface: wwan0): no ifupdown configuration found.
Feb 10 13:10:55 systemd[1]: Starting Session c1 of user root.
Feb 10 13:10:55 systemd[1]: Started Session c1 of user root.
Feb 10 13:10:55 systemd[1]: Starting User Manager for UID 0...
Feb 10 13:10:55 ModemManager[954]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 13:10:56 systemd[1]: Started USB_ModeSwitch.
Feb 10 13:10:56 ModemManager[954]: <warn>  (ttyUSB1): port attributes not fully set
Feb 10 13:10:56 dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7
Feb 10 13:10:56 dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
Feb 10 13:10:56 dhclient: DHCPOFFER from 82.195.210.40
Feb 10 13:10:56 dhclient: DHCPACK from 82.195.210.40
Feb 10 13:10:56 systemd[1161]: Starting Paths.
Feb 10 13:10:56 systemd[1161]: Reached target Paths.
Feb 10 13:10:56 systemd[1161]: Starting Timers.
Feb 10 13:10:56 systemd[1161]: Reached target Timers.
Feb 10 13:10:56 systemd[1161]: Starting Sockets.
Feb 10 13:10:56 systemd[1161]: Reached target Sockets.
Feb 10 13:10:56 systemd[1161]: Starting Basic System.
Feb 10 13:10:56 systemd[1161]: Reached target Basic System.
Feb 10 13:10:57 systemd[1161]: Starting Default.
Feb 10 13:10:57 systemd[1161]: Reached target Default.
Feb 10 13:10:57 systemd[1161]: Startup finished in 665ms.
Feb 10 13:10:57 systemd[1]: Started User Manager for UID 0.
Feb 10 13:10:57 ModemManager[954]: <warn>  (ttyUSB0): port attributes not fully set
Feb 10 13:10:57 dhclient: bound to 82.195.211.143 -- renewal in 43954 seconds.
Feb 10 13:10:59 ModemManager[954]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 13:10:59 ModemManager[954]: <warn>  (ttyUSB1): port attributes not fully set
Feb 10 13:11:15 ModemManager[954]: <info>  Creating modem with plugin 'Huawei' and '5' ports
Feb 10 13:11:15 ModemManager[954]: <warn>  Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type'
Feb 10 13:11:15 ModemManager[954]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 13:11:15 ModemManager[954]: <info>  Modem for device at '/sys/devices/soc0/ahb/500000.ohci/usb1/1-1/1-1.3' successfully created
Feb 10 13:11:16 ModemManager[954]: Error while checking ^SYSCFGEX format: Unknown error
Feb 10 13:11:22 ModemManager[954]: Invalid mobile equipment error code: 50
Feb 10 13:11:22 ModemManager[954]: <info>  Modem: state changed (unknown -> disabled)
Feb 10 13:11:22 NetworkManager[957]: <warn> (ttyUSB2): failed to look up interface index
Feb 10 13:11:22 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
Feb 10 13:11:22 NetworkManager[957]: <info> (ttyUSB2): modem state changed, 'disabled' --> 'enabling' (reason: user preference)
Feb 10 13:11:22 NetworkManager[957]: <info> (ttyUSB2): new Broadband device (driver: 'huawei_cdc_ncm, option1' ifindex: 0)
Feb 10 13:11:22 NetworkManager[957]: <info> (ttyUSB2): exported as /org/freedesktop/NetworkManager/Devices/3
Feb 10 13:11:22 NetworkManager[957]: <info> (ttyUSB2): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Feb 10 13:11:22 ModemManager[954]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 13:11:22 NetworkManager[957]: <info> (ttyUSB2): preparing device
Feb 10 13:11:22 NetworkManager[957]: <info> (ttyUSB2): modem state 'enabling'
Feb 10 13:11:22 NetworkManager[957]: <info> (ttyUSB2): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
Feb 10 13:11:23 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
Feb 10 13:11:24 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
Feb 10 13:11:24 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '28', Cell ID: '689378')
Feb 10 13:11:24 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '244', MNC: '12', Location area code: '28', Cell ID: '689378')
Feb 10 13:11:26 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
Feb 10 13:11:26 NetworkManager[957]: <info> (ttyUSB2): modem state changed, 'enabling' --> 'registered' (reason: user-requested)
Feb 10 13:11:53 ModemManager[954]: <info>  Simple connect started...
Feb 10 13:11:53 ModemManager[954]: <info>  Simple connect state (4/8): Wait to get fully enabled
Feb 10 13:11:53 ModemManager[954]: <info>  Simple connect state (5/8): Register
Feb 10 13:11:53 ModemManager[954]: <info>  Simple connect state (6/8): Bearer
Feb 10 13:11:53 ModemManager[954]: <info>  Simple connect state (7/8): Connect
Feb 10 13:11:53 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
Feb 10 13:11:53 NetworkManager[957]: <info> (ttyUSB2): modem state changed, 'registered' --> 'connecting' (reason: user-requested)
Feb 10 13:11:56 ModemManager[954]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
Feb 10 13:11:56 ModemManager[954]: <info>  Simple connect state (8/8): All done
Feb 10 13:11:56 NetworkManager[957]: <info> (ttyUSB2): modem state changed, 'connecting' --> 'connected' (reason: user-requested)
Feb 10 13:14:20 dhclient: Internet Systems Consortium DHCP Client 4.3.1
Feb 10 13:14:20 dhclient: Copyright 2004-2014 Internet Systems Consortium.
Feb 10 13:14:20 dhclient: All rights reserved.
Feb 10 13:14:20 dhclient: For info, please visit https://www.isc.org/software/dhcp/
Feb 10 13:14:20 dhclient: 
Feb 10 13:14:20 dhclient: Listening on LPF/wwan0/58:2c:80:13:92:63
Feb 10 13:14:20 dhclient: Sending on   LPF/wwan0/58:2c:80:13:92:63
Feb 10 13:14:20 dhclient: Sending on   Socket/fallback
Feb 10 13:14:20 dhclient: DHCPREQUEST on wwan0 to 255.255.255.255 port 67
Feb 10 13:14:20 dhclient: DHCPNAK from 37.33.16.241
Feb 10 13:14:20 dhclient: DHCPDISCOVER on wwan0 to 255.255.255.255 port 67 interval 4
Feb 10 13:14:20 dhclient: DHCPREQUEST on wwan0 to 255.255.255.255 port 67
Feb 10 13:14:20 dhclient: DHCPOFFER from 37.33.16.241
Feb 10 13:14:20 dhclient: DHCPACK from 37.33.16.241
Feb 10 13:14:20 dhclient: bound to 37.33.16.243 -- renewal in 232568 seconds.
Feb 10 13:14:22 ntpd[985]: Listen normally on 6 wwan0 37.33.16.243 UDP 123
Feb 10 13:14:22 ntpd[985]: Listen normally on 7 wwan0 fe80::5a2c:80ff:fe13:9263 UDP 123
Feb 10 13:14:22 ntpd[985]: peers refreshed

PiシステムのSyslog：

Feb 10 12:45:20 raspberrypi kernel: [   70.179443] usb 1-1.5.4: new high-speed USB device number 9 using dwc_otg
Feb 10 12:45:20 raspberrypi kernel: [   70.280330] usb 1-1.5.4: New USB device found, idVendor=12d1, idProduct=1506
Feb 10 12:45:20 raspberrypi kernel: [   70.280349] usb 1-1.5.4: New USB device strings: Mfr=3, Product=2, SerialNumber=0
Feb 10 12:45:20 raspberrypi kernel: [   70.280362] usb 1-1.5.4: Product: HUAWEI Mobile
Feb 10 12:45:20 raspberrypi kernel: [   70.280375] usb 1-1.5.4: Manufacturer: HUAWEI
Feb 10 12:45:20 raspberrypi kernel: [   70.284114] usb-storage 1-1.5.4:1.4: USB Mass Storage device detected
Feb 10 12:45:20 raspberrypi kernel: [   70.285173] scsi host2: usb-storage 1-1.5.4:1.4
Feb 10 12:45:20 raspberrypi kernel: [   70.286131] usb-storage 1-1.5.4:1.5: USB Mass Storage device detected
Feb 10 12:45:20 raspberrypi kernel: [   70.286494] scsi host3: usb-storage 1-1.5.4:1.5
Feb 10 12:45:20 raspberrypi systemd-udevd[871]: failed to execute '/lib/udev/mtp-probe' 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.5/1-1.5.4 1 9': No such file or directory
Feb 10 12:45:20 raspberrypi kernel: [   70.320269] usbcore: registered new interface driver cdc_ncm
Feb 10 12:45:20 raspberrypi kernel: [   70.324621] usbcore: registered new interface driver cdc_wdm
Feb 10 12:45:20 raspberrypi kernel: [   70.331163] usbcore: registered new interface driver usbserial
Feb 10 12:45:20 raspberrypi kernel: [   70.331276] usbcore: registered new interface driver usbserial_generic
Feb 10 12:45:20 raspberrypi kernel: [   70.331375] usbserial: USB Serial support registered for generic
Feb 10 12:45:20 raspberrypi kernel: [   70.332798] huawei_cdc_ncm 1-1.5.4:1.1: MAC-Address: 58:2c:80:13:92:63
Feb 10 12:45:20 raspberrypi kernel: [   70.332858] huawei_cdc_ncm 1-1.5.4:1.1: setting rx_max = 16384
Feb 10 12:45:20 raspberrypi kernel: [   70.333498] huawei_cdc_ncm 1-1.5.4:1.1: setting tx_max = 16384
Feb 10 12:45:20 raspberrypi kernel: [   70.334914] huawei_cdc_ncm 1-1.5.4:1.1: cdc-wdm0: USB WDM device
Feb 10 12:45:20 raspberrypi kernel: [   70.336971] huawei_cdc_ncm 1-1.5.4:1.1 wwan0: register 'huawei_cdc_ncm' at usb-3f980000.usb-1.5.4, Huawei CDC NCM device, 58:2c:80:13:92:63
Feb 10 12:45:20 raspberrypi kernel: [   70.337760] usbcore: registered new interface driver huawei_cdc_ncm
Feb 10 12:45:20 raspberrypi kernel: [   70.348717] usbcore: registered new interface driver option
Feb 10 12:45:20 raspberrypi kernel: [   70.348838] usbserial: USB Serial support registered for GSM modem (1-port)
Feb 10 12:45:20 raspberrypi kernel: [   70.350449] option 1-1.5.4:1.0: GSM modem (1-port) converter detected
Feb 10 12:45:20 raspberrypi kernel: [   70.351000] usb 1-1.5.4: GSM modem (1-port) converter now attached to ttyUSB0
Feb 10 12:45:20 raspberrypi kernel: [   70.351174] option 1-1.5.4:1.2: GSM modem (1-port) converter detected
Feb 10 12:45:20 raspberrypi kernel: [   70.351477] usb 1-1.5.4: GSM modem (1-port) converter now attached to ttyUSB1
Feb 10 12:45:20 raspberrypi kernel: [   70.351550] option 1-1.5.4:1.3: GSM modem (1-port) converter detected
Feb 10 12:45:20 raspberrypi kernel: [   70.351695] usb 1-1.5.4: GSM modem (1-port) converter now attached to ttyUSB2
Feb 10 12:45:20 raspberrypi logger: usb_modeswitch: switched to 12d1:1506 on 001/009
Feb 10 12:45:20 raspberrypi NetworkManager[385]: <info> devices added (path: /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.5/1-1.5.4/1-1.5.4:1.1/net/wwan0, iface: wwan0)
Feb 10 12:45:20 raspberrypi NetworkManager[385]: <info> device added (path: /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.5/1-1.5.4/1-1.5.4:1.1/net/wwan0, iface: wwan0): no ifupdown configuration found.
Feb 10 12:45:20 raspberrypi dhcpcd[396]: wwan0: adding address fe80::3d2:b0ae:25df:f0c5
Feb 10 12:45:20 raspberrypi ModemManager[386]: <warn>  (ttyUSB1): port attributes not fully set
Feb 10 12:45:20 raspberrypi ModemManager[386]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 12:45:20 raspberrypi dhcpcd[396]: wwan0: waiting for carrier
Feb 10 12:45:20 raspberrypi dhcpcd[396]: wwan0: carrier acquired
Feb 10 12:45:20 raspberrypi dhcpcd[396]: wwan0: IAID 80:13:92:63
Feb 10 12:45:20 raspberrypi dhcpcd[396]: wwan0: rebinding lease of 37.136.135.101
Feb 10 12:45:21 raspberrypi kernel: [   71.280158] scsi 2:0:0:0: CD-ROM            HUAWEI   Mass Storage     2.31 PQ: 0 ANSI: 2
Feb 10 12:45:21 raspberrypi kernel: [   71.284820] scsi 3:0:0:0: Direct-Access     HUAWEI   SD Storage       2.31 PQ: 0 ANSI: 2
Feb 10 12:45:21 raspberrypi kernel: [   71.287199] sd 3:0:0:0: [sda] Attached SCSI removable disk
Feb 10 12:45:21 raspberrypi kernel: [   71.294817] scsi 2:0:0:0: Attached scsi generic sg0 type 5
Feb 10 12:45:21 raspberrypi kernel: [   71.296390] sd 3:0:0:0: Attached scsi generic sg1 type 0
Feb 10 12:45:21 raspberrypi kernel: [   71.296999] sr 2:0:0:0: [sr0] scsi-1 drive
Feb 10 12:45:21 raspberrypi kernel: [   71.297014] cdrom: Uniform CD-ROM driver Revision: 3.20
Feb 10 12:45:21 raspberrypi kernel: [   71.301150] sr 2:0:0:0: Attached scsi CD-ROM sr0
Feb 10 12:45:21 raspberrypi systemd[1]: Started USB_ModeSwitch.
Feb 10 12:45:21 raspberrypi ModemManager[386]: <warn>  (ttyUSB0): port attributes not fully set
Feb 10 12:45:21 raspberrypi dhcpcd[396]: wwan0: soliciting an IPv6 router
Feb 10 12:45:21 raspberrypi kernel: [   71.598335] ISO 9660 Extensions: Microsoft Joliet Level 1
Feb 10 12:45:21 raspberrypi kernel: [   71.604495] ISOFS: changing to secondary root
Feb 10 12:45:21 raspberrypi org.gtk.Private.UDisks2VolumeMonitor[683]: index_parse.c:191: indx_parse(): error opening /media/pi/Cyfrowy Polsat/BDMV/index.bdmv
Feb 10 12:45:21 raspberrypi org.gtk.Private.UDisks2VolumeMonitor[683]: index_parse.c:191: indx_parse(): error opening /media/pi/Cyfrowy Polsat/BDMV/BACKUP/index.bdmv
Feb 10 12:45:21 raspberrypi avahi-daemon[391]: Joining mDNS multicast group on interface wwan0.IPv6 with address fe80::3d2:b0ae:25df:f0c5.
Feb 10 12:45:21 raspberrypi avahi-daemon[391]: New relevant interface wwan0.IPv6 for mDNS.
Feb 10 12:45:21 raspberrypi avahi-daemon[391]: Registering new address record for fe80::3d2:b0ae:25df:f0c5 on wwan0.*.
Feb 10 12:45:21 raspberrypi udisksd[769]: Mounted /dev/sr0 at /media/pi/Cyfrowy Polsat on behalf of uid 1000
Feb 10 12:45:23 raspberrypi ntpd[535]: Listen normally on 4 wwan0 fe80::3d2:b0ae:25df:f0c5 UDP 123
Feb 10 12:45:23 raspberrypi ntpd[535]: peers refreshed
Feb 10 12:45:23 raspberrypi ntpd_intres[537]: host name not found: 0.debian.pool.ntp.org
Feb 10 12:45:23 raspberrypi ntpd_intres[537]: host name not found: 1.debian.pool.ntp.org
Feb 10 12:45:23 raspberrypi ntpd_intres[537]: host name not found: 2.debian.pool.ntp.org
Feb 10 12:45:23 raspberrypi ntpd_intres[537]: host name not found: 3.debian.pool.ntp.org
Feb 10 12:45:23 raspberrypi ModemManager[386]: <warn>  (ttyUSB1): port attributes not fully set
Feb 10 12:45:23 raspberrypi ModemManager[386]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 12:45:25 raspberrypi dhcpcd[396]: wwan0: probing for an IPv4LL address
Feb 10 12:45:25 raspberrypi dhcpcd[396]: wwan0: DHCP lease expired
Feb 10 12:45:25 raspberrypi dhcpcd[396]: wwan0: soliciting a DHCP lease
Feb 10 12:45:25 raspberrypi ntpd_intres[537]: host name not found: 0.debian.pool.ntp.org
Feb 10 12:45:25 raspberrypi ntpd_intres[537]: host name not found: 1.debian.pool.ntp.org
Feb 10 12:45:25 raspberrypi ntpd_intres[537]: host name not found: 2.debian.pool.ntp.org
Feb 10 12:45:25 raspberrypi ntpd_intres[537]: host name not found: 3.debian.pool.ntp.org
Feb 10 12:45:29 raspberrypi dhcpcd[396]: wwan0: using IPv4LL address 169.254.169.80
Feb 10 12:45:29 raspberrypi avahi-daemon[391]: Joining mDNS multicast group on interface wwan0.IPv4 with address 169.254.169.80.
Feb 10 12:45:29 raspberrypi dhcpcd[396]: wwan0: adding route to 169.254.0.0/16
Feb 10 12:45:29 raspberrypi avahi-daemon[391]: New relevant interface wwan0.IPv4 for mDNS.
Feb 10 12:45:29 raspberrypi avahi-daemon[391]: Registering new address record for 169.254.169.80 on wwan0.IPv4.
Feb 10 12:45:31 raspberrypi ntpd[535]: Listen normally on 5 wwan0 169.254.169.80 UDP 123
Feb 10 12:45:31 raspberrypi ntpd[535]: peers refreshed
Feb 10 12:45:33 raspberrypi ntpd_intres[537]: host name not found: 0.debian.pool.ntp.org
Feb 10 12:45:33 raspberrypi ntpd_intres[537]: host name not found: 1.debian.pool.ntp.org
Feb 10 12:45:33 raspberrypi ntpd_intres[537]: host name not found: 2.debian.pool.ntp.org
Feb 10 12:45:33 raspberrypi ntpd_intres[537]: host name not found: 3.debian.pool.ntp.org
Feb 10 12:45:33 raspberrypi dhcpcd[396]: wwan0: no IPv6 Routers available
Feb 10 12:45:39 raspberrypi ModemManager[386]: <info>  Creating modem with plugin 'Huawei' and '5' ports
Feb 10 12:45:39 raspberrypi ModemManager[386]: <warn>  Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type'
Feb 10 12:45:39 raspberrypi ModemManager[386]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 12:45:39 raspberrypi ModemManager[386]: <info>  Modem for device at '/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.5/1-1.5.4' successfully created
Feb 10 12:45:40 raspberrypi ModemManager[386]: Error while checking ^SYSCFGEX format: Unknown error
Feb 10 12:45:43 raspberrypi ModemManager[386]: Invalid mobile equipment error code: 50
Feb 10 12:45:43 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Feb 10 12:46:13 2017 [try http://www.rsyslog.com/e/2007 ]
Feb 10 12:45:43 raspberrypi ModemManager[386]: <info>  Modem: state changed (unknown -> disabled)
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <warn> (ttyUSB2): failed to look up interface index
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): modem state changed, 'disabled' --> 'enabling' (reason: user preference)
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): new Broadband device (driver: 'huawei_cdc_ncm, option1' ifindex: 0)
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): exported as /org/freedesktop/NetworkManager/Devices/3
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Feb 10 12:45:43 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
Feb 10 12:45:43 raspberrypi ModemManager[386]: <warn>  (ttyUSB2): port attributes not fully set
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): preparing device
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): modem state 'enabling'
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
Feb 10 12:45:43 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
Feb 10 12:45:43 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
Feb 10 12:45:43 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '28', Cell ID: '689378')
Feb 10 12:45:43 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '244', MNC: '12', Location area code: '28', Cell ID: '689378')
Feb 10 12:45:43 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
Feb 10 12:45:43 raspberrypi NetworkManager[385]: <info> (ttyUSB2): modem state changed, 'enabling' --> 'registered' (reason: user-requested)
Feb 10 12:46:00 raspberrypi wpa_supplicant[548]: wlan0: Failed to initiate sched scan
Feb 10 12:46:19 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Feb 10 12:46:49 2017 [try http://www.rsyslog.com/e/2007 ]
Feb 10 12:46:22 raspberrypi ModemManager[386]: <info>  Simple connect started...
Feb 10 12:46:22 raspberrypi ModemManager[386]: <info>  Simple connect state (4/8): Wait to get fully enabled
Feb 10 12:46:22 raspberrypi ModemManager[386]: <info>  Simple connect state (5/8): Register
Feb 10 12:46:22 raspberrypi ModemManager[386]: <info>  Simple connect state (6/8): Bearer
Feb 10 12:46:22 raspberrypi ModemManager[386]: <info>  Simple connect state (7/8): Connect
Feb 10 12:46:22 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
Feb 10 12:46:22 raspberrypi NetworkManager[385]: <info> (ttyUSB2): modem state changed, 'registered' --> 'connecting' (reason: user-requested)
Feb 10 12:46:27 raspberrypi ModemManager[386]: <info>  Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
Feb 10 12:46:27 raspberrypi ModemManager[386]: <info>  Simple connect state (8/8): All done
Feb 10 12:46:27 raspberrypi NetworkManager[385]: <info> (ttyUSB2): modem state changed, 'connecting' --> 'connected' (reason: user-requested)
Feb 10 12:46:53 raspberrypi wpa_supplicant[548]: wlan0: Failed to initiate sched scan
Feb 10 12:46:53 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Feb 10 12:47:23 2017 [try http://www.rsyslog.com/e/2007 ]
Feb 10 12:47:30 raspberrypi dhcpcd[396]: wwan0: offered 178.55.198.223 from 178.55.198.193
Feb 10 12:47:30 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Feb 10 12:48:00 2017 [try http://www.rsyslog.com/e/2007 ]
Feb 10 12:47:35 raspberrypi dhcpcd[396]: wwan0: leased 178.55.198.223 for 518400 seconds
Feb 10 12:47:35 raspberrypi dhcpcd[396]: wwan0: adding route to 178.55.198.192/26
Feb 10 12:47:35 raspberrypi dhcpcd[396]: wwan0: adding default route via 178.55.198.193
Feb 10 12:47:35 raspberrypi dhcpcd[396]: wwan0: deleting route to 169.254.0.0/16
Feb 10 12:47:35 raspberrypi avahi-daemon[391]: Registering new address record for 178.55.198.223 on wwan0.IPv4.
Feb 10 12:47:35 raspberrypi avahi-daemon[391]: Withdrawing address record for 169.254.169.80 on wwan0.
Feb 10 12:47:35 raspberrypi avahi-daemon[391]: Leaving mDNS multicast group on interface wwan0.IPv4 with address 169.254.169.80.
Feb 10 12:47:35 raspberrypi avahi-daemon[391]: Joining mDNS multicast group on interface wwan0.IPv4 with address 178.55.198.223.