Feb 14 19:13:36 armadillo ModemManager[2206]: logging: level 'DEBUG' Feb 14 19:13:38 armadillo ModemManager[2206]: loading signal quality... Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (open) Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+CIND?' Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyCommModem): <-- '+CIND: 0,4,1,0,0,0,1,0OK' Feb 14 19:13:38 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (80) Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyUSB0) device open count is 2 (open) Feb 14 19:13:38 armadillo ModemManager[2206]: loading access technologies via QCDM... Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyCommModem) device open count is 1 (close) Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyUSB0): --> 4b 08 01 00 66 f5 7e Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyUSB0): <-- 4b 08 01 00 08 8a 56 30 06 94 62 59 13 00 00 00 00 00 00 00 00 00 09 de ad 00 00 00 00 00 00 00 78 ee 7e Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyUSB0): <-- 4b 04 0f 00 08 8a 56 30 06 94 62 59 13 08 49 04 15 03 51 95 73 99 09 c4 b6 7e Feb 14 19:13:38 armadillo ModemManager[2206]: QCDM operating mode: 0 Feb 14 19:13:38 armadillo ModemManager[2206]: QCDM system mode: 0 Feb 14 19:13:38 armadillo ModemManager[2206]: QCDM hybrid pref: 0 Feb 14 19:13:38 armadillo ModemManager[2206]: QCDM WCDMA open: 0 Feb 14 19:13:38 armadillo ModemManager[2206]: QCDM EVDO open: 0 Feb 14 19:13:38 armadillo ModemManager[2206]: Periodic signal quality checks scheduled in 30s Feb 14 19:13:38 armadillo ModemManager[2206]: (ttyUSB0) device open count is 1 (close) Feb 14 19:13:40 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:13:40 armadillo update-ca-certificates[5585]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:13:41 armadillo update-ca-certificates[5585]: done. Feb 14 19:13:41 armadillo update-ca-certificates[5585]: Updating certificates in /etc/ssl/certs... Feb 14 19:13:47 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:13:47 armadillo update-ca-certificates[5828]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:13:47 armadillo update-ca-certificates[5828]: done. Feb 14 19:13:47 armadillo update-ca-certificates[5828]: Updating certificates in /etc/ssl/certs... Feb 14 19:13:53 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:13:54 armadillo update-ca-certificates[6077]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:13:54 armadillo update-ca-certificates[6077]: done. Feb 14 19:13:54 armadillo update-ca-certificates[6077]: Updating certificates in /etc/ssl/certs... Feb 14 19:13:58 armadillo NetworkManager[1941]: [1550139238.1929] keyfile: add connection /etc/NetworkManager/system-connections/gsm-ttyCommModem-1e32ed54-6b27-4b04-8d3f-1ee4241f0754.nmconnection (1e32ed54-6b27-4b04-8d3f-1ee4241f0754,"gsm-ttyCommModem") Feb 14 19:13:58 armadillo NetworkManager[1941]: [1550139238.2169] audit: failed to open auditd socket: Protocol not supported Feb 14 19:13:58 armadillo NetworkManager[1941]: [1550139238.2181] audit: op="connection-add" uuid="1e32ed54-6b27-4b04-8d3f-1ee4241f0754" name="gsm-ttyCommModem" pid=6297 uid=0 result="success" Feb 14 19:14:00 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:14:00 armadillo update-ca-certificates[6327]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:14:00 armadillo update-ca-certificates[6327]: done. Feb 14 19:14:00 armadillo update-ca-certificates[6327]: Updating certificates in /etc/ssl/certs... Feb 14 19:14:06 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:14:07 armadillo update-ca-certificates[6573]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:14:07 armadillo update-ca-certificates[6573]: done. Feb 14 19:14:07 armadillo update-ca-certificates[6573]: Updating certificates in /etc/ssl/certs... Feb 14 19:14:08 armadillo ModemManager[2206]: loading signal quality... Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (open) Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+CIND?' Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyCommModem): <-- '+CIND: 0,4,1,0,0,0,1,0OK' Feb 14 19:14:08 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (80) Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyUSB0) device open count is 2 (open) Feb 14 19:14:08 armadillo ModemManager[2206]: loading access technologies via QCDM... Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyCommModem) device open count is 1 (close) Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyUSB0): --> 4b 08 01 00 66 f5 7e Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyUSB0): <-- 4b 08 01 00 08 8a 56 30 06 94 62 59 13 00 00 00 00 00 00 00 00 00 09 de ad 00 00 00 00 00 00 00 78 ee 7e Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyUSB0): <-- 4b 04 0f 00 08 8a 56 30 06 94 62 59 13 08 49 04 15 03 51 95 73 99 09 c4 b6 7e Feb 14 19:14:08 armadillo ModemManager[2206]: QCDM operating mode: 0 Feb 14 19:14:08 armadillo ModemManager[2206]: QCDM system mode: 0 Feb 14 19:14:08 armadillo ModemManager[2206]: QCDM hybrid pref: 0 Feb 14 19:14:08 armadillo ModemManager[2206]: QCDM WCDMA open: 0 Feb 14 19:14:08 armadillo ModemManager[2206]: QCDM EVDO open: 0 Feb 14 19:14:08 armadillo ModemManager[2206]: Periodic signal quality checks scheduled in 30s Feb 14 19:14:08 armadillo ModemManager[2206]: (ttyUSB0) device open count is 1 (close) Feb 14 19:14:13 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:14:13 armadillo update-ca-certificates[6815]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:14:13 armadillo update-ca-certificates[6815]: done. Feb 14 19:14:13 armadillo update-ca-certificates[6815]: Updating certificates in /etc/ssl/certs... Feb 14 19:14:19 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:14:20 armadillo update-ca-certificates[7071]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:14:20 armadillo connection-recover: ttyCommModem reconnect start... Feb 14 19:14:20 armadillo update-ca-certificates[7071]: done. Feb 14 19:14:20 armadillo update-ca-certificates[7071]: Updating certificates in /etc/ssl/certs... Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.8350] agent-manager: req[0x230d900, :1.43/nmcli-connect/0]: agent registered Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.8494] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (1e32ed54-6b27-4b04-8d3f-1ee4241f0754) Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.8513] audit: op="connection-activate" uuid="1e32ed54-6b27-4b04-8d3f-1ee4241f0754" name="gsm-ttyCommModem" pid=7296 uid=0 result="success" Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.8549] device (ttyCommModem): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.8606] manager: NetworkManager state is now CONNECTING Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.8652] device (ttyCommModem): state change: prepare -> need-auth (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.8799] device (ttyCommModem): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:25 armadillo ModemManager[2206]: Simple connect started... Feb 14 19:14:25 armadillo ModemManager[2206]: PIN: unspecified Feb 14 19:14:25 armadillo ModemManager[2206]: Operator ID: unspecified Feb 14 19:14:25 armadillo ModemManager[2206]: Allowed roaming: yes Feb 14 19:14:25 armadillo ModemManager[2206]: APN: ●●● Feb 14 19:14:25 armadillo ModemManager[2206]: IP family: ipv4v6 Feb 14 19:14:25 armadillo ModemManager[2206]: Allowed authentication: unspecified Feb 14 19:14:25 armadillo ModemManager[2206]: User: ●●● Feb 14 19:14:25 armadillo ModemManager[2206]: Password: ●●● Feb 14 19:14:25 armadillo ModemManager[2206]: Simple connect state (4/8): Wait to get fully enabled Feb 14 19:14:25 armadillo ModemManager[2206]: Simple connect state (5/8): Register Feb 14 19:14:25 armadillo ModemManager[2206]: Already registered in network '(null)', automatic registration not launched... Feb 14 19:14:25 armadillo ModemManager[2206]: Simple connect state (6/8): Bearer Feb 14 19:14:25 armadillo ModemManager[2206]: Creating new bearer... Feb 14 19:14:25 armadillo ModemManager[2206]: Creating Broadband bearer Quectel EC25 in broadband modem Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (open) Feb 14 19:14:25 armadillo ModemManager[2206]: Simple connect state (7/8): Connect Feb 14 19:14:25 armadillo NetworkManager[1941]: [1550139265.9118] modem["ttyCommModem"]: modem state changed, 'registered' --> 'connecting' (reason: user-requested) Feb 14 19:14:25 armadillo ModemManager[2206]: Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0' Feb 14 19:14:25 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Feb 14 19:14:25 armadillo ModemManager[2206]: Launching 3GPP connection attempt with APN '●●●' Feb 14 19:14:25 armadillo ModemManager[2206]: Quectel EC25, We always use cid 1. Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (open) Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (close) Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+QICSGP=1' Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem): <-- '+QICSGP: 1,"au.au-net.ne.jp","user@au.au-net.ne.jp","au",2OK' Feb 14 19:14:25 armadillo ModemManager[2206]: using cid: 1, set PDP context. Feb 14 19:14:25 armadillo ModemManager[2206]: APN user/password given but no authentication type explicitly requested: defaulting to 'CHAP' Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (open) Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (close) Feb 14 19:14:25 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+QICSGP=1,1,"●●●","●●●","●●●",2' Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK' Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (open) Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (close) Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+CFUN=0' Feb 14 19:14:26 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:14:26 armadillo update-ca-certificates[7323]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK+CIEV: 1,0+CIEV: 2,0+CIEV: 6,0+CGEV: ME DETACH' Feb 14 19:14:26 armadillo ModemManager[2206]: mobile equipment forced PS detach: all contexts have been deactivated Feb 14 19:14:26 armadillo ModemManager[2206]: Bearer /org/freedesktop/ModemManager1/Bearer/0: explicitly disconnected Feb 14 19:14:26 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Feb 14 19:14:26 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (0) Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (open) Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (close) Feb 14 19:14:26 armadillo NetworkManager[1941]: [1550139266.8205] modem["ttyCommModem"]: modem state changed, 'connecting' --> 'registered' (reason: user-requested) Feb 14 19:14:26 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+CFUN=1' Feb 14 19:14:27 armadillo update-ca-certificates[7323]: done. Feb 14 19:14:27 armadillo update-ca-certificates[7323]: Updating certificates in /etc/ssl/certs... Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK+CREG: 0+CGREG: 0+CEREG: 0' Feb 14 19:14:27 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> idle) Feb 14 19:14:27 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '0', Tracking area code: 'C224', Cell ID: '85EC308') Feb 14 19:14:27 armadillo ModemManager[2206]: Bearer not allowed to connect, not registered in 3GPP network Feb 14 19:14:27 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (lte -> unknown) Feb 14 19:14:27 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '0', Tracking area code: '0', Cell ID: '0') Feb 14 19:14:27 armadillo ModemManager[2206]: load operator code ... Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (open) Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (open) Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (close) Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS=3,2' Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK' Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (close) Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS?' Feb 14 19:14:27 armadillo ModemManager[2206]: (ttyCommModem): <-- '+COPS: 0OK' Feb 14 19:14:27 armadillo ModemManager[2206]: retry check network connection: 1/10 Feb 14 19:14:30 armadillo ModemManager[2206]: load operator code ... Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- '+CPIN: READY+QUSIM: 1+QIND: SMS DONE+CIEV: 4,1+QIND: PB DONE+CIEV: 2,1+CIEV: 4,0+CIEV: 6,1+CREG: 1,"C224","85EC308",7+CGREG: 1,"C224","85EC308",7+CEREG: 1,"C224","85EC308",7' Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: signal quality updated (20) Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (idle -> registering) Feb 14 19:14:30 armadillo ModemManager[2206]: loading Operator Code... Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 5 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> lte) Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '0', Tracking area code: 'C224', Cell ID: '85EC308') Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: 'C224', Tracking area code: '0', Cell ID: '85EC308') Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '0', MNC: '0', Location area code: '0', Tracking area code: 'C224', Cell ID: '85EC308') Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS=3,2' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS?' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- '+COPS: 0,2,"44051",7OK' Feb 14 19:14:30 armadillo ModemManager[2206]: loaded Operator Code: 44051 Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 5 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS=3,2' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS?' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- '+COPS: 0,2,"44051",7OK' Feb 14 19:14:30 armadillo ModemManager[2206]: loaded Operator Code: 44051 Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '440', MNC: '51', Location area code: '0', Tracking area code: 'C224', Cell ID: '85EC308') Feb 14 19:14:30 armadillo ModemManager[2206]: loading Operator Name... Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 5 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+QIACT?' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 5 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 4 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS=3,0' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 3 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+COPS?' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- '+COPS: 0,0,"KDDI KDDI",7OK' Feb 14 19:14:30 armadillo ModemManager[2206]: loaded Operator Name: KDDI KDDI Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+QIACT=1' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- 'OK' Feb 14 19:14:30 armadillo ModemManager[2206]: Activated PDP context, start dial. Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3) opening serial port... Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3): setting up baudrate: 57600 Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3): no flow control explicitly requested for device Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3): port attributes not fully set Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3) device open count is 1 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: Connection through a plain serial AT port (ttyUSB3) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3) device open count is 2 (open) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem) device open count is 1 (close) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3): --> 'ATD*99***1#' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyCommModem): <-- '+CIEV: 7,2' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3): <-- 'CONNECT 150000000' Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3): port now connected Feb 14 19:14:30 armadillo ModemManager[2206]: Connected bearer '/org/freedesktop/ModemManager1/Bearer/0' Feb 14 19:14:30 armadillo ModemManager[2206]: PPP is required for connection, will ignore disconnection reports Feb 14 19:14:30 armadillo ModemManager[2206]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connected) Feb 14 19:14:30 armadillo ModemManager[2206]: Simple connect state (8/8): All done Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4143] modem["ttyCommModem"]: modem state changed, 'registered' --> 'connected' (reason: user-requested) Feb 14 19:14:30 armadillo ModemManager[2206]: (ttyUSB3) device open count is 1 (close) Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4236] device (ttyCommModem): state change: prepare -> config (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4295] device (ttyCommModem): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4335] device (ttyCommModem): interface ttyCommModem not up for IP configuration Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4337] modem["ttyCommModem"]: using modem-specified IP timeout: 20 seconds Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4396] loaded PPP plugin /usr/lib/arm-linux-gnueabihf/NetworkManager/1.14.6/libnm-ppp-plugin.so Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4428] ppp-manager: starting PPP connection Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.4700] ppp-manager: pppd started with pid 7541 Feb 14 19:14:30 armadillo NetworkManager[1941]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (plugin_init): initializing Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Feb 14 19:14:30 armadillo NetworkManager[1941]: Using interface ppp0 Feb 14 19:14:30 armadillo NetworkManager[1941]: Connect: ppp0 <--> /dev/ttyUSB3 Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.5406] manager: (ppp0): new Ppp device (/org/freedesktop/NetworkManager/Devices/12) Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Feb 14 19:14:30 armadillo NetworkManager[1941]: CHAP authentication succeeded Feb 14 19:14:30 armadillo NetworkManager[1941]: CHAP authentication succeeded Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Feb 14 19:14:30 armadillo ModemManager[2206]: (net/ppp0): adding device at sysfs path: /sys/devices/virtual/net/ppp0 Feb 14 19:14:30 armadillo ModemManager[2206]: [filter] (net/ppp0) port filtered: virtual device Feb 14 19:14:30 armadillo NetworkManager[1941]: Could not determine remote IP address: defaulting to 10.64.64.64 Feb 14 19:14:30 armadillo NetworkManager[1941]: local IP address 100.103.101.25 Feb 14 19:14:30 armadillo NetworkManager[1941]: remote IP address 10.64.64.64 Feb 14 19:14:30 armadillo NetworkManager[1941]: primary DNS address 210.130.0.20 Feb 14 19:14:30 armadillo NetworkManager[1941]: secondary DNS address 210.130.1.20 Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (nm_ip_up): ip-up event Feb 14 19:14:30 armadillo pppd[7541]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.6769] ppp-manager: (IPv4 Config Get) reply received. Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.7186] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Feb 14 19:14:30 armadillo dnsmasq[2260]: reading /etc/resolv.conf Feb 14 19:14:30 armadillo dnsmasq[2260]: using nameserver 210.130.0.20#53 Feb 14 19:14:30 armadillo dnsmasq[2260]: using nameserver 210.130.1.20#53 Feb 14 19:14:30 armadillo dnsmasq[2260]: no servers found in /etc/resolv.conf, will retry Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.7460] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.7585] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.7616] device (ttyCommModem): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed') Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.7643] manager: NetworkManager state is now CONNECTED_SITE Feb 14 19:14:30 armadillo dnsmasq[2260]: reading /etc/resolv.conf Feb 14 19:14:30 armadillo dnsmasq[2260]: using nameserver 210.130.0.20#53 Feb 14 19:14:30 armadillo dnsmasq[2260]: using nameserver 210.130.1.20#53 Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.7993] device (ttyCommModem): Activation: successful, device activated. Feb 14 19:14:30 armadillo NetworkManager[1941]: [1550139270.8088] manager: NetworkManager state is now CONNECTED_GLOBAL Feb 14 19:14:30 armadillo dbus-daemon[1912]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.3' (uid=0 pid=1941 comm="/usr/sbin/NetworkManager --no-daemon ") Feb 14 19:14:30 armadillo dnsmasq[2260]: reading /etc/resolv.conf Feb 14 19:14:30 armadillo dnsmasq[2260]: using nameserver 210.130.0.20#53 Feb 14 19:14:30 armadillo dnsmasq[2260]: using nameserver 210.130.1.20#53 Feb 14 19:14:30 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Feb 14 19:14:30 armadillo connection-recover: ttyCommModem reconnect success Feb 14 19:14:30 armadillo dbus-daemon[1912]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Feb 14 19:14:30 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Feb 14 19:14:31 armadillo nm-dispatcher: req:1 'up' [ppp0]: new request (2 scripts) Feb 14 19:14:31 armadillo nm-dispatcher: req:1 'up' [ppp0]: start running ordered scripts... Feb 14 19:14:31 armadillo nm-dispatcher: req:2 'connectivity-change': new request (2 scripts) Feb 14 19:14:31 armadillo nm-dispatcher: req:2 'connectivity-change': start running ordered scripts... Feb 14 19:14:31 armadillo ModemManager[2206]: (ttyCommModem): <-- '+CIEV: 1,4' Feb 14 19:14:33 armadillo systemd-timedated[2448]: Set NTP to disabled Feb 14 19:14:33 armadillo update-ca-certificates[7618]: Clearing symlinks in /etc/ssl/certs... Feb 14 19:14:33 armadillo update-ca-certificates[7618]: done. Feb 14 19:14:33 armadillo update-ca-certificates[7618]: Updating certificates in /etc/ssl/certs... Feb 14 19:14:38 armadillo ModemManager[2206]: loading signal quality... Feb 14 19:14:38 armadillo ModemManager[2206]: (ttyCommModem) device open count is 2 (open) Feb 14 19:14:38 armadillo ModemManager[2206]: (ttyCommModem): --> 'AT+CIND?' Feb 14 19:14:38 armadillo ModemManager[2206]: (ttyCommModem): <-- '+CIND: 0,4,1,0,0,0,1,2OK' Feb 14 19:14:38 armadillo ModemManager[2206]: