Nov 27 08:32:11 armadillo kernel: Booting Linux on physical CPU 0x0 Nov 27 08:32:11 armadillo systemd[1]: Started Load Kernel Modules. Nov 27 08:32:11 armadillo kernel: Linux version 4.9.133-at15 (atmark@atde7) (gcc version 6.3.0 20170516 (Debian 6.3.0-18) ) #9 SMP PREEMPT Sun Oct 11 09:22:33 JST 2020 Nov 27 08:32:11 armadillo kernel: CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c53c7d Nov 27 08:32:11 armadillo kernel: CPU: div instructions available: patching division code Nov 27 08:32:11 armadillo kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Nov 27 08:32:11 armadillo systemd[1]: Started Remount Root and Kernel File Systems. Nov 27 08:32:11 armadillo systemd[1]: Started Create Static Device Nodes in /dev. Nov 27 08:32:11 armadillo systemd[1]: Starting udev Kernel Device Manager... Nov 27 08:32:11 armadillo systemd[1]: Starting Load/Save Random Seed... Nov 27 08:32:11 armadillo systemd[1]: Reached target Local File Systems (Pre). Nov 27 08:32:11 armadillo systemd[1]: Starting udev Coldplug all Devices... Nov 27 08:32:11 armadillo systemd[1]: Reached target Local File Systems. Nov 27 08:32:11 armadillo systemd[1]: Starting Apply Kernel Variables... Nov 27 08:32:11 armadillo systemd[1]: Mounting FUSE Control File System... Nov 27 08:32:11 armadillo systemd[1]: Mounting Configuration File System... Nov 27 08:32:11 armadillo systemd[1]: Starting Flush Journal to Persistent Storage... Nov 27 08:32:11 armadillo systemd[1]: Mounted Configuration File System. Nov 27 08:32:11 armadillo systemd[1]: Mounted FUSE Control File System. Nov 27 08:32:11 armadillo kernel: OF: fdt:Machine model: Atmark-Techno Armadillo-IoT Gateway G3 M1 Board Nov 27 08:32:11 armadillo kernel: Reserved memory: created CMA memory pool at 0xac000000, size 320 MiB Nov 27 08:32:11 armadillo kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Nov 27 08:32:11 armadillo kernel: Memory policy: Data cache writealloc Nov 27 08:32:11 armadillo kernel: On node 0 totalpages: 262144 Nov 27 08:32:11 armadillo kernel: free_area_init_node: node 0, pgdat 815a3640, node_mem_map ab659000 Nov 27 08:32:11 armadillo kernel: Normal zone: 2304 pages used for memmap Nov 27 08:32:11 armadillo systemd[1]: Started udev Kernel Device Manager. Nov 27 08:32:11 armadillo kernel: Normal zone: 0 pages reserved Nov 27 08:32:11 armadillo kernel: Normal zone: 262144 pages, LIFO batch:31 Nov 27 08:32:11 armadillo systemd[1]: Started Load/Save Random Seed. Nov 27 08:32:11 armadillo kernel: percpu: Embedded 14 pages/cpu @ab61b000 s26508 r8192 d22644 u57344 Nov 27 08:32:11 armadillo kernel: pcpu-alloc: s26508 r8192 d22644 u57344 alloc=14*4096 Nov 27 08:32:11 armadillo kernel: pcpu-alloc: [0] 0 [0] 1 Nov 27 08:32:11 armadillo kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 259840 Nov 27 08:32:11 armadillo kernel: Kernel command line: console=ttymxc4,115200 root=/dev/mmcblk2p2 rootwait rw softdog.soft_margin=300 Nov 27 08:32:11 armadillo kernel: PID hash table entries: 4096 (order: 2, 16384 bytes) Nov 27 08:32:11 armadillo systemd[1]: Started Apply Kernel Variables. Nov 27 08:32:11 armadillo kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Nov 27 08:32:11 armadillo kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Nov 27 08:32:11 armadillo kernel: Memory: 688276K/1048576K available (11264K kernel code, 657K rwdata, 5028K rodata, 3072K init, 494K bss, 32620K reserved, 327680K cma-reserved, 0K highmem) Nov 27 08:32:11 armadillo systemd[1]: Started Flush Journal to Persistent Storage. Nov 27 08:32:11 armadillo systemd[1]: Starting Create Volatile Files and Directories... Nov 27 08:32:11 armadillo systemd[1]: Started Create Volatile Files and Directories. Nov 27 08:32:11 armadillo systemd[1]: Starting Network Time Synchronization... Nov 27 08:32:11 armadillo systemd[1]: Starting Update UTMP about System Boot/Shutdown... Nov 27 08:32:11 armadillo systemd[1]: Started Update UTMP about System Boot/Shutdown. Nov 27 08:32:11 armadillo systemd[1]: Started udev Coldplug all Devices. Nov 27 08:32:11 armadillo systemd[1]: Started Network Time Synchronization. Nov 27 08:32:11 armadillo systemd[1]: Reached target System Time Synchronized. Nov 27 08:32:11 armadillo systemd[1]: Reached target System Initialization. Nov 27 08:32:11 armadillo systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 27 08:32:11 armadillo systemd[1]: apt-daily.timer: Adding 4h 18min 29.348627s random time. Nov 27 08:32:11 armadillo systemd[1]: Started Daily apt download activities. Nov 27 08:32:11 armadillo systemd[1]: apt-daily-upgrade.timer: Adding 48min 20.499418s random time. Nov 27 08:32:11 armadillo systemd[1]: Started Daily apt upgrade and clean activities. Nov 27 08:32:11 armadillo systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Nov 27 08:32:11 armadillo systemd[1]: Reached target Sockets. Nov 27 08:32:11 armadillo systemd[1]: Reached target Basic System. Nov 27 08:32:11 armadillo systemd[1]: Starting Restore /etc/resolv.conf if the system crashed before the ppp link was shut down... Nov 27 08:32:11 armadillo systemd[1]: Started Power off EC25 safely. Nov 27 08:32:11 armadillo systemd[1]: Starting Login Service... Nov 27 08:32:11 armadillo systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Nov 27 08:32:11 armadillo systemd[1]: Started D-Bus System Message Bus. Nov 27 08:32:11 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 27 08:32:11 armadillo systemd[1]: Starting Network Manager... Nov 27 08:32:11 armadillo systemd[1]: Started Regular background program processing daemon. Nov 27 08:32:11 armadillo systemd[1]: Starting System Logging Service... Nov 27 08:32:11 armadillo cron[710]: (CRON) INFO (pidfile fd = 3) Nov 27 08:32:11 armadillo systemd[1]: Starting EC25 resetting configuration... Nov 27 08:32:11 armadillo cron[710]: (CRON) INFO (Running @reboot jobs) Nov 27 08:32:11 armadillo kernel: Virtual kernel memory layout: Nov 27 08:32:11 armadillo kernel: vector : 0xffff0000 - 0xffff1000 ( 4 kB) Nov 27 08:32:11 armadillo systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Nov 27 08:32:11 armadillo kernel: fixmap : 0xffc00000 - 0xfff00000 (3072 kB) Nov 27 08:32:11 armadillo kernel: vmalloc : 0xc0800000 - 0xff800000 (1008 MB) Nov 27 08:32:11 armadillo kernel: lowmem : 0x80000000 - 0xc0000000 (1024 MB) Nov 27 08:32:11 armadillo kernel: pkmap : 0x7fe00000 - 0x80000000 ( 2 MB) Nov 27 08:32:11 armadillo kernel: modules : 0x7f000000 - 0x7fe00000 ( 14 MB) Nov 27 08:32:11 armadillo kernel: .text : 0x80008000 - 0x80c00000 (12256 kB) Nov 27 08:32:11 armadillo kernel: .init : 0x81200000 - 0x81500000 (3072 kB) Nov 27 08:32:11 armadillo kernel: .data : 0x81500000 - 0x815a47a0 ( 658 kB) Nov 27 08:32:11 armadillo kernel: .bss : 0x815a6000 - 0x81621a54 ( 495 kB) Nov 27 08:32:11 armadillo kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Nov 27 08:32:11 armadillo kernel: Preemptible hierarchical RCU implementation. Nov 27 08:32:11 armadillo kernel: Build-time adjustment of leaf fanout to 32. Nov 27 08:32:11 armadillo kernel: RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2. Nov 27 08:32:11 armadillo kernel: RCU: Adjusting geometry for rcu_fanout_leaf=32, nr_cpu_ids=2 Nov 27 08:32:11 armadillo kernel: NR_IRQS:16 nr_irqs:16 16 Nov 27 08:32:11 armadillo kernel: arm_arch_timer: Architected cp15 timer(s) running at 8.00MHz (phys). Nov 27 08:32:11 armadillo kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1d854df40, max_idle_ns: 440795202120 ns Nov 27 08:32:11 armadillo kernel: sched_clock: 56 bits at 8MHz, resolution 125ns, wraps every 2199023255500ns Nov 27 08:32:11 armadillo kernel: Switching to timer-based delay loop, resolution 125ns Nov 27 08:32:11 armadillo kernel: Ignoring duplicate/late registration of read_current_timer delay Nov 27 08:32:11 armadillo kernel: clocksource: mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns Nov 27 08:32:11 armadillo kernel: Console: colour dummy device 80x30 Nov 27 08:32:11 armadillo kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 16.00 BogoMIPS (lpj=80000) Nov 27 08:32:11 armadillo kernel: pid_max: default: 32768 minimum: 301 Nov 27 08:32:11 armadillo kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Nov 27 08:32:11 armadillo kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Nov 27 08:32:11 armadillo kernel: CPU: Testing write buffer coherency: ok Nov 27 08:32:11 armadillo kernel: CPU0: update cpu_capacity 1024 Nov 27 08:32:11 armadillo kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Nov 27 08:32:11 armadillo kernel: Setting up static identity map for 0x80100000 - 0x80100058 Nov 27 08:32:11 armadillo kernel: CPU1: update cpu_capacity 1024 Nov 27 08:32:11 armadillo kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Nov 27 08:32:11 armadillo kernel: Brought up 2 CPUs Nov 27 08:32:11 armadillo kernel: SMP: Total of 2 processors activated (32.00 BogoMIPS). Nov 27 08:32:11 armadillo kernel: CPU: All CPU(s) started in SVC mode. Nov 27 08:32:11 armadillo kernel: devtmpfs: initialized Nov 27 08:32:11 armadillo kernel: VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5 Nov 27 08:32:11 armadillo kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Nov 27 08:32:11 armadillo kernel: futex hash table entries: 512 (order: 3, 32768 bytes) Nov 27 08:32:11 armadillo kernel: pinctrl core: initialized pinctrl subsystem Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 16 Nov 27 08:32:11 armadillo kernel: DMA: preallocated 256 KiB pool for atomic coherent allocations Nov 27 08:32:11 armadillo kernel: cpuidle: using governor ladder Nov 27 08:32:11 armadillo kernel: cpuidle: using governor menu Nov 27 08:32:11 armadillo kernel: DDR type is DDR3! Nov 27 08:32:11 armadillo kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Nov 27 08:32:11 armadillo kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Nov 27 08:32:11 armadillo kernel: imx7d-pinctrl 302c0000.iomuxc-lpsr: initialized IMX pinctrl driver Nov 27 08:32:11 armadillo kernel: imx7d-pinctrl 30330000.iomuxc: initialized IMX pinctrl driver Nov 27 08:32:11 armadillo kernel: MU is ready for cross core communication! Nov 27 08:32:11 armadillo kernel: GPIO line 13 (MCU_INTB) hogged as input Nov 27 08:32:11 armadillo kernel: GPIO line 43 (SVEN) hogged as output/high Nov 27 08:32:11 armadillo kernel: GPIO line 60 (LAN1_INT_N) hogged as input Nov 27 08:32:11 armadillo kernel: GPIO line 62 (LAN1_COMA_MODE) hogged as output/low Nov 27 08:32:11 armadillo kernel: GPIO line 85 (EC25_USB_VBUS) hogged as output/low Nov 27 08:32:11 armadillo kernel: mxs-dma 33000000.dma-apbh: initialized Nov 27 08:32:11 armadillo kernel: vgaarb: loaded Nov 27 08:32:11 armadillo kernel: SCSI subsystem initialized Nov 27 08:32:11 armadillo kernel: libata version 3.00 loaded. Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver usbfs Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver hub Nov 27 08:32:11 armadillo kernel: usbcore: registered new device driver usb Nov 27 08:32:11 armadillo systemd[1]: Starting thermal_trip_point-set.service... Nov 27 08:32:11 armadillo systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 27 08:32:11 armadillo kernel: 30800000.aips-bus:usbphynop1 supply vcc not found, using dummy regulator Nov 27 08:32:11 armadillo kernel: 30800000.aips-bus:usbphynop2 supply vcc not found, using dummy regulator Nov 27 08:32:11 armadillo kernel: i2c i2c-0: IMX I2C adapter registered Nov 27 08:32:11 armadillo kernel: i2c i2c-0: can't use DMA, using PIO instead. Nov 27 08:32:11 armadillo kernel: gpio_bmic 3-0014: version: 2.0 Nov 27 08:32:11 armadillo kernel: bmic_regulator 3-0016: version: 1.0 Nov 27 08:32:11 armadillo kernel: i2c i2c-3: IMX I2C adapter registered Nov 27 08:32:11 armadillo kernel: i2c i2c-3: can't use DMA, using PIO instead. Nov 27 08:32:11 armadillo systemd[1]: Reached target Timers. Nov 27 08:32:11 armadillo kernel: Linux video capture interface: v2.00 Nov 27 08:32:11 armadillo kernel: pps_core: LinuxPPS API ver. 1 registered Nov 27 08:32:11 armadillo kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Nov 27 08:32:11 armadillo kernel: PTP clock support registered Nov 27 08:32:11 armadillo liblogging-stdlog: [origin software="rsyslogd" swVersion="8.24.0" x-pid="713" x-info="http://www.rsyslog.com"] start Nov 27 08:32:11 armadillo kernel: MIPI CSI2 driver module loaded Nov 27 08:32:11 armadillo kernel: imx rpmsg driver is registered. Nov 27 08:32:11 armadillo kernel: Advanced Linux Sound Architecture Driver Initialized. Nov 27 08:32:11 armadillo kernel: Bluetooth: Core ver 2.22 Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 31 Nov 27 08:32:11 armadillo kernel: Bluetooth: HCI device and connection manager initialized Nov 27 08:32:11 armadillo kernel: Bluetooth: HCI socket layer initialized Nov 27 08:32:11 armadillo kernel: Bluetooth: L2CAP socket layer initialized Nov 27 08:32:11 armadillo kernel: Bluetooth: SCO socket layer initialized Nov 27 08:32:11 armadillo kernel: armadillo_iotg_addon addon: probe Nov 27 08:32:11 armadillo kernel: random: fast init done Nov 27 08:32:11 armadillo kernel: armadillo_iotg_addon addon: Atmark Techno DI/DO/AD board detected at Add-On Module I/F 1(Rev 2, SerialNumber=3576). Nov 27 08:32:11 armadillo kernel: armadillo_iotg_addon addon: Atmark Techno DI/DO/AD board detected at Add-On Module I/F 2(Rev 2, SerialNumber=3628). Nov 27 08:32:11 armadillo kernel: DIDOAD_VREF: Failed to create debugfs directory Nov 27 08:32:11 armadillo kernel: clocksource: Switched to clocksource arch_sys_counter Nov 27 08:32:11 armadillo kernel: VFS: Disk quotas dquot_6.6.0 Nov 27 08:32:11 armadillo kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 2 Nov 27 08:32:11 armadillo kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes) Nov 27 08:32:11 armadillo kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Nov 27 08:32:11 armadillo systemd[1]: Started Restore /etc/resolv.conf if the system crashed before the ppp link was shut down. Nov 27 08:32:11 armadillo kernel: TCP: Hash tables configured (established 8192 bind 8192) Nov 27 08:32:11 armadillo kernel: UDP hash table entries: 512 (order: 2, 16384 bytes) Nov 27 08:32:11 armadillo kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 1 Nov 27 08:32:11 armadillo kernel: RPC: Registered named UNIX socket transport module. Nov 27 08:32:11 armadillo kernel: RPC: Registered udp transport module. Nov 27 08:32:11 armadillo kernel: RPC: Registered tcp transport module. Nov 27 08:32:11 armadillo kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 27 08:32:11 armadillo kernel: PCI: CLS 0 bytes, default 64 Nov 27 08:32:11 armadillo kernel: Bus freq driver module loaded Nov 27 08:32:11 armadillo kernel: workingset: timestamp_bits=14 max_order=18 bucket_order=4 Nov 27 08:32:11 armadillo kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 27 08:32:11 armadillo kernel: NFS: Registering the id_resolver key type Nov 27 08:32:11 armadillo kernel: Key type id_resolver registered Nov 27 08:32:11 armadillo kernel: Key type id_legacy registered Nov 27 08:32:11 armadillo kernel: jffs2: version 2.2. (NAND) Ԥ 2001-2006 Red Hat, Inc. Nov 27 08:32:11 armadillo kernel: fuse init (API version 7.26) Nov 27 08:32:11 armadillo kernel: io scheduler noop registered Nov 27 08:32:11 armadillo kernel: io scheduler deadline registered Nov 27 08:32:11 armadillo kernel: io scheduler cfq registered (default) Nov 27 08:32:11 armadillo kernel: OF: PCI: host bridge /soc/pcie@0x33800000 ranges: Nov 27 08:32:11 armadillo kernel: OF: PCI: No bus range found for /soc/pcie@0x33800000, using [bus 00-ff] Nov 27 08:32:11 armadillo kernel: OF: PCI: IO 0x4ff80000..0x4ff8ffff -> 0x00000000 Nov 27 08:32:11 armadillo kernel: OF: PCI: MEM 0x40000000..0x4fefffff -> 0x40000000 Nov 27 08:32:11 armadillo kernel: imx6q-pcie 33800000.pcie: phy link never came up Nov 27 08:32:11 armadillo kernel: imx6q-pcie 33800000.pcie: Link never came up Nov 27 08:32:11 armadillo kernel: imx6q-pcie 33800000.pcie: failed to initialize host Nov 27 08:32:11 armadillo kernel: imx6q-pcie: probe of 33800000.pcie failed with error -110 Nov 27 08:32:11 armadillo kernel: imx-sdma 30bd0000.sdma: loaded firmware 4.2 Nov 27 08:32:11 armadillo kernel: pfuze100-regulator 3-0009: Full layer: 1, Metal layer: 1 Nov 27 08:32:11 armadillo kernel: pfuze100-regulator 3-0009: FAB: 0, FIN: 0 Nov 27 08:32:11 armadillo kernel: pfuze100-regulator 3-0009: pfuze3000 found. Nov 27 08:32:11 armadillo kernel: 30a70000.serial: ttymxc4 at MMIO 0x30a70000 (irq = 45, base_baud = 5000000) is a IMX Nov 27 08:32:11 armadillo kernel: console [ttymxc4] enabled Nov 27 08:32:11 armadillo kernel: 30a90000.serial: ttymxc6 at MMIO 0x30a90000 (irq = 46, base_baud = 500000) is a IMX Nov 27 08:32:11 armadillo kernel: imx sema4 driver is registered. Nov 27 08:32:11 armadillo kernel: [drm] Initialized Nov 27 08:32:11 armadillo kernel: [drm] Initialized vivante 1.0.0 20120216 on minor 0 Nov 27 08:32:11 armadillo kernel: brd: module loaded Nov 27 08:32:11 armadillo kernel: loop: module loaded Nov 27 08:32:11 armadillo kernel: (hci_tty): inside hci_tty_init Nov 27 08:32:11 armadillo kernel: (hci_tty): allocated 247, 0 Nov 27 08:32:11 armadillo kernel: spi_imx 30830000.ecspi: dma setup error -19, use pio Nov 27 08:32:11 armadillo kernel: spi_imx 30830000.ecspi: probed Nov 27 08:32:11 armadillo kernel: spi_imx 30820000.ecspi: dma setup error -19, use pio Nov 27 08:32:11 armadillo kernel: spi_imx 30820000.ecspi: probed Nov 27 08:32:11 armadillo kernel: libphy: Fixed MDIO Bus: probed Nov 27 08:32:11 armadillo kernel: tun: Universal TUN/TAP device driver, 1.6 Nov 27 08:32:11 armadillo kernel: tun: (C) 1999-2004 Max Krasnyansky Nov 27 08:32:11 armadillo kernel: CAN device driver interface Nov 27 08:32:11 armadillo kernel: 30bf0000.ethernet supply phy not found, using dummy regulator Nov 27 08:32:11 armadillo kernel: pps pps0: new PPS source ptp0 Nov 27 08:32:11 armadillo kernel: libphy: fec_enet_mii_bus: probed Nov 27 08:32:11 armadillo kernel: fec 30bf0000.ethernet eth0: registered PHC device 0 Nov 27 08:32:11 armadillo kernel: PPP generic driver version 2.4.2 Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver kaweth Nov 27 08:32:11 armadillo kernel: pegasus: v0.9.3 (2013/04/25), Pegasus/Pegasus II USB Ethernet driver Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver pegasus Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver rtl8150 Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver r8152 Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver asix Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver ax88179_178a Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver cdc_ether Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver cdc_eem Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver smsc95xx Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver net1080 Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver cdc_subset Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver zaurus Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver sierra_net Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver cdc_ncm Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver qmi_wwan Nov 27 08:32:11 armadillo kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Nov 27 08:32:11 armadillo kernel: ehci-pci: EHCI PCI platform driver Nov 27 08:32:11 armadillo kernel: ehci-mxc: Freescale On-Chip EHCI Host driver Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver cdc_acm Nov 27 08:32:11 armadillo kernel: cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver cdc_wdm Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver usb-storage Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver usbserial Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver usbserial_generic Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for generic Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver cp210x Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for cp210x Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver ftdi_sio Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for FTDI USB Serial Device Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver option Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for GSM modem (1-port) Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver pl2303 Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for pl2303 Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver sierra Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for Sierra USB modem Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver usb_serial_simple Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for carelink Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for zio Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for funsoft Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for flashloader Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for google Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for libtransistor Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for vivopay Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for moto_modem Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for motorola_tetra Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for novatel_gps Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for hp4x Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for suunto Nov 27 08:32:11 armadillo kernel: usbserial: USB Serial support registered for siemens_mpi Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver usb_ehset_test Nov 27 08:32:11 armadillo kernel: usb3503 3-0008: switched to HUB mode Nov 27 08:32:11 armadillo kernel: usb3503 3-0008: usb3503_probe: probed in hub mode Nov 27 08:32:11 armadillo kernel: 30b10200.usbmisc supply vbus-wakeup not found, using dummy regulator Nov 27 08:32:11 armadillo kernel: 30b30200.usbmisc supply vbus-wakeup not found, using dummy regulator Nov 27 08:32:11 armadillo kernel: 30b20200.usbmisc supply vbus-wakeup not found, using dummy regulator Nov 27 08:32:11 armadillo kernel: ci_hdrc ci_hdrc.0: EHCI Host Controller Nov 27 08:32:11 armadillo kernel: ci_hdrc ci_hdrc.0: new USB bus registered, assigned bus number 1 Nov 27 08:32:11 armadillo kernel: ci_hdrc ci_hdrc.0: USB 2.0 started, EHCI 1.00 Nov 27 08:32:11 armadillo kernel: hub 1-0:1.0: USB hub found Nov 27 08:32:11 armadillo kernel: hub 1-0:1.0: 1 port detected Nov 27 08:32:11 armadillo kernel: 30b30000.usb supply vbus not found, using dummy regulator Nov 27 08:32:11 armadillo kernel: ci_hdrc ci_hdrc.1: EHCI Host Controller Nov 27 08:32:11 armadillo kernel: ci_hdrc ci_hdrc.1: new USB bus registered, assigned bus number 2 Nov 27 08:32:11 armadillo kernel: ci_hdrc ci_hdrc.1: USB 2.0 started, EHCI 1.00 Nov 27 08:32:11 armadillo kernel: hub 2-0:1.0: USB hub found Nov 27 08:32:11 armadillo kernel: hub 2-0:1.0: 1 port detected Nov 27 08:32:11 armadillo kernel: udc-core: couldn't find an available UDC - added [g_cdc] to list of pending drivers Nov 27 08:32:11 armadillo kernel: mousedev: PS/2 mouse device common for all mice Nov 27 08:32:11 armadillo kernel: input: 30370000.snvs:snvs-powerkey as /devices/soc0/soc/30000000.aips-bus/30370000.snvs/30370000.snvs:snvs-powerkey/input/input0 Nov 27 08:32:11 armadillo kernel: bmic_rtc 3-0011: version: 1.1 Nov 27 08:32:11 armadillo kernel: bmic_rtc 3-0011: rtc core: registered bmic_rtc as rtc0 Nov 27 08:32:11 armadillo kernel: snvs_rtc 30370000.snvs:snvs-rtc-lp: rtc core: registered 30370000.snvs:snvs- as rtc1 Nov 27 08:32:11 armadillo kernel: i2c /dev entries driver Nov 27 08:32:11 armadillo kernel: IR NEC protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR RC5(x/sz) protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR RC6 protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR JVC protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR Sony protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR SANYO protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR Sharp protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR MCE Keyboard/mouse protocol handler initialized Nov 27 08:32:11 armadillo kernel: IR XMP protocol handler initialized Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver uvcvideo Nov 27 08:32:11 armadillo kernel: USB Video Class driver (1.1.1) Nov 27 08:32:11 armadillo kernel: bmic_thermal 3-0013: version: 1.0 Nov 27 08:32:11 armadillo kernel: imx2-wdt 30280000.wdog: timeout 10 sec (nowayout=0) Nov 27 08:32:11 armadillo kernel: softdog: initialized. soft_noboot=0 soft_margin=300 sec soft_panic=0 (nowayout=0) Nov 27 08:32:11 armadillo kernel: Bluetooth: HCI UART driver ver 2.3 Nov 27 08:32:11 armadillo kernel: Bluetooth: HCI UART protocol H4 registered Nov 27 08:32:11 armadillo kernel: Bluetooth: HCI UART protocol BCSP registered Nov 27 08:32:11 armadillo kernel: Bluetooth: HCI UART protocol LL registered Nov 27 08:32:11 armadillo kernel: Bluetooth: HCI UART protocol ATH3K registered Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver bcm203x Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver btusb Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver ath3k Nov 27 08:32:11 armadillo kernel: sdhci: Secure Digital Host Controller Interface driver Nov 27 08:32:11 armadillo kernel: sdhci: Copyright(c) Pierre Ossman Nov 27 08:32:11 armadillo kernel: sdhci-pltfm: SDHCI platform and OF driver helper Nov 27 08:32:11 armadillo kernel: sdhci-esdhc-imx 30b40000.usdhc: Got CD GPIO Nov 27 08:32:11 armadillo kernel: sdhci-esdhc-imx 30b40000.usdhc: Got WP GPIO Nov 27 08:32:11 armadillo kernel: mmc0: SDHCI controller on 30b40000.usdhc [30b40000.usdhc] using ADMA Nov 27 08:32:11 armadillo kernel: sdhci-esdhc-imx 30b60000.usdhc: could not get ultra high speed state, work on normal mode Nov 27 08:32:11 armadillo kernel: sdhci-esdhc-imx 30b60000.usdhc: allocated mmc-pwrseq Nov 27 08:32:11 armadillo kernel: usb 1-1: new high-speed USB device number 2 using ci_hdrc Nov 27 08:32:11 armadillo kernel: usb 2-1: new high-speed USB device number 2 using ci_hdrc Nov 27 08:32:11 armadillo kernel: mmc2: SDHCI controller on 30b60000.usdhc [30b60000.usdhc] using ADMA Nov 27 08:32:11 armadillo kernel: caam 30900000.caam: ERA source: CCBVID. Nov 27 08:32:11 armadillo kernel: caam 30900000.caam: Entropy delay = 3200 Nov 27 08:32:11 armadillo kernel: caam 30900000.caam: Instantiated RNG4 SH0 Nov 27 08:32:11 armadillo kernel: mmc0: new high speed SD card at address 2f03 Nov 27 08:32:11 armadillo kernel: mmcblk0: mmc0:2f03 RF512 473 MiB Nov 27 08:32:11 armadillo kernel: mmcblk0: p1 Nov 27 08:32:11 armadillo kernel: mmc2: new DDR MMC card at address 0001 Nov 27 08:32:11 armadillo kernel: caam 30900000.caam: Instantiated RNG4 SH1 Nov 27 08:32:11 armadillo kernel: caam 30900000.caam: device ID = 0x0a16030000000000 (Era 8) Nov 27 08:32:11 armadillo kernel: caam 30900000.caam: job rings = 3, qi = 0 Nov 27 08:32:11 armadillo kernel: caam algorithms registered in /proc/crypto Nov 27 08:32:11 armadillo kernel: usb-storage 1-1:1.0: USB Mass Storage device detected Nov 27 08:32:11 armadillo kernel: mmcblk2: mmc2:0001 S0J35A 3.54 GiB Nov 27 08:32:11 armadillo kernel: scsi host0: usb-storage 1-1:1.0 Nov 27 08:32:11 armadillo kernel: caam_jr 30901000.jr0: registering rng-caam Nov 27 08:32:11 armadillo kernel: caam 30900000.caam: caam pkc algorithms registered in /proc/crypto Nov 27 08:32:11 armadillo kernel: snvs-secvio 30370000.caam-snvs: can't get snvs clock Nov 27 08:32:11 armadillo kernel: snvs-secvio 30370000.caam-snvs: violation handlers armed - non-secure state Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver usbhid Nov 27 08:32:11 armadillo kernel: usbhid: USB HID core driver Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver r8712u Nov 27 08:32:11 armadillo kernel: mmcblk2boot0: mmc2:0001 S0J35A partition 1 31.5 MiB Nov 27 08:32:11 armadillo kernel: mmcblk2boot1: mmc2:0001 S0J35A partition 2 31.5 MiB Nov 27 08:32:11 armadillo kernel: mmcblk2gp0: mmc2:0001 S0J35A partition 4 8.00 MiB Nov 27 08:32:11 armadillo kernel: bmic_adc 3-0012: version: 1.0 Nov 27 08:32:11 armadillo kernel: mmcblk2gp1: mmc2:0001 S0J35A partition 5 8.00 MiB Nov 27 08:32:11 armadillo kernel: coresight-etm3x 3007c000.etm: ETM 3.5 initialized Nov 27 08:32:11 armadillo kernel: coresight-etm3x 3007d000.etm: ETM 3.5 initialized Nov 27 08:32:11 armadillo kernel: usbcore: registered new interface driver snd-usb-audio Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 26 Nov 27 08:32:11 armadillo kernel: Netfilter messages via NETLINK v0.30. Nov 27 08:32:11 armadillo kernel: nfnl_acct: registering with nfnetlink. Nov 27 08:32:11 armadillo kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Nov 27 08:32:11 armadillo kernel: ctnetlink v0.93: registering with nfnetlink. Nov 27 08:32:11 armadillo kernel: nf_tables: (c) 2007-2009 Patrick McHardy Nov 27 08:32:11 armadillo kernel: nf_tables_compat: (c) 2012 Pablo Neira Ayuso Nov 27 08:32:11 armadillo kernel: xt_time: kernel timezone is -0000 Nov 27 08:32:11 armadillo kernel: IPVS: Registered protocols () Nov 27 08:32:11 armadillo kernel: IPVS: Connection hash table configured (size=4096, memory=32Kbytes) Nov 27 08:32:11 armadillo kernel: IPVS: Creating netns size=912 id=0 Nov 27 08:32:11 armadillo kernel: IPVS: ipvs loaded. Nov 27 08:32:11 armadillo kernel: ipip: IPv4 and MPLS over IPv4 tunneling driver Nov 27 08:32:11 armadillo kernel: gre: GRE over IPv4 demultiplexor driver Nov 27 08:32:11 armadillo kernel: ip_gre: GRE over IPv4 tunneling driver Nov 27 08:32:11 armadillo kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Nov 27 08:32:11 armadillo kernel: ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully Nov 27 08:32:11 armadillo kernel: arp_tables: arp_tables: (C) 2002 David S. Miller Nov 27 08:32:11 armadillo kernel: Initializing XFRM netlink socket Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 10 Nov 27 08:32:11 armadillo kernel: hub 2-1:1.0: USB hub found Nov 27 08:32:11 armadillo kernel: mmcblk2gp2: mmc2:0001 S0J35A partition 6 8.00 MiB Nov 27 08:32:11 armadillo kernel: hub 2-1:1.0: 3 ports detected Nov 27 08:32:11 armadillo kernel: mmcblk2gp3: mmc2:0001 S0J35A partition 7 8.00 MiB Nov 27 08:32:11 armadillo kernel: mip6: Mobile IPv6 Nov 27 08:32:11 armadillo kernel: ip6_tables: (C) 2000-2006 Netfilter Core Team Nov 27 08:32:11 armadillo kernel: sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver Nov 27 08:32:11 armadillo kernel: ip6_gre: GRE over IPv6 tunneling driver Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 17 Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 15 Nov 27 08:32:11 armadillo kernel: Bridge firewalling registered Nov 27 08:32:11 armadillo kernel: can: controller area network core (rev 20120528 abi 9) Nov 27 08:32:11 armadillo kernel: NET: Registered protocol family 29 Nov 27 08:32:11 armadillo kernel: can: raw protocol (rev 20120528) Nov 27 08:32:11 armadillo kernel: can: broadcast manager protocol (rev 20161123 t) Nov 27 08:32:11 armadillo kernel: can: netlink gateway (rev 20130117) max_hops=1 Nov 27 08:32:11 armadillo kernel: Bluetooth: RFCOMM TTY layer initialized Nov 27 08:32:11 armadillo kernel: mmcblk2rpmb: mmc2:0001 S0J35A partition 3 4.00 MiB Nov 27 08:32:11 armadillo kernel: Bluetooth: RFCOMM socket layer initialized Nov 27 08:32:11 armadillo kernel: Bluetooth: RFCOMM ver 1.11 Nov 27 08:32:11 armadillo kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Nov 27 08:32:11 armadillo kernel: Bluetooth: BNEP filters: protocol multicast Nov 27 08:32:11 armadillo kernel: Bluetooth: BNEP socket layer initialized Nov 27 08:32:11 armadillo kernel: Bluetooth: HIDP (Human Interface Emulation) ver 1.2 Nov 27 08:32:11 armadillo kernel: Bluetooth: HIDP socket layer initialized Nov 27 08:32:11 armadillo kernel: 8021q: 802.1Q VLAN Support v1.8 Nov 27 08:32:11 armadillo kernel: Key type dns_resolver registered Nov 27 08:32:11 armadillo kernel: ThumbEE CPU extension supported. Nov 27 08:32:11 armadillo kernel: mmcblk2: p1 p2 p3 Nov 27 08:32:11 armadillo kernel: imx_thermal 30000000.aips-bus:tempmon: Extended Commercial CPU temperature grade - max:105C critical:100C passive:95C Nov 27 08:32:11 armadillo kernel: dhd_module_init in Nov 27 08:32:11 armadillo kernel: input: gpio-keys as /devices/soc0/gpio-keys/input/input1 Nov 27 08:32:11 armadillo kernel: bmic_rtc 3-0011: setting system clock to 2020-11-26 23:32:06 UTC (1606433526) Nov 27 08:32:11 armadillo kernel: VLDO2: disabling Nov 27 08:32:11 armadillo kernel: ALSA device list: Nov 27 08:32:11 armadillo kernel: No soundcards found. Nov 27 08:32:11 armadillo kernel: Warning: unable to open an initial console. Nov 27 08:32:11 armadillo kernel: Freeing unused kernel memory: 3072K Nov 27 08:32:11 armadillo kernel: random: systemd-udevd: uninitialized urandom read (16 bytes read) Nov 27 08:32:11 armadillo kernel: EXT4-fs (mmcblk2p2): mounted filesystem with ordered data mode. Opts: (null) Nov 27 08:32:11 armadillo kernel: scsi 0:0:0:0: Direct-Access TOSHIBA TransMemory 1.00 PQ: 0 ANSI: 4 Nov 27 08:32:11 armadillo kernel: sd 0:0:0:0: [sda] 60594432 512-byte logical blocks: (31.0 GB/28.9 GiB) Nov 27 08:32:11 armadillo kernel: sd 0:0:0:0: [sda] Write Protect is off Nov 27 08:32:11 armadillo kernel: sd 0:0:0:0: [sda] Mode Sense: 45 00 00 00 Nov 27 08:32:11 armadillo kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Nov 27 08:32:11 armadillo kernel: sda: sda1 Nov 27 08:32:11 armadillo kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Nov 27 08:32:11 armadillo kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 27 08:32:11 armadillo kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 27 08:32:11 armadillo kernel: random: systemd-cryptse: uninitialized urandom read (16 bytes read) Nov 27 08:32:11 armadillo kernel: random: systemd-gpt-aut: uninitialized urandom read (16 bytes read) Nov 27 08:32:11 armadillo kernel: random: systemd-sysv-ge: uninitialized urandom read (16 bytes read) Nov 27 08:32:11 armadillo systemd[1]: Started System Logging Service. Nov 27 08:32:11 armadillo avahi-daemon[731]: Found user 'avahi' (UID 109) and group 'avahi' (GID 115). Nov 27 08:32:11 armadillo avahi-daemon[731]: Successfully dropped root privileges. Nov 27 08:32:11 armadillo avahi-daemon[731]: avahi-daemon 0.6.32 starting up. Nov 27 08:32:11 armadillo avahi-daemon[731]: Successfully called chroot(). Nov 27 08:32:11 armadillo avahi-daemon[731]: Successfully dropped remaining capabilities. Nov 27 08:32:11 armadillo avahi-daemon[789]: chroot.c: open() failed: No such file or directory Nov 27 08:32:11 armadillo avahi-daemon[731]: Failed to open /etc/resolv.conf: Invalid argument Nov 27 08:32:11 armadillo avahi-daemon[731]: No service file found in /etc/avahi/services. Nov 27 08:32:11 armadillo avahi-daemon[731]: Network interface enumeration completed. Nov 27 08:32:11 armadillo avahi-daemon[731]: Server startup complete. Host name is armadillo.local. Local service cookie is 2521277252. Nov 27 08:32:11 armadillo systemd[1]: Started thermal_trip_point-set.service. Nov 27 08:32:11 armadillo systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 27 08:32:11 armadillo systemd[1]: Started Login Service. Nov 27 08:32:12 armadillo NetworkManager[706]: [1606433532.1846] NetworkManager (version 1.6.2) is starting... Nov 27 08:32:12 armadillo NetworkManager[706]: [1606433532.1878] Read config: /etc/NetworkManager/NetworkManager.conf Nov 27 08:32:12 armadillo systemd-udevd[313]: could not open moddep file '/lib/modules/4.9.133-at15/modules.dep.bin' Nov 27 08:32:12 armadillo systemd-udevd[313]: could not open moddep file '/lib/modules/4.9.133-at15/modules.dep.bin' Nov 27 08:32:12 armadillo systemd-udevd[312]: could not open moddep file '/lib/modules/4.9.133-at15/modules.dep.bin' Nov 27 08:32:12 armadillo loadcpufreq[624]: Loading cpufreq kernel modules...done (none). Nov 27 08:32:12 armadillo systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Nov 27 08:32:12 armadillo NetworkManager[706]: [1606433532.3017] manager[0x1a780f0]: monitoring kernel firmware directory '/lib/firmware'. Nov 27 08:32:12 armadillo NetworkManager[706]: [1606433532.3041] monitoring ifupdown state file '/run/network/ifstate'. Nov 27 08:32:12 armadillo systemd[1]: Starting LSB: set CPUFreq kernel parameters... Nov 27 08:32:12 armadillo NetworkManager[706]: [1606433532.3846] dns-mgr[0x1a89028]: init: dns=default, rc-manager=resolvconf Nov 27 08:32:12 armadillo NetworkManager[706]: [1606433532.4081] manager[0x1a780f0]: WiFi hardware radio set enabled Nov 27 08:32:12 armadillo NetworkManager[706]: [1606433532.4380] manager[0x1a780f0]: WWAN hardware radio set enabled Nov 27 08:32:12 armadillo systemd[1]: Started Network Manager. Nov 27 08:32:12 armadillo systemd[1]: Starting Network Manager Wait Online... Nov 27 08:32:12 armadillo systemd[1]: Reached target Network. Nov 27 08:32:12 armadillo systemd[1]: Starting OpenBSD Secure Shell server... Nov 27 08:32:12 armadillo systemd[1]: Starting Lighttpd Daemon... Nov 27 08:32:12 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:32:12 armadillo systemd[1]: Starting Connection Recover... Nov 27 08:32:12 armadillo systemd[1]: Starting Permit User Sessions... Nov 27 08:32:12 armadillo systemd[1]: Started Permit User Sessions. Nov 27 08:32:13 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:32:13 armadillo cpufrequtils[948]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...done. Nov 27 08:32:13 armadillo systemd[1]: Started LSB: set CPUFreq kernel parameters. Nov 27 08:32:13 armadillo systemd[1]: Found device /dev/ttymxc4. Nov 27 08:32:13 armadillo systemd[1]: Started Connection Recover. Nov 27 08:32:13 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:32:13 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5545] init! Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5574] management mode: unmanaged Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5771] devices added (path: /sys/devices/soc0/soc/30800000.aips-bus/30bf0000.ethernet/net/eth0, iface: eth0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5773] device added (path: /sys/devices/soc0/soc/30800000.aips-bus/30bf0000.ethernet/net/eth0, iface: eth0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5774] devices added (path: /sys/devices/virtual/net/gre0, iface: gre0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5775] device added (path: /sys/devices/virtual/net/gre0, iface: gre0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5775] devices added (path: /sys/devices/virtual/net/gretap0, iface: gretap0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5776] device added (path: /sys/devices/virtual/net/gretap0, iface: gretap0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5777] devices added (path: /sys/devices/virtual/net/ip6_vti0, iface: ip6_vti0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5777] device added (path: /sys/devices/virtual/net/ip6_vti0, iface: ip6_vti0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5778] devices added (path: /sys/devices/virtual/net/ip6gre0, iface: ip6gre0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5779] device added (path: /sys/devices/virtual/net/ip6gre0, iface: ip6gre0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5780] devices added (path: /sys/devices/virtual/net/ip6tnl0, iface: ip6tnl0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5781] device added (path: /sys/devices/virtual/net/ip6tnl0, iface: ip6tnl0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5782] devices added (path: /sys/devices/virtual/net/lo, iface: lo) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5783] device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5784] devices added (path: /sys/devices/virtual/net/sit0, iface: sit0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5785] device added (path: /sys/devices/virtual/net/sit0, iface: sit0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5785] devices added (path: /sys/devices/virtual/net/tunl0, iface: tunl0) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5786] device added (path: /sys/devices/virtual/net/tunl0, iface: tunl0): no ifupdown configuration found. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5787] end _init. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5789] settings: loaded plugin ifupdown: (C) 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list. (/usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-settings-plugin-ifupdown.so) Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5792] settings: loaded plugin keyfile: (c) 2007 - 2016 Red Hat, Inc. To report bugs please use the NetworkManager mailing list. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5793] (27671808) ... get_connections. Nov 27 08:32:13 armadillo NetworkManager[706]: [1606433533.5794] (27671808) ... get_connections (managed=false): return empty list. Nov 27 08:32:13 armadillo systemd[1]: Started OpenBSD Secure Shell server. Nov 27 08:32:14 armadillo systemd-udevd[316]: could not open moddep file '/lib/modules/4.9.133-at15/modules.dep.bin' Nov 27 08:32:14 armadillo NetworkManager[706]: [1606433534.4994] keyfile: new connection /etc/NetworkManager/system-connections/gsm-ttyCommModem (228f11da-105c-453a-a736-a1c5f4e6fd8d,"gsm-ttyCommModem") Nov 27 08:32:14 armadillo systemd[1]: Found device /dev/license. Nov 27 08:32:14 armadillo NetworkManager[706]: [1606433534.5303] get unmanaged devices count: 0 Nov 27 08:32:14 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Nov 27 08:32:14 armadillo systemd[1]: Starting Hostname Service... Nov 27 08:32:14 armadillo kernel: IPVS: Creating netns size=912 id=1 Nov 27 08:32:14 armadillo systemd[1]: Mounting /opt/license... Nov 27 08:32:14 armadillo systemd[1]: Started Lighttpd Daemon. Nov 27 08:32:14 armadillo systemd[1]: Mounted /opt/license. Nov 27 08:32:15 armadillo systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Nov 27 08:32:15 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 27 08:32:15 armadillo systemd[1]: Started Hostname Service. Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5576] settings: hostname: using hostnamed Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5577] settings: hostname changed from (none) to "armadillo" Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5589] dhcp-init: Using DHCP client 'dhclient' Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5590] manager: WiFi enabled by radio killswitch; enabled by state file Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5592] manager: WWAN enabled by radio killswitch; enabled by state file Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5593] manager: Networking is enabled by state file Nov 27 08:32:15 armadillo nm-dispatcher: req:1 'hostname': new request (2 scripts) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5696] Loaded device plugin: NMBondDeviceFactory (internal) Nov 27 08:32:15 armadillo nm-dispatcher: req:1 'hostname': start running ordered scripts... Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5697] Loaded device plugin: NMBridgeDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5699] Loaded device plugin: NMEthernetDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5700] Loaded device plugin: NMInfinibandDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5701] Loaded device plugin: NMIPTunnelDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5702] Loaded device plugin: NMMacsecDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5703] Loaded device plugin: NMMacvlanDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5704] Loaded device plugin: NMTunDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5705] Loaded device plugin: NMVethDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5706] Loaded device plugin: NMVlanDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.5707] Loaded device plugin: NMVxlanDeviceFactory (internal) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.6247] Loaded device plugin: NMTeamFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-team.so) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.7498] Loaded device plugin: NMBluezManager (/usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-bluetooth.so) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.7737] Loaded device plugin: NMWwanFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wwan.so) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.7860] Loaded device plugin: NMWifiFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wifi.so) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.8021] Loaded device plugin: NMAtmManager (/usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-adsl.so) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.8109] device (lo): link connected Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.8291] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.8654] manager: (eth0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2) Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.8748] keyfile: add connection in-memory (f9a1d518-9812-3923-8289-1468f15dcc7a,"Wired connection 1") Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.8831] settings: (eth0): created default wired connection 'Wired connection 1' Nov 27 08:32:15 armadillo NetworkManager[706]: [1606433535.9091] device (eth0): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:32:15 armadillo systemd-udevd[318]: Process '/sbin/crda' failed with exit code 249. Nov 27 08:32:15 armadillo kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Nov 27 08:32:16 armadillo kernel: Vitesse VSC8501 30bf0000.ethernet-1:00: attached PHY driver [Vitesse VSC8501] (mii_bus:phy_addr=30bf0000.ethernet-1:00, irq=-1) Nov 27 08:32:16 armadillo kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.0598] manager: (tunl0): new IPTunnel device (/org/freedesktop/NetworkManager/Devices/3) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.0755] manager: (gre0): new IPTunnel device (/org/freedesktop/NetworkManager/Devices/4) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.0902] manager: (gretap0): new Generic device (/org/freedesktop/NetworkManager/Devices/5) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1050] manager: (ip6_vti0): new Generic device (/org/freedesktop/NetworkManager/Devices/6) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1209] manager: (sit0): new IPTunnel device (/org/freedesktop/NetworkManager/Devices/7) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1355] manager: (ip6tnl0): new Generic device (/org/freedesktop/NetworkManager/Devices/8) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1501] manager: (ip6gre0): new Generic device (/org/freedesktop/NetworkManager/Devices/9) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1557] Error: failed to open /run/network/ifstate Nov 27 08:32:16 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' Nov 27 08:32:16 armadillo systemd[1]: Starting Authorization Manager... Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1766] devices added (path: /sys/devices/soc0/soc/30800000.aips-bus/30bf0000.ethernet/net/eth0, iface: eth0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1768] device added (path: /sys/devices/soc0/soc/30800000.aips-bus/30bf0000.ethernet/net/eth0, iface: eth0): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1971] devices added (path: /sys/devices/virtual/net/lo, iface: lo) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.1992] device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2056] devices added (path: /sys/devices/virtual/net/gre0, iface: gre0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2096] device added (path: /sys/devices/virtual/net/gre0, iface: gre0): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2170] devices added (path: /sys/devices/virtual/net/sit0, iface: sit0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2223] device added (path: /sys/devices/virtual/net/sit0, iface: sit0): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2280] devices added (path: /sys/devices/virtual/net/gretap0, iface: gretap0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2282] device added (path: /sys/devices/virtual/net/gretap0, iface: gretap0): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2414] devices added (path: /sys/devices/virtual/net/tunl0, iface: tunl0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2416] device added (path: /sys/devices/virtual/net/tunl0, iface: tunl0): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2457] devices added (path: /sys/devices/virtual/net/ip6_vti0, iface: ip6_vti0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2462] device added (path: /sys/devices/virtual/net/ip6_vti0, iface: ip6_vti0): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2716] devices added (path: /sys/devices/virtual/net/ip6gre0, iface: ip6gre0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2718] device added (path: /sys/devices/virtual/net/ip6gre0, iface: ip6gre0): no ifupdown configuration found. Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2795] devices added (path: /sys/devices/virtual/net/ip6tnl0, iface: ip6tnl0) Nov 27 08:32:16 armadillo NetworkManager[706]: [1606433536.2806] device added (path: /sys/devices/virtual/net/ip6tnl0, iface: ip6tnl0): no ifupdown configuration found. Nov 27 08:32:16 armadillo polkitd[1477]: started daemon version 0.105 using authority implementation `local' version `0.105' Nov 27 08:32:16 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 27 08:32:16 armadillo systemd[1]: Started Authorization Manager. Nov 27 08:32:17 armadillo systemd[1]: Started EC25 resetting configuration. Nov 27 08:32:17 armadillo systemd[1]: Starting Modem Manager... Nov 27 08:32:17 armadillo ModemManager[1484]: ModemManager (version 1.6.4) starting in system bus... Nov 27 08:32:17 armadillo NetworkManager[706]: [1606433537.9084] ModemManager disappeared from bus Nov 27 08:32:17 armadillo systemd[1]: Started Modem Manager. Nov 27 08:32:17 armadillo NetworkManager[706]: [1606433537.9805] ModemManager available in the bus Nov 27 08:32:18 armadillo kernel: usb 2-1.2: new high-speed USB device number 3 using ci_hdrc Nov 27 08:32:19 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 08:32:19 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 08:32:19 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 08:32:19 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 08:32:19 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 08:32:19 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 08:32:19 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 08:32:19 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 08:32:20 armadillo ModemManager[1484]: (ttyUSB3): port attributes not fully set Nov 27 08:32:20 armadillo ModemManager[1484]: (ttyUSB2): port attributes not fully set Nov 27 08:32:20 armadillo ModemManager[1484]: (ttyUSB1): port attributes not fully set Nov 27 08:32:20 armadillo ModemManager[1484]: (ttyUSB0): port attributes not fully set Nov 27 08:32:21 armadillo NetworkManager[706]: [1606433541.4153] manager: startup complete Nov 27 08:32:21 armadillo systemd[1]: Started Network Manager Wait Online. Nov 27 08:32:21 armadillo systemd[1]: Reached target Network is Online. Nov 27 08:32:21 armadillo systemd[1]: Starting /etc/rc.local Compatibility... Nov 27 08:32:21 armadillo rc.local[1517]: Starting addi_ini: Nov 27 08:32:21 armadillo rc.local[1517]: Starting boot_ini: Nov 27 08:32:21 armadillo rc.local[1517]: Starting 3G_ini: Nov 27 08:32:21 armadillo systemd[1]: Starting LSB: exim Mail Transport Agent... Nov 27 08:32:21 armadillo systemd[1]: Started /etc/rc.local Compatibility. Nov 27 08:32:21 armadillo systemd[1]: Started reset usb3503. Nov 27 08:32:21 armadillo systemd[1]: Started Getty on tty1. Nov 27 08:32:21 armadillo systemd[1]: Starting input event poweroff daemon... Nov 27 08:32:21 armadillo systemd[1]: Started Serial Getty on ttymxc4. Nov 27 08:32:21 armadillo systemd[1]: Reached target Login Prompts. Nov 27 08:32:21 armadillo systemd[1]: Starting change status LED... Nov 27 08:32:21 armadillo kernel: EXT4-fs (mmcblk0p1): mounting ext3 file system using the ext4 subsystem Nov 27 08:32:21 armadillo systemd[1]: Started change status LED. Nov 27 08:32:21 armadillo kernel: EXT4-fs (mmcblk0p1): warning: maximal mount count reached, running e2fsck is recommended Nov 27 08:32:21 armadillo kernel: EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null) Nov 27 08:32:22 armadillo systemd[1]: Started input event poweroff daemon. Nov 27 08:32:22 armadillo input-poweroff[1649]: start-stop-daemon: warning: failed to kill 1619: No such process Nov 27 08:32:24 armadillo exim4[1522]: Starting MTA: exim4. Nov 27 08:32:24 armadillo systemd[1]: Started LSB: exim Mail Transport Agent. Nov 27 08:32:24 armadillo systemd[1]: Reached target Multi-User System. Nov 27 08:32:24 armadillo systemd[1]: Reached target Graphical Interface. Nov 27 08:32:24 armadillo systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 27 08:32:24 armadillo systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 27 08:32:24 armadillo systemd[1]: Startup finished in 7.080s (kernel) + 17.013s (userspace) = 24.094s. Nov 27 08:32:41 armadillo ModemManager[1484]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 08:32:52 armadillo kernel: random: crng init done Nov 27 08:32:52 armadillo kernel: random: 4 urandom warning(s) missed due to ratelimiting Nov 27 08:32:54 armadillo ModemManager[1484]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 08:32:54 armadillo ModemManager[1484]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 08:32:54 armadillo ModemManager[1484]: (ttyCommModem): port attributes not fully set Nov 27 08:32:54 armadillo ModemManager[1484]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 08:32:55 armadillo ModemManager[1484]: Modem: state changed (unknown -> disabled) Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1267] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/10) Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1289] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1313] device (ttyCommModem): modem state 'enabling' Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1371] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1421] policy: auto-activating connection 'gsm-ttyCommModem' Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1518] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1544] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1557] manager: NetworkManager state is now CONNECTING Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1599] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.1801] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:32:55 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 08:32:55 armadillo ModemManager[1484]: (ttyCommModem): port attributes not fully set Nov 27 08:32:55 armadillo ModemManager[1484]: Simple connect started... Nov 27 08:32:55 armadillo ModemManager[1484]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:32:55 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 08:32:55 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 08:32:55 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 08:32:55 armadillo ModemManager[1484]: Simple connect state (5/8): Register Nov 27 08:32:55 armadillo ModemManager[1484]: Simple connect state (6/8): Bearer Nov 27 08:32:55 armadillo ModemManager[1484]: Simple connect state (7/8): Connect Nov 27 08:32:55 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:32:55 armadillo ModemManager[1484]: (ttyUSB3): port attributes not fully set Nov 27 08:32:55 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:32:55 armadillo ModemManager[1484]: Simple connect state (8/8): All done Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8678] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8689] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8705] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8718] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8719] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8776] loaded PPP plugin /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-ppp-plugin.so Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8806] ppp-manager: starting PPP connection Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.8889] ppp-manager: pppd started with pid 1851 Nov 27 08:32:55 armadillo pppd[1851]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:32:55 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:32:55 armadillo pppd[1851]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:32:55 armadillo pppd[1851]: pppd 2.4.7 started by root, uid 0 Nov 27 08:32:55 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:32:55 armadillo pppd[1851]: Using interface ppp0 Nov 27 08:32:55 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:32:55 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:32:55 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:32:55 armadillo pppd[1851]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:32:55 armadillo NetworkManager[706]: [1606433575.9552] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/11) Nov 27 08:32:55 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:32:55 armadillo pppd[1851]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:32:55 armadillo pppd[1851]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:32:55 armadillo pppd[1851]: CHAP authentication succeeded Nov 27 08:32:55 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:32:55 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:32:55 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:32:56 armadillo pppd[1851]: CHAP authentication succeeded Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.0203] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.0205] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:32:56 armadillo pppd[1851]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:32:56 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:32:56 armadillo pppd[1851]: local IP address ***.***.***.*** Nov 27 08:32:56 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 08:32:56 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 08:32:56 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 08:32:56 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 08:32:56 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 08:32:56 armadillo pppd[1851]: remote IP address 10.64.64.64 Nov 27 08:32:56 armadillo pppd[1851]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 08:32:56 armadillo pppd[1851]: primary DNS address 59.190.146.81 Nov 27 08:32:56 armadillo pppd[1851]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 08:32:56 armadillo pppd[1851]: secondary DNS address 59.190.147.17 Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.0536] ppp-manager: (IPv4 Config Get) reply received. Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.0959] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.1006] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.1090] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.1106] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 08:32:56 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:32:56 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.1281] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.1338] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 08:32:56 armadillo NetworkManager[706]: [1606433576.1376] device (ttyCommModem): Activation: successful, device activated. Nov 27 08:32:56 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:32:56 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:32:56 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:32:56 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:32:56 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 08:32:56 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 08:32:56 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 08:32:56 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 08:33:05 armadillo systemd[1]: Time has been changed Nov 27 08:33:05 armadillo systemd[1]: apt-daily.timer: Adding 1h 25min 971.210ms random time. Nov 27 08:33:05 armadillo systemd[1]: apt-daily-upgrade.timer: Adding 17min 37.594981s random time. Nov 27 08:33:05 armadillo ntpdate[1912]: step time server 133.243.238.243 offset -1.006320 sec Nov 27 08:33:10 armadillo systemd-timesyncd[434]: Synchronized to time server 129.250.35.251:123 (0.debian.pool.ntp.org). Nov 27 08:33:26 armadillo pppd[1851]: IPV6CP: timeout sending Config-Requests Nov 27 08:33:26 armadillo NetworkManager[706]: IPV6CP: timeout sending Config-Requests Nov 27 08:35:35 armadillo systemd[1]: Created slice User Slice of root. Nov 27 08:35:35 armadillo systemd[1]: Starting User Manager for UID 0... Nov 27 08:35:35 armadillo systemd[1]: Started Session c1 of user root. Nov 27 08:35:35 armadillo systemd[1947]: Reached target Paths. Nov 27 08:35:35 armadillo systemd[1947]: Listening on GnuPG network certificate management daemon. Nov 27 08:35:35 armadillo systemd[1947]: Listening on GnuPG cryptographic agent and passphrase cache. Nov 27 08:35:36 armadillo systemd[1947]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Nov 27 08:35:36 armadillo systemd[1947]: Listening on GnuPG cryptographic agent (access for web browsers). Nov 27 08:35:36 armadillo systemd[1947]: Reached target Timers. Nov 27 08:35:36 armadillo systemd[1947]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Nov 27 08:35:36 armadillo systemd[1947]: Reached target Sockets. Nov 27 08:35:36 armadillo systemd[1947]: Reached target Basic System. Nov 27 08:35:36 armadillo systemd[1947]: Reached target Default. Nov 27 08:35:36 armadillo systemd[1947]: Startup finished in 121ms. Nov 27 08:35:36 armadillo systemd[1]: Started User Manager for UID 0. Nov 27 08:36:24 armadillo connection-recover: ttyCommModem ping fail Nov 27 08:36:24 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 08:36:24 armadillo NetworkManager[706]: [1606433784.5540] device (ttyCommModem): state change: activated -> deactivating (reason 'user-requested') [100 110 39] Nov 27 08:36:24 armadillo NetworkManager[706]: [1606433784.5557] manager: NetworkManager state is now DISCONNECTING Nov 27 08:36:24 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:36:24 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:36:24 armadillo NetworkManager[706]: [1606433784.5891] audit: failed to open auditd socket: Protocol not supported Nov 27 08:36:24 armadillo NetworkManager[706]: [1606433784.5894] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=2079 uid=0 result="success" Nov 27 08:36:24 armadillo pppd[1851]: Terminating on signal 15 Nov 27 08:36:24 armadillo NetworkManager[706]: Terminating on signal 15 Nov 27 08:36:24 armadillo NetworkManager[706]: Connect time 3.5 minutes. Nov 27 08:36:24 armadillo NetworkManager[706]: Sent 6733 bytes, received 7640 bytes. Nov 27 08:36:24 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate' Nov 27 08:36:24 armadillo pppd[1851]: Connect time 3.5 minutes. Nov 27 08:36:24 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:36:24 armadillo pppd[1851]: Sent 6733 bytes, received 7640 bytes. Nov 27 08:36:24 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:36:24 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 08:36:24 armadillo NetworkManager[706]: Connection terminated. Nov 27 08:36:24 armadillo pppd[1851]: Connection terminated. Nov 27 08:36:24 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:36:24 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:36:24 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:36:24 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:36:24 armadillo NetworkManager[706]: [1606433784.8329] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:36:24 armadillo pppd[1851]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 08:36:24 armadillo pppd[1851]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 08:36:24 armadillo pppd[1851]: Exit. Nov 27 08:36:24 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 08:36:25 armadillo ModemManager[1484]: (ttyUSB3): port attributes not fully set Nov 27 08:36:26 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 08:36:26 armadillo NetworkManager[706]: [1606433786.9460] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 08:36:26 armadillo NetworkManager[706]: [1606433786.9516] manager: NetworkManager state is now DISCONNECTED Nov 27 08:36:26 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: new request (2 scripts) Nov 27 08:36:26 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: start running ordered scripts... Nov 27 08:36:32 armadillo NetworkManager[706]: [1606433792.1656] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:36:32 armadillo NetworkManager[706]: [1606433792.1670] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=2157 uid=0 result="success" Nov 27 08:36:32 armadillo NetworkManager[706]: [1606433792.1690] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:36:32 armadillo NetworkManager[706]: [1606433792.1704] manager: NetworkManager state is now CONNECTING Nov 27 08:36:32 armadillo NetworkManager[706]: [1606433792.1738] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:36:32 armadillo NetworkManager[706]: [1606433792.2037] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:36:32 armadillo ModemManager[1484]: Simple connect started... Nov 27 08:36:32 armadillo ModemManager[1484]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:36:32 armadillo ModemManager[1484]: Simple connect state (5/8): Register Nov 27 08:36:32 armadillo ModemManager[1484]: Simple connect state (6/8): Bearer Nov 27 08:36:32 armadillo ModemManager[1484]: Simple connect state (7/8): Connect Nov 27 08:36:32 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:36:32 armadillo ModemManager[1484]: (ttyUSB3): port attributes not fully set Nov 27 08:36:54 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Nov 27 08:36:54 armadillo NetworkManager[706]: [1606433814.8137] modem-broadband[ttyCommModem]: failed to connect modem: 0,-1 Nov 27 08:36:54 armadillo NetworkManager[706]: [1606433814.8139] device (ttyCommModem): state change: prepare -> failed (reason 'modem-no-carrier') [40 120 25] Nov 27 08:36:54 armadillo NetworkManager[706]: [1606433814.8149] manager: NetworkManager state is now DISCONNECTED Nov 27 08:36:54 armadillo NetworkManager[706]: [1606433814.8185] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 08:36:54 armadillo NetworkManager[706]: [1606433814.8237] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 08:36:54 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 08:38:55 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.5428] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.5467] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=2187 uid=0 result="success" Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.5524] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.5560] manager: NetworkManager state is now CONNECTING Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.5613] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.5940] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:39:00 armadillo ModemManager[1484]: Simple connect started... Nov 27 08:39:00 armadillo ModemManager[1484]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:39:00 armadillo ModemManager[1484]: Simple connect state (5/8): Register Nov 27 08:39:00 armadillo ModemManager[1484]: Simple connect state (6/8): Bearer Nov 27 08:39:00 armadillo ModemManager[1484]: Simple connect state (7/8): Connect Nov 27 08:39:00 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:39:00 armadillo ModemManager[1484]: (ttyUSB3): port attributes not fully set Nov 27 08:39:00 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:39:00 armadillo ModemManager[1484]: Simple connect state (8/8): All done Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.6832] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.6843] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.6860] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.6918] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.6920] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.6934] ppp-manager: starting PPP connection Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.7007] ppp-manager: pppd started with pid 2193 Nov 27 08:39:00 armadillo pppd[2193]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:39:00 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:39:00 armadillo pppd[2193]: pppd 2.4.7 started by root, uid 0 Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:39:00 armadillo pppd[2193]: Using interface ppp0 Nov 27 08:39:00 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:39:00 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:39:00 armadillo pppd[2193]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.7587] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/12) Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:39:00 armadillo pppd[2193]: CHAP authentication succeeded Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:39:00 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:39:00 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:39:00 armadillo pppd[2193]: CHAP authentication succeeded Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.8436] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.8461] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:39:00 armadillo pppd[2193]: Modem hangup Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:39:00 armadillo NetworkManager[706]: Modem hangup Nov 27 08:39:00 armadillo NetworkManager[706]: Connection terminated. Nov 27 08:39:00 armadillo pppd[2193]: Connection terminated. Nov 27 08:39:00 armadillo pppd[2193]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.8924] device (ttyCommModem): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5] Nov 27 08:39:00 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.8941] manager: NetworkManager state is now DISCONNECTED Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9117] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9582] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9661] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9693] policy: auto-activating connection 'gsm-ttyCommModem' Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9772] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9793] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9803] manager: NetworkManager state is now CONNECTING Nov 27 08:39:00 armadillo NetworkManager[706]: [1606433940.9836] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:39:00 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 08:39:01 armadillo connection-recover: exec wwan-force-restart Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.0070] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:39:01 armadillo ModemManager[1484]: Simple connect started... Nov 27 08:39:01 armadillo ModemManager[1484]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:39:01 armadillo /usr/bin/wwan-force-restart: start force restart ec25 Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.5262] device (ttyCommModem): state change: prepare -> deactivating (reason 'user-requested') [40 110 39] Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.5275] manager: NetworkManager state is now DISCONNECTING Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.5286] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=2225 uid=0 result="success" Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.5455] device (ttyCommModem): Deactivation failed: GDBus.Error:org.freedesktop.ModemManager1.Error.Core.InProgress: Bearer already being disconnected Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.5458] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.5481] manager: NetworkManager state is now DISCONNECTED Nov 27 08:39:01 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:39:01 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:39:01 armadillo ModemManager[1484]: Caught signal, shutting down... Nov 27 08:39:01 armadillo systemd[1]: Stopping Modem Manager... Nov 27 08:39:01 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:39:01 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:39:01 armadillo nm-dispatcher: req:1 'down' [ttyCommModem]: new request (2 scripts) Nov 27 08:39:01 armadillo nm-dispatcher: req:1 'down' [ttyCommModem]: start running ordered scripts... Nov 27 08:39:01 armadillo pppd[2193]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 08:39:01 armadillo ModemManager[1484]: (ttyUSB3): port attributes not fully set Nov 27 08:39:01 armadillo [2193]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 08:39:01 armadillo pppd[2193]: Exit. Nov 27 08:39:01 armadillo NetworkManager[706]: [1606433941.9400] ppp-manager: pppd pid 2193 exited with error: A modem hung up the phone Nov 27 08:39:02 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 08:39:02 armadillo ModemManager[1484]: Simple connect state (5/8): Register Nov 27 08:39:02 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) Nov 27 08:39:02 armadillo ModemManager[1484]: Simple connect state (6/8): Bearer Nov 27 08:39:02 armadillo ModemManager[1484]: Simple connect state (7/8): Connect Nov 27 08:39:02 armadillo ModemManager[1484]: (ttyUSB3): port attributes not fully set Nov 27 08:39:03 armadillo ModemManager[1484]: Simple connect state (8/8): All done Nov 27 08:39:03 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) Nov 27 08:39:03 armadillo ModemManager[1484]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) Nov 27 08:39:03 armadillo NetworkManager[706]: [1606433943.1108] ModemManager disappeared from bus Nov 27 08:39:03 armadillo NetworkManager[706]: [1606433943.1110] device (ttyCommModem): state change: disconnected -> unmanaged (reason 'removed') [30 10 36] Nov 27 08:39:03 armadillo ModemManager[1484]: ModemManager is shut down Nov 27 08:39:03 armadillo systemd[1]: Stopped Modem Manager. Nov 27 08:39:17 armadillo kernel: usb 2-1.2: USB disconnect, device number 3 Nov 27 08:39:17 armadillo kernel: option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 27 08:39:17 armadillo kernel: option 2-1.2:1.0: device disconnected Nov 27 08:39:17 armadillo kernel: option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 27 08:39:17 armadillo kernel: option 2-1.2:1.1: device disconnected Nov 27 08:39:17 armadillo kernel: option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Nov 27 08:39:18 armadillo kernel: option 2-1.2:1.2: device disconnected Nov 27 08:39:18 armadillo kernel: option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Nov 27 08:39:18 armadillo kernel: option 2-1.2:1.3: device disconnected Nov 27 08:39:19 armadillo systemd[1]: Starting Modem Manager... Nov 27 08:39:19 armadillo ModemManager[2333]: ModemManager (version 1.6.4) starting in system bus... Nov 27 08:39:19 armadillo NetworkManager[706]: [1606433959.7131] ModemManager disappeared from bus Nov 27 08:39:19 armadillo systemd[1]: Started Modem Manager. Nov 27 08:39:19 armadillo NetworkManager[706]: [1606433959.8010] ModemManager available in the bus Nov 27 08:39:21 armadillo NetworkManager[706]: [1606433961.4070] ppp-manager: pppd timed out or didn't initialize our dbus module Nov 27 08:39:21 armadillo NetworkManager[706]: instance with invalid (NULL) class pointer Nov 27 08:39:21 armadillo NetworkManager[706]: g_signal_emit_valist: assertion 'G_TYPE_CHECK_INSTANCE (instance)' failed Nov 27 08:39:32 armadillo kernel: usb 2-1.2: new high-speed USB device number 4 using ci_hdrc Nov 27 08:39:32 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 08:39:32 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 08:39:32 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 08:39:32 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 08:39:32 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 08:39:32 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 08:39:32 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 08:39:32 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 08:39:33 armadillo ModemManager[2333]: (ttyUSB2): port attributes not fully set Nov 27 08:39:33 armadillo ModemManager[2333]: (ttyUSB1): port attributes not fully set Nov 27 08:39:33 armadillo ModemManager[2333]: (ttyUSB0): port attributes not fully set Nov 27 08:39:33 armadillo ModemManager[2333]: (ttyUSB3): port attributes not fully set Nov 27 08:39:52 armadillo ModemManager[2333]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 08:40:04 armadillo ModemManager[2333]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 08:40:04 armadillo ModemManager[2333]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 08:40:04 armadillo ModemManager[2333]: (ttyCommModem): port attributes not fully set Nov 27 08:40:04 armadillo ModemManager[2333]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 08:40:05 armadillo ModemManager[2333]: Modem: state changed (unknown -> disabled) Nov 27 08:40:05 armadillo NetworkManager[706]: [1606434005.1147] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/13) Nov 27 08:40:05 armadillo NetworkManager[706]: [1606434005.1186] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:40:05 armadillo NetworkManager[706]: [1606434005.1225] device (ttyCommModem): modem state 'enabling' Nov 27 08:40:05 armadillo NetworkManager[706]: [1606434005.1298] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 08:40:05 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 08:40:05 armadillo ModemManager[2333]: (ttyCommModem): port attributes not fully set Nov 27 08:40:05 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 08:40:05 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 08:40:05 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.1821] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.1831] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=2580 uid=0 result="success" Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.1845] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.1856] manager: NetworkManager state is now CONNECTING Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.1886] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.2276] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:40:06 armadillo ModemManager[2333]: Simple connect started... Nov 27 08:40:06 armadillo ModemManager[2333]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:40:06 armadillo ModemManager[2333]: Simple connect state (5/8): Register Nov 27 08:40:06 armadillo ModemManager[2333]: Simple connect state (6/8): Bearer Nov 27 08:40:06 armadillo ModemManager[2333]: Simple connect state (7/8): Connect Nov 27 08:40:06 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:40:06 armadillo ModemManager[2333]: (ttyUSB3): port attributes not fully set Nov 27 08:40:06 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:40:06 armadillo ModemManager[2333]: Simple connect state (8/8): All done Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3208] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3219] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3234] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3241] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3242] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3255] ppp-manager: starting PPP connection Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3322] ppp-manager: pppd started with pid 2586 Nov 27 08:40:06 armadillo pppd[2586]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:40:06 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:40:06 armadillo pppd[2586]: pppd 2.4.7 started by root, uid 0 Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.3917] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/14) Nov 27 08:40:06 armadillo pppd[2586]: Using interface ppp0 Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:40:06 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:40:06 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:40:06 armadillo pppd[2586]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:40:06 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:40:06 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:40:06 armadillo pppd[2586]: CHAP authentication succeeded Nov 27 08:40:06 armadillo pppd[2586]: CHAP authentication succeeded Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.4751] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.4753] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:40:06 armadillo pppd[2586]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 08:40:06 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:40:06 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 08:40:06 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 08:40:06 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 08:40:06 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 08:40:06 armadillo pppd[2586]: local IP address ***.***.***.*** Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 08:40:06 armadillo pppd[2586]: remote IP address 10.64.64.64 Nov 27 08:40:06 armadillo pppd[2586]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 08:40:06 armadillo pppd[2586]: primary DNS address 59.190.146.81 Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.5061] ppp-manager: (IPv4 Config Get) reply received. Nov 27 08:40:06 armadillo pppd[2586]: secondary DNS address 59.190.147.17 Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.5422] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.5514] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.5564] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.5597] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 08:40:06 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:40:06 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.5959] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.5988] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 08:40:06 armadillo NetworkManager[706]: [1606434006.6089] device (ttyCommModem): Activation: successful, device activated. Nov 27 08:40:06 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:40:06 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:40:06 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:40:06 armadillo /usr/bin/wwan-force-restart: end force restart ec25 Nov 27 08:40:06 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:40:06 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 08:40:06 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 08:40:06 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 08:40:07 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 08:40:18 armadillo ntpdate[2649]: adjust time server 133.243.238.243 offset -0.001023 sec Nov 27 08:40:36 armadillo pppd[2586]: IPV6CP: timeout sending Config-Requests Nov 27 08:40:36 armadillo NetworkManager[706]: IPV6CP: timeout sending Config-Requests Nov 27 08:42:17 armadillo connection-recover: ttyCommModem ping fail Nov 27 08:42:17 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 08:42:17 armadillo NetworkManager[706]: [1606434137.2351] device (ttyCommModem): state change: activated -> deactivating (reason 'user-requested') [100 110 39] Nov 27 08:42:17 armadillo NetworkManager[706]: [1606434137.2381] manager: NetworkManager state is now DISCONNECTING Nov 27 08:42:17 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:42:17 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:42:17 armadillo NetworkManager[706]: [1606434137.2676] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=2681 uid=0 result="success" Nov 27 08:42:17 armadillo pppd[2586]: Terminating on signal 15 Nov 27 08:42:17 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate' Nov 27 08:42:17 armadillo NetworkManager[706]: Terminating on signal 15 Nov 27 08:42:17 armadillo NetworkManager[706]: Connect time 2.2 minutes. Nov 27 08:42:17 armadillo NetworkManager[706]: Sent 5977 bytes, received 6249 bytes. Nov 27 08:42:17 armadillo pppd[2586]: Connect time 2.2 minutes. Nov 27 08:42:17 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:42:17 armadillo pppd[2586]: Sent 5977 bytes, received 6249 bytes. Nov 27 08:42:17 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:42:17 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 08:42:17 armadillo pppd[2586]: Connection terminated. Nov 27 08:42:17 armadillo NetworkManager[706]: Connection terminated. Nov 27 08:42:17 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:42:17 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:42:17 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:42:17 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:42:17 armadillo NetworkManager[706]: [1606434137.3778] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:42:17 armadillo pppd[2586]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 08:42:17 armadillo pppd[2586]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 08:42:17 armadillo pppd[2586]: Exit. Nov 27 08:42:17 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 08:42:18 armadillo ModemManager[2333]: (ttyUSB3): port attributes not fully set Nov 27 08:42:19 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 08:42:19 armadillo NetworkManager[706]: [1606434139.4635] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 08:42:19 armadillo NetworkManager[706]: [1606434139.4672] manager: NetworkManager state is now DISCONNECTED Nov 27 08:42:19 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: new request (2 scripts) Nov 27 08:42:19 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: start running ordered scripts... Nov 27 08:42:24 armadillo NetworkManager[706]: [1606434144.6763] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:42:24 armadillo NetworkManager[706]: [1606434144.6773] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=2711 uid=0 result="success" Nov 27 08:42:24 armadillo NetworkManager[706]: [1606434144.6787] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:42:24 armadillo NetworkManager[706]: [1606434144.6797] manager: NetworkManager state is now CONNECTING Nov 27 08:42:24 armadillo NetworkManager[706]: [1606434144.6827] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:42:24 armadillo NetworkManager[706]: [1606434144.7025] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:42:24 armadillo ModemManager[2333]: Simple connect started... Nov 27 08:42:24 armadillo ModemManager[2333]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:42:24 armadillo ModemManager[2333]: Simple connect state (5/8): Register Nov 27 08:42:24 armadillo ModemManager[2333]: Simple connect state (6/8): Bearer Nov 27 08:42:24 armadillo ModemManager[2333]: Simple connect state (7/8): Connect Nov 27 08:42:24 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:42:24 armadillo ModemManager[2333]: (ttyUSB3): port attributes not fully set Nov 27 08:42:47 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Nov 27 08:42:47 armadillo NetworkManager[706]: [1606434167.3750] modem-broadband[ttyCommModem]: failed to connect modem: 0,-1 Nov 27 08:42:47 armadillo NetworkManager[706]: [1606434167.3752] device (ttyCommModem): state change: prepare -> failed (reason 'modem-no-carrier') [40 120 25] Nov 27 08:42:47 armadillo NetworkManager[706]: [1606434167.3760] manager: NetworkManager state is now DISCONNECTED Nov 27 08:42:47 armadillo NetworkManager[706]: [1606434167.3806] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 08:42:47 armadillo NetworkManager[706]: [1606434167.3855] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 08:42:47 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 08:42:47 armadillo connection-recover: exec wwan-force-restart Nov 27 08:42:47 armadillo /usr/bin/wwan-force-restart: start force restart ec25 Nov 27 08:42:47 armadillo ModemManager[2333]: Caught signal, shutting down... Nov 27 08:42:47 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) Nov 27 08:42:47 armadillo systemd[1]: Stopping Modem Manager... Nov 27 08:42:48 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) Nov 27 08:42:48 armadillo ModemManager[2333]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) Nov 27 08:42:48 armadillo NetworkManager[706]: [1606434168.0853] ModemManager disappeared from bus Nov 27 08:42:48 armadillo NetworkManager[706]: [1606434168.0856] device (ttyCommModem): state change: disconnected -> unmanaged (reason 'removed') [30 10 36] Nov 27 08:42:48 armadillo ModemManager[2333]: ModemManager is shut down Nov 27 08:42:48 armadillo systemd[1]: Stopped Modem Manager. Nov 27 08:43:02 armadillo kernel: usb 2-1.2: USB disconnect, device number 4 Nov 27 08:43:02 armadillo kernel: option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 27 08:43:02 armadillo kernel: option 2-1.2:1.0: device disconnected Nov 27 08:43:02 armadillo kernel: option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 27 08:43:02 armadillo kernel: option 2-1.2:1.1: device disconnected Nov 27 08:43:02 armadillo kernel: option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Nov 27 08:43:02 armadillo kernel: option 2-1.2:1.2: device disconnected Nov 27 08:43:02 armadillo kernel: option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Nov 27 08:43:02 armadillo kernel: option 2-1.2:1.3: device disconnected Nov 27 08:43:04 armadillo systemd[1]: Starting Modem Manager... Nov 27 08:43:04 armadillo ModemManager[2826]: ModemManager (version 1.6.4) starting in system bus... Nov 27 08:43:04 armadillo systemd[1]: Started Modem Manager. Nov 27 08:43:04 armadillo NetworkManager[706]: [1606434184.5231] ModemManager disappeared from bus Nov 27 08:43:04 armadillo NetworkManager[706]: [1606434184.6226] ModemManager available in the bus Nov 27 08:43:16 armadillo kernel: usb 2-1.2: new high-speed USB device number 5 using ci_hdrc Nov 27 08:43:17 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 08:43:17 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 08:43:17 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 08:43:17 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 08:43:17 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 08:43:17 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 08:43:17 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 08:43:17 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 08:43:18 armadillo ModemManager[2826]: (ttyUSB2): port attributes not fully set Nov 27 08:43:18 armadillo ModemManager[2826]: (ttyUSB1): port attributes not fully set Nov 27 08:43:18 armadillo ModemManager[2826]: (ttyUSB3): port attributes not fully set Nov 27 08:43:18 armadillo ModemManager[2826]: (ttyUSB0): port attributes not fully set Nov 27 08:43:39 armadillo ModemManager[2826]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 08:43:51 armadillo ModemManager[2826]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 08:43:51 armadillo ModemManager[2826]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 08:43:51 armadillo ModemManager[2826]: (ttyCommModem): port attributes not fully set Nov 27 08:43:51 armadillo ModemManager[2826]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 08:43:52 armadillo ModemManager[2826]: Modem: state changed (unknown -> disabled) Nov 27 08:43:52 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 08:43:52 armadillo ModemManager[2826]: (ttyCommModem): port attributes not fully set Nov 27 08:43:52 armadillo NetworkManager[706]: [1606434232.1395] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/15) Nov 27 08:43:52 armadillo NetworkManager[706]: [1606434232.1423] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:43:52 armadillo NetworkManager[706]: [1606434232.1454] device (ttyCommModem): modem state 'enabling' Nov 27 08:43:52 armadillo NetworkManager[706]: [1606434232.1780] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 08:43:52 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 08:43:52 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 08:43:52 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.5066] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.5106] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=3083 uid=0 result="success" Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.5138] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.5167] manager: NetworkManager state is now CONNECTING Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.5212] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.5522] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:43:53 armadillo ModemManager[2826]: Simple connect started... Nov 27 08:43:53 armadillo ModemManager[2826]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:43:53 armadillo ModemManager[2826]: Simple connect state (5/8): Register Nov 27 08:43:53 armadillo ModemManager[2826]: Simple connect state (6/8): Bearer Nov 27 08:43:53 armadillo ModemManager[2826]: Simple connect state (7/8): Connect Nov 27 08:43:53 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:43:53 armadillo ModemManager[2826]: (ttyUSB3): port attributes not fully set Nov 27 08:43:53 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:43:53 armadillo ModemManager[2826]: Simple connect state (8/8): All done Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.6395] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.6407] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.6423] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.6429] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.6430] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.6442] ppp-manager: starting PPP connection Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.6549] ppp-manager: pppd started with pid 3089 Nov 27 08:43:53 armadillo pppd[3089]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:43:53 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:43:53 armadillo pppd[3089]: pppd 2.4.7 started by root, uid 0 Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:43:53 armadillo pppd[3089]: Using interface ppp0 Nov 27 08:43:53 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:43:53 armadillo pppd[3089]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:43:53 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.7277] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/16) Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.7933] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.7934] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:43:53 armadillo pppd[3089]: CHAP authentication succeeded Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:43:53 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:43:53 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:43:53 armadillo pppd[3089]: CHAP authentication succeeded Nov 27 08:43:53 armadillo pppd[3089]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:43:53 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:43:53 armadillo pppd[3089]: local IP address ***.***.***.*** Nov 27 08:43:53 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 08:43:53 armadillo pppd[3089]: remote IP address 10.64.64.64 Nov 27 08:43:53 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 08:43:53 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 08:43:53 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 08:43:53 armadillo pppd[3089]: primary DNS address 59.190.146.81 Nov 27 08:43:53 armadillo pppd[3089]: secondary DNS address 59.190.147.17 Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 08:43:53 armadillo pppd[3089]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.8809] ppp-manager: (IPv4 Config Get) reply received. Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.9191] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.9279] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.9352] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.9375] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 08:43:53 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:43:53 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.9663] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.9681] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 08:43:53 armadillo NetworkManager[706]: [1606434233.9718] device (ttyCommModem): Activation: successful, device activated. Nov 27 08:43:54 armadillo /usr/bin/wwan-force-restart: end force restart ec25 Nov 27 08:43:54 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:43:54 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:43:54 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:43:54 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:43:54 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 08:43:54 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 08:43:54 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 08:43:54 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 08:44:04 armadillo ntpdate[3151]: adjust time server 133.243.238.243 offset -0.002414 sec Nov 27 08:44:23 armadillo pppd[3089]: IPV6CP: timeout sending Config-Requests Nov 27 08:44:23 armadillo NetworkManager[706]: IPV6CP: timeout sending Config-Requests Nov 27 08:46:04 armadillo connection-recover: ttyCommModem ping fail Nov 27 08:46:04 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 08:46:04 armadillo NetworkManager[706]: [1606434364.5495] device (ttyCommModem): state change: activated -> deactivating (reason 'user-requested') [100 110 39] Nov 27 08:46:04 armadillo NetworkManager[706]: [1606434364.5529] manager: NetworkManager state is now DISCONNECTING Nov 27 08:46:04 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:46:04 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:46:04 armadillo NetworkManager[706]: [1606434364.5724] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=3182 uid=0 result="success" Nov 27 08:46:04 armadillo pppd[3089]: Terminating on signal 15 Nov 27 08:46:04 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate' Nov 27 08:46:04 armadillo NetworkManager[706]: Terminating on signal 15 Nov 27 08:46:04 armadillo NetworkManager[706]: Connect time 2.2 minutes. Nov 27 08:46:04 armadillo NetworkManager[706]: Sent 5977 bytes, received 6373 bytes. Nov 27 08:46:04 armadillo pppd[3089]: Connect time 2.2 minutes. Nov 27 08:46:04 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:46:04 armadillo pppd[3089]: Sent 5977 bytes, received 6373 bytes. Nov 27 08:46:04 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:46:04 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 08:46:04 armadillo NetworkManager[706]: Connection terminated. Nov 27 08:46:04 armadillo pppd[3089]: Connection terminated. Nov 27 08:46:04 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:46:04 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:46:04 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:46:04 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:46:04 armadillo NetworkManager[706]: [1606434364.6796] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:46:04 armadillo pppd[3089]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 08:46:04 armadillo pppd[3089]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 08:46:04 armadillo pppd[3089]: Exit. Nov 27 08:46:04 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 08:46:05 armadillo ModemManager[2826]: (ttyUSB3): port attributes not fully set Nov 27 08:46:06 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 08:46:06 armadillo NetworkManager[706]: [1606434366.7716] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 08:46:06 armadillo NetworkManager[706]: [1606434366.7752] manager: NetworkManager state is now DISCONNECTED Nov 27 08:46:06 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: new request (2 scripts) Nov 27 08:46:06 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: start running ordered scripts... Nov 27 08:46:11 armadillo NetworkManager[706]: [1606434371.9824] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:46:11 armadillo NetworkManager[706]: [1606434371.9864] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=3212 uid=0 result="success" Nov 27 08:46:11 armadillo NetworkManager[706]: [1606434371.9900] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:46:11 armadillo NetworkManager[706]: [1606434371.9917] manager: NetworkManager state is now CONNECTING Nov 27 08:46:11 armadillo NetworkManager[706]: [1606434371.9968] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:46:12 armadillo NetworkManager[706]: [1606434372.0328] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:46:12 armadillo ModemManager[2826]: Simple connect started... Nov 27 08:46:12 armadillo ModemManager[2826]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:46:12 armadillo ModemManager[2826]: Simple connect state (5/8): Register Nov 27 08:46:12 armadillo ModemManager[2826]: Simple connect state (6/8): Bearer Nov 27 08:46:12 armadillo ModemManager[2826]: Simple connect state (7/8): Connect Nov 27 08:46:12 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:46:12 armadillo ModemManager[2826]: (ttyUSB3): port attributes not fully set Nov 27 08:46:34 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Nov 27 08:46:34 armadillo NetworkManager[706]: [1606434394.6831] modem-broadband[ttyCommModem]: failed to connect modem: 0,-1 Nov 27 08:46:34 armadillo NetworkManager[706]: [1606434394.6832] device (ttyCommModem): state change: prepare -> failed (reason 'modem-no-carrier') [40 120 25] Nov 27 08:46:34 armadillo NetworkManager[706]: [1606434394.6841] manager: NetworkManager state is now DISCONNECTED Nov 27 08:46:34 armadillo NetworkManager[706]: [1606434394.6877] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 08:46:34 armadillo NetworkManager[706]: [1606434394.6911] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 08:46:34 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 08:46:34 armadillo connection-recover: exec wwan-force-restart Nov 27 08:46:34 armadillo /usr/bin/wwan-force-restart: start force restart ec25 Nov 27 08:46:35 armadillo ModemManager[2826]: Caught signal, shutting down... Nov 27 08:46:35 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) Nov 27 08:46:35 armadillo systemd[1]: Stopping Modem Manager... Nov 27 08:46:35 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) Nov 27 08:46:35 armadillo ModemManager[2826]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) Nov 27 08:46:35 armadillo NetworkManager[706]: [1606434395.3853] ModemManager disappeared from bus Nov 27 08:46:35 armadillo NetworkManager[706]: [1606434395.3855] device (ttyCommModem): state change: disconnected -> unmanaged (reason 'removed') [30 10 36] Nov 27 08:46:35 armadillo ModemManager[2826]: ModemManager is shut down Nov 27 08:46:35 armadillo systemd[1]: Stopped Modem Manager. Nov 27 08:46:50 armadillo kernel: usb 2-1.2: USB disconnect, device number 5 Nov 27 08:46:50 armadillo kernel: option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 27 08:46:50 armadillo kernel: option 2-1.2:1.0: device disconnected Nov 27 08:46:50 armadillo kernel: option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 27 08:46:50 armadillo kernel: option 2-1.2:1.1: device disconnected Nov 27 08:46:50 armadillo kernel: option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Nov 27 08:46:50 armadillo kernel: option 2-1.2:1.2: device disconnected Nov 27 08:46:50 armadillo kernel: option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Nov 27 08:46:50 armadillo kernel: option 2-1.2:1.3: device disconnected Nov 27 08:46:51 armadillo systemd[1]: Starting Modem Manager... Nov 27 08:46:51 armadillo ModemManager[3326]: ModemManager (version 1.6.4) starting in system bus... Nov 27 08:46:51 armadillo NetworkManager[706]: [1606434411.9592] ModemManager disappeared from bus Nov 27 08:46:51 armadillo systemd[1]: Started Modem Manager. Nov 27 08:46:52 armadillo NetworkManager[706]: [1606434412.0585] ModemManager available in the bus Nov 27 08:47:04 armadillo kernel: usb 2-1.2: new high-speed USB device number 6 using ci_hdrc Nov 27 08:47:04 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 08:47:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 08:47:04 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 08:47:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 08:47:04 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 08:47:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 08:47:04 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 08:47:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 08:47:04 armadillo systemd[1]: Starting Cleanup of Temporary Directories... Nov 27 08:47:04 armadillo systemd[1]: Started Cleanup of Temporary Directories. Nov 27 08:47:06 armadillo ModemManager[3326]: (ttyUSB2): port attributes not fully set Nov 27 08:47:06 armadillo ModemManager[3326]: (ttyUSB1): port attributes not fully set Nov 27 08:47:06 armadillo ModemManager[3326]: (ttyUSB3): port attributes not fully set Nov 27 08:47:06 armadillo ModemManager[3326]: (ttyUSB0): port attributes not fully set Nov 27 08:47:35 armadillo ModemManager[3326]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 08:47:42 armadillo ModemManager[3326]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 08:47:42 armadillo ModemManager[3326]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 08:47:42 armadillo ModemManager[3326]: (ttyCommModem): port attributes not fully set Nov 27 08:47:42 armadillo ModemManager[3326]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 08:47:43 armadillo ModemManager[3326]: Modem: state changed (unknown -> disabled) Nov 27 08:47:43 armadillo NetworkManager[706]: [1606434463.1450] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/17) Nov 27 08:47:43 armadillo NetworkManager[706]: [1606434463.1469] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:47:43 armadillo NetworkManager[706]: [1606434463.1487] device (ttyCommModem): modem state 'enabling' Nov 27 08:47:43 armadillo NetworkManager[706]: [1606434463.1516] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 08:47:43 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 08:47:43 armadillo ModemManager[3326]: (ttyCommModem): port attributes not fully set Nov 27 08:47:43 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 08:47:43 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 08:47:43 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.2130] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.2153] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=3605 uid=0 result="success" Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.2163] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.2170] manager: NetworkManager state is now CONNECTING Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.2197] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.2494] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:47:44 armadillo ModemManager[3326]: Simple connect started... Nov 27 08:47:44 armadillo ModemManager[3326]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:47:44 armadillo ModemManager[3326]: Simple connect state (5/8): Register Nov 27 08:47:44 armadillo ModemManager[3326]: Simple connect state (6/8): Bearer Nov 27 08:47:44 armadillo ModemManager[3326]: Simple connect state (7/8): Connect Nov 27 08:47:44 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:47:44 armadillo ModemManager[3326]: (ttyUSB3): port attributes not fully set Nov 27 08:47:44 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:47:44 armadillo ModemManager[3326]: Simple connect state (8/8): All done Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.3316] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.3327] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.3343] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.3350] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.3351] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.3363] ppp-manager: starting PPP connection Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.3455] ppp-manager: pppd started with pid 3611 Nov 27 08:47:44 armadillo pppd[3611]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:47:44 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:47:44 armadillo pppd[3611]: pppd 2.4.7 started by root, uid 0 Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:47:44 armadillo pppd[3611]: Using interface ppp0 Nov 27 08:47:44 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:47:44 armadillo pppd[3611]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:47:44 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.4070] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/18) Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:47:44 armadillo pppd[3611]: CHAP authentication succeeded Nov 27 08:47:44 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:47:44 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:47:44 armadillo pppd[3611]: CHAP authentication succeeded Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.4857] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.4859] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:47:44 armadillo pppd[3611]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:47:44 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:47:44 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 08:47:44 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 08:47:44 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 08:47:44 armadillo pppd[3611]: local IP address ***.***.***.*** Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 08:47:44 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 08:47:44 armadillo pppd[3611]: remote IP address 10.64.64.64 Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 08:47:44 armadillo pppd[3611]: primary DNS address 59.190.146.81 Nov 27 08:47:44 armadillo pppd[3611]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 08:47:44 armadillo pppd[3611]: secondary DNS address 59.190.147.17 Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.5357] ppp-manager: (IPv4 Config Get) reply received. Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.5657] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.5716] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.5774] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.5786] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 08:47:44 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:47:44 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.6058] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.6103] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 08:47:44 armadillo NetworkManager[706]: [1606434464.6125] device (ttyCommModem): Activation: successful, device activated. Nov 27 08:47:44 armadillo /usr/bin/wwan-force-restart: end force restart ec25 Nov 27 08:47:44 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:47:44 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:47:44 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:47:44 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:47:44 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 08:47:44 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 08:47:44 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 08:47:45 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 08:47:56 armadillo ntpdate[3673]: adjust time server 133.243.238.163 offset -0.002242 sec Nov 27 08:48:14 armadillo pppd[3611]: IPV6CP: timeout sending Config-Requests Nov 27 08:48:14 armadillo NetworkManager[706]: IPV6CP: timeout sending Config-Requests Nov 27 08:49:55 armadillo connection-recover: ttyCommModem ping fail Nov 27 08:49:55 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 08:49:55 armadillo NetworkManager[706]: [1606434595.2043] device (ttyCommModem): state change: activated -> deactivating (reason 'user-requested') [100 110 39] Nov 27 08:49:55 armadillo NetworkManager[706]: [1606434595.2052] manager: NetworkManager state is now DISCONNECTING Nov 27 08:49:55 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:49:55 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:49:55 armadillo NetworkManager[706]: [1606434595.2260] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=3704 uid=0 result="success" Nov 27 08:49:55 armadillo pppd[3611]: Terminating on signal 15 Nov 27 08:49:55 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate' Nov 27 08:49:55 armadillo NetworkManager[706]: Terminating on signal 15 Nov 27 08:49:55 armadillo NetworkManager[706]: Connect time 2.2 minutes. Nov 27 08:49:55 armadillo NetworkManager[706]: Sent 5977 bytes, received 6189 bytes. Nov 27 08:49:55 armadillo pppd[3611]: Connect time 2.2 minutes. Nov 27 08:49:55 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:49:55 armadillo pppd[3611]: Sent 5977 bytes, received 6189 bytes. Nov 27 08:49:55 armadillo pppd[3611]: Connection terminated. Nov 27 08:49:55 armadillo NetworkManager[706]: Connection terminated. Nov 27 08:49:55 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:49:55 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 08:49:55 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:49:55 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:49:55 armadillo NetworkManager[706]: [1606434595.3334] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:49:55 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:49:55 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:49:56 armadillo pppd[3611]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 08:49:56 armadillo pppd[3611]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 08:49:56 armadillo pppd[3611]: Exit. Nov 27 08:49:56 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 08:49:57 armadillo ModemManager[3326]: (ttyUSB3): port attributes not fully set Nov 27 08:49:58 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 08:49:58 armadillo NetworkManager[706]: [1606434598.4033] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 08:49:58 armadillo NetworkManager[706]: [1606434598.4072] manager: NetworkManager state is now DISCONNECTED Nov 27 08:49:58 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: new request (2 scripts) Nov 27 08:49:58 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: start running ordered scripts... Nov 27 08:50:03 armadillo NetworkManager[706]: [1606434603.6173] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:50:03 armadillo NetworkManager[706]: [1606434603.6194] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=3740 uid=0 result="success" Nov 27 08:50:03 armadillo NetworkManager[706]: [1606434603.6204] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:50:03 armadillo NetworkManager[706]: [1606434603.6212] manager: NetworkManager state is now CONNECTING Nov 27 08:50:03 armadillo NetworkManager[706]: [1606434603.6239] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:50:03 armadillo NetworkManager[706]: [1606434603.6543] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:50:03 armadillo ModemManager[3326]: Simple connect started... Nov 27 08:50:03 armadillo ModemManager[3326]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:50:03 armadillo ModemManager[3326]: Simple connect state (5/8): Register Nov 27 08:50:03 armadillo ModemManager[3326]: Simple connect state (6/8): Bearer Nov 27 08:50:03 armadillo ModemManager[3326]: Simple connect state (7/8): Connect Nov 27 08:50:03 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:50:03 armadillo ModemManager[3326]: (ttyUSB3): port attributes not fully set Nov 27 08:50:25 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Nov 27 08:50:25 armadillo NetworkManager[706]: [1606434625.3347] modem-broadband[ttyCommModem]: failed to connect modem: 0,-1 Nov 27 08:50:25 armadillo NetworkManager[706]: [1606434625.3349] device (ttyCommModem): state change: prepare -> failed (reason 'modem-no-carrier') [40 120 25] Nov 27 08:50:25 armadillo NetworkManager[706]: [1606434625.3358] manager: NetworkManager state is now DISCONNECTED Nov 27 08:50:25 armadillo NetworkManager[706]: [1606434625.3393] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 08:50:25 armadillo NetworkManager[706]: [1606434625.3477] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 08:50:25 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 08:50:25 armadillo connection-recover: exec wwan-force-restart Nov 27 08:50:25 armadillo /usr/bin/wwan-force-restart: start force restart ec25 Nov 27 08:50:25 armadillo ModemManager[3326]: Caught signal, shutting down... Nov 27 08:50:25 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) Nov 27 08:50:25 armadillo systemd[1]: Stopping Modem Manager... Nov 27 08:50:26 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) Nov 27 08:50:26 armadillo ModemManager[3326]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) Nov 27 08:50:26 armadillo NetworkManager[706]: [1606434626.0390] ModemManager disappeared from bus Nov 27 08:50:26 armadillo ModemManager[3326]: ModemManager is shut down Nov 27 08:50:26 armadillo NetworkManager[706]: [1606434626.0393] device (ttyCommModem): state change: disconnected -> unmanaged (reason 'removed') [30 10 36] Nov 27 08:50:26 armadillo systemd[1]: Stopped Modem Manager. Nov 27 08:50:40 armadillo kernel: usb 2-1.2: USB disconnect, device number 6 Nov 27 08:50:40 armadillo kernel: option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 27 08:50:40 armadillo kernel: option 2-1.2:1.0: device disconnected Nov 27 08:50:40 armadillo kernel: option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 27 08:50:40 armadillo kernel: option 2-1.2:1.1: device disconnected Nov 27 08:50:40 armadillo kernel: option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Nov 27 08:50:40 armadillo kernel: option 2-1.2:1.2: device disconnected Nov 27 08:50:40 armadillo kernel: option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Nov 27 08:50:40 armadillo kernel: option 2-1.2:1.3: device disconnected Nov 27 08:50:42 armadillo systemd[1]: Starting Modem Manager... Nov 27 08:50:42 armadillo ModemManager[3853]: ModemManager (version 1.6.4) starting in system bus... Nov 27 08:50:42 armadillo NetworkManager[706]: [1606434642.6389] ModemManager disappeared from bus Nov 27 08:50:42 armadillo systemd[1]: Started Modem Manager. Nov 27 08:50:42 armadillo NetworkManager[706]: [1606434642.7404] ModemManager available in the bus Nov 27 08:50:54 armadillo kernel: usb 2-1.2: new high-speed USB device number 7 using ci_hdrc Nov 27 08:50:54 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 08:50:54 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 08:50:55 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 08:50:55 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 08:50:55 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 08:50:55 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 08:50:55 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 08:50:55 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 08:50:56 armadillo ModemManager[3853]: (ttyUSB2): port attributes not fully set Nov 27 08:50:56 armadillo ModemManager[3853]: (ttyUSB0): port attributes not fully set Nov 27 08:50:56 armadillo ModemManager[3853]: (ttyUSB3): port attributes not fully set Nov 27 08:50:56 armadillo ModemManager[3853]: (ttyUSB1): port attributes not fully set Nov 27 08:51:23 armadillo ModemManager[3853]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 08:51:29 armadillo ModemManager[3853]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 08:51:29 armadillo ModemManager[3853]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 08:51:29 armadillo ModemManager[3853]: (ttyCommModem): port attributes not fully set Nov 27 08:51:29 armadillo ModemManager[3853]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 08:51:30 armadillo ModemManager[3853]: Modem: state changed (unknown -> disabled) Nov 27 08:51:30 armadillo NetworkManager[706]: [1606434690.1333] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/19) Nov 27 08:51:30 armadillo NetworkManager[706]: [1606434690.1361] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:51:30 armadillo NetworkManager[706]: [1606434690.1387] device (ttyCommModem): modem state 'enabling' Nov 27 08:51:30 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 08:51:30 armadillo NetworkManager[706]: [1606434690.1482] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 08:51:30 armadillo ModemManager[3853]: (ttyCommModem): port attributes not fully set Nov 27 08:51:30 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 08:51:30 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 08:51:30 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.4187] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.4221] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=4110 uid=0 result="success" Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.4265] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.4280] manager: NetworkManager state is now CONNECTING Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.4322] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.4638] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:51:31 armadillo ModemManager[3853]: Simple connect started... Nov 27 08:51:31 armadillo ModemManager[3853]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:51:31 armadillo ModemManager[3853]: Simple connect state (5/8): Register Nov 27 08:51:31 armadillo ModemManager[3853]: Simple connect state (6/8): Bearer Nov 27 08:51:31 armadillo ModemManager[3853]: Simple connect state (7/8): Connect Nov 27 08:51:31 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:51:31 armadillo ModemManager[3853]: (ttyUSB3): port attributes not fully set Nov 27 08:51:31 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:51:31 armadillo ModemManager[3853]: Simple connect state (8/8): All done Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.5452] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.5463] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.5478] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.5485] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.5486] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.5498] ppp-manager: starting PPP connection Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.5625] ppp-manager: pppd started with pid 4116 Nov 27 08:51:31 armadillo pppd[4116]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:51:31 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:51:31 armadillo pppd[4116]: pppd 2.4.7 started by root, uid 0 Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:51:31 armadillo pppd[4116]: Using interface ppp0 Nov 27 08:51:31 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:51:31 armadillo pppd[4116]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:51:31 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.6325] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/20) Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.7125] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:51:31 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:51:31 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:51:31 armadillo pppd[4116]: CHAP authentication succeeded Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.7127] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:51:31 armadillo pppd[4116]: CHAP authentication succeeded Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:51:31 armadillo pppd[4116]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 08:51:31 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:51:31 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 08:51:31 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 08:51:31 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 08:51:31 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 08:51:31 armadillo pppd[4116]: local IP address ***.***.***.*** Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 08:51:31 armadillo pppd[4116]: remote IP address 10.64.64.64 Nov 27 08:51:31 armadillo pppd[4116]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 08:51:31 armadillo pppd[4116]: primary DNS address 59.190.146.81 Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.7661] ppp-manager: (IPv4 Config Get) reply received. Nov 27 08:51:31 armadillo pppd[4116]: secondary DNS address 59.190.147.17 Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.8054] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.8170] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.8260] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.8278] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 08:51:31 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:51:31 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.8560] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.8574] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 08:51:31 armadillo NetworkManager[706]: [1606434691.8588] device (ttyCommModem): Activation: successful, device activated. Nov 27 08:51:31 armadillo /usr/bin/wwan-force-restart: end force restart ec25 Nov 27 08:51:31 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:51:31 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:51:31 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:51:31 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:51:31 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 08:51:31 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 08:51:32 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 08:51:32 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 08:51:43 armadillo ntpdate[4177]: adjust time server 133.243.238.243 offset 0.008640 sec Nov 27 08:51:51 armadillo systemd-timesyncd[434]: Synchronized to time server 133.243.238.243:123 (0.debian.pool.ntp.org). Nov 27 08:52:01 armadillo pppd[4116]: IPV6CP: timeout sending Config-Requests Nov 27 08:52:01 armadillo NetworkManager[706]: IPV6CP: timeout sending Config-Requests Nov 27 08:53:42 armadillo connection-recover: ttyCommModem ping fail Nov 27 08:53:42 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 08:53:42 armadillo NetworkManager[706]: [1606434822.4723] device (ttyCommModem): state change: activated -> deactivating (reason 'user-requested') [100 110 39] Nov 27 08:53:42 armadillo NetworkManager[706]: [1606434822.4760] manager: NetworkManager state is now DISCONNECTING Nov 27 08:53:42 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:53:42 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:53:42 armadillo NetworkManager[706]: [1606434822.4975] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=4211 uid=0 result="success" Nov 27 08:53:42 armadillo pppd[4116]: Terminating on signal 15 Nov 27 08:53:42 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate' Nov 27 08:53:42 armadillo NetworkManager[706]: Terminating on signal 15 Nov 27 08:53:42 armadillo NetworkManager[706]: Connect time 2.2 minutes. Nov 27 08:53:42 armadillo NetworkManager[706]: Sent 6187 bytes, received 6178 bytes. Nov 27 08:53:42 armadillo pppd[4116]: Connect time 2.2 minutes. Nov 27 08:53:42 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:53:42 armadillo pppd[4116]: Sent 6187 bytes, received 6178 bytes. Nov 27 08:53:42 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:53:42 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:53:42 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:53:42 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:53:42 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:53:42 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 08:53:42 armadillo NetworkManager[706]: Connection terminated. Nov 27 08:53:42 armadillo pppd[4116]: Connection terminated. Nov 27 08:53:42 armadillo NetworkManager[706]: [1606434822.6099] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:53:43 armadillo pppd[4116]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 08:53:43 armadillo pppd[4116]: Exit. Nov 27 08:53:43 armadillo pppd[4116]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 08:53:43 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 08:53:44 armadillo ModemManager[3853]: (ttyUSB3): port attributes not fully set Nov 27 08:53:45 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 08:53:45 armadillo NetworkManager[706]: [1606434825.7023] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 08:53:45 armadillo NetworkManager[706]: [1606434825.7061] manager: NetworkManager state is now DISCONNECTED Nov 27 08:53:45 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: new request (2 scripts) Nov 27 08:53:45 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: start running ordered scripts... Nov 27 08:53:50 armadillo NetworkManager[706]: [1606434830.9113] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:53:50 armadillo NetworkManager[706]: [1606434830.9144] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=4247 uid=0 result="success" Nov 27 08:53:50 armadillo NetworkManager[706]: [1606434830.9195] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:53:50 armadillo NetworkManager[706]: [1606434830.9216] manager: NetworkManager state is now CONNECTING Nov 27 08:53:50 armadillo NetworkManager[706]: [1606434830.9258] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:53:50 armadillo NetworkManager[706]: [1606434830.9630] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:53:50 armadillo ModemManager[3853]: Simple connect started... Nov 27 08:53:50 armadillo ModemManager[3853]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:53:50 armadillo ModemManager[3853]: Simple connect state (5/8): Register Nov 27 08:53:50 armadillo ModemManager[3853]: Simple connect state (6/8): Bearer Nov 27 08:53:50 armadillo ModemManager[3853]: Simple connect state (7/8): Connect Nov 27 08:53:50 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:53:51 armadillo ModemManager[3853]: (ttyUSB3): port attributes not fully set Nov 27 08:54:12 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Nov 27 08:54:12 armadillo NetworkManager[706]: [1606434852.6330] modem-broadband[ttyCommModem]: failed to connect modem: 0,-1 Nov 27 08:54:12 armadillo NetworkManager[706]: [1606434852.6332] device (ttyCommModem): state change: prepare -> failed (reason 'modem-no-carrier') [40 120 25] Nov 27 08:54:12 armadillo NetworkManager[706]: [1606434852.6341] manager: NetworkManager state is now DISCONNECTED Nov 27 08:54:12 armadillo NetworkManager[706]: [1606434852.6378] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 08:54:12 armadillo NetworkManager[706]: [1606434852.6421] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 08:54:12 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 08:54:12 armadillo connection-recover: exec wwan-force-restart Nov 27 08:54:12 armadillo /usr/bin/wwan-force-restart: start force restart ec25 Nov 27 08:54:13 armadillo systemd[1]: Stopping Modem Manager... Nov 27 08:54:13 armadillo ModemManager[3853]: Caught signal, shutting down... Nov 27 08:54:13 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) Nov 27 08:54:13 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) Nov 27 08:54:13 armadillo ModemManager[3853]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) Nov 27 08:54:13 armadillo NetworkManager[706]: [1606434853.3527] ModemManager disappeared from bus Nov 27 08:54:13 armadillo ModemManager[3853]: ModemManager is shut down Nov 27 08:54:13 armadillo NetworkManager[706]: [1606434853.3529] device (ttyCommModem): state change: disconnected -> unmanaged (reason 'removed') [30 10 36] Nov 27 08:54:13 armadillo systemd[1]: Stopped Modem Manager. Nov 27 08:54:28 armadillo kernel: usb 2-1.2: USB disconnect, device number 7 Nov 27 08:54:28 armadillo kernel: option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 27 08:54:28 armadillo kernel: option 2-1.2:1.0: device disconnected Nov 27 08:54:28 armadillo kernel: option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 27 08:54:28 armadillo kernel: option 2-1.2:1.1: device disconnected Nov 27 08:54:28 armadillo kernel: option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Nov 27 08:54:28 armadillo kernel: option 2-1.2:1.2: device disconnected Nov 27 08:54:28 armadillo kernel: option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Nov 27 08:54:28 armadillo kernel: option 2-1.2:1.3: device disconnected Nov 27 08:54:30 armadillo systemd[1]: Starting Modem Manager... Nov 27 08:54:30 armadillo ModemManager[4360]: ModemManager (version 1.6.4) starting in system bus... Nov 27 08:54:30 armadillo NetworkManager[706]: [1606434870.1307] ModemManager disappeared from bus Nov 27 08:54:30 armadillo systemd[1]: Started Modem Manager. Nov 27 08:54:30 armadillo NetworkManager[706]: [1606434870.2130] ModemManager available in the bus Nov 27 08:54:42 armadillo kernel: usb 2-1.2: new high-speed USB device number 8 using ci_hdrc Nov 27 08:54:42 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 08:54:42 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 08:54:42 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 08:54:42 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 08:54:42 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 08:54:42 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 08:54:42 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 08:54:42 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 08:54:44 armadillo ModemManager[4360]: (ttyUSB1): port attributes not fully set Nov 27 08:54:44 armadillo ModemManager[4360]: (ttyUSB0): port attributes not fully set Nov 27 08:54:44 armadillo ModemManager[4360]: (ttyUSB3): port attributes not fully set Nov 27 08:54:44 armadillo ModemManager[4360]: (ttyUSB2): port attributes not fully set Nov 27 08:55:02 armadillo ModemManager[4360]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 08:55:08 armadillo ModemManager[4360]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 08:55:08 armadillo ModemManager[4360]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 08:55:08 armadillo ModemManager[4360]: (ttyCommModem): port attributes not fully set Nov 27 08:55:08 armadillo ModemManager[4360]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 08:55:09 armadillo ModemManager[4360]: Modem: state changed (unknown -> disabled) Nov 27 08:55:09 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.1081] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/21) Nov 27 08:55:09 armadillo ModemManager[4360]: (ttyCommModem): port attributes not fully set Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.1125] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.1146] device (ttyCommModem): modem state 'enabling' Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.1218] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 08:55:09 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 08:55:09 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.6837] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.6875] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=4569 uid=0 result="success" Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.6921] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.6958] manager: NetworkManager state is now CONNECTING Nov 27 08:55:09 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.7050] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.7396] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:55:09 armadillo ModemManager[4360]: Simple connect started... Nov 27 08:55:09 armadillo ModemManager[4360]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:55:09 armadillo ModemManager[4360]: Simple connect state (5/8): Register Nov 27 08:55:09 armadillo ModemManager[4360]: Simple connect state (6/8): Bearer Nov 27 08:55:09 armadillo ModemManager[4360]: Simple connect state (7/8): Connect Nov 27 08:55:09 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:55:09 armadillo ModemManager[4360]: (ttyUSB3): port attributes not fully set Nov 27 08:55:09 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:55:09 armadillo ModemManager[4360]: Simple connect state (8/8): All done Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.8364] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.8376] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.8392] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.8399] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.8400] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.8412] ppp-manager: starting PPP connection Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.8529] ppp-manager: pppd started with pid 4575 Nov 27 08:55:09 armadillo pppd[4575]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:55:09 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:55:09 armadillo pppd[4575]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:55:09 armadillo pppd[4575]: pppd 2.4.7 started by root, uid 0 Nov 27 08:55:09 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:55:09 armadillo pppd[4575]: Using interface ppp0 Nov 27 08:55:09 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:55:09 armadillo pppd[4575]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:55:09 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:55:09 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:55:09 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:55:09 armadillo pppd[4575]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:55:09 armadillo NetworkManager[706]: [1606434909.9176] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/22) Nov 27 08:55:09 armadillo pppd[4575]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:55:09 armadillo pppd[4575]: CHAP authentication succeeded Nov 27 08:55:09 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:55:09 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:55:09 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:55:09 armadillo pppd[4575]: CHAP authentication succeeded Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.0001] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.0002] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:55:10 armadillo pppd[4575]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:55:10 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:55:10 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 08:55:10 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 08:55:10 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 08:55:10 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 08:55:10 armadillo pppd[4575]: local IP address ***.***.***.*** Nov 27 08:55:10 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 08:55:10 armadillo pppd[4575]: remote IP address 10.64.64.64 Nov 27 08:55:10 armadillo pppd[4575]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 08:55:10 armadillo pppd[4575]: primary DNS address 59.190.146.81 Nov 27 08:55:10 armadillo pppd[4575]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 08:55:10 armadillo pppd[4575]: secondary DNS address 59.190.147.17 Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.0396] ppp-manager: (IPv4 Config Get) reply received. Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.0816] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.0897] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.0960] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.1000] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 08:55:10 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:55:10 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.1272] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.1312] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 08:55:10 armadillo NetworkManager[706]: [1606434910.1452] device (ttyCommModem): Activation: successful, device activated. Nov 27 08:55:10 armadillo /usr/bin/wwan-force-restart: end force restart ec25 Nov 27 08:55:10 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:55:10 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:55:10 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:55:10 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:55:10 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 08:55:10 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 08:55:10 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 08:55:10 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 08:55:22 armadillo ntpdate[4637]: adjust time server 202.181.103.212 offset -0.011578 sec Nov 27 08:55:40 armadillo pppd[4575]: IPV6CP: timeout sending Config-Requests Nov 27 08:55:40 armadillo NetworkManager[706]: IPV6CP: timeout sending Config-Requests Nov 27 08:57:20 armadillo connection-recover: ttyCommModem ping fail Nov 27 08:57:20 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 08:57:20 armadillo NetworkManager[706]: [1606435040.7451] device (ttyCommModem): state change: activated -> deactivating (reason 'user-requested') [100 110 39] Nov 27 08:57:20 armadillo NetworkManager[706]: [1606435040.7459] manager: NetworkManager state is now DISCONNECTING Nov 27 08:57:20 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:57:20 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:57:20 armadillo NetworkManager[706]: [1606435040.7616] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=4668 uid=0 result="success" Nov 27 08:57:20 armadillo pppd[4575]: Terminating on signal 15 Nov 27 08:57:20 armadillo NetworkManager[706]: Terminating on signal 15 Nov 27 08:57:20 armadillo NetworkManager[706]: Connect time 2.2 minutes. Nov 27 08:57:20 armadillo NetworkManager[706]: Sent 5977 bytes, received 6049 bytes. Nov 27 08:57:20 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate' Nov 27 08:57:20 armadillo pppd[4575]: Connect time 2.2 minutes. Nov 27 08:57:20 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:57:20 armadillo pppd[4575]: Sent 5977 bytes, received 6049 bytes. Nov 27 08:57:20 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:57:20 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 08:57:20 armadillo NetworkManager[706]: Connection terminated. Nov 27 08:57:20 armadillo pppd[4575]: Connection terminated. Nov 27 08:57:20 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:57:20 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:57:20 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:57:20 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:57:20 armadillo NetworkManager[706]: [1606435040.8725] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:57:20 armadillo pppd[4575]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 08:57:20 armadillo pppd[4575]: Exit. Nov 27 08:57:20 armadillo [4575]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 08:57:20 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 08:57:21 armadillo ModemManager[4360]: (ttyUSB3): port attributes not fully set Nov 27 08:57:22 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 08:57:22 armadillo NetworkManager[706]: [1606435042.9679] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 08:57:22 armadillo NetworkManager[706]: [1606435042.9718] manager: NetworkManager state is now DISCONNECTED Nov 27 08:57:22 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: new request (2 scripts) Nov 27 08:57:22 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: start running ordered scripts... Nov 27 08:57:28 armadillo NetworkManager[706]: [1606435048.1863] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:57:28 armadillo NetworkManager[706]: [1606435048.1884] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=4704 uid=0 result="success" Nov 27 08:57:28 armadillo NetworkManager[706]: [1606435048.1894] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:57:28 armadillo NetworkManager[706]: [1606435048.1901] manager: NetworkManager state is now CONNECTING Nov 27 08:57:28 armadillo NetworkManager[706]: [1606435048.1928] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:57:28 armadillo NetworkManager[706]: [1606435048.2223] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:57:28 armadillo ModemManager[4360]: Simple connect started... Nov 27 08:57:28 armadillo ModemManager[4360]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:57:28 armadillo ModemManager[4360]: Simple connect state (5/8): Register Nov 27 08:57:28 armadillo ModemManager[4360]: Simple connect state (6/8): Bearer Nov 27 08:57:28 armadillo ModemManager[4360]: Simple connect state (7/8): Connect Nov 27 08:57:28 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:57:28 armadillo ModemManager[4360]: (ttyUSB3): port attributes not fully set Nov 27 08:57:50 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Nov 27 08:57:50 armadillo NetworkManager[706]: [1606435070.8762] modem-broadband[ttyCommModem]: failed to connect modem: 0,-1 Nov 27 08:57:50 armadillo NetworkManager[706]: [1606435070.8763] device (ttyCommModem): state change: prepare -> failed (reason 'modem-no-carrier') [40 120 25] Nov 27 08:57:50 armadillo NetworkManager[706]: [1606435070.8772] manager: NetworkManager state is now DISCONNECTED Nov 27 08:57:50 armadillo NetworkManager[706]: [1606435070.8808] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 08:57:50 armadillo NetworkManager[706]: [1606435070.8840] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 08:57:50 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 08:57:50 armadillo connection-recover: exec wwan-force-restart Nov 27 08:57:51 armadillo /usr/bin/wwan-force-restart: start force restart ec25 Nov 27 08:57:51 armadillo ModemManager[4360]: Caught signal, shutting down... Nov 27 08:57:51 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) Nov 27 08:57:51 armadillo systemd[1]: Stopping Modem Manager... Nov 27 08:57:51 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) Nov 27 08:57:51 armadillo ModemManager[4360]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) Nov 27 08:57:51 armadillo NetworkManager[706]: [1606435071.5997] ModemManager disappeared from bus Nov 27 08:57:51 armadillo ModemManager[4360]: ModemManager is shut down Nov 27 08:57:51 armadillo NetworkManager[706]: [1606435071.5999] device (ttyCommModem): state change: disconnected -> unmanaged (reason 'removed') [30 10 36] Nov 27 08:57:51 armadillo systemd[1]: Stopped Modem Manager. Nov 27 08:58:06 armadillo kernel: usb 2-1.2: USB disconnect, device number 8 Nov 27 08:58:06 armadillo kernel: option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 27 08:58:06 armadillo kernel: option 2-1.2:1.0: device disconnected Nov 27 08:58:06 armadillo kernel: option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 27 08:58:06 armadillo kernel: option 2-1.2:1.1: device disconnected Nov 27 08:58:06 armadillo kernel: option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Nov 27 08:58:06 armadillo kernel: option 2-1.2:1.2: device disconnected Nov 27 08:58:06 armadillo kernel: option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Nov 27 08:58:06 armadillo kernel: option 2-1.2:1.3: device disconnected Nov 27 08:58:08 armadillo systemd[1]: Starting Modem Manager... Nov 27 08:58:08 armadillo ModemManager[4818]: ModemManager (version 1.6.4) starting in system bus... Nov 27 08:58:08 armadillo systemd[1]: Started Modem Manager. Nov 27 08:58:08 armadillo NetworkManager[706]: [1606435088.2851] ModemManager disappeared from bus Nov 27 08:58:08 armadillo NetworkManager[706]: [1606435088.3923] ModemManager available in the bus Nov 27 08:58:20 armadillo kernel: usb 2-1.2: new high-speed USB device number 9 using ci_hdrc Nov 27 08:58:20 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 08:58:20 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 08:58:20 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 08:58:20 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 08:58:20 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 08:58:20 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 08:58:20 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 08:58:20 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 08:58:22 armadillo ModemManager[4818]: (ttyUSB1): port attributes not fully set Nov 27 08:58:22 armadillo ModemManager[4818]: (ttyUSB2): port attributes not fully set Nov 27 08:58:22 armadillo ModemManager[4818]: (ttyUSB0): port attributes not fully set Nov 27 08:58:22 armadillo ModemManager[4818]: (ttyUSB3): port attributes not fully set Nov 27 08:58:43 armadillo ModemManager[4818]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 08:58:52 armadillo ModemManager[4818]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 08:58:52 armadillo ModemManager[4818]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 08:58:52 armadillo ModemManager[4818]: (ttyCommModem): port attributes not fully set Nov 27 08:58:52 armadillo ModemManager[4818]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 08:58:53 armadillo ModemManager[4818]: Modem: state changed (unknown -> disabled) Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.0437] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/23) Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.0458] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.0486] device (ttyCommModem): modem state 'enabling' Nov 27 08:58:53 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.0587] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 08:58:53 armadillo ModemManager[4818]: (ttyCommModem): port attributes not fully set Nov 27 08:58:53 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 08:58:53 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 08:58:53 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.7587] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.7614] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=5057 uid=0 result="success" Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.7643] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.7671] manager: NetworkManager state is now CONNECTING Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.7726] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.7984] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 08:58:53 armadillo ModemManager[4818]: Simple connect started... Nov 27 08:58:53 armadillo ModemManager[4818]: Simple connect state (4/8): Wait to get fully enabled Nov 27 08:58:53 armadillo ModemManager[4818]: Simple connect state (5/8): Register Nov 27 08:58:53 armadillo ModemManager[4818]: Simple connect state (6/8): Bearer Nov 27 08:58:53 armadillo ModemManager[4818]: Simple connect state (7/8): Connect Nov 27 08:58:53 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 08:58:53 armadillo ModemManager[4818]: (ttyUSB3): port attributes not fully set Nov 27 08:58:53 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 08:58:53 armadillo ModemManager[4818]: Simple connect state (8/8): All done Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.8849] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.8860] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.8876] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.8882] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.8883] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.8895] ppp-manager: starting PPP connection Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.9010] ppp-manager: pppd started with pid 5063 Nov 27 08:58:53 armadillo pppd[5063]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:58:53 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 08:58:53 armadillo pppd[5063]: nm-ppp-plugin: (plugin_init): initializing Nov 27 08:58:53 armadillo pppd[5063]: pppd 2.4.7 started by root, uid 0 Nov 27 08:58:53 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 08:58:53 armadillo pppd[5063]: Using interface ppp0 Nov 27 08:58:53 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 08:58:53 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 08:58:53 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:58:53 armadillo pppd[5063]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 08:58:53 armadillo NetworkManager[706]: [1606435133.9597] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/24) Nov 27 08:58:53 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 08:58:53 armadillo pppd[5063]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 08:58:54 armadillo pppd[5063]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.0316] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.0317] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 08:58:54 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:58:54 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 08:58:54 armadillo pppd[5063]: CHAP authentication succeeded Nov 27 08:58:54 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 08:58:54 armadillo pppd[5063]: CHAP authentication succeeded Nov 27 08:58:54 armadillo pppd[5063]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:58:54 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 08:58:54 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 08:58:54 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 08:58:54 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 08:58:54 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 08:58:54 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 08:58:54 armadillo pppd[5063]: local IP address ***.***.***.*** Nov 27 08:58:54 armadillo pppd[5063]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 08:58:54 armadillo pppd[5063]: remote IP address 10.64.64.64 Nov 27 08:58:54 armadillo pppd[5063]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 08:58:54 armadillo pppd[5063]: primary DNS address 59.190.146.81 Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.0975] ppp-manager: (IPv4 Config Get) reply received. Nov 27 08:58:54 armadillo pppd[5063]: secondary DNS address 59.190.147.17 Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.1333] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.1418] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.1489] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.1516] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 08:58:54 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 08:58:54 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.1879] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.1885] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 08:58:54 armadillo NetworkManager[706]: [1606435134.1899] device (ttyCommModem): Activation: successful, device activated. Nov 27 08:58:54 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 08:58:54 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 08:58:54 armadillo /usr/bin/wwan-force-restart: end force restart ec25 Nov 27 08:58:54 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 08:58:54 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 08:58:54 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 08:58:54 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 08:58:54 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 08:58:54 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 08:59:05 armadillo ntpdate[5125]: adjust time server 133.243.238.243 offset 0.004923 sec Nov 27 08:59:24 armadillo pppd[5063]: IPV6CP: timeout sending Config-Requests Nov 27 08:59:24 armadillo NetworkManager[706]: IPV6CP: timeout sending Config-Requests Nov 27 09:01:04 armadillo connection-recover: ttyCommModem ping fail Nov 27 09:01:04 armadillo connection-recover: ttyCommModem reconnect start... Nov 27 09:01:04 armadillo NetworkManager[706]: [1606435264.8002] device (ttyCommModem): state change: activated -> deactivating (reason 'user-requested') [100 110 39] Nov 27 09:01:04 armadillo NetworkManager[706]: [1606435264.8012] manager: NetworkManager state is now DISCONNECTING Nov 27 09:01:04 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 09:01:04 armadillo NetworkManager[706]: [1606435264.8124] audit: op="connection-deactivate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=5156 uid=0 result="success" Nov 27 09:01:04 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 09:01:04 armadillo pppd[5063]: Terminating on signal 15 Nov 27 09:01:04 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate' Nov 27 09:01:04 armadillo NetworkManager[706]: Terminating on signal 15 Nov 27 09:01:04 armadillo NetworkManager[706]: Connect time 2.2 minutes. Nov 27 09:01:04 armadillo NetworkManager[706]: Sent 5977 bytes, received 6357 bytes. Nov 27 09:01:04 armadillo pppd[5063]: Connect time 2.2 minutes. Nov 27 09:01:04 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 09:01:04 armadillo pppd[5063]: Sent 5977 bytes, received 6357 bytes. Nov 27 09:01:04 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 09:01:04 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 09:01:04 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 09:01:04 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 09:01:04 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 09:01:04 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect' Nov 27 09:01:04 armadillo NetworkManager[706]: Connection terminated. Nov 27 09:01:04 armadillo pppd[5063]: Connection terminated. Nov 27 09:01:04 armadillo NetworkManager[706]: [1606435264.9360] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 09:01:05 armadillo pppd[5063]: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead' Nov 27 09:01:05 armadillo pppd[5063]: Exit. Nov 27 09:01:05 armadillo [5063]: nm-ppp-plugin: (nm_exit_notify): cleaning up Nov 27 09:01:05 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connected -> disconnecting) Nov 27 09:01:07 armadillo ModemManager[4818]: (ttyUSB3): port attributes not fully set Nov 27 09:01:08 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disconnecting -> registered) Nov 27 09:01:08 armadillo NetworkManager[706]: [1606435268.0299] device (ttyCommModem): state change: deactivating -> disconnected (reason 'user-requested') [110 30 39] Nov 27 09:01:08 armadillo NetworkManager[706]: [1606435268.0336] manager: NetworkManager state is now DISCONNECTED Nov 27 09:01:08 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: new request (2 scripts) Nov 27 09:01:08 armadillo nm-dispatcher: req:2 'down' [ttyCommModem]: start running ordered scripts... Nov 27 09:01:13 armadillo NetworkManager[706]: [1606435273.2576] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 09:01:13 armadillo NetworkManager[706]: [1606435273.2607] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=5192 uid=0 result="success" Nov 27 09:01:13 armadillo NetworkManager[706]: [1606435273.2658] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 09:01:13 armadillo NetworkManager[706]: [1606435273.2680] manager: NetworkManager state is now CONNECTING Nov 27 09:01:13 armadillo NetworkManager[706]: [1606435273.2720] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 09:01:13 armadillo NetworkManager[706]: [1606435273.3066] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 09:01:13 armadillo ModemManager[4818]: Simple connect started... Nov 27 09:01:13 armadillo ModemManager[4818]: Simple connect state (4/8): Wait to get fully enabled Nov 27 09:01:13 armadillo ModemManager[4818]: Simple connect state (5/8): Register Nov 27 09:01:13 armadillo ModemManager[4818]: Simple connect state (6/8): Bearer Nov 27 09:01:13 armadillo ModemManager[4818]: Simple connect state (7/8): Connect Nov 27 09:01:13 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 09:01:13 armadillo ModemManager[4818]: (ttyUSB3): port attributes not fully set Nov 27 09:01:34 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered) Nov 27 09:01:34 armadillo NetworkManager[706]: [1606435294.9660] modem-broadband[ttyCommModem]: failed to connect modem: 0,-1 Nov 27 09:01:34 armadillo NetworkManager[706]: [1606435294.9661] device (ttyCommModem): state change: prepare -> failed (reason 'modem-no-carrier') [40 120 25] Nov 27 09:01:34 armadillo NetworkManager[706]: [1606435294.9669] manager: NetworkManager state is now DISCONNECTED Nov 27 09:01:34 armadillo NetworkManager[706]: [1606435294.9701] device (ttyCommModem): Activation: failed for connection 'gsm-ttyCommModem' Nov 27 09:01:34 armadillo NetworkManager[706]: [1606435294.9731] device (ttyCommModem): state change: failed -> disconnected (reason 'none') [120 30 0] Nov 27 09:01:35 armadillo connection-recover: ttyCommModem reconnect fail Nov 27 09:01:35 armadillo connection-recover: exec wwan-force-restart Nov 27 09:01:35 armadillo /usr/bin/wwan-force-restart: start force restart ec25 Nov 27 09:01:35 armadillo systemd[1]: Stopping Modem Manager... Nov 27 09:01:35 armadillo ModemManager[4818]: Caught signal, shutting down... Nov 27 09:01:35 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> disabling) Nov 27 09:01:35 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (home -> unknown) Nov 27 09:01:35 armadillo ModemManager[4818]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabling -> disabled) Nov 27 09:01:35 armadillo NetworkManager[706]: [1606435295.6792] ModemManager disappeared from bus Nov 27 09:01:35 armadillo NetworkManager[706]: [1606435295.6794] device (ttyCommModem): state change: disconnected -> unmanaged (reason 'removed') [30 10 36] Nov 27 09:01:35 armadillo ModemManager[4818]: ModemManager is shut down Nov 27 09:01:35 armadillo systemd[1]: Stopped Modem Manager. Nov 27 09:01:50 armadillo kernel: usb 2-1.2: USB disconnect, device number 9 Nov 27 09:01:50 armadillo kernel: option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 27 09:01:50 armadillo kernel: option 2-1.2:1.0: device disconnected Nov 27 09:01:50 armadillo kernel: option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 27 09:01:50 armadillo kernel: option 2-1.2:1.1: device disconnected Nov 27 09:01:50 armadillo kernel: option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Nov 27 09:01:50 armadillo kernel: option 2-1.2:1.2: device disconnected Nov 27 09:01:50 armadillo kernel: option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Nov 27 09:01:50 armadillo kernel: option 2-1.2:1.3: device disconnected Nov 27 09:01:52 armadillo systemd[1]: Starting Modem Manager... Nov 27 09:01:52 armadillo ModemManager[5305]: ModemManager (version 1.6.4) starting in system bus... Nov 27 09:01:52 armadillo NetworkManager[706]: [1606435312.2890] ModemManager disappeared from bus Nov 27 09:01:52 armadillo systemd[1]: Started Modem Manager. Nov 27 09:01:52 armadillo NetworkManager[706]: [1606435312.3751] ModemManager available in the bus Nov 27 09:02:04 armadillo kernel: usb 2-1.2: new high-speed USB device number 10 using ci_hdrc Nov 27 09:02:04 armadillo kernel: option 2-1.2:1.0: GSM modem (1-port) converter detected Nov 27 09:02:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB0 Nov 27 09:02:04 armadillo kernel: option 2-1.2:1.1: GSM modem (1-port) converter detected Nov 27 09:02:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB1 Nov 27 09:02:04 armadillo kernel: option 2-1.2:1.2: GSM modem (1-port) converter detected Nov 27 09:02:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB2 Nov 27 09:02:04 armadillo kernel: option 2-1.2:1.3: GSM modem (1-port) converter detected Nov 27 09:02:04 armadillo kernel: usb 2-1.2: GSM modem (1-port) converter now attached to ttyUSB3 Nov 27 09:02:06 armadillo ModemManager[5305]: (ttyUSB2): port attributes not fully set Nov 27 09:02:06 armadillo ModemManager[5305]: (ttyUSB3): port attributes not fully set Nov 27 09:02:06 armadillo ModemManager[5305]: (ttyUSB0): port attributes not fully set Nov 27 09:02:06 armadillo ModemManager[5305]: (ttyUSB1): port attributes not fully set Nov 27 09:02:21 armadillo ModemManager[5305]: (tty/ttyUSB0) failed to parse QCDM version info command result: -7 Nov 27 09:02:23 armadillo kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Nov 27 09:02:27 armadillo ModemManager[5305]: Creating modem with plugin 'Quectel EC25' and '4' ports Nov 27 09:02:27 armadillo ModemManager[5305]: Could not grab port (tty/ttyUSB1): 'Cannot add port 'tty/ttyUSB1', unhandled serial type' Nov 27 09:02:27 armadillo ModemManager[5305]: (ttyCommModem): port attributes not fully set Nov 27 09:02:27 armadillo ModemManager[5305]: Modem for device at '/sys/devices/soc0/soc/30800000.aips-bus/30b30000.usb/ci_hdrc.1/usb2/2-1/2-1.2' successfully created Nov 27 09:02:28 armadillo ModemManager[5305]: Modem: state changed (unknown -> disabled) Nov 27 09:02:28 armadillo ModemManager[5305]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) Nov 27 09:02:28 armadillo ModemManager[5305]: (ttyCommModem): port attributes not fully set Nov 27 09:02:28 armadillo NetworkManager[706]: [1606435348.1160] manager: (ttyCommModem): new Broadband device (/org/freedesktop/NetworkManager/Devices/25) Nov 27 09:02:28 armadillo NetworkManager[706]: [1606435348.1178] device (ttyCommModem): state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 27 09:02:28 armadillo NetworkManager[706]: [1606435348.1196] device (ttyCommModem): modem state 'enabling' Nov 27 09:02:28 armadillo NetworkManager[706]: [1606435348.1243] device (ttyCommModem): state change: unavailable -> disconnected (reason 'none') [20 30 0] Nov 27 09:02:28 armadillo ModemManager[5305]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering) Nov 27 09:02:28 armadillo ModemManager[5305]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) Nov 27 09:02:28 armadillo ModemManager[5305]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered) Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.3341] device (ttyCommModem): Activation: starting connection 'gsm-ttyCommModem' (228f11da-105c-453a-a736-a1c5f4e6fd8d) Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.3374] audit: op="connection-activate" uuid="228f11da-105c-453a-a736-a1c5f4e6fd8d" name="gsm-ttyCommModem" pid=5506 uid=0 result="success" Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.3416] device (ttyCommModem): state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.3449] manager: NetworkManager state is now CONNECTING Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.3500] device (ttyCommModem): state change: prepare -> need-auth (reason 'none') [40 60 0] Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.3786] device (ttyCommModem): state change: need-auth -> prepare (reason 'none') [60 40 0] Nov 27 09:02:29 armadillo ModemManager[5305]: Simple connect started... Nov 27 09:02:29 armadillo ModemManager[5305]: Simple connect state (4/8): Wait to get fully enabled Nov 27 09:02:29 armadillo ModemManager[5305]: Simple connect state (5/8): Register Nov 27 09:02:29 armadillo ModemManager[5305]: Simple connect state (6/8): Bearer Nov 27 09:02:29 armadillo ModemManager[5305]: Simple connect state (7/8): Connect Nov 27 09:02:29 armadillo ModemManager[5305]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) Nov 27 09:02:29 armadillo ModemManager[5305]: (ttyUSB3): port attributes not fully set Nov 27 09:02:29 armadillo ModemManager[5305]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) Nov 27 09:02:29 armadillo ModemManager[5305]: Simple connect state (8/8): All done Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.4610] device (ttyCommModem): ip-ifname: set ifname 'ttyUSB3', unknown ifindex Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.4621] device (ttyCommModem): state change: prepare -> config (reason 'none') [40 50 0] Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.4637] device (ttyCommModem): state change: config -> ip-config (reason 'none') [50 70 0] Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.4643] device (ttyCommModem): interface ttyUSB3 not up for IP configuration Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.4644] (ttyCommModem): using modem-specified IP timeout: 20 seconds Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.4657] ppp-manager: starting PPP connection Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.4789] ppp-manager: pppd started with pid 5512 Nov 27 09:02:29 armadillo pppd[5512]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 09:02:29 armadillo NetworkManager[706]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded. Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (plugin_init): initializing Nov 27 09:02:29 armadillo pppd[5512]: pppd 2.4.7 started by root, uid 0 Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection' Nov 27 09:02:29 armadillo pppd[5512]: Using interface ppp0 Nov 27 09:02:29 armadillo NetworkManager[706]: Using interface ppp0 Nov 27 09:02:29 armadillo pppd[5512]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 09:02:29 armadillo NetworkManager[706]: Connect: ppp0 <--> /dev/ttyUSB3 Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish' Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.5437] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/26) Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate' Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials... Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.6169] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Nov 27 09:02:29 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 09:02:29 armadillo NetworkManager[706]: CHAP authentication succeeded Nov 27 09:02:29 armadillo pppd[5512]: CHAP authentication succeeded Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.6170] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Nov 27 09:02:29 armadillo pppd[5512]: CHAP authentication succeeded Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network' Nov 27 09:02:29 armadillo pppd[5512]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 09:02:29 armadillo NetworkManager[706]: Could not determine remote IP address: defaulting to 10.64.64.64 Nov 27 09:02:29 armadillo NetworkManager[706]: local IP address ***.***.***.*** Nov 27 09:02:29 armadillo NetworkManager[706]: remote IP address 10.64.64.64 Nov 27 09:02:29 armadillo NetworkManager[706]: primary DNS address 59.190.146.81 Nov 27 09:02:29 armadillo NetworkManager[706]: secondary DNS address 59.190.147.17 Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running' Nov 27 09:02:29 armadillo pppd[5512]: local IP address ***.***.***.*** Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (nm_ip_up): ip-up event Nov 27 09:02:29 armadillo pppd[5512]: remote IP address 10.64.64.64 Nov 27 09:02:29 armadillo pppd[5512]: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager... Nov 27 09:02:29 armadillo pppd[5512]: primary DNS address 59.190.146.81 Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.6899] ppp-manager: (IPv4 Config Get) reply received. Nov 27 09:02:29 armadillo pppd[5512]: secondary DNS address 59.190.147.17 Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.7053] device (ttyCommModem): state change: ip-config -> ip-check (reason 'none') [70 80 0] Nov 27 09:02:29 armadillo dbus[633]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.7081] device (ttyCommModem): state change: ip-check -> secondaries (reason 'none') [80 90 0] Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.7099] device (ttyCommModem): state change: secondaries -> activated (reason 'none') [90 100 0] Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.7106] manager: NetworkManager state is now CONNECTED_LOCAL Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.7282] manager: NetworkManager state is now CONNECTED_GLOBAL Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.7288] policy: set 'gsm-ttyCommModem' (ppp0) as default for IPv4 routing and DNS Nov 27 09:02:29 armadillo NetworkManager[706]: [1606435349.7302] device (ttyCommModem): Activation: successful, device activated. Nov 27 09:02:29 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service... Nov 27 09:02:29 armadillo /usr/bin/wwan-force-restart: end force restart ec25 Nov 27 09:02:29 armadillo dbus[633]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Nov 27 09:02:29 armadillo systemd[1]: Started Network Manager Script Dispatcher Service. Nov 27 09:02:29 armadillo nm-dispatcher: req:1 'connectivity-change': new request (2 scripts) Nov 27 09:02:29 armadillo nm-dispatcher: req:1 'connectivity-change': start running ordered scripts... Nov 27 09:02:29 armadillo nm-dispatcher: req:2 'up' [ppp0]: new request (2 scripts) Nov 27 09:02:29 armadillo nm-dispatcher: req:2 'up' [ppp0]: start running ordered scripts... Nov 27 09:02:30 armadillo systemd[1]: Reloading OpenBSD Secure Shell server. Nov 27 09:02:30 armadillo systemd[1]: Reloaded OpenBSD Secure Shell server. Nov 27 09:02:41 armadillo ntpdate[5573]: adjust time server 133.243.238.163 offset -0.012749 sec