[opensuse] wicked fails on boot due to read-only mount?
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: dm-devel@redhat.com 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: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org
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: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org
On Sat, 13 Jan 2018 11:27:57 +0300 Andrei Borzenkov <arvidjaar@gmail.com> 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: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org
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: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org
On Sat, 13 Jan 2018 12:10:13 +0300 Andrei Borzenkov <arvidjaar@gmail.com> 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: opensuse+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse+owner@opensuse.org
participants (2)
-
Andrei Borzenkov -
Paul Neuwirth