Created
June 25, 2021 08:26
-
-
Save cywang117/e9cdf2a98db2e65cd1fd439b4308ff2c to your computer and use it in GitHub Desktop.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
| -- Logs begin at Wed 2021-06-23 07:55:37 UTC, end at Fri 2021-06-25 08:23:04 UTC. -- | |
| Jun 24 09:04:12 localhost kernel: Booting Linux on physical CPU 0x0 | |
| Jun 24 09:04:12 localhost kernel: Linux version 5.4.70+ (oe-user@oe-host) (gcc version 9.3.0 (GCC)) #1 SMP PREEMPT Tue Jan 5 03:15:22 UTC 2021 | |
| Jun 24 09:04:12 localhost kernel: CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d | |
| Jun 24 09:04:12 localhost kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache | |
| Jun 24 09:04:12 localhost kernel: OF: fdt: Machine model: TI AM335x BeagleBone Black | |
| Jun 24 09:04:12 localhost kernel: Memory policy: Data cache writeback | |
| Jun 24 09:04:12 localhost kernel: efi: Getting EFI parameters from FDT: | |
| Jun 24 09:04:12 localhost kernel: efi: UEFI not found. | |
| Jun 24 09:04:12 localhost kernel: cma: Reserved 48 MiB at 0x9c800000 | |
| Jun 24 09:04:12 localhost kernel: On node 0 totalpages: 130560 | |
| Jun 24 09:04:12 localhost kernel: Normal zone: 1148 pages used for memmap | |
| Jun 24 09:04:12 localhost kernel: Normal zone: 0 pages reserved | |
| Jun 24 09:04:12 localhost kernel: Normal zone: 130560 pages, LIFO batch:31 | |
| Jun 24 09:04:12 localhost kernel: CPU: All CPU(s) started in SVC mode. | |
| Jun 24 09:04:12 localhost kernel: AM335X ES2.1 (sgx neon) | |
| Jun 24 09:04:12 localhost kernel: percpu: Embedded 20 pages/cpu s53068 r8192 d20660 u81920 | |
| Jun 24 09:04:12 localhost kernel: pcpu-alloc: s53068 r8192 d20660 u81920 alloc=20*4096 | |
| Jun 24 09:04:12 localhost kernel: pcpu-alloc: [0] 0 | |
| Jun 24 09:04:12 localhost kernel: Built 1 zonelists, mobility grouping on. Total pages: 129412 | |
| Jun 24 09:04:12 localhost kernel: Kernel command line: console=ttyO0,115200n8 root=UUID=ba1eadef-95e1-4cb6-95f3-c81fef720cb2 console=null quiet splash vt.global_cursor_default=0 consoleblank=0 coherent_pool=1M net.ifnames=0 lpj=1990656 rng_core.default_quality=100 | |
| Jun 24 09:04:12 localhost kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: mem auto-init: stack:off, heap alloc:off, heap free:off | |
| Jun 24 09:04:12 localhost kernel: Memory: 440056K/522240K available (13312K kernel code, 1096K rwdata, 3748K rodata, 8192K init, 358K bss, 33032K reserved, 49152K cma-reserved, 0K highmem) | |
| Jun 24 09:04:12 localhost kernel: random: get_random_u32 called from __kmem_cache_create+0x48/0x510 with crng_init=0 | |
| Jun 24 09:04:12 localhost kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 | |
| Jun 24 09:04:12 localhost kernel: ftrace: allocating 44760 entries in 88 pages | |
| Jun 24 09:04:12 localhost kernel: rcu: Preemptible hierarchical RCU implementation. | |
| Jun 24 09:04:12 localhost kernel: rcu: RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. | |
| Jun 24 09:04:12 localhost kernel: Tasks RCU enabled. | |
| Jun 24 09:04:12 localhost kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. | |
| Jun 24 09:04:12 localhost kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 | |
| Jun 24 09:04:12 localhost kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 | |
| Jun 24 09:04:12 localhost kernel: IRQ: Found an INTC at 0x(ptrval) (revision 5.0) with 128 interrupts | |
| Jun 24 09:04:12 localhost kernel: OMAP clockevent source: timer2 at 24000000 Hz | |
| Jun 24 09:04:12 localhost kernel: sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 89478484971ns | |
| Jun 24 09:04:12 localhost kernel: clocksource: timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns | |
| Jun 24 09:04:12 localhost kernel: OMAP clocksource: timer1 at 24000000 Hz | |
| Jun 24 09:04:12 localhost kernel: timer_probe: no matching timers found | |
| Jun 24 09:04:12 localhost kernel: Console: colour dummy device 80x30 | |
| Jun 24 09:04:12 localhost kernel: Calibrating delay loop (skipped) preset value.. 995.32 BogoMIPS (lpj=1990656) | |
| Jun 24 09:04:12 localhost kernel: pid_max: default: 32768 minimum: 301 | |
| Jun 24 09:04:12 localhost kernel: LSM: Security Framework initializing | |
| Jun 24 09:04:12 localhost kernel: Yama: becoming mindful. | |
| Jun 24 09:04:12 localhost kernel: AppArmor: AppArmor initialized | |
| Jun 24 09:04:12 localhost kernel: TOMOYO Linux initialized | |
| Jun 24 09:04:12 localhost kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE tmpfs *** | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE proc *** | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE cgroup1 *** | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE cgroup2 *** | |
| Jun 24 09:04:12 localhost kernel: CPU: Testing write buffer coherency: ok | |
| Jun 24 09:04:12 localhost kernel: CPU0: Spectre v2: using BPIALL workaround | |
| Jun 24 09:04:12 localhost kernel: CPU0: thread -1, cpu 0, socket -1, mpidr 0 | |
| Jun 24 09:04:12 localhost kernel: Setting up static identity map for 0x80100000 - 0x80100060 | |
| Jun 24 09:04:12 localhost kernel: rcu: Hierarchical SRCU implementation. | |
| Jun 24 09:04:12 localhost kernel: EFI services will not be available. | |
| Jun 24 09:04:12 localhost kernel: smp: Bringing up secondary CPUs ... | |
| Jun 24 09:04:12 localhost kernel: smp: Brought up 1 node, 1 CPU | |
| Jun 24 09:04:12 localhost kernel: SMP: Total of 1 processors activated (995.32 BogoMIPS). | |
| Jun 24 09:04:12 localhost kernel: CPU: All CPU(s) started in SVC mode. | |
| Jun 24 09:04:12 localhost kernel: devtmpfs: initialized | |
| Jun 24 09:04:12 localhost kernel: VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3 | |
| Jun 24 09:04:12 localhost kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns | |
| Jun 24 09:04:12 localhost kernel: futex hash table entries: 256 (order: 2, 16384 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: pinctrl core: initialized pinctrl subsystem | |
| Jun 24 09:04:12 localhost kernel: NET: Registered protocol family 16 | |
| Jun 24 09:04:12 localhost kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations | |
| Jun 24 09:04:12 localhost kernel: l3-aon-clkctrl:0000:0: failed to disable | |
| Jun 24 09:04:12 localhost kernel: audit: initializing netlink subsys (disabled) | |
| Jun 24 09:04:12 localhost kernel: cpuidle: using governor ladder | |
| Jun 24 09:04:12 localhost kernel: cpuidle: using governor menu | |
| Jun 24 09:04:12 localhost kernel: audit: type=2000 audit(0.084:1): state=initialized audit_enabled=0 res=1 | |
| Jun 24 09:04:12 localhost kernel: hw-breakpoint: debug architecture 0x4 unsupported. | |
| Jun 24 09:04:12 localhost kernel: debugfs: Directory '49000000.edma' with parent 'dmaengine' already present! | |
| Jun 24 09:04:12 localhost kernel: edma 49000000.edma: TI EDMA DMA engine driver | |
| Jun 24 09:04:12 localhost kernel: iommu: Default domain type: Translated | |
| Jun 24 09:04:12 localhost kernel: SCSI subsystem initialized | |
| Jun 24 09:04:12 localhost kernel: libata version 3.00 loaded. | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver usbfs | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver hub | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new device driver usb | |
| Jun 24 09:04:12 localhost kernel: mc: Linux media interface: v0.10 | |
| Jun 24 09:04:12 localhost kernel: videodev: Linux video capture interface: v2.00 | |
| Jun 24 09:04:12 localhost kernel: pps_core: LinuxPPS API ver. 1 registered | |
| Jun 24 09:04:12 localhost kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> | |
| Jun 24 09:04:12 localhost kernel: PTP clock support registered | |
| Jun 24 09:04:12 localhost kernel: Advanced Linux Sound Architecture Driver Initialized. | |
| Jun 24 09:04:12 localhost kernel: NetLabel: Initializing | |
| Jun 24 09:04:12 localhost kernel: NetLabel: domain hash size = 128 | |
| Jun 24 09:04:12 localhost kernel: NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO | |
| Jun 24 09:04:12 localhost kernel: NetLabel: unlabeled traffic allowed by default | |
| Jun 24 09:04:12 localhost kernel: clocksource: Switched to clocksource timer1 | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE bpf *** | |
| Jun 24 09:04:12 localhost kernel: VFS: Disk quotas dquot_6.6.0 | |
| Jun 24 09:04:12 localhost kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE ramfs *** | |
| Jun 24 09:04:12 localhost kernel: AppArmor: AppArmor Filesystem Enabled | |
| Jun 24 09:04:12 localhost kernel: thermal_sys: Registered thermal governor 'fair_share' | |
| Jun 24 09:04:12 localhost kernel: thermal_sys: Registered thermal governor 'bang_bang' | |
| Jun 24 09:04:12 localhost kernel: thermal_sys: Registered thermal governor 'step_wise' | |
| Jun 24 09:04:12 localhost kernel: NET: Registered protocol family 2 | |
| Jun 24 09:04:12 localhost kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: TCP bind hash table entries: 4096 (order: 3, 32768 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: TCP: Hash tables configured (established 4096 bind 4096) | |
| Jun 24 09:04:12 localhost kernel: UDP hash table entries: 256 (order: 1, 8192 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear) | |
| Jun 24 09:04:12 localhost kernel: NET: Registered protocol family 1 | |
| Jun 24 09:04:12 localhost kernel: RPC: Registered named UNIX socket transport module. | |
| Jun 24 09:04:12 localhost kernel: RPC: Registered udp transport module. | |
| Jun 24 09:04:12 localhost kernel: RPC: Registered tcp transport module. | |
| Jun 24 09:04:12 localhost kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. | |
| Jun 24 09:04:12 localhost kernel: NET: Registered protocol family 44 | |
| Jun 24 09:04:12 localhost kernel: random: fast init done | |
| Jun 24 09:04:12 localhost kernel: hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available | |
| Jun 24 09:04:12 localhost kernel: Initialise system trusted keyrings | |
| Jun 24 09:04:12 localhost kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3 | |
| Jun 24 09:04:12 localhost kernel: zbud: loaded | |
| Jun 24 09:04:12 localhost kernel: NFS: Registering the id_resolver key type | |
| Jun 24 09:04:12 localhost kernel: Key type id_resolver registered | |
| Jun 24 09:04:12 localhost kernel: Key type id_legacy registered | |
| Jun 24 09:04:12 localhost kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... | |
| Jun 24 09:04:12 localhost kernel: fuse: init (API version 7.31) | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE fuse *** | |
| Jun 24 09:04:12 localhost kernel: *** VALIDATE fuse *** | |
| Jun 24 09:04:12 localhost kernel: aufs 5.4.3-20210104 | |
| Jun 24 09:04:12 localhost kernel: Key type asymmetric registered | |
| Jun 24 09:04:12 localhost kernel: Asymmetric key parser 'x509' registered | |
| Jun 24 09:04:12 localhost kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) | |
| Jun 24 09:04:12 localhost kernel: io scheduler mq-deadline registered | |
| Jun 24 09:04:12 localhost kernel: OMAP GPIO hardware version 0.1 | |
| Jun 24 09:04:12 localhost kernel: omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400 | |
| Jun 24 09:04:12 localhost kernel: omap_i2c 4819c000.i2c: bus 2 rev0.11 at 100 kHz | |
| Jun 24 09:04:12 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:12 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:12 localhost kernel: pinctrl-single 44e10800.pinmux: 142 pins, size 568 | |
| Jun 24 09:04:12 localhost kernel: gpio-of-helper ocp:cape-universal: ready | |
| Jun 24 09:04:12 localhost kernel: wkup_m3_ipc 44e11324.wkup_m3_ipc: could not get rproc handle | |
| Jun 24 09:04:12 localhost kernel: omap_uart 44e09000.serial: no wakeirq for uart0 | |
| Jun 24 09:04:12 localhost kernel: 44e09000.serial: ttyO0 at MMIO 0x44e09000 (irq = 29, base_baud = 3000000) is a OMAP UART0 | |
| Jun 24 09:04:12 localhost kernel: printk: console [ttyO0] enabled | |
| Jun 24 09:04:12 localhost kernel: omap_uart 48024000.serial: no wakeirq for uart2 | |
| Jun 24 09:04:12 localhost kernel: 48024000.serial: ttyO2 at MMIO 0x48024000 (irq = 36, base_baud = 3000000) is a OMAP UART2 | |
| Jun 24 09:04:12 localhost kernel: omap_uart 481a8000.serial: no wakeirq for uart4 | |
| Jun 24 09:04:12 localhost kernel: 481a8000.serial: ttyO4 at MMIO 0x481a8000 (irq = 46, base_baud = 3000000) is a OMAP UART4 | |
| Jun 24 09:04:12 localhost kernel: omap_uart 481aa000.serial: no wakeirq for uart5 | |
| Jun 24 09:04:12 localhost kernel: 481aa000.serial: ttyO5 at MMIO 0x481aa000 (irq = 47, base_baud = 3000000) is a OMAP UART5 | |
| Jun 24 09:04:12 localhost kernel: omap_rng 48310000.rng: Random Number Generator ver. 20 | |
| Jun 24 09:04:12 localhost kernel: sdhci: Secure Digital Host Controller Interface driver | |
| Jun 24 09:04:12 localhost kernel: sdhci: Copyright(c) Pierre Ossman | |
| Jun 24 09:04:12 localhost kernel: omap_gpio 44e07000.gpio: Could not set line 6 debounce to 200000 microseconds (-22) | |
| Jun 24 09:04:12 localhost kernel: omap_hsmmc 48060000.mmc: Got CD GPIO | |
| Jun 24 09:04:12 localhost kernel: random: crng init done | |
| Jun 24 09:04:12 localhost kernel: omap_hsmmc 47810000.mmc: RX DMA channel request failed | |
| Jun 24 09:04:12 localhost kernel: sdhci-pltfm: SDHCI platform and OF driver helper | |
| Jun 24 09:04:12 localhost kernel: zram: Added device: zram0 | |
| Jun 24 09:04:12 localhost kernel: mmc1: switch to bus width 8 failed | |
| Jun 24 09:04:12 localhost kernel: mmc1: new high speed MMC card at address 0001 | |
| Jun 24 09:04:12 localhost kernel: mmcblk1: mmc1:0001 P1XXXX 3.60 GiB | |
| Jun 24 09:04:12 localhost kernel: mmcblk1boot0: mmc1:0001 P1XXXX partition 1 16.0 MiB | |
| Jun 24 09:04:12 localhost kernel: mmcblk1boot1: mmc1:0001 P1XXXX partition 2 16.0 MiB | |
| Jun 24 09:04:12 localhost kernel: mmcblk1rpmb: mmc1:0001 P1XXXX partition 3 128 KiB, chardev (242:0) | |
| Jun 24 09:04:12 localhost kernel: mmcblk1: p1 p2 p3 p4 < p5 p6 > | |
| Jun 24 09:04:12 localhost kernel: libphy: Fixed MDIO Bus: probed | |
| Jun 24 09:04:12 localhost kernel: tun: Universal TUN/TAP device driver, 1.6 | |
| Jun 24 09:04:12 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:12 localhost kernel: davinci_mdio 4a101000.mdio: davinci mdio revision 1.6, bus freq 1000000 | |
| Jun 24 09:04:12 localhost kernel: libphy: 4a101000.mdio: probed | |
| Jun 24 09:04:12 localhost kernel: davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720 | |
| Jun 24 09:04:12 localhost kernel: cpsw 4a100000.ethernet: initialized cpsw ale version 1.4 | |
| Jun 24 09:04:12 localhost kernel: cpsw 4a100000.ethernet: ALE Table size 1024 | |
| Jun 24 09:04:12 localhost kernel: cpsw 4a100000.ethernet: cpts: overflow check period 1250 (jiffies) | |
| Jun 24 09:04:12 localhost kernel: cpsw 4a100000.ethernet: Detected MACID = 58:7a:62:7f:26:9d | |
| Jun 24 09:04:12 localhost kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver | |
| Jun 24 09:04:12 localhost kernel: ehci-platform: EHCI generic platform driver | |
| Jun 24 09:04:12 localhost kernel: ehci-omap: OMAP-EHCI Host Controller driver | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver uas | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver usb-storage | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-alauda | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-cypress | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-datafab | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums_eneub6250 | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-freecom | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-isd200 | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-jumpshot | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-karma | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-onetouch | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-realtek | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-sddr09 | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-sddr55 | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver ums-usbat | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver usbserial_generic | |
| Jun 24 09:04:12 localhost kernel: usbserial: USB Serial support registered for generic | |
| Jun 24 09:04:12 localhost kernel: am335x-phy-driver 47401300.usb-phy: 47401300.usb-phy supply vcc not found, using dummy regulator | |
| Jun 24 09:04:12 localhost kernel: am335x-phy-driver 47401b00.usb-phy: 47401b00.usb-phy supply vcc not found, using dummy regulator | |
| Jun 24 09:04:12 localhost kernel: musb-hdrc musb-hdrc.1: MUSB HDRC host driver | |
| Jun 24 09:04:12 localhost kernel: musb-hdrc musb-hdrc.1: new USB bus registered, assigned bus number 1 | |
| Jun 24 09:04:12 localhost kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04 | |
| Jun 24 09:04:12 localhost kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 | |
| Jun 24 09:04:12 localhost kernel: usb usb1: Product: MUSB HDRC host driver | |
| Jun 24 09:04:12 localhost kernel: usb usb1: Manufacturer: Linux 5.4.70+ musb-hcd | |
| Jun 24 09:04:12 localhost kernel: usb usb1: SerialNumber: musb-hdrc.1 | |
| Jun 24 09:04:12 localhost kernel: hub 1-0:1.0: USB hub found | |
| Jun 24 09:04:12 localhost kernel: hub 1-0:1.0: 1 port detected | |
| Jun 24 09:04:12 localhost kernel: omap_rtc 44e3e000.rtc: already running | |
| Jun 24 09:04:12 localhost kernel: omap_rtc 44e3e000.rtc: registered as rtc0 | |
| Jun 24 09:04:12 localhost kernel: i2c /dev entries driver | |
| Jun 24 09:04:12 localhost kernel: Driver for 1-wire Dallas network protocol. | |
| Jun 24 09:04:12 localhost kernel: omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec | |
| Jun 24 09:04:12 localhost kernel: softdog: initialized. soft_noboot=0 soft_margin=60 sec soft_panic=0 (nowayout=0) | |
| Jun 24 09:04:12 localhost kernel: cpuidle: enable-method property 'ti,am3352' found operations | |
| Jun 24 09:04:12 localhost kernel: ledtrig-cpu: registered to indicate activity on CPUs | |
| Jun 24 09:04:12 localhost kernel: omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2 | |
| Jun 24 09:04:12 localhost kernel: omap-aes 53500000.aes: will run requests pump with realtime priority | |
| Jun 24 09:04:12 localhost kernel: omap-sham 53100000.sham: hw accel on OMAP rev 4.3 | |
| Jun 24 09:04:12 localhost kernel: hidraw: raw HID events driver (C) Jiri Kosina | |
| Jun 24 09:04:12 localhost kernel: usbcore: registered new interface driver usbhid | |
| Jun 24 09:04:12 localhost kernel: usbhid: USB HID core driver | |
| Jun 24 09:04:12 localhost kernel: remoteproc remoteproc0: wkup_m3 is available | |
| Jun 24 09:04:12 localhost kernel: drop_monitor: Initializing network drop monitor service | |
| Jun 24 09:04:12 localhost kernel: IPVS: Registered protocols (TCP, UDP, SCTP, AH, ESP) | |
| Jun 24 09:04:12 localhost kernel: IPVS: Connection hash table configured (size=4096, memory=32Kbytes) | |
| Jun 24 09:04:12 localhost kernel: IPVS: ipvs loaded. | |
| Jun 24 09:04:12 localhost kernel: wireguard: WireGuard 0.0.20191219 loaded. See www.wireguard.com for information. | |
| Jun 24 09:04:12 localhost kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld <Jason@zx2c4.com>. All Rights Reserved. | |
| Jun 24 09:04:12 localhost kernel: NET: Registered protocol family 10 | |
| Jun 24 09:04:12 localhost kernel: Segment Routing with IPv6 | |
| Jun 24 09:04:12 localhost kernel: mip6: Mobile IPv6 | |
| Jun 24 09:04:12 localhost kernel: NET: Registered protocol family 17 | |
| Jun 24 09:04:12 localhost kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. | |
| Jun 24 09:04:12 localhost kernel: Key type dns_resolver registered | |
| Jun 24 09:04:12 localhost kernel: mpls_gso: MPLS GSO support | |
| Jun 24 09:04:12 localhost kernel: ThumbEE CPU extension supported. | |
| Jun 24 09:04:12 localhost kernel: Registering SWP/SWPB emulation handler | |
| Jun 24 09:04:12 localhost kernel: omap_voltage_late_init: Voltage driver support not added | |
| Jun 24 09:04:12 localhost kernel: PM: Cannot get wkup_m3_ipc handle | |
| Jun 24 09:04:12 localhost kernel: registered taskstats version 1 | |
| Jun 24 09:04:12 localhost kernel: Loading compiled-in X.509 certificates | |
| Jun 24 09:04:12 localhost kernel: zswap: loaded using pool lzo/zbud | |
| Jun 24 09:04:12 localhost kernel: Key type ._fscrypt registered | |
| Jun 24 09:04:12 localhost kernel: Key type .fscrypt registered | |
| Jun 24 09:04:12 localhost kernel: AppArmor: AppArmor sha1 policy hashing enabled | |
| Jun 24 09:04:12 localhost kernel: tps6521x_pwrbutton tps65217-pwrbutton: DMA mask not set | |
| Jun 24 09:04:12 localhost kernel: input: tps65217_pwr_but as /devices/platform/ocp/44c00000.interconnect/44c00000.interconnect:segment@200000/44e0b000.target-module/44e0b000.i2c/i2c-0/0-0024/tps65217-pwrbutton/input/input0 | |
| Jun 24 09:04:12 localhost kernel: tps65217 0-0024: TPS65217 ID 0xe version 1.2 | |
| Jun 24 09:04:12 localhost kernel: at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write | |
| Jun 24 09:04:12 localhost kernel: omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz | |
| Jun 24 09:04:12 localhost kernel: remoteproc remoteproc1: 4a334000.pru is available | |
| Jun 24 09:04:12 localhost kernel: pru-rproc 4a334000.pru: PRU rproc node /ocp/interconnect@4a000000/segment@0/target-module@300000/pruss@0/pru@34000 probed successfully | |
| Jun 24 09:04:12 localhost kernel: remoteproc remoteproc2: 4a338000.pru is available | |
| Jun 24 09:04:12 localhost kernel: pru-rproc 4a338000.pru: PRU rproc node /ocp/interconnect@4a000000/segment@0/target-module@300000/pruss@0/pru@38000 probed successfully | |
| Jun 24 09:04:12 localhost kernel: remoteproc remoteproc0: powering up wkup_m3 | |
| Jun 24 09:04:12 localhost kernel: remoteproc remoteproc0: Booting fw image am335x-pm-firmware.elf, size 217168 | |
| Jun 24 09:04:12 localhost kernel: remoteproc remoteproc0: remote processor wkup_m3 is now up | |
| Jun 24 09:04:12 localhost kernel: wkup_m3_ipc 44e11324.wkup_m3_ipc: CM3 Firmware Version = 0x193 | |
| Jun 24 09:04:12 localhost kernel: PM: bootloader does not support rtc-only! | |
| Jun 24 09:04:12 localhost kernel: omap_rtc 44e3e000.rtc: setting system clock to 2021-06-24T09:03:58 UTC (1624525438) | |
| Jun 24 09:04:12 localhost kernel: ALSA device list: | |
| Jun 24 09:04:12 localhost kernel: No soundcards found. | |
| Jun 24 09:04:12 localhost kernel: Freeing unused kernel memory: 8192K | |
| Jun 24 09:04:12 localhost kernel: Run /init as init process | |
| Jun 24 09:04:12 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:12 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:12 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:12 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:12 localhost kernel: zram0: detected capacity change from 0 to 254668800 | |
| Jun 24 09:04:12 localhost kernel: EXT4-fs (mmcblk1p3): mounted filesystem with ordered data mode. Opts: (null) | |
| Jun 24 09:04:12 localhost kernel: EXT4-fs (mmcblk1p5): mounted filesystem with ordered data mode. Opts: (null) | |
| Jun 24 09:04:12 localhost kernel: ext4 filesystem being mounted at /rootfs/mnt/state supports timestamps until 2038 (0x7fffffff) | |
| Jun 24 09:04:12 localhost kernel: Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist. | |
| Jun 24 09:04:12 localhost kernel: EXT4-fs (mmcblk1p3): re-mounted. Opts: (null) | |
| Jun 24 09:04:12 localhost kernel: ext4 filesystem being remounted at / supports timestamps until 2038 (0x7fffffff) | |
| Jun 24 09:04:12 localhost kernel: aufs au_opts_verify:1611:init[1]: dirperm1 breaks the protection by the permission bits on the lower branch | |
| Jun 24 09:04:12 localhost kernel: EXT4-fs (mmcblk1p6): mounted filesystem with ordered data mode. Opts: (null) | |
| Jun 24 09:04:12 localhost kernel: Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist. | |
| Jun 24 09:04:12 localhost systemd[1]: /lib/systemd/system/balena-host.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/balena-host.sock → /run/balena-host.sock; please update the unit file accordingly. | |
| Jun 24 09:04:12 localhost systemd[1]: /lib/systemd/system/balena-engine.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/balena-engine.sock → /run/balena-engine.sock; please update the unit file accordingly. | |
| Jun 24 09:04:12 localhost systemd[1]: /etc/systemd/system/bluetooth.service.d/bluetooth.conf:6: Neither a valid executable name nor an absolute path: pkglibexecdir@/bluetoothd | |
| Jun 24 09:04:12 localhost systemd-journald[697]: Journal started | |
| Jun 24 09:04:12 localhost systemd-journald[697]: Runtime Journal (/run/log/journal/900c4d7c427b46f39b59dade5d90c42b) is 4.0M, max 32.0M, 28.0M free. | |
| Jun 24 09:04:12 localhost systemd-vconsole-setup[639]: KD_FONT_OP_GET failed while trying to get the font metadata: Function not implemented | |
| Jun 24 09:04:12 localhost systemd-vconsole-setup[639]: Fonts will not be copied to remaining consoles | |
| Jun 24 09:04:12 localhost systemd-tmpfiles[651]: /etc/tmpfiles.d/openvpn.conf:1: Line references path below legacy directory /var/run/, updating /var/run/openvpn → /run/openvpn; please update the tmpfiles.d/ drop-in file accordingly. | |
| Jun 24 09:04:12 localhost resin-partition-mounter[618]: INFO: /dev/disk/by-state/active (active) already mounted in /mnt/sysroot/active. | |
| Jun 24 09:04:13 localhost resin-partition-mounter[619]: INFO: Mounting /dev/disk/by-state/resin-boot (resin-boot) in /mnt/boot. | |
| Jun 24 09:04:13 localhost resin-partition-mounter[620]: INFO: /dev/disk/by-state/resin-state (resin-state) already mounted in /mnt/state. | |
| Jun 24 09:04:13 localhost timeinit-buildtime.sh[642]: [timeinit-buildtime.sh][INFO] Setting system time from build time. | |
| Jun 24 09:04:13 localhost timeinit-buildtime.sh[642]: [timeinit-buildtime.sh][INFO] System time already set. | |
| Jun 24 09:04:13 localhost os-config[649]: `deviceApiKey` already generated | |
| Jun 24 09:04:13 localhost resin-partition-mounter[657]: INFO: /dev/disk/by-state/resin-data (resin-data) already mounted in /mnt/data. | |
| Jun 24 09:04:13 localhost fake-hwclock[664]: [fake-hwclock][INFO] Current system time: 2021-06-24 09:04:12 | |
| Jun 24 09:04:13 localhost fake-hwclock[664]: [fake-hwclock][INFO] fake-hwclock saved clock information is in the past: 2021-06-17 08:07:16 | |
| Jun 24 09:04:13 localhost fake-hwclock[664]: [fake-hwclock][INFO] To set system time to this saved clock anyway, use "force" | |
| Jun 24 09:04:13 localhost systemd-tmpfiles[700]: /etc/tmpfiles.d/openvpn.conf:1: Line references path below legacy directory /var/run/, updating /var/run/openvpn → /run/openvpn; please update the tmpfiles.d/ drop-in file accordingly. | |
| Jun 24 09:04:13 localhost bindmount[702]: INFO: Bindmounting /etc/NetworkManager/conf.d in /mnt/state/root-overlay/etc/NetworkManager/conf.d ... | |
| Jun 24 09:04:13 localhost bindmount[702]: INFO: Successfully mounted /mnt/state/root-overlay/etc/NetworkManager/conf.d. | |
| Jun 24 09:04:13 localhost bindmount[703]: INFO: Bindmounting /etc/NetworkManager/system-connections in /mnt/state/root-overlay/etc/NetworkManager/system-connections ... | |
| Jun 24 09:04:13 localhost bindmount[703]: INFO: Successfully mounted /mnt/state/root-overlay/etc/NetworkManager/system-connections. | |
| Jun 24 09:04:13 localhost bindmount[704]: INFO: Bindmounting /etc/docker in /mnt/state/root-overlay/etc/docker ... | |
| Jun 24 09:04:13 localhost bindmount[704]: INFO: Successfully mounted /mnt/state/root-overlay/etc/docker. | |
| Jun 24 09:04:13 localhost bindmount[705]: INFO: Bindmounting /etc/hostname in /mnt/state/root-overlay/etc/hostname ... | |
| Jun 24 09:04:13 localhost bindmount[705]: INFO: Successfully mounted /mnt/state/root-overlay/etc/hostname. | |
| Jun 24 09:04:13 localhost bindmount[706]: INFO: Bindmounting /etc/openvpn in /mnt/state/root-overlay/etc/openvpn ... | |
| Jun 24 09:04:13 localhost bindmount[706]: INFO: Successfully mounted /mnt/state/root-overlay/etc/openvpn. | |
| Jun 24 09:04:13 localhost bindmount[707]: INFO: Bindmounting /etc/resin-supervisor in /mnt/state/root-overlay/etc/resin-supervisor ... | |
| Jun 24 09:04:13 localhost bindmount[707]: WARN: /etc/resin-supervisor is not an empty entry. You are going to shadow content. | |
| Jun 24 09:04:13 localhost bindmount[707]: INFO: Successfully mounted /mnt/state/root-overlay/etc/resin-supervisor. | |
| Jun 24 09:04:13 localhost bindmount[708]: INFO: Bindmounting /etc/ssh/hostkeys in /mnt/state/root-overlay/etc/ssh/hostkeys ... | |
| Jun 24 09:04:13 localhost bindmount[708]: INFO: Successfully mounted /mnt/state/root-overlay/etc/ssh/hostkeys. | |
| Jun 24 09:04:13 localhost bindmount[709]: INFO: Bindmounting /etc/udev/rules.d in /mnt/state/root-overlay/etc/udev/rules.d ... | |
| Jun 24 09:04:13 localhost bindmount[709]: INFO: Successfully mounted /mnt/state/root-overlay/etc/udev/rules.d. | |
| Jun 24 09:04:13 localhost bindmount[710]: INFO: Bindmounting /home/root/.docker in /mnt/state/root-overlay/home/root/.docker ... | |
| Jun 24 09:04:13 localhost bindmount[710]: INFO: Successfully mounted /mnt/state/root-overlay/home/root/.docker. | |
| Jun 24 09:04:13 localhost bindmount[711]: INFO: Bindmounting /home/root/.rnd in /mnt/state/root-overlay/home/root/.rnd ... | |
| Jun 24 09:04:13 localhost bindmount[711]: INFO: Successfully mounted /mnt/state/root-overlay/home/root/.rnd. | |
| Jun 24 09:04:14 localhost bindmount[712]: INFO: Bindmounting /home/root/.ssh in /mnt/state/root-overlay/home/root/.ssh ... | |
| Jun 24 09:04:14 localhost bindmount[712]: INFO: Successfully mounted /mnt/state/root-overlay/home/root/.ssh. | |
| Jun 24 09:04:14 localhost bindmount[713]: INFO: Bindmounting /usr/share/ca-certificates/balena in /mnt/state/root-overlay/usr/share/ca-certificates/balena ... | |
| Jun 24 09:04:14 localhost bindmount[713]: INFO: Successfully mounted /mnt/state/root-overlay/usr/share/ca-certificates/balena. | |
| Jun 24 09:04:14 localhost bindmount[714]: INFO: Bindmounting /var/lib/NetworkManager in /mnt/state/root-overlay/var/lib/NetworkManager ... | |
| Jun 24 09:04:14 localhost bindmount[714]: INFO: Successfully mounted /mnt/state/root-overlay/var/lib/NetworkManager. | |
| Jun 24 09:04:14 localhost bindmount[715]: INFO: Bindmounting /var/lib/bluetooth in /mnt/state/root-overlay/var/lib/bluetooth ... | |
| Jun 24 09:04:14 localhost bindmount[715]: INFO: Successfully mounted /mnt/state/root-overlay/var/lib/bluetooth. | |
| Jun 24 09:04:14 localhost bindmount[716]: INFO: Bindmounting /var/lib/chrony in /mnt/state/root-overlay/var/lib/chrony ... | |
| Jun 24 09:04:14 localhost bindmount[716]: INFO: Successfully mounted /mnt/state/root-overlay/var/lib/chrony. | |
| Jun 24 09:04:14 localhost bindmount[717]: INFO: Bindmounting /var/lib/systemd in /mnt/state/root-overlay/var/lib/systemd ... | |
| Jun 24 09:04:14 localhost bindmount[717]: WARN: /var/lib/systemd is not an empty entry. You are going to shadow content. | |
| Jun 24 09:04:14 localhost bindmount[717]: INFO: Successfully mounted /mnt/state/root-overlay/var/lib/systemd. | |
| Jun 24 09:04:14 localhost systemd-udevd[722]: Network interface NamePolicy= disabled on kernel command line, ignoring. | |
| Jun 24 09:04:14 localhost systemd-udevd[722]: Configuration file /lib/udev/rules.d/10-local-bt-hci-up.rules is marked executable. Please remove executable permission bits. Proceeding anyway. | |
| Jun 24 09:04:14 localhost systemd-udevd[722]: /lib/udev/rules.d/50-udev-default.rules:39 Unknown group 'render', ignoring | |
| Jun 24 09:04:14 localhost systemd-udevd[722]: /lib/udev/rules.d/50-udev-default.rules:40 Unknown group 'render', ignoring | |
| Jun 24 09:04:21 localhost systemd-udevd[727]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:04:21 localhost systemd-udevd[727]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:04:21 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:21 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:21 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:21 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:22 localhost systemd-udevd[730]: zram0: Failed to substitute variable '$parent' or apply format '%P', ignoring: No such file or directory | |
| Jun 24 09:04:23 localhost systemd-udevd[727]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:04:23 localhost kernel: zram: Can't change algorithm for initialized device | |
| Jun 24 09:04:23 localhost systemd-udevd[730]: zram0: Process '/lib/udev/zram-swap-init /dev/zram0' failed with exit code 1. | |
| Jun 24 09:04:24 localhost udevadm[701]: systemd-udev-settle.service is deprecated. | |
| Jun 24 09:04:24 localhost systemd-vconsole-setup[840]: KD_FONT_OP_GET failed while trying to get the font metadata: Function not implemented | |
| Jun 24 09:04:24 localhost systemd-vconsole-setup[840]: Fonts will not be copied to remaining consoles | |
| Jun 24 09:04:26 localhost kernel: Adding 248696k swap on /dev/zram0. Priority:-2 extents:1 across:248696k SSFS | |
| Jun 24 09:04:26 localhost rngd[852]: Initializing available sources | |
| Jun 24 09:04:26 localhost rngd[852]: [hwrng ]: Initialized | |
| Jun 24 09:04:26 localhost rngd[852]: [jitter]: Initializing AES buffer | |
| Jun 24 09:04:26 localhost rngd[852]: [jitter]: Unable to obtain AES key, disabling AES in JITTER source | |
| Jun 24 09:04:26 localhost rngd[852]: [jitter]: Enabling JITTER rng support | |
| Jun 24 09:04:26 localhost rngd[852]: [jitter]: Initialized | |
| Jun 24 09:04:26 localhost timeinit-rtc.sh[858]: [timeinit-rtc.sh][INFO] Setting system time from RTC. | |
| Jun 24 09:04:27 localhost kernel: Bluetooth: Core ver 2.22 | |
| Jun 24 09:04:27 localhost kernel: NET: Registered protocol family 31 | |
| Jun 24 09:04:27 localhost kernel: Bluetooth: HCI device and connection manager initialized | |
| Jun 24 09:04:27 localhost kernel: Bluetooth: HCI socket layer initialized | |
| Jun 24 09:04:27 localhost kernel: Bluetooth: L2CAP socket layer initialized | |
| Jun 24 09:04:27 localhost kernel: Bluetooth: SCO socket layer initialized | |
| Jun 24 09:04:28 localhost kernel: Bluetooth: RFCOMM TTY layer initialized | |
| Jun 24 09:04:28 localhost kernel: Bluetooth: RFCOMM socket layer initialized | |
| Jun 24 09:04:28 localhost kernel: Bluetooth: RFCOMM ver 1.11 | |
| Jun 24 09:04:29 localhost timeinit-rtc.sh[858]: [timeinit-rtc.sh][INFO] System time is already set. | |
| Jun 24 09:04:30 localhost chronyd[882]: 2021-06-24T09:04:30Z chronyd version 4.0 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH +IPV6 -DEBUG) | |
| Jun 24 09:04:30 localhost ModemManager[869]: ModemManager (version 1.14.2) starting in system bus... | |
| Jun 24 09:04:30 localhost kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:30 localhost chronyd[882]: 2021-06-24T09:04:30Z Frequency 57.125 +/- 0.077 ppm read from /var/lib/chrony/drift | |
| Jun 24 09:04:33 localhost kernel: Bluetooth: HCI UART driver ver 2.3 | |
| Jun 24 09:04:33 localhost kernel: Bluetooth: HCI UART protocol H4 registered | |
| Jun 24 09:04:33 localhost kernel: Bluetooth: HCI UART protocol LL registered | |
| Jun 24 09:04:36 localhost systemd-logind[940]: Watching system buttons on /dev/input/event0 (tps65217_pwr_but) | |
| Jun 24 09:04:36 localhost systemd-logind[940]: New seat seat0. | |
| Jun 24 09:04:37 localhost ModemManager[869]: [base-manager] couldn't check support for device '/sys/devices/platform/ocp/4a000000.interconnect/4a000000.interconnect:segment@0/4a101200.target-module/4a100000.ethernet': not supported by any plugin | |
| Jun 24 09:04:38 localhost extract-balena-ca[892]: [extract-balena-ca][INFO] The config.json file does not contain custom CA | |
| Jun 24 09:04:39 localhost kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database | |
| Jun 24 09:04:39 localhost kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' | |
| Jun 24 09:04:39 localhost os-networkmanager[904]: os-networkmanager: <info> Using /mnt/boot/config.json config.json. | |
| Jun 24 09:04:39 localhost os-networkmanager[904]: os-networkmanager: <info> Using NetworkManager configuration fragment file in /etc/NetworkManager/conf.d/os-networkmanager.conf. | |
| Jun 24 09:04:40 localhost bash[916]: resin-net-config: Found config.json in /mnt/boot/config.json . | |
| Jun 24 09:04:40 localhost systemd-udevd[949]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:04:40 localhost systemd-udevd[949]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:04:41 localhost bindmount[972]: INFO: Bindmounting /var/log/journal in /mnt/data/root-overlay/var/log/journal ... | |
| Jun 24 09:04:41 localhost bindmount[972]: INFO: Successfully mounted /mnt/data/root-overlay/var/log/journal. | |
| Jun 24 09:04:42 localhost systemd-journald[697]: Time spent on flushing to /var is 818.210ms for 385 entries. | |
| Jun 24 09:04:42 localhost systemd-journald[697]: System Journal (/var/log/journal/900c4d7c427b46f39b59dade5d90c42b) is 12.0M, max 32.0M, 19.9M free. | |
| Jun 24 09:04:47 localhost os-sshkeys[907]: os-sshkeys: No custom SSH public keys configured. | |
| Jun 24 09:04:47 localhost sh[857]: Rollback: Parsing bootloader configuration | |
| Jun 24 09:04:47 localhost bash[871]: [INFO] balena-unique-key : Device already has uuid assigned. | |
| Jun 24 09:04:47 localhost os-udevrules[911]: os-udevrules: No custom udev rules found in /mnt/boot/config.json | |
| Jun 24 09:04:47 localhost resin-persistent-logs[921]: resin-persistent-logs: Persistent logging activated. | |
| Jun 24 09:04:48 localhost kernel: EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) | |
| Jun 24 09:04:48 localhost kernel: ext4 filesystem being mounted at /mnt/sysroot/inactive supports timestamps until 2038 (0x7fffffff) | |
| Jun 24 09:04:49 localhost resin-ntp-config[975]: resin-ntp-config: Found config.json in /mnt/boot/config.json . | |
| Jun 24 09:04:51 localhost os-networkmanager[904]: os-networkmanager: <info> .os.network.connectivity.uri not defined. Trying default | |
| Jun 24 09:04:51 localhost os-networkmanager[904]: os-networkmanager: <info> Using default os.network.connectivity.uri configuration : https://api.resin.io/connectivity-check | |
| Jun 24 09:04:53 localhost prepare-openvpn[988]: prepare-openvpn: [INFO] Balena.io VPN authentication. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Found user 'avahi' (UID 994) and group 'avahi' (GID 991). | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Successfully dropped root privileges. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: avahi-daemon 0.7 starting up. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Successfully called chroot(). | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Successfully dropped remaining capabilities. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Loading service file /services/ssh.service. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Joining mDNS multicast group on interface resin-dns.IPv4 with address 10.114.102.1. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: New relevant interface resin-dns.IPv4 for mDNS. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Network interface enumeration completed. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Registering new address record for 10.114.102.1 on resin-dns.IPv4. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Successfully dropped remaining capabilities. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Loading service file /services/ssh.service. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Joining mDNS multicast group on interface resin-dns.IPv4 with address 10.114.102.1. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: New relevant interface resin-dns.IPv4 for mDNS. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Network interface enumeration completed. | |
| Jun 24 09:04:53 a3659e1 avahi-daemon[1015]: Registering new address record for 10.114.102.1 on resin-dns.IPv4. | |
| Jun 24 09:04:54 a3659e1 avahi-daemon[1015]: Server startup complete. Host name is a3659e1.local. Local service cookie is 2298636302. | |
| Jun 24 09:04:55 a3659e1 os-networkmanager[904]: os-networkmanager: <info> Using default os.network.connectivity.interval : 3600 | |
| Jun 24 09:04:55 a3659e1 avahi-daemon[1015]: Service "a3659e1" (/services/ssh.service) successfully established. | |
| Jun 24 09:04:56 a3659e1 sh[997]: rollbacks: Previous Host OS META_BALENA_VERSION:2.47.1 OK for rollbacks. | |
| Jun 24 09:04:56 a3659e1 sh[857]: Rollback: Nothing to do by rollback-altboot.service | |
| Jun 24 09:04:56 a3659e1 sh[857]: Rollback: rollback-health.service will run sanity checks and remove breadcrumbs | |
| Jun 24 09:04:57 a3659e1 os-networkmanager[904]: os-networkmanager: <info> Using default os.network.connectivity.response : "" | |
| Jun 24 09:04:57 a3659e1 os-networkmanager[904]: os-networkmanager: <info> NM custom configuration fragment already in place. | |
| Jun 24 09:04:58 a3659e1 NetworkManager[1029]: <info> [1624525498.8397] NetworkManager (version 1.28.0) is starting... (for the first time) | |
| Jun 24 09:04:58 a3659e1 NetworkManager[1029]: <info> [1624525498.8465] Read config: /etc/NetworkManager/NetworkManager.conf (etc: os-networkmanager.conf) | |
| Jun 24 09:04:58 a3659e1 NetworkManager[1029]: <info> [1624525498.8993] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager" | |
| Jun 24 09:04:58 a3659e1 kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:58 a3659e1 kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1036]: dnsmasq: syntax check OK. | |
| Jun 24 09:04:59 a3659e1 NetworkManager[1029]: <info> [1624525499.1179] manager[0x1eec070]: monitoring kernel firmware directory '/lib/firmware'. | |
| Jun 24 09:04:59 a3659e1 dbus-daemon[884]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=1029 comm="/usr/sbin/NetworkManager --no-daemon ") | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 WARNING: file '/var/volatile/vpn-auth' is group or others accessible | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 OpenVPN 2.4.7 arm-poky-linux-gnueabi [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on Feb 20 2019 | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 library versions: OpenSSL 1.1.1g 21 Apr 2020, LZO 2.10 | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:04:59 a3659e1 bash[1040]: Board specific initialization... | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 RESOLVE: Cannot resolve host address: vpn.balena-cloud.com:443 (Temporary failure in name resolution) | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 RESOLVE: Cannot resolve host address: vpn.balena-cloud.com:443 (Temporary failure in name resolution) | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 Could not determine IPv4/IPv6 protocol | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 NOTE: UID/GID downgrade will be delayed because of --client, --pull, or --up-delay | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 SIGUSR1[soft,init_instance] received, process restarting | |
| Jun 24 09:04:59 a3659e1 openvpn[1037]: Thu Jun 24 09:04:59 2021 Restart pause, 5 second(s) | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1041]: dnsmasq[1041]: started, version 2.84rc2 cachesize 150 | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1041]: dnsmasq[1041]: compile time options: IPv6 GNU-getopt DBus no-UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP no-conntrack ipset auth no-cryptohash no-DNSSEC loop-detect inotify dumpfile | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1041]: dnsmasq[1041]: DBus support enabled: connected to system bus | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1041]: dnsmasq[1041]: reading /etc/resolv.dnsmasq | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1041]: dnsmasq[1041]: using nameserver 8.8.8.8#53 | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1041]: dnsmasq[1041]: read /etc/hosts - 6 addresses | |
| Jun 24 09:04:59 a3659e1 dnsmasq[1041]: dnsmasq[1041]: using nameserver 8.8.8.8#53 | |
| Jun 24 09:05:00 a3659e1 os-config[1039]: Fetching service configuration from https://api.resin.io/os/v1/config... | |
| Jun 24 09:05:00 a3659e1 os-config[1039]: https://api.resin.io/os/v1/config: error trying to connect: failed to lookup address information: Temporary failure in name resolution | |
| Jun 24 09:05:02 a3659e1 dbus-daemon[884]: [system] Successfully activated service 'org.freedesktop.hostname1' | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.5001] hostname: hostname: using hostnamed | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.5036] hostname: hostname changed from (none) to "a3659e1" | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.5261] dns-mgr[0x1ef7000]: init: dns=default,systemd-resolved rc-manager=resolvconf (auto) | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.5492] manager[0x1eec070]: rfkill: Wi-Fi hardware radio set enabled | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.5592] manager[0x1eec070]: rfkill: WWAN hardware radio set enabled | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.6208] Loaded device plugin: NMAtmManager (/usr/lib/NetworkManager/1.28.0/libnm-device-plugin-adsl.so) | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.7202] Loaded device plugin: NMBluezManager (/usr/lib/NetworkManager/1.28.0/libnm-device-plugin-bluetooth.so) | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.7465] Loaded device plugin: NMWifiFactory (/usr/lib/NetworkManager/1.28.0/libnm-device-plugin-wifi.so) | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.7642] Loaded device plugin: NMWwanFactory (/usr/lib/NetworkManager/1.28.0/libnm-device-plugin-wwan.so) | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.7960] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.8104] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.8276] manager: Networking is enabled by state file | |
| Jun 24 09:05:02 a3659e1 dbus-daemon[884]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=1029 comm="/usr/sbin/NetworkManager --no-daemon ") | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.8513] dhcp-init: Using DHCP client 'internal' | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.8599] settings: Loaded settings plugin: keyfile (internal) | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.9276] device (lo): carrier: link connected | |
| Jun 24 09:05:02 a3659e1 NetworkManager[1029]: <info> [1624525502.9495] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1) | |
| Jun 24 09:05:03 a3659e1 kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:05:03 a3659e1 kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:05:03 a3659e1 kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:05:03 a3659e1 kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:05:03 a3659e1 NetworkManager[1029]: <info> [1624525503.1955] manager: (eth0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2) | |
| Jun 24 09:05:03 a3659e1 NetworkManager[1029]: <info> [1624525503.4034] settings: (eth0): created default wired connection 'Wired connection 1' | |
| Jun 24 09:05:03 a3659e1 NetworkManager[1029]: <info> [1624525503.4674] device (eth0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external') | |
| Jun 24 09:05:03 a3659e1 dbus-daemon[884]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' | |
| Jun 24 09:05:03 a3659e1 kernel: ti-sysc 4a101200.target-module: OCP softreset timed out | |
| Jun 24 09:05:03 a3659e1 kernel: cpsw 4a100000.ethernet: initializing cpsw version 1.12 (0) | |
| Jun 24 09:05:03 a3659e1 kernel: SMSC LAN8710/LAN8720 4a101000.mdio:00: attached PHY driver [SMSC LAN8710/LAN8720] (mii_bus:phy_addr=4a101000.mdio:00, irq=POLL) | |
| Jun 24 09:05:03 a3659e1 NetworkManager[1029]: <info> [1624525503.9511] manager: (resin-dns): new Bridge device (/org/freedesktop/NetworkManager/Devices/3) | |
| Jun 24 09:05:04 a3659e1 NetworkManager[1029]: <info> [1624525504.4030] modem-manager: ModemManager available | |
| Jun 24 09:05:04 a3659e1 openvpn[1037]: Thu Jun 24 09:05:04 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:04 a3659e1 openvpn[1037]: Thu Jun 24 09:05:04 2021 RESOLVE: Cannot resolve host address: vpn.balena-cloud.com:443 (Temporary failure in name resolution) | |
| Jun 24 09:05:04 a3659e1 openvpn[1037]: Thu Jun 24 09:05:04 2021 RESOLVE: Cannot resolve host address: vpn.balena-cloud.com:443 (Temporary failure in name resolution) | |
| Jun 24 09:05:04 a3659e1 openvpn[1037]: Thu Jun 24 09:05:04 2021 Could not determine IPv4/IPv6 protocol | |
| Jun 24 09:05:04 a3659e1 openvpn[1037]: Thu Jun 24 09:05:04 2021 SIGUSR1[soft,init_instance] received, process restarting | |
| Jun 24 09:05:04 a3659e1 openvpn[1037]: Thu Jun 24 09:05:04 2021 Restart pause, 5 second(s) | |
| Jun 24 09:05:04 a3659e1 sh[1045]: resin-proxy-config: Found config.json in /mnt/boot/config.json . | |
| Jun 24 09:05:04 a3659e1 sh[1082]: iptables: No chain/target/match by that name. | |
| Jun 24 09:05:05 a3659e1 sh[1084]: iptables: No chain/target/match by that name. | |
| Jun 24 09:05:05 a3659e1 balenad[1043]: time="2021-06-24T09:05:05.118082382Z" level=info msg="Starting up" | |
| Jun 24 09:05:05 a3659e1 sh[1085]: iptables v1.8.4 (legacy): Couldn't load target `REDSOCKS':No such file or directory | |
| Jun 24 09:05:05 a3659e1 sh[1085]: Try `iptables -h' or 'iptables --help' for more information. | |
| Jun 24 09:05:05 a3659e1 balenad[1043]: time="2021-06-24T09:05:05.136347547Z" level=warning msg="Running experimental build" | |
| Jun 24 09:05:05 a3659e1 sh[1086]: iptables v1.8.4 (legacy): Couldn't load target `REDSOCKS':No such file or directory | |
| Jun 24 09:05:05 a3659e1 sh[1086]: Try `iptables -h' or 'iptables --help' for more information. | |
| Jun 24 09:05:05 a3659e1 sh[1087]: iptables v1.8.4 (legacy): Couldn't load target `REDSOCKS':No such file or directory | |
| Jun 24 09:05:05 a3659e1 sh[1087]: Try `iptables -h' or 'iptables --help' for more information. | |
| Jun 24 09:05:05 a3659e1 sh[1088]: iptables: No chain/target/match by that name. | |
| Jun 24 09:05:05 a3659e1 balenad[1043]: time="2021-06-24T09:05:05.345262029Z" level=info msg="libcontainerd: started new balena-engine-containerd process" pid=1089 | |
| Jun 24 09:05:05 a3659e1 sh[1091]: iptables: No chain/target/match by that name. | |
| Jun 24 09:05:05 a3659e1 sh[1045]: resin-proxy-config: No proxy configuration found, skipping. | |
| Jun 24 09:05:05 a3659e1 kernel: cpsw 4a100000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off | |
| Jun 24 09:05:05 a3659e1 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready | |
| Jun 24 09:05:05 a3659e1 NetworkManager[1029]: <info> [1624525505.7436] device (eth0): carrier: link connected | |
| Jun 24 09:05:05 a3659e1 NetworkManager[1029]: <info> [1624525505.7755] device (eth0): state change: unavailable -> disconnected (reason 'carrier-changed', sys-iface-state: 'managed') | |
| Jun 24 09:05:05 a3659e1 NetworkManager[1029]: <info> [1624525505.8483] policy: auto-activating connection 'Wired connection 1' (860464b2-ac9f-3db3-a8e8-fa6a8f6e92f4) | |
| Jun 24 09:05:05 a3659e1 NetworkManager[1029]: <info> [1624525505.8872] device (eth0): Activation: starting connection 'Wired connection 1' (860464b2-ac9f-3db3-a8e8-fa6a8f6e92f4) | |
| Jun 24 09:05:05 a3659e1 NetworkManager[1029]: <info> [1624525505.9064] device (eth0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed') | |
| Jun 24 09:05:05 a3659e1 NetworkManager[1029]: <info> [1624525505.9573] manager: NetworkManager state is now CONNECTING | |
| Jun 24 09:05:05 a3659e1 NetworkManager[1029]: <info> [1624525505.9873] device (eth0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed') | |
| Jun 24 09:05:06 a3659e1 NetworkManager[1029]: <info> [1624525506.0335] device (eth0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed') | |
| Jun 24 09:05:06 a3659e1 NetworkManager[1029]: <info> [1624525506.0742] dhcp4 (eth0): activation: beginning transaction (no timeout) | |
| Jun 24 09:05:06 a3659e1 avahi-daemon[1015]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::a6a3:ab84:e5a4:89e8. | |
| Jun 24 09:05:06 a3659e1 avahi-daemon[1015]: New relevant interface eth0.IPv6 for mDNS. | |
| Jun 24 09:05:06 a3659e1 avahi-daemon[1015]: Registering new address record for fe80::a6a3:ab84:e5a4:89e8 on eth0.*. | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.567794188Z" level=info msg="starting containerd" revision= version=1.2.0+unknown | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.580444090Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.583316759Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.649517394Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.658508672Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.676505685Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.685083945Z" level=info msg="metadata content store policy set" policy=shared | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.708751218Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.711245118Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.715650366Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.716869005Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.718092726Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.723353926Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.724670726Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.727386070Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.728585419Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.733227653Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.736351975Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.746369694Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.762085713Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.767138008Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.770561396Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.779017871Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.804336883Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.809096944Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.815794061Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.817828570Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.823671570Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.827420897Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.847016444Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.851706552Z" level=warning msg="failed to load plugin io.containerd.internal.v1.opt" error="mkdir /opt: read-only file system" | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.853112221Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.854192326Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.857428391Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.858419335Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.889881704Z" level=info msg=serving... address=/var/run/balena-engine/containerd/balena-engine-containerd-debug.sock | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.892850743Z" level=info msg=serving... address=/var/run/balena-engine/containerd/balena-engine-containerd.sock.ttrpc | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.898880648Z" level=info msg=serving... address=/var/run/balena-engine/containerd/balena-engine-containerd.sock | |
| Jun 24 09:05:06 a3659e1 balenad[1089]: time="2021-06-24T09:05:06.900225988Z" level=info msg="containerd successfully booted in 0.366684s" | |
| Jun 24 09:05:07 a3659e1 balenad[1043]: time="2021-06-24T09:05:07.120246669Z" level=warning msg="[graphdriver] WARNING: the aufs storage-driver is deprecated, and will be removed in a future release" | |
| Jun 24 09:05:09 a3659e1 balenad[1043]: time="2021-06-24T09:05:09.189210139Z" level=warning msg="Your kernel does not support cgroup blkio weight" | |
| Jun 24 09:05:09 a3659e1 balenad[1043]: time="2021-06-24T09:05:09.195042514Z" level=warning msg="Your kernel does not support cgroup blkio weight_device" | |
| Jun 24 09:05:09 a3659e1 balenad[1043]: time="2021-06-24T09:05:09.200675526Z" level=info msg="Loading containers: start." | |
| Jun 24 09:05:09 a3659e1 openvpn[1037]: Thu Jun 24 09:05:09 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:09 a3659e1 openvpn[1037]: Thu Jun 24 09:05:09 2021 RESOLVE: Cannot resolve host address: vpn.balena-cloud.com:443 (Temporary failure in name resolution) | |
| Jun 24 09:05:09 a3659e1 openvpn[1037]: Thu Jun 24 09:05:09 2021 RESOLVE: Cannot resolve host address: vpn.balena-cloud.com:443 (Temporary failure in name resolution) | |
| Jun 24 09:05:09 a3659e1 openvpn[1037]: Thu Jun 24 09:05:09 2021 Could not determine IPv4/IPv6 protocol | |
| Jun 24 09:05:09 a3659e1 openvpn[1037]: Thu Jun 24 09:05:09 2021 SIGUSR1[soft,init_instance] received, process restarting | |
| Jun 24 09:05:09 a3659e1 openvpn[1037]: Thu Jun 24 09:05:09 2021 Restart pause, 5 second(s) | |
| Jun 24 09:05:10 a3659e1 kernel: Bridge firewalling registered | |
| Jun 24 09:05:10 a3659e1 os-config[1039]: Awaiting service configuration... | |
| Jun 24 09:05:11 a3659e1 kernel: Initializing XFRM netlink socket | |
| Jun 24 09:05:11 a3659e1 systemd-udevd[1112]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:05:11 a3659e1 systemd-udevd[1112]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:05:11 a3659e1 NetworkManager[1029]: <info> [1624525511.8445] manager: (balena0): new Bridge device (/org/freedesktop/NetworkManager/Devices/4) | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0555] dhcp4 (eth0): option dhcp_lease_time => '24330' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0584] dhcp4 (eth0): option domain_name => 'koppertcress.com' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0625] dhcp4 (eth0): option domain_name_servers => '208.67.222.222 8.8.8.8' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0702] dhcp4 (eth0): option expiry => '1624549841' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0717] dhcp4 (eth0): option ip_address => '10.10.65.104' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0749] dhcp4 (eth0): option requested_broadcast_address => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0751] dhcp4 (eth0): option requested_domain_name => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0753] dhcp4 (eth0): option requested_domain_name_servers => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0754] dhcp4 (eth0): option requested_domain_search => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0755] dhcp4 (eth0): option requested_host_name => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0756] dhcp4 (eth0): option requested_interface_mtu => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0757] dhcp4 (eth0): option requested_ms_classless_static_routes => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0758] dhcp4 (eth0): option requested_nis_domain => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0759] dhcp4 (eth0): option requested_nis_servers => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0761] dhcp4 (eth0): option requested_ntp_servers => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0762] dhcp4 (eth0): option requested_rfc3442_classless_static_routes => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0763] dhcp4 (eth0): option requested_root_path => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0764] dhcp4 (eth0): option requested_routers => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0765] dhcp4 (eth0): option requested_static_routes => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0766] dhcp4 (eth0): option requested_subnet_mask => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0767] dhcp4 (eth0): option requested_time_offset => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0768] dhcp4 (eth0): option requested_wpad => '1' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0769] dhcp4 (eth0): option routers => '10.10.65.254' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0770] dhcp4 (eth0): option subnet_mask => '255.255.255.0' | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.0771] dhcp4 (eth0): state changed unknown -> bound | |
| Jun 24 09:05:12 a3659e1 avahi-daemon[1015]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.10.65.104. | |
| Jun 24 09:05:12 a3659e1 avahi-daemon[1015]: New relevant interface eth0.IPv4 for mDNS. | |
| Jun 24 09:05:12 a3659e1 avahi-daemon[1015]: Registering new address record for 10.10.65.104 on eth0.IPv4. | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.1977] device (eth0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed') | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.3448] device (eth0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed') | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.3727] device (eth0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed') | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.4156] manager: NetworkManager state is now CONNECTED_LOCAL | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.5192] manager: NetworkManager state is now CONNECTED_SITE | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.5368] policy: set 'Wired connection 1' (eth0) as default for IPv4 routing and DNS | |
| Jun 24 09:05:12 a3659e1 NetworkManager[1029]: <info> [1624525512.5680] dns-mgr: Writing DNS information to /sbin/resolvconf | |
| Jun 24 09:05:12 a3659e1 os-config[1039]: Service configuration retrieved | |
| Jun 24 09:05:12 a3659e1 os-config[1039]: No configuration changes | |
| Jun 24 09:05:12 a3659e1 dnsmasq[1041]: dnsmasq[1041]: reading /etc/resolv.dnsmasq | |
| Jun 24 09:05:12 a3659e1 dnsmasq[1041]: dnsmasq[1041]: using nameserver 8.8.8.8#53 | |
| Jun 24 09:05:12 a3659e1 dnsmasq[1041]: dnsmasq[1041]: using nameserver 208.67.222.222#53 | |
| Jun 24 09:05:12 a3659e1 dnsmasq[1041]: dnsmasq[1041]: using nameserver 8.8.8.8#53 | |
| Jun 24 09:05:13 a3659e1 NetworkManager[1029]: <info> [1624525513.0518] device (eth0): Activation: successful, device activated. | |
| Jun 24 09:05:13 a3659e1 NetworkManager[1029]: <info> [1624525513.1214] manager: startup complete | |
| Jun 24 09:05:13 a3659e1 nm-dispatcher[1188]: Setting NTP source on/offline status (eth0 up). | |
| Jun 24 09:05:13 a3659e1 avahi-daemon[1015]: Joining mDNS multicast group on interface balena0.IPv4 with address 10.114.101.1. | |
| Jun 24 09:05:13 a3659e1 avahi-daemon[1015]: New relevant interface balena0.IPv4 for mDNS. | |
| Jun 24 09:05:13 a3659e1 avahi-daemon[1015]: Registering new address record for 10.114.101.1 on balena0.IPv4. | |
| Jun 24 09:05:13 a3659e1 systemd-udevd[1112]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:05:14 a3659e1 NetworkManager[1029]: <info> [1624525514.0097] manager: (br-f0a77408ae8d): new Bridge device (/org/freedesktop/NetworkManager/Devices/5) | |
| Jun 24 09:05:14 a3659e1 openvpn[1037]: Thu Jun 24 09:05:14 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:14 a3659e1 openvpn[1037]: Thu Jun 24 09:05:14 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:05:14 a3659e1 openvpn[1037]: Thu Jun 24 09:05:14 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:05:14 a3659e1 openvpn[1037]: Thu Jun 24 09:05:14 2021 Attempting to establish TCP connection with [AF_INET]3.227.28.93:443 [nonblock] | |
| Jun 24 09:05:14 a3659e1 NetworkManager[1029]: <info> [1624525514.8733] manager: NetworkManager state is now CONNECTED_GLOBAL | |
| Jun 24 09:05:15 a3659e1 avahi-daemon[1015]: Joining mDNS multicast group on interface br-f0a77408ae8d.IPv4 with address 172.18.0.1. | |
| Jun 24 09:05:15 a3659e1 avahi-daemon[1015]: New relevant interface br-f0a77408ae8d.IPv4 for mDNS. | |
| Jun 24 09:05:15 a3659e1 avahi-daemon[1015]: Registering new address record for 172.18.0.1 on br-f0a77408ae8d.IPv4. | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 TCP connection established with [AF_INET]3.227.28.93:443 | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 TCP_CLIENT link remote: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:05:15 a3659e1 balenad[1043]: time="2021-06-24T09:05:15.635253514Z" level=warning msg="could not create bridge network for id 4a823878cbcfe08cc05b138ade6cdd53ebce1353e94767a09ee7715c7edf11fb bridge name docker0 while booting up from persistent state: bridge device with non default name docker0 must be created manually" | |
| Jun 24 09:05:15 a3659e1 systemd-udevd[1112]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:05:15 a3659e1 NetworkManager[1029]: <info> [1624525515.6849] manager: (supervisor0): new Bridge device (/org/freedesktop/NetworkManager/Devices/6) | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 TLS: Initial packet from [AF_INET]3.227.28.93:443, sid=18bb5a27 6ad6a16b | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 WARNING: this configuration may cache passwords in memory -- use the auth-nocache option to prevent this | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 Connection reset, restarting [-1] | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:05:15 a3659e1 openvpn[1037]: Thu Jun 24 09:05:15 2021 Restart pause, 5 second(s) | |
| Jun 24 09:05:16 a3659e1 avahi-daemon[1015]: Joining mDNS multicast group on interface supervisor0.IPv4 with address 10.114.104.1. | |
| Jun 24 09:05:16 a3659e1 avahi-daemon[1015]: New relevant interface supervisor0.IPv4 for mDNS. | |
| Jun 24 09:05:16 a3659e1 avahi-daemon[1015]: Registering new address record for 10.114.104.1 on supervisor0.IPv4. | |
| Jun 24 09:05:16 a3659e1 NetworkManager[1029]: <info> [1624525516.8453] device (supervisor0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.0597] device (supervisor0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.1259] device (supervisor0): Activation: starting connection 'supervisor0' (0b315acc-dda1-4b07-91c8-e781fd0f5e02) | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.2214] device (supervisor0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.2647] device (supervisor0): state change: prepare -> config (reason 'none', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.3000] device (supervisor0): state change: config -> ip-config (reason 'none', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.3289] device (supervisor0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.4314] device (supervisor0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.4612] device (supervisor0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external') | |
| Jun 24 09:05:17 a3659e1 NetworkManager[1029]: <info> [1624525517.5712] device (supervisor0): Activation: successful, device activated. | |
| Jun 24 09:05:18 a3659e1 nm-dispatcher[1258]: Setting NTP source on/offline status (supervisor0 up). | |
| Jun 24 09:05:19 a3659e1 balenad[1043]: time="2021-06-24T09:05:19.112928882Z" level=info msg="Removing stale sandbox 5fefc75c4779923aff47208ae95d98e4b2a62a2633a541cacc50b5bf93626495 (2c82cbb482d8185da6e878787c42cc64c18339a7a0337a71ce437c0794d5160a)" | |
| Jun 24 09:05:19 a3659e1 balenad[1043]: time="2021-06-24T09:05:19.156015629Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 0a8801355accbe175dabb9ada14d7555c08550d808effcc21df19d4697e75fcc a6b77e10c0d1485647d54396e97ddc4a0f4a795f66aea64b5ddeb2def82a16fe], retrying...." | |
| Jun 24 09:05:19 a3659e1 chronyd[882]: 2021-06-24T09:05:19Z Selected source 162.159.200.1 (1.resinio.pool.ntp.org) | |
| Jun 24 09:05:20 a3659e1 openvpn[1037]: Thu Jun 24 09:05:20 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:20 a3659e1 openvpn[1037]: Thu Jun 24 09:05:20 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:05:20 a3659e1 openvpn[1037]: Thu Jun 24 09:05:20 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:05:20 a3659e1 openvpn[1037]: Thu Jun 24 09:05:20 2021 Attempting to establish TCP connection with [AF_INET]35.169.89.252:443 [nonblock] | |
| Jun 24 09:05:21 a3659e1 openvpn[1037]: Thu Jun 24 09:05:21 2021 TCP connection established with [AF_INET]35.169.89.252:443 | |
| Jun 24 09:05:21 a3659e1 openvpn[1037]: Thu Jun 24 09:05:21 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:05:21 a3659e1 openvpn[1037]: Thu Jun 24 09:05:21 2021 TCP_CLIENT link remote: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:05:21 a3659e1 openvpn[1037]: Thu Jun 24 09:05:21 2021 TLS: Initial packet from [AF_INET]35.169.89.252:443, sid=5b6f896e a94370bb | |
| Jun 24 09:05:21 a3659e1 openvpn[1037]: Thu Jun 24 09:05:21 2021 Connection reset, restarting [-1] | |
| Jun 24 09:05:21 a3659e1 openvpn[1037]: Thu Jun 24 09:05:21 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:05:21 a3659e1 openvpn[1037]: Thu Jun 24 09:05:21 2021 Restart pause, 5 second(s) | |
| Jun 24 09:05:25 a3659e1 balenad[1089]: time="2021-06-24T09:05:25.771779780Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/542e7b77f8f28efd8504d5bad144fbef1374c5ca26c28f99f5e52b372852a518.sock debug=false pid=1322 | |
| Jun 24 09:05:25 a3659e1 balenad[1089]: time="2021-06-24T09:05:25.907387214Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/51dd7537152234cbb1936472777b5c9025f82f07adc095c63d4112e60510ed52.sock debug=false pid=1325 | |
| Jun 24 09:05:26 a3659e1 openvpn[1037]: Thu Jun 24 09:05:26 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:26 a3659e1 openvpn[1037]: Thu Jun 24 09:05:26 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:05:26 a3659e1 openvpn[1037]: Thu Jun 24 09:05:26 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:05:26 a3659e1 openvpn[1037]: Thu Jun 24 09:05:26 2021 Attempting to establish TCP connection with [AF_INET]35.169.76.143:443 [nonblock] | |
| Jun 24 09:05:27 a3659e1 openvpn[1037]: Thu Jun 24 09:05:27 2021 TCP connection established with [AF_INET]35.169.76.143:443 | |
| Jun 24 09:05:27 a3659e1 openvpn[1037]: Thu Jun 24 09:05:27 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:05:27 a3659e1 openvpn[1037]: Thu Jun 24 09:05:27 2021 TCP_CLIENT link remote: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:05:28 a3659e1 openvpn[1037]: Thu Jun 24 09:05:28 2021 TLS: Initial packet from [AF_INET]35.169.76.143:443, sid=018e5de9 30fa2326 | |
| Jun 24 09:05:28 a3659e1 openvpn[1037]: Thu Jun 24 09:05:28 2021 Connection reset, restarting [-1] | |
| Jun 24 09:05:28 a3659e1 openvpn[1037]: Thu Jun 24 09:05:28 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:05:28 a3659e1 openvpn[1037]: Thu Jun 24 09:05:28 2021 Restart pause, 5 second(s) | |
| Jun 24 09:05:29 a3659e1 kernel: cgroup: cgroup: disabling cgroup2 socket matching due to net_prio or net_cls activation | |
| Jun 24 09:05:33 a3659e1 openvpn[1037]: Thu Jun 24 09:05:33 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:33 a3659e1 openvpn[1037]: Thu Jun 24 09:05:33 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:05:33 a3659e1 openvpn[1037]: Thu Jun 24 09:05:33 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:05:33 a3659e1 openvpn[1037]: Thu Jun 24 09:05:33 2021 Attempting to establish TCP connection with [AF_INET]35.169.76.143:443 [nonblock] | |
| Jun 24 09:05:34 a3659e1 openvpn[1037]: Thu Jun 24 09:05:34 2021 TCP connection established with [AF_INET]35.169.76.143:443 | |
| Jun 24 09:05:34 a3659e1 openvpn[1037]: Thu Jun 24 09:05:34 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:05:34 a3659e1 openvpn[1037]: Thu Jun 24 09:05:34 2021 TCP_CLIENT link remote: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:05:34 a3659e1 openvpn[1037]: Thu Jun 24 09:05:34 2021 TLS: Initial packet from [AF_INET]35.169.76.143:443, sid=ba1292b3 6feee153 | |
| Jun 24 09:05:34 a3659e1 openvpn[1037]: Thu Jun 24 09:05:34 2021 Connection reset, restarting [-1] | |
| Jun 24 09:05:34 a3659e1 openvpn[1037]: Thu Jun 24 09:05:34 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:05:34 a3659e1 openvpn[1037]: Thu Jun 24 09:05:34 2021 Restart pause, 10 second(s) | |
| Jun 24 09:05:42 a3659e1 2c82cbb482d8[1043]: [29B blob data] | |
| Jun 24 09:05:43 a3659e1 kernel: Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist. | |
| Jun 24 09:05:43 a3659e1 2c82cbb482d8[1043]: [179B blob data] | |
| Jun 24 09:05:43 a3659e1 2c82cbb482d8[1043]: [32B blob data] | |
| Jun 24 09:05:43 a3659e1 2c82cbb482d8[1043]: [27B blob data] | |
| Jun 24 09:05:43 a3659e1 2c82cbb482d8[1043]: [27B blob data] | |
| Jun 24 09:05:43 a3659e1 2c82cbb482d8[1043]: [69B blob data] | |
| Jun 24 09:05:44 a3659e1 openvpn[1037]: Thu Jun 24 09:05:44 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:44 a3659e1 openvpn[1037]: Thu Jun 24 09:05:44 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:05:44 a3659e1 openvpn[1037]: Thu Jun 24 09:05:44 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:05:44 a3659e1 openvpn[1037]: Thu Jun 24 09:05:44 2021 Attempting to establish TCP connection with [AF_INET]35.169.89.252:443 [nonblock] | |
| Jun 24 09:05:44 a3659e1 balenad[1043]: time="2021-06-24T09:05:44.888440729Z" level=info msg="Loading containers: done." | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 TCP connection established with [AF_INET]35.169.89.252:443 | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 TCP_CLIENT link remote: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 TLS: Initial packet from [AF_INET]35.169.89.252:443, sid=e7dd48a6 f30382e3 | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 Connection reset, restarting [0] | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:05:45 a3659e1 openvpn[1037]: Thu Jun 24 09:05:45 2021 Restart pause, 10 second(s) | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [108B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [94B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [98B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [98B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [114B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [102B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [106B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [112B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [110B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [92B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [84B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [80B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [100B blob data] | |
| Jun 24 09:05:46 a3659e1 2c82cbb482d8[1043]: [102B blob data] | |
| Jun 24 09:05:47 a3659e1 balenad[1043]: time="2021-06-24T09:05:47.492848233Z" level=info msg="Docker daemon" commit=074a481789174b4b6fd2d706086e8ffceb72e924 graphdriver(s)=aufs version=19.03.13-dev | |
| Jun 24 09:05:47 a3659e1 balenad[1043]: time="2021-06-24T09:05:47.507568600Z" level=info msg="Daemon has completed initialization" | |
| Jun 24 09:05:48 a3659e1 balenad[1043]: time="2021-06-24T09:05:48.086292413Z" level=info msg="API listen on /var/run/balena-engine.sock" | |
| Jun 24 09:05:48 a3659e1 balenad[1043]: time="2021-06-24T09:05:48.200504138Z" level=info msg="API listen on /run/balena-engine.sock" | |
| Jun 24 09:05:48 a3659e1 balenad[1043]: time="2021-06-24T09:05:48.383143913Z" level=info msg="API listen on /var/run/balena.sock" | |
| Jun 24 09:05:51 a3659e1 systemd-journald[44]: Received request to flush runtime journal from PID 1 | |
| Jun 24 09:05:55 a3659e1 openvpn[1037]: Thu Jun 24 09:05:55 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:05:55 a3659e1 openvpn[1037]: Thu Jun 24 09:05:55 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:05:55 a3659e1 openvpn[1037]: Thu Jun 24 09:05:55 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:05:55 a3659e1 openvpn[1037]: Thu Jun 24 09:05:55 2021 Attempting to establish TCP connection with [AF_INET]3.227.28.93:443 [nonblock] | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 TCP connection established with [AF_INET]3.227.28.93:443 | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 TCP_CLIENT link remote: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 TLS: Initial packet from [AF_INET]3.227.28.93:443, sid=99adc9e9 db0d17dc | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 Connection reset, restarting [0] | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:05:56 a3659e1 openvpn[1037]: Thu Jun 24 09:05:56 2021 Restart pause, 10 second(s) | |
| Jun 24 09:05:58 a3659e1 sh[1495]: Rollback: Parsing bootloader configuration | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [19B blob data] | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [46B blob data] | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [51B blob data] | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [51B blob data] | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [50B blob data] | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [55B blob data] | |
| Jun 24 09:05:59 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:06:00 a3659e1 2c82cbb482d8[1043]: [16B blob data] | |
| Jun 24 09:06:05 a3659e1 sh[1567]: rollbacks: Previous Host OS META_BALENA_VERSION:2.47.1 OK for rollbacks. | |
| Jun 24 09:06:05 a3659e1 sh[1495]: Rollback: Health sanity check | |
| Jun 24 09:06:05 a3659e1 sh[1495]: Rollback: HUP detected. Running healthchecks after 60 seconds | |
| Jun 24 09:06:06 a3659e1 openvpn[1037]: Thu Jun 24 09:06:06 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:06:06 a3659e1 openvpn[1037]: Thu Jun 24 09:06:06 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:06:06 a3659e1 openvpn[1037]: Thu Jun 24 09:06:06 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:06:06 a3659e1 openvpn[1037]: Thu Jun 24 09:06:06 2021 Attempting to establish TCP connection with [AF_INET]3.227.28.93:443 [nonblock] | |
| Jun 24 09:06:07 a3659e1 2c82cbb482d8[1043]: [23B blob data] | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 TCP connection established with [AF_INET]3.227.28.93:443 | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 TCP_CLIENT link remote: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 TLS: Initial packet from [AF_INET]3.227.28.93:443, sid=c0b5e814 99ae9530 | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 Connection reset, restarting [0] | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:06:07 a3659e1 openvpn[1037]: Thu Jun 24 09:06:07 2021 Restart pause, 20 second(s) | |
| Jun 24 09:06:08 a3659e1 2c82cbb482d8[1043]: [5B blob data] | |
| Jun 24 09:06:09 a3659e1 2c82cbb482d8[1043]: [19B blob data] | |
| Jun 24 09:06:10 a3659e1 2c82cbb482d8[1043]: [21B blob data] | |
| Jun 24 09:06:10 a3659e1 2c82cbb482d8[1043]: [31B blob data] | |
| Jun 24 09:06:10 a3659e1 2c82cbb482d8[1043]: [17B blob data] | |
| Jun 24 09:06:11 a3659e1 systemd-logind[940]: Watching system buttons on /dev/input/event0 (tps65217_pwr_but) | |
| Jun 24 09:06:11 a3659e1 balenad[1089]: time="2021-06-24T09:06:11.501545092Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/4fef63f17c2b2cf9507ad177a6f9b8b2abcf6aa21fdc84860b573590deff7bae.sock debug=false pid=1619 | |
| Jun 24 09:06:15 a3659e1 balenad[1043]: time="2021-06-24T09:06:15.683492805Z" level=info msg="Container f44300088b61617b566f37958100f91ff13c55768c12ff0866bed7e53e37324a failed to exit within 10 seconds of signal 15 - using the force" | |
| Jun 24 09:06:18 a3659e1 f44300088b61[1043]: [info] Supervisor v12.4.6 starting up... | |
| Jun 24 09:06:22 a3659e1 systemd-udevd[1514]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:06:22 a3659e1 systemd-udevd[1514]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:06:24 a3659e1 f44300088b61[1043]: [info] Setting host to discoverable | |
| Jun 24 09:06:24 a3659e1 f44300088b61[1043]: [info] 🔥 Applying firewall mode: off | |
| Jun 24 09:06:24 a3659e1 f44300088b61[1043]: [debug] Starting logging infrastructure | |
| Jun 24 09:06:25 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:06:25 a3659e1 2c82cbb482d8[1043]: [45B blob data] | |
| Jun 24 09:06:25 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:06:26 a3659e1 f44300088b61[1043]: [info] Starting firewall | |
| Jun 24 09:06:26 a3659e1 f44300088b61[1043]: [debug] Performing database cleanup for container log timestamps | |
| Jun 24 09:06:27 a3659e1 ModemManager[869]: [base-manager] couldn't check support for device '/sys/devices/platform/ocp/4a000000.interconnect/4a000000.interconnect:segment@0/4a101200.target-module/4a100000.ethernet': not supported by any plugin | |
| Jun 24 09:06:27 a3659e1 openvpn[1037]: Thu Jun 24 09:06:27 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:06:27 a3659e1 openvpn[1037]: Thu Jun 24 09:06:27 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:06:27 a3659e1 openvpn[1037]: Thu Jun 24 09:06:27 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:06:27 a3659e1 openvpn[1037]: Thu Jun 24 09:06:27 2021 Attempting to establish TCP connection with [AF_INET]35.169.76.143:443 [nonblock] | |
| Jun 24 09:06:28 a3659e1 systemd-udevd[1509]: zram0: Failed to substitute variable '$parent' or apply format '%P', ignoring: No such file or directory | |
| Jun 24 09:06:28 a3659e1 systemd[1]: docker-f44300088b61617b566f37958100f91ff13c55768c12ff0866bed7e53e37324a.scope: Consumed 11.451s CPU time. | |
| Jun 24 09:06:28 a3659e1 openvpn[1037]: Thu Jun 24 09:06:28 2021 TCP connection established with [AF_INET]35.169.76.143:443 | |
| Jun 24 09:06:28 a3659e1 openvpn[1037]: Thu Jun 24 09:06:28 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:06:28 a3659e1 openvpn[1037]: Thu Jun 24 09:06:28 2021 TCP_CLIENT link remote: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:06:29 a3659e1 openvpn[1037]: Thu Jun 24 09:06:29 2021 TLS: Initial packet from [AF_INET]35.169.76.143:443, sid=aa875265 27276c51 | |
| Jun 24 09:06:29 a3659e1 openvpn[1037]: Thu Jun 24 09:06:29 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:06:29 a3659e1 openvpn[1037]: Thu Jun 24 09:06:29 2021 Connection reset, restarting [0] | |
| Jun 24 09:06:29 a3659e1 openvpn[1037]: Thu Jun 24 09:06:29 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:06:29 a3659e1 openvpn[1037]: Thu Jun 24 09:06:29 2021 Restart pause, 20 second(s) | |
| Jun 24 09:06:29 a3659e1 systemd-udevd[1519]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:06:29 a3659e1 systemd-udevd[1515]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:06:29 a3659e1 systemd-udevd[1510]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:06:29 a3659e1 systemd-udevd[1514]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:06:29 a3659e1 systemd-udevd[1519]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:06:29 a3659e1 systemd-udevd[1515]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:06:29 a3659e1 systemd-udevd[1510]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:06:30 a3659e1 kernel: zram: Can't change algorithm for initialized device | |
| Jun 24 09:06:30 a3659e1 systemd-udevd[1514]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:06:30 a3659e1 systemd-udevd[1509]: zram0: Process '/lib/udev/zram-swap-init /dev/zram0' failed with exit code 1. | |
| Jun 24 09:06:31 a3659e1 systemd-udevd[1519]: ptmx: Failed to process device, ignoring: File exists | |
| Jun 24 09:06:33 a3659e1 systemd-vconsole-setup[1820]: KD_FONT_OP_GET failed while trying to get the font metadata: Function not implemented | |
| Jun 24 09:06:33 a3659e1 systemd-vconsole-setup[1820]: Fonts will not be copied to remaining consoles | |
| Jun 24 09:06:38 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:06:38 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:06:38 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:06:38 a3659e1 2c82cbb482d8[1043]: [19B blob data] | |
| Jun 24 09:06:38 a3659e1 2c82cbb482d8[1043]: [19B blob data] | |
| Jun 24 09:06:40 a3659e1 balenad[1089]: time="2021-06-24T09:06:40.764449073Z" level=info msg="shim reaped" id=f44300088b61617b566f37958100f91ff13c55768c12ff0866bed7e53e37324a | |
| Jun 24 09:06:40 a3659e1 balenad[1043]: time="2021-06-24T09:06:40.860146022Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:06:41 a3659e1 resin-supervisor[1494]: resin_supervisor | |
| Jun 24 09:06:42 a3659e1 resin-supervisor[1892]: active | |
| Jun 24 09:06:49 a3659e1 openvpn[1037]: Thu Jun 24 09:06:49 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:06:49 a3659e1 openvpn[1037]: Thu Jun 24 09:06:49 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:06:49 a3659e1 openvpn[1037]: Thu Jun 24 09:06:49 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:06:49 a3659e1 openvpn[1037]: Thu Jun 24 09:06:49 2021 Attempting to establish TCP connection with [AF_INET]35.169.89.252:443 [nonblock] | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 TCP connection established with [AF_INET]35.169.89.252:443 | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 TCP_CLIENT link remote: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 TLS: Initial packet from [AF_INET]35.169.89.252:443, sid=1c89bc64 87cd0b6a | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 Connection reset, restarting [0] | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:06:50 a3659e1 openvpn[1037]: Thu Jun 24 09:06:50 2021 Restart pause, 20 second(s) | |
| Jun 24 09:06:51 a3659e1 balenad[1089]: time="2021-06-24T09:06:51.079774557Z" level=info msg="shim reaped" id=74384d643210b55b138910f4a15ee05b81a159f3dab5f8f89391d4bf8aeb95c2 | |
| Jun 24 09:06:51 a3659e1 balenad[1043]: time="2021-06-24T09:06:51.138386167Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:07:02 a3659e1 resin-supervisor[1893]: Container config has not changed | |
| Jun 24 09:07:03 a3659e1 balenad[1089]: time="2021-06-24T09:07:03.706589029Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/542e7b77f8f28efd8504d5bad144fbef1374c5ca26c28f99f5e52b372852a518.sock debug=false pid=2020 | |
| Jun 24 09:07:05 a3659e1 sh[1495]: Rollback: Running healthchecks to see if new system is stable | |
| Jun 24 09:07:07 a3659e1 sh[2044]: Rollback: Running tests | |
| Jun 24 09:07:07 a3659e1 sh[2044]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:07:07 a3659e1 sh[1495]: Trying healthcheck again 0 of 15 attempts | |
| Jun 24 09:07:10 a3659e1 openvpn[1037]: Thu Jun 24 09:07:10 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:07:10 a3659e1 openvpn[1037]: Thu Jun 24 09:07:10 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:07:10 a3659e1 openvpn[1037]: Thu Jun 24 09:07:10 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:07:10 a3659e1 openvpn[1037]: Thu Jun 24 09:07:10 2021 Attempting to establish TCP connection with [AF_INET]35.169.89.252:443 [nonblock] | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 TCP connection established with [AF_INET]35.169.89.252:443 | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 TCP_CLIENT link remote: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 TLS: Initial packet from [AF_INET]35.169.89.252:443, sid=2d5f4ecb cc3467e6 | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 Connection reset, restarting [0] | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:07:11 a3659e1 openvpn[1037]: Thu Jun 24 09:07:11 2021 Restart pause, 40 second(s) | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [42B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [81B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [76B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [21B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [81B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [85B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [40B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [55B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [83B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [65B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [65B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [81B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [61B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [81B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [75B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [53B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [1B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [26B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [81B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [76B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [21B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [81B blob data] | |
| Jun 24 09:07:14 a3659e1 2c82cbb482d8[1043]: [29B blob data] | |
| Jun 24 09:07:18 a3659e1 f44300088b61[1043]: [info] Supervisor v12.4.6 starting up... | |
| Jun 24 09:07:18 a3659e1 resin-supervisor[2014]: [info] Supervisor v12.4.6 starting up... | |
| Jun 24 09:07:20 a3659e1 f44300088b61[1043]: [info] Setting host to discoverable | |
| Jun 24 09:07:20 a3659e1 resin-supervisor[2014]: [info] Setting host to discoverable | |
| Jun 24 09:07:20 a3659e1 resin-supervisor[2014]: [info] 🔥 Applying firewall mode: off | |
| Jun 24 09:07:20 a3659e1 f44300088b61[1043]: [info] 🔥 Applying firewall mode: off | |
| Jun 24 09:07:20 a3659e1 f44300088b61[1043]: [debug] Starting logging infrastructure | |
| Jun 24 09:07:20 a3659e1 resin-supervisor[2014]: [debug] Starting logging infrastructure | |
| Jun 24 09:07:20 a3659e1 f44300088b61[1043]: [debug] Performing database cleanup for container log timestamps | |
| Jun 24 09:07:20 a3659e1 resin-supervisor[2014]: [debug] Performing database cleanup for container log timestamps | |
| Jun 24 09:07:20 a3659e1 f44300088b61[1043]: [info] Starting firewall | |
| Jun 24 09:07:20 a3659e1 resin-supervisor[2014]: [info] Starting firewall | |
| Jun 24 09:07:21 a3659e1 f44300088b61[1043]: [info] Previous engine snapshot was not stored. Skipping cleanup. | |
| Jun 24 09:07:21 a3659e1 resin-supervisor[2014]: [info] Previous engine snapshot was not stored. Skipping cleanup. | |
| Jun 24 09:07:21 a3659e1 resin-supervisor[2014]: [debug] Handling of local mode switch is completed | |
| Jun 24 09:07:21 a3659e1 f44300088b61[1043]: [debug] Handling of local mode switch is completed | |
| Jun 24 09:07:21 a3659e1 f44300088b61[1043]: [success] 🔥 Firewall mode applied | |
| Jun 24 09:07:21 a3659e1 resin-supervisor[2014]: [success] 🔥 Firewall mode applied | |
| Jun 24 09:07:21 a3659e1 f44300088b61[1043]: [debug] Starting api binder | |
| Jun 24 09:07:21 a3659e1 resin-supervisor[2014]: [debug] Starting api binder | |
| Jun 24 09:07:21 a3659e1 f44300088b61[1043]: (node:1) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. | |
| Jun 24 09:07:21 a3659e1 resin-supervisor[2014]: (node:1) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. | |
| Jun 24 09:07:22 a3659e1 f44300088b61[1043]: [info] API Binder bound to: https://api.resin.io/v6/ | |
| Jun 24 09:07:22 a3659e1 resin-supervisor[2014]: [info] API Binder bound to: https://api.resin.io/v6/ | |
| Jun 24 09:07:22 a3659e1 f44300088b61[1043]: [event] Event: Supervisor start {} | |
| Jun 24 09:07:22 a3659e1 resin-supervisor[2014]: [event] Event: Supervisor start {} | |
| Jun 24 09:07:22 a3659e1 f44300088b61[1043]: [debug] Spawning journald with: chroot /mnt/root journalctl -a -S 2021-06-23 07:57:42 -o json CONTAINER_ID_FULL=2c82cbb482d8185da6e878787c42cc64c18339a7a0337a71ce437c0794d5160a | |
| Jun 24 09:07:22 a3659e1 resin-supervisor[2014]: [debug] Spawning journald with: chroot /mnt/root journalctl -a -S 2021-06-23 07:57:42 -o json CONTAINER_ID_FULL=2c82cbb482d8185da6e878787c42cc64c18339a7a0337a71ce437c0794d5160a | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [debug] Connectivity check enabled: true | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [debug] Connectivity check enabled: true | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [debug] Starting periodic check for IP addresses | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [debug] Starting periodic check for IP addresses | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [info] Reporting initial state, supervisor version and API info | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [info] Reporting initial state, supervisor version and API info | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [debug] Skipping preloading | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [debug] Skipping preloading | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [info] VPN connection is not active. | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [info] VPN connection is not active. | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [info] Waiting for connectivity... | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [info] Waiting for connectivity... | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [info] Starting API server | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [info] Starting API server | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [info] Supervisor API successfully started on port 48484 | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [info] Supervisor API successfully started on port 48484 | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [info] Applying target state | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [info] Applying target state | |
| Jun 24 09:07:24 a3659e1 f44300088b61[1043]: [debug] Ensuring device is provisioned | |
| Jun 24 09:07:24 a3659e1 resin-supervisor[2014]: [debug] Ensuring device is provisioned | |
| Jun 24 09:07:25 a3659e1 f44300088b61[1043]: [debug] Starting current state report | |
| Jun 24 09:07:25 a3659e1 resin-supervisor[2014]: [debug] Starting current state report | |
| Jun 24 09:07:25 a3659e1 f44300088b61[1043]: [debug] Starting target state poll | |
| Jun 24 09:07:25 a3659e1 resin-supervisor[2014]: [debug] Starting target state poll | |
| Jun 24 09:07:25 a3659e1 f44300088b61[1043]: [debug] Spawning journald with: chroot /mnt/root journalctl -a --follow -o json _SYSTEMD_UNIT=balena.service | |
| Jun 24 09:07:25 a3659e1 resin-supervisor[2014]: [debug] Spawning journald with: chroot /mnt/root journalctl -a --follow -o json _SYSTEMD_UNIT=balena.service | |
| Jun 24 09:07:27 a3659e1 f44300088b61[1043]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:27 a3659e1 resin-supervisor[2014]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:27 a3659e1 f44300088b61[1043]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:27 a3659e1 resin-supervisor[2014]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:27 a3659e1 f44300088b61[1043]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:27 a3659e1 resin-supervisor[2014]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:27 a3659e1 f44300088b61[1043]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:27 a3659e1 resin-supervisor[2014]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:27 a3659e1 f44300088b61[1043]: [event] Event: Service kill {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:27 a3659e1 resin-supervisor[2014]: [event] Event: Service kill {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:32 a3659e1 f44300088b61[1043]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:32 a3659e1 resin-supervisor[2014]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:32 a3659e1 f44300088b61[1043]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:32 a3659e1 resin-supervisor[2014]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:32 a3659e1 2c82cbb482d8[1043]: [42B blob data] | |
| Jun 24 09:07:32 a3659e1 systemd-journald[44]: Received SIGTERM from PID 1 (systemd-shutdow). | |
| Jun 24 09:07:32 a3659e1 2c82cbb482d8[1043]: [42B blob data] | |
| Jun 24 09:07:32 a3659e1 2c82cbb482d8[1043]: [16B blob data] | |
| Jun 24 09:07:32 a3659e1 systemd[1]: docker-2c82cbb482d8185da6e878787c42cc64c18339a7a0337a71ce437c0794d5160a.scope: Consumed 26.959s CPU time. | |
| Jun 24 09:07:36 a3659e1 balenad[1089]: time="2021-06-24T09:07:36.152749903Z" level=info msg="shim reaped" id=2c82cbb482d8185da6e878787c42cc64c18339a7a0337a71ce437c0794d5160a | |
| Jun 24 09:07:36 a3659e1 balenad[1043]: time="2021-06-24T09:07:36.168862775Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:07:36 a3659e1 f44300088b61[1043]: [event] Event: Service exit {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:36 a3659e1 resin-supervisor[2014]: [event] Event: Service exit {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:40 a3659e1 f44300088b61[1043]: [event] Event: Service stop {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:40 a3659e1 resin-supervisor[2014]: [event] Event: Service stop {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:40 a3659e1 f44300088b61[1043]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:40 a3659e1 resin-supervisor[2014]: [debug] Replacing container for service main because of config changes: | |
| Jun 24 09:07:40 a3659e1 f44300088b61[1043]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:40 a3659e1 resin-supervisor[2014]: [debug] Non-array fields: {"added":{},"deleted":{},"updated":{"environment":{"BALENA_HOST_OS_VERSION":"balenaOS 2.73.1+rev2","RESIN_HOST_OS_VERSION":"balenaOS 2.73.1+rev2"}}} | |
| Jun 24 09:07:43 a3659e1 f44300088b61[1043]: [event] Event: Service install {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:43 a3659e1 resin-supervisor[2014]: [event] Event: Service install {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:44 a3659e1 f44300088b61[1043]: [event] Event: Service installed {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:44 a3659e1 resin-supervisor[2014]: [event] Event: Service installed {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:44 a3659e1 f44300088b61[1043]: [event] Event: Service start {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:44 a3659e1 resin-supervisor[2014]: [event] Event: Service start {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:44 a3659e1 balenad[1089]: time="2021-06-24T09:07:44.913294461Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/d9e756d2f6d9c89b04ea7783649383461bf770908fcb3c631639f3c2d734e647.sock debug=false pid=2257 | |
| Jun 24 09:07:49 a3659e1 0e234c214533[1043]: [73B blob data] | |
| Jun 24 09:07:49 a3659e1 0e234c214533[1043]: [29B blob data] | |
| Jun 24 09:07:49 a3659e1 kernel: Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist. | |
| Jun 24 09:07:49 a3659e1 0e234c214533[1043]: [179B blob data] | |
| Jun 24 09:07:49 a3659e1 0e234c214533[1043]: [32B blob data] | |
| Jun 24 09:07:49 a3659e1 0e234c214533[1043]: [27B blob data] | |
| Jun 24 09:07:49 a3659e1 0e234c214533[1043]: [27B blob data] | |
| Jun 24 09:07:49 a3659e1 0e234c214533[1043]: [69B blob data] | |
| Jun 24 09:07:49 a3659e1 f44300088b61[1043]: [event] Event: Service started {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:49 a3659e1 resin-supervisor[2014]: [event] Event: Service started {"service":{"appId":943304,"serviceId":7268,"serviceName":"main","releaseId":1803555}} | |
| Jun 24 09:07:50 a3659e1 f44300088b61[1043]: [debug] Spawning journald with: chroot /mnt/root journalctl -a -S 2021-06-24 09:07:50 -o json CONTAINER_ID_FULL=0e234c21453396aa453be5c304896f62826ec96cd5e328f93225e1323bb5c41b | |
| Jun 24 09:07:50 a3659e1 resin-supervisor[2014]: [debug] Spawning journald with: chroot /mnt/root journalctl -a -S 2021-06-24 09:07:50 -o json CONTAINER_ID_FULL=0e234c21453396aa453be5c304896f62826ec96cd5e328f93225e1323bb5c41b | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [114B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [106B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [98B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [102B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [98B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [108B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [94B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [112B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [110B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [100B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [80B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [92B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [84B blob data] | |
| Jun 24 09:07:50 a3659e1 0e234c214533[1043]: [102B blob data] | |
| Jun 24 09:07:51 a3659e1 openvpn[1037]: Thu Jun 24 09:07:51 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:07:51 a3659e1 openvpn[1037]: Thu Jun 24 09:07:51 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:07:51 a3659e1 openvpn[1037]: Thu Jun 24 09:07:51 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:07:51 a3659e1 openvpn[1037]: Thu Jun 24 09:07:51 2021 Attempting to establish TCP connection with [AF_INET]35.169.76.143:443 [nonblock] | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 TCP connection established with [AF_INET]35.169.76.143:443 | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 TCP_CLIENT link remote: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 TLS: Initial packet from [AF_INET]35.169.76.143:443, sid=4abe72e2 fbb6425d | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 Connection reset, restarting [0] | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:07:52 a3659e1 openvpn[1037]: Thu Jun 24 09:07:52 2021 Restart pause, 40 second(s) | |
| Jun 24 09:07:53 a3659e1 systemd-journald[48]: Received request to flush runtime journal from PID 1 | |
| Jun 24 09:07:55 a3659e1 f44300088b61[1043]: [debug] Finished applying target state | |
| Jun 24 09:07:55 a3659e1 resin-supervisor[2014]: [debug] Finished applying target state | |
| Jun 24 09:07:55 a3659e1 f44300088b61[1043]: [success] Device state apply success | |
| Jun 24 09:07:55 a3659e1 resin-supervisor[2014]: [success] Device state apply success | |
| Jun 24 09:07:56 a3659e1 f44300088b61[1043]: [info] Applying target state | |
| Jun 24 09:07:56 a3659e1 resin-supervisor[2014]: [info] Applying target state | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [19B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [46B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [51B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [51B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [50B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [55B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:07:57 a3659e1 0e234c214533[1043]: [16B blob data] | |
| Jun 24 09:08:00 a3659e1 0e234c214533[1043]: [23B blob data] | |
| Jun 24 09:08:00 a3659e1 0e234c214533[1043]: [5B blob data] | |
| Jun 24 09:08:00 a3659e1 0e234c214533[1043]: [19B blob data] | |
| Jun 24 09:08:00 a3659e1 0e234c214533[1043]: [21B blob data] | |
| Jun 24 09:08:00 a3659e1 0e234c214533[1043]: [31B blob data] | |
| Jun 24 09:08:00 a3659e1 0e234c214533[1043]: [17B blob data] | |
| Jun 24 09:08:01 a3659e1 resin-supervisor[2014]: [debug] Finished applying target state | |
| Jun 24 09:08:01 a3659e1 f44300088b61[1043]: [debug] Finished applying target state | |
| Jun 24 09:08:01 a3659e1 f44300088b61[1043]: [success] Device state apply success | |
| Jun 24 09:08:01 a3659e1 resin-supervisor[2014]: [success] Device state apply success | |
| Jun 24 09:08:06 a3659e1 systemd-logind[940]: Watching system buttons on /dev/input/event0 (tps65217_pwr_but) | |
| Jun 24 09:08:08 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:08:08 a3659e1 0e234c214533[1043]: [45B blob data] | |
| Jun 24 09:08:08 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:08:11 a3659e1 sh[2493]: Rollback: Running tests | |
| Jun 24 09:08:11 a3659e1 sh[2493]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:08:11 a3659e1 sh[1495]: Trying healthcheck again 1 of 15 attempts | |
| Jun 24 09:08:15 a3659e1 systemd-udevd[2376]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:08:15 a3659e1 systemd-udevd[2376]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:08:19 a3659e1 systemd-udevd[2371]: zram0: Failed to substitute variable '$parent' or apply format '%P', ignoring: No such file or directory | |
| Jun 24 09:08:20 a3659e1 systemd-udevd[2372]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:08:20 a3659e1 ModemManager[869]: [base-manager] couldn't check support for device '/sys/devices/platform/ocp/4a000000.interconnect/4a000000.interconnect:segment@0/4a101200.target-module/4a100000.ethernet': not supported by any plugin | |
| Jun 24 09:08:20 a3659e1 systemd-udevd[2373]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:08:20 a3659e1 systemd-udevd[2372]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:08:20 a3659e1 systemd-udevd[2376]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:08:20 a3659e1 systemd-udevd[2370]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:08:20 a3659e1 systemd-udevd[2370]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:08:20 a3659e1 systemd-udevd[2373]: Using default interface naming scheme 'v243'. | |
| Jun 24 09:08:21 a3659e1 systemd-udevd[2373]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable. | |
| Jun 24 09:08:21 a3659e1 kernel: zram: Can't change algorithm for initialized device | |
| Jun 24 09:08:21 a3659e1 systemd-udevd[2371]: zram0: Process '/lib/udev/zram-swap-init /dev/zram0' failed with exit code 1. | |
| Jun 24 09:08:21 a3659e1 systemd-udevd[2371]: ptmx: Failed to process device, ignoring: File exists | |
| Jun 24 09:08:23 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:08:23 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:08:23 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:08:23 a3659e1 0e234c214533[1043]: [19B blob data] | |
| Jun 24 09:08:23 a3659e1 0e234c214533[1043]: [19B blob data] | |
| Jun 24 09:08:24 a3659e1 systemd-vconsole-setup[2662]: KD_FONT_OP_GET failed while trying to get the font metadata: Function not implemented | |
| Jun 24 09:08:24 a3659e1 systemd-vconsole-setup[2662]: Fonts will not be copied to remaining consoles | |
| Jun 24 09:08:32 a3659e1 openvpn[1037]: Thu Jun 24 09:08:32 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:08:32 a3659e1 openvpn[1037]: Thu Jun 24 09:08:32 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:08:32 a3659e1 openvpn[1037]: Thu Jun 24 09:08:32 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:08:32 a3659e1 openvpn[1037]: Thu Jun 24 09:08:32 2021 Attempting to establish TCP connection with [AF_INET]3.227.28.93:443 [nonblock] | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 TCP connection established with [AF_INET]3.227.28.93:443 | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 TCP_CLIENT link remote: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 TLS: Initial packet from [AF_INET]3.227.28.93:443, sid=8469b84a 3e833ef5 | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 Connection reset, restarting [0] | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:08:33 a3659e1 openvpn[1037]: Thu Jun 24 09:08:33 2021 Restart pause, 40 second(s) | |
| Jun 24 09:08:58 a3659e1 0e234c214533[1043]: [42B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [81B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [71B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [21B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [27B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [81B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [85B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [40B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [55B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [65B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [65B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [81B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [61B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [81B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [75B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [53B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [1B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [26B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [81B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [71B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [21B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [27B blob data] | |
| Jun 24 09:08:59 a3659e1 0e234c214533[1043]: [29B blob data] | |
| Jun 24 09:09:12 a3659e1 sh[2792]: Rollback: Running tests | |
| Jun 24 09:09:12 a3659e1 sh[2792]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:09:12 a3659e1 sh[1495]: Trying healthcheck again 2 of 15 attempts | |
| Jun 24 09:09:13 a3659e1 openvpn[1037]: Thu Jun 24 09:09:13 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:09:13 a3659e1 openvpn[1037]: Thu Jun 24 09:09:13 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:09:13 a3659e1 openvpn[1037]: Thu Jun 24 09:09:13 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:09:13 a3659e1 openvpn[1037]: Thu Jun 24 09:09:13 2021 Attempting to establish TCP connection with [AF_INET]35.169.76.143:443 [nonblock] | |
| Jun 24 09:09:14 a3659e1 openvpn[1037]: Thu Jun 24 09:09:14 2021 TCP connection established with [AF_INET]35.169.76.143:443 | |
| Jun 24 09:09:14 a3659e1 openvpn[1037]: Thu Jun 24 09:09:14 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:09:14 a3659e1 openvpn[1037]: Thu Jun 24 09:09:14 2021 TCP_CLIENT link remote: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:09:15 a3659e1 openvpn[1037]: Thu Jun 24 09:09:15 2021 TLS: Initial packet from [AF_INET]35.169.76.143:443, sid=5623ce73 01b25f48 | |
| Jun 24 09:09:15 a3659e1 openvpn[1037]: Thu Jun 24 09:09:15 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:09:15 a3659e1 openvpn[1037]: Thu Jun 24 09:09:15 2021 Connection reset, restarting [0] | |
| Jun 24 09:09:15 a3659e1 openvpn[1037]: Thu Jun 24 09:09:15 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:09:15 a3659e1 openvpn[1037]: Thu Jun 24 09:09:15 2021 Restart pause, 80 second(s) | |
| Jun 24 09:09:55 a3659e1 balenad[1089]: time="2021-06-24T09:09:55.723280005Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/30dec214cc6879a6a8449bebc2e5b906d054500e4554bffc2b18bbe2725a4f3b.sock debug=false pid=2915 | |
| Jun 24 09:10:09 a3659e1 balenad[1089]: time="2021-06-24T09:10:09.865127883Z" level=info msg="shim reaped" id=6a5260cac198d77ed7b4c922d11cdae77dc1ab142dc4815ab0dfc3d48db97167 | |
| Jun 24 09:10:09 a3659e1 balenad[1043]: time="2021-06-24T09:10:09.918401214Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:10:15 a3659e1 sh[3126]: Rollback: Running tests | |
| Jun 24 09:10:15 a3659e1 sh[3126]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:10:15 a3659e1 sh[1495]: Trying healthcheck again 3 of 15 attempts | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 Attempting to establish TCP connection with [AF_INET]35.169.89.252:443 [nonblock] | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 TCP connection established with [AF_INET]35.169.89.252:443 | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 TCP_CLIENT link remote: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 TLS: Initial packet from [AF_INET]35.169.89.252:443, sid=f0ddeb37 59b74a81 | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 Connection reset, restarting [0] | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:10:35 a3659e1 openvpn[1037]: Thu Jun 24 09:10:35 2021 Restart pause, 80 second(s) | |
| Jun 24 09:11:17 a3659e1 sh[3267]: Rollback: Running tests | |
| Jun 24 09:11:17 a3659e1 sh[3267]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:11:17 a3659e1 sh[1495]: Trying healthcheck again 4 of 15 attempts | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 Attempting to establish TCP connection with [AF_INET]3.227.28.93:443 [nonblock] | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 TCP connection established with [AF_INET]3.227.28.93:443 | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 TCP_CLIENT link remote: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 TLS: Initial packet from [AF_INET]3.227.28.93:443, sid=2f78522e 59ebc362 | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 Connection reset, restarting [0] | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:11:55 a3659e1 openvpn[1037]: Thu Jun 24 09:11:55 2021 Restart pause, 80 second(s) | |
| Jun 24 09:12:13 a3659e1 f44300088b61[1043]: [api] GET /v1/healthy 200 - 156.946 ms | |
| Jun 24 09:12:13 a3659e1 resin-supervisor[2014]: [api] GET /v1/healthy 200 - 156.946 ms | |
| Jun 24 09:12:19 a3659e1 sh[3510]: Rollback: Running tests | |
| Jun 24 09:12:19 a3659e1 sh[3510]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:12:19 a3659e1 sh[1495]: Trying healthcheck again 5 of 15 attempts | |
| Jun 24 09:13:15 a3659e1 openvpn[1037]: Thu Jun 24 09:13:15 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:13:15 a3659e1 openvpn[1037]: Thu Jun 24 09:13:15 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:13:15 a3659e1 openvpn[1037]: Thu Jun 24 09:13:15 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:13:15 a3659e1 openvpn[1037]: Thu Jun 24 09:13:15 2021 Attempting to establish TCP connection with [AF_INET]35.169.89.252:443 [nonblock] | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 TCP connection established with [AF_INET]35.169.89.252:443 | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 TCP_CLIENT link remote: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 TLS: Initial packet from [AF_INET]35.169.89.252:443, sid=8805f572 647ff646 | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 Connection reset, restarting [0] | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:13:16 a3659e1 openvpn[1037]: Thu Jun 24 09:13:16 2021 Restart pause, 120 second(s) | |
| Jun 24 09:13:17 a3659e1 balenad[1089]: time="2021-06-24T09:13:17.072140011Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/bf268845f0cc4ea528b17b48b4528c8a18c01301061636eb4d85f76d94e81aed.sock debug=false pid=3689 | |
| Jun 24 09:13:23 a3659e1 sh[3737]: Rollback: Running tests | |
| Jun 24 09:13:23 a3659e1 sh[3737]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:13:23 a3659e1 sh[1495]: Trying healthcheck again 6 of 15 attempts | |
| Jun 24 09:13:31 a3659e1 balenad[1089]: time="2021-06-24T09:13:31.576773597Z" level=info msg="shim reaped" id=2d7601f5109d82c5b4c8e2d877a634599637cadfc59533f9d4ade9c8ce8f6ffc | |
| Jun 24 09:13:31 a3659e1 balenad[1043]: time="2021-06-24T09:13:31.608119389Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:14:24 a3659e1 sh[4077]: Rollback: Running tests | |
| Jun 24 09:14:24 a3659e1 sh[4077]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:14:24 a3659e1 sh[1495]: Trying healthcheck again 7 of 15 attempts | |
| Jun 24 09:15:16 a3659e1 openvpn[1037]: Thu Jun 24 09:15:16 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:15:16 a3659e1 openvpn[1037]: Thu Jun 24 09:15:16 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:15:16 a3659e1 openvpn[1037]: Thu Jun 24 09:15:16 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:15:16 a3659e1 openvpn[1037]: Thu Jun 24 09:15:16 2021 Attempting to establish TCP connection with [AF_INET]35.169.76.143:443 [nonblock] | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 TCP connection established with [AF_INET]35.169.76.143:443 | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 TCP_CLIENT link remote: [AF_INET]35.169.76.143:443 | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 TLS: Initial packet from [AF_INET]35.169.76.143:443, sid=28b6bb8e 644cf490 | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 Connection reset, restarting [0] | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:15:17 a3659e1 openvpn[1037]: Thu Jun 24 09:15:17 2021 Restart pause, 120 second(s) | |
| Jun 24 09:15:25 a3659e1 sh[4200]: Rollback: Running tests | |
| Jun 24 09:15:25 a3659e1 sh[4200]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:15:25 a3659e1 sh[1495]: Trying healthcheck again 8 of 15 attempts | |
| Jun 24 09:16:26 a3659e1 sh[4304]: Rollback: Running tests | |
| Jun 24 09:16:26 a3659e1 sh[4304]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:16:26 a3659e1 sh[1495]: Trying healthcheck again 9 of 15 attempts | |
| Jun 24 09:16:37 a3659e1 balenad[1089]: time="2021-06-24T09:16:37.365536618Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/31633aa32126fa2da08a6e0f35830fec04cce8244bfe8705b7cd01eb7debdd9d.sock debug=false pid=4412 | |
| Jun 24 09:16:44 a3659e1 balenad[1089]: time="2021-06-24T09:16:44.879029636Z" level=info msg="shim reaped" id=3ab45dd8b8c7ac57a1e9d09345be61effb8ad1d8cf532b92d617b7026ded3826 | |
| Jun 24 09:16:44 a3659e1 balenad[1043]: time="2021-06-24T09:16:44.909825752Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:17:16 a3659e1 f44300088b61[1043]: [debug] Attempting container log timestamp flush... | |
| Jun 24 09:17:16 a3659e1 resin-supervisor[2014]: [debug] Attempting container log timestamp flush... | |
| Jun 24 09:17:17 a3659e1 f44300088b61[1043]: [debug] Container log timestamp flush complete | |
| Jun 24 09:17:17 a3659e1 resin-supervisor[2014]: [debug] Container log timestamp flush complete | |
| Jun 24 09:17:17 a3659e1 openvpn[1037]: Thu Jun 24 09:17:17 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:17:17 a3659e1 openvpn[1037]: Thu Jun 24 09:17:17 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:17:17 a3659e1 openvpn[1037]: Thu Jun 24 09:17:17 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:17:17 a3659e1 openvpn[1037]: Thu Jun 24 09:17:17 2021 Attempting to establish TCP connection with [AF_INET]3.227.28.93:443 [nonblock] | |
| Jun 24 09:17:18 a3659e1 f44300088b61[1043]: [api] GET /v1/healthy 200 - 47.012 ms | |
| Jun 24 09:17:18 a3659e1 resin-supervisor[2014]: [api] GET /v1/healthy 200 - 47.012 ms | |
| Jun 24 09:17:18 a3659e1 openvpn[1037]: Thu Jun 24 09:17:18 2021 TCP connection established with [AF_INET]3.227.28.93:443 | |
| Jun 24 09:17:18 a3659e1 openvpn[1037]: Thu Jun 24 09:17:18 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:17:18 a3659e1 openvpn[1037]: Thu Jun 24 09:17:18 2021 TCP_CLIENT link remote: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:17:19 a3659e1 openvpn[1037]: Thu Jun 24 09:17:19 2021 TLS: Initial packet from [AF_INET]3.227.28.93:443, sid=1e1cd759 5027ac68 | |
| Jun 24 09:17:19 a3659e1 openvpn[1037]: Thu Jun 24 09:17:19 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:17:19 a3659e1 openvpn[1037]: Thu Jun 24 09:17:19 2021 Connection reset, restarting [0] | |
| Jun 24 09:17:19 a3659e1 openvpn[1037]: Thu Jun 24 09:17:19 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:17:19 a3659e1 openvpn[1037]: Thu Jun 24 09:17:19 2021 Restart pause, 120 second(s) | |
| Jun 24 09:17:28 a3659e1 sh[4791]: Rollback: Running tests | |
| Jun 24 09:17:28 a3659e1 sh[4791]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:17:28 a3659e1 sh[1495]: Trying healthcheck again 10 of 15 attempts | |
| Jun 24 09:18:29 a3659e1 sh[4961]: Rollback: Running tests | |
| Jun 24 09:18:29 a3659e1 sh[4961]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:18:29 a3659e1 sh[1495]: Trying healthcheck again 11 of 15 attempts | |
| Jun 24 09:18:57 a3659e1 systemd-tmpfiles[5011]: /etc/tmpfiles.d/openvpn.conf:1: Line references path below legacy directory /var/run/, updating /var/run/openvpn → /run/openvpn; please update the tmpfiles.d/ drop-in file accordingly. | |
| Jun 24 09:18:59 a3659e1 sh[5012]: Getting image name and tag... | |
| Jun 24 09:19:01 a3659e1 sh[5012]: Supervisor configuration found from API. | |
| Jun 24 09:19:01 a3659e1 sh[5012]: Getting image id... | |
| Jun 24 09:19:02 a3659e1 sh[5012]: Supervisor registry2.balena-cloud.com/v2/479124025eee6b952affc43fe94552fb:latest already downloaded. | |
| Jun 24 09:19:19 a3659e1 openvpn[1037]: Thu Jun 24 09:19:19 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:19:19 a3659e1 openvpn[1037]: Thu Jun 24 09:19:19 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:19:19 a3659e1 openvpn[1037]: Thu Jun 24 09:19:19 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:19:19 a3659e1 openvpn[1037]: Thu Jun 24 09:19:19 2021 Attempting to establish TCP connection with [AF_INET]35.169.89.252:443 [nonblock] | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 TCP connection established with [AF_INET]35.169.89.252:443 | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 TCP_CLIENT link remote: [AF_INET]35.169.89.252:443 | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 TLS: Initial packet from [AF_INET]35.169.89.252:443, sid=b85920ca 5c615257 | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 Connection reset, restarting [0] | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:19:20 a3659e1 openvpn[1037]: Thu Jun 24 09:19:20 2021 Restart pause, 120 second(s) | |
| Jun 24 09:19:30 a3659e1 sh[5121]: Rollback: Running tests | |
| Jun 24 09:19:30 a3659e1 sh[5121]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:19:30 a3659e1 sh[1495]: Trying healthcheck again 12 of 15 attempts | |
| Jun 24 09:19:51 a3659e1 balenad[1089]: time="2021-06-24T09:19:51.148341121Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/0678ab403892defab8745829ade0a2b407e63dd2108a3a1529e1a4e35024c00d.sock debug=false pid=5218 | |
| Jun 24 09:19:59 a3659e1 balenad[1089]: time="2021-06-24T09:19:59.736690110Z" level=info msg="shim reaped" id=35596cd276db3a8b03929387f02407c12480bf1018b7ee5839aaba76982dabaa | |
| Jun 24 09:19:59 a3659e1 balenad[1043]: time="2021-06-24T09:19:59.758276793Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:20:31 a3659e1 sh[5418]: Rollback: Running tests | |
| Jun 24 09:20:31 a3659e1 sh[5418]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:20:31 a3659e1 sh[1495]: Trying healthcheck again 13 of 15 attempts | |
| Jun 24 09:21:20 a3659e1 openvpn[1037]: Thu Jun 24 09:21:20 2021 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts | |
| Jun 24 09:21:20 a3659e1 openvpn[1037]: Thu Jun 24 09:21:20 2021 TCP/UDP: Preserving recently used remote address: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:21:20 a3659e1 openvpn[1037]: Thu Jun 24 09:21:20 2021 Socket Buffers: R=[131072->131072] S=[16384->16384] | |
| Jun 24 09:21:20 a3659e1 openvpn[1037]: Thu Jun 24 09:21:20 2021 Attempting to establish TCP connection with [AF_INET]3.227.28.93:443 [nonblock] | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 TCP connection established with [AF_INET]3.227.28.93:443 | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 TCP_CLIENT link local: (not bound) | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 TCP_CLIENT link remote: [AF_INET]3.227.28.93:443 | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 TLS: Initial packet from [AF_INET]3.227.28.93:443, sid=1022fc9d 008a7b53 | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 write TCP_CLIENT: Connection reset by peer (code=104) | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 Connection reset, restarting [0] | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 SIGUSR1[soft,connection-reset] received, process restarting | |
| Jun 24 09:21:21 a3659e1 openvpn[1037]: Thu Jun 24 09:21:21 2021 Restart pause, 120 second(s) | |
| Jun 24 09:21:32 a3659e1 sh[5515]: Rollback: Running tests | |
| Jun 24 09:21:33 a3659e1 sh[5515]: Rollback: ERROR: VPN used to be ok but has not connected! | |
| Jun 24 09:21:33 a3659e1 sh[1495]: Trying healthcheck again 14 of 15 attempts | |
| Jun 24 09:22:23 a3659e1 f44300088b61[1043]: [api] GET /v1/healthy 200 - 55.609 ms | |
| Jun 24 09:22:23 a3659e1 resin-supervisor[2014]: [api] GET /v1/healthy 200 - 55.609 ms | |
| Jun 24 09:22:33 a3659e1 sh[1495]: Rollback: Looks like we failed some health check. Rolling back | |
| Jun 24 09:22:33 a3659e1 sh[1495]: Rollback: Running hooks from previous rootfs | |
| Jun 24 09:22:33 a3659e1 sh[5774]: time="2021-06-24T09:22:33Z" level=warning msg="[graphdriver] WARNING: the aufs storage-driver is deprecated, and will be removed in a future release" | |
| Jun 24 09:22:35 a3659e1 sh[5795]: sh: cannot set terminal process group (1495): Inappropriate ioctl for device | |
| Jun 24 09:22:35 a3659e1 sh[5795]: sh: no job control in this shell | |
| Jun 24 09:22:36 a3659e1 sh[5795]: [54B blob data] | |
| Jun 24 09:22:37 a3659e1 sh[5830]: [INFO] Checking if boot partition can accommodate the new update... success. | |
| Jun 24 09:22:38 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/MLO... overwriting modified file... done. | |
| Jun 24 09:22:38 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/image-version-info... overwriting modified file... done. | |
| Jun 24 09:22:38 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/splash/resin-logo.png...file blacklisted. Ignoring. | |
| Jun 24 09:22:38 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/resinos.fingerprint... overwriting modified file... done. | |
| Jun 24 09:22:39 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/device-type.json... overwriting modified file... done. | |
| Jun 24 09:22:39 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/resin-image... done. | |
| Jun 24 09:22:39 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/u-boot.img... overwriting modified file... done. | |
| Jun 24 09:22:39 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/system-connections/resin-sample.ignore... done. | |
| Jun 24 09:22:39 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/system-connections/README.ignore... done. | |
| Jun 24 09:22:40 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/os-release... overwriting modified file... done. | |
| Jun 24 09:22:40 a3659e1 sh[5830]: [INFO] Deploying /mnt/boot/config.json...file blacklisted. Ignoring. | |
| Jun 24 09:22:40 a3659e1 sh[5975]: [INFO] Running rollback hook | |
| Jun 24 09:22:40 a3659e1 sh[5984]: [INFO] Switching uboot root partition index to 2...... done. | |
| Jun 24 09:22:40 a3659e1 sh[5795]: sh-4.4# exit | |
| Jun 24 09:22:40 a3659e1 sh[1495]: Rollback: Failed heathchecks. Rebooting to previous rootfs | |
| Jun 24 09:22:42 a3659e1 sh[5994]: Rollback: Parsing bootloader configuration | |
| Jun 24 09:22:42 a3659e1 sh[5994]: Rollback: Stopping further rollbacks | |
| Jun 24 09:22:42 a3659e1 sh[5994]: Rollback: Setting upgrade_available to 0 and removing breadcrumbs | |
| Jun 24 09:22:43 a3659e1 sh[5994]: Rollback: Following bootloader file /mnt/boot/resinOS_uEnv.txt found | |
| Jun 24 09:22:43 a3659e1 sh[5994]: Rollback: Further rollbacks stopped | |
| Jun 24 09:22:53 a3659e1 ModemManager[869]: caught signal, shutting down... | |
| Jun 24 09:22:53 a3659e1 avahi-daemon[1015]: Got SIGTERM, quitting. | |
| Jun 24 09:22:53 a3659e1 avahi-daemon[1015]: Leaving mDNS multicast group on interface supervisor0.IPv4 with address 10.114.104.1. | |
| Jun 24 09:22:54 a3659e1 avahi-daemon[1015]: Leaving mDNS multicast group on interface br-f0a77408ae8d.IPv4 with address 172.18.0.1. | |
| Jun 24 09:22:54 a3659e1 avahi-daemon[1015]: Leaving mDNS multicast group on interface balena0.IPv4 with address 10.114.101.1. | |
| Jun 24 09:22:54 a3659e1 avahi-daemon[1015]: Leaving mDNS multicast group on interface resin-dns.IPv4 with address 10.114.102.1. | |
| Jun 24 09:22:54 a3659e1 avahi-daemon[1015]: Leaving mDNS multicast group on interface eth0.IPv6 with address fe80::a6a3:ab84:e5a4:89e8. | |
| Jun 24 09:22:54 a3659e1 avahi-daemon[1015]: Leaving mDNS multicast group on interface eth0.IPv4 with address 10.10.65.104. | |
| Jun 24 09:22:54 a3659e1 avahi-daemon[1015]: avahi-daemon 0.7 exiting. | |
| Jun 24 09:22:54 a3659e1 NetworkManager[1029]: <info> [1624526574.5929] modem-manager: ModemManager no longer available | |
| Jun 24 09:22:54 a3659e1 bindmount[6051]: INFO: Unmounting /mnt/state/root-overlay/home/root/.rnd ... | |
| Jun 24 09:22:54 a3659e1 bindmount[6051]: INFO: Successfully unmounted /mnt/state/root-overlay/home/root/.rnd. | |
| Jun 24 09:22:54 a3659e1 bindmount[6052]: INFO: Unmounting /mnt/state/root-overlay/usr/share/ca-certificates/balena ... | |
| Jun 24 09:22:54 a3659e1 bindmount[6052]: INFO: Successfully unmounted /mnt/state/root-overlay/usr/share/ca-certificates/balena. | |
| Jun 24 09:22:54 a3659e1 systemd[1]: rollback-health.service: Main process exited, code=killed, status=15/TERM | |
| Jun 24 09:22:54 a3659e1 bindmount[6055]: INFO: Unmounting /mnt/data/root-overlay/var/log/journal ... | |
| Jun 24 09:22:54 a3659e1 bindmount[6055]: INFO: bind mountpont is already unmounted. | |
| Jun 24 09:22:55 a3659e1 bindmount[6054]: INFO: Unmounting /mnt/state/root-overlay/var/lib/chrony ... | |
| Jun 24 09:22:55 a3659e1 bindmount[6054]: INFO: Successfully unmounted /mnt/state/root-overlay/var/lib/chrony. | |
| Jun 24 09:22:55 a3659e1 bindmount[6053]: INFO: Unmounting /mnt/state/root-overlay/var/lib/bluetooth ... | |
| Jun 24 09:22:55 a3659e1 bindmount[6053]: INFO: Successfully unmounted /mnt/state/root-overlay/var/lib/bluetooth. | |
| Jun 24 09:22:55 a3659e1 bindmount[6056]: INFO: Unmounting /mnt/state/root-overlay/home/root/.ssh ... | |
| Jun 24 09:22:55 a3659e1 bindmount[6056]: INFO: Successfully unmounted /mnt/state/root-overlay/home/root/.ssh. | |
| Jun 24 09:22:55 a3659e1 bindmount[6057]: INFO: Unmounting /mnt/state/root-overlay/etc/udev/rules.d ... | |
| Jun 24 09:22:55 a3659e1 bindmount[6057]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/udev/rules.d. | |
| Jun 24 09:22:54 a3659e1 systemd[1]: rollback-health.service: Failed with result 'signal'. | |
| Jun 24 09:22:54 a3659e1 ModemManager[869]: ModemManager is shut down | |
| Jun 24 09:22:55 a3659e1 bindmount[6061]: INFO: Unmounting /mnt/state/root-overlay/etc/ssh/hostkeys ... | |
| Jun 24 09:22:55 a3659e1 bindmount[6061]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/ssh/hostkeys. | |
| Jun 24 09:22:55 a3659e1 openvpn[1037]: Thu Jun 24 09:22:55 2021 SIGTERM[hard,init_instance] received, process exiting | |
| Jun 24 09:22:56 a3659e1 bindmount[6080]: INFO: Unmounting /mnt/state/root-overlay/var/lib/systemd ... | |
| Jun 24 09:22:56 a3659e1 bindmount[6080]: INFO: Successfully unmounted /mnt/state/root-overlay/var/lib/systemd. | |
| Jun 24 09:22:56 a3659e1 bindmount[6082]: INFO: Unmounting /mnt/state/root-overlay/etc/hostname ... | |
| Jun 24 09:22:56 a3659e1 bindmount[6085]: INFO: Unmounting /mnt/state/root-overlay/etc/openvpn ... | |
| Jun 24 09:22:56 a3659e1 bindmount[6082]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/hostname. | |
| Jun 24 09:22:56 a3659e1 bindmount[6085]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/openvpn. | |
| Jun 24 09:22:56 a3659e1 resin-partition-mounter[6081]: INFO: Unmounting /dev/disk/by-state/active (active). | |
| Jun 24 09:22:57 a3659e1 resin-partition-mounter[6088]: umount: /mnt/sysroot/active: target is busy. | |
| Jun 24 09:22:57 a3659e1 systemd[1]: mnt-sysroot-active.service: Control process exited, code=exited, status=32/n/a | |
| Jun 24 09:22:57 a3659e1 systemd[1]: mnt-sysroot-active.service: Failed with result 'exit-code'. | |
| Jun 24 09:23:03 a3659e1 rollback-clear-bootcount[6060]: Rollback: Parsing bootloader configuration | |
| Jun 24 09:23:07 a3659e1 balenad[1089]: time="2021-06-24T09:23:07.863356238Z" level=info msg="shim balena-engine-containerd-shim started" address=/containerd-shim/768da89702ef06f90f522e1a67edea88cef3f3c009f358944af108bee2149733.sock debug=false pid=6186 | |
| Jun 24 09:23:14 a3659e1 balenad[1043]: time="2021-06-24T09:23:14.143714494Z" level=info msg="Container f44300088b61617b566f37958100f91ff13c55768c12ff0866bed7e53e37324a failed to exit within 10 seconds of signal 15 - using the force" | |
| Jun 24 09:23:18 a3659e1 systemd[1]: docker-f44300088b61617b566f37958100f91ff13c55768c12ff0866bed7e53e37324a.scope: Consumed 2min 18.126s CPU time. | |
| Jun 24 09:23:18 a3659e1 balenad[1089]: time="2021-06-24T09:23:18.790566070Z" level=info msg="shim reaped" id=522b15a09d2f17489833eaa28e797d4905f63917d1c171a39db2ef7f48a437b1 | |
| Jun 24 09:23:18 a3659e1 balenad[1043]: time="2021-06-24T09:23:18.835578832Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:23:21 a3659e1 balenad[1089]: time="2021-06-24T09:23:21.581625789Z" level=info msg="shim reaped" id=f44300088b61617b566f37958100f91ff13c55768c12ff0866bed7e53e37324a | |
| Jun 24 09:23:21 a3659e1 balenad[1043]: time="2021-06-24T09:23:21.597484133Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:23:24 a3659e1 resin-supervisor[6059]: resin_supervisor | |
| Jun 24 09:23:24 a3659e1 balenad[1043]: time="2021-06-24T09:23:24.290441914Z" level=info msg="Processing signal 'terminated'" | |
| Jun 24 09:23:24 a3659e1 bindmount[6370]: INFO: Unmounting /mnt/state/root-overlay/etc/resin-supervisor ... | |
| Jun 24 09:23:24 a3659e1 bindmount[6370]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/resin-supervisor. | |
| Jun 24 09:23:26 a3659e1 0e234c214533[1043]: [42B blob data] | |
| Jun 24 09:23:26 a3659e1 systemd-journald[48]: Received SIGTERM from PID 1 (systemd-shutdow). | |
| Jun 24 09:23:26 a3659e1 0e234c214533[1043]: [42B blob data] | |
| Jun 24 09:23:26 a3659e1 0e234c214533[1043]: [16B blob data] | |
| Jun 24 09:23:26 a3659e1 systemd[1]: docker-0e234c21453396aa453be5c304896f62826ec96cd5e328f93225e1323bb5c41b.scope: Consumed 1min 58.333s CPU time. | |
| Jun 24 09:23:29 a3659e1 balenad[1089]: time="2021-06-24T09:23:29.173414000Z" level=info msg="shim reaped" id=0e234c21453396aa453be5c304896f62826ec96cd5e328f93225e1323bb5c41b | |
| Jun 24 09:23:29 a3659e1 balenad[1043]: time="2021-06-24T09:23:29.192699357Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" | |
| Jun 24 09:23:29 a3659e1 balenad[1043]: time="2021-06-24T09:23:29.637328164Z" level=info msg="Daemon shutdown complete" | |
| Jun 24 09:23:29 a3659e1 balenad[1043]: time="2021-06-24T09:23:29.640165586Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby | |
| Jun 24 09:23:29 a3659e1 balenad[1043]: time="2021-06-24T09:23:29.643082502Z" level=info msg="stopping healthcheck following graceful shutdown" module=libcontainerd | |
| Jun 24 09:23:29 a3659e1 balenad[1043]: time="2021-06-24T09:23:29.651707301Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby | |
| Jun 24 09:23:30 a3659e1 bindmount[6435]: INFO: Unmounting /mnt/state/root-overlay/etc/docker ... | |
| Jun 24 09:23:30 a3659e1 bindmount[6435]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/docker. | |
| Jun 24 09:23:30 a3659e1 dnsmasq[1041]: dnsmasq[1041]: exiting on receipt of SIGTERM | |
| Jun 24 09:23:30 a3659e1 bindmount[6436]: INFO: Unmounting /mnt/state/root-overlay/home/root/.docker ... | |
| Jun 24 09:23:30 a3659e1 bindmount[6436]: INFO: Successfully unmounted /mnt/state/root-overlay/home/root/.docker. | |
| Jun 24 09:23:31 a3659e1 NetworkManager[1029]: <info> [1624526611.0804] caught SIGTERM, shutting down normally. | |
| Jun 24 09:23:31 a3659e1 NetworkManager[1029]: <info> [1624526611.1193] dhcp4 (eth0): canceled DHCP transaction | |
| Jun 24 09:23:31 a3659e1 NetworkManager[1029]: <info> [1624526611.1208] dhcp4 (eth0): state changed bound -> done | |
| Jun 24 09:23:31 a3659e1 NetworkManager[1029]: <info> [1624526611.1220] device (eth0): DHCPv4: trying to acquire a new lease | |
| Jun 24 09:23:31 a3659e1 NetworkManager[1029]: <info> [1624526611.1557] manager: NetworkManager state is now CONNECTED_SITE | |
| Jun 24 09:23:31 a3659e1 dbus-daemon[884]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=1029 comm="/usr/sbin/NetworkManager --no-daemon ") | |
| Jun 24 09:23:31 a3659e1 dbus-daemon[884]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.nm-dispatcher.service': Refusing activation, D-Bus is shutting down. | |
| Jun 24 09:23:31 a3659e1 dbus-daemon[884]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=1029 comm="/usr/sbin/NetworkManager --no-daemon ") | |
| Jun 24 09:23:31 a3659e1 dbus-daemon[884]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.nm-dispatcher.service': Refusing activation, D-Bus is shutting down. | |
| Jun 24 09:23:31 a3659e1 NetworkManager[1029]: <info> [1624526611.2524] exiting (success) | |
| Jun 24 09:23:31 a3659e1 chronyd[882]: 2021-06-24T09:23:31Z chronyd exiting | |
| Jun 24 09:23:31 a3659e1 bindmount[6438]: INFO: Unmounting /mnt/state/root-overlay/var/lib/NetworkManager ... | |
| Jun 24 09:23:31 a3659e1 bindmount[6438]: INFO: Successfully unmounted /mnt/state/root-overlay/var/lib/NetworkManager. | |
| Jun 24 09:23:31 a3659e1 bindmount[6439]: INFO: Unmounting /mnt/state/root-overlay/etc/NetworkManager/conf.d ... | |
| Jun 24 09:23:31 a3659e1 bindmount[6439]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/NetworkManager/conf.d. | |
| Jun 24 09:23:31 a3659e1 bindmount[6440]: INFO: Unmounting /mnt/state/root-overlay/etc/NetworkManager/system-connections ... | |
| Jun 24 09:23:31 a3659e1 bindmount[6440]: INFO: Successfully unmounted /mnt/state/root-overlay/etc/NetworkManager/system-connections. | |
| Jun 24 09:23:31 a3659e1 rngd[852]: [hwrng ]: Shutting down | |
| Jun 24 09:23:31 a3659e1 rngd[852]: [jitter]: Shutting down | |
| Jun 24 09:23:31 a3659e1 rngd[852]: [jitter]: Closing thread 0 | |
| Jun 24 09:23:32 a3659e1 umount[6449]: umount: /mnt/sysroot/active: target is busy. | |
| Jun 24 09:23:32 a3659e1 fake-hwclock[6443]: [fake-hwclock][INFO] Saving system time to /etc/fake-hwclock/fake-hwclock.data. | |
| Jun 24 09:23:32 a3659e1 resin-partition-mounter[6444]: INFO: Unmounting /dev/disk/by-state/resin-state (resin-state). | |
| Jun 24 09:23:33 a3659e1 umount[6469]: umount: /var/volatile/lib/docker: not mounted. | |
| Jun 24 09:23:33 a3659e1 umount[6471]: umount: /var/cache: not mounted. | |
| Jun 24 09:23:33 a3659e1 umount[6470]: umount: /var/volatile/log/journal: target is busy. | |
| Jun 24 09:23:33 a3659e1 umount[6472]: umount: /var/spool: not mounted. | |
| Jun 24 09:23:33 a3659e1 umount[6473]: umount: /srv: not mounted. | |
| Jun 24 09:23:33 a3659e1 systemd[1]: mnt-sysroot-active.mount: Mount process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:33 a3659e1 systemd[1]: Failed unmounting /mnt/sysroot/active. | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-lib-docker.mount: Mount process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-lib-docker.mount: Failed with result 'exit-code'. | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-log-journal.mount: Mount process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:33 a3659e1 systemd[1]: Failed unmounting /var/volatile/log/journal. | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-cache.service: Control process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-cache.service: Failed with result 'exit-code'. | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-spool.service: Control process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-spool.service: Failed with result 'exit-code'. | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-srv.service: Control process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-srv.service: Failed with result 'exit-code'. | |
| Jun 24 09:23:33 a3659e1 umount[6479]: umount: /var/lib: not mounted. | |
| Jun 24 09:23:33 a3659e1 resin-partition-mounter[6478]: INFO: /mnt/data already unmounted. | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-lib.service: Control process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:33 a3659e1 systemd[1]: var-volatile-lib.service: Failed with result 'exit-code'. | |
| Jun 24 09:23:34 a3659e1 umount[6483]: umount: /var/volatile: target is busy. | |
| Jun 24 09:23:34 a3659e1 systemd[1]: var-volatile.mount: Mount process exited, code=exited, status=32/n/a | |
| Jun 24 09:23:34 a3659e1 systemd[1]: Failed unmounting /var/volatile. | |
| Jun 24 09:23:34 a3659e1 systemd[1]: Shutting down. | |
| Jun 24 09:23:34 a3659e1 kernel: watchdog: watchdog0: watchdog did not stop! | |
| Jun 24 09:23:34 a3659e1 systemd-journald[697]: Journal stopped |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment