Sep 25 11:10:17 armadillo systemd[1]: Stopping User Manager for UID 1001... Sep 25 11:10:17 armadillo systemd[2951]: Stopped target Default. Sep 25 11:10:17 armadillo systemd[2951]: Stopped target Basic System. Sep 25 11:10:17 armadillo systemd[2951]: Stopped target Timers. Sep 25 11:10:17 armadillo systemd[2951]: Stopped target Sockets. Sep 25 11:10:17 armadillo systemd[2951]: Closed GnuPG cryptographic agent and passphrase cache (restricted). Sep 25 11:10:17 armadillo systemd[2951]: Closed GnuPG cryptographic agent (ssh-agent emulation). Sep 25 11:10:17 armadillo systemd[2951]: Closed GnuPG cryptographic agent (access for web browsers). Sep 25 11:10:17 armadillo systemd[2951]: Closed GnuPG cryptographic agent and passphrase cache. Sep 25 11:10:17 armadillo systemd[2951]: Stopped target Paths. Sep 25 11:10:17 armadillo systemd[2951]: Closed GnuPG network certificate management daemon. Sep 25 11:10:17 armadillo systemd[2951]: Reached target Shutdown. Sep 25 11:10:17 armadillo systemd[2951]: Starting Exit the Session... Sep 25 11:10:17 armadillo systemd[2951]: Received SIGRTMIN+24 from PID 3609 (kill). Sep 25 11:10:17 armadillo systemd[1]: Stopped User Manager for UID 1001. Sep 25 11:10:17 armadillo systemd[1]: Removed slice User Slice of okura. Sep 25 11:17:01 armadillo CRON[3733]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Sep 25 11:35:52 armadillo pppd[18037]: LCP terminated by peer Sep 25 11:35:52 armadillo pppd[18037]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Sep 25 11:35:52 armadillo NetworkManager[17940]: LCP terminated by peer Sep 25 11:35:52 armadillo NetworkManager[17940]: Connect time 1441.2 minutes. Sep 25 11:35:52 armadillo NetworkManager[17940]: Sent 5266411 bytes, received 6322049 bytes. Sep 25 11:35:52 armadillo pppd[18037]: Connect time 1441.2 minutes. Sep 25 11:35:52 armadillo pppd[18037]: Sent 5266411 bytes, received 6322049 bytes. Sep 25 11:35:52 armadillo pppd[18037]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Sep 25 11:35:52 armadillo pppd[18037]: Modem hangup Sep 25 11:35:52 armadillo NetworkManager[17940]: Modem hangup Sep 25 11:35:52 armadillo pppd[18037]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Sep 25 11:35:52 armadillo pppd[18037]: Connection terminated. Sep 25 11:35:52 armadillo NetworkManager[17940]: Connection terminated. Sep 25 11:35:53 armadillo NetworkManager[17940]: [1601001353.0106] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Sep 25 11:35:53 armadillo chronyd[1253]: Source [IPアドレス1] offline Sep 25 11:35:53 armadillo chronyd[1253]: Source [IPアドレス2] offline Sep 25 11:35:53 armadillo chronyd[1253]: Source [IPアドレス3] offline Sep 25 11:35:53 armadillo chronyd[1253]: Source [IPアドレス4] offline Sep 25 11:35:53 armadillo chronyd[1253]: Can't synchronise: no selectable sources Sep 25 11:35:53 armadillo pppd[18037]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Sep 25 11:35:53 armadillo pppd[18037]: nm-ppp-plugin: (nm_exit_notify): cleaning up Sep 25 11:35:53 armadillo pppd[18037]: Exit. Sep 25 11:35:53 armadillo NetworkManager[17940]: [1601001353.0499] ppp-manager: pppd pid 18037 exited with error: A modem hung up the phone Sep 25 11:36:02 armadillo connection-recover: ttyUSB2 ping fail Sep 25 11:36:02 armadillo connection-recover: ttyUSB2 reconnect start... Sep 25 11:36:08 armadillo NetworkManager[17940]: [1601001368.2121] device (ttyUSB2): disconnecting for new activation request. Sep 25 11:36:08 armadillo NetworkManager[17940]: [1601001368.2152] device (ttyUSB2): state change: activated -> deactivating (reason 'new-activation') [100 110 60] Sep 25 11:36:08 armadillo NetworkManager[17940]: [1601001368.2161] manager: NetworkManager state is now CONNECTED_LOCAL Sep 25 11:36:08 armadillo NetworkManager[17940]: [1601001368.2313] audit: failed to open auditd socket: Protocol not supported Sep 25 11:36:08 armadillo NetworkManager[17940]: [1601001368.2316] audit: op="connection-activate" uuid="[UUID]" name="gsm-ttyUSB2" pid=4000 uid=0 result="success" Sep 25 11:36:08 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Sep 25 11:36:09 armadillo ModemManager[17945]: (ttyUSB3): port attributes not fully set Sep 25 11:36:10 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.3123] device (ttyUSB2): state change: deactivating -> disconnected (reason 'new-activation') [110 30 60] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.3205] device (ttyUSB2): Activation: starting connection 'gsm-ttyUSB2' ([UUID]) Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.3304] device (ttyUSB2): state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 25 11:36:10 armadillo dbus[689]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.3362] manager: NetworkManager state is now CONNECTING Sep 25 11:36:10 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.3569] device (ttyUSB2): state change: prepare -> need-auth (reason 'none') [40 60 0] Sep 25 11:36:10 armadillo dbus[689]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Sep 25 11:36:10 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Sep 25 11:36:10 armadillo nm-dispatcher: req:1 'down' [ttyUSB2]: new request (3 scripts) Sep 25 11:36:10 armadillo nm-dispatcher: req:1 'down' [ttyUSB2]: start running ordered scripts... Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.4309] device (ttyUSB2): state change: need-auth -> prepare (reason 'none') [60 40 0] Sep 25 11:36:10 armadillo nm-dispatcher: req:2 'connectivity-change': new request (3 scripts) Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect started... Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect state (4/8): Wait to get fully enabled Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect state (5/8): Register Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect state (6/8): Bearer Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect state (7/8): Connect Sep 25 11:36:10 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Sep 25 11:36:10 armadillo ModemManager[17945]: (ttyUSB3): port attributes not fully set Sep 25 11:36:10 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect state (8/8): All done Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5171] device (ttyUSB2): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5183] device (ttyUSB2): state change: prepare -> config (reason 'none') [40 50 0] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5199] device (ttyUSB2): state change: config -> ip-config (reason 'none') [50 70 0] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5205] device (ttyUSB2): interface ttyUSB3 not up for IP configuration Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5206] (ttyUSB2): unhandled WWAN IPv4 method 'manual'; will fail Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5207] device (ttyUSB2): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5227] manager: NetworkManager state is now CONNECTED_LOCAL Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5304] device (ttyUSB2): Activation: failed for connection 'gsm-ttyUSB2' Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5378] device (ttyUSB2): state change: failed -> disconnected (reason 'none') [120 30 0] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5430] policy: auto-activating connection 'gsm-ttyUSB2-1' Sep 25 11:36:10 armadillo nm-dispatcher: req:3 'connectivity-change': new request (3 scripts) Sep 25 11:36:10 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5587] device (ttyUSB2): Activation: starting connection 'gsm-ttyUSB2-1' (xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxxx) Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5605] device (ttyUSB2): state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5619] manager: NetworkManager state is now CONNECTING Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.5658] device (ttyUSB2): state change: prepare -> need-auth (reason 'none') [40 60 0] Sep 25 11:36:10 armadillo nm-dispatcher: req:4 'connectivity-change': new request (3 scripts) Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6229] device (ttyUSB2): state change: need-auth -> failed (reason 'modem-no-carrier') [60 120 25] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6239] manager: NetworkManager state is now CONNECTED_LOCAL Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6304] device (ttyUSB2): Activation: failed for connection 'gsm-ttyUSB2-1' Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6355] device (ttyUSB2): state change: failed -> disconnected (reason 'none') [120 30 0] Sep 25 11:36:10 armadillo nm-dispatcher: req:5 'connectivity-change': new request (3 scripts) Sep 25 11:36:10 armadillo connection-recover: ttyUSB2 reconnect fail Sep 25 11:36:10 armadillo nm-dispatcher: req:2 'connectivity-change': start running ordered scripts... Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6825] policy: auto-activating connection 'gsm-ttyUSB2-1' Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6907] device (ttyUSB2): Activation: starting connection 'gsm-ttyUSB2-1' (xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxxx) Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6934] device (ttyUSB2): state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.6949] manager: NetworkManager state is now CONNECTING Sep 25 11:36:10 armadillo nm-dispatcher: req:6 'connectivity-change': new request (3 scripts) Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.7011] device (ttyUSB2): state change: prepare -> need-auth (reason 'none') [40 60 0] Sep 25 11:36:10 armadillo NetworkManager[17940]: [1601001370.7255] device (ttyUSB2): state change: need-auth -> prepare (reason 'none') [60 40 0] Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect started... Sep 25 11:36:10 armadillo ModemManager[17945]: Simple connect state (4/8): Wait to get fully enabled Sep 25 11:36:10 armadillo nm-dispatcher: req:3 'connectivity-change': start running ordered scripts... Sep 25 11:36:10 armadillo nm-dispatcher: req:4 'connectivity-change': start running ordered scripts... Sep 25 11:36:10 armadillo nm-dispatcher: req:5 'connectivity-change': start running ordered scripts... Sep 25 11:36:10 armadillo nm-dispatcher: req:6 'connectivity-change': start running ordered scripts... Sep 25 11:36:11 armadillo ModemManager[17945]: (ttyUSB3): port attributes not fully set Sep 25 11:36:12 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Sep 25 11:36:12 armadillo ModemManager[17945]: Simple connect state (5/8): Register Sep 25 11:36:12 armadillo ModemManager[17945]: Simple connect state (6/8): Bearer Sep 25 11:36:12 armadillo ModemManager[17945]: Simple connect state (7/8): Connect Sep 25 11:36:12 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Sep 25 11:36:12 armadillo ModemManager[17945]: (ttyUSB3): port attributes not fully set Sep 25 11:36:12 armadillo ModemManager[17945]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Sep 25 11:36:12 armadillo ModemManager[17945]: Simple connect state (8/8): All done Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.7005] device (ttyUSB2): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.7034] device (ttyUSB2): state change: prepare -> config (reason 'none') [40 50 0] Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.7066] device (ttyUSB2): state change: config -> ip-config (reason 'none') [50 70 0] Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.7090] device (ttyUSB2): interface ttyUSB3 not up for IP configuration Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.7107] (ttyUSB2): using modem-specified IP timeout: 20 seconds Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.7137] ppp-manager: starting PPP connection Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.7223] ppp-manager: pppd started with pid 4052 Sep 25 11:36:12 armadillo pppd[4052]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Sep 25 11:36:12 armadillo NetworkManager[17940]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Sep 25 11:36:12 armadillo pppd[4052]: nm-ppp-plugin: (plugin_init): initializing Sep 25 11:36:12 armadillo pppd[4052]: pppd 2.4.7 started by root, uid 0 Sep 25 11:36:12 armadillo pppd[4052]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Sep 25 11:36:12 armadillo pppd[4052]: Using interface ppp0 Sep 25 11:36:12 armadillo pppd[4052]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Sep 25 11:36:12 armadillo NetworkManager[17940]: Using interface ppp0 Sep 25 11:36:12 armadillo NetworkManager[17940]: Connect: ppp0 <--> /dev/ttyUSB3 Sep 25 11:36:12 armadillo pppd[4052]: Connect: ppp0 <--> /dev/ttyUSB3 Sep 25 11:36:12 armadillo pppd[4052]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Sep 25 11:36:12 armadillo pppd[4052]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.8082] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/13) Sep 25 11:36:12 armadillo pppd[4052]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Sep 25 11:36:12 armadillo pppd[4052]: CHAP authentication succeeded Sep 25 11:36:12 armadillo pppd[4052]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Sep 25 11:36:12 armadillo NetworkManager[17940]: CHAP authentication succeeded Sep 25 11:36:12 armadillo NetworkManager[17940]: CHAP authentication succeeded Sep 25 11:36:12 armadillo pppd[4052]: CHAP authentication succeeded Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.8463] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Sep 25 11:36:12 armadillo NetworkManager[17940]: [1601001372.8464] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Sep 25 11:36:13 armadillo pppd[4052]: Could not determine remote IP address: defaulting to [IPアドレス5] Sep 25 11:36:13 armadillo NetworkManager[17940]: Could not determine remote IP address: defaulting to [IPアドレス5] Sep 25 11:36:13 armadillo pppd[4052]: local IP address [IPアドレス6] Sep 25 11:36:13 armadillo NetworkManager[17940]: local IP address [IPアドレス6] Sep 25 11:36:13 armadillo NetworkManager[17940]: remote IP address [IPアドレス5] Sep 25 11:36:13 armadillo NetworkManager[17940]: primary DNS address [IPアドレス7] Sep 25 11:36:13 armadillo NetworkManager[17940]: secondary DNS address [IPアドレス8] Sep 25 11:36:13 armadillo pppd[4052]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Sep 25 11:36:13 armadillo pppd[4052]: remote IP address [IPアドレス5] Sep 25 11:36:13 armadillo pppd[4052]: nm-ppp-plugin: (nm_ip_up): ip-up event Sep 25 11:36:13 armadillo pppd[4052]: primary DNS address [IPアドレス7] Sep 25 11:36:13 armadillo pppd[4052]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Sep 25 11:36:13 armadillo pppd[4052]: secondary DNS address [IPアドレス8] Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.1670] ppp-manager: (IPv4 Config Get) reply received. Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.1960] device (ttyUSB2): state change: ip-config -> ip-check (reason 'none') [70 80 0] Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.1990] device (ttyUSB2): state change: ip-check -> secondaries (reason 'none') [80 90 0] Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.2011] device (ttyUSB2): state change: secondaries -> activated (reason 'none') [90 100 0] Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.2019] manager: NetworkManager state is now CONNECTED_LOCAL Sep 25 11:36:13 armadillo nm-dispatcher: req:7 'connectivity-change': new request (3 scripts) Sep 25 11:36:13 armadillo nm-dispatcher: req:7 'connectivity-change': start running ordered scripts... Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.2172] manager: NetworkManager state is now CONNECTED_GLOBAL Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.2180] policy: set 'gsm-ttyUSB2-1' (ppp0) as default for IPv4 routing and DNS Sep 25 11:36:13 armadillo NetworkManager[17940]: [1601001373.2195] device (ttyUSB2): Activation: successful, device activated. Sep 25 11:36:13 armadillo nm-dispatcher: req:8 'up' [ppp0]: new request (3 scripts) Sep 25 11:36:13 armadillo nm-dispatcher: req:8 'up' [ppp0]: start running ordered scripts... Sep 25 11:36:13 armadillo chronyd[1253]: Source [IPアドレス1] online Sep 25 11:36:13 armadillo chronyd[1253]: Source [IPアドレス4] online Sep 25 11:36:13 armadillo chronyd[1253]: Source [IPアドレス2] online Sep 25 11:36:13 armadillo chronyd[1253]: Source [IPアドレス3] online Sep 25 11:36:13 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Sep 25 11:36:13 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Sep 25 11:36:15 armadillo pppd[4052]: sif6addr: ioctl(SIOCSIFADDR): Permission denied (line 2613) Sep 25 11:36:15 armadillo NetworkManager[17940]: sif6addr: ioctl(SIOCSIFADDR): Permission denied (line 2613) Sep 25 11:36:15 armadillo pppd[4052]: cif6addr: ioctl(SIOCDIFADDR): No such address Sep 25 11:36:15 armadillo NetworkManager[17940]: cif6addr: ioctl(SIOCDIFADDR): No such address Sep 25 11:36:23 armadillo ntpdate[4116]: adjust time server 133.243.238.243 offset -0.001779 sec Sep 25 11:53:52 armadillo systemd[1]: Created slice User Slice of okura. Sep 25 11:53:52 armadillo systemd[1]: Starting User Manager for UID 1001... Sep 25 11:53:52 armadillo systemd[1]: Started Session c14 of user okura. Sep 25 11:53:53 armadillo systemd[4321]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Sep 25 11:53:53 armadillo systemd[4321]: Reached target Paths.