On Apr 23, 2015, at 1:29 AM, Michael Biebl <bi...@debian.org> wrote:
> Can you boot with systemd.log_level=debug on the kernel command line and > attach the journal output of this boot, so we have more information out > the timing, i.e. when certain services are started > > There might be a race somewhere, i.e. lvm2-activation(-early).service > being run *before* mdadm has assembled the RAID. > > You could test this theory, be artifically delaying those two services. > Copy them to /etc/systemd/system, and add a ExecStartPre=/bin/sleep 30 > to the [Service] section of those two units. > > Michael OK, here’s the log… Hope it helps! Interestingly, one time (just once! out of several tries) it booted fine — so it pretty clearly *is* a race condition!
-- Logs begin at Thu 2015-04-23 03:24:37 PDT, end at Thu 2015-04-23 03:28:32 PDT. -- Apr 23 03:24:37 cube systemd-journal[163]: Runtime journal is using 5.0M (max allowed 40.4M, trying to leave 60.6M free of 399.0M available â current limit 40.4M). Apr 23 03:24:37 cube systemd-journal[163]: Runtime journal is using 5.0M (max allowed 40.4M, trying to leave 60.6M free of 399.0M available â current limit 40.4M). Apr 23 03:24:37 cube kernel: Booting Linux on physical CPU 0x0 Apr 23 03:24:37 cube kernel: Initializing cgroup subsys cpuset Apr 23 03:24:37 cube kernel: Initializing cgroup subsys cpu Apr 23 03:24:37 cube kernel: Initializing cgroup subsys cpuacct Apr 23 03:24:37 cube kernel: Linux version 3.16.0-4-armmp (debian-ker...@lists.debian.org) (gcc version 4.8.4 (Debian 4.8.4-1) ) #1 SMP Debian 3.16.7-ckt9-2 (2015-04-13) Apr 23 03:24:37 cube kernel: CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c5387d Apr 23 03:24:37 cube kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Apr 23 03:24:37 cube kernel: Machine model: SolidRun Cubox-i Dual/Quad Apr 23 03:24:37 cube kernel: Memory policy: Data cache writealloc Apr 23 03:24:37 cube kernel: On node 0 totalpages: 524288 Apr 23 03:24:37 cube kernel: free_area_init_node: node 0, pgdat c09dc700, node_mem_map ee7f8000 Apr 23 03:24:37 cube kernel: DMA zone: 1520 pages used for memmap Apr 23 03:24:37 cube kernel: DMA zone: 0 pages reserved Apr 23 03:24:37 cube kernel: DMA zone: 194560 pages, LIFO batch:31 Apr 23 03:24:37 cube kernel: HighMem zone: 2576 pages used for memmap Apr 23 03:24:37 cube kernel: HighMem zone: 329728 pages, LIFO batch:31 Apr 23 03:24:37 cube kernel: PERCPU: Embedded 9 pages/cpu @ee7b3000 s12608 r8192 d16064 u36864 Apr 23 03:24:37 cube kernel: pcpu-alloc: s12608 r8192 d16064 u36864 alloc=9*4096 Apr 23 03:24:37 cube kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Apr 23 03:24:37 cube kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522768 Apr 23 03:24:37 cube kernel: Kernel command line: console=ttymxc0,115200 quiet Apr 23 03:24:37 cube kernel: PID hash table entries: 4096 (order: 2, 16384 bytes) Apr 23 03:24:37 cube kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Apr 23 03:24:37 cube kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Apr 23 03:24:37 cube kernel: Memory: 2054816K/2097152K available (6404K kernel code, 828K rwdata, 2204K rodata, 684K init, 393K bss, 42336K reserved, 1318912K highmem) Apr 23 03:24:37 cube kernel: Virtual kernel memory layout: vector : 0xffff0000 - 0xffff1000 ( 4 kB) fixmap : 0xffc00000 - 0xffe00000 (2048 kB) vmalloc : 0xf0000000 - 0xff000000 ( 240 MB) lowmem : 0xc0000000 - 0xef800000 ( 760 MB) pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) modules : 0xbf000000 - 0xbfe00000 ( 14 MB) .text : 0xc0008000 - 0xc08702e4 (8609 kB) .init : 0xc0871000 - 0xc091c140 ( 685 kB) .data : 0xc091e000 - 0xc09ed3d0 ( 829 kB) .bss : 0xc09ed3d0 - 0xc0a4f874 ( 394 kB) Apr 23 03:24:37 cube kernel: Hierarchical RCU implementation. Apr 23 03:24:37 cube kernel: RCU dyntick-idle grace-period acceleration is enabled. Apr 23 03:24:37 cube kernel: NR_IRQS:16 nr_irqs:16 16 Apr 23 03:24:37 cube kernel: L2C-310 erratum 769419 enabled Apr 23 03:24:37 cube kernel: L2C-310 enabling early BRESP for Cortex-A9 Apr 23 03:24:37 cube kernel: L2C-310 full line of zeros enabled for Cortex-A9 Apr 23 03:24:37 cube kernel: L2C-310 ID prefetch enabled, offset 1 lines Apr 23 03:24:37 cube kernel: L2C-310 dynamic clock gating enabled, standby mode enabled Apr 23 03:24:37 cube kernel: L2C-310 cache controller enabled, 16 ways, 1024 kB Apr 23 03:24:37 cube kernel: L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76070001 Apr 23 03:24:37 cube kernel: Switching to timer-based delay loop Apr 23 03:24:37 cube kernel: sched_clock: 32 bits at 66MHz, resolution 15ns, wraps every 65075262448ns Apr 23 03:24:37 cube kernel: Console: colour dummy device 80x30 Apr 23 03:24:37 cube kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 132.00 BogoMIPS (lpj=264000) Apr 23 03:24:37 cube kernel: pid_max: default: 32768 minimum: 301 Apr 23 03:24:37 cube kernel: Security Framework initialized Apr 23 03:24:37 cube kernel: AppArmor: AppArmor disabled by boot time parameter Apr 23 03:24:37 cube kernel: Yama: disabled by default; enable with sysctl kernel.yama.* Apr 23 03:24:37 cube kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Apr 23 03:24:37 cube kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Apr 23 03:24:37 cube kernel: Initializing cgroup subsys memory Apr 23 03:24:37 cube kernel: Initializing cgroup subsys devices Apr 23 03:24:37 cube kernel: Initializing cgroup subsys freezer Apr 23 03:24:37 cube kernel: Initializing cgroup subsys net_cls Apr 23 03:24:37 cube kernel: Initializing cgroup subsys blkio Apr 23 03:24:37 cube kernel: Initializing cgroup subsys perf_event Apr 23 03:24:37 cube kernel: Initializing cgroup subsys net_prio Apr 23 03:24:37 cube kernel: CPU: Testing write buffer coherency: ok Apr 23 03:24:37 cube kernel: ftrace: allocating 23044 entries in 68 pages Apr 23 03:24:37 cube kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Apr 23 03:24:37 cube kernel: Setting up static identity map for 0x105c02d8 - 0x105c0330 Apr 23 03:24:37 cube kernel: CPU1: Booted secondary processor Apr 23 03:24:37 cube kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Apr 23 03:24:37 cube kernel: CPU2: Booted secondary processor Apr 23 03:24:37 cube kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Apr 23 03:24:37 cube kernel: CPU3: Booted secondary processor Apr 23 03:24:37 cube kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Apr 23 03:24:37 cube kernel: Brought up 4 CPUs Apr 23 03:24:37 cube kernel: SMP: Total of 4 processors activated (528.00 BogoMIPS). Apr 23 03:24:37 cube kernel: CPU: All CPU(s) started in SVC mode. Apr 23 03:24:37 cube kernel: devtmpfs: initialized Apr 23 03:24:37 cube kernel: VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4 Apr 23 03:24:37 cube kernel: pinctrl core: initialized pinctrl subsystem Apr 23 03:24:37 cube kernel: regulator-dummy: no parameters Apr 23 03:24:37 cube kernel: NET: Registered protocol family 16 Apr 23 03:24:37 cube kernel: DMA: preallocated 256 KiB pool for atomic coherent allocations Apr 23 03:24:37 cube kernel: CPU identified as i.MX6Q, unknown revision Apr 23 03:24:37 cube kernel: No ATAGs? Apr 23 03:24:37 cube kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers. Apr 23 03:24:37 cube kernel: hw-breakpoint: maximum watchpoint size is 4 bytes. Apr 23 03:24:37 cube kernel: EXYNOS: PMU not supported Apr 23 03:24:37 cube kernel: imx6q-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver Apr 23 03:24:37 cube kernel: Serial: AMBA PL011 UART driver Apr 23 03:24:37 cube kernel: mxs-dma 110000.dma-apbh: initialized Apr 23 03:24:37 cube kernel: edma-dma-engine edma-dma-engine.0: Can't allocate PaRAM dummy slot Apr 23 03:24:37 cube kernel: edma-dma-engine: probe of edma-dma-engine.0 failed with error -5 Apr 23 03:24:37 cube kernel: 3P3V: 3300 mV Apr 23 03:24:37 cube kernel: usb_h1_vbus: 5000 mV Apr 23 03:24:37 cube kernel: usb_otg_vbus: 5000 mV Apr 23 03:24:37 cube kernel: vgaarb: loaded Apr 23 03:24:37 cube kernel: usbcore: registered new interface driver usbfs Apr 23 03:24:37 cube kernel: usbcore: registered new interface driver hub Apr 23 03:24:37 cube kernel: usbcore: registered new device driver usb Apr 23 03:24:37 cube kernel: media: Linux media interface: v0.10 Apr 23 03:24:37 cube kernel: Linux video capture interface: v2.00 Apr 23 03:24:37 cube kernel: pps_core: LinuxPPS API ver. 1 registered Apr 23 03:24:37 cube kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giome...@linux.it> Apr 23 03:24:37 cube kernel: PTP clock support registered Apr 23 03:24:37 cube kernel: Switched to clocksource mxc_timer1 Apr 23 03:24:37 cube kernel: NET: Registered protocol family 2 Apr 23 03:24:37 cube kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes) Apr 23 03:24:37 cube kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Apr 23 03:24:37 cube kernel: TCP: Hash tables configured (established 8192 bind 8192) Apr 23 03:24:37 cube kernel: TCP: reno registered Apr 23 03:24:37 cube kernel: UDP hash table entries: 512 (order: 2, 16384 bytes) Apr 23 03:24:37 cube kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Apr 23 03:24:37 cube kernel: NET: Registered protocol family 1 Apr 23 03:24:37 cube kernel: PCI: CLS 0 bytes, default 64 Apr 23 03:24:37 cube kernel: Unpacking initramfs... Apr 23 03:24:37 cube kernel: Freeing initrd memory: 14284K (c1800000 - c25f3000) Apr 23 03:24:37 cube kernel: hw perfevents: enabled with ARMv7 Cortex-A9 PMU driver, 7 counters available Apr 23 03:24:37 cube kernel: futex hash table entries: 1024 (order: 4, 65536 bytes) Apr 23 03:24:37 cube kernel: audit: initializing netlink subsys (disabled) Apr 23 03:24:37 cube kernel: audit: type=2000 audit(1.287:1): initialized Apr 23 03:24:37 cube kernel: zbud: loaded Apr 23 03:24:37 cube kernel: VFS: Disk quotas dquot_6.5.2 Apr 23 03:24:37 cube kernel: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Apr 23 03:24:37 cube kernel: msgmni has been set to 1465 Apr 23 03:24:37 cube kernel: alg: No test for stdrng (krng) Apr 23 03:24:37 cube kernel: bounce: pool size: 64 pages Apr 23 03:24:37 cube kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Apr 23 03:24:37 cube kernel: io scheduler noop registered Apr 23 03:24:37 cube kernel: io scheduler deadline registered Apr 23 03:24:37 cube kernel: io scheduler cfq registered (default) Apr 23 03:24:37 cube kernel: imx-sdma 20ec000.sdma: firmware: failed to load imx/sdma/sdma-imx6q.bin (-2) Apr 23 03:24:37 cube kernel: imx-sdma 20ec000.sdma: initialized Apr 23 03:24:37 cube kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled Apr 23 03:24:37 cube kernel: Serial: AMBA driver Apr 23 03:24:37 cube kernel: Serial: IMX driver Apr 23 03:24:37 cube kernel: 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 58, base_baud = 5000000) is a IMX Apr 23 03:24:37 cube kernel: console [ttymxc0] enabled Apr 23 03:24:37 cube kernel: 2188000.ethernet supply phy not found, using dummy regulator Apr 23 03:24:37 cube kernel: libphy: fec_enet_mii_bus: probed Apr 23 03:24:37 cube kernel: fec 2188000.ethernet eth0: registered PHC device 0 Apr 23 03:24:37 cube kernel: mousedev: PS/2 mouse device common for all mice Apr 23 03:24:37 cube kernel: snvs_rtc 20cc034.snvs-rtc-lp: rtc core: registered 20cc034.snvs-rtc-lp as rtc0 Apr 23 03:24:37 cube kernel: ledtrig-cpu: registered to indicate activity on CPUs Apr 23 03:24:37 cube kernel: hidraw: raw HID events driver (C) Jiri Kosina Apr 23 03:24:37 cube kernel: usbcore: registered new interface driver usbhid Apr 23 03:24:37 cube kernel: usbhid: USB HID core driver Apr 23 03:24:37 cube kernel: TCP: cubic registered Apr 23 03:24:37 cube kernel: NET: Registered protocol family 10 Apr 23 03:24:37 cube kernel: mip6: Mobile IPv6 Apr 23 03:24:51 cube kernel: NET: Registered protocol family 17 Apr 23 03:24:51 cube kernel: mpls_gso: MPLS GSO support Apr 23 03:24:51 cube kernel: ThumbEE CPU extension supported. Apr 23 03:24:51 cube kernel: Registering SWP/SWPB emulation handler Apr 23 03:24:51 cube kernel: registered taskstats version 1 Apr 23 03:24:51 cube kernel: snvs_rtc 20cc034.snvs-rtc-lp: setting system clock to 2015-04-23 10:24:35 UTC (1429784675) Apr 23 03:24:51 cube kernel: PM: Hibernation image not present or could not be loaded. Apr 23 03:24:51 cube kernel: usb_otg_vbus: disabling Apr 23 03:24:51 cube kernel: usb_h1_vbus: disabling Apr 23 03:24:51 cube kernel: Freeing unused kernel memory: 684K (c0871000 - c091c000) Apr 23 03:24:51 cube systemd-udevd[73]: starting version 215 Apr 23 03:24:51 cube kernel: random: systemd-udevd urandom read with 1 bits of entropy available Apr 23 03:24:51 cube kernel: sdhci: Secure Digital Host Controller Interface driver Apr 23 03:24:51 cube kernel: sdhci: Copyright(c) Pierre Ossman Apr 23 03:24:51 cube kernel: sdhci-pltfm: SDHCI platform and OF driver helper Apr 23 03:24:51 cube kernel: sdhci-esdhc-imx 2194000.usdhc: could not get ultra high speed state, work on normal mode Apr 23 03:24:51 cube kernel: mmc0: no vqmmc regulator found Apr 23 03:24:51 cube kernel: SCSI subsystem initialized Apr 23 03:24:51 cube kernel: libata version 3.00 loaded. Apr 23 03:24:51 cube kernel: ahci-imx 2200000.sata: SSS flag set, parallel bus scan disabled Apr 23 03:24:51 cube kernel: ahci-imx 2200000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode Apr 23 03:24:51 cube kernel: ahci-imx 2200000.sata: flags: ncq sntf stag pm led clo only pmp pio slum part ccc apst Apr 23 03:24:51 cube kernel: scsi0 : ahci_platform Apr 23 03:24:51 cube kernel: ata1: SATA max UDMA/133 mmio [mem 0x02200000-0x02203fff] port 0x100 irq 71 Apr 23 03:24:51 cube kernel: mmc0: SDHCI controller on 2194000.usdhc [2194000.usdhc] using ADMA Apr 23 03:24:51 cube kernel: mmc0: host does not support reading read-only switch. assuming write-enable. Apr 23 03:24:51 cube kernel: mmc0: new high speed SDXC card at address 0007 Apr 23 03:24:51 cube kernel: mmcblk0: mmc0:0007 SD64G 58.4 GiB Apr 23 03:24:51 cube kernel: mmcblk0: p1 p2 p3 < p5 p6 p7 > Apr 23 03:24:51 cube kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Apr 23 03:24:51 cube kernel: ata1.00: ATA-8: HGST HTS721010A9E630, JB0OA3J0, max UDMA/133 Apr 23 03:24:51 cube kernel: ata1.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32) Apr 23 03:24:51 cube kernel: ata1.00: configured for UDMA/133 Apr 23 03:24:51 cube kernel: scsi 0:0:0:0: Direct-Access ATA HGST HTS721010A9 A3J0 PQ: 0 ANSI: 5 Apr 23 03:24:51 cube kernel: sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/931 GiB) Apr 23 03:24:51 cube kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Apr 23 03:24:51 cube kernel: sd 0:0:0:0: [sda] Write Protect is off Apr 23 03:24:51 cube kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Apr 23 03:24:51 cube kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Apr 23 03:24:51 cube kernel: sda: unknown partition table Apr 23 03:24:51 cube kernel: sd 0:0:0:0: [sda] Attached SCSI disk Apr 23 03:24:51 cube kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Apr 23 03:24:51 cube kernel: device-mapper: uevent: version 1.0.3 Apr 23 03:24:51 cube kernel: device-mapper: ioctl: 4.27.0-ioctl (2013-10-30) initialised: dm-de...@redhat.com Apr 23 03:24:51 cube kernel: PM: Starting manual resume from disk Apr 23 03:24:51 cube kernel: PM: Hibernation image partition 179:5 present Apr 23 03:24:51 cube kernel: PM: Looking for hibernation image. Apr 23 03:24:51 cube kernel: PM: Image not found (code -22) Apr 23 03:24:51 cube kernel: PM: Hibernation image not present or could not be loaded. Apr 23 03:24:51 cube kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Apr 23 03:24:51 cube systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Apr 23 03:24:51 cube kernel: EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro Apr 23 03:24:51 cube systemd-journal[163]: Journal started Apr 23 03:24:51 cube systemd-modules-load[155]: Failed to find module 'lp' Apr 23 03:24:51 cube systemd-modules-load[155]: Failed to find module 'ppdev' Apr 23 03:24:51 cube systemd-modules-load[155]: Failed to find module 'parport_pc' Apr 23 03:24:51 cube fake-hwclock[153]: Thu Apr 23 10:24:51 UTC 2015 Apr 23 03:24:51 cube kernel: raid6: int32x1 85 MB/s Apr 23 03:24:51 cube kernel: raid6: int32x2 143 MB/s Apr 23 03:24:51 cube systemd-udevd[183]: starting version 215 Apr 23 03:24:51 cube kernel: raid6: int32x4 159 MB/s Apr 23 03:24:51 cube kernel: raid6: int32x8 173 MB/s Apr 23 03:24:51 cube kernel: raid6: using algorithm int32x8 (173 MB/s) Apr 23 03:24:51 cube kernel: raid6: using intx1 recovery algorithm Apr 23 03:24:51 cube kernel: async_tx: api initialized (async) Apr 23 03:24:51 cube kernel: xor: measuring software checksum speed Apr 23 03:24:51 cube kernel: arm4regs : 1312.000 MB/sec Apr 23 03:24:51 cube kernel: 8regs : 891.000 MB/sec Apr 23 03:24:51 cube kernel: 32regs : 680.000 MB/sec Apr 23 03:24:51 cube kernel: xor: using function: arm4regs (1312.000 MB/sec) Apr 23 03:24:51 cube kernel: md: raid10 personality registered for level 10 Apr 23 03:24:51 cube kernel: random: nonblocking pool is initialized Apr 23 03:24:51 cube kernel: md: raid1 personality registered for level 1 Apr 23 03:24:51 cube mdadm-raid[186]: Generating udev events for MD arrays...done. Apr 23 03:24:51 cube kernel: md: raid6 personality registered for level 6 Apr 23 03:24:51 cube kernel: md: raid5 personality registered for level 5 Apr 23 03:24:51 cube kernel: md: raid4 personality registered for level 4 Apr 23 03:24:51 cube systemd-modules-load[155]: Inserted module 'dm_raid' Apr 23 03:24:51 cube kernel: device-mapper: raid: Loading target version 1.5.2 Apr 23 03:24:51 cube systemd[1]: systemd-modules-load.service: main process exited, code=exited, status=1/FAILURE Apr 23 03:24:51 cube systemd[1]: Failed to start Load Kernel Modules. Apr 23 03:24:51 cube systemd[1]: Unit systemd-modules-load.service entered failed state. Apr 23 03:24:51 cube kernel: Registered IR keymap rc-empty Apr 23 03:24:51 cube kernel: input: gpio_ir_recv as /devices/soc0/ir-receiver/rc/rc0/input0 Apr 23 03:24:51 cube kernel: rc0: gpio_ir_recv as /devices/soc0/ir-receiver/rc/rc0 Apr 23 03:24:51 cube kernel: IR NEC protocol handler initialized Apr 23 03:24:51 cube kernel: [drm] Initialized drm 1.1.0 20060810 Apr 23 03:24:51 cube kernel: IR RC5(x) protocol handler initialized Apr 23 03:24:51 cube kernel: ipu_smfc_init: ioremap 0x02650000 -> f0652000 Apr 23 03:24:51 cube kernel: imx-ipuv3 2400000.ipu: IPUv3H probed Apr 23 03:24:51 cube kernel: ipu_smfc_init: ioremap 0x02a50000 -> f0666000 Apr 23 03:24:51 cube kernel: IR RC6 protocol handler initialized Apr 23 03:24:51 cube kernel: imx-ipuv3 2800000.ipu: IPUv3H probed Apr 23 03:24:51 cube kernel: imx2-wdt 20bc000.wdog: timeout 60 sec (nowayout=0) Apr 23 03:24:51 cube kernel: IR Sony protocol handler initialized Apr 23 03:24:51 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 23 03:24:51 cube kernel: IR SANYO protocol handler initialized Apr 23 03:24:51 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 23 03:24:51 cube kernel: i2c i2c-1: IMX I2C adapter registered Apr 23 03:24:51 cube kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Apr 23 03:24:51 cube kernel: IR JVC protocol handler initialized Apr 23 03:24:51 cube kernel: i2c i2c-2: IMX I2C adapter registered Apr 23 03:24:51 cube kernel: IR Sharp protocol handler initialized Apr 23 03:24:51 cube kernel: input: MCE IR Keyboard/Mouse (gpio-rc-recv) as /devices/virtual/input/input1 Apr 23 03:24:51 cube kernel: IR MCE Keyboard/mouse protocol handler initialized Apr 23 03:24:51 cube kernel: lirc_dev: IR Remote Control driver registered, major 243 Apr 23 03:24:51 cube kernel: imx_hdmi: module is from the staging directory, the quality is unknown, you have been warned. Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.0: ChipIdea HDRC found, lpm: 0; cap: f06fe100 op: f06fe140 Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.0: It is OTG capable controller Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.0: EHCI Host Controller Apr 23 03:24:51 cube kernel: rc rc0: lirc_dev: driver ir-lirc-codec (gpio-rc-recv) registered at minor = 0 Apr 23 03:24:51 cube kernel: IR LIRC bridge handler initialized Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.0: new USB bus registered, assigned bus number 1 Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.0: USB 2.0 started, EHCI 1.00 Apr 23 03:24:51 cube kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Apr 23 03:24:51 cube kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 23 03:24:51 cube kernel: usb usb1: Product: EHCI Host Controller Apr 23 03:24:51 cube kernel: usb usb1: Manufacturer: Linux 3.16.0-4-armmp ehci_hcd Apr 23 03:24:51 cube kernel: usb usb1: SerialNumber: ci_hdrc.0 Apr 23 03:24:51 cube kernel: hub 1-0:1.0: USB hub found Apr 23 03:24:51 cube kernel: hub 1-0:1.0: 1 port detected Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.1: ChipIdea HDRC found, lpm: 0; cap: f07f8300 op: f07f8340 Apr 23 03:24:51 cube kernel: imx-spdif sound-spdif: ASoC: CPU DAI (null) not registered Apr 23 03:24:51 cube kernel: imx-spdif sound-spdif: snd_soc_register_card failed: -517 Apr 23 03:24:51 cube kernel: platform sound-spdif: Driver imx-spdif requests probe deferral Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.1: doesn't support gadget Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.1: EHCI Host Controller Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.1: new USB bus registered, assigned bus number 2 Apr 23 03:24:51 cube kernel: imx-spdif sound-spdif: snd-soc-dummy-dai <-> 2004000.spdif mapping ok Apr 23 03:24:51 cube kernel: ci_hdrc ci_hdrc.1: USB 2.0 started, EHCI 1.00 Apr 23 03:24:51 cube kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002 Apr 23 03:24:51 cube kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 23 03:24:51 cube kernel: usb usb2: Product: EHCI Host Controller Apr 23 03:24:51 cube kernel: usb usb2: Manufacturer: Linux 3.16.0-4-armmp ehci_hcd Apr 23 03:24:51 cube kernel: usb usb2: SerialNumber: ci_hdrc.1 Apr 23 03:24:51 cube kernel: hub 2-0:1.0: USB hub found Apr 23 03:24:51 cube kernel: hub 2-0:1.0: 1 port detected Apr 23 03:24:51 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 23 03:24:51 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 23 03:24:51 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 23 03:24:51 cube kernel: [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). Apr 23 03:24:51 cube kernel: [drm] No driver support for vblank timestamp query. Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.0 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.1 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.4 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.5 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 23 03:24:51 cube kernel: imx-hdmi 120000.hdmi: Detected HDMI controller 0x13:0xa:0xa0:0xc1 Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: bound 120000.hdmi (ops imx_hdmi_driver_exit [imx_hdmi]) Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: No connectors reported connected with modes Apr 23 03:24:51 cube kernel: [drm] Cannot find any crtc or sizes - going 1024x768 Apr 23 03:24:51 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 23 03:24:51 cube kernel: Console: switching to colour frame buffer device 128x48 Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: fb0: frame buffer device Apr 23 03:24:51 cube kernel: imx-drm display-subsystem: registered panic notifier Apr 23 03:24:51 cube kernel: [drm] Initialized imx-drm 1.0.0 20120507 on minor 0 Apr 23 03:24:52 cube kernel: usb 1-1: new high-speed USB device number 2 using ci_hdrc Apr 23 03:24:52 cube kernel: usb 1-1: New USB device found, idVendor=0409, idProduct=005a Apr 23 03:24:52 cube kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Apr 23 03:24:52 cube kernel: hub 1-1:1.0: USB hub found Apr 23 03:24:52 cube kernel: hub 1-1:1.0: 4 ports detected Apr 23 03:24:52 cube kernel: usb 1-1.1: new high-speed USB device number 3 using ci_hdrc Apr 23 03:24:52 cube kernel: Adding 9764860k swap on /dev/mmcblk0p5. Priority:-1 extents:1 across:9764860k SSFS Apr 23 03:24:52 cube systemd-fsck[239]: /dev/mmcblk0p7: Superblock last write time is in the future. Apr 23 03:24:52 cube systemd-fsck[239]: (by less than a day, probably due to the hardware clock being incorrectly set). FIXED. Apr 23 03:24:52 cube systemd-fsck[245]: /dev/mmcblk0p1: clean, 22/62248 files, 29964/248832 blocks Apr 23 03:24:52 cube kernel: usb 1-1.1: New USB device found, idVendor=0781, idProduct=5571 Apr 23 03:24:52 cube kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 23 03:24:52 cube kernel: usb 1-1.1: Product: Cruzer Fit Apr 23 03:24:52 cube kernel: usb 1-1.1: Manufacturer: SanDisk Apr 23 03:24:52 cube kernel: usb 1-1.1: SerialNumber: 4C530013220303118132 Apr 23 03:24:52 cube systemd-fsck[240]: HOME: clean, 826/2445984 files, 340161/9764864 blocks Apr 23 03:24:52 cube kernel: usb 1-1.2: new high-speed USB device number 4 using ci_hdrc Apr 23 03:24:52 cube kernel: usb 1-1.2: New USB device found, idVendor=0781, idProduct=5571 Apr 23 03:24:52 cube kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 23 03:24:52 cube kernel: usb 1-1.2: Product: Cruzer Fit Apr 23 03:24:52 cube kernel: usb 1-1.2: Manufacturer: SanDisk Apr 23 03:24:52 cube kernel: usb 1-1.2: SerialNumber: 4C530201430303122020 Apr 23 03:24:52 cube kernel: usb 1-1.3: new high-speed USB device number 5 using ci_hdrc Apr 23 03:24:52 cube lvm[246]: 1 logical volume(s) in volume group "vg" now active Apr 23 03:24:52 cube kernel: usb 1-1.3: New USB device found, idVendor=0781, idProduct=5571 Apr 23 03:24:52 cube kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 23 03:24:52 cube kernel: usb 1-1.3: Product: Cruzer Fit Apr 23 03:24:52 cube kernel: usb 1-1.3: Manufacturer: SanDisk Apr 23 03:24:52 cube kernel: usb 1-1.3: SerialNumber: 4C530201470303119301 Apr 23 03:24:53 cube kernel: EXT4-fs (mmcblk0p1): mounting ext2 file system using the ext4 subsystem Apr 23 03:24:53 cube kernel: usb 1-1.4: new high-speed USB device number 6 using ci_hdrc Apr 23 03:24:53 cube kernel: usb 1-1.4: New USB device found, idVendor=0409, idProduct=005a Apr 23 03:24:53 cube kernel: usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Apr 23 03:24:53 cube kernel: hub 1-1.4:1.0: USB hub found Apr 23 03:24:53 cube kernel: hub 1-1.4:1.0: 4 ports detected Apr 23 03:24:53 cube kernel: EXT4-fs (mmcblk0p1): mounted filesystem without journal. Opts: (null) Apr 23 03:24:53 cube kernel: EXT4-fs (mmcblk0p6): mounted filesystem with ordered data mode. Opts: (null) Apr 23 03:24:53 cube kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Apr 23 03:24:53 cube kernel: scsi1 : usb-storage 1-1.1:1.0 Apr 23 03:24:53 cube kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Apr 23 03:24:53 cube kernel: scsi2 : usb-storage 1-1.2:1.0 Apr 23 03:24:53 cube kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected Apr 23 03:24:53 cube kernel: scsi3 : usb-storage 1-1.3:1.0 Apr 23 03:24:53 cube kernel: usbcore: registered new interface driver usb-storage Apr 23 03:24:53 cube systemd-fsck[268]: BIG: clean, 11/61054976 files, 3883091/244190208 blocks Apr 23 03:24:53 cube kernel: usb 1-1.4.1: new high-speed USB device number 7 using ci_hdrc Apr 23 03:24:53 cube lvm[267]: 1 logical volume(s) in volume group "vg" now active Apr 23 03:24:53 cube kernel: usb 1-1.4.1: New USB device found, idVendor=0781, idProduct=5571 Apr 23 03:24:53 cube kernel: usb 1-1.4.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 23 03:24:53 cube kernel: usb 1-1.4.1: Product: Cruzer Fit Apr 23 03:24:53 cube kernel: usb 1-1.4.1: Manufacturer: SanDisk Apr 23 03:24:53 cube kernel: usb 1-1.4.1: SerialNumber: 4C530001450303119270 Apr 23 03:24:53 cube kernel: usb-storage 1-1.4.1:1.0: USB Mass Storage device detected Apr 23 03:24:53 cube kernel: scsi4 : usb-storage 1-1.4.1:1.0 Apr 23 03:24:53 cube systemd-fsck[239]: /dev/mmcblk0p7: 4752/334560 files (1.1% non-contiguous), 191940/1335808 blocks Apr 23 03:24:53 cube kernel: EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null) Apr 23 03:24:53 cube kernel: usb 1-1.4.2: new high-speed USB device number 8 using ci_hdrc Apr 23 03:24:53 cube kernel: EXT4-fs (mmcblk0p7): mounted filesystem with ordered data mode. Opts: (null) Apr 23 03:24:53 cube kernel: usb 1-1.4.2: New USB device found, idVendor=0781, idProduct=5571 Apr 23 03:24:53 cube kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 23 03:24:53 cube kernel: usb 1-1.4.2: Product: Cruzer Fit Apr 23 03:24:53 cube kernel: usb 1-1.4.2: Manufacturer: SanDisk Apr 23 03:24:53 cube kernel: usb 1-1.4.2: SerialNumber: 4C530301400303119272 Apr 23 03:24:53 cube kernel: usb-storage 1-1.4.2:1.0: USB Mass Storage device detected Apr 23 03:24:53 cube kernel: scsi5 : usb-storage 1-1.4.2:1.0 Apr 23 03:24:53 cube lvm[299]: 1 logical volume(s) in volume group "vg" monitored Apr 23 03:24:54 cube kernel: scsi 2:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 23 03:24:54 cube kernel: scsi 3:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 23 03:24:54 cube kernel: scsi 1:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 23 03:24:54 cube kernel: sd 2:0:0:0: Attached scsi generic sg1 type 0 Apr 23 03:24:54 cube kernel: sd 2:0:0:0: [sdb] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 23 03:24:54 cube kernel: sd 3:0:0:0: Attached scsi generic sg2 type 0 Apr 23 03:24:54 cube kernel: sd 3:0:0:0: [sdc] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 23 03:24:54 cube kernel: sd 3:0:0:0: [sdc] Write Protect is off Apr 23 03:24:54 cube kernel: sd 3:0:0:0: [sdc] Mode Sense: 43 00 00 00 Apr 23 03:24:54 cube kernel: sd 1:0:0:0: Attached scsi generic sg3 type 0 Apr 23 03:24:54 cube kernel: sd 3:0:0:0: [sdc] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 23 03:24:54 cube kernel: sd 2:0:0:0: [sdb] Write Protect is off Apr 23 03:24:54 cube kernel: sd 2:0:0:0: [sdb] Mode Sense: 43 00 00 00 Apr 23 03:24:54 cube kernel: sd 2:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 23 03:24:54 cube kernel: sd 1:0:0:0: [sdd] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 23 03:24:54 cube kernel: sd 1:0:0:0: [sdd] Write Protect is off Apr 23 03:24:54 cube kernel: sd 1:0:0:0: [sdd] Mode Sense: 43 00 00 00 Apr 23 03:24:54 cube kernel: sd 1:0:0:0: [sdd] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 23 03:24:54 cube kernel: sdc: unknown partition table Apr 23 03:24:54 cube kernel: sdb: unknown partition table Apr 23 03:24:54 cube kernel: sd 2:0:0:0: [sdb] Attached SCSI removable disk Apr 23 03:24:54 cube kernel: sd 3:0:0:0: [sdc] Attached SCSI removable disk Apr 23 03:24:54 cube kernel: sdd: unknown partition table Apr 23 03:24:54 cube kernel: sd 1:0:0:0: [sdd] Attached SCSI removable disk Apr 23 03:24:54 cube kernel: md: bind<sdc> Apr 23 03:24:54 cube kernel: md: bind<sdb> Apr 23 03:24:54 cube kernel: md: bind<sdd> Apr 23 03:24:54 cube kernel: scsi 4:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 23 03:24:54 cube kernel: sd 4:0:0:0: Attached scsi generic sg4 type 0 Apr 23 03:24:54 cube kernel: sd 4:0:0:0: [sde] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 23 03:24:54 cube kernel: sd 4:0:0:0: [sde] Write Protect is off Apr 23 03:24:54 cube kernel: sd 4:0:0:0: [sde] Mode Sense: 43 00 00 00 Apr 23 03:24:54 cube kernel: sd 4:0:0:0: [sde] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 23 03:24:54 cube kernel: sde: unknown partition table Apr 23 03:24:54 cube kernel: sd 4:0:0:0: [sde] Attached SCSI removable disk Apr 23 03:24:54 cube kernel: md: bind<sde> Apr 23 03:24:54 cube kernel: scsi 5:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 23 03:24:54 cube kernel: sd 5:0:0:0: Attached scsi generic sg5 type 0 Apr 23 03:24:54 cube kernel: sd 5:0:0:0: [sdf] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 23 03:24:54 cube kernel: sd 5:0:0:0: [sdf] Write Protect is off Apr 23 03:24:54 cube kernel: sd 5:0:0:0: [sdf] Mode Sense: 43 00 00 00 Apr 23 03:24:54 cube kernel: sd 5:0:0:0: [sdf] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 23 03:24:54 cube kernel: sdf: unknown partition table Apr 23 03:24:54 cube kernel: sd 5:0:0:0: [sdf] Attached SCSI removable disk Apr 23 03:24:54 cube kernel: md: bind<sdf> Apr 23 03:24:54 cube kernel: md/raid:md127: device sdf operational as raid disk 4 Apr 23 03:24:54 cube kernel: md/raid:md127: device sde operational as raid disk 3 Apr 23 03:24:54 cube kernel: md/raid:md127: device sdd operational as raid disk 0 Apr 23 03:24:54 cube kernel: md/raid:md127: device sdb operational as raid disk 1 Apr 23 03:24:54 cube kernel: md/raid:md127: device sdc operational as raid disk 2 Apr 23 03:24:54 cube kernel: md/raid:md127: allocated 0kB Apr 23 03:24:54 cube kernel: md/raid:md127: raid level 6 active with 5 out of 5 devices, algorithm 2 Apr 23 03:24:54 cube kernel: RAID conf printout: Apr 23 03:24:54 cube kernel: --- level:6 rd:5 wd:5 Apr 23 03:24:54 cube kernel: disk 0, o:1, dev:sdd Apr 23 03:24:54 cube kernel: disk 1, o:1, dev:sdb Apr 23 03:24:54 cube kernel: disk 2, o:1, dev:sdc Apr 23 03:24:54 cube kernel: disk 3, o:1, dev:sde Apr 23 03:24:54 cube kernel: disk 4, o:1, dev:sdf Apr 23 03:24:54 cube kernel: md127: detected capacity change from 0 to 93731684352 Apr 23 03:24:54 cube kernel: md127: unknown partition table Apr 23 03:26:20 cube systemd[1]: Job dev-disk-by\x2dlabel-BACKUP.device/start timed out. Apr 23 03:26:20 cube systemd[1]: Timed out waiting for device dev-disk-by\x2dlabel-BACKUP.device. Apr 23 03:26:20 cube systemd[1]: Dependency failed for /backup. Apr 23 03:26:20 cube systemd[1]: Dependency failed for Local File Systems. Apr 23 03:26:21 cube adjtimex[323]: Regulating system clock...done. Apr 23 03:26:21 cube systemd-journal[163]: Runtime journal is using 5.0M (max allowed 40.4M, trying to leave 60.6M free of 398.8M available â current limit 40.4M). Apr 23 03:26:21 cube kernel: fec 2188000.ethernet eth0: Freescale FEC PHY driver [Atheros 8035 ethernet] (mii_bus:phy_addr=2188000.ethernet:00, irq=-1) Apr 23 03:26:21 cube kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Apr 23 03:26:21 cube networking[325]: Configuring network interfaces...done. Apr 23 03:26:21 cube dhclient[379]: Internet Systems Consortium DHCP Client 4.3.1 Apr 23 03:26:21 cube ifup[374]: Internet Systems Consortium DHCP Client 4.3.1 Apr 23 03:26:21 cube dhclient[379]: Copyright 2004-2014 Internet Systems Consortium. Apr 23 03:26:21 cube dhclient[379]: All rights reserved. Apr 23 03:26:21 cube dhclient[379]: For info, please visit https://www.isc.org/software/dhcp/ Apr 23 03:26:21 cube dhclient[379]: Apr 23 03:26:21 cube ifup[374]: Copyright 2004-2014 Internet Systems Consortium. Apr 23 03:26:21 cube ifup[374]: All rights reserved. Apr 23 03:26:21 cube ifup[374]: For info, please visit https://www.isc.org/software/dhcp/ Apr 23 03:26:22 cube dhclient[379]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:22 cube dhclient[379]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:22 cube dhclient[379]: Sending on Socket/fallback Apr 23 03:26:22 cube dhclient[379]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 3 Apr 23 03:26:22 cube ifup[374]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:22 cube ifup[374]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:22 cube ifup[374]: Sending on Socket/fallback Apr 23 03:26:22 cube ifup[374]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 3 Apr 23 03:26:22 cube rpcbind[380]: Starting rpcbind daemon.... Apr 23 03:26:22 cube rpc.statd[401]: Version 1.2.8 starting Apr 23 03:26:22 cube sm-notify[402]: Version 1.2.8 starting Apr 23 03:26:22 cube kernel: RPC: Registered named UNIX socket transport module. Apr 23 03:26:22 cube kernel: RPC: Registered udp transport module. Apr 23 03:26:22 cube kernel: RPC: Registered tcp transport module. Apr 23 03:26:22 cube kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 23 03:26:22 cube kernel: FS-Cache: Loaded Apr 23 03:26:22 cube kernel: FS-Cache: Netfs 'nfs' registered for caching Apr 23 03:26:22 cube kernel: Installing knfsd (copyright (C) 1996 o...@monad.swb.de). Apr 23 03:26:22 cube nfs-common[396]: Starting NFS common utilities: statd idmapd. Apr 23 03:26:22 cube systemd[329]: Failed at step EXEC spawning /bin/plymouth: No such file or directory Apr 23 03:26:25 cube kernel: fec 2188000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 23 03:26:25 cube kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Apr 23 03:26:25 cube dhclient[379]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4 Apr 23 03:26:25 cube ifup[374]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4 Apr 23 03:26:25 cube dhclient[379]: DHCPREQUEST on eth0 to 255.255.255.255 port 67 Apr 23 03:26:25 cube dhclient[379]: DHCPOFFER from 192.168.3.4 Apr 23 03:26:25 cube ifup[374]: DHCPREQUEST on eth0 to 255.255.255.255 port 67 Apr 23 03:26:25 cube ifup[374]: DHCPOFFER from 192.168.3.4 Apr 23 03:26:25 cube dhclient[379]: DHCPACK from 192.168.3.4 Apr 23 03:26:25 cube ifup[374]: DHCPACK from 192.168.3.4 Apr 23 03:26:26 cube dhclient[379]: bound to 192.168.3.129 -- renewal in 3462 seconds. Apr 23 03:26:26 cube ifup[374]: bound to 192.168.3.129 -- renewal in 3462 seconds. Apr 23 03:26:27 cube systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Apr 23 03:26:27 cube systemd-modules-load[555]: Failed to find module 'lp' Apr 23 03:26:27 cube systemd-modules-load[555]: Failed to find module 'ppdev' Apr 23 03:26:27 cube systemd-modules-load[555]: Failed to find module 'parport_pc' Apr 23 03:26:27 cube systemd[1]: systemd-modules-load.service: main process exited, code=exited, status=1/FAILURE Apr 23 03:26:27 cube systemd[1]: Failed to start Load Kernel Modules. Apr 23 03:26:27 cube systemd[1]: Unit systemd-modules-load.service entered failed state. Apr 23 03:26:27 cube dhclient[567]: Killed old client process Apr 23 03:26:27 cube ifdown[552]: Killed old client process Apr 23 03:26:27 cube lvm[557]: 1 logical volume(s) in volume group "vg1" now active Apr 23 03:26:27 cube lvm[557]: 1 logical volume(s) in volume group "vg" now active Apr 23 03:26:27 cube systemd[1]: backup.mount: Directory /backup to mount over is not empty, mounting anyway. Apr 23 03:26:27 cube kernel: EXT4-fs (dm-1): mounted filesystem with ordered data mode. Opts: (null) Apr 23 03:26:27 cube lvm[577]: 1 logical volume(s) in volume group "vg1" now active Apr 23 03:26:27 cube lvm[577]: 1 logical volume(s) in volume group "vg" now active Apr 23 03:26:28 cube dhclient[567]: Internet Systems Consortium DHCP Client 4.3.1 Apr 23 03:26:28 cube dhclient[567]: Copyright 2004-2014 Internet Systems Consortium. Apr 23 03:26:28 cube dhclient[567]: All rights reserved. Apr 23 03:26:28 cube dhclient[567]: For info, please visit https://www.isc.org/software/dhcp/ Apr 23 03:26:28 cube dhclient[567]: Apr 23 03:26:28 cube ifdown[552]: Internet Systems Consortium DHCP Client 4.3.1 Apr 23 03:26:28 cube ifdown[552]: Copyright 2004-2014 Internet Systems Consortium. Apr 23 03:26:28 cube ifdown[552]: All rights reserved. Apr 23 03:26:28 cube ifdown[552]: For info, please visit https://www.isc.org/software/dhcp/ Apr 23 03:26:28 cube dhclient[567]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:28 cube dhclient[567]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:28 cube dhclient[567]: Sending on Socket/fallback Apr 23 03:26:28 cube ifdown[552]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:28 cube ifdown[552]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:26:28 cube ifdown[552]: Sending on Socket/fallback Apr 23 03:26:28 cube dhclient[567]: DHCPRELEASE on eth0 to 192.168.3.4 port 67 Apr 23 03:26:28 cube ifdown[552]: DHCPRELEASE on eth0 to 192.168.3.4 port 67 Apr 23 03:26:29 cube cron[656]: (CRON) INFO (pidfile fd = 3) Apr 23 03:26:29 cube ntpd[686]: ntpd 4.2.6p5@1.2349-o Fri Apr 10 19:31:04 UTC 2015 (1) Apr 23 03:26:29 cube ntpd[688]: proto: precision = 0.909 usec Apr 23 03:26:29 cube ntpd[688]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 23 03:26:29 cube ntp[662]: Starting NTP server: ntpd. Apr 23 03:26:29 cube ntpd[688]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 23 03:26:29 cube ntpd[688]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 23 03:26:29 cube ntpd[688]: Listen normally on 3 lo ::1 UDP 123 Apr 23 03:26:29 cube ntpd[688]: peers refreshed Apr 23 03:26:29 cube ntpd[688]: Listening on routing socket on fd #20 for interface updates Apr 23 03:26:29 cube ntpd[688]: Deferring DNS for base.rcthomas.org 1 Apr 23 03:26:29 cube ntpd[688]: Deferring DNS for pool.rcthomas.org 10 Apr 23 03:26:29 cube ntpd[688]: Deferring DNS for pool.ntp.org 10 Apr 23 03:26:29 cube ntpd[688]: Deferring DNS for ntp.sixxs.net 10 Apr 23 03:26:29 cube ntpd[694]: signal_no_reset: signal 17 had flags 4000000 Apr 23 03:26:29 cube cron[656]: (CRON) INFO (Running @reboot jobs) Apr 23 03:26:29 cube sshd[657]: Server listening on 0.0.0.0 port 22. Apr 23 03:26:29 cube sshd[657]: Server listening on :: port 22. Apr 23 03:26:29 cube irqbalance[663]: Starting SMP IRQ Balancer: irqbalance. Apr 23 03:26:29 cube avahi-daemon[664]: Found user 'avahi' (UID 105) and group 'avahi' (GID 112). Apr 23 03:26:29 cube avahi-daemon[664]: Successfully dropped root privileges. Apr 23 03:26:29 cube avahi-daemon[664]: avahi-daemon 0.6.31 starting up. Apr 23 03:26:29 cube CRON[695]: pam_unix(cron:session): session opened for user root by (uid=0) Apr 23 03:26:29 cube CRON[736]: (root) CMD (bash /usr/local/sbin/mount-backup) Apr 23 03:26:29 cube avahi-daemon[664]: Successfully called chroot(). Apr 23 03:26:29 cube avahi-daemon[664]: Successfully dropped remaining capabilities. Apr 23 03:26:29 cube avahi-daemon[664]: No service file found in /etc/avahi/services. Apr 23 03:26:29 cube avahi-daemon[664]: Network interface enumeration completed. Apr 23 03:26:29 cube avahi-daemon[664]: Registering HINFO record with values 'ARMV7L'/'LINUX'. Apr 23 03:26:29 cube avahi-daemon[664]: Server startup complete. Host name is cube.local. Local service cookie is 3858955790. Apr 23 03:26:29 cube systemd-journal[163]: Runtime journal is using 5.0M (max allowed 40.4M, trying to leave 60.6M free of 398.7M available â current limit 40.4M). Apr 23 03:26:29 cube mount-backup[761]: Mounting the /backup filesystem Apr 23 03:26:29 cube mount-backup[786]: + cat /proc/mdstat Apr 23 03:26:29 cube mount-backup[786]: Personalities : [raid10] [raid1] [raid6] [raid5] [raid4] Apr 23 03:26:29 cube mount-backup[786]: md127 : active raid6 sdf[4] sde[3] sdd[0] sdb[1] sdc[2] Apr 23 03:26:29 cube mount-backup[786]: 91534848 blocks super 1.2 level 6, 512k chunk, algorithm 2 [5/5] [UUUUU] Apr 23 03:26:29 cube mount-backup[786]: Apr 23 03:26:29 cube mount-backup[786]: unused devices: <none> Apr 23 03:26:29 cube mount-backup[786]: + ls -l /dev/disk/by-label Apr 23 03:26:29 cube mount-backup[786]: total 0 Apr 23 03:26:29 cube mount-backup[786]: lrwxrwxrwx 1 root root 10 Apr 23 03:26 BACKUP -> ../../dm-1 Apr 23 03:26:29 cube mount-backup[786]: lrwxrwxrwx 1 root root 10 Apr 23 03:24 BIG -> ../../dm-0 Apr 23 03:26:29 cube mount-backup[786]: lrwxrwxrwx 1 root root 15 Apr 23 03:24 HOME -> ../../mmcblk0p6 Apr 23 03:26:29 cube mount-backup[786]: lrwxrwxrwx 1 root root 15 Apr 23 03:24 SWAP -> ../../mmcblk0p5 Apr 23 03:26:29 cube mount-backup[786]: + ls -lL /dev/disk/by-label Apr 23 03:26:29 cube mount-backup[786]: total 0 Apr 23 03:26:29 cube mount-backup[786]: brw-rw---- 1 root disk 254, 1 Apr 23 03:26 BACKUP Apr 23 03:26:29 cube mount-backup[786]: brw-rw---- 1 root disk 254, 0 Apr 23 03:24 BIG Apr 23 03:26:29 cube mount-backup[786]: brw-rw---- 1 root disk 179, 6 Apr 23 03:24 HOME Apr 23 03:26:29 cube mount-backup[786]: brw-rw---- 1 root disk 179, 5 Apr 23 03:24 SWAP Apr 23 03:26:29 cube mount-backup[786]: + ls -ld /backup/lost+found Apr 23 03:26:29 cube mount-backup[786]: drwx------ 2 root root 16384 Apr 17 04:29 /backup/lost+found Apr 23 03:26:29 cube mount-backup[786]: + let count=10 Apr 23 03:26:29 cube mount-backup[786]: + '[' '!' '(' -h /dev/disk/by-label/BACKUP -a -d /backup/lost+found ')' ']' Apr 23 03:26:29 cube mount-backup[786]: + /sbin/fsck -nf /backup Apr 23 03:26:29 cube saned[740]: saned disabled; edit /etc/default/saned. Apr 23 03:26:29 cube mount-backup[786]: fsck from util-linux 2.25.2 Apr 23 03:26:29 cube systemd-logind[659]: New seat seat0. Apr 23 03:26:29 cube mount-backup[786]: e2fsck 1.42.12 (29-Aug-2014) Apr 23 03:26:29 cube mount-backup[786]: Warning! /dev/mapper/vg1-backup is mounted. Apr 23 03:26:29 cube mount-backup[786]: Warning: skipping journal recovery because doing a read-only filesystem check. Apr 23 03:26:29 cube mount-backup[786]: Pass 1: Checking inodes, blocks, and sizes Apr 23 03:26:30 cube dbus[667]: [system] Activating via systemd: service name='org.freedesktop.ColorManager' unit='colord.service' Apr 23 03:26:30 cube colord[988]: Using mapping database file /var/lib/colord/mapping.db Apr 23 03:26:30 cube colord[988]: Using device database file /var/lib/colord/storage.db Apr 23 03:26:30 cube colord[988]: Using profile database file /var/lib/colord/storage.db Apr 23 03:26:30 cube exim4[661]: Starting MTA: exim4. Apr 23 03:26:30 cube colord[988]: loaded plugin libcd_plugin_camera.so Apr 23 03:26:30 cube colord[988]: loaded plugin libcd_plugin_sane.so Apr 23 03:26:30 cube colord[988]: loaded plugin libcd_plugin_scanner.so Apr 23 03:26:30 cube colord[988]: Daemon ready for requests Apr 23 03:26:30 cube dbus[667]: [system] Successfully activated service 'org.freedesktop.ColorManager' Apr 23 03:26:31 cube ntpd_intres[694]: host name not found: base.rcthomas.org Apr 23 03:26:31 cube ntpd_intres[694]: host name not found: pool.rcthomas.org Apr 23 03:26:31 cube ntpd_intres[694]: host name not found: pool.ntp.org Apr 23 03:26:31 cube ntpd_intres[694]: host name not found: ntp.sixxs.net Apr 23 03:26:31 cube apache2[660]: Starting web server: apache2 .. Apr 23 03:26:34 cube mount-backup[786]: Pass 2: Checking directory structure Apr 23 03:26:39 cube colord[988]: Profile added: laserjet-Gray.. Apr 23 03:26:39 cube colord[988]: Profile added: laserjet-RGB.. Apr 23 03:26:39 cube colord[988]: (colord:988): Cd-WARNING **: failed to get session [pid 747]: Unknown error -2 Apr 23 03:26:39 cube colord[988]: Device added: cups-laserjet Apr 23 03:26:39 cube colord[988]: Profile added: officejet-Gray.. Apr 23 03:26:39 cube colord[988]: Profile added: officejet-RGB.. Apr 23 03:26:39 cube colord[988]: (colord:988): Cd-WARNING **: failed to get session [pid 747]: Unknown error -2 Apr 23 03:26:39 cube colord[988]: Device added: cups-officejet Apr 23 03:26:39 cube colord[988]: Profile added: PDF-Gray.. Apr 23 03:26:39 cube colord[988]: Profile added: PDF-RGB.. Apr 23 03:26:39 cube colord[988]: (colord:988): Cd-WARNING **: failed to get session [pid 747]: Unknown error -2 Apr 23 03:26:39 cube colord[988]: Device added: cups-PDF Apr 23 03:26:39 cube kernel: warning: process `colord-sane' used the deprecated sysctl system call with 8.1.2. Apr 23 03:26:47 cube mount-backup[786]: Pass 3: Checking directory connectivity Apr 23 03:26:47 cube mount-backup[786]: Pass 4: Checking reference counts Apr 23 03:26:48 cube mount-backup[786]: Pass 5: Checking group summary information Apr 23 03:26:48 cube mount-backup[786]: BACKUP: 116210/5726208 files (0.6% non-contiguous), 1354057/22883328 blocks Apr 23 03:26:48 cube mount-backup[786]: + /bin/mount -v /backup Apr 23 03:26:48 cube mount-backup[786]: mount: /dev/mapper/vg1-backup is already mounted or /backup busy Apr 23 03:26:48 cube mount-backup[786]: /dev/mapper/vg1-backup is already mounted on /backup Apr 23 03:26:59 cube CRON[695]: pam_unix(cron:session): session closed for user root Apr 23 03:27:07 cube login[840]: pam_unix(login:session): session opened for user root by LOGIN(uid=0) Apr 23 03:27:07 cube systemd-logind[659]: New session 2 of user root. Apr 23 03:27:07 cube systemd[1083]: pam_unix(systemd-user:session): session opened for user root by (uid=0) Apr 23 03:27:07 cube systemd[1083]: Starting Paths. Apr 23 03:27:07 cube systemd[1083]: Reached target Paths. Apr 23 03:27:07 cube systemd[1083]: Starting Timers. Apr 23 03:27:07 cube systemd[1083]: Reached target Timers. Apr 23 03:27:07 cube systemd[1083]: Starting Sockets. Apr 23 03:27:07 cube systemd[1083]: Reached target Sockets. Apr 23 03:27:07 cube systemd[1083]: Starting Basic System. Apr 23 03:27:07 cube systemd[1083]: Reached target Basic System. Apr 23 03:27:07 cube systemd[1083]: Starting Default. Apr 23 03:27:07 cube systemd[1083]: Reached target Default. Apr 23 03:27:07 cube systemd[1083]: Startup finished in 60ms. Apr 23 03:27:07 cube login[1087]: ROOT LOGIN on '/dev/ttymxc0' Apr 23 03:27:23 cube dhclient[1099]: Internet Systems Consortium DHCP Client 4.3.1 Apr 23 03:27:23 cube dhclient[1099]: Copyright 2004-2014 Internet Systems Consortium. Apr 23 03:27:23 cube dhclient[1099]: All rights reserved. Apr 23 03:27:23 cube dhclient[1099]: For info, please visit https://www.isc.org/software/dhcp/ Apr 23 03:27:23 cube dhclient[1099]: Apr 23 03:27:23 cube kernel: fec 2188000.ethernet eth0: Freescale FEC PHY driver [Atheros 8035 ethernet] (mii_bus:phy_addr=2188000.ethernet:00, irq=-1) Apr 23 03:27:23 cube dhclient[1099]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:27:23 cube dhclient[1099]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 23 03:27:23 cube dhclient[1099]: Sending on Socket/fallback Apr 23 03:27:23 cube dhclient[1099]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7 Apr 23 03:27:25 cube avahi-daemon[664]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::d263:b4ff:fe00:912f. Apr 23 03:27:25 cube avahi-daemon[664]: New relevant interface eth0.IPv6 for mDNS. Apr 23 03:27:25 cube avahi-daemon[664]: Registering new address record for fe80::d263:b4ff:fe00:912f on eth0.*. Apr 23 03:27:27 cube ntpd[688]: Listen normally on 4 eth0 fe80::d263:b4ff:fe00:912f UDP 123 Apr 23 03:27:27 cube ntpd[688]: peers refreshed Apr 23 03:27:27 cube kernel: fec 2188000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 23 03:27:29 cube ntpd_intres[694]: host name not found: base.rcthomas.org Apr 23 03:27:29 cube ntpd_intres[694]: host name not found: pool.rcthomas.org Apr 23 03:27:29 cube ntpd_intres[694]: host name not found: pool.ntp.org Apr 23 03:27:29 cube ntpd_intres[694]: host name not found: ntp.sixxs.net Apr 23 03:27:30 cube dhclient[1099]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 10 Apr 23 03:27:30 cube dhclient[1099]: DHCPREQUEST on eth0 to 255.255.255.255 port 67 Apr 23 03:27:30 cube dhclient[1099]: DHCPOFFER from 192.168.3.4 Apr 23 03:27:30 cube dhclient[1099]: DHCPACK from 192.168.3.4 Apr 23 03:27:30 cube avahi-daemon[664]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.129. Apr 23 03:27:30 cube avahi-daemon[664]: New relevant interface eth0.IPv4 for mDNS. Apr 23 03:27:30 cube avahi-daemon[664]: Registering new address record for 192.168.3.129 on eth0.IPv4. Apr 23 03:27:31 cube ntpd[688]: ntpd exiting on signal 15 Apr 23 03:27:31 cube ntp[1158]: Stopping NTP server: ntpd. Apr 23 03:27:31 cube ntpd[1175]: ntpd 4.2.6p5@1.2349-o Fri Apr 10 19:31:04 UTC 2015 (1) Apr 23 03:27:31 cube ntpd[1176]: proto: precision = 2.364 usec Apr 23 03:27:31 cube ntpd[1176]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 23 03:27:31 cube ntp[1167]: Starting NTP server: ntpd. Apr 23 03:27:31 cube ntpd[1176]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 23 03:27:31 cube ntpd[1176]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 23 03:27:31 cube ntpd[1176]: Listen normally on 3 eth0 192.168.3.129 UDP 123 Apr 23 03:27:31 cube ntpd[1176]: Listen normally on 4 lo ::1 UDP 123 Apr 23 03:27:31 cube ntpd[1176]: Listen normally on 5 eth0 fe80::d263:b4ff:fe00:912f UDP 123 Apr 23 03:27:31 cube ntpd[1176]: peers refreshed Apr 23 03:27:31 cube ntpd[1176]: Listening on routing socket on fd #22 for interface updates Apr 23 03:27:31 cube dhclient[1099]: bound to 192.168.3.129 -- renewal in 3502 seconds. Apr 23 03:27:31 cube avahi-daemon[664]: Leaving mDNS multicast group on interface eth0.IPv6 with address fe80::d263:b4ff:fe00:912f. Apr 23 03:27:31 cube avahi-daemon[664]: Joining mDNS multicast group on interface eth0.IPv6 with address 2001:4978:2d2:1:d263:b4ff:fe00:912f. Apr 23 03:27:31 cube avahi-daemon[664]: Registering new address record for 2001:4978:2d2:1:d263:b4ff:fe00:912f on eth0.*. Apr 23 03:27:31 cube avahi-daemon[664]: Withdrawing address record for fe80::d263:b4ff:fe00:912f on eth0. Apr 23 03:27:31 cube sshd[657]: Received SIGHUP; restarting. Apr 23 03:27:31 cube sshd[657]: Server listening on 0.0.0.0 port 22. Apr 23 03:27:31 cube sshd[657]: Server listening on :: port 22. Apr 23 03:27:32 cube sshd[657]: Received SIGHUP; restarting. Apr 23 03:27:32 cube sshd[657]: Server listening on 0.0.0.0 port 22. Apr 23 03:27:32 cube sshd[657]: Server listening on :: port 22. Apr 23 03:27:33 cube ntpd[1176]: Listen normally on 6 eth0 2001:4978:2d2:1:d263:b4ff:fe00:912f UDP 123 Apr 23 03:27:33 cube ntpd[1176]: 2001:770:18:8::4 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:7e8:1:102::a interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:648:2ffc:1106::2 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:7b8:3:4f:202:b3ff:fe46:bec interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:6f8:800:1003::2 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:6f8:800:1003::3 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:808:2:3003::66 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:6f8:891:1::c2e9:c721 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:6f8:200:1003::10 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: 2001:6f8:862:1::c2e9:c729 interface fe80::d263:b4ff:fe00:912f -> 2001:4978:2d2:1:d263:b4ff:fe00:912f Apr 23 03:27:33 cube ntpd[1176]: peers refreshed Apr 23 03:28:17 cube systemd[1083]: Time has been changed Apr 23 03:28:21 cube sshd[1304]: Accepted publickey for rbthomas from 192.168.3.23 port 64934 ssh2: RSA ef:03:d4:f3:8b:97:f3:98:0c:63:fb:12:0e:cd:bb:15 Apr 23 03:28:21 cube sshd[1304]: pam_unix(sshd:session): session opened for user rbthomas by (uid=0) Apr 23 03:28:22 cube systemd-logind[659]: New session 3 of user rbthomas. Apr 23 03:28:22 cube systemd[1306]: pam_unix(systemd-user:session): session opened for user rbthomas by (uid=0) Apr 23 03:28:22 cube systemd[1306]: Starting Paths. Apr 23 03:28:22 cube systemd[1306]: Reached target Paths. Apr 23 03:28:22 cube systemd[1306]: Starting Timers. Apr 23 03:28:22 cube systemd[1306]: Reached target Timers. Apr 23 03:28:22 cube systemd[1306]: Starting Sockets. Apr 23 03:28:22 cube systemd[1306]: Reached target Sockets. Apr 23 03:28:22 cube systemd[1306]: Starting Basic System. Apr 23 03:28:22 cube systemd[1306]: Reached target Basic System. Apr 23 03:28:22 cube systemd[1306]: Starting Default. Apr 23 03:28:22 cube systemd[1306]: Reached target Default. Apr 23 03:28:22 cube systemd[1306]: Startup finished in 61ms. Apr 23 03:28:32 cube sudo[1319]: rbthomas : TTY=pts/0 ; PWD=/home/rbthomas ; USER=root ; COMMAND=/bin/journalctl Apr 23 03:28:32 cube sudo[1319]: pam_unix(sudo:session): session opened for user root by rbthomas(uid=0)