wicked fails on boot due to read-only mount?

classic Classic list List threaded Threaded
5 messages Options
Reply | Threaded
Open this post in threaded view
|

wicked fails on boot due to read-only mount?

Paul Neuwirth-3
Hello,
I have an Issue on several machines using Leap 42.2 or 42.3, sometimes
wicked fails on boot. Login in on console and doing systemctl restart
wicked always works... I want know to find out the problem.

On this (virtual) machine, with recent Leap 42.3 installed, following happens:
network get setup in initrd, iscsi device gets mounted read-only, root
is being switched, and wicked failes due to read-only mount, I think.

the boot journal (just look for hostname changes..) :
-- Logs begin at Sam 2018-01-13 09:05:40 CET, end at Sam 2018-01-13 09:11:05 CET. --
Jan 13 09:05:40 linux-a6jk systemd-journald[97]: Runtime journal (/run/log/journal/) is currently using 5.7M.
                                                 Maximum allowed usage is set to 46.1M.
                                                 Leaving at least 69.2M free (of currently available 456.1M of space).
                                                 Enforced usage limit is thus 46.1M, of which 40.4M are still available.
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys cpuset
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys cpu
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys cpuacct
Jan 13 09:05:40 linux-a6jk kernel: Linux version 4.4.104-39-default (geeko@buildhost) (gcc version 4.8.5 (SUSE Linux) ) #1 SMP Thu Jan 4 08:11:03 UTC 2018 (7db1912)
Jan 13 09:05:40 linux-a6jk kernel: Command line: root=UUID=701327b1-4c4b-49d9-9eef-5463501ba94c xencons=tty debug=1 ipv6.disable=1 resume=/dev/xvda1 splash=silent quiet showopt
Jan 13 09:05:40 linux-a6jk kernel: x86/fpu: Legacy x87 FPU detected.
Jan 13 09:05:40 linux-a6jk kernel: x86/fpu: Using 'lazy' FPU context switches.
Jan 13 09:05:40 linux-a6jk kernel: ACPI in unprivileged domain disabled
Jan 13 09:05:40 linux-a6jk kernel: Released 0 page(s)
Jan 13 09:05:40 linux-a6jk kernel: e820: BIOS-provided physical RAM map:
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x0000000000000000-0x000000000009ffff] usable
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000000a0000-0x00000000000fffff] reserved
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x0000000000100000-0x000000003fffffff] usable
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x0000000040000000-0x00000000dffbffff] unusable
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000dffc0000-0x00000000dffcfbff] ACPI data
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000dffcfc00-0x00000000dfffefff] reserved
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000f0000000-0x00000000f3ffffff] reserved
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000fec00000-0x00000000fed003ff] reserved
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000fed13000-0x00000000fed9ffff] reserved
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000fee00000-0x00000000feefffff] reserved
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000000ffb00000-0x00000000ffffffff] reserved
Jan 13 09:05:40 linux-a6jk kernel: Xen: [mem 0x00000001ffffe000-0x00000001ffffffff] reserved
Jan 13 09:05:40 linux-a6jk kernel: NX (Execute Disable) protection: active
Jan 13 09:05:40 linux-a6jk kernel: DMI not present or invalid.
Jan 13 09:05:40 linux-a6jk kernel: Hypervisor detected: Xen
Jan 13 09:05:40 linux-a6jk kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Jan 13 09:05:40 linux-a6jk kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
Jan 13 09:05:40 linux-a6jk kernel: AGP: No AGP bridge found
Jan 13 09:05:40 linux-a6jk kernel: e820: last_pfn = 0x40000 max_arch_pfn = 0x400000000
Jan 13 09:05:40 linux-a6jk kernel: MTRR: Disabled
Jan 13 09:05:40 linux-a6jk kernel: x86/PAT: MTRRs disabled, skipping PAT initialization too.
Jan 13 09:05:40 linux-a6jk kernel: x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WC  WP  UC  UC  
Jan 13 09:05:40 linux-a6jk kernel: Scanning 1 areas for low memory corruption
Jan 13 09:05:40 linux-a6jk kernel: Base memory trampoline at [ffff88000009a000] 9a000 size 24576
Jan 13 09:05:40 linux-a6jk kernel: BRK [0x0241b000, 0x0241bfff] PGTABLE
Jan 13 09:05:40 linux-a6jk kernel: BRK [0x0241c000, 0x0241cfff] PGTABLE
Jan 13 09:05:40 linux-a6jk kernel: BRK [0x0241d000, 0x0241dfff] PGTABLE
Jan 13 09:05:40 linux-a6jk kernel: BRK [0x0241e000, 0x0241efff] PGTABLE
Jan 13 09:05:40 linux-a6jk kernel: BRK [0x0241f000, 0x0241ffff] PGTABLE
Jan 13 09:05:40 linux-a6jk kernel: BRK [0x02420000, 0x02420fff] PGTABLE
Jan 13 09:05:40 linux-a6jk kernel: RAMDISK: [mem 0x02800000-0x035d7fff]
Jan 13 09:05:40 linux-a6jk kernel: NUMA turned off
Jan 13 09:05:40 linux-a6jk kernel: Faking a node at [mem 0x0000000000000000-0x000000003fffffff]
Jan 13 09:05:40 linux-a6jk kernel: NODE_DATA(0) allocated [mem 0x3fdef000-0x3fe19fff]
Jan 13 09:05:40 linux-a6jk kernel: Zone ranges:
Jan 13 09:05:40 linux-a6jk kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
Jan 13 09:05:40 linux-a6jk kernel:   DMA32    [mem 0x0000000001000000-0x000000003fffffff]
Jan 13 09:05:40 linux-a6jk kernel:   Normal   empty
Jan 13 09:05:40 linux-a6jk kernel:   Device   empty
Jan 13 09:05:40 linux-a6jk kernel: Movable zone start for each node
Jan 13 09:05:40 linux-a6jk kernel: Early memory node ranges
Jan 13 09:05:40 linux-a6jk kernel:   node   0: [mem 0x0000000000001000-0x000000000009ffff]
Jan 13 09:05:40 linux-a6jk kernel:   node   0: [mem 0x0000000000100000-0x000000003fffffff]
Jan 13 09:05:40 linux-a6jk kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000003fffffff]
Jan 13 09:05:40 linux-a6jk kernel: On node 0 totalpages: 262047
Jan 13 09:05:40 linux-a6jk kernel:   DMA zone: 64 pages used for memmap
Jan 13 09:05:40 linux-a6jk kernel:   DMA zone: 21 pages reserved
Jan 13 09:05:40 linux-a6jk kernel:   DMA zone: 3999 pages, LIFO batch:0
Jan 13 09:05:40 linux-a6jk kernel:   DMA32 zone: 4032 pages used for memmap
Jan 13 09:05:40 linux-a6jk kernel:   DMA32 zone: 258048 pages, LIFO batch:31
Jan 13 09:05:40 linux-a6jk kernel: p2m virtual area at ffffc90000000000, size is 40000000
Jan 13 09:05:40 linux-a6jk kernel: Remapped 0 page(s)
Jan 13 09:05:40 linux-a6jk kernel: smpboot: Allowing 1 CPUs, 0 hotplug CPUs
Jan 13 09:05:40 linux-a6jk kernel: PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
Jan 13 09:05:40 linux-a6jk kernel: PM: Registered nosave memory: [mem 0x000a0000-0x000fffff]
Jan 13 09:05:40 linux-a6jk kernel: e820: [mem 0xdffff000-0xefffffff] available for PCI devices
Jan 13 09:05:40 linux-a6jk kernel: Booting paravirtualized kernel on Xen
Jan 13 09:05:40 linux-a6jk kernel: Xen version: 4.9.1_02-13 (preserve-AD)
Jan 13 09:05:40 linux-a6jk kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
Jan 13 09:05:40 linux-a6jk kernel: setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
Jan 13 09:05:40 linux-a6jk kernel: PERCPU: Embedded 33 pages/cpu @ffff88003f600000 s96280 r8192 d30696 u2097152
Jan 13 09:05:40 linux-a6jk kernel: pcpu-alloc: s96280 r8192 d30696 u2097152 alloc=1*2097152
Jan 13 09:05:40 linux-a6jk kernel: pcpu-alloc: [0] 0
Jan 13 09:05:40 linux-a6jk kernel: xen: PV spinlocks enabled
Jan 13 09:05:40 linux-a6jk kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes)
Jan 13 09:05:40 linux-a6jk kernel: Built 1 zonelists in Node order, mobility grouping on.  Total pages: 257930
Jan 13 09:05:40 linux-a6jk kernel: Policy zone: DMA32
Jan 13 09:05:40 linux-a6jk kernel: Kernel command line: root=UUID=701327b1-4c4b-49d9-9eef-5463501ba94c xencons=tty debug=1 ipv6.disable=1 resume=/dev/xvda1 splash=silent quiet
Jan 13 09:05:40 linux-a6jk kernel: PID hash table entries: 4096 (order: 3, 32768 bytes)
Jan 13 09:05:40 linux-a6jk kernel: software IO TLB [mem 0x3a400000-0x3e400000] (64MB) mapped at [ffff88003a400000-ffff88003e3fffff]
Jan 13 09:05:40 linux-a6jk kernel: Memory: 926428K/1048188K available (6376K kernel code, 1484K rwdata, 4696K rodata, 2120K init, 2612K bss, 121760K reserved, 0K cma-reserved)
Jan 13 09:05:40 linux-a6jk kernel: Hierarchical RCU implementation.
Jan 13 09:05:40 linux-a6jk kernel:         RCU debugfs-based tracing is enabled.
Jan 13 09:05:40 linux-a6jk kernel:         Build-time adjustment of leaf fanout to 64.
Jan 13 09:05:40 linux-a6jk kernel:         RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=1.
Jan 13 09:05:40 linux-a6jk kernel: RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
Jan 13 09:05:40 linux-a6jk kernel: Using NULL legacy PIC
Jan 13 09:05:40 linux-a6jk kernel: NR_IRQS:524544 nr_irqs:32 0
Jan 13 09:05:40 linux-a6jk kernel: xen:events: Using FIFO-based ABI
Jan 13 09:05:40 linux-a6jk kernel: Console: colour dummy device 80x25
Jan 13 09:05:40 linux-a6jk kernel: console [tty0] enabled
Jan 13 09:05:40 linux-a6jk kernel: console [hvc0] enabled
Jan 13 09:05:40 linux-a6jk kernel: clocksource: xen: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
Jan 13 09:05:40 linux-a6jk kernel: Xen: using vcpuop timer interface
Jan 13 09:05:40 linux-a6jk kernel: installing Xen timer for CPU 0
Jan 13 09:05:40 linux-a6jk kernel: tsc: Detected 3000.130 MHz processor
Jan 13 09:05:40 linux-a6jk kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 6000.26 BogoMIPS (lpj=12000520)
Jan 13 09:05:40 linux-a6jk kernel: pid_max: default: 32768 minimum: 301
Jan 13 09:05:40 linux-a6jk kernel: Security Framework initialized
Jan 13 09:05:40 linux-a6jk kernel: AppArmor: AppArmor initialized
Jan 13 09:05:40 linux-a6jk kernel: Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
Jan 13 09:05:40 linux-a6jk kernel: Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
Jan 13 09:05:40 linux-a6jk kernel: Mount-cache hash table entries: 2048 (order: 2, 16384 bytes)
Jan 13 09:05:40 linux-a6jk kernel: Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes)
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys io
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys memory
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys devices
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys freezer
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys net_cls
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys perf_event
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys net_prio
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys hugetlb
Jan 13 09:05:40 linux-a6jk kernel: Initializing cgroup subsys pids
Jan 13 09:05:40 linux-a6jk kernel: CPU: Physical Processor ID: 0
Jan 13 09:05:40 linux-a6jk kernel: CPU: Processor Core ID: 0
Jan 13 09:05:40 linux-a6jk kernel: mce: CPU supports 2 MCE banks
Jan 13 09:05:40 linux-a6jk kernel: Last level iTLB entries: 4KB 128, 2MB 128, 4MB 128
Jan 13 09:05:40 linux-a6jk kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 64, 1GB 0
Jan 13 09:05:40 linux-a6jk kernel: Freeing SMP alternatives memory: 24K
Jan 13 09:05:40 linux-a6jk kernel: ftrace: allocating 25952 entries in 102 pages
Jan 13 09:05:40 linux-a6jk kernel: cpu 0 spinlock event irq 1
Jan 13 09:05:40 linux-a6jk kernel: VPMU disabled by hypervisor.
Jan 13 09:05:40 linux-a6jk kernel: Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
Jan 13 09:05:40 linux-a6jk kernel: x86: Booted up 1 node, 1 CPUs
Jan 13 09:05:40 linux-a6jk kernel: NMI watchdog: disabled (cpu0): hardware events not enabled
Jan 13 09:05:40 linux-a6jk kernel: NMI watchdog: Shutting down hard lockup detector on all cpus
Jan 13 09:05:40 linux-a6jk kernel: devtmpfs: initialized
Jan 13 09:05:40 linux-a6jk kernel: evm: security.selinux
Jan 13 09:05:40 linux-a6jk kernel: evm: security.ima
Jan 13 09:05:40 linux-a6jk kernel: evm: security.capability
Jan 13 09:05:40 linux-a6jk kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
Jan 13 09:05:40 linux-a6jk kernel: futex hash table entries: 256 (order: 2, 16384 bytes)
Jan 13 09:05:40 linux-a6jk kernel: pinctrl core: initialized pinctrl subsystem
Jan 13 09:05:40 linux-a6jk kernel: RTC time: 165:165:165, date: 165/165/65
Jan 13 09:05:40 linux-a6jk kernel: NET: Registered protocol family 16
Jan 13 09:05:40 linux-a6jk kernel: xen:grant_table: Grant tables using version 1 layout
Jan 13 09:05:40 linux-a6jk kernel: Grant table initialized
Jan 13 09:05:40 linux-a6jk kernel: PCI: setting up Xen PCI frontend stub
Jan 13 09:05:40 linux-a6jk kernel: PCI: pci_cache_line_size set to 64 bytes
Jan 13 09:05:40 linux-a6jk kernel: ACPI: Interpreter disabled.
Jan 13 09:05:40 linux-a6jk kernel: xen:balloon: Initialising balloon driver
Jan 13 09:05:40 linux-a6jk kernel: vgaarb: loaded
Jan 13 09:05:40 linux-a6jk kernel: dmi: Firmware registration failed.
Jan 13 09:05:40 linux-a6jk kernel: PCI: System does not support PCI
Jan 13 09:05:40 linux-a6jk kernel: PCI: System does not support PCI
Jan 13 09:05:40 linux-a6jk kernel: NetLabel: Initializing
Jan 13 09:05:40 linux-a6jk kernel: NetLabel:  domain hash size = 128
Jan 13 09:05:40 linux-a6jk kernel: NetLabel:  protocols = UNLABELED CIPSOv4
Jan 13 09:05:40 linux-a6jk kernel: NetLabel:  unlabeled traffic allowed by default
Jan 13 09:05:40 linux-a6jk kernel: amd_nb: Cannot enumerate AMD northbridges
Jan 13 09:05:40 linux-a6jk kernel: clocksource: Switched to clocksource xen
Jan 13 09:05:40 linux-a6jk kernel: AppArmor: AppArmor Filesystem Enabled
Jan 13 09:05:40 linux-a6jk kernel: pnp: PnP ACPI: disabled
Jan 13 09:05:40 linux-a6jk kernel: NET: Registered protocol family 2
Jan 13 09:05:40 linux-a6jk kernel: TCP established hash table entries: 8192 (order: 4, 65536 bytes)
Jan 13 09:05:40 linux-a6jk kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes)
Jan 13 09:05:40 linux-a6jk kernel: TCP: Hash tables configured (established 8192 bind 8192)
Jan 13 09:05:40 linux-a6jk kernel: UDP hash table entries: 512 (order: 2, 16384 bytes)
Jan 13 09:05:40 linux-a6jk kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
Jan 13 09:05:40 linux-a6jk kernel: NET: Registered protocol family 1
Jan 13 09:05:40 linux-a6jk kernel: PCI: CLS 0 bytes, default 64
Jan 13 09:05:40 linux-a6jk kernel: Unpacking initramfs...
Jan 13 09:05:40 linux-a6jk kernel: Freeing initrd memory: 14176K
Jan 13 09:05:40 linux-a6jk kernel: Scanning for low memory corruption every 60 seconds
Jan 13 09:05:40 linux-a6jk kernel: kgr: successfully initialized
Jan 13 09:05:40 linux-a6jk kernel: audit: initializing netlink subsys (disabled)
Jan 13 09:05:40 linux-a6jk kernel: audit: type=2000 audit(1515830726.776:1): initialized
Jan 13 09:05:40 linux-a6jk kernel: zbud: loaded
Jan 13 09:05:40 linux-a6jk kernel: VFS: Disk quotas dquot_6.6.0
Jan 13 09:05:40 linux-a6jk kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Jan 13 09:05:40 linux-a6jk kernel: hugetlbfs: disabling because there are no supported hugepage sizes
Jan 13 09:05:40 linux-a6jk kernel: Key type big_key registered
Jan 13 09:05:40 linux-a6jk kernel: Key type asymmetric registered
Jan 13 09:05:40 linux-a6jk kernel: Asymmetric key parser 'x509' registered
Jan 13 09:05:40 linux-a6jk kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
Jan 13 09:05:40 linux-a6jk kernel: io scheduler noop registered
Jan 13 09:05:40 linux-a6jk kernel: io scheduler deadline registered
Jan 13 09:05:40 linux-a6jk kernel: io scheduler cfq registered (default)
Jan 13 09:05:40 linux-a6jk kernel: start plist test
Jan 13 09:05:40 linux-a6jk kernel: end plist test
Jan 13 09:05:40 linux-a6jk kernel: pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Jan 13 09:05:40 linux-a6jk kernel: pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Jan 13 09:05:40 linux-a6jk kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
Jan 13 09:05:40 linux-a6jk kernel: Non-volatile memory driver v1.3
Jan 13 09:05:40 linux-a6jk kernel: Linux agpgart interface v0.103
Jan 13 09:05:40 linux-a6jk kernel: i8042: PNP: No PS/2 controller found.
Jan 13 09:05:40 linux-a6jk kernel: i8042: Probing ports directly.
Jan 13 09:05:40 linux-a6jk kernel: i8042: No controller found
Jan 13 09:05:40 linux-a6jk kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2b3ec06c55a, max_idle_ns: 440795350534 ns
Jan 13 09:05:40 linux-a6jk kernel: mousedev: PS/2 mouse device common for all mice
Jan 13 09:05:40 linux-a6jk kernel: ledtrig-cpu: registered to indicate activity on CPUs
Jan 13 09:05:40 linux-a6jk kernel: hidraw: raw HID events driver (C) Jiri Kosina
Jan 13 09:05:40 linux-a6jk kernel: IPv6: Loaded, but administratively disabled, reboot required to enable
Jan 13 09:05:40 linux-a6jk kernel: registered taskstats version 1
Jan 13 09:05:40 linux-a6jk kernel: zswap: loaded using pool lzo/zbud
Jan 13 09:05:40 linux-a6jk kernel: page_owner is disabled
Jan 13 09:05:40 linux-a6jk kernel: Key type encrypted registered
Jan 13 09:05:40 linux-a6jk kernel: AppArmor: AppArmor sha1 policy hashing enabled
Jan 13 09:05:40 linux-a6jk kernel: ima: No TPM chip found, activating TPM-bypass!
Jan 13 09:05:40 linux-a6jk kernel: evm: HMAC attrs: 0x1
Jan 13 09:05:40 linux-a6jk kernel: xenbus_probe_frontend: Device with no driver: device/vbd/51712
Jan 13 09:05:40 linux-a6jk kernel: xenbus_probe_frontend: Device with no driver: device/vif/0
Jan 13 09:05:40 linux-a6jk kernel: xenbus_probe_frontend: Device with no driver: device/pci/0
Jan 13 09:05:40 linux-a6jk kernel:   Magic number: 1:252:3141
Jan 13 09:05:40 linux-a6jk kernel: hctosys: unable to open rtc device (rtc0)
Jan 13 09:05:40 linux-a6jk kernel: PM: Checking hibernation image partition /dev/xvda1
Jan 13 09:05:40 linux-a6jk kernel: PM: Hibernation image not present or could not be loaded.
Jan 13 09:05:40 linux-a6jk kernel: Freeing unused kernel memory: 2120K
Jan 13 09:05:40 linux-a6jk kernel: Write protecting the kernel read-only data: 14336k
Jan 13 09:05:40 linux-a6jk kernel: Freeing unused kernel memory: 1800K
Jan 13 09:05:40 linux-a6jk kernel: Freeing unused kernel memory: 1448K
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk systemd[1]: systemd 228 running in system mode. (+PAM -AUDIT +SELINUX -IMA +APPARMOR -SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ -
Jan 13 09:05:40 linux-a6jk systemd[1]: Detected virtualization xen.
Jan 13 09:05:40 linux-a6jk systemd[1]: Detected architecture x86-64.
Jan 13 09:05:40 linux-a6jk systemd[1]: Running in initial RAM disk.
Jan 13 09:05:40 linux-a6jk systemd[1]: Set hostname to <linux-a6jk>.
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk kernel: random: systemd: uninitialized urandom read (16 bytes read, 25 bits of entropy available)
Jan 13 09:05:40 linux-a6jk systemd[1]: Listening on Journal Audit Socket.
Jan 13 09:05:40 linux-a6jk systemd[1]: Reached target Swap.
Jan 13 09:05:40 linux-a6jk systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
Jan 13 09:05:40 linux-a6jk systemd[1]: Reached target Timers.
Jan 13 09:05:40 linux-a6jk systemd[1]: Reached target Local File Systems.
Jan 13 09:05:40 linux-a6jk kernel: SCSI subsystem initialized
Jan 13 09:05:40 linux-a6jk kernel: alua: device handler registered
Jan 13 09:05:40 linux-a6jk kernel: emc: device handler registered
Jan 13 09:05:40 linux-a6jk kernel: rdac: device handler registered
Jan 13 09:05:40 linux-a6jk kernel: device-mapper: uevent: version 1.0.3
Jan 13 09:05:40 linux-a6jk kernel: device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: [hidden email]
Jan 13 09:05:40 linux-a6jk systemd-journald[97]: Journal started
Jan 13 09:05:40 linux-a6jk systemd-modules-load[93]: Inserted module 'scsi_dh_alua'
Jan 13 09:05:40 linux-a6jk systemd-modules-load[93]: Inserted module 'scsi_dh_emc'
Jan 13 09:05:40 linux-a6jk systemd-modules-load[93]: Inserted module 'scsi_dh_rdac'
Jan 13 09:05:40 linux-a6jk systemd-modules-load[93]: Inserted module 'dm_multipath'
Jan 13 09:05:40 linux-a6jk systemd-modules-load[93]: Inserted module 'sg'
Jan 13 09:05:40 linux-a6jk systemd-sysctl[114]: Couldn't write '0' to 'net/bridge/bridge-nf-call-iptables', ignoring: No such file or directory
Jan 13 09:05:40 linux-a6jk systemd-sysctl[114]: Couldn't write '0' to 'dev/cdrom/autoclose', ignoring: No such file or directory
Jan 13 09:05:40 linux-a6jk systemd-sysctl[114]: Couldn't write '1' to 'net/ipv6/conf/default/use_tempaddr', ignoring: No such file or directory
Jan 13 09:05:40 linux-a6jk systemd-sysctl[114]: Couldn't write '0' to 'net/bridge/bridge-nf-call-ip6tables', ignoring: No such file or directory
Jan 13 09:05:40 linux-a6jk systemd[1]: Started Apply Kernel Variables.
Jan 13 09:05:40 linux-a6jk systemd[1]: Started dracut ask for additional cmdline parameters.
Jan 13 09:05:40 linux-a6jk systemd[1]: Starting dracut cmdline hook...
Jan 13 09:05:40 linux-a6jk dracut-cmdline[122]: dracut-42.3 dracut-044-29.1
Jan 13 09:05:40 linux-a6jk dracut-cmdline[122]: Using kernel command line parameters: ip=eth0:dhcp ifname=eth0:00:16:3e:37:02:1c rd.iscsi.initiator=iqn.1996-04.de.suse:01:6b578
Jan 13 09:05:40 linux-a6jk kernel: Loading iSCSI transport class v2.0-870.
Jan 13 09:05:40 linux-a6jk kernel: iscsi: registered transport (tcp)
Jan 13 09:05:40 linux-a6jk dracut-cmdline[122]: eth0:dhcp
Jan 13 09:05:41 linux-a6jk dracut-cmdline[122]: Multiple ip= arguments: assuming rd.neednet=1
Jan 13 09:05:41 linux-a6jk dracut-cmdline[122]: Setting bootdev to 'eth0'
Jan 13 09:05:41 linux-a6jk systemd[1]: Started dracut cmdline hook.
Jan 13 09:05:41 linux-a6jk systemd[1]: Starting dracut pre-udev hook...
Jan 13 09:05:41 linux-a6jk systemd[1]: Started dracut pre-udev hook.
Jan 13 09:05:41 linux-a6jk systemd[1]: Starting udev Kernel Device Manager...
Jan 13 09:05:41 linux-a6jk systemd-udevd[276]: Network interface NamePolicy= disabled by default.
Jan 13 09:05:41 linux-a6jk systemd[1]: Started udev Kernel Device Manager.
Jan 13 09:05:41 linux-a6jk systemd[1]: Starting dracut pre-trigger hook...
Jan 13 09:05:41 linux-a6jk systemd[1]: Started dracut pre-trigger hook.
Jan 13 09:05:41 linux-a6jk systemd[1]: Starting udev Coldplug all Devices...
Jan 13 09:05:42 linux-a6jk systemd-udevd[276]: Network interface NamePolicy= disabled by default.
Jan 13 09:05:42 linux-a6jk systemd[1]: Started udev Coldplug all Devices.
Jan 13 09:05:42 linux-a6jk systemd[1]: Reached target System Initialization.
Jan 13 09:05:42 linux-a6jk systemd[1]: Listening on Open-iSCSI iscsid Socket.
Jan 13 09:05:42 linux-a6jk systemd[1]: Listening on Open-iSCSI iscsiuio Socket.
Jan 13 09:05:42 linux-a6jk systemd[1]: Starting iSCSI UserSpace I/O driver...
Jan 13 09:05:42 linux-a6jk systemd[1]: Reached target Sockets.
Jan 13 09:05:42 linux-a6jk systemd[1]: Reached target Basic System.
Jan 13 09:05:42 linux-a6jk systemd[1]: Started iSCSI UserSpace I/O driver.
Jan 13 09:05:42 linux-a6jk systemd[1]: Started Open-iSCSI.
Jan 13 09:05:42 linux-a6jk systemd[1]: Starting dracut initqueue hook...
Jan 13 09:05:42 linux-a6jk kernel: xen_netfront: Initialising Xen virtual ethernet driver
Jan 13 09:05:42 linux-a6jk kernel: blkfront: xvda: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Jan 13 09:05:42 linux-a6jk kernel:  xvda: xvda1
Jan 13 09:05:43 linux-a6jk kernel: raid6: sse2x1   gen()  2175 MB/s
Jan 13 09:05:43 linux-a6jk kernel: raid6: sse2x1   xor()  1905 MB/s
Jan 13 09:05:43 linux-a6jk kernel: raid6: sse2x2   gen()  3126 MB/s
Jan 13 09:05:43 linux-a6jk kernel: raid6: sse2x2   xor()  1932 MB/s
Jan 13 09:05:43 linux-a6jk kernel: raid6: sse2x4   gen()  3117 MB/s
Jan 13 09:05:43 linux-a6jk kernel: raid6: sse2x4   xor()  1859 MB/s
Jan 13 09:05:43 linux-a6jk kernel: raid6: using algorithm sse2x2 gen() 3126 MB/s
Jan 13 09:05:43 linux-a6jk kernel: raid6: .... xor() 1932 MB/s, rmw enabled
Jan 13 09:05:43 linux-a6jk kernel: raid6: using intx1 recovery algorithm
Jan 13 09:05:43 linux-a6jk dracut-initqueue[341]: Preparation for DHCP transaction
Jan 13 09:05:43 linux-a6jk dracut-initqueue[341]: Notice: eth0: Request to acquire DHCPv4 lease with UUID d7bd595a-e156-0b00-9501-000001000000
Jan 13 09:05:44 linux-a6jk kernel: xor: measuring software checksum speed
Jan 13 09:05:44 linux-a6jk kernel:    prefetch64-sse:  5629.000 MB/sec
Jan 13 09:05:44 linux-a6jk kernel:    generic_sse:  5684.000 MB/sec
Jan 13 09:05:44 linux-a6jk kernel: xor: using function: generic_sse (5684.000 MB/sec)
Jan 13 09:05:44 linux-a6jk systemd[1]: Found device /dev/disk/by-uuid/a40b39ea-0708-40d2-9b9c-edacf65c9f4d.
Jan 13 09:05:44 linux-a6jk kernel: Btrfs loaded, crc32c=crc32c-generic, assert=on
Jan 13 09:05:44 linux-a6jk kernel: BTRFS: device fsid a40b39ea-0708-40d2-9b9c-edacf65c9f4d devid 1 transid 57 /dev/xvda1
Jan 13 09:05:44 linux-a6jk kernel: NET: Registered protocol family 17
Jan 13 09:05:44 linux-a6jk dracut-initqueue[341]: Error: unknown sip encoding 172
Jan 13 09:05:44 linux-a6jk dracut-initqueue[341]: Error: unknown sip encoding 172
Jan 13 09:05:44 linux-a6jk dracut-initqueue[341]: Notice: eth0: Committed DHCPv4 lease with address 172.18.0.81 (lease time 14400 sec, renew in 7200 sec, rebind in 12600 sec)
Jan 13 09:05:44 linux-a6jk dracut-initqueue[341]: RTNETLINK answers: File exists
Jan 13 09:05:44 alif dracut-initqueue[341]: DHCP is finished successfully
Jan 13 09:05:45 alif dracut-initqueue[341]: iscsiadm: No records found
Jan 13 09:05:45 alif kernel: scsi host0: iSCSI Initiator over TCP/IP
Jan 13 09:05:45 alif iscsid[339]: iscsid: Connection1:0 to [target: iqn.2018-01.net.swabian:alif_disks, portal: 172.18.0.1,3260] through [iface: default] is operational now
Jan 13 09:05:45 alif kernel: scsi 0:0:0:0: RAID              IET      Controller       0001 PQ: 0 ANSI: 5
Jan 13 09:05:45 alif kernel: scsi 0:0:0:0: Attached scsi generic sg0 type 12
Jan 13 09:05:45 alif kernel: scsi 0:0:0:1: Direct-Access     IET      VIRTUAL-DISK     0001 PQ: 0 ANSI: 5
Jan 13 09:05:45 alif kernel: scsi 0:0:0:1: Attached scsi generic sg1 type 0
Jan 13 09:05:45 alif dracut-initqueue[341]: Logging in to [iface: default, target: iqn.2018-01.net.swabian:alif_disks, portal: 172.18.0.1,3260] (multiple)
Jan 13 09:05:45 alif dracut-initqueue[341]: Login to [iface: default, target: iqn.2018-01.net.swabian:alif_disks, portal: 172.18.0.1,3260] successful.
Jan 13 09:05:45 alif kernel: sd 0:0:0:1: Power-on or device reset occurred
Jan 13 09:05:45 alif kernel: sd 0:0:0:1: [sda] 16875520 512-byte logical blocks: (8.64 GB/8.05 GiB)
Jan 13 09:05:45 alif kernel: sd 0:0:0:1: [sda] 4096-byte physical blocks
Jan 13 09:05:45 alif kernel: sd 0:0:0:1: [sda] Write Protect is off
Jan 13 09:05:45 alif kernel: sd 0:0:0:1: [sda] Mode Sense: 69 00 00 08
Jan 13 09:05:45 alif kernel: sd 0:0:0:1: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Jan 13 09:05:45 alif kernel:  sda: sda1 sda2
Jan 13 09:05:45 alif kernel: sd 0:0:0:1: [sda] Attached SCSI disk
Jan 13 09:05:46 alif kernel: BTRFS: device fsid 701327b1-4c4b-49d9-9eef-5463501ba94c devid 1 transid 605 /dev/sda2
Jan 13 09:05:46 alif systemd[1]: Found device VIRTUAL-DISK 2.
Jan 13 09:05:46 alif dracut-initqueue[341]: 172.18.0.1:3260,1 iqn.2018-01.net.swabian:alif_disks
Jan 13 09:05:46 alif dracut-initqueue[341]: iscsiadm: default: 1 session requested, but 1 already present.
Jan 13 09:05:46 alif dracut-initqueue[341]: iscsiadm: Could not log into all portals
Jan 13 09:05:46 alif systemd[1]: Started dracut initqueue hook.
Jan 13 09:05:46 alif systemd[1]: Reached target Remote File Systems (Pre).
Jan 13 09:05:46 alif systemd[1]: Reached target Remote File Systems.
Jan 13 09:05:46 alif systemd[1]: Starting File System Check on /dev/disk/by-uuid/701327b1-4c4b-49d9-9eef-5463501ba94c...
Jan 13 09:05:46 alif systemd[1]: Started File System Check on /dev/disk/by-uuid/701327b1-4c4b-49d9-9eef-5463501ba94c.
Jan 13 09:05:46 alif systemd[1]: Mounting /sysroot...
Jan 13 09:05:46 alif kernel: BTRFS info (device sda2): disk space caching is enabled
Jan 13 09:05:46 alif kernel: BTRFS info (device sda2): has skinny extents
Jan 13 09:05:46 alif kernel: random: nonblocking pool is initialized
Jan 13 09:05:46 alif systemd[1]: Mounted /sysroot.
Jan 13 09:05:46 alif systemd[1]: Reached target Initrd Root File System.
Jan 13 09:05:46 alif systemd[1]: Starting Reload Configuration from the Real Root...
Jan 13 09:05:46 alif systemd[1]: Reloading.
Jan 13 09:05:47 alif systemd[1]: Started Reload Configuration from the Real Root.
Jan 13 09:05:47 alif systemd[1]: Reached target Initrd File Systems.
Jan 13 09:05:47 alif systemd[1]: Reached target Initrd Default Target.
Jan 13 09:05:47 alif systemd[1]: Starting dracut pre-pivot and cleanup hook...
Jan 13 09:05:47 alif systemd[1]: Started dracut pre-pivot and cleanup hook.
Jan 13 09:05:47 alif systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
Jan 13 09:05:47 alif systemd[1]: Stopped target Timers.
Jan 13 09:05:47 alif systemd[1]: Stopped Cleaning Up and Shutting Down Daemons.
Jan 13 09:05:47 alif systemd[1]: Stopped dracut pre-pivot and cleanup hook.
Jan 13 09:05:47 alif systemd[1]: Stopped target Remote File Systems.
Jan 13 09:05:47 alif systemd[1]: Stopped target Remote File Systems (Pre).
Jan 13 09:05:47 alif systemd[1]: Stopped dracut initqueue hook.
Jan 13 09:05:47 alif iscsid[339]: iscsid: iscsid shutting down.
Jan 13 09:05:47 alif systemd[1]: Stopping Open-iSCSI...
Jan 13 09:05:47 alif systemd[1]: Stopped target Initrd Default Target.
Jan 13 09:05:47 alif systemd[1]: Stopped target Basic System.
Jan 13 09:05:47 alif systemd[1]: Stopped target Paths.
Jan 13 09:05:47 alif systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Jan 13 09:05:47 alif systemd[1]: Stopped target Sockets.
Jan 13 09:05:47 alif systemd[1]: Stopped target Slices.
Jan 13 09:05:47 alif systemd[1]: Stopped Open-iSCSI.
Jan 13 09:05:47 alif systemd[1]: Stopping iSCSI UserSpace I/O driver...
Jan 13 09:05:47 alif systemd[1]: Closed Open-iSCSI iscsid Socket.
Jan 13 09:05:47 alif systemd[1]: Stopped iSCSI UserSpace I/O driver.
Jan 13 09:05:47 alif systemd[1]: Closed Open-iSCSI iscsiuio Socket.
Jan 13 09:05:47 alif systemd[1]: Stopped target System Initialization.
Jan 13 09:05:47 alif systemd[1]: Stopped Apply Kernel Variables.
Jan 13 09:05:47 alif systemd[1]: Stopped Load Kernel Modules.
Jan 13 09:05:47 alif systemd[1]: Stopped target Swap.
Jan 13 09:05:47 alif systemd[1]: Stopped target Local File Systems.
Jan 13 09:05:47 alif systemd[1]: Stopped udev Coldplug all Devices.
Jan 13 09:05:47 alif systemd[1]: Stopped dracut pre-trigger hook.
Jan 13 09:05:47 alif systemd[1]: Stopping udev Kernel Device Manager...
Jan 13 09:05:47 alif systemd[1]: Stopped udev Kernel Device Manager.
Jan 13 09:05:47 alif systemd[1]: Stopped dracut pre-udev hook.
Jan 13 09:05:47 alif systemd[1]: Stopped dracut cmdline hook.
Jan 13 09:05:47 alif systemd[1]: Stopped dracut ask for additional cmdline parameters.
Jan 13 09:05:47 alif systemd[1]: Stopped Create Static Device Nodes in /dev.
Jan 13 09:05:47 alif systemd[1]: Stopped Create list of required static device nodes for the current kernel.
Jan 13 09:05:47 alif systemd[1]: Closed udev Kernel Socket.
Jan 13 09:05:47 alif systemd[1]: Closed udev Control Socket.
Jan 13 09:05:47 alif systemd[1]: Starting Cleanup udevd DB...
Jan 13 09:05:47 alif systemd[1]: Started Cleanup udevd DB.
Jan 13 09:05:47 alif systemd[1]: Reached target Switch Root.
Jan 13 09:05:47 alif systemd[1]: Starting Switch Root...
Jan 13 09:05:47 alif systemd[1]: Switching root.
Jan 13 09:05:47 alif haveged[88]: haveged: Stopping due to signal 15
Jan 13 09:05:47 alif haveged[88]: haveged starting up
Jan 13 09:05:47 alif systemd-journald[97]: Journal stopped
Jan 13 09:05:49 linux-a6jk systemd-journald[685]: Runtime journal (/run/log/journal/) is currently using 5.7M.
                                                  Maximum allowed usage is set to 46.1M.
                                                  Leaving at least 69.2M free (of currently available 455.9M of space).
                                                  Enforced usage limit is thus 46.1M, of which 40.4M are still available.
Jan 13 09:05:49 linux-a6jk systemd-journald[97]: Received SIGTERM from PID 1 (systemd).
Jan 13 09:05:49 linux-a6jk kernel: systemd: 18 output lines suppressed due to ratelimiting
Jan 13 09:05:49 linux-a6jk kernel: BTRFS info (device sda2): disk space caching is enabled
Jan 13 09:05:49 linux-a6jk systemd-journald[685]: Journal started
Jan 13 09:05:49 linux-a6jk auditd[727]: Couldn't open log file /var/log/audit/audit.log (Read-only file system)
Jan 13 09:05:48 linux-a6jk systemd[1]: systemd 228 running in system mode. (+PAM -AUDIT +SELINUX -IMA +APPARMOR -SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ -
Jan 13 09:05:49 linux-a6jk auditd[715]: Cannot daemonize (Success)
Jan 13 09:05:48 linux-a6jk systemd[1]: Detected virtualization xen.
Jan 13 09:05:49 linux-a6jk auditd[715]: The audit daemon is exiting.
Jan 13 09:05:48 linux-a6jk systemd[1]: Detected architecture x86-64.
Jan 13 09:05:49 linux-a6jk auditd[727]: The audit daemon is exiting.
Jan 13 09:05:48 linux-a6jk systemd[1]: Set hostname to <linux-a6jk>.
Jan 13 09:05:49 linux-a6jk auditd[727]: Error setting audit daemon pid (Permission denied)
Jan 13 09:05:49 linux-a6jk systemd[1]: nss-lookup.target: Dependency Before=nss-lookup.target dropped
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found ordering cycle on wicked.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on wickedd-nanny.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on local-fs.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on home-pane-.gnupg.mount/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on storage.mount/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on network.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on wicked.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Breaking ordering cycle by deleting job wickedd-nanny.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: wickedd-nanny.service: Job wickedd-nanny.service/start deleted to break ordering cycle starting with wicked.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found ordering cycle on sysinit.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on local-fs.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on home-pane-.gnupg.mount/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on storage.mount/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on network.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on wicked.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on wickedd.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on wickedd-dhcp4.service/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on sysinit.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Breaking ordering cycle by deleting job local-fs.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: local-fs.target: Job local-fs.target/start deleted to break ordering cycle starting with sysinit.target/start
Jan 13 09:05:49 linux-a6jk systemd[1]: Started Load/Save Random Seed.
Jan 13 09:05:49 linux-a6jk systemd[1]: Started Create Static Device Nodes in /dev.
Jan 13 09:05:49 linux-a6jk systemd[1]: Starting udev Kernel Device Manager...
Jan 13 09:05:49 linux-a6jk systemd[1]: Reached target Local File Systems (Pre).
Jan 13 09:05:50 linux-a6jk systemd[1]: Mounting mount xenstore file system...
Jan 13 09:05:50 linux-a6jk systemd[1]: Mounted mount xenstore file system.
Jan 13 09:05:50 linux-a6jk systemd[1]: Started udev Coldplug all Devices.
Jan 13 09:05:50 linux-a6jk systemd-udevd[754]: Network interface NamePolicy= disabled by default.
Jan 13 09:05:50 linux-a6jk systemd[1]: Started udev Kernel Device Manager.
Jan 13 09:05:50 linux-a6jk kernel: input: PC Speaker as /devices/platform/pcspkr/input/input0
Jan 13 09:05:50 linux-a6jk kernel: pcifront pci-0: Installing PCI frontend
Jan 13 09:05:50 linux-a6jk kernel: pcifront pci-0: Creating PCI Frontend Bus 0000:00
Jan 13 09:05:50 linux-a6jk kernel: pcifront pci-0: PCI host bridge to bus 0000:00
Jan 13 09:05:50 linux-a6jk kernel: pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
Jan 13 09:05:50 linux-a6jk kernel: pci_bus 0000:00: root bus resource [mem 0x00000000-0xfffffffff]
Jan 13 09:05:50 linux-a6jk kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Jan 13 09:05:50 linux-a6jk kernel: pci 0000:00:00.0: [1011:1065] type 00 class 0x0e0001
Jan 13 09:05:50 linux-a6jk kernel: pci 0000:00:00.0: reg 0x10: [mem 0xfe7ffc00-0xfe7ffc7f]
Jan 13 09:05:50 linux-a6jk kernel: pci 0000:00:00.0: reg 0x14: [io  0xdc80-0xdcff]
Jan 13 09:05:50 linux-a6jk kernel: pci 0000:00:00.0: supports D1 D2
Jan 13 09:05:50 linux-a6jk kernel: pcifront pci-0: claiming resource 0000:00:00.0/0
Jan 13 09:05:50 linux-a6jk kernel: pcifront pci-0: claiming resource 0000:00:00.0/1
Jan 13 09:05:50 linux-a6jk kernel: audit: type=1400 audit(1515830750.940:2): apparmor="STATUS" operation="profile_load" name="/{usr/,}bin/ping" pid=788 comm="apparmor_parser"
Jan 13 09:05:51 linux-a6jk systemd[1]: Found device /dev/hvc0.
Jan 13 09:05:51 linux-a6jk kernel: audit: type=1400 audit(1515830751.248:3): apparmor="STATUS" operation="profile_load" name="klogd" pid=830 comm="apparmor_parser"
lines 400-456


--
To unsubscribe, e-mail: [hidden email]
To contact the owner, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

Re: wicked fails on boot due to read-only mount?

Andrei Borzenkov
13.01.2018 11:21, Paul Neuwirth пишет:
> Hello,
> I have an Issue on several machines using Leap 42.2 or 42.3, sometimes
> wicked fails on boot. Login in on console and doing systemctl restart
> wicked always works... I want know to find out the problem.
>
> On this (virtual) machine, with recent Leap 42.3 installed, following happens:
> network get setup in initrd, iscsi device gets mounted read-only, root
> is being switched, and wicked failes due to read-only mount, I think.
>

What exactly "failes" means?
...

> Jan 13 09:05:49 linux-a6jk systemd[1]: nss-lookup.target: Dependency Before=nss-lookup.target dropped
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found ordering cycle on wicked.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on wickedd-nanny.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on local-fs.target/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on home-pane-.gnupg.mount/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on storage.mount/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on network.target/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency on wicked.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Breaking ordering cycle by deleting job wickedd-nanny.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: wickedd-nanny.service: Job wickedd-nanny.service/start deleted to break ordering cycle starting with wicked.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found ordering cycle on sysinit.target/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on local-fs.target/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on home-pane-.gnupg.mount/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on storage.mount/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on network.target/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on wicked.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on wickedd.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on wickedd-dhcp4.service/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on sysinit.target/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Breaking ordering cycle by deleting job local-fs.target/start
> Jan 13 09:05:49 linux-a6jk systemd[1]: local-fs.target: Job local-fs.target/start deleted to break ordering cycle starting with sysinit.target/start

you have dependency loop apparently due ti /home/pane/.gnupg mount.
Please show /etc/fstab line for this filesystem. Is it on iSCSI?

--
To unsubscribe, e-mail: [hidden email]
To contact the owner, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

Re: wicked fails on boot due to read-only mount?

Paul Neuwirth-3
On Sat, 13 Jan 2018 11:27:57 +0300
Andrei Borzenkov <[hidden email]> wrote:

> 13.01.2018 11:21, Paul Neuwirth пишет:
> > Hello,
> > I have an Issue on several machines using Leap 42.2 or 42.3,
> > sometimes wicked fails on boot. Login in on console and doing
> > systemctl restart wicked always works... I want know to find out
> > the problem.
> >
> > On this (virtual) machine, with recent Leap 42.3 installed,
> > following happens: network get setup in initrd, iscsi device gets
> > mounted read-only, root is being switched, and wicked failes due to
> > read-only mount, I think.
>
> What exactly "failes" means?

good question.. status is not failed.. but network setup is incomplete
(hostname not set, dns not working..), wicked says "device-unconfigured"

this it what I did intentionally after this boot:
linux-a6jk login: root
Password:
Last login: Fri Jan 12 11:09:55 on hvc0
Have a lot of fun...
ifclinux-a6jk:~ # ifconfig
eth0      Link encap:Ethernet  HWaddr 00:16:3E:37:02:1C  
          inet addr:172.18.0.81  Bcast:172.18.0.255  Mask:255.255.255.0
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:17217 errors:0 dropped:75 overruns:0 frame:0
          TX packets:15328 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:88934060 (84.8 Mb)  TX bytes:6674371 (6.3 Mb)

lo        Link encap:Local Loopback  
          inet addr:127.0.0.1  Mask:255.0.0.0
          UP LOOPBACK RUNNING  MTU:65536  Metric:1
          RX packets:2072624 errors:0 dropped:0 overruns:0 frame:0
          TX packets:2072624 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1
          RX bytes:159594836 (152.2 Mb)  TX bytes:159594836 (152.2 Mb)

linux-a6jk:~ # systemctl --failed
  UNIT              LOAD   ACTIVE SUB    DESCRIPTION
● auditd.service    loaded failed failed Security Auditing Service
● xenstored.service loaded failed failed The Xen xenstore

LOAD   = Reflects whether the unit definition was properly loaded.
ACTIVE = The high-level unit activation state, i.e. generalization of SUB.
SUB    = The low-level unit activation state, values depend on unit type.

2 loaded units listed. Pass --all to see loaded but inactive units, too.
To show all installed unit files use 'systemctl list-unit-files'.
linux-a6jk:~ # systemctl status wicked
● wicked.service - wicked managed network interfaces
   Loaded: loaded (/usr/lib/systemd/system/wicked.service; enabled; vendor preset: disabled)
   Active: active (exited) since Sat 2018-01-13 09:06:41 CET; 1min 20s ago
  Process: 1749 ExecStart=/usr/sbin/wicked --systemd ifup all (code=exited, status=0/SUCCESS)
 Main PID: 1749 (code=exited, status=0/SUCCESS)
    Tasks: 0 (limit: 512)
   CGroup: /system.slice/wicked.service

Jan 13 09:06:11 linux-a6jk systemd[1]: Starting wicked managed network inte.....
Jan 13 09:06:11 linux-a6jk wicked[1749]: device lo: unable to apply configur...y
Jan 13 09:06:11 linux-a6jk wicked[1749]: device eth0: unable to apply config...y
Jan 13 09:06:41 linux-a6jk wicked[1749]: lo              device-unconfigured
Jan 13 09:06:41 linux-a6jk wicked[1749]: eth0            device-unconfigured
Jan 13 09:06:41 linux-a6jk systemd[1]: Started wicked managed network inter...s.
Hint: Some lines were ellipsized, use -l to show in full.
linux-a6jk:~ # systemctl status wicked -l
● wicked.service - wicked managed network interfaces
   Loaded: loaded (/usr/lib/systemd/system/wicked.service; enabled; vendor preset: disabled)
   Active: active (exited) since Sat 2018-01-13 09:06:41 CET; 1min 35s ago
  Process: 1749 ExecStart=/usr/sbin/wicked --systemd ifup all (code=exited, status=0/SUCCESS)
 Main PID: 1749 (code=exited, status=0/SUCCESS)
    Tasks: 0 (limit: 512)
   CGroup: /system.slice/wicked.service

Jan 13 09:06:11 linux-a6jk systemd[1]: Starting wicked managed network interfaces...
Jan 13 09:06:11 linux-a6jk wicked[1749]: device lo: unable to apply configuration to nanny
Jan 13 09:06:11 linux-a6jk wicked[1749]: device eth0: unable to apply configuration to nanny
Jan 13 09:06:41 linux-a6jk wicked[1749]: lo              device-unconfigured
Jan 13 09:06:41 linux-a6jk wicked[1749]: eth0            device-unconfigured
Jan 13 09:06:41 linux-a6jk systemd[1]: Started wicked managed network interfaces.
linux-a6jk:~ # systemctl --failed
  UNIT              LOAD   ACTIVE SUB    DESCRIPTION
● storage.mount     loaded failed failed /storage
● auditd.service    loaded failed failed Security Auditing Service
● xenstored.service loaded failed failed The Xen xenstore

LOAD   = Reflects whether the unit definition was properly loaded.
ACTIVE = The high-level unit activation state, i.e. generalization of SUB.
SUB    = The low-level unit activation state, values depend on unit type.

3 loaded units listed. Pass --all to see loaded but inactive units, too.
To show all installed unit files use 'systemctl list-unit-files'.
linux-a6jk:~ # mount -av
swap                     : ignored
/                        : ignored
/boot                    : already mounted
/boot/grub2/i386-pc      : already mounted
/boot/grub2/x86_64-efi   : already mounted
/home                    : already mounted
/opt                     : already mounted
/srv                     : already mounted
/tmp                     : already mounted
/usr/local               : already mounted
/var/cache               : already mounted
/var/crash               : already mounted
/var/lib/libvirt/images  : already mounted
/var/lib/machines        : already mounted
/var/lib/mailman         : already mounted
/var/lib/mariadb         : already mounted
/var/lib/mysql           : already mounted
/var/lib/named           : already mounted
/var/lib/pgsql           : already mounted
/var/log                 : already mounted
/var/opt                 : already mounted
/var/spool               : already mounted
/var/tmp                 : already mounted
mount.nfs: timeout set for Sat Jan 13 09:13:31 2018
^C
linux-a6jk:~ # ping alpha.swabian.net
ping: unknown host alpha.swabian.net
linux-a6jk:~ # systemctl restart wicked -l
linux-a6jk:~ # ping alpha.swabian.net
PING alpha.swabian.net (172.18.0.1) 56(84) bytes of data.
64 bytes from alpha.swabian.net (172.18.0.1): icmp_seq=1 ttl=64 time=0.525 ms
^C
--- alpha.swabian.net ping statistics ---
1 packets transmitted, 1 received, 0% packet loss, time 0ms
rtt min/avg/max/mdev = 0.525/0.525/0.525/0.000 ms
linux-a6jk:~ # mount -av
swap                     : ignored
/                        : ignored
/boot                    : already mounted
/boot/grub2/i386-pc      : already mounted
/boot/grub2/x86_64-efi   : already mounted
/home                    : already mounted
/opt                     : already mounted
/srv                     : already mounted
/tmp                     : already mounted
/usr/local               : already mounted
/var/cache               : already mounted
/var/crash               : already mounted
/var/lib/libvirt/images  : already mounted
/var/lib/machines        : already mounted
/var/lib/mailman         : already mounted
/var/lib/mariadb         : already mounted
/var/lib/mysql           : already mounted
/var/lib/named           : already mounted
/var/lib/pgsql           : already mounted
/var/log                 : already mounted
/var/opt                 : already mounted
/var/spool               : already mounted
/var/tmp                 : already mounted
mount.nfs: timeout set for Sat Jan 13 09:15:06 2018
mount.nfs: trying text-based options 'soft,timeo=50,retrans=5,actimeo=10,retry=5,vers=4,addr=172.18.0.1,clientaddr=172.18.0.81'
/storage                 : successfully mounted
/backup                  : ignored
/home/pane/Documents     : already mounted
/home/pane/Downloads     : already mounted
/home/pane/finanzen      : already mounted
/home/pane/.gnupg        : already mounted
linux-a6jk:~ #

> ...
> > Jan 13 09:05:49 linux-a6jk systemd[1]: nss-lookup.target:
> > Dependency Before=nss-lookup.target dropped Jan 13 09:05:49
> > linux-a6jk systemd[1]: wicked.service: Found ordering cycle on
> > wicked.service/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > wicked.service: Found dependency on wickedd-nanny.service/start Jan
> > 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found dependency
> > on local-fs.target/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > wicked.service: Found dependency on home-pane-.gnupg.mount/start
> > Jan 13 09:05:49 linux-a6jk systemd[1]: wicked.service: Found
> > dependency on storage.mount/start Jan 13 09:05:49 linux-a6jk
> > systemd[1]: wicked.service: Found dependency on
> > network.target/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > wicked.service: Found dependency on wicked.service/start Jan 13
> > 09:05:49 linux-a6jk systemd[1]: wicked.service: Breaking ordering
> > cycle by deleting job wickedd-nanny.service/start Jan 13 09:05:49
> > linux-a6jk systemd[1]: wickedd-nanny.service: Job
> > wickedd-nanny.service/start deleted to break ordering cycle
> > starting with wicked.service/start Jan 13 09:05:49 linux-a6jk
> > systemd[1]: sysinit.target: Found ordering cycle on
> > sysinit.target/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > sysinit.target: Found dependency on local-fs.target/start Jan 13
> > 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on
> > home-pane-.gnupg.mount/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > sysinit.target: Found dependency on storage.mount/start Jan 13
> > 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on
> > network.target/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > sysinit.target: Found dependency on wicked.service/start Jan 13
> > 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency on
> > wickedd.service/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > sysinit.target: Found dependency on wickedd-dhcp4.service/start Jan
> > 13 09:05:49 linux-a6jk systemd[1]: sysinit.target: Found dependency
> > on sysinit.target/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > sysinit.target: Breaking ordering cycle by deleting job
> > local-fs.target/start Jan 13 09:05:49 linux-a6jk systemd[1]:
> > local-fs.target: Job local-fs.target/start deleted to break
> > ordering cycle starting with sysinit.target/start  
>
> you have dependency loop apparently due ti /home/pane/.gnupg mount.
> Please show /etc/fstab line for this filesystem. Is it on iSCSI?
>

interesting... that could be the cause (also for the other machines...)
the relevant lines are:
alpha.swabian.net:/storage    /storage   nfs    soft,timeo=50,retrans=5,actimeo=10,retry=5,nofail    0    0
/storage/pane/.gnupg    /home/pane/.gnupg       none defaults,bind,auto      0       0

but I do not understand why.
It's on NFS, or better to say a bind mount to a NFS directory.

mount says:
alpha.swabian.net:/storage on /storage type nfs4
(rw,relatime,vers=4.0,rsize=1048576,wsize=1048576,namlen=255,acregmin=10,acregmax=10,acdirmin=10,acdirmax=10,soft,proto=tcp,port=0,timeo=50,retrans=5,sec=sys,clientaddr=172.18.0.81,local_lock=none,addr=172.18.0.1)
alpha.swabian.net:/storage/pane/.gnupg on /home/pane/.gnupg type nfs4
(rw,relatime,vers=4.0,rsize=1048576,wsize=1048576,namlen=255,acregmin=10,acregmax=10,acdirmin=10,acdirmax=10,soft,proto=tcp,port=0,timeo=50,retrans=5,sec=sys,clientaddr=172.18.0.81,local_lock=none,addr=172.18.0.1)


--
To unsubscribe, e-mail: [hidden email]
To contact the owner, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

Re: wicked fails on boot due to read-only mount?

Andrei Borzenkov
13.01.2018 11:42, Paul Neuwirth пишет:
...

>>
>> you have dependency loop apparently due ti /home/pane/.gnupg mount.
>> Please show /etc/fstab line for this filesystem. Is it on iSCSI?
>>
>
> interesting... that could be the cause (also for the other machines...)
> the relevant lines are:
> alpha.swabian.net:/storage    /storage   nfs    soft,timeo=50,retrans=5,actimeo=10,retry=5,nofail    0    0
> /storage/pane/.gnupg    /home/pane/.gnupg       none defaults,bind,auto      0       0
>

Try adding _netdev to /home/pane/.gnupg options, so it will be ordered
after networking is up.

> but I do not understand why.
> It's on NFS, or better to say a bind mount to a NFS directory.
>
> mount says:
> alpha.swabian.net:/storage on /storage type nfs4
> (rw,relatime,vers=4.0,rsize=1048576,wsize=1048576,namlen=255,acregmin=10,acregmax=10,acdirmin=10,acdirmax=10,soft,proto=tcp,port=0,timeo=50,retrans=5,sec=sys,clientaddr=172.18.0.81,local_lock=none,addr=172.18.0.1)
> alpha.swabian.net:/storage/pane/.gnupg on /home/pane/.gnupg type nfs4
> (rw,relatime,vers=4.0,rsize=1048576,wsize=1048576,namlen=255,acregmin=10,acregmax=10,acdirmin=10,acdirmax=10,soft,proto=tcp,port=0,timeo=50,retrans=5,sec=sys,clientaddr=172.18.0.81,local_lock=none,addr=172.18.0.1)
>


--
To unsubscribe, e-mail: [hidden email]
To contact the owner, e-mail: [hidden email]

Reply | Threaded
Open this post in threaded view
|

Re: wicked fails on boot due to read-only mount?

Paul Neuwirth-3
On Sat, 13 Jan 2018 12:10:13 +0300
Andrei Borzenkov <[hidden email]> wrote:

> 13.01.2018 11:42, Paul Neuwirth пишет:
> ...
> >>
> >> you have dependency loop apparently due ti /home/pane/.gnupg mount.
> >> Please show /etc/fstab line for this filesystem. Is it on iSCSI?
> >>  
> >
> > interesting... that could be the cause (also for the other
> > machines...) the relevant lines are:
> > alpha.swabian.net:/storage    /storage   nfs
> > soft,timeo=50,retrans=5,actimeo=10,retry=5,nofail    0
> > 0 /storage/pane/.gnupg    /home/pane/.gnupg       none
> > defaults,bind,auto      0       0
>
> Try adding _netdev to /home/pane/.gnupg options, so it will be ordered
> after networking is up.
>
that actually did the trick. boot went perfectly fine. great, thanks.

--
To unsubscribe, e-mail: [hidden email]
To contact the owner, e-mail: [hidden email]