On Apr 22, 2015, at 8:17 AM, Michael Biebl <bi...@debian.org> wrote:
> Am 22.04.2015 um 12:10 schrieb Rick Thomas: >> This works. Interestingly, without the sleep loop the vgchange >> fails. >> >> Now, you say that a VM with two virtual disks configured as RAID1 >> with a logical volume works fresh out of the box. This makes me >> wonder if it’s some kind of a timing problem… It takes a few seconds >> for the freshly rebooted system to find the USB-Flash sticks and >> assemble them. So some time-out is triggered in the systemd stuff >> on my setup, while your setup has no such physical constraints — >> everything is available immediately. > > So you're running vgchange in a loop, which suggests that the > lvm2-activation.service and lvm2-activation-early.service unitsas > shipped by lvm2 are not sufficient. Those are supposed to run vgchange. > > I notice, that the /etc/init.d/lvm2 init script has > Should-Start: mdadm-raid > but the systemd unit files have no such ordering. > > I wonder, if that makes a difference. > > Could you copy /lib/systemd/system/lvm2-activation.service to > /etc/systemd/system and add a line > After=mdadm-raid.service > to the [Unit] section. Odd… That didn’t work. I was almost sure you had it nailed! /-: It’s worth noting that there is no file named “mdadm-raid.service” anywhere that I could find in /etc/systemd/ or /lib/systemd/. Also, the files /lib/systemd/system/mdadm-waitidle.service and /lib/systemd/system/mdadm.service are both symlinks to /dev/null. Does that tell you anything? Attached is the output of journalctl for that boot… The potentially interesting parts (with time-stamps as pointers to the context in which they occur in the full journal) are: rbthomas@cube:~$ egrep -i 'md127|mdadm|lvm|backup|md array|mount' < /tmp/boot-journal.txt Apr 22 23:58:02 cube kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Apr 22 23:58:02 cube kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Apr 22 23:58:02 cube kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:02 cube kernel: EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro Apr 22 23:58:02 cube mdadm-raid[185]: Generating udev events for MD arrays...done. Apr 22 23:58:03 cube lvm[196]: 1 logical volume(s) in volume group "vg" now active Apr 22 23:58:03 cube lvm[260]: 1 logical volume(s) in volume group "vg" now active Apr 22 23:58:03 cube kernel: EXT4-fs (mmcblk0p1): mounting ext2 file system using the ext4 subsystem Apr 22 23:58:03 cube kernel: EXT4-fs (mmcblk0p6): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:04 cube kernel: EXT4-fs (mmcblk0p1): mounted filesystem without journal. Opts: (null) Apr 22 23:58:04 cube kernel: EXT4-fs (mmcblk0p7): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:04 cube kernel: EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:04 cube lvm[296]: 1 logical volume(s) in volume group "vg" monitored Apr 22 23:58:05 cube kernel: md/raid:md127: device sdf operational as raid disk 4 Apr 22 23:58:05 cube kernel: md/raid:md127: device sde operational as raid disk 3 Apr 22 23:58:05 cube kernel: md/raid:md127: device sdd operational as raid disk 2 Apr 22 23:58:05 cube kernel: md/raid:md127: device sdc operational as raid disk 1 Apr 22 23:58:05 cube kernel: md/raid:md127: device sdb operational as raid disk 0 Apr 22 23:58:05 cube kernel: md/raid:md127: allocated 0kB Apr 22 23:58:05 cube kernel: md/raid:md127: raid level 6 active with 5 out of 5 devices, algorithm 2 Apr 22 23:58:05 cube kernel: md127: detected capacity change from 0 to 93731684352 Apr 22 23:58:05 cube kernel: md127: unknown partition table Apr 22 23:59:31 cube systemd[1]: Job dev-disk-by\x2dlabel-BACKUP.device/start timed out. Apr 22 23:59:31 cube systemd[1]: Timed out waiting for device dev-disk-by\x2dlabel-BACKUP.device. Apr 22 23:59:31 cube systemd[1]: Dependency failed for /backup. Apr 22 23:59:53 cube lvm[588]: 1 logical volume(s) in volume group "vg1" now active Apr 22 23:59:54 cube lvm[588]: 1 logical volume(s) in volume group "vg" now active Apr 22 23:59:54 cube systemd[1]: backup.mount: Directory /backup to mount over is not empty, mounting anyway. Apr 22 23:59:54 cube kernel: EXT4-fs (dm-1): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:59:54 cube lvm[635]: 1 logical volume(s) in volume group "vg1" now active Apr 22 23:59:54 cube lvm[635]: 1 logical volume(s) in volume group “vg” now active I don’t see any events having to do with LVM between the point when the md127 raid is assembled by the kernel (not by systemd) and the point when the systemd time-out occurs a minute and a half later. However, there is an LVM event for vg (the volume group on the eSATA disk) a second or two before the md127 raid stuff… Hope this helps! Rick
-- Logs begin at Wed 2015-04-22 23:58:02 PDT, end at Thu 2015-04-23 00:01:24 PDT. -- Apr 22 23:58:02 cube systemd-journal[162]: 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 22 23:58:02 cube systemd-journal[162]: 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 22 23:58:02 cube kernel: Booting Linux on physical CPU 0x0 Apr 22 23:58:02 cube kernel: Initializing cgroup subsys cpuset Apr 22 23:58:02 cube kernel: Initializing cgroup subsys cpu Apr 22 23:58:02 cube kernel: Initializing cgroup subsys cpuacct Apr 22 23:58:02 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 22 23:58:02 cube kernel: CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c5387d Apr 22 23:58:02 cube kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Apr 22 23:58:02 cube kernel: Machine model: SolidRun Cubox-i Dual/Quad Apr 22 23:58:02 cube kernel: Memory policy: Data cache writealloc Apr 22 23:58:02 cube kernel: On node 0 totalpages: 524288 Apr 22 23:58:02 cube kernel: free_area_init_node: node 0, pgdat c09dc700, node_mem_map ee7f8000 Apr 22 23:58:02 cube kernel: DMA zone: 1520 pages used for memmap Apr 22 23:58:02 cube kernel: DMA zone: 0 pages reserved Apr 22 23:58:02 cube kernel: DMA zone: 194560 pages, LIFO batch:31 Apr 22 23:58:02 cube kernel: HighMem zone: 2576 pages used for memmap Apr 22 23:58:02 cube kernel: HighMem zone: 329728 pages, LIFO batch:31 Apr 22 23:58:02 cube kernel: PERCPU: Embedded 9 pages/cpu @ee7b3000 s12608 r8192 d16064 u36864 Apr 22 23:58:02 cube kernel: pcpu-alloc: s12608 r8192 d16064 u36864 alloc=9*4096 Apr 22 23:58:02 cube kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Apr 22 23:58:02 cube kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522768 Apr 22 23:58:02 cube kernel: Kernel command line: console=ttymxc0,115200 quiet Apr 22 23:58:02 cube kernel: PID hash table entries: 4096 (order: 2, 16384 bytes) Apr 22 23:58:02 cube kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Apr 22 23:58:02 cube kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Apr 22 23:58:02 cube kernel: Memory: 2054816K/2097152K available (6404K kernel code, 828K rwdata, 2204K rodata, 684K init, 393K bss, 42336K reserved, 1318912K highmem) Apr 22 23:58:02 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 22 23:58:02 cube kernel: Hierarchical RCU implementation. Apr 22 23:58:02 cube kernel: RCU dyntick-idle grace-period acceleration is enabled. Apr 22 23:58:02 cube kernel: NR_IRQS:16 nr_irqs:16 16 Apr 22 23:58:02 cube kernel: L2C-310 erratum 769419 enabled Apr 22 23:58:02 cube kernel: L2C-310 enabling early BRESP for Cortex-A9 Apr 22 23:58:02 cube kernel: L2C-310 full line of zeros enabled for Cortex-A9 Apr 22 23:58:02 cube kernel: L2C-310 ID prefetch enabled, offset 1 lines Apr 22 23:58:02 cube kernel: L2C-310 dynamic clock gating enabled, standby mode enabled Apr 22 23:58:02 cube kernel: L2C-310 cache controller enabled, 16 ways, 1024 kB Apr 22 23:58:02 cube kernel: L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76070001 Apr 22 23:58:02 cube kernel: Switching to timer-based delay loop Apr 22 23:58:02 cube kernel: sched_clock: 32 bits at 66MHz, resolution 15ns, wraps every 65075262448ns Apr 22 23:58:02 cube kernel: Console: colour dummy device 80x30 Apr 22 23:58:02 cube kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 132.00 BogoMIPS (lpj=264000) Apr 22 23:58:02 cube kernel: pid_max: default: 32768 minimum: 301 Apr 22 23:58:02 cube kernel: Security Framework initialized Apr 22 23:58:02 cube kernel: AppArmor: AppArmor disabled by boot time parameter Apr 22 23:58:02 cube kernel: Yama: disabled by default; enable with sysctl kernel.yama.* Apr 22 23:58:02 cube kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Apr 22 23:58:02 cube kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Apr 22 23:58:02 cube kernel: Initializing cgroup subsys memory Apr 22 23:58:02 cube kernel: Initializing cgroup subsys devices Apr 22 23:58:02 cube kernel: Initializing cgroup subsys freezer Apr 22 23:58:02 cube kernel: Initializing cgroup subsys net_cls Apr 22 23:58:02 cube kernel: Initializing cgroup subsys blkio Apr 22 23:58:02 cube kernel: Initializing cgroup subsys perf_event Apr 22 23:58:02 cube kernel: Initializing cgroup subsys net_prio Apr 22 23:58:02 cube kernel: CPU: Testing write buffer coherency: ok Apr 22 23:58:02 cube kernel: ftrace: allocating 23044 entries in 68 pages Apr 22 23:58:02 cube kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Apr 22 23:58:02 cube kernel: Setting up static identity map for 0x105c02d8 - 0x105c0330 Apr 22 23:58:02 cube kernel: CPU1: Booted secondary processor Apr 22 23:58:02 cube kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Apr 22 23:58:02 cube kernel: CPU2: Booted secondary processor Apr 22 23:58:02 cube kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Apr 22 23:58:02 cube kernel: CPU3: Booted secondary processor Apr 22 23:58:02 cube kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Apr 22 23:58:02 cube kernel: Brought up 4 CPUs Apr 22 23:58:02 cube kernel: SMP: Total of 4 processors activated (528.00 BogoMIPS). Apr 22 23:58:02 cube kernel: CPU: All CPU(s) started in SVC mode. Apr 22 23:58:02 cube kernel: devtmpfs: initialized Apr 22 23:58:02 cube kernel: VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4 Apr 22 23:58:02 cube kernel: pinctrl core: initialized pinctrl subsystem Apr 22 23:58:02 cube kernel: regulator-dummy: no parameters Apr 22 23:58:02 cube kernel: NET: Registered protocol family 16 Apr 22 23:58:02 cube kernel: DMA: preallocated 256 KiB pool for atomic coherent allocations Apr 22 23:58:02 cube kernel: CPU identified as i.MX6Q, unknown revision Apr 22 23:58:02 cube kernel: No ATAGs? Apr 22 23:58:02 cube kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers. Apr 22 23:58:02 cube kernel: hw-breakpoint: maximum watchpoint size is 4 bytes. Apr 22 23:58:02 cube kernel: EXYNOS: PMU not supported Apr 22 23:58:02 cube kernel: imx6q-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver Apr 22 23:58:02 cube kernel: Serial: AMBA PL011 UART driver Apr 22 23:58:02 cube kernel: mxs-dma 110000.dma-apbh: initialized Apr 22 23:58:02 cube kernel: edma-dma-engine edma-dma-engine.0: Can't allocate PaRAM dummy slot Apr 22 23:58:02 cube kernel: edma-dma-engine: probe of edma-dma-engine.0 failed with error -5 Apr 22 23:58:02 cube kernel: 3P3V: 3300 mV Apr 22 23:58:02 cube kernel: usb_h1_vbus: 5000 mV Apr 22 23:58:02 cube kernel: usb_otg_vbus: 5000 mV Apr 22 23:58:02 cube kernel: vgaarb: loaded Apr 22 23:58:02 cube kernel: usbcore: registered new interface driver usbfs Apr 22 23:58:02 cube kernel: usbcore: registered new interface driver hub Apr 22 23:58:02 cube kernel: usbcore: registered new device driver usb Apr 22 23:58:02 cube kernel: media: Linux media interface: v0.10 Apr 22 23:58:02 cube kernel: Linux video capture interface: v2.00 Apr 22 23:58:02 cube kernel: pps_core: LinuxPPS API ver. 1 registered Apr 22 23:58:02 cube kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giome...@linux.it> Apr 22 23:58:02 cube kernel: PTP clock support registered Apr 22 23:58:02 cube kernel: Switched to clocksource mxc_timer1 Apr 22 23:58:02 cube kernel: NET: Registered protocol family 2 Apr 22 23:58:02 cube kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes) Apr 22 23:58:02 cube kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Apr 22 23:58:02 cube kernel: TCP: Hash tables configured (established 8192 bind 8192) Apr 22 23:58:02 cube kernel: TCP: reno registered Apr 22 23:58:02 cube kernel: UDP hash table entries: 512 (order: 2, 16384 bytes) Apr 22 23:58:02 cube kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Apr 22 23:58:02 cube kernel: NET: Registered protocol family 1 Apr 22 23:58:02 cube kernel: PCI: CLS 0 bytes, default 64 Apr 22 23:58:02 cube kernel: Unpacking initramfs... Apr 22 23:58:02 cube kernel: Freeing initrd memory: 14284K (c1800000 - c25f3000) Apr 22 23:58:02 cube kernel: hw perfevents: enabled with ARMv7 Cortex-A9 PMU driver, 7 counters available Apr 22 23:58:02 cube kernel: futex hash table entries: 1024 (order: 4, 65536 bytes) Apr 22 23:58:02 cube kernel: audit: initializing netlink subsys (disabled) Apr 22 23:58:02 cube kernel: audit: type=2000 audit(1.287:1): initialized Apr 22 23:58:02 cube kernel: zbud: loaded Apr 22 23:58:02 cube kernel: VFS: Disk quotas dquot_6.5.2 Apr 22 23:58:02 cube kernel: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Apr 22 23:58:02 cube kernel: msgmni has been set to 1465 Apr 22 23:58:02 cube kernel: alg: No test for stdrng (krng) Apr 22 23:58:02 cube kernel: bounce: pool size: 64 pages Apr 22 23:58:02 cube kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Apr 22 23:58:02 cube kernel: io scheduler noop registered Apr 22 23:58:02 cube kernel: io scheduler deadline registered Apr 22 23:58:02 cube kernel: io scheduler cfq registered (default) Apr 22 23:58:02 cube kernel: imx-sdma 20ec000.sdma: firmware: failed to load imx/sdma/sdma-imx6q.bin (-2) Apr 22 23:58:02 cube kernel: imx-sdma 20ec000.sdma: initialized Apr 22 23:58:02 cube kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled Apr 22 23:58:02 cube kernel: Serial: AMBA driver Apr 22 23:58:02 cube kernel: Serial: IMX driver Apr 22 23:58:02 cube kernel: 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 58, base_baud = 5000000) is a IMX Apr 22 23:58:02 cube kernel: console [ttymxc0] enabled Apr 22 23:58:02 cube kernel: 2188000.ethernet supply phy not found, using dummy regulator Apr 22 23:58:02 cube kernel: libphy: fec_enet_mii_bus: probed Apr 22 23:58:02 cube kernel: fec 2188000.ethernet eth0: registered PHC device 0 Apr 22 23:58:02 cube kernel: mousedev: PS/2 mouse device common for all mice Apr 22 23:58:02 cube kernel: snvs_rtc 20cc034.snvs-rtc-lp: rtc core: registered 20cc034.snvs-rtc-lp as rtc0 Apr 22 23:58:02 cube kernel: ledtrig-cpu: registered to indicate activity on CPUs Apr 22 23:58:02 cube kernel: hidraw: raw HID events driver (C) Jiri Kosina Apr 22 23:58:02 cube kernel: usbcore: registered new interface driver usbhid Apr 22 23:58:02 cube kernel: usbhid: USB HID core driver Apr 22 23:58:02 cube kernel: TCP: cubic registered Apr 22 23:58:02 cube kernel: NET: Registered protocol family 10 Apr 22 23:58:02 cube kernel: mip6: Mobile IPv6 Apr 22 23:58:02 cube kernel: NET: Registered protocol family 17 Apr 22 23:58:02 cube kernel: mpls_gso: MPLS GSO support Apr 22 23:58:02 cube kernel: ThumbEE CPU extension supported. Apr 22 23:58:02 cube kernel: Registering SWP/SWPB emulation handler Apr 22 23:58:02 cube kernel: registered taskstats version 1 Apr 22 23:58:02 cube kernel: snvs_rtc 20cc034.snvs-rtc-lp: setting system clock to 2015-04-23 06:57:59 UTC (1429772279) Apr 22 23:58:02 cube kernel: PM: Hibernation image not present or could not be loaded. Apr 22 23:58:02 cube kernel: usb_otg_vbus: disabling Apr 22 23:58:02 cube kernel: usb_h1_vbus: disabling Apr 22 23:58:02 cube kernel: Freeing unused kernel memory: 684K (c0871000 - c091c000) Apr 22 23:58:02 cube systemd-udevd[73]: starting version 215 Apr 22 23:58:02 cube kernel: random: systemd-udevd urandom read with 1 bits of entropy available Apr 22 23:58:02 cube kernel: sdhci: Secure Digital Host Controller Interface driver Apr 22 23:58:02 cube kernel: sdhci: Copyright(c) Pierre Ossman Apr 22 23:58:02 cube kernel: sdhci-pltfm: SDHCI platform and OF driver helper Apr 22 23:58:02 cube kernel: sdhci-esdhc-imx 2194000.usdhc: could not get ultra high speed state, work on normal mode Apr 22 23:58:02 cube kernel: mmc0: no vqmmc regulator found Apr 22 23:58:02 cube kernel: SCSI subsystem initialized Apr 22 23:58:02 cube kernel: libata version 3.00 loaded. Apr 22 23:58:02 cube kernel: ahci-imx 2200000.sata: SSS flag set, parallel bus scan disabled Apr 22 23:58:02 cube kernel: ahci-imx 2200000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode Apr 22 23:58:02 cube kernel: ahci-imx 2200000.sata: flags: ncq sntf stag pm led clo only pmp pio slum part ccc apst Apr 22 23:58:02 cube kernel: scsi0 : ahci_platform Apr 22 23:58:02 cube kernel: ata1: SATA max UDMA/133 mmio [mem 0x02200000-0x02203fff] port 0x100 irq 71 Apr 22 23:58:02 cube kernel: mmc0: SDHCI controller on 2194000.usdhc [2194000.usdhc] using ADMA Apr 22 23:58:02 cube kernel: mmc0: host does not support reading read-only switch. assuming write-enable. Apr 22 23:58:02 cube kernel: mmc0: new high speed SDXC card at address 0007 Apr 22 23:58:02 cube kernel: mmcblk0: mmc0:0007 SD64G 58.4 GiB Apr 22 23:58:02 cube kernel: mmcblk0: p1 p2 p3 < p5 p6 p7 > Apr 22 23:58:02 cube kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Apr 22 23:58:02 cube kernel: ata1.00: ATA-8: HGST HTS721010A9E630, JB0OA3J0, max UDMA/133 Apr 22 23:58:02 cube kernel: ata1.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32) Apr 22 23:58:02 cube kernel: ata1.00: configured for UDMA/133 Apr 22 23:58:02 cube kernel: scsi 0:0:0:0: Direct-Access ATA HGST HTS721010A9 A3J0 PQ: 0 ANSI: 5 Apr 22 23:58:02 cube kernel: sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/931 GiB) Apr 22 23:58:02 cube kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Apr 22 23:58:02 cube kernel: sd 0:0:0:0: [sda] Write Protect is off Apr 22 23:58:02 cube kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Apr 22 23:58:02 cube kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Apr 22 23:58:02 cube kernel: sda: unknown partition table Apr 22 23:58:02 cube kernel: sd 0:0:0:0: [sda] Attached SCSI disk Apr 22 23:58:02 cube kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Apr 22 23:58:02 cube kernel: device-mapper: uevent: version 1.0.3 Apr 22 23:58:02 cube kernel: device-mapper: ioctl: 4.27.0-ioctl (2013-10-30) initialised: dm-de...@redhat.com Apr 22 23:58:02 cube kernel: PM: Starting manual resume from disk Apr 22 23:58:02 cube kernel: PM: Hibernation image partition 179:5 present Apr 22 23:58:02 cube kernel: PM: Looking for hibernation image. Apr 22 23:58:02 cube kernel: PM: Image not found (code -22) Apr 22 23:58:02 cube kernel: PM: Hibernation image not present or could not be loaded. Apr 22 23:58:02 cube kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:02 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 22 23:58:02 cube kernel: raid6: int32x1 82 MB/s Apr 22 23:58:02 cube kernel: EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro Apr 22 23:58:02 cube kernel: raid6: int32x2 124 MB/s Apr 22 23:58:02 cube systemd-journal[162]: Journal started Apr 22 23:58:02 cube systemd-modules-load[154]: Failed to find module 'lp' Apr 22 23:58:02 cube systemd-modules-load[154]: Failed to find module 'ppdev' Apr 22 23:58:02 cube systemd-modules-load[154]: Failed to find module 'parport_pc' Apr 22 23:58:02 cube fake-hwclock[152]: Current system time: 2015-04-23 06:58:01 Apr 22 23:58:02 cube fake-hwclock[152]: fake-hwclock saved clock information is in the past: 2015-04-23 06:57:23 Apr 22 23:58:02 cube fake-hwclock[152]: To set system time to this saved clock anyway, use "force" Apr 22 23:58:02 cube systemd-udevd[182]: starting version 215 Apr 22 23:58:02 cube kernel: raid6: int32x4 157 MB/s Apr 22 23:58:02 cube kernel: raid6: int32x8 167 MB/s Apr 22 23:58:02 cube kernel: raid6: using algorithm int32x8 (167 MB/s) Apr 22 23:58:02 cube kernel: raid6: using intx1 recovery algorithm Apr 22 23:58:02 cube kernel: async_tx: api initialized (async) Apr 22 23:58:02 cube kernel: xor: measuring software checksum speed Apr 22 23:58:02 cube kernel: arm4regs : 1344.000 MB/sec Apr 22 23:58:02 cube kernel: random: nonblocking pool is initialized Apr 22 23:58:02 cube kernel: 8regs : 862.000 MB/sec Apr 22 23:58:02 cube mdadm-raid[185]: Generating udev events for MD arrays...done. Apr 22 23:58:02 cube kernel: 32regs : 662.000 MB/sec Apr 22 23:58:02 cube kernel: xor: using function: arm4regs (1344.000 MB/sec) Apr 22 23:58:02 cube kernel: md: raid10 personality registered for level 10 Apr 22 23:58:02 cube kernel: md: raid1 personality registered for level 1 Apr 22 23:58:02 cube kernel: md: raid6 personality registered for level 6 Apr 22 23:58:02 cube kernel: md: raid5 personality registered for level 5 Apr 22 23:58:02 cube kernel: md: raid4 personality registered for level 4 Apr 22 23:58:02 cube systemd-modules-load[154]: Inserted module 'dm_raid' Apr 22 23:58:02 cube kernel: device-mapper: raid: Loading target version 1.5.2 Apr 22 23:58:02 cube systemd[1]: systemd-modules-load.service: main process exited, code=exited, status=1/FAILURE Apr 22 23:58:02 cube systemd[1]: Failed to start Load Kernel Modules. Apr 22 23:58:02 cube systemd[1]: Unit systemd-modules-load.service entered failed state. Apr 22 23:58:02 cube kernel: Registered IR keymap rc-empty Apr 22 23:58:02 cube kernel: input: gpio_ir_recv as /devices/soc0/ir-receiver/rc/rc0/input0 Apr 22 23:58:02 cube kernel: rc0: gpio_ir_recv as /devices/soc0/ir-receiver/rc/rc0 Apr 22 23:58:02 cube kernel: leds_pwm pwmleds: unable to request PWM for imx6:red:front: -517 Apr 22 23:58:02 cube kernel: IR RC5(x) protocol handler initialized Apr 22 23:58:02 cube kernel: platform pwmleds: Driver leds_pwm requests probe deferral Apr 22 23:58:02 cube kernel: IR RC6 protocol handler initialized Apr 22 23:58:02 cube kernel: lirc_dev: IR Remote Control driver registered, major 243 Apr 22 23:58:02 cube kernel: rc rc0: lirc_dev: driver ir-lirc-codec (gpio-rc-recv) registered at minor = 0 Apr 22 23:58:02 cube kernel: IR LIRC bridge handler initialized Apr 22 23:58:02 cube kernel: IR JVC protocol handler initialized Apr 22 23:58:02 cube kernel: IR Sony protocol handler initialized Apr 22 23:58:02 cube kernel: IR Sharp protocol handler initialized Apr 22 23:58:02 cube kernel: IR SANYO protocol handler initialized Apr 22 23:58:02 cube kernel: IR NEC protocol handler initialized Apr 22 23:58:02 cube kernel: input: MCE IR Keyboard/Mouse (gpio-rc-recv) as /devices/virtual/input/input1 Apr 22 23:58:02 cube kernel: IR MCE Keyboard/mouse protocol handler initialized Apr 22 23:58:02 cube kernel: imx2-wdt 20bc000.wdog: timeout 60 sec (nowayout=0) Apr 22 23:58:02 cube kernel: leds_pwm pwmleds: unable to request PWM for imx6:red:front: -517 Apr 22 23:58:02 cube kernel: platform pwmleds: Driver leds_pwm requests probe deferral Apr 22 23:58:02 cube kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.0: ChipIdea HDRC found, lpm: 0; cap: f00f6100 op: f00f6140 Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.0: It is OTG capable controller Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.0: EHCI Host Controller Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.0: new USB bus registered, assigned bus number 1 Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.0: USB 2.0 started, EHCI 1.00 Apr 22 23:58:02 cube kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Apr 22 23:58:02 cube kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 22 23:58:02 cube kernel: usb usb1: Product: EHCI Host Controller Apr 22 23:58:02 cube kernel: usb usb1: Manufacturer: Linux 3.16.0-4-armmp ehci_hcd Apr 22 23:58:02 cube kernel: usb usb1: SerialNumber: ci_hdrc.0 Apr 22 23:58:02 cube kernel: hub 1-0:1.0: USB hub found Apr 22 23:58:02 cube kernel: hub 1-0:1.0: 1 port detected Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.1: ChipIdea HDRC found, lpm: 0; cap: f065e300 op: f065e340 Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.1: doesn't support gadget Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.1: EHCI Host Controller Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.1: new USB bus registered, assigned bus number 2 Apr 22 23:58:02 cube kernel: [drm] Initialized drm 1.1.0 20060810 Apr 22 23:58:02 cube kernel: ci_hdrc ci_hdrc.1: USB 2.0 started, EHCI 1.00 Apr 22 23:58:02 cube kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002 Apr 22 23:58:02 cube kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 22 23:58:02 cube kernel: usb usb2: Product: EHCI Host Controller Apr 22 23:58:02 cube kernel: usb usb2: Manufacturer: Linux 3.16.0-4-armmp ehci_hcd Apr 22 23:58:02 cube kernel: usb usb2: SerialNumber: ci_hdrc.1 Apr 22 23:58:02 cube kernel: hub 2-0:1.0: USB hub found Apr 22 23:58:02 cube kernel: hub 2-0:1.0: 1 port detected Apr 22 23:58:02 cube kernel: i2c i2c-1: IMX I2C adapter registered Apr 22 23:58:02 cube kernel: i2c i2c-2: IMX I2C adapter registered Apr 22 23:58:02 cube kernel: ipu_smfc_init: ioremap 0x02650000 -> f0734000 Apr 22 23:58:02 cube kernel: imx-ipuv3 2400000.ipu: IPUv3H probed Apr 22 23:58:02 cube kernel: ipu_smfc_init: ioremap 0x02a50000 -> f07ce000 Apr 22 23:58:02 cube kernel: imx-ipuv3 2800000.ipu: IPUv3H probed Apr 22 23:58:02 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:02 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:02 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:02 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:02 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:02 cube kernel: imxdrm: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:03 cube kernel: imx_hdmi: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:03 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:03 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:03 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:03 cube kernel: imx_ipuv3_crtc: module is from the staging directory, the quality is unknown, you have been warned. Apr 22 23:58:03 cube kernel: [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). Apr 22 23:58:03 cube kernel: [drm] No driver support for vblank timestamp query. Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.0 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.1 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.4 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: bound imx-ipuv3-crtc.5 (ops .LANCHOR0 [imx_ipuv3_crtc]) Apr 22 23:58:03 cube kernel: imx-hdmi 120000.hdmi: Detected HDMI controller 0x13:0xa:0xa0:0xc1 Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: bound 120000.hdmi (ops imx_hdmi_driver_exit [imx_hdmi]) Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: No connectors reported connected with modes Apr 22 23:58:03 cube kernel: [drm] Cannot find any crtc or sizes - going 1024x768 Apr 22 23:58:03 cube kernel: Console: switching to colour frame buffer device 128x48 Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: fb0: frame buffer device Apr 22 23:58:03 cube kernel: imx-drm display-subsystem: registered panic notifier Apr 22 23:58:03 cube kernel: usb 1-1: new high-speed USB device number 2 using ci_hdrc Apr 22 23:58:03 cube kernel: [drm] Initialized imx-drm 1.0.0 20120507 on minor 0 Apr 22 23:58:03 cube kernel: imx-spdif sound-spdif: snd-soc-dummy-dai <-> 2004000.spdif mapping ok Apr 22 23:58:03 cube kernel: usb 1-1: New USB device found, idVendor=0409, idProduct=005a Apr 22 23:58:03 cube kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Apr 22 23:58:03 cube kernel: hub 1-1:1.0: USB hub found Apr 22 23:58:03 cube kernel: hub 1-1:1.0: 4 ports detected Apr 22 23:58:03 cube lvm[196]: 1 logical volume(s) in volume group "vg" now active Apr 22 23:58:03 cube kernel: Adding 9764860k swap on /dev/mmcblk0p5. Priority:-1 extents:1 across:9764860k SSFS Apr 22 23:58:03 cube kernel: usb 1-1.1: new high-speed USB device number 3 using ci_hdrc Apr 22 23:58:03 cube kernel: usb 1-1.1: New USB device found, idVendor=0781, idProduct=5571 Apr 22 23:58:03 cube kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 22 23:58:03 cube kernel: usb 1-1.1: Product: Cruzer Fit Apr 22 23:58:03 cube kernel: usb 1-1.1: Manufacturer: SanDisk Apr 22 23:58:03 cube kernel: usb 1-1.1: SerialNumber: 4C530013220303118132 Apr 22 23:58:03 cube kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Apr 22 23:58:03 cube kernel: scsi1 : usb-storage 1-1.1:1.0 Apr 22 23:58:03 cube kernel: usbcore: registered new interface driver usb-storage Apr 22 23:58:03 cube kernel: usb 1-1.2: new high-speed USB device number 4 using ci_hdrc Apr 22 23:58:03 cube lvm[260]: 1 logical volume(s) in volume group "vg" now active Apr 22 23:58:03 cube systemd-fsck[246]: HOME: clean, 826/2445984 files, 340160/9764864 blocks Apr 22 23:58:03 cube systemd-fsck[247]: /dev/mmcblk0p1: clean, 22/62248 files, 29964/248832 blocks Apr 22 23:58:03 cube kernel: usb 1-1.2: New USB device found, idVendor=0781, idProduct=5571 Apr 22 23:58:03 cube kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 22 23:58:03 cube kernel: usb 1-1.2: Product: Cruzer Fit Apr 22 23:58:03 cube kernel: usb 1-1.2: Manufacturer: SanDisk Apr 22 23:58:03 cube kernel: usb 1-1.2: SerialNumber: 4C530201430303122020 Apr 22 23:58:03 cube kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Apr 22 23:58:03 cube kernel: scsi2 : usb-storage 1-1.2:1.0 Apr 22 23:58:03 cube systemd-fsck[259]: BIG: clean, 11/61054976 files, 3883091/244190208 blocks Apr 22 23:58:03 cube kernel: EXT4-fs (mmcblk0p1): mounting ext2 file system using the ext4 subsystem Apr 22 23:58:03 cube kernel: EXT4-fs (mmcblk0p6): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:03 cube kernel: usb 1-1.3: new high-speed USB device number 5 using ci_hdrc Apr 22 23:58:03 cube kernel: usb 1-1.3: New USB device found, idVendor=0781, idProduct=5571 Apr 22 23:58:03 cube kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 22 23:58:03 cube kernel: usb 1-1.3: Product: Cruzer Fit Apr 22 23:58:03 cube kernel: usb 1-1.3: Manufacturer: SanDisk Apr 22 23:58:03 cube kernel: usb 1-1.3: SerialNumber: 4C530201470303119301 Apr 22 23:58:03 cube kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected Apr 22 23:58:03 cube kernel: scsi3 : usb-storage 1-1.3:1.0 Apr 22 23:58:04 cube kernel: usb 1-1.4: new high-speed USB device number 6 using ci_hdrc Apr 22 23:58:04 cube kernel: EXT4-fs (mmcblk0p1): mounted filesystem without journal. Opts: (null) Apr 22 23:58:04 cube systemd-fsck[253]: /dev/mmcblk0p7: clean, 4748/334560 files, 191938/1335808 blocks Apr 22 23:58:04 cube kernel: usb 1-1.4: New USB device found, idVendor=0409, idProduct=005a Apr 22 23:58:04 cube kernel: usb 1-1.4: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Apr 22 23:58:04 cube kernel: hub 1-1.4:1.0: USB hub found Apr 22 23:58:04 cube kernel: hub 1-1.4:1.0: 4 ports detected Apr 22 23:58:04 cube kernel: EXT4-fs (mmcblk0p7): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:04 cube kernel: EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:58:04 cube lvm[296]: 1 logical volume(s) in volume group "vg" monitored Apr 22 23:58:04 cube kernel: usb 1-1.4.1: new high-speed USB device number 7 using ci_hdrc Apr 22 23:58:04 cube kernel: usb 1-1.4.1: New USB device found, idVendor=0781, idProduct=5571 Apr 22 23:58:04 cube kernel: usb 1-1.4.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 22 23:58:04 cube kernel: usb 1-1.4.1: Product: Cruzer Fit Apr 22 23:58:04 cube kernel: usb 1-1.4.1: Manufacturer: SanDisk Apr 22 23:58:04 cube kernel: usb 1-1.4.1: SerialNumber: 4C530001450303119270 Apr 22 23:58:04 cube kernel: usb-storage 1-1.4.1:1.0: USB Mass Storage device detected Apr 22 23:58:04 cube kernel: scsi4 : usb-storage 1-1.4.1:1.0 Apr 22 23:58:04 cube kernel: usb 1-1.4.2: new high-speed USB device number 8 using ci_hdrc Apr 22 23:58:04 cube kernel: scsi 1:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 22 23:58:04 cube kernel: sd 1:0:0:0: Attached scsi generic sg1 type 0 Apr 22 23:58:04 cube kernel: sd 1:0:0:0: [sdb] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 22 23:58:04 cube kernel: sd 1:0:0:0: [sdb] Write Protect is off Apr 22 23:58:04 cube kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00 Apr 22 23:58:04 cube kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 22 23:58:04 cube kernel: sdb: unknown partition table Apr 22 23:58:04 cube kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk Apr 22 23:58:04 cube kernel: md: bind<sdb> Apr 22 23:58:04 cube kernel: usb 1-1.4.2: New USB device found, idVendor=0781, idProduct=5571 Apr 22 23:58:04 cube kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 22 23:58:04 cube kernel: usb 1-1.4.2: Product: Cruzer Fit Apr 22 23:58:04 cube kernel: usb 1-1.4.2: Manufacturer: SanDisk Apr 22 23:58:04 cube kernel: usb 1-1.4.2: SerialNumber: 4C530301400303119272 Apr 22 23:58:04 cube kernel: usb-storage 1-1.4.2:1.0: USB Mass Storage device detected Apr 22 23:58:04 cube kernel: scsi5 : usb-storage 1-1.4.2:1.0 Apr 22 23:58:04 cube kernel: scsi 2:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 22 23:58:04 cube kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0 Apr 22 23:58:04 cube kernel: sd 2:0:0:0: [sdc] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 22 23:58:04 cube kernel: sd 2:0:0:0: [sdc] Write Protect is off Apr 22 23:58:04 cube kernel: sd 2:0:0:0: [sdc] Mode Sense: 43 00 00 00 Apr 22 23:58:04 cube kernel: sd 2:0:0:0: [sdc] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 22 23:58:04 cube kernel: sdc: unknown partition table Apr 22 23:58:04 cube kernel: sd 2:0:0:0: [sdc] Attached SCSI removable disk Apr 22 23:58:04 cube kernel: md: bind<sdc> Apr 22 23:58:04 cube kernel: scsi 3:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 22 23:58:04 cube kernel: sd 3:0:0:0: Attached scsi generic sg3 type 0 Apr 22 23:58:04 cube kernel: sd 3:0:0:0: [sdd] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 22 23:58:04 cube kernel: sd 3:0:0:0: [sdd] Write Protect is off Apr 22 23:58:04 cube kernel: sd 3:0:0:0: [sdd] Mode Sense: 43 00 00 00 Apr 22 23:58:04 cube kernel: sd 3:0:0:0: [sdd] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 22 23:58:04 cube kernel: sdd: unknown partition table Apr 22 23:58:04 cube kernel: sd 3:0:0:0: [sdd] Attached SCSI removable disk Apr 22 23:58:05 cube kernel: md: bind<sdd> Apr 22 23:58:05 cube kernel: scsi 4:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 22 23:58:05 cube kernel: sd 4:0:0:0: Attached scsi generic sg4 type 0 Apr 22 23:58:05 cube kernel: sd 4:0:0:0: [sde] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 22 23:58:05 cube kernel: sd 4:0:0:0: [sde] Write Protect is off Apr 22 23:58:05 cube kernel: sd 4:0:0:0: [sde] Mode Sense: 43 00 00 00 Apr 22 23:58:05 cube kernel: sd 4:0:0:0: [sde] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 22 23:58:05 cube kernel: sde: unknown partition table Apr 22 23:58:05 cube kernel: sd 4:0:0:0: [sde] Attached SCSI removable disk Apr 22 23:58:05 cube kernel: md: bind<sde> Apr 22 23:58:05 cube kernel: scsi 5:0:0:0: Direct-Access SanDisk Cruzer Fit 1.27 PQ: 0 ANSI: 6 Apr 22 23:58:05 cube kernel: sd 5:0:0:0: Attached scsi generic sg5 type 0 Apr 22 23:58:05 cube kernel: sd 5:0:0:0: [sdf] 61056064 512-byte logical blocks: (31.2 GB/29.1 GiB) Apr 22 23:58:05 cube kernel: sd 5:0:0:0: [sdf] Write Protect is off Apr 22 23:58:05 cube kernel: sd 5:0:0:0: [sdf] Mode Sense: 43 00 00 00 Apr 22 23:58:05 cube kernel: sd 5:0:0:0: [sdf] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 22 23:58:05 cube kernel: sdf: unknown partition table Apr 22 23:58:05 cube kernel: sd 5:0:0:0: [sdf] Attached SCSI removable disk Apr 22 23:58:05 cube kernel: md: bind<sdf> Apr 22 23:58:05 cube kernel: md/raid:md127: device sdf operational as raid disk 4 Apr 22 23:58:05 cube kernel: md/raid:md127: device sde operational as raid disk 3 Apr 22 23:58:05 cube kernel: md/raid:md127: device sdd operational as raid disk 2 Apr 22 23:58:05 cube kernel: md/raid:md127: device sdc operational as raid disk 1 Apr 22 23:58:05 cube kernel: md/raid:md127: device sdb operational as raid disk 0 Apr 22 23:58:05 cube kernel: md/raid:md127: allocated 0kB Apr 22 23:58:05 cube kernel: md/raid:md127: raid level 6 active with 5 out of 5 devices, algorithm 2 Apr 22 23:58:05 cube kernel: RAID conf printout: Apr 22 23:58:05 cube kernel: --- level:6 rd:5 wd:5 Apr 22 23:58:05 cube kernel: disk 0, o:1, dev:sdb Apr 22 23:58:05 cube kernel: disk 1, o:1, dev:sdc Apr 22 23:58:05 cube kernel: disk 2, o:1, dev:sdd Apr 22 23:58:05 cube kernel: disk 3, o:1, dev:sde Apr 22 23:58:05 cube kernel: disk 4, o:1, dev:sdf Apr 22 23:58:05 cube kernel: md127: detected capacity change from 0 to 93731684352 Apr 22 23:58:05 cube kernel: md127: unknown partition table Apr 22 23:59:31 cube systemd[1]: Job dev-disk-by\x2dlabel-BACKUP.device/start timed out. Apr 22 23:59:31 cube systemd[1]: Timed out waiting for device dev-disk-by\x2dlabel-BACKUP.device. Apr 22 23:59:31 cube systemd[1]: Dependency failed for /backup. Apr 22 23:59:31 cube systemd[1]: Dependency failed for Local File Systems. Apr 22 23:59:32 cube adjtimex[323]: Regulating system clock...done. Apr 22 23:59:32 cube systemd-journal[162]: 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 22 23:59:32 cube kernel: fec 2188000.ethernet eth0: Freescale FEC PHY driver [Atheros 8035 ethernet] (mii_bus:phy_addr=2188000.ethernet:00, irq=-1) Apr 22 23:59:32 cube kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Apr 22 23:59:32 cube networking[325]: Configuring network interfaces...done. Apr 22 23:59:32 cube dhclient[380]: Internet Systems Consortium DHCP Client 4.3.1 Apr 22 23:59:32 cube ifup[375]: Internet Systems Consortium DHCP Client 4.3.1 Apr 22 23:59:32 cube dhclient[380]: Copyright 2004-2014 Internet Systems Consortium. Apr 22 23:59:32 cube dhclient[380]: All rights reserved. Apr 22 23:59:32 cube dhclient[380]: For info, please visit https://www.isc.org/software/dhcp/ Apr 22 23:59:32 cube dhclient[380]: Apr 22 23:59:32 cube ifup[375]: Copyright 2004-2014 Internet Systems Consortium. Apr 22 23:59:32 cube ifup[375]: All rights reserved. Apr 22 23:59:32 cube ifup[375]: For info, please visit https://www.isc.org/software/dhcp/ Apr 22 23:59:32 cube dhclient[380]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:32 cube dhclient[380]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:32 cube dhclient[380]: Sending on Socket/fallback Apr 22 23:59:32 cube dhclient[380]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 6 Apr 22 23:59:32 cube ifup[375]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:32 cube ifup[375]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:32 cube ifup[375]: Sending on Socket/fallback Apr 22 23:59:32 cube ifup[375]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 6 Apr 22 23:59:32 cube rpcbind[381]: Starting rpcbind daemon.... Apr 22 23:59:33 cube rpc.statd[402]: Version 1.2.8 starting Apr 22 23:59:33 cube sm-notify[403]: Version 1.2.8 starting Apr 22 23:59:33 cube kernel: RPC: Registered named UNIX socket transport module. Apr 22 23:59:33 cube kernel: RPC: Registered udp transport module. Apr 22 23:59:33 cube kernel: RPC: Registered tcp transport module. Apr 22 23:59:33 cube kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 22 23:59:33 cube kernel: FS-Cache: Loaded Apr 22 23:59:33 cube kernel: FS-Cache: Netfs 'nfs' registered for caching Apr 22 23:59:33 cube kernel: Installing knfsd (copyright (C) 1996 o...@monad.swb.de). Apr 22 23:59:33 cube nfs-common[397]: Starting NFS common utilities: statd idmapd. Apr 22 23:59:33 cube systemd[329]: Failed at step EXEC spawning /bin/plymouth: No such file or directory Apr 22 23:59:36 cube kernel: fec 2188000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 22 23:59:36 cube kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Apr 22 23:59:38 cube dhclient[380]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 6 Apr 22 23:59:38 cube ifup[375]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 6 Apr 22 23:59:38 cube dhclient[380]: DHCPREQUEST on eth0 to 255.255.255.255 port 67 Apr 22 23:59:38 cube dhclient[380]: DHCPOFFER from 192.168.3.4 Apr 22 23:59:38 cube ifup[375]: DHCPREQUEST on eth0 to 255.255.255.255 port 67 Apr 22 23:59:38 cube ifup[375]: DHCPOFFER from 192.168.3.4 Apr 22 23:59:38 cube dhclient[380]: DHCPACK from 192.168.3.4 Apr 22 23:59:38 cube ifup[375]: DHCPACK from 192.168.3.4 Apr 22 23:59:39 cube dhclient[380]: bound to 192.168.3.129 -- renewal in 2859 seconds. Apr 22 23:59:39 cube ifup[375]: bound to 192.168.3.129 -- renewal in 2859 seconds. Apr 22 23:59:50 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 22 23:59:51 cube dhclient[563]: Killed old client process Apr 22 23:59:51 cube ifdown[553]: Killed old client process Apr 22 23:59:52 cube dhclient[563]: Internet Systems Consortium DHCP Client 4.3.1 Apr 22 23:59:52 cube dhclient[563]: Copyright 2004-2014 Internet Systems Consortium. Apr 22 23:59:52 cube dhclient[563]: All rights reserved. Apr 22 23:59:52 cube dhclient[563]: For info, please visit https://www.isc.org/software/dhcp/ Apr 22 23:59:52 cube dhclient[563]: Apr 22 23:59:52 cube ifdown[553]: Internet Systems Consortium DHCP Client 4.3.1 Apr 22 23:59:52 cube ifdown[553]: Copyright 2004-2014 Internet Systems Consortium. Apr 22 23:59:52 cube ifdown[553]: All rights reserved. Apr 22 23:59:52 cube ifdown[553]: For info, please visit https://www.isc.org/software/dhcp/ Apr 22 23:59:52 cube dhclient[563]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:52 cube dhclient[563]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:52 cube dhclient[563]: Sending on Socket/fallback Apr 22 23:59:52 cube ifdown[553]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:52 cube ifdown[553]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 22 23:59:52 cube ifdown[553]: Sending on Socket/fallback Apr 22 23:59:52 cube dhclient[563]: DHCPRELEASE on eth0 to 192.168.3.4 port 67 Apr 22 23:59:52 cube ifdown[553]: DHCPRELEASE on eth0 to 192.168.3.4 port 67 Apr 22 23:59:53 cube systemd-modules-load[587]: Failed to find module 'lp' Apr 22 23:59:53 cube systemd-modules-load[587]: Failed to find module 'ppdev' Apr 22 23:59:53 cube systemd-modules-load[587]: Failed to find module 'parport_pc' Apr 22 23:59:53 cube systemd[1]: systemd-modules-load.service: main process exited, code=exited, status=1/FAILURE Apr 22 23:59:53 cube systemd[1]: Failed to start Load Kernel Modules. Apr 22 23:59:53 cube systemd[1]: Unit systemd-modules-load.service entered failed state. Apr 22 23:59:53 cube lvm[588]: 1 logical volume(s) in volume group "vg1" now active Apr 22 23:59:54 cube lvm[588]: 1 logical volume(s) in volume group "vg" now active Apr 22 23:59:54 cube systemd[1]: backup.mount: Directory /backup to mount over is not empty, mounting anyway. Apr 22 23:59:54 cube kernel: EXT4-fs (dm-1): mounted filesystem with ordered data mode. Opts: (null) Apr 22 23:59:54 cube lvm[635]: 1 logical volume(s) in volume group "vg1" now active Apr 22 23:59:54 cube lvm[635]: 1 logical volume(s) in volume group "vg" now active Apr 22 23:59:54 cube cron[658]: (CRON) INFO (pidfile fd = 3) Apr 22 23:59:54 cube cron[658]: (CRON) INFO (Running @reboot jobs) Apr 22 23:59:54 cube irqbalance[665]: Starting SMP IRQ Balancer: irqbalance. Apr 22 23:59:54 cube avahi-daemon[666]: Found user 'avahi' (UID 105) and group 'avahi' (GID 112). Apr 22 23:59:54 cube avahi-daemon[666]: Successfully dropped root privileges. Apr 22 23:59:54 cube avahi-daemon[666]: avahi-daemon 0.6.31 starting up. Apr 22 23:59:54 cube sshd[659]: Server listening on 0.0.0.0 port 22. Apr 22 23:59:54 cube sshd[659]: Server listening on :: port 22. Apr 22 23:59:54 cube avahi-daemon[666]: Successfully called chroot(). Apr 22 23:59:54 cube avahi-daemon[666]: Successfully dropped remaining capabilities. Apr 22 23:59:54 cube dbus[668]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 22 23:59:54 cube ntpd[689]: ntpd 4.2.6p5@1.2349-o Fri Apr 10 19:31:04 UTC 2015 (1) Apr 22 23:59:54 cube avahi-daemon[666]: No service file found in /etc/avahi/services. Apr 22 23:59:54 cube ntpd[695]: proto: precision = 0.909 usec Apr 22 23:59:54 cube avahi-daemon[666]: Network interface enumeration completed. Apr 22 23:59:54 cube avahi-daemon[666]: Registering HINFO record with values 'ARMV7L'/'LINUX'. Apr 22 23:59:54 cube avahi-daemon[666]: Server startup complete. Host name is cube.local. Local service cookie is 1586967200. Apr 22 23:59:54 cube ntpd[695]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 22 23:59:54 cube ntp[664]: Starting NTP server: ntpd. Apr 22 23:59:54 cube ntpd[695]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 22 23:59:54 cube ntpd[695]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 22 23:59:54 cube ntpd[695]: Listen normally on 3 lo ::1 UDP 123 Apr 22 23:59:54 cube ntpd[695]: peers refreshed Apr 22 23:59:54 cube ntpd[695]: Listening on routing socket on fd #20 for interface updates Apr 22 23:59:54 cube ntpd[695]: Deferring DNS for base.rcthomas.org 1 Apr 22 23:59:54 cube ntpd[695]: Deferring DNS for pool.rcthomas.org 10 Apr 22 23:59:54 cube ntpd[695]: Deferring DNS for pool.ntp.org 10 Apr 22 23:59:54 cube ntpd[695]: Deferring DNS for ntp.sixxs.net 10 Apr 22 23:59:54 cube ntpd[714]: signal_no_reset: signal 17 had flags 4000000 Apr 22 23:59:54 cube systemd-journal[162]: 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 22 23:59:54 cube systemd-logind[661]: New seat seat0. Apr 22 23:59:54 cube saned[698]: saned disabled; edit /etc/default/saned. Apr 22 23:59:55 cube dbus[668]: [system] Activating via systemd: service name='org.freedesktop.ColorManager' unit='colord.service' Apr 22 23:59:55 cube colord[1009]: Using mapping database file /var/lib/colord/mapping.db Apr 22 23:59:55 cube colord[1009]: Using device database file /var/lib/colord/storage.db Apr 22 23:59:55 cube colord[1009]: Using profile database file /var/lib/colord/storage.db Apr 22 23:59:55 cube colord[1009]: loaded plugin libcd_plugin_camera.so Apr 22 23:59:55 cube colord[1009]: loaded plugin libcd_plugin_sane.so Apr 22 23:59:55 cube colord[1009]: loaded plugin libcd_plugin_scanner.so Apr 22 23:59:55 cube colord[1009]: Daemon ready for requests Apr 22 23:59:55 cube dbus[668]: [system] Successfully activated service 'org.freedesktop.ColorManager' Apr 22 23:59:56 cube exim4[663]: Starting MTA: exim4. Apr 22 23:59:56 cube apache2[662]: Starting web server: apache2 .. Apr 22 23:59:56 cube colord[1009]: Profile added: laserjet-Gray.. Apr 22 23:59:56 cube colord[1009]: Profile added: laserjet-RGB.. Apr 22 23:59:56 cube colord[1009]: (colord:1009): Cd-WARNING **: failed to get session [pid 701]: Unknown error -2 Apr 22 23:59:56 cube colord[1009]: Device added: cups-laserjet Apr 22 23:59:56 cube colord[1009]: Profile added: officejet-Gray.. Apr 22 23:59:56 cube colord[1009]: Profile added: officejet-RGB.. Apr 22 23:59:56 cube ntpd_intres[714]: host name not found: base.rcthomas.org Apr 22 23:59:56 cube ntpd_intres[714]: host name not found: pool.rcthomas.org Apr 22 23:59:56 cube ntpd_intres[714]: host name not found: pool.ntp.org Apr 22 23:59:56 cube ntpd_intres[714]: host name not found: ntp.sixxs.net Apr 22 23:59:56 cube colord[1009]: (colord:1009): Cd-WARNING **: failed to get session [pid 701]: Unknown error -2 Apr 22 23:59:56 cube colord[1009]: Device added: cups-officejet Apr 22 23:59:56 cube colord[1009]: Profile added: PDF-Gray.. Apr 22 23:59:56 cube colord[1009]: Profile added: PDF-RGB.. Apr 22 23:59:56 cube colord[1009]: (colord:1009): Cd-WARNING **: failed to get session [pid 701]: Unknown error -2 Apr 22 23:59:56 cube colord[1009]: Device added: cups-PDF Apr 22 23:59:59 cube kernel: warning: process `colord-sane' used the deprecated sysctl system call with 8.1.2. Apr 23 00:00:01 cube CRON[1063]: pam_unix(cron:session): session opened for user root by (uid=0) Apr 23 00:00:01 cube CRON[1064]: (root) CMD (/usr/bin/rsnapshot sync && /usr/bin/rsnapshot hourly) Apr 23 00:00:06 cube login[732]: pam_unix(login:session): session opened for user root by LOGIN(uid=0) Apr 23 00:00:06 cube systemd-logind[661]: New session 2 of user root. Apr 23 00:00:07 cube systemd[1075]: pam_unix(systemd-user:session): session opened for user root by (uid=0) Apr 23 00:00:09 cube systemd[1075]: Starting Paths. Apr 23 00:00:09 cube systemd[1075]: Reached target Paths. Apr 23 00:00:09 cube systemd[1075]: Starting Timers. Apr 23 00:00:09 cube systemd[1075]: Reached target Timers. Apr 23 00:00:09 cube systemd[1075]: Starting Sockets. Apr 23 00:00:09 cube systemd[1075]: Reached target Sockets. Apr 23 00:00:09 cube systemd[1075]: Starting Basic System. Apr 23 00:00:09 cube systemd[1075]: Reached target Basic System. Apr 23 00:00:09 cube systemd[1075]: Starting Default. Apr 23 00:00:09 cube systemd[1075]: Reached target Default. Apr 23 00:00:09 cube systemd[1075]: Startup finished in 1.558s. Apr 23 00:00:11 cube login[1078]: ROOT LOGIN on '/dev/ttymxc0' Apr 23 00:00:32 cube dhclient[1092]: Internet Systems Consortium DHCP Client 4.3.1 Apr 23 00:00:32 cube dhclient[1092]: Copyright 2004-2014 Internet Systems Consortium. Apr 23 00:00:32 cube dhclient[1092]: All rights reserved. Apr 23 00:00:32 cube dhclient[1092]: For info, please visit https://www.isc.org/software/dhcp/ Apr 23 00:00:32 cube dhclient[1092]: Apr 23 00:00:32 cube kernel: fec 2188000.ethernet eth0: Freescale FEC PHY driver [Atheros 8035 ethernet] (mii_bus:phy_addr=2188000.ethernet:00, irq=-1) Apr 23 00:00:32 cube dhclient[1092]: Listening on LPF/eth0/d0:63:b4:00:91:2f Apr 23 00:00:32 cube dhclient[1092]: Sending on LPF/eth0/d0:63:b4:00:91:2f Apr 23 00:00:32 cube dhclient[1092]: Sending on Socket/fallback Apr 23 00:00:32 cube dhclient[1092]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 3 Apr 23 00:00:33 cube avahi-daemon[666]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::d263:b4ff:fe00:912f. Apr 23 00:00:33 cube avahi-daemon[666]: New relevant interface eth0.IPv6 for mDNS. Apr 23 00:00:33 cube avahi-daemon[666]: Registering new address record for fe80::d263:b4ff:fe00:912f on eth0.*. Apr 23 00:00:35 cube ntpd[695]: Listen normally on 4 eth0 fe80::d263:b4ff:fe00:912f UDP 123 Apr 23 00:00:35 cube ntpd[695]: peers refreshed Apr 23 00:00:35 cube dhclient[1092]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 5 Apr 23 00:00:36 cube kernel: fec 2188000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 23 00:00:37 cube ntpd_intres[714]: host name not found: base.rcthomas.org Apr 23 00:00:37 cube ntpd_intres[714]: host name not found: pool.rcthomas.org Apr 23 00:00:37 cube ntpd_intres[714]: host name not found: pool.ntp.org Apr 23 00:00:37 cube ntpd_intres[714]: host name not found: ntp.sixxs.net Apr 23 00:00:39 cube avahi-daemon[666]: Leaving mDNS multicast group on interface eth0.IPv6 with address fe80::d263:b4ff:fe00:912f. Apr 23 00:00:39 cube avahi-daemon[666]: Joining mDNS multicast group on interface eth0.IPv6 with address 2001:4978:2d2:1:d263:b4ff:fe00:912f. Apr 23 00:00:39 cube avahi-daemon[666]: Registering new address record for 2001:4978:2d2:1:d263:b4ff:fe00:912f on eth0.*. Apr 23 00:00:39 cube avahi-daemon[666]: Withdrawing address record for fe80::d263:b4ff:fe00:912f on eth0. Apr 23 00:00:40 cube ntpd[695]: Listen normally on 5 eth0 2001:4978:2d2:1:d263:b4ff:fe00:912f UDP 123 Apr 23 00:00:40 cube ntpd[695]: peers refreshed Apr 23 00:00:40 cube dhclient[1092]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 8 Apr 23 00:00:40 cube dhclient[1092]: DHCPREQUEST on eth0 to 255.255.255.255 port 67 Apr 23 00:00:40 cube dhclient[1092]: DHCPOFFER from 192.168.3.4 Apr 23 00:00:40 cube dhclient[1092]: DHCPACK from 192.168.3.4 Apr 23 00:00:40 cube avahi-daemon[666]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.129. Apr 23 00:00:40 cube avahi-daemon[666]: New relevant interface eth0.IPv4 for mDNS. Apr 23 00:00:40 cube avahi-daemon[666]: Registering new address record for 192.168.3.129 on eth0.IPv4. Apr 23 00:00:41 cube ntpd[695]: ntpd exiting on signal 15 Apr 23 00:00:41 cube ntp[1151]: Stopping NTP server: ntpd. Apr 23 00:00:41 cube ntpd[1168]: ntpd 4.2.6p5@1.2349-o Fri Apr 10 19:31:04 UTC 2015 (1) Apr 23 00:00:41 cube ntpd[1169]: proto: precision = 0.909 usec Apr 23 00:00:41 cube ntpd[1169]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 23 00:00:41 cube ntp[1160]: Starting NTP server: ntpd. Apr 23 00:00:41 cube ntpd[1169]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 23 00:00:41 cube ntpd[1169]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 23 00:00:41 cube ntpd[1169]: Listen normally on 3 eth0 192.168.3.129 UDP 123 Apr 23 00:00:41 cube ntpd[1169]: Listen normally on 4 lo ::1 UDP 123 Apr 23 00:00:41 cube ntpd[1169]: Listen normally on 5 eth0 2001:4978:2d2:1:d263:b4ff:fe00:912f UDP 123 Apr 23 00:00:41 cube ntpd[1169]: Listen normally on 6 eth0 fe80::d263:b4ff:fe00:912f UDP 123 Apr 23 00:00:41 cube ntpd[1169]: peers refreshed Apr 23 00:00:41 cube ntpd[1169]: Listening on routing socket on fd #23 for interface updates Apr 23 00:00:41 cube dhclient[1092]: bound to 192.168.3.129 -- renewal in 2703 seconds. Apr 23 00:00:42 cube sshd[659]: Received SIGHUP; restarting. Apr 23 00:00:42 cube sshd[659]: Server listening on 0.0.0.0 port 22. Apr 23 00:00:42 cube sshd[659]: Server listening on :: port 22. Apr 23 00:00:42 cube sshd[659]: Received SIGHUP; restarting. Apr 23 00:00:42 cube sshd[659]: Server listening on 0.0.0.0 port 22. Apr 23 00:00:42 cube sshd[659]: Server listening on :: port 22. Apr 23 00:00:42 cube ntpd_intres[714]: parent died before we finished, exiting Apr 23 00:00:49 cube systemd[1075]: Time has been changed Apr 23 00:01:09 cube sshd[1301]: Accepted publickey for rbthomas from 192.168.3.23 port 64758 ssh2: RSA ef:03:d4:f3:8b:97:f3:98:0c:63:fb:12:0e:cd:bb:15 Apr 23 00:01:09 cube sshd[1301]: pam_unix(sshd:session): session opened for user rbthomas by (uid=0) Apr 23 00:01:09 cube systemd-logind[661]: New session 3 of user rbthomas. Apr 23 00:01:09 cube systemd[1303]: pam_unix(systemd-user:session): session opened for user rbthomas by (uid=0) Apr 23 00:01:09 cube systemd[1303]: Starting Paths. Apr 23 00:01:09 cube systemd[1303]: Reached target Paths. Apr 23 00:01:09 cube systemd[1303]: Starting Timers. Apr 23 00:01:09 cube systemd[1303]: Reached target Timers. Apr 23 00:01:09 cube systemd[1303]: Starting Sockets. Apr 23 00:01:09 cube systemd[1303]: Reached target Sockets. Apr 23 00:01:09 cube systemd[1303]: Starting Basic System. Apr 23 00:01:09 cube systemd[1303]: Reached target Basic System. Apr 23 00:01:09 cube systemd[1303]: Starting Default. Apr 23 00:01:09 cube systemd[1303]: Reached target Default. Apr 23 00:01:09 cube systemd[1303]: Startup finished in 50ms. Apr 23 00:01:24 cube sudo[1316]: rbthomas : TTY=pts/0 ; PWD=/home/rbthomas ; USER=root ; COMMAND=/bin/journalctl Apr 23 00:01:24 cube sudo[1316]: pam_unix(sudo:session): session opened for user root by rbthomas(uid=0)