You are not logged in.

#1 2013-09-21 16:52:30

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Much slower boot speed after upgrading to systemd-207

As subject says, i am experiencing a double boot time after upgrading to systemd-207.
Before update boot time:~13sec
After update: Startup finished in 566ms (kernel) + 3.007s (initrd) + 20.723s (userspace) = 24.298s

The only thing i changed was removing the timestamp and udev hooks and adding systemd hook in mkinitcpio.conf:

HOOKS="base systemd autodetect keyboard keymap modconf block filesystems fsck shutdown"

In the boot screen, it hags for 6-7 seconds in Socket  creation...maybe it's relevant.

systemd-analyze blame shows:

2.244s systemd-vconsole-setup.service
1.103s kmod-static-nodes.service
1.095s dev-hugepages.mount
1.095s sys-kernel-debug.mount
1.095s dev-mqueue.mount
 959ms systemd-fsck@dev-disk-by\x2duuid-152477bd\x2d9112\x2d4613\x2d8f48\x2d7f5c4aee074f.service
 761ms netctl-auto@wlan.service
 548ms systemd-sysctl.service
 423ms systemd-udevd.service
 415ms systemd-tmpfiles-clean.service
 332ms alsa-restore.service
 314ms systemd-update-utmp.service
 273ms systemd-random-seed.service
 212ms systemd-logind.service
 203ms systemd-remount-fs.service
 179ms user@1000.service
 139ms sys-kernel-config.mount
 134ms systemd-readahead-replay.service
  99ms systemd-udev-trigger.service
  83ms systemd-user-sessions.service
  42ms systemd-tmpfiles-setup-dev.service
  37ms tmp.mount
  33ms systemd-tmpfiles-setup.service
  21ms systemd-readahead-collect.service
  21ms dev-disk-by\x2duuid-14c7b2fa\x2de6ed\x2d49aa\x2daa56\x2d8b32947d3812.swap
   7ms boot.mount
   7ms systemd-backlight@acpi_video0.service
   4ms systemd-readahead-done.service
   2ms systemd-journal-flush.service

journalctl shows these errors:

Cannot add dependency job for unit local-fs.target, ignoring: Unit local-fs.target failed to load: No such file or directory
Cannot add dependency job for unit swap.target, ignoring: Unit swap.target failed to load: No such file or directory. 
Cannot add dependency job for unit timers.target, ignoring: Unit timers.target failed to load: No such file or directory.
Cannot add dependency job for unit paths.target, ignoring: Unit paths.target failed to load: No such file or directory.
Cannot add dependency job for unit slices.target, ignoring: Unit slices.target failed to load: No such file or directory.
...
Failed to open private bus connection: Failed to connect to socket /var/run/dbus/system_bus_socket: No such file or directory.
Failed to open private bus connection: Failed to connect to socket /run/user/1000/dbus/user_bus_socket: No such file or directory.

But all these .target files exist in /usr/lib/systemd/system, and i these sockets also exist in their respective paths. Any ideas?


-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#2 2013-09-24 21:43:55

Pse
Member
Registered: 2008-03-15
Posts: 413

Re: Much slower boot speed after upgrading to systemd-207

What's the output of 'systemd-analyze critical-chain'?

Offline

#3 2013-09-24 22:36:13

cfr
Member
From: Cymru
Registered: 2011-11-27
Posts: 7,148

Re: Much slower boot speed after upgrading to systemd-207

Can you give some context for those journalctl errors?


CLI Paste | How To Ask Questions

Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L

Offline

#4 2013-09-26 11:07:14

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

Pse wrote:

What's the output of 'systemd-analyze critical-chain'?

Here it is:

The time after the unit is active or started is printed after the "@" character.
The time the unit takes to start is printed after the "+" character.

multi-user.target @28.375s
└─systemd-logind.service @28.147s +90ms
  └─basic.target @28.130s
    └─timers.target @28.091s
      └─systemd-tmpfiles-clean.timer @7.012s
        └─sysinit.target @7.008s
          └─systemd-update-utmp.service @6.997s +9ms
            └─systemd-tmpfiles-setup.service @6.959s +35ms
              └─local-fs.target @6.957s
                └─boot.mount @6.941s +14ms
                  └─systemd-fsck@dev-disk-by\x2duuid-152477bd\x2d9112\x2d4613\x2d8f48\x2d7f5c4aee074f.service @6.451s +435ms
                    └─dev-disk-by\x2duuid-152477bd\x2d9112\x2d4613\x2d8f48\x2d7f5c4aee074f.device @6.448s

-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#5 2013-09-26 11:12:55

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

cfr wrote:

Can you give some context for those journalctl errors?

Not sure of what you ask, so i pasted all journalctl --this-boot:

-- Logs begin at Mon 2012-12-03 20:05:08 EET, end at Thu 2013-09-26 14:09:05 EEST. --
Sep 26 13:59:28 localhost systemd-journal[40]: Runtime journal is using 704.0K (max 195.5M, leaving 293.2M of free 1.9G, current limit 195.5M).
Sep 26 13:59:28 localhost systemd-journal[40]: Runtime journal is using 704.0K (max 195.5M, leaving 293.2M of free 1.9G, current limit 195.5M).
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys cpuset
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys cpu
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys cpuacct
Sep 26 13:59:28 localhost kernel: Linux version 3.11.1-2-ARCH (tobias@T-POWA-LX) (gcc version 4.8.1 20130725 (prerelease) (GCC) ) #1 SMP PREEMPT Sun Sep 22 19:45:00 CEST 2013
Sep 26 13:59:28 localhost kernel: Command line: root=/dev/sda6 rw libahci.ignore_sss=1 initrd=../initramfs-linux.img BOOT_IMAGE=../vmlinuz-linux 
Sep 26 13:59:28 localhost kernel: e820: BIOS-provided physical RAM map:
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009bbff] usable
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x000000000009bc00-0x000000000009ffff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000dd04d3ff] usable
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000dd04d400-0x00000000dd04f3ff] ACPI NVS
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000dd04f400-0x00000000dfffffff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000f8000000-0x00000000fbffffff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec0ffff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000fed18000-0x00000000fed1bfff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000fed20000-0x00000000fed8ffff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000feda0000-0x00000000feda5fff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee0ffff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x00000000ffe60000-0x00000000ffffffff] reserved
Sep 26 13:59:28 localhost kernel: BIOS-e820: [mem 0x0000000100000000-0x000000011fffffff] usable
Sep 26 13:59:28 localhost kernel: NX (Execute Disable) protection: active
Sep 26 13:59:28 localhost kernel: SMBIOS 2.4 present.
Sep 26 13:59:28 localhost kernel: DMI: Dell Inc. Latitude E4300                  /0WR116, BIOS A23 09/27/2011
Sep 26 13:59:28 localhost kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Sep 26 13:59:28 localhost kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
Sep 26 13:59:28 localhost kernel: No AGP bridge found
Sep 26 13:59:28 localhost kernel: e820: last_pfn = 0x120000 max_arch_pfn = 0x400000000
Sep 26 13:59:28 localhost kernel: MTRR default type: uncachable
Sep 26 13:59:28 localhost kernel: MTRR fixed ranges enabled:
Sep 26 13:59:28 localhost kernel:   00000-9FFFF write-back
Sep 26 13:59:28 localhost kernel:   A0000-BFFFF uncachable
Sep 26 13:59:28 localhost kernel:   C0000-D7FFF write-protect
Sep 26 13:59:28 localhost kernel:   D8000-EFFFF uncachable
Sep 26 13:59:28 localhost kernel:   F0000-FFFFF write-protect
Sep 26 13:59:28 localhost kernel: MTRR variable ranges enabled:
Sep 26 13:59:28 localhost kernel:   0 base 000000000 mask 800000000 write-back
Sep 26 13:59:28 localhost kernel:   1 base 0E0000000 mask FE0000000 uncachable
Sep 26 13:59:28 localhost kernel:   2 base 0DDC00000 mask FFFC00000 uncachable
Sep 26 13:59:28 localhost kernel:   3 base 0DE000000 mask FFE000000 uncachable
Sep 26 13:59:28 localhost kernel:   4 disabled
Sep 26 13:59:28 localhost kernel:   5 disabled
Sep 26 13:59:28 localhost kernel:   6 disabled
Sep 26 13:59:28 localhost kernel: x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
Sep 26 13:59:28 localhost kernel: e820: update [mem 0xddc00000-0xffffffff] usable ==> reserved
Sep 26 13:59:28 localhost kernel: e820: last_pfn = 0xdd04d max_arch_pfn = 0x400000000
Sep 26 13:59:28 localhost kernel: Scanning 1 areas for low memory corruption
Sep 26 13:59:28 localhost kernel: Base memory trampoline at [ffff880000095000] 95000 size 24576
Sep 26 13:59:28 localhost kernel: init_memory_mapping: [mem 0x00000000-0x000fffff]
Sep 26 13:59:28 localhost kernel:  [mem 0x00000000-0x000fffff] page 4k
Sep 26 13:59:28 localhost kernel: BRK [0x01b2d000, 0x01b2dfff] PGTABLE
Sep 26 13:59:28 localhost kernel: BRK [0x01b2e000, 0x01b2efff] PGTABLE
Sep 26 13:59:28 localhost kernel: BRK [0x01b2f000, 0x01b2ffff] PGTABLE
Sep 26 13:59:28 localhost kernel: init_memory_mapping: [mem 0x11fe00000-0x11fffffff]
Sep 26 13:59:28 localhost kernel:  [mem 0x11fe00000-0x11fffffff] page 2M
Sep 26 13:59:28 localhost kernel: BRK [0x01b30000, 0x01b30fff] PGTABLE
Sep 26 13:59:28 localhost kernel: init_memory_mapping: [mem 0x11c000000-0x11fdfffff]
Sep 26 13:59:28 localhost kernel:  [mem 0x11c000000-0x11fdfffff] page 2M
Sep 26 13:59:28 localhost kernel: init_memory_mapping: [mem 0x100000000-0x11bffffff]
Sep 26 13:59:28 localhost kernel:  [mem 0x100000000-0x11bffffff] page 2M
Sep 26 13:59:28 localhost kernel: init_memory_mapping: [mem 0x00100000-0xdd04cfff]
Sep 26 13:59:28 localhost kernel:  [mem 0x00100000-0x001fffff] page 4k
Sep 26 13:59:28 localhost kernel:  [mem 0x00200000-0xdcffffff] page 2M
Sep 26 13:59:28 localhost kernel:  [mem 0xdd000000-0xdd04cfff] page 4k
Sep 26 13:59:28 localhost kernel: RAMDISK: [mem 0x7fb30000-0x7fffefff]
Sep 26 13:59:28 localhost kernel: ACPI: RSDP 00000000000fb9f0 00024 (v02 DELL  )
Sep 26 13:59:28 localhost kernel: ACPI: XSDT 00000000dd051e00 00074 (v01 DELL    M09     27DB091B ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: FACP 00000000dd051c9c 000F4 (v04 DELL    M09     27DB091B ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: DSDT 00000000dd052400 068DD (v02 INT430 SYSFexxx 00001001 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: FACS 00000000dd060c00 00040
Sep 26 13:59:28 localhost kernel: ACPI: HPET 00000000dd051f00 00038 (v01 DELL    M09     00000001 ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: DMAR 00000000dd060400 000F8 (v01 DELL    M09     27DB091B ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: APIC 00000000dd052000 00068 (v01 DELL    M09     27DB091B ASL  00000047)
Sep 26 13:59:28 localhost kernel: ACPI: ASF! 00000000dd051c00 0006A (v32 DELL    M09     27DB091B ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: MCFG 00000000dd051fc0 0003C (v16 DELL    M09     27DB091B ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: TCPA 00000000dd052300 00032 (v01                 00000000 ASL  00000000)
Sep 26 13:59:28 localhost kernel: ACPI: SLIC 00000000dd05209c 00176 (v01 DELL    M09     27DB091B ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: BOOT 00000000dd051bc0 00028 (v01 DELL    M09     27DB091B ASL  00000061)
Sep 26 13:59:28 localhost kernel: ACPI: SSDT 00000000dd050331 0066C (v01  PmRef    CpuPm 00003000 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: Local APIC address 0xfee00000
Sep 26 13:59:28 localhost kernel: No NUMA configuration found
Sep 26 13:59:28 localhost kernel: Faking a node at [mem 0x0000000000000000-0x000000011fffffff]
Sep 26 13:59:28 localhost kernel: Initmem setup node 0 [mem 0x00000000-0x11fffffff]
Sep 26 13:59:28 localhost kernel:   NODE_DATA [mem 0x11fff7000-0x11fffbfff]
Sep 26 13:59:28 localhost kernel:  [ffffea0000000000-ffffea00047fffff] PMD -> [ffff88011b600000-ffff88011f5fffff] on node 0
Sep 26 13:59:28 localhost kernel: Zone ranges:
Sep 26 13:59:28 localhost kernel:   DMA      [mem 0x00001000-0x00ffffff]
Sep 26 13:59:28 localhost kernel:   DMA32    [mem 0x01000000-0xffffffff]
Sep 26 13:59:28 localhost kernel:   Normal   [mem 0x100000000-0x11fffffff]
Sep 26 13:59:28 localhost kernel: Movable zone start for each node
Sep 26 13:59:28 localhost kernel: Early memory node ranges
Sep 26 13:59:28 localhost kernel:   node   0: [mem 0x00001000-0x0009afff]
Sep 26 13:59:28 localhost kernel:   node   0: [mem 0x00100000-0xdd04cfff]
Sep 26 13:59:28 localhost kernel:   node   0: [mem 0x100000000-0x11fffffff]
Sep 26 13:59:28 localhost kernel: On node 0 totalpages: 1036263
Sep 26 13:59:28 localhost kernel:   DMA zone: 64 pages used for memmap
Sep 26 13:59:28 localhost kernel:   DMA zone: 21 pages reserved
Sep 26 13:59:28 localhost kernel:   DMA zone: 3994 pages, LIFO batch:0
Sep 26 13:59:28 localhost kernel:   DMA32 zone: 14082 pages used for memmap
Sep 26 13:59:28 localhost kernel:   DMA32 zone: 901197 pages, LIFO batch:31
Sep 26 13:59:28 localhost kernel:   Normal zone: 2048 pages used for memmap
Sep 26 13:59:28 localhost kernel:   Normal zone: 131072 pages, LIFO batch:31
Sep 26 13:59:28 localhost kernel: ACPI: PM-Timer IO Port: 0x1008
Sep 26 13:59:28 localhost kernel: ACPI: Local APIC address 0xfee00000
Sep 26 13:59:28 localhost kernel: ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
Sep 26 13:59:28 localhost kernel: ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
Sep 26 13:59:28 localhost kernel: ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
Sep 26 13:59:28 localhost kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
Sep 26 13:59:28 localhost kernel: ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
Sep 26 13:59:28 localhost kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
Sep 26 13:59:28 localhost kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
Sep 26 13:59:28 localhost kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
Sep 26 13:59:28 localhost kernel: ACPI: IRQ0 used by override.
Sep 26 13:59:28 localhost kernel: ACPI: IRQ2 used by override.
Sep 26 13:59:28 localhost kernel: ACPI: IRQ9 used by override.
Sep 26 13:59:28 localhost kernel: Using ACPI (MADT) for SMP configuration information
Sep 26 13:59:28 localhost kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000
Sep 26 13:59:28 localhost kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs
Sep 26 13:59:28 localhost kernel: nr_irqs_gsi: 40
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0x0009b000-0x0009bfff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0x0009c000-0x0009ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0x000a0000-0x000fffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xdd04d000-0xdd04dfff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xdd04e000-0xdd04efff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xdd04f000-0xdd04ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xdd050000-0xdfffffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xe0000000-0xf7ffffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xf8000000-0xfbffffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfc000000-0xfebfffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfec00000-0xfec0ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfec10000-0xfed17fff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfed18000-0xfed1bfff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfed1c000-0xfed1ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfed20000-0xfed8ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfed90000-0xfed9ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfeda0000-0xfeda5fff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfeda6000-0xfedfffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfee00000-0xfee0ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xfee10000-0xffe5ffff]
Sep 26 13:59:28 localhost kernel: PM: Registered nosave memory: [mem 0xffe60000-0xffffffff]
Sep 26 13:59:28 localhost kernel: e820: [mem 0xe0000000-0xf7ffffff] available for PCI devices
Sep 26 13:59:28 localhost kernel: Booting paravirtualized kernel on bare hardware
Sep 26 13:59:28 localhost kernel: setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:2 nr_node_ids:1
Sep 26 13:59:28 localhost kernel: PERCPU: Embedded 29 pages/cpu @ffff88011fc00000 s86528 r8192 d24064 u1048576
Sep 26 13:59:28 localhost kernel: pcpu-alloc: s86528 r8192 d24064 u1048576 alloc=1*2097152
Sep 26 13:59:28 localhost kernel: pcpu-alloc: [0] 0 1 
Sep 26 13:59:28 localhost kernel: Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1020048
Sep 26 13:59:28 localhost kernel: Policy zone: Normal
Sep 26 13:59:28 localhost kernel: Kernel command line: root=/dev/sda6 rw libahci.ignore_sss=1 initrd=../initramfs-linux.img BOOT_IMAGE=../vmlinuz-linux 
Sep 26 13:59:28 localhost kernel: PID hash table entries: 4096 (order: 3, 32768 bytes)
Sep 26 13:59:28 localhost kernel: Checking aperture...
Sep 26 13:59:28 localhost kernel: No AGP bridge found
Sep 26 13:59:28 localhost kernel: Calgary: detecting Calgary via BIOS EBDA area
Sep 26 13:59:28 localhost kernel: Calgary: Unable to locate Rio Grande table in EBDA - bailing!
Sep 26 13:59:28 localhost kernel: Memory: 3996472K/4145052K available (5045K kernel code, 795K rwdata, 1696K rodata, 1140K init, 1284K bss, 148580K reserved)
Sep 26 13:59:28 localhost kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Sep 26 13:59:28 localhost kernel: Preemptible hierarchical RCU implementation.
Sep 26 13:59:28 localhost kernel:         RCU dyntick-idle grace-period acceleration is enabled.
Sep 26 13:59:28 localhost kernel:         Dump stacks of tasks blocking RCU-preempt GP.
Sep 26 13:59:28 localhost kernel:         RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2.
Sep 26 13:59:28 localhost kernel: NR_IRQS:4352 nr_irqs:512 16
Sep 26 13:59:28 localhost kernel: Console: colour VGA+ 80x25
Sep 26 13:59:28 localhost kernel: console [tty0] enabled
Sep 26 13:59:28 localhost kernel: allocated 16777216 bytes of page_cgroup
Sep 26 13:59:28 localhost kernel: please try 'cgroup_disable=memory' option if you don't want memory cgroups
Sep 26 13:59:28 localhost kernel: hpet clockevent registered
Sep 26 13:59:28 localhost kernel: tsc: Fast TSC calibration using PIT
Sep 26 13:59:28 localhost kernel: tsc: Detected 2261.036 MHz processor
Sep 26 13:59:28 localhost kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4523.49 BogoMIPS (lpj=7536786)
Sep 26 13:59:28 localhost kernel: pid_max: default: 32768 minimum: 301
Sep 26 13:59:28 localhost kernel: Security Framework initialized
Sep 26 13:59:28 localhost kernel: AppArmor: AppArmor disabled by boot time parameter
Sep 26 13:59:28 localhost kernel: Yama: becoming mindful.
Sep 26 13:59:28 localhost kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
Sep 26 13:59:28 localhost kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
Sep 26 13:59:28 localhost kernel: Mount-cache hash table entries: 256
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys memory
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys devices
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys freezer
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys net_cls
Sep 26 13:59:28 localhost kernel: Initializing cgroup subsys blkio
Sep 26 13:59:28 localhost kernel: CPU: Physical Processor ID: 0
Sep 26 13:59:28 localhost kernel: CPU: Processor Core ID: 0
Sep 26 13:59:28 localhost kernel: mce: CPU supports 6 MCE banks
Sep 26 13:59:28 localhost kernel: CPU0: Thermal monitoring enabled (TM2)
Sep 26 13:59:28 localhost kernel: Last level iTLB entries: 4KB 128, 2MB 4, 4MB 4
                                  Last level dTLB entries: 4KB 256, 2MB 0, 4MB 32
                                  tlb_flushall_shift: -1
Sep 26 13:59:28 localhost kernel: Freeing SMP alternatives memory: 20K (ffffffff819e5000 - ffffffff819ea000)
Sep 26 13:59:28 localhost kernel: ACPI: Core revision 20130517
Sep 26 13:59:28 localhost kernel: ACPI: All ACPI Tables successfully acquired
Sep 26 13:59:28 localhost kernel: ftrace: allocating 20088 entries in 79 pages
Sep 26 13:59:28 localhost kernel: dmar: Host address width 36
Sep 26 13:59:28 localhost kernel: dmar: DRHD base: 0x000000fed10000 flags: 0x0
Sep 26 13:59:28 localhost kernel: dmar: IOMMU 0: reg_base_addr fed10000 ver 1:0 cap c9008020e30260 ecap 1000
Sep 26 13:59:28 localhost kernel: dmar: DRHD base: 0x000000fed11000 flags: 0x0
Sep 26 13:59:28 localhost kernel: dmar: IOMMU 1: reg_base_addr fed11000 ver 1:0 cap c0000020630260 ecap 1000
Sep 26 13:59:28 localhost kernel: dmar: DRHD base: 0x000000fed13000 flags: 0x1
Sep 26 13:59:28 localhost kernel: dmar: IOMMU 2: reg_base_addr fed13000 ver 1:0 cap c9008020630260 ecap 1000
Sep 26 13:59:28 localhost kernel: dmar: RMRR base: 0x000000dd7e7000 end: 0x000000dd7fffff
Sep 26 13:59:28 localhost kernel: dmar: RMRR base: 0x000000ddc00000 end: 0x000000dfffffff
Sep 26 13:59:28 localhost kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
Sep 26 13:59:28 localhost kernel: smpboot: CPU0: Intel(R) Core(TM)2 Duo CPU     P9300  @ 2.26GHz (fam: 06, model: 17, stepping: 06)
Sep 26 13:59:28 localhost kernel: Performance Events: PEBS fmt0+, 4-deep LBR, Core2 events, Intel PMU driver.
Sep 26 13:59:28 localhost kernel: ... version:                2
Sep 26 13:59:28 localhost kernel: ... bit width:              40
Sep 26 13:59:28 localhost kernel: ... generic registers:      2
Sep 26 13:59:28 localhost kernel: ... value mask:             000000ffffffffff
Sep 26 13:59:28 localhost kernel: ... max period:             000000007fffffff
Sep 26 13:59:28 localhost kernel: ... fixed-purpose events:   3
Sep 26 13:59:28 localhost kernel: ... event mask:             0000000700000003
Sep 26 13:59:28 localhost kernel: smpboot: Booting Node   0, Processors  #1 OK
Sep 26 13:59:28 localhost kernel: NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
Sep 26 13:59:28 localhost kernel: Brought up 2 CPUs
Sep 26 13:59:28 localhost kernel: smpboot: Total of 2 processors activated (9047.98 BogoMIPS)
Sep 26 13:59:28 localhost kernel: devtmpfs: initialized
Sep 26 13:59:28 localhost kernel: PM: Registering ACPI NVS region [mem 0xdd04d400-0xdd04f3ff] (8192 bytes)
Sep 26 13:59:28 localhost kernel: RTC time: 10:59:27, date: 09/26/13
Sep 26 13:59:28 localhost kernel: NET: Registered protocol family 16
Sep 26 13:59:28 localhost kernel: ACPI: bus type PCI registered
Sep 26 13:59:28 localhost kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Sep 26 13:59:28 localhost kernel: PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf8000000-0xfbffffff] (base 0xf8000000)
Sep 26 13:59:28 localhost kernel: PCI: MMCONFIG at [mem 0xf8000000-0xfbffffff] reserved in E820
Sep 26 13:59:28 localhost kernel: PCI: Using configuration type 1 for base access
Sep 26 13:59:28 localhost kernel: dmi type 0xB1 record - unknown flag
Sep 26 13:59:28 localhost kernel: bio: create slab <bio-0> at 0
Sep 26 13:59:28 localhost kernel: ACPI: Added _OSI(Module Device)
Sep 26 13:59:28 localhost kernel: ACPI: Added _OSI(Processor Device)
Sep 26 13:59:28 localhost kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Sep 26 13:59:28 localhost kernel: ACPI: Added _OSI(Processor Aggregator Device)
Sep 26 13:59:28 localhost kernel: ACPI: EC: Look up EC in DSDT
Sep 26 13:59:28 localhost kernel: [Firmware Bug]: ACPI: BIOS _OSI(Linux) query ignored
Sep 26 13:59:28 localhost kernel: ACPI: SSDT 00000000dd05099d 00281 (v01  PmRef   BspIst 00003000 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: Dynamic OEM Table Load:
Sep 26 13:59:28 localhost kernel: ACPI: SSDT           (null) 00281 (v01  PmRef   BspIst 00003000 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: SSDT 00000000dd050df5 005C6 (v01  PmRef   BspCst 00003001 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: Dynamic OEM Table Load:
Sep 26 13:59:28 localhost kernel: ACPI: SSDT           (null) 005C6 (v01  PmRef   BspCst 00003001 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: SSDT 00000000dd050c1e 001D7 (v01  PmRef    ApIst 00003000 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: Dynamic OEM Table Load:
Sep 26 13:59:28 localhost kernel: ACPI: SSDT           (null) 001D7 (v01  PmRef    ApIst 00003000 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: SSDT 00000000dd0513bb 0008D (v01  PmRef    ApCst 00003000 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: Dynamic OEM Table Load:
Sep 26 13:59:28 localhost kernel: ACPI: SSDT           (null) 0008D (v01  PmRef    ApCst 00003000 INTL 20050624)
Sep 26 13:59:28 localhost kernel: ACPI: Interpreter enabled
Sep 26 13:59:28 localhost kernel: ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20130517/hwxface-571)
Sep 26 13:59:28 localhost kernel: ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20130517/hwxface-571)
Sep 26 13:59:28 localhost kernel: ACPI: (supports S0 S3 S4 S5)
Sep 26 13:59:28 localhost kernel: ACPI: Using IOAPIC for interrupt routing
Sep 26 13:59:28 localhost kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
Sep 26 13:59:28 localhost kernel: ACPI: No dock devices found.
Sep 26 13:59:28 localhost kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
Sep 26 13:59:28 localhost kernel: acpi PNP0A03:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge
Sep 26 13:59:28 localhost kernel: PCI host bridge to bus 0000:00
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0x000d8000-0x000dffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xe0000000-0xf7ffffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xfc000000-0xfebfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xfec10000-0xfecfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xfed1c000-0xfed1ffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xfed90000-0xfed9ffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xfed40000-0xfed44fff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xfeda7000-0xfedfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xfee10000-0xff9fffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: root bus resource [mem 0xffc00000-0xffdfffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:00.0: [8086:2a40] type 00 class 0x060000
Sep 26 13:59:28 localhost kernel: DMAR: Forcing write-buffer flush capability
Sep 26 13:59:28 localhost kernel: DMAR: Disabling IOMMU for graphics on this chipset
Sep 26 13:59:28 localhost kernel: pci 0000:00:02.0: [8086:2a42] type 00 class 0x030000
Sep 26 13:59:28 localhost kernel: pci 0000:00:02.0: reg 0x10: [mem 0xf6c00000-0xf6ffffff 64bit]
Sep 26 13:59:28 localhost kernel: pci 0000:00:02.0: reg 0x18: [mem 0xe0000000-0xefffffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci 0000:00:02.0: reg 0x20: [io  0xef98-0xef9f]
Sep 26 13:59:28 localhost kernel: pci 0000:00:02.1: [8086:2a43] type 00 class 0x038000
Sep 26 13:59:28 localhost kernel: pci 0000:00:02.1: reg 0x10: [mem 0xf6b00000-0xf6bfffff 64bit]
Sep 26 13:59:28 localhost kernel: pci 0000:00:19.0: [8086:10f5] type 00 class 0x020000
Sep 26 13:59:28 localhost kernel: pci 0000:00:19.0: reg 0x10: [mem 0xf6ae0000-0xf6afffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:19.0: reg 0x14: [mem 0xf6adb000-0xf6adbfff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:19.0: reg 0x18: [io  0xefe0-0xefff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:19.0: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.0: [8086:2937] type 00 class 0x0c0300
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.0: reg 0x20: [io  0x6f60-0x6f7f]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.0: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.1: [8086:2938] type 00 class 0x0c0300
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.1: reg 0x20: [io  0x6f80-0x6f9f]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.1: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.2: [8086:2939] type 00 class 0x0c0300
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.2: reg 0x20: [io  0x6fa0-0x6fbf]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.2: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.7: [8086:293c] type 00 class 0x0c0320
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.7: reg 0x10: [mem 0xfed1c400-0xfed1c7ff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.7: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1a.7: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1b.0: [8086:293e] type 00 class 0x040300
Sep 26 13:59:28 localhost kernel: pci 0000:00:1b.0: reg 0x10: [mem 0xf6adc000-0xf6adffff 64bit]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1b.0: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: [8086:2940] type 01 class 0x060400
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: [8086:2942] type 01 class 0x060400
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3: [8086:2946] type 01 class 0x060400
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.0: reg 0x20: [io  0x6f00-0x6f1f]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.0: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.1: reg 0x20: [io  0x6f20-0x6f3f]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.1: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.2: reg 0x20: [io  0x6f40-0x6f5f]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.2: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.7: reg 0x10: [mem 0xfed1c000-0xfed1c3ff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1d.7: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0: [8086:2448] type 01 class 0x060401
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0: System wakeup disabled by ACPI
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.0: [8086:2917] type 00 class 0x060100
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: [8086:282a] type 00 class 0x010400
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: reg 0x10: [io  0x6e70-0x6e77]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: reg 0x14: [io  0x6e78-0x6e7b]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: reg 0x18: [io  0x6e80-0x6e87]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: reg 0x1c: [io  0x6e88-0x6e8b]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: reg 0x20: [io  0x6ea0-0x6ebf]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfed1c800-0xfed1cfff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.2: PME# supported from D3hot
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.3: reg 0x10: [mem 0xf6adaf00-0xf6adafff 64bit]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1f.3: reg 0x20: [io  0x1100-0x111f]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: PCI bridge to [bus 0b]
Sep 26 13:59:28 localhost kernel: pci 0000:0c:00.0: [14e4:432b] type 00 class 0x028000
Sep 26 13:59:28 localhost kernel: pci 0000:0c:00.0: reg 0x10: [mem 0xf69fc000-0xf69fffff 64bit]
Sep 26 13:59:28 localhost kernel: pci 0000:0c:00.0: supports D1 D2
Sep 26 13:59:28 localhost kernel: pci 0000:0c:00.0: PME# supported from D0 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: PCI bridge to [bus 0c]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1:   bridge window [mem 0xf6900000-0xf69fffff]
Sep 26 13:59:28 localhost kernel: acpiphp: Slot [1] registered
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3: PCI bridge to [bus 0d-0e]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3:   bridge window [io  0xd000-0xdfff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3:   bridge window [mem 0xf6600000-0xf68fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3:   bridge window [mem 0xf0000000-0xf01fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.0: [1180:0832] type 00 class 0x0c0010
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.0: reg 0x10: [mem 0xf65ff800-0xf65fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.0: supports D1 D2
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.0: PME# supported from D0 D1 D2 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.1: [1180:0822] type 00 class 0x080501
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.1: reg 0x10: [mem 0xf65ff700-0xf65ff7ff]
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.1: supports D1 D2
Sep 26 13:59:28 localhost kernel: pci 0000:02:01.1: PME# supported from D0 D1 D2 D3hot D3cold
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0: PCI bridge to [bus 02] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xf6500000-0xf65fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [io  0x0000-0x0cf7] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [io  0x0d00-0xffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0x000a0000-0x000bffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0x000d8000-0x000dffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xe0000000-0xf7ffffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xfc000000-0xfebfffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xfec10000-0xfecfffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xfed1c000-0xfed1ffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xfed90000-0xfed9ffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xfed40000-0xfed44fff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xfeda7000-0xfedfffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xfee10000-0xff9fffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xffc00000-0xffdfffff] (subtractive decode)
Sep 26 13:59:28 localhost kernel: acpi PNP0A03:00: ACPI _OSC support notification failed, disabling PCIe ASPM
Sep 26 13:59:28 localhost kernel: acpi PNP0A03:00: Unable to request _OSC control (_OSC support mask: 0x08)
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 10 *11)
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 5 7) *3
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 10 *11)
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 5 7 *10 11)
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs *3 4 5 6 7 10 11 12 14 15)
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 *11 12 14 15)
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 *10 11 12 14 15)
Sep 26 13:59:28 localhost kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
Sep 26 13:59:28 localhost kernel: ACPI: Enabled 3 GPEs in block 00 to 3F
Sep 26 13:59:28 localhost kernel: ACPI: \_SB_.PCI0: notify handler is installed
Sep 26 13:59:28 localhost kernel: Found 1 acpi root devices
Sep 26 13:59:28 localhost kernel: ACPI: EC: GPE = 0x11, I/O: command/status = 0x934, data = 0x930
Sep 26 13:59:28 localhost kernel: vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
Sep 26 13:59:28 localhost kernel: vgaarb: loaded
Sep 26 13:59:28 localhost kernel: vgaarb: bridge control possible 0000:00:02.0
Sep 26 13:59:28 localhost kernel: PCI: Using ACPI for IRQ routing
Sep 26 13:59:28 localhost kernel: PCI: pci_cache_line_size set to 64 bytes
Sep 26 13:59:28 localhost kernel: e820: reserve RAM buffer [mem 0x0009bc00-0x0009ffff]
Sep 26 13:59:28 localhost kernel: e820: reserve RAM buffer [mem 0xdd04d400-0xdfffffff]
Sep 26 13:59:28 localhost kernel: NetLabel: Initializing
Sep 26 13:59:28 localhost kernel: NetLabel:  domain hash size = 128
Sep 26 13:59:28 localhost kernel: NetLabel:  protocols = UNLABELED CIPSOv4
Sep 26 13:59:28 localhost kernel: NetLabel:  unlabeled traffic allowed by default
Sep 26 13:59:28 localhost kernel: HPET: 4 timers in total, 0 timers will be used for per-cpu timer
Sep 26 13:59:28 localhost kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0
Sep 26 13:59:28 localhost kernel: hpet0: 4 comparators, 64-bit 14.318180 MHz counter
Sep 26 13:59:28 localhost kernel: Switched to clocksource hpet
Sep 26 13:59:28 localhost kernel: pnp: PnP ACPI init
Sep 26 13:59:28 localhost kernel: ACPI: bus type PNP registered
Sep 26 13:59:28 localhost kernel: pnp 00:00: Plug and Play ACPI device, IDs PNP0f13 (active)
Sep 26 13:59:28 localhost kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
Sep 26 13:59:28 localhost kernel: pnp 00:02: Plug and Play ACPI device, IDs PNP0b00 (active)
Sep 26 13:59:28 localhost kernel: pnp 00:03: Plug and Play ACPI device, IDs PNP0800 (active)
Sep 26 13:59:28 localhost kernel: system 00:04: [io  0x0c80-0x0caf] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:04: [io  0x0cc0-0x0cff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:04: Plug and Play ACPI device, IDs PNP0c01 (active)
Sep 26 13:59:28 localhost kernel: pnp 00:05: [dma 4]
Sep 26 13:59:28 localhost kernel: pnp 00:05: Plug and Play ACPI device, IDs PNP0200 (active)
Sep 26 13:59:28 localhost kernel: pnp 00:06: Plug and Play ACPI device, IDs PNP0c04 (active)
Sep 26 13:59:28 localhost kernel: system 00:07: [mem 0xfed00000-0xfed003ff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:07: Plug and Play ACPI device, IDs PNP0103 PNP0c01 (active)
Sep 26 13:59:28 localhost kernel: system 00:08: [io  0x0cb0-0x0cbb] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:08: [mem 0xfed40000-0xfed44fff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:08: Plug and Play ACPI device, IDs PNP0c01 (active)
Sep 26 13:59:28 localhost kernel: system 00:09: [io  0x0900-0x092f] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:09: [io  0x0931-0x0933] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:09: [io  0x0935-0x097f] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:09: [io  0x04d0-0x04d1] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:09: [io  0x1000-0x1005] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:09: [io  0x1008-0x100f] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:09: Plug and Play ACPI device, IDs PNP0c01 (active)
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0xf400-0xf4fe] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0x1006-0x1007] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0x100a-0x1059] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0x1060-0x107f] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0x1080-0x10bf] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0x1100-0x111f] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0x1010-0x102f] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: [io  0x0809] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0a: Plug and Play ACPI device, IDs PNP0c01 (active)
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0x00000000-0x0009efff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0x0009f000-0x0009ffff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0x000c0000-0x000d7fff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0x000e0000-0x000fffff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0x00100000-0xdd04d3ff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xdd04d400-0xddafffff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xddb00000-0xddbfffff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xffe00000-0xffffffff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xffa00000-0xffbfffff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfec00000-0xfec0ffff] could not be reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfee00000-0xfee0ffff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfed20000-0xfed3ffff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfed45000-0xfed8ffff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfeda0000-0xfeda3fff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfeda4000-0xfeda4fff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfeda5000-0xfeda5fff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfeda6000-0xfeda6fff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfed1c800-0xfed1cfff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xfed18000-0xfed1bfff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: [mem 0xf8000000-0xfbffffff] has been reserved
Sep 26 13:59:28 localhost kernel: system 00:0b: Plug and Play ACPI device, IDs PNP0c01 (active)
Sep 26 13:59:28 localhost kernel: pnp: PnP ACPI: found 12 devices
Sep 26 13:59:28 localhost kernel: ACPI: bus type PNP unregistered
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: bridge window [io  0x1000-0x0fff] to [bus 0b] add_size 1000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 0b] add_size 200000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff] to [bus 0b] add_size 200000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: bridge window [io  0x1000-0x0fff] to [bus 0c] add_size 1000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 0c] add_size 200000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: res[14]=[mem 0x00100000-0x000fffff] get_res_add_size add_size 200000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: res[15]=[mem 0x00100000-0x000fffff 64bit pref] get_res_add_size add_size 200000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: res[15]=[mem 0x00100000-0x000fffff 64bit pref] get_res_add_size add_size 200000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: res[13]=[io  0x1000-0x0fff] get_res_add_size add_size 1000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: res[13]=[io  0x1000-0x0fff] get_res_add_size add_size 1000
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: BAR 14: assigned [mem 0xf0200000-0xf03fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: BAR 15: assigned [mem 0xf0400000-0xf05fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: BAR 15: assigned [mem 0xf0600000-0xf07fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: BAR 13: assigned [io  0x2000-0x2fff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: BAR 13: assigned [io  0x3000-0x3fff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0: PCI bridge to [bus 0b]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0:   bridge window [io  0x2000-0x2fff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0:   bridge window [mem 0xf0200000-0xf03fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.0:   bridge window [mem 0xf0400000-0xf05fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1: PCI bridge to [bus 0c]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1:   bridge window [io  0x3000-0x3fff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1:   bridge window [mem 0xf6900000-0xf69fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.1:   bridge window [mem 0xf0600000-0xf07fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3: PCI bridge to [bus 0d-0e]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3:   bridge window [io  0xd000-0xdfff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3:   bridge window [mem 0xf6600000-0xf68fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1c.3:   bridge window [mem 0xf0000000-0xf01fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0: PCI bridge to [bus 02]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0:   bridge window [mem 0xf6500000-0xf65fffff]
Sep 26 13:59:28 localhost kernel: pci 0000:00:1e.0: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 7 [mem 0x000d8000-0x000dffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 8 [mem 0xe0000000-0xf7ffffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 9 [mem 0xfc000000-0xfebfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 10 [mem 0xfec10000-0xfecfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 11 [mem 0xfed1c000-0xfed1ffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 12 [mem 0xfed90000-0xfed9ffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 13 [mem 0xfed40000-0xfed44fff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 14 [mem 0xfeda7000-0xfedfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 15 [mem 0xfee10000-0xff9fffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:00: resource 16 [mem 0xffc00000-0xffdfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0b: resource 0 [io  0x2000-0x2fff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0b: resource 1 [mem 0xf0200000-0xf03fffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0b: resource 2 [mem 0xf0400000-0xf05fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0c: resource 0 [io  0x3000-0x3fff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0c: resource 1 [mem 0xf6900000-0xf69fffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0c: resource 2 [mem 0xf0600000-0xf07fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0d: resource 0 [io  0xd000-0xdfff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0d: resource 1 [mem 0xf6600000-0xf68fffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:0d: resource 2 [mem 0xf0000000-0xf01fffff 64bit pref]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 1 [mem 0xf6500000-0xf65fffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 4 [io  0x0000-0x0cf7]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 5 [io  0x0d00-0xffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 6 [mem 0x000a0000-0x000bffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 7 [mem 0x000d8000-0x000dffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 8 [mem 0xe0000000-0xf7ffffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 9 [mem 0xfc000000-0xfebfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 10 [mem 0xfec10000-0xfecfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 11 [mem 0xfed1c000-0xfed1ffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 12 [mem 0xfed90000-0xfed9ffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 13 [mem 0xfed40000-0xfed44fff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 14 [mem 0xfeda7000-0xfedfffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 15 [mem 0xfee10000-0xff9fffff]
Sep 26 13:59:28 localhost kernel: pci_bus 0000:02: resource 16 [mem 0xffc00000-0xffdfffff]
Sep 26 13:59:28 localhost kernel: NET: Registered protocol family 2
Sep 26 13:59:28 localhost kernel: TCP established hash table entries: 32768 (order: 7, 524288 bytes)
Sep 26 13:59:28 localhost kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes)
Sep 26 13:59:28 localhost kernel: TCP: Hash tables configured (established 32768 bind 32768)
Sep 26 13:59:28 localhost kernel: TCP: reno registered
Sep 26 13:59:28 localhost kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes)
Sep 26 13:59:28 localhost kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes)
Sep 26 13:59:28 localhost kernel: NET: Registered protocol family 1
Sep 26 13:59:28 localhost kernel: pci 0000:00:02.0: Boot video device
Sep 26 13:59:28 localhost kernel: PCI: CLS 64 bytes, default 64
Sep 26 13:59:28 localhost kernel: Unpacking initramfs...
Sep 26 13:59:28 localhost kernel: Freeing initrd memory: 4924K (ffff88007fb30000 - ffff88007ffff000)
Sep 26 13:59:28 localhost kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
Sep 26 13:59:28 localhost kernel: software IO TLB [mem 0xd904d000-0xdd04d000] (64MB) mapped at [ffff8800d904d000-ffff8800dd04cfff]
Sep 26 13:59:28 localhost kernel: Simple Boot Flag at 0x79 set to 0x1
Sep 26 13:59:28 localhost kernel: Scanning for low memory corruption every 60 seconds
Sep 26 13:59:28 localhost kernel: audit: initializing netlink socket (disabled)
Sep 26 13:59:28 localhost kernel: type=2000 audit(1380193167.553:1): initialized
Sep 26 13:59:28 localhost kernel: HugeTLB registered 2 MB page size, pre-allocated 0 pages
Sep 26 13:59:28 localhost kernel: zbud: loaded
Sep 26 13:59:28 localhost kernel: VFS: Disk quotas dquot_6.5.2
Sep 26 13:59:28 localhost kernel: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Sep 26 13:59:28 localhost kernel: msgmni has been set to 7815
Sep 26 13:59:28 localhost kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Sep 26 13:59:28 localhost kernel: io scheduler noop registered
Sep 26 13:59:28 localhost kernel: io scheduler deadline registered
Sep 26 13:59:28 localhost kernel: io scheduler cfq registered (default)
Sep 26 13:59:28 localhost kernel: pcieport 0000:00:1c.0: irq 40 for MSI/MSI-X
Sep 26 13:59:28 localhost kernel: pcieport 0000:00:1c.1: irq 41 for MSI/MSI-X
Sep 26 13:59:28 localhost kernel: pcieport 0000:00:1c.3: irq 42 for MSI/MSI-X
Sep 26 13:59:28 localhost kernel: pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Sep 26 13:59:28 localhost kernel: pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Sep 26 13:59:28 localhost kernel: intel_idle: does not run on family 6 model 23
Sep 26 13:59:28 localhost kernel: GHES: HEST is not enabled!
Sep 26 13:59:28 localhost kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
Sep 26 13:59:28 localhost kernel: Linux agpgart interface v0.103
Sep 26 13:59:28 localhost kernel: i8042: PNP: PS/2 Controller [PNP0303:KBC,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
Sep 26 13:59:28 localhost kernel: i8042: Warning: Keylock active
Sep 26 13:59:28 localhost kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
Sep 26 13:59:28 localhost kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
Sep 26 13:59:28 localhost kernel: mousedev: PS/2 mouse device common for all mice
Sep 26 13:59:28 localhost kernel: rtc_cmos 00:02: RTC can wake from S4
Sep 26 13:59:28 localhost kernel: rtc_cmos 00:02: rtc core: registered rtc_cmos as rtc0
Sep 26 13:59:28 localhost kernel: rtc_cmos 00:02: alarms up to one month, y3k, 114 bytes nvram, hpet irqs
Sep 26 13:59:28 localhost kernel: cpuidle: using governor ladder
Sep 26 13:59:28 localhost kernel: cpuidle: using governor menu
Sep 26 13:59:28 localhost kernel: drop_monitor: Initializing network drop monitor service
Sep 26 13:59:28 localhost kernel: TCP: cubic registered
Sep 26 13:59:28 localhost kernel: NET: Registered protocol family 10
Sep 26 13:59:28 localhost kernel: NET: Registered protocol family 17
Sep 26 13:59:28 localhost kernel: Key type dns_resolver registered
Sep 26 13:59:28 localhost kernel: PM: Hibernation image not present or could not be loaded.
Sep 26 13:59:28 localhost kernel: registered taskstats version 1
Sep 26 13:59:28 localhost kernel:   Magic number: 13:474:983
Sep 26 13:59:28 localhost kernel: acpi PNP0C14:00: hash matches
Sep 26 13:59:28 localhost kernel: rtc_cmos 00:02: setting system clock to 2013-09-26 10:59:28 UTC (1380193168)
Sep 26 13:59:28 localhost kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
Sep 26 13:59:28 localhost kernel: Freeing unused kernel memory: 1140K (ffffffff818c8000 - ffffffff819e5000)
Sep 26 13:59:28 localhost kernel: Write protecting the kernel read-only data: 8192k
Sep 26 13:59:28 localhost kernel: Freeing unused kernel memory: 1088K (ffff8800014f0000 - ffff880001600000)
Sep 26 13:59:28 localhost kernel: Freeing unused kernel memory: 352K (ffff8800017a8000 - ffff880001800000)
Sep 26 13:59:28 localhost systemd[1]: systemd 207 running in system mode. (+PAM -LIBWRAP -AUDIT -SELINUX -IMA -SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ)
Sep 26 13:59:28 localhost systemd[1]: Running in initial RAM disk.
Sep 26 13:59:28 localhost systemd[1]: No hostname configured.
Sep 26 13:59:28 localhost systemd[1]: Set hostname to <localhost>.
Sep 26 13:59:28 localhost systemd[1]: Initializing machine ID from random generator.
Sep 26 13:59:28 localhost systemd[1]: Cannot add dependency job for unit local-fs.target, ignoring: Unit local-fs.target failed to load: No such file or directory. See system logs and 'systemctl status local-fs.target' for details.
Sep 26 13:59:28 localhost systemd[1]: Cannot add dependency job for unit swap.target, ignoring: Unit swap.target failed to load: No such file or directory. See system logs and 'systemctl status swap.target' for details.
Sep 26 13:59:28 localhost systemd[1]: Cannot add dependency job for unit timers.target, ignoring: Unit timers.target failed to load: No such file or directory. See system logs and 'systemctl status timers.target' for details.
Sep 26 13:59:28 localhost systemd[1]: Cannot add dependency job for unit paths.target, ignoring: Unit paths.target failed to load: No such file or directory. See system logs and 'systemctl status paths.target' for details.
Sep 26 13:59:28 localhost systemd[1]: Cannot add dependency job for unit slices.target, ignoring: Unit slices.target failed to load: No such file or directory. See system logs and 'systemctl status slices.target' for details.
Sep 26 13:59:28 localhost systemd[1]: Expecting device dev-sda6.device...
Sep 26 13:59:28 localhost systemd[1]: Starting udev Kernel Socket.
Sep 26 13:59:28 localhost systemd[1]: Listening on udev Kernel Socket.
Sep 26 13:59:28 localhost systemd[1]: Starting udev Control Socket.
Sep 26 13:59:28 localhost systemd[1]: Listening on udev Control Socket.
Sep 26 13:59:28 localhost systemd[1]: Starting -.slice.
Sep 26 13:59:28 localhost systemd[1]: Created slice -.slice.
Sep 26 13:59:28 localhost systemd[1]: Starting system.slice.
Sep 26 13:59:28 localhost systemd[1]: Created slice system.slice.
Sep 26 13:59:28 localhost systemd[1]: Starting Journal Socket.
Sep 26 13:59:28 localhost systemd[1]: Listening on Journal Socket.
Sep 26 13:59:28 localhost systemd[1]: Starting udev Coldplug all Devices...
Sep 26 13:59:28 localhost systemd[1]: Starting Sockets.
Sep 26 13:59:28 localhost systemd[1]: Reached target Sockets.
Sep 26 13:59:28 localhost systemd[1]: Starting Journal Service...
Sep 26 13:59:28 localhost systemd[1]: Started Journal Service.
Sep 26 13:59:28 localhost systemd-udevd[46]: starting version 207
Sep 26 13:59:28 localhost kernel: input: Lid Switch as /devices/LNXSYSTM:00/device:00/PNP0C0D:00/input/input1
Sep 26 13:59:28 localhost kernel: ACPI: Lid Switch [LID]
Sep 26 13:59:28 localhost kernel: input: Power Button as /devices/LNXSYSTM:00/device:00/PNP0C0C:00/input/input2
Sep 26 13:59:28 localhost kernel: ACPI: Power Button [PBTN]
Sep 26 13:59:28 localhost kernel: input: Sleep Button as /devices/LNXSYSTM:00/device:00/PNP0C0E:00/input/input3
Sep 26 13:59:28 localhost kernel: ACPI: Sleep Button [SBTN]
Sep 26 13:59:28 localhost systemd-journal[40]: Journal started
Sep 26 13:59:28 localhost systemd[1]: Starting Create list of required static device nodes for the current kernel...
Sep 26 13:59:28 localhost systemd[1]: Started Create list of required static device nodes for the current kernel.
Sep 26 13:59:28 localhost systemd[1]: Starting Create static device nodes in /dev...
Sep 26 13:59:28 localhost systemd[1]: Started Create static device nodes in /dev.
Sep 26 13:59:28 localhost systemd[1]: Starting udev Kernel Device Manager...
Sep 26 13:59:28 localhost systemd[1]: Started udev Kernel Device Manager.
Sep 26 13:59:28 localhost systemd[1]: Started udev Coldplug all Devices.
Sep 26 13:59:28 localhost systemd[1]: Starting System Initialization.
Sep 26 13:59:28 localhost systemd[1]: Reached target System Initialization.
Sep 26 13:59:28 localhost systemd[1]: Starting Basic System.
Sep 26 13:59:28 localhost systemd[1]: Reached target Basic System.
Sep 26 13:59:28 localhost kernel: agpgart-intel 0000:00:00.0: Intel GM45 Chipset
Sep 26 13:59:28 localhost kernel: agpgart-intel 0000:00:00.0: detected gtt size: 2097152K total, 262144K mappable
Sep 26 13:59:28 localhost kernel: agpgart-intel 0000:00:00.0: detected 32768K stolen memory
Sep 26 13:59:28 localhost kernel: [drm] Initialized drm 1.1.0 20060810
Sep 26 13:59:28 localhost kernel: agpgart-intel 0000:00:00.0: AGP aperture is 256M @ 0xe0000000
Sep 26 13:59:28 localhost kernel: ACPI: bus type USB registered
Sep 26 13:59:28 localhost kernel: usbcore: registered new interface driver usbfs
Sep 26 13:59:28 localhost kernel: usbcore: registered new interface driver hub
Sep 26 13:59:28 localhost kernel: usbcore: registered new device driver usb
Sep 26 13:59:28 localhost kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Sep 26 13:59:28 localhost kernel: uhci_hcd: USB Universal Host Controller Interface driver
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.0: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.0: UHCI Host Controller
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.0: irq 20, io base 0x00006f60
Sep 26 13:59:28 localhost kernel: ehci-pci: EHCI PCI platform driver
Sep 26 13:59:28 localhost kernel: hub 1-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 1-0:1.0: 2 ports detected
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1a.7: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1a.7: EHCI Host Controller
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1a.7: new USB bus registered, assigned bus number 2
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1a.7: debug port 1
Sep 26 13:59:28 localhost kernel: SCSI subsystem initialized
Sep 26 13:59:28 localhost kernel: ACPI: bus type ATA registered
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1a.7: cache line size of 64 is not supported
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1a.7: irq 22, io mem 0xfed1c400
Sep 26 13:59:28 localhost kernel: libata version 3.00 loaded.
Sep 26 13:59:28 localhost kernel: sdhci: Secure Digital Host Controller Interface driver
Sep 26 13:59:28 localhost kernel: sdhci: Copyright(c) Pierre Ossman
Sep 26 13:59:28 localhost kernel: sdhci-pci 0000:02:01.1: SDHCI controller found [1180:0822] (rev 22)
Sep 26 13:59:28 localhost kernel: mmc0: SDHCI controller on PCI [0000:02:01.1] using DMA
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1a.7: USB 2.0 started, EHCI 1.00
Sep 26 13:59:28 localhost kernel: hub 2-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 2-0:1.0: 6 ports detected
Sep 26 13:59:28 localhost kernel: hub 1-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 1-0:1.0: 2 ports detected
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1d.7: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1d.7: EHCI Host Controller
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 3
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1d.7: debug port 1
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1d.7: cache line size of 64 is not supported
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1d.7: irq 20, io mem 0xfed1c000
Sep 26 13:59:28 localhost kernel: ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00
Sep 26 13:59:28 localhost kernel: hub 3-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 3-0:1.0: 6 ports detected
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.1: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.1: UHCI Host Controller
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 4
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.1: irq 21, io base 0x00006f80
Sep 26 13:59:28 localhost kernel: hub 4-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 4-0:1.0: 2 ports detected
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.2: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.2: UHCI Host Controller
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.2: new USB bus registered, assigned bus number 5
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1a.2: irq 22, io base 0x00006fa0
Sep 26 13:59:28 localhost kernel: hub 5-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 5-0:1.0: 2 ports detected
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.0: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.0: UHCI Host Controller
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 6
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.0: irq 20, io base 0x00006f00
Sep 26 13:59:28 localhost kernel: hub 6-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 6-0:1.0: 2 ports detected
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.1: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.1: UHCI Host Controller
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 7
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.1: irq 21, io base 0x00006f20
Sep 26 13:59:28 localhost kernel: hub 7-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 7-0:1.0: 2 ports detected
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.2: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.2: UHCI Host Controller
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 8
Sep 26 13:59:28 localhost kernel: uhci_hcd 0000:00:1d.2: irq 22, io base 0x00006f40
Sep 26 13:59:28 localhost kernel: hub 8-0:1.0: USB hub found
Sep 26 13:59:28 localhost kernel: hub 8-0:1.0: 2 ports detected
Sep 26 13:59:28 localhost kernel: [drm] Memory usable by graphics device = 2048M
Sep 26 13:59:28 localhost kernel: i915 0000:00:02.0: setting latency timer to 64
Sep 26 13:59:28 localhost kernel: firewire_ohci 0000:02:01.0: added OHCI v1.10 device as card 0, 4 IR + 4 IT contexts, quirks 0x11
Sep 26 13:59:28 localhost kernel: i915 0000:00:02.0: irq 43 for MSI/MSI-X
Sep 26 13:59:28 localhost kernel: [drm] Supports vblank timestamp caching Rev 1 (10.10.2010).
Sep 26 13:59:28 localhost kernel: [drm] Driver supports precise vblank timestamp query.
Sep 26 13:59:28 localhost kernel: vgaarb: device changed decodes: PCI:0000:00:02.0,olddecodes=io+mem,decodes=io+mem:owns=io+mem
Sep 26 13:59:29 localhost kernel: fbcon: inteldrmfb (fb0) is primary device
Sep 26 13:59:29 localhost kernel: firewire_core 0000:02:01.0: created device fw0: GUID 364fc00022f6a890, S400
Sep 26 13:59:29 localhost kernel: usb 5-1: new full-speed USB device number 2 using uhci_hcd
Sep 26 13:59:29 localhost kernel: tsc: Refined TSC clocksource calibration: 2260.999 MHz
Sep 26 13:59:29 localhost kernel: usb 5-1: config 0 descriptor??
Sep 26 13:59:29 localhost kernel: Console: switching to colour frame buffer device 160x50
Sep 26 13:59:29 localhost kernel: i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
Sep 26 13:59:29 localhost kernel: i915 0000:00:02.0: registered panic notifier
Sep 26 13:59:29 localhost kernel: acpi device:36: registered as cooling_device0
Sep 26 13:59:29 localhost kernel: ACPI: Video Device [VID] (multi-head: yes  rom: no  post: no)
Sep 26 13:59:29 localhost kernel: input: Video Bus as /devices/LNXSYSTM:00/device:00/PNP0A03:00/LNXVIDEO:00/input/input4
Sep 26 13:59:29 localhost kernel: [Firmware Bug]: Duplicate ACPI video bus devices for the same VGA controller, please try module parameter "video.allow_duplicates=1"if the current driver doesn't work.
Sep 26 13:59:29 localhost kernel: [drm] Initialized i915 1.6.0 20080730 for 0000:00:02.0 on minor 0
Sep 26 13:59:29 localhost kernel: ahci 0000:00:1f.2: version 3.0
Sep 26 13:59:29 localhost kernel: ahci 0000:00:1f.2: irq 44 for MSI/MSI-X
Sep 26 13:59:29 localhost kernel: ahci 0000:00:1f.2: AHCI 0001.0200 32 slots 4 ports 3 Gbps 0x33 impl RAID mode
Sep 26 13:59:29 localhost kernel: ahci 0000:00:1f.2: flags: 64bit ncq sntf stag pm led clo pmp pio slum part ccc ems sxs 
Sep 26 13:59:29 localhost kernel: ahci 0000:00:1f.2: setting latency timer to 64
Sep 26 13:59:29 localhost kernel: scsi0 : ahci
Sep 26 13:59:29 localhost kernel: scsi1 : ahci
Sep 26 13:59:29 localhost kernel: scsi2 : ahci
Sep 26 13:59:29 localhost kernel: scsi3 : ahci
Sep 26 13:59:29 localhost kernel: scsi4 : ahci
Sep 26 13:59:29 localhost kernel: scsi5 : ahci
Sep 26 13:59:29 localhost kernel: ata1: SATA max UDMA/133 abar m2048@0xfed1c800 port 0xfed1c900 irq 44
Sep 26 13:59:29 localhost kernel: ata2: SATA max UDMA/133 abar m2048@0xfed1c800 port 0xfed1c980 irq 44
Sep 26 13:59:29 localhost kernel: ata3: DUMMY
Sep 26 13:59:29 localhost kernel: ata4: DUMMY
Sep 26 13:59:29 localhost kernel: ata5: SATA max UDMA/133 abar m2048@0xfed1c800 port 0xfed1cb00 irq 44
Sep 26 13:59:29 localhost kernel: ata6: SATA max UDMA/133 abar m2048@0xfed1c800 port 0xfed1cb80 irq 44
Sep 26 13:59:29 localhost kernel: usb 6-1: new low-speed USB device number 2 using uhci_hcd
Sep 26 13:59:29 localhost kernel: hidraw: raw HID events driver (C) Jiri Kosina
Sep 26 13:59:29 localhost kernel: usbcore: registered new interface driver usbhid
Sep 26 13:59:29 localhost kernel: usbhid: USB HID core driver
Sep 26 13:59:29 localhost kernel: input: SIGMACHIP Usb Mouse as /devices/pci0000:00/0000:00:1d.0/usb6/6-1/6-1:1.0/input/input5
Sep 26 13:59:29 localhost kernel: hid-generic 0003:1C4F:0032.0001: input,hidraw0: USB HID v1.10 Mouse [SIGMACHIP Usb Mouse] on usb-0000:00:1d.0-1/input0
Sep 26 13:59:30 localhost kernel: ata5: SATA link down (SStatus 0 SControl 300)
Sep 26 13:59:30 localhost kernel: ata6: SATA link down (SStatus 0 SControl 300)
Sep 26 13:59:30 localhost kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Sep 26 13:59:30 localhost kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Sep 26 13:59:30 localhost kernel: ata1.00: ATA-8: WDC WD1600BJKT-75F4T0, 11.01A11, max UDMA/133
Sep 26 13:59:30 localhost kernel: ata1.00: 312581808 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
Sep 26 13:59:30 localhost kernel: ata1.00: configured for UDMA/133
Sep 26 13:59:30 localhost kernel: scsi 0:0:0:0: Direct-Access     ATA      WDC WD1600BJKT-7 11.0 PQ: 0 ANSI: 5
Sep 26 13:59:30 localhost kernel: ata2.00: ATAPI: TSSTcorp DVD+/-RW TS-U633A, D200, max UDMA/100
Sep 26 13:59:30 localhost kernel: ata2.00: applying bridge limits
Sep 26 13:59:30 localhost kernel: ata2.00: configured for UDMA/100
Sep 26 13:59:30 localhost kernel: scsi 1:0:0:0: CD-ROM            TSSTcorp DVD+-RW TS-U633A D200 PQ: 0 ANSI: 5
Sep 26 13:59:30 localhost kernel: sd 0:0:0:0: [sda] 312581808 512-byte logical blocks: (160 GB/149 GiB)
Sep 26 13:59:30 localhost kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 26 13:59:30 localhost kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
Sep 26 13:59:30 localhost kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 26 13:59:30 localhost kernel: sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
Sep 26 13:59:30 localhost kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
Sep 26 13:59:30 localhost kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0
Sep 26 13:59:30 localhost kernel:  sda: sda1 sda2 sda3 sda4 < sda5 sda6 >
Sep 26 13:59:30 localhost kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Sep 26 13:59:30 localhost kernel: Switched to clocksource tsc
Sep 26 13:59:30 localhost systemd[1]: Found device WDC_WD1600BJKT-75F4T0.
Sep 26 13:59:30 localhost systemd[1]: Mounting /sysroot...
Sep 26 13:59:30 localhost systemd[1]: Mounted /sysroot.
Sep 26 13:59:30 localhost systemd[1]: Starting Initrd Root File System.
Sep 26 13:59:30 localhost systemd[1]: Reached target Initrd Root File System.
Sep 26 13:59:30 localhost systemd[1]: Starting Reload Configuration from the Real Root...
Sep 26 13:59:30 localhost kernel: EXT4-fs (sda6): mounted filesystem with ordered data mode. Opts: (null)
Sep 26 13:59:30 localhost systemd[1]: Reloading.
Sep 26 13:59:30 localhost systemd[1]: Started Reload Configuration from the Real Root.
Sep 26 13:59:30 localhost systemd[1]: Starting Initrd File Systems.
Sep 26 13:59:30 localhost systemd[1]: Reached target Initrd File Systems.
Sep 26 13:59:30 localhost systemd[1]: Starting Initrd Default Target.
Sep 26 13:59:30 localhost systemd[1]: Reached target Initrd Default Target.
Sep 26 13:59:30 localhost systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
Sep 26 13:59:30 localhost systemd[1]: Stopping Cleaning Up and Shutting Down Daemons...
Sep 26 13:59:30 localhost systemd[1]: Stopped Cleaning Up and Shutting Down Daemons.
Sep 26 13:59:30 localhost systemd[1]: Stopping Initrd Default Target.
Sep 26 13:59:30 localhost systemd[1]: Stopped target Initrd Default Target.
Sep 26 13:59:30 localhost systemd[1]: Stopping Basic System.
Sep 26 13:59:30 localhost systemd[1]: Stopped target Basic System.
Sep 26 13:59:30 localhost systemd[1]: Stopping Sockets.
Sep 26 13:59:30 localhost systemd[1]: Stopped target Sockets.
Sep 26 13:59:30 localhost systemd[1]: Stopping System Initialization.
Sep 26 13:59:30 localhost systemd[1]: Stopped target System Initialization.
Sep 26 13:59:30 localhost systemd[1]: Stopping udev Coldplug all Devices...
Sep 26 13:59:30 localhost systemd[1]: Stopped udev Coldplug all Devices.
Sep 26 13:59:30 localhost systemd[1]: Stopping udev Kernel Device Manager...
Sep 26 13:59:30 localhost systemd[1]: Stopped udev Kernel Device Manager.
Sep 26 13:59:30 localhost systemd[1]: Stopping Create static device nodes in /dev...
Sep 26 13:59:30 localhost systemd[1]: Stopped Create static device nodes in /dev.
Sep 26 13:59:30 localhost systemd[1]: Stopping Create list of required static device nodes for the current kernel...
Sep 26 13:59:30 localhost systemd[1]: Stopped Create list of required static device nodes for the current kernel.
Sep 26 13:59:30 localhost systemd[1]: Stopping udev Kernel Socket.
Sep 26 13:59:30 localhost systemd[1]: Closed udev Kernel Socket.
Sep 26 13:59:30 localhost systemd[1]: Stopping udev Control Socket.
Sep 26 13:59:30 localhost systemd[1]: Closed udev Control Socket.
Sep 26 13:59:30 localhost systemd[1]: Starting Cleanup udevd DB...
Sep 26 13:59:30 localhost systemd[1]: Started Cleanup udevd DB.
Sep 26 13:59:30 localhost systemd[1]: Starting Switch Root.
Sep 26 13:59:30 localhost systemd[1]: Reached target Switch Root.
Sep 26 13:59:30 localhost systemd[1]: Starting Switch Root...
Sep 26 13:59:30 localhost systemd[1]: Switching root.
Sep 26 13:59:30 localhost systemd-journal[40]: Journal stopped
Sep 26 13:59:33 LatitudePC systemd-journal[119]: Runtime journal is using 704.0K (max 195.5M, leaving 293.2M of free 1.9G, current limit 195.5M).
Sep 26 13:59:33 LatitudePC systemd-journal[119]: Runtime journal is using 704.0K (max 195.5M, leaving 293.2M of free 1.9G, current limit 195.5M).
Sep 26 13:59:33 LatitudePC systemd-journald[40]: Received SIGTERM
Sep 26 13:59:33 LatitudePC systemd-readahead[113]: Bumped block_nr parameter of 8:0 to 20480. This is a temporary hack and should be removed one day.
Sep 26 13:59:33 LatitudePC systemd-journal[119]: Journal started
Sep 26 13:59:31 LatitudePC systemd[1]: systemd 207 running in system mode. (+PAM -LIBWRAP -AUDIT -SELINUX -IMA -SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ)
Sep 26 13:59:31 LatitudePC systemd[1]: Set hostname to <LatitudePC>.
Sep 26 13:59:31 LatitudePC systemd[1]: Failed to open private bus connection: Failed to connect to socket /var/run/dbus/system_bus_socket: No such file or directory
Sep 26 13:59:32 LatitudePC systemd[1]: Started Collect Read-Ahead Data.
Sep 26 13:59:32 LatitudePC systemd[1]: Started udev Coldplug all Devices.
Sep 26 13:59:32 LatitudePC systemd[1]: Started Replay Read-Ahead Data.
Sep 26 13:59:32 LatitudePC systemd[1]: Started File System Check on Root Device.
Sep 26 13:59:32 LatitudePC systemd[1]: Starting Setup Virtual Console...
Sep 26 13:59:32 LatitudePC systemd[1]: Starting Apply Kernel Variables...
Sep 26 13:59:33 LatitudePC systemd[1]: Started Load Kernel Modules.
Sep 26 13:59:33 LatitudePC systemd[1]: Mounted FUSE Control File System.
Sep 26 13:59:33 LatitudePC systemd[1]: Mounting Configuration File System...
Sep 26 13:59:33 LatitudePC systemd[1]: Started Set Up Additional Binary Formats.
Sep 26 13:59:33 LatitudePC systemd[1]: Starting Remount Root and Kernel File Systems...
Sep 26 13:59:33 LatitudePC systemd[1]: Mounted Huge Pages File System.
Sep 26 13:59:33 LatitudePC systemd[1]: Mounted Debug File System.
Sep 26 13:59:33 LatitudePC systemd[1]: Mounted POSIX Message Queue File System.
Sep 26 13:59:33 LatitudePC systemd[1]: Started Apply Kernel Variables.
Sep 26 13:59:33 LatitudePC systemd[1]: Mounted Configuration File System.
Sep 26 13:59:33 LatitudePC kernel: EXT4-fs (sda6): re-mounted. Opts: (null)
Sep 26 13:59:33 LatitudePC systemd[1]: Started Remount Root and Kernel File Systems.
Sep 26 13:59:33 LatitudePC systemd[1]: Starting Load/Save Random Seed...
Sep 26 13:59:34 LatitudePC systemd[1]: Started Create list of required static device nodes for the current kernel.
Sep 26 13:59:34 LatitudePC systemd[1]: Starting Create static device nodes in /dev...
Sep 26 13:59:34 LatitudePC systemd[1]: Started Setup Virtual Console.
Sep 26 13:59:34 LatitudePC systemd[1]: Started Load/Save Random Seed.
Sep 26 13:59:34 LatitudePC systemd[1]: Started Create static device nodes in /dev.
Sep 26 13:59:34 LatitudePC systemd[1]: Starting udev Kernel Device Manager...
Sep 26 13:59:34 LatitudePC systemd[1]: Starting Local File Systems (Pre).
Sep 26 13:59:34 LatitudePC systemd[1]: Reached target Local File Systems (Pre).
Sep 26 13:59:34 LatitudePC systemd[1]: Mounting /tmp...
Sep 26 13:59:34 LatitudePC systemd-udevd[146]: starting version 207
Sep 26 13:59:34 LatitudePC systemd[1]: Started udev Kernel Device Manager.
Sep 26 13:59:34 LatitudePC systemd[1]: Mounted /tmp.
Sep 26 13:59:34 LatitudePC systemd[1]: Starting Load/Save Screen Backlight Brightness of acpi_video0...
Sep 26 13:59:34 LatitudePC kernel: ACPI: AC Adapter [AC] (on-line)
Sep 26 13:59:34 LatitudePC kernel: ACPI: Battery Slot [BAT0] (battery absent)
Sep 26 13:59:34 LatitudePC kernel: ACPI: Battery Slot [BAT1] (battery absent)
Sep 26 13:59:34 LatitudePC kernel: pps_core: LinuxPPS API ver. 1 registered
Sep 26 13:59:34 LatitudePC kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Sep 26 13:59:34 LatitudePC kernel: PTP clock support registered
Sep 26 13:59:34 LatitudePC kernel: ACPI: Requesting acpi_cpufreq
Sep 26 13:59:34 LatitudePC kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
Sep 26 13:59:35 LatitudePC kernel: e1000e: Intel(R) PRO/1000 Network Driver - 2.3.2-k
Sep 26 13:59:35 LatitudePC kernel: e1000e: Copyright(c) 1999 - 2013 Intel Corporation.
Sep 26 13:59:35 LatitudePC kernel: e1000e 0000:00:19.0: setting latency timer to 64
Sep 26 13:59:35 LatitudePC kernel: e1000e 0000:00:19.0: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode
Sep 26 13:59:35 LatitudePC kernel: e1000e 0000:00:19.0: irq 45 for MSI/MSI-X
Sep 26 13:59:35 LatitudePC kernel: Monitor-Mwait will be used to enter C-1 state
Sep 26 13:59:35 LatitudePC kernel: Monitor-Mwait will be used to enter C-2 state
Sep 26 13:59:35 LatitudePC kernel: Monitor-Mwait will be used to enter C-3 state
Sep 26 13:59:35 LatitudePC kernel: tsc: Marking TSC unstable due to TSC halts in idle
Sep 26 13:59:35 LatitudePC kernel: ACPI: acpi_idle registered with cpuidle
Sep 26 13:59:35 LatitudePC kernel: Switched to clocksource hpet
Sep 26 13:59:35 LatitudePC kernel: wmi: Mapper loaded
Sep 26 13:59:35 LatitudePC kernel: thermal LNXTHERM:00: registered as thermal_zone0
Sep 26 13:59:35 LatitudePC kernel: ACPI: Thermal Zone [THM] (52 C)
Sep 26 13:59:35 LatitudePC kernel: input: PC Speaker as /devices/platform/pcspkr/input/input6
Sep 26 13:59:35 LatitudePC kernel: cfg80211: Calling CRDA to update world regulatory domain
Sep 26 13:59:35 LatitudePC kernel: lib80211: common routines for IEEE802.11 drivers
Sep 26 13:59:35 LatitudePC kernel: lib80211_crypt: registered algorithm 'NULL'
Sep 26 13:59:35 LatitudePC kernel: microcode: CPU0 sig=0x10676, pf=0x80, revision=0x60c
Sep 26 13:59:35 LatitudePC kernel: dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
Sep 26 13:59:35 LatitudePC kernel: e1000e 0000:00:19.0 eth0: (PCI Express:2.5GT/s:Width x1) 00:24:e8:92:6f:fc
Sep 26 13:59:35 LatitudePC kernel: e1000e 0000:00:19.0 eth0: Intel(R) PRO/1000 Network Connection
Sep 26 13:59:35 LatitudePC kernel: e1000e 0000:00:19.0 eth0: MAC: 7, PHY: 8, PBA No: 3002FF-0FF
Sep 26 13:59:35 LatitudePC systemd[1]: Started Load/Save Screen Backlight Brightness of acpi_video0.
Sep 26 13:59:35 LatitudePC kernel: snd_hda_intel 0000:00:1b.0: irq 46 for MSI/MSI-X
Sep 26 13:59:35 LatitudePC kernel: input: Dell WMI hotkeys as /devices/virtual/input/input7
Sep 26 13:59:35 LatitudePC kernel: input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
Sep 26 13:59:35 LatitudePC kernel: microcode: CPU1 sig=0x10676, pf=0x80, revision=0x60c
Sep 26 13:59:35 LatitudePC kernel: microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
Sep 26 13:59:35 LatitudePC systemd-udevd[147]: renamed network interface eth0 to eth
Sep 26 13:59:35 LatitudePC kernel: input: HDA Intel HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9
Sep 26 13:59:35 LatitudePC kernel: input: HDA Intel Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10
Sep 26 13:59:35 LatitudePC kernel: input: HDA Intel Dock Line Out as /devices/pci0000:00/0000:00:1b.0/sound/card0/input11
Sep 26 13:59:35 LatitudePC kernel: input: HDA Intel Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input12
Sep 26 13:59:35 LatitudePC kernel: input: HDA Intel Dock Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input13
Sep 26 13:59:35 LatitudePC kernel: i801_smbus 0000:00:1f.3: SMBus using PCI Interrupt
Sep 26 13:59:35 LatitudePC systemd[1]: Starting Sound Card.
Sep 26 13:59:35 LatitudePC kernel: iTCO_vendor_support: vendor-support=0
Sep 26 13:59:35 LatitudePC kernel: iTCO_wdt: Intel TCO WatchDog Timer Driver v1.10
Sep 26 13:59:35 LatitudePC kernel: iTCO_wdt: Found a ICH9M-E TCO device (Version=2, TCOBASE=0x1060)
Sep 26 13:59:35 LatitudePC kernel: iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
Sep 26 13:59:35 LatitudePC kernel: gpio_ich: GPIO from 195 to 255 on gpio_ich
Sep 26 13:59:35 LatitudePC systemd[1]: Reached target Sound Card.
Sep 26 13:59:35 LatitudePC kernel: wl: module license 'Mixed/Proprietary' taints kernel.
Sep 26 13:59:35 LatitudePC kernel: Disabling lock debugging due to kernel taint
Sep 26 13:59:35 LatitudePC kernel: INFO @wl_cfg80211_attach : Registered CFG80211 phy
Sep 26 13:59:35 LatitudePC kernel: lib80211_crypt: registered algorithm 'TKIP'
Sep 26 13:59:35 LatitudePC kernel: eth0: Broadcom BCM432b 802.11 Hybrid Wireless Controller 6.30.223.141 (r415941)
Sep 26 13:59:35 LatitudePC systemd-udevd[148]: renamed network interface eth0 to wlan
Sep 26 13:59:36 LatitudePC kernel: input: DualPoint Stick as /devices/platform/i8042/serio1/input/input14
Sep 26 13:59:36 LatitudePC kernel: input: AlpsPS/2 ALPS DualPoint TouchPad as /devices/platform/i8042/serio1/input/input15
Sep 26 13:59:37 LatitudePC systemd[1]: Found device WDC_WD1600BJKT-75F4T0.
Sep 26 13:59:37 LatitudePC systemd[1]: Activating swap /dev/disk/by-uuid/14c7b2fa-e6ed-49aa-aa56-8b32947d3812...
Sep 26 13:59:37 LatitudePC systemd[1]: Found device WDC_WD1600BJKT-75F4T0.
Sep 26 13:59:37 LatitudePC systemd[1]: Starting File System Check on /dev/disk/by-uuid/152477bd-9112-4613-8f48-7f5c4aee074f...
Sep 26 13:59:37 LatitudePC kernel: Adding 3903756k swap on /dev/sda5.  Priority:-1 extents:1 across:3903756k FS
Sep 26 13:59:37 LatitudePC systemd[1]: Activated swap /dev/disk/by-uuid/14c7b2fa-e6ed-49aa-aa56-8b32947d3812.
Sep 26 13:59:37 LatitudePC systemd[1]: Starting Swap.
Sep 26 13:59:37 LatitudePC systemd[1]: Reached target Swap.
Sep 26 13:59:38 LatitudePC systemd-fsck[185]: Boot: clean, 27/16128 files, 30210/64260 blocks
Sep 26 13:59:38 LatitudePC systemd[1]: Started File System Check on /dev/disk/by-uuid/152477bd-9112-4613-8f48-7f5c4aee074f.
Sep 26 13:59:38 LatitudePC systemd[1]: Mounting /boot...
Sep 26 13:59:38 LatitudePC kernel: EXT4-fs (sda3): mounting ext2 file system using the ext4 subsystem
Sep 26 13:59:38 LatitudePC systemd[1]: Mounted /boot.
Sep 26 13:59:38 LatitudePC systemd[1]: Starting Local File Systems.
Sep 26 13:59:38 LatitudePC systemd[1]: Reached target Local File Systems.
Sep 26 13:59:38 LatitudePC systemd[1]: Starting Recreate Volatile Files and Directories...
Sep 26 13:59:38 LatitudePC kernel: EXT4-fs (sda3): mounted filesystem without journal. Opts: (null)
Sep 26 13:59:38 LatitudePC systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage...
Sep 26 13:59:38 LatitudePC systemd-journal[119]: Permanent journal is using 126.4M (max 4.0G, leaving 4.0G of free 44.3G, current limit 4.0G).
Sep 26 13:59:38 LatitudePC systemd[1]: Started Trigger Flushing of Journal to Persistent Storage.
Sep 26 13:59:38 LatitudePC systemd[1]: Started Recreate Volatile Files and Directories.
Sep 26 13:59:38 LatitudePC systemd[1]: Starting Update UTMP about System Reboot/Shutdown...
Sep 26 13:59:38 LatitudePC systemd[1]: Started Update UTMP about System Reboot/Shutdown.
Sep 26 13:59:38 LatitudePC systemd[1]: Starting System Initialization.
Sep 26 13:59:38 LatitudePC systemd[1]: Reached target System Initialization.
Sep 26 13:59:38 LatitudePC systemd[1]: Starting D-Bus System Message Bus Socket.
Sep 26 13:59:38 LatitudePC systemd[1]: Listening on D-Bus System Message Bus Socket.
Sep 26 13:59:38 LatitudePC systemd[1]: Starting Sockets.
Sep 26 13:59:38 LatitudePC systemd[1]: Reached target Sockets.
Sep 26 13:59:38 LatitudePC systemd[1]: Starting Daily Cleanup of Temporary Directories.
Sep 26 13:59:59 LatitudePC systemd[1]: Started Daily Cleanup of Temporary Directories.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Timers.
Sep 26 13:59:59 LatitudePC systemd[1]: Reached target Timers.
Sep 26 13:59:59 LatitudePC systemd[1]: Started Manage Sound Card State (restore and store).
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Restore Sound Card State...
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Basic System.
Sep 26 13:59:59 LatitudePC systemd[1]: Reached target Basic System.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Periodic Command Scheduler...
Sep 26 13:59:59 LatitudePC systemd[1]: Started Periodic Command Scheduler.
Sep 26 13:59:59 LatitudePC systemd[1]: Started SSH Key Generation.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting OpenSSH Daemon...
Sep 26 13:59:59 LatitudePC systemd[1]: Started OpenSSH Daemon.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Login Service...
Sep 26 13:59:59 LatitudePC systemd[1]: Starting D-Bus System Message Bus...
Sep 26 13:59:59 LatitudePC systemd[1]: Started D-Bus System Message Bus.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Permit User Sessions...
Sep 26 13:59:59 LatitudePC systemd[1]: Started Restore Sound Card State.
Sep 26 13:59:59 LatitudePC systemd[1]: Started Permit User Sessions.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Getty on tty1...
Sep 26 13:59:59 LatitudePC systemd[1]: Started Getty on tty1.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Login Prompts.
Sep 26 13:59:59 LatitudePC systemd[1]: Reached target Login Prompts.
Sep 26 13:59:59 LatitudePC systemd-logind[206]: New seat seat0.
Sep 26 13:59:59 LatitudePC systemd[1]: Started Login Service.
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Multi-User System.
Sep 26 13:59:59 LatitudePC systemd-logind[206]: Watching system buttons on /dev/input/event4 (Video Bus)
Sep 26 13:59:59 LatitudePC systemd[1]: Reached target Multi-User System.
Sep 26 13:59:59 LatitudePC systemd-logind[206]: Watching system buttons on /dev/input/event2 (Power Button)
Sep 26 13:59:59 LatitudePC systemd[1]: Starting Stop Read-Ahead Data Collection 10s After Completed Startup.
Sep 26 13:59:59 LatitudePC systemd-logind[206]: Watching system buttons on /dev/input/event1 (Lid Switch)
Sep 26 14:00:00 LatitudePC systemd[1]: Started Stop Read-Ahead Data Collection 10s After Completed Startup.
Sep 26 14:00:00 LatitudePC systemd-logind[206]: Watching system buttons on /dev/input/event3 (Sleep Button)
Sep 26 14:00:00 LatitudePC systemd[1]: Startup finished in 584ms (kernel) + 3.020s (initrd) + 28.615s (userspace) = 32.220s.
Sep 26 14:00:00 LatitudePC systemd[1]: Starting user-1000.slice.
Sep 26 14:00:00 LatitudePC systemd[1]: Created slice user-1000.slice.
Sep 26 14:00:00 LatitudePC systemd[1]: Starting User Manager for 1000...
Sep 26 14:00:00 LatitudePC systemd-logind[206]: New session 1 of user thanoulis.
Sep 26 14:00:00 LatitudePC systemd[1]: Starting Session 1 of user thanoulis.
Sep 26 14:00:00 LatitudePC systemd[1]: Started Session 1 of user thanoulis.
Sep 26 14:00:00 LatitudePC systemd[215]: Failed to open private bus connection: Failed to connect to socket /run/user/1000/dbus/user_bus_socket: No such file or directory
Sep 26 14:00:00 LatitudePC systemd[215]: Mounted /sys/kernel/config.
Sep 26 14:00:00 LatitudePC systemd[215]: Stopped target Sound Card.
Sep 26 14:00:00 LatitudePC systemd[215]: Starting Default.
Sep 26 14:00:00 LatitudePC systemd[215]: Reached target Default.
Sep 26 14:00:00 LatitudePC systemd[215]: Startup finished in 284ms.
Sep 26 14:00:00 LatitudePC systemd[1]: Started User Manager for 1000.
Sep 26 13:59:59 LatitudePC sshd[205]: Server listening on 0.0.0.0 port 22.
Sep 26 13:59:59 LatitudePC sshd[205]: Server listening on :: port 22.
Sep 26 13:59:59 LatitudePC dbus[207]: [system] Successfully activated service 'org.freedesktop.systemd1'
Sep 26 13:59:59 LatitudePC login[210]: pam_unix(login:session): session opened for user thanoulis by LOGIN(uid=0)
Sep 26 13:59:59 LatitudePC crond[203]: (CRON) INFO (Syslog will be used instead of sendmail.)
Sep 26 13:59:59 LatitudePC crond[203]: (CRON) INFO (running with inotify support)
Sep 26 14:00:00 LatitudePC systemd[215]: pam_unix(systemd-user:session): session opened for user thanoulis by (uid=0)
Sep 26 14:00:00 LatitudePC login[210]: LOGIN ON tty1 BY thanoulis
Sep 26 14:00:01 LatitudePC dbus-daemon[207]: dbus[207]: [system] Successfully activated service 'org.freedesktop.systemd1'
Sep 26 14:00:29 LatitudePC systemd[1]: Starting Stop Read-Ahead Data Collection...
Sep 26 14:00:29 LatitudePC systemd[1]: Started Stop Read-Ahead Data Collection.

-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#6 2013-09-26 13:15:49

andy123
Member
Registered: 2011-11-04
Posts: 169
Website

Re: Much slower boot speed after upgrading to systemd-207

Sep 26 13:59:38 LatitudePC systemd[1]: Starting Daily Cleanup of Temporary Directories.
Sep 26 13:59:59 LatitudePC systemd[1]: Started Daily Cleanup of Temporary Directories.

wha? What is this service and what does it do that takes so long?


i'm sorry for my poor english wirting skills…

Offline

#7 2013-09-26 14:56:00

Pse
Member
Registered: 2008-03-15
Posts: 413

Re: Much slower boot speed after upgrading to systemd-207

Definitely, the critical-chain output shows that as well: cleaning the tmpfiles appears to be taking way too long. What happens if you remove the systemd hook and use the old base/udev/timestamp hooks?

Edit: clarity.

Last edited by Pse (2013-09-26 14:56:27)

Offline

#8 2013-09-26 16:51:19

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

The problem remains even after i removed the systemd hook and replaced it with udev

new systemd-analyze critical-chain shows:

The time after the unit is active or started is printed after the "@" character.
The time the unit takes to start is printed after the "+" character.

multi-user.target @23.305s
└─systemd-logind.service @23.068s +125ms
  └─basic.target @22.986s
    └─timers.target @22.932s
      └─systemd-tmpfiles-clean.timer @5.598s
        └─sysinit.target @5.594s
          └─systemd-update-utmp.service @5.583s +9ms
            └─systemd-tmpfiles-setup.service @5.532s +48ms
              └─local-fs.target @5.529s
                └─boot.mount @5.518s +9ms
                  └─systemd-fsck@dev-disk-by\x2duuid-152477bd\x2d9112\x2d4613\x2d8f48\x2d7f5c4aee074f.service @5.202s +294ms
                    └─dev-disk-by\x2duuid-152477bd\x2d9112\x2d4613\x2d8f48\x2d7f5c4aee074f.device @5.200s

Also, the output of the mount command is: (not sure if that helps)

proc on /proc type proc (rw,nosuid,nodev,noexec,relatime)
sys on /sys type sysfs (rw,nosuid,nodev,noexec,relatime)
dev on /dev type devtmpfs (rw,nosuid,relatime,size=1998876k,nr_inodes=499719,mode=755)
run on /run type tmpfs (rw,nosuid,nodev,relatime,mode=755)
/dev/sda6 on / type ext4 (rw,relatime,data=ordered)
securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime)
tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev)
devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000)
tmpfs on /sys/fs/cgroup type tmpfs (rw,nosuid,nodev,noexec,mode=755)
cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,release_agent=/usr/lib/systemd/systemd-cgroups-agent,name=systemd)
pstore on /sys/fs/pstore type pstore (rw,nosuid,nodev,noexec,relatime)
cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset)
cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpuacct,cpu)
cgroup on /sys/fs/cgroup/memory type cgroup (rw,nosuid,nodev,noexec,relatime,memory)
cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices)
cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer)
cgroup on /sys/fs/cgroup/net_cls type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls)
cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio)
systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=39,pgrp=1,timeout=300,minproto=5,maxproto=5,direct)
mqueue on /dev/mqueue type mqueue (rw,relatime)
hugetlbfs on /dev/hugepages type hugetlbfs (rw,relatime)
debugfs on /sys/kernel/debug type debugfs (rw,relatime)
configfs on /sys/kernel/config type configfs (rw,relatime)
tmpfs on /tmp type tmpfs (rw,nosuid,nodev,relatime)
/dev/sda3 on /boot type ext2 (rw,relatime)

And my /etc/fstab:

tmpfs                                       /tmp	tmpfs	nodev,nosuid	    0	    0
UUID=152477bd-9112-4613-8f48-7f5c4aee074f   /boot   ext2    defaults,relatime   0       1
UUID=6dee221a-d4b4-48f2-8510-ec9c02d57e84   /       ext4    defaults,relatime   0       2
UUID=14c7b2fa-e6ed-49aa-aa56-8b32947d3812   swap    swap    defaults            0       0

-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#9 2013-09-26 18:18:14

Pse
Member
Registered: 2008-03-15
Posts: 413

Re: Much slower boot speed after upgrading to systemd-207

Could you please try by removing or commenting the tmpfs line from /etc/fstab? It is not required when using systemd and I don't have it in my own config. Could you also please list the output of 'systemctl list-dependencies timers.target'?

Offline

#10 2013-09-26 22:53:03

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

Pse wrote:

Could you please try by removing or commenting the tmpfs line from /etc/fstab?

Done, but no change.

Could you also please list the output of 'systemctl list-dependencies timers.target'?

Sure. Here you are:

timers.target
└─systemd-tmpfiles-clean.timer

But I believe that the problem is on socket creation. After 207 update, the system hags for some seconds (varies from 6-12 iirc) in Reached Targets Sockets message. Also, journal is complaining about dbus (and dbus for user) sockets not found.

Last edited by Thanoulis (2013-09-26 23:15:37)


-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#11 2013-09-26 23:26:33

cfr
Member
From: Cymru
Registered: 2011-11-27
Posts: 7,148

Re: Much slower boot speed after upgrading to systemd-207

Also, in fstab:
/ should be "0 1" at the end
/boot should be "0 2".

The journal tells you where to look for information about those errors. In particular, it tells you to use systemctl to get more information. You need to figure out what is causing those targets to fail.


CLI Paste | How To Ask Questions

Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L

Offline

#12 2013-09-26 23:44:20

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

cfr wrote:

Also, in fstab:
/ should be "0 1" at the end
/boot should be "0 2".

Fixed. Thank you.

The journal tells you where to look for information about those errors. In particular, it tells you to use systemctl to get more information. You need to figure out what is causing those targets to fail.

That's exactly the problem. As I posted above, there is no failing job, and the complaining about "not found" sockets is fictional, as I can see them in my filesystem.


-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#13 2013-09-26 23:55:14

cfr
Member
From: Cymru
Registered: 2011-11-27
Posts: 7,148

Re: Much slower boot speed after upgrading to systemd-207

Did you run the suggested commands? What was the output?


CLI Paste | How To Ask Questions

Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L

Offline

#14 2013-09-27 00:08:46

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

cfr wrote:

Did you run the suggested commands? What was the output?

systemctl --failed:

0 loaded units listed. Pass --all to see loaded but inactive units, too.
To show all installed unit files use 'systemctl list-unit-files'.

systemctl --all:

UNIT                       LOAD   ACTIVE   SUB       DESCRIPTION
proc-sys..._misc.automount loaded active   waiting   Arbitrary Executable File F
dev-cdrom.device           loaded active   plugged   TSSTcorp_DVD+_-RW_TS-U633A
dev-disk...x2dU633A.device loaded active   plugged   TSSTcorp_DVD+_-RW_TS-U633A
dev-disk...09AV5674.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart1.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart2.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart3.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart4.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart5.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart6.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...580ce16f.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart1.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart2.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart3.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart4.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart5.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...x2dpart6.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...\xce\xb1.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...bel-Boot.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...lesystem.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...bel-Swap.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...947d3812.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...4aee074f.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...02d57e84.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...868B1A31.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-disk...8C4A56E6.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sda.device             loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sda1.device            loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sda2.device            loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sda3.device            loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sda4.device            loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sda5.device            loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sda6.device            loaded active   plugged   WDC_WD1600BJKT-75F4T0
dev-sr0.device             loaded active   plugged   TSSTcorp_DVD+_-RW_TS-U633A
dev-ttyS0.device           loaded active   plugged   /dev/ttyS0
dev-ttyS1.device           loaded active   plugged   /dev/ttyS1
dev-ttyS2.device           loaded active   plugged   /dev/ttyS2
dev-ttyS3.device           loaded active   plugged   /dev/ttyS3
sys-devi...i_video0.device loaded active   plugged   /sys/devices/pci0000:00/000
sys-devi...-net-eth.device loaded active   plugged   82567LM Gigabit Network Con
sys-devi...nd-card0.device loaded active   plugged   82801I (ICH9 Family) HD Aud
sys-devi...net-wlan.device loaded active   plugged   Wireless 1510 Wireless-N WL
sys-devi...sda-sda1.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
sys-devi...sda-sda2.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
sys-devi...sda-sda3.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
sys-devi...sda-sda4.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
sys-devi...sda-sda5.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
sys-devi...sda-sda6.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
sys-devi...lock-sda.device loaded active   plugged   WDC_WD1600BJKT-75F4T0
sys-devi...lock-sr0.device loaded active   plugged   TSSTcorp_DVD+_-RW_TS-U633A
sys-devi...ty-ttyS0.device loaded active   plugged   /sys/devices/platform/seria
sys-devi...ty-ttyS1.device loaded active   plugged   /sys/devices/platform/seria
sys-devi...ty-ttyS2.device loaded active   plugged   /sys/devices/platform/seria
sys-devi...ty-ttyS3.device loaded active   plugged   /sys/devices/platform/seria
sys-module-configfs.device loaded active   plugged   /sys/module/configfs
sys-subs...ices-eth.device loaded active   plugged   82567LM Gigabit Network Con
sys-subs...ces-wlan.device loaded active   plugged   Wireless 1510 Wireless-N WL
-.mount                    loaded active   mounted   /
boot.mount                 loaded active   mounted   /boot
dev-hugepages.mount        loaded active   mounted   Huge Pages File System
dev-mqueue.mount           loaded active   mounted   POSIX Message Queue File Sy
proc-sys...nfmt_misc.mount loaded inactive dead      Arbitrary Executable File F
sys-fs-f...nnections.mount loaded inactive dead      FUSE Control File System
sys-kernel-config.mount    loaded active   mounted   Configuration File System
sys-kernel-debug.mount     loaded active   mounted   Debug File System
tmp.mount                  loaded active   mounted   Temporary Directory
systemd-...rd-console.path loaded active   waiting   Dispatch Password Requests 
systemd-...sword-wall.path loaded active   waiting   Forward Password Requests t
session-1.scope            loaded active   running   Session 1 of user thanoulis
alsa-restore.service       loaded inactive dead      Restore Sound Card State
alsa-state.service         loaded inactive dead      Manage Sound Card State (re
alsa-store.service         loaded inactive dead      Store Sound Card State
auditd.service             not-found inactive dead      auditd.service
cronie.service             loaded active   running   Periodic Command Scheduler
dbus.service               loaded active   running   D-Bus System Message Bus
dmeventd.service           loaded inactive dead      Device-mapper event daemon
emergency.service          loaded inactive dead      Emergency Shell
getty@tty1.service         loaded active   running   Getty on tty1
kmod-static-nodes.service  loaded active   exited    Create list of required sta
lvmetad.service            loaded inactive dead      LVM2 metadata daemon
netctl-auto@wlan.service   loaded active   running   Automatic wireless network 
plymouth-quit-wait.service not-found inactive dead      plymouth-quit-wait.service
plymouth-start.service     not-found inactive dead      plymouth-start.service
rescue.service             loaded inactive dead      Rescue Shell
sshd.service               loaded active   running   OpenSSH Daemon
sshdgenkeys.service        loaded inactive dead      SSH Key Generation
syslog.service             not-found inactive dead      syslog.service
systemd-...console.service loaded inactive dead      Dispatch Password Requests 
systemd-...rd-wall.service loaded inactive dead      Forward Password Requests t
systemd-..._video0.service loaded active   exited    Load/Save Screen Backlight 
systemd-binfmt.service     loaded inactive dead      Set Up Additional Binary Fo
systemd-fsck-root.service  loaded inactive dead      File System Check on Root D
systemd-...aee074f.service loaded active   exited    File System Check on /dev/d
systemd-initctl.service    loaded inactive dead      /dev/initctl Compatibility 
systemd-...l-flush.service loaded inactive dead      Trigger Flushing of Journal
systemd-journald.service   loaded active   running   Journal Service
systemd-logind.service     loaded active   running   Login Service
systemd-...es-load.service loaded inactive dead      Load Kernel Modules
systemd-...om-seed.service loaded active   exited    Load/Save Random Seed
systemd-...collect.service loaded active   exited    Collect Read-Ahead Data
systemd-...ad-done.service loaded inactive dead      Stop Read-Ahead Data Collec
systemd-...-replay.service loaded active   exited    Replay Read-Ahead Data
systemd-remount-fs.service loaded active   exited    Remount Root and Kernel Fil
systemd-shutdownd.service  loaded inactive dead      Delayed Shutdown Service
systemd-sysctl.service     loaded active   exited    Apply Kernel Variables
systemd-...s-clean.service loaded inactive dead      Cleanup of Temporary Direct
systemd-...tup-dev.service loaded active   exited    Create static device nodes 
systemd-...s-setup.service loaded active   exited    Recreate Volatile Files and
systemd-...trigger.service loaded active   exited    udev Coldplug all Devices
systemd-udevd.service      loaded active   running   udev Kernel Device Manager
systemd-...te-utmp.service loaded active   exited    Update UTMP about System Re
systemd-...essions.service loaded active   exited    Permit User Sessions
systemd-...e-setup.service loaded active   exited    Setup Virtual Console
user@1000.service          loaded active   running   User Manager for 1000
-.slice                    loaded active   active    Root Slice
system-getty.slice         loaded active   active    system-getty.slice
system-n...l\x2dauto.slice loaded active   active    system-netctl\x2dauto.slice
system-s...backlight.slice loaded inactive dead      system-systemd\x2dbacklight
system-s...d\x2dfsck.slice loaded inactive dead      system-systemd\x2dfsck.slic
system.slice               loaded active   active    System Slice
user-1000.slice            loaded active   active    user-1000.slice
user.slice                 loaded active   active    User and Session Slice
dbus.socket                loaded active   running   D-Bus System Message Bus So
dmeventd.socket            loaded active   listening Device-mapper event daemon 
lvmetad.socket             loaded active   listening LVM2 metadata daemon socket
syslog.socket              loaded inactive dead      Syslog Socket
systemd-initctl.socket     loaded active   listening /dev/initctl Compatibility 
systemd-journald.socket    loaded active   running   Journal Socket
systemd-shutdownd.socket   loaded active   listening Delayed Shutdown Socket
systemd-...-control.socket loaded active   running   udev Control Socket
systemd-...d-kernel.socket loaded active   running   udev Kernel Socket
dev-disk...4\x2dpart5.swap loaded active   active    /dev/disk/by-id/ata-WDC_WD1
dev-disk...f\x2dpart5.swap loaded active   active    /dev/disk/by-id/wwn-0x50014
dev-disk...label-Swap.swap loaded active   active    /dev/disk/by-label/Swap
dev-disk...32947d3812.swap loaded active   active    /dev/disk/by-uuid/14c7b2fa-
dev-sda5.swap              loaded active   active    /dev/sda5
basic.target               loaded active   active    Basic System
cryptsetup.target          loaded active   active    Encrypted Volumes
emergency.target           loaded inactive dead      Emergency Mode
getty.target               loaded active   active    Login Prompts
local-fs-pre.target        loaded active   active    Local File Systems (Pre)
local-fs.target            loaded active   active    Local File Systems
multi-user.target          loaded active   active    Multi-User System
network.target             loaded active   active    Network
nss-user-lookup.target     loaded inactive dead      User and Group Name Lookups
paths.target               loaded active   active    Paths
remote-fs-pre.target       loaded inactive dead      Remote File Systems (Pre)
remote-fs.target           loaded active   active    Remote File Systems
rescue.target              loaded inactive dead      Rescue Mode
shutdown.target            loaded inactive dead      Shutdown
slices.target              loaded active   active    Slices
sockets.target             loaded active   active    Sockets
sound.target               loaded active   active    Sound Card
swap.target                loaded active   active    Swap
sysinit.target             loaded active   active    System Initialization
syslog.target              not-found inactive dead      syslog.target
timers.target              loaded active   active    Timers
umount.target              loaded inactive dead      Unmount All Filesystems
systemd-...head-done.timer loaded active   elapsed   Stop Read-Ahead Data Collec
systemd-...les-clean.timer loaded active   waiting   Daily Cleanup of Temporary 

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.

160 loaded units listed.
To show all installed unit files use 'systemctl list-unit-files'.

systemctl list-unit-files:

UNIT FILE                              STATE   
proc-sys-fs-binfmt_misc.automount      static  
dev-hugepages.mount                    static  
dev-mqueue.mount                       static  
proc-sys-fs-binfmt_misc.mount          static  
sys-fs-fuse-connections.mount          static  
sys-kernel-config.mount                static  
sys-kernel-debug.mount                 static  
tmp.mount                              static  
systemd-ask-password-console.path      static  
systemd-ask-password-wall.path         static  
session-1.scope                        static  
alsa-restore.service                   static  
alsa-state.service                     static  
alsa-store.service                     static  
autovt@.service                        disabled
avahi-daemon.service                   disabled
avahi-dnsconfd.service                 disabled
console-getty.service                  disabled
console-shell.service                  disabled
cronie.service                         enabled 
dbus-org.freedesktop.hostname1.service static  
dbus-org.freedesktop.locale1.service   static  
dbus-org.freedesktop.login1.service    static  
dbus-org.freedesktop.machine1.service  static  
dbus-org.freedesktop.timedate1.service static  
dbus.service                           static  
debug-shell.service                    disabled
dhcpcd.service                         disabled
dhcpcd@.service                        disabled
dmeventd.service                       static  
emergency.service                      static  
ftpd.service                           disabled
getty@.service                         enabled 
git-daemon@.service                    static  
gpm.service                            disabled
initrd-cleanup.service                 static  
initrd-parse-etc.service               static  
initrd-switch-root.service             static  
initrd-udevadm-cleanup-db.service      static  
ip6tables.service                      disabled
iptables.service                       disabled
irexec.service                         disabled
kmod-static-nodes.service              static  
krb5-kadmind.service                   disabled
krb5-kdc.service                       disabled
krb5-kpropd.service                    disabled
krb5-kpropd@.service                   static  
lirc.service                           disabled
lircm.service                          disabled
lvm-monitoring.service                 disabled
lvmetad.service                        static  
mdadm.service                          disabled
netctl-auto@.service                   disabled
netctl-ifplugd@.service                disabled
netctl-sleep.service                   disabled
netctl.service                         disabled
netctl@.service                        static  
nscd.service                           disabled
polkit.service                         static  
ppp@.service                           disabled
quotaon.service                        static  
rescue.service                         static  
rfkill-block@.service                  disabled
rfkill-unblock@.service                disabled
serial-getty@.service                  static  
sshd.service                           enabled 
sshd@.service                          static  
sshdgenkeys.service                    enabled 
systemd-ask-password-console.service   static  
systemd-ask-password-wall.service      static  
systemd-backlight@.service             static  
systemd-binfmt.service                 static  
systemd-fsck-root.service              static  
systemd-fsck@.service                  static  
systemd-halt.service                   static  
systemd-hibernate.service              static  
systemd-hostnamed.service              static  
systemd-hybrid-sleep.service           static  
systemd-initctl.service                static  
systemd-journal-flush.service          static  
systemd-journal-gatewayd.service       static  
systemd-journald.service               static  
systemd-kexec.service                  static  
systemd-localed.service                static  
systemd-logind.service                 static  
systemd-machined.service               static  
systemd-modules-load.service           static  
systemd-nspawn@.service                static  
systemd-poweroff.service               static  
systemd-quotacheck.service             static  
systemd-random-seed.service            static  
systemd-readahead-collect.service      enabled 
systemd-readahead-done.service         static  
systemd-readahead-drop.service         enabled 
systemd-readahead-replay.service       enabled 
systemd-reboot.service                 static  
systemd-remount-fs.service             static  
systemd-shutdownd.service              static  
systemd-suspend.service                static  
systemd-sysctl.service                 static  
systemd-timedated.service              static  
systemd-tmpfiles-clean.service         static  
systemd-tmpfiles-setup-dev.service     static  
systemd-tmpfiles-setup.service         static  
systemd-udev-settle.service            static  
systemd-udev-trigger.service           static  
systemd-udevd.service                  static  
systemd-update-utmp-runlevel.service   static  
systemd-update-utmp.service            static  
systemd-user-sessions.service          static  
systemd-vconsole-setup.service         static  
user@.service                          static  
uuidd.service                          static  
wesnothd.service                       disabled
wpa_supplicant-nl80211@.service        disabled
wpa_supplicant-wired@.service          disabled
wpa_supplicant.service                 disabled
wpa_supplicant@.service                disabled
-.slice                                static  
machine.slice                          static  
system.slice                           static  
user.slice                             static  
avahi-daemon.socket                    disabled
dbus.socket                            static  
dmeventd.socket                        static  
git-daemon.socket                      disabled
krb5-kpropd.socket                     disabled
lvmetad.socket                         static  
sshd.socket                            disabled
syslog.socket                          static  
systemd-initctl.socket                 static  
systemd-journal-gatewayd.socket        disabled
systemd-journald.socket                static  
systemd-shutdownd.socket               static  
systemd-udevd-control.socket           static  
systemd-udevd-kernel.socket            static  
uuidd.socket                           disabled
basic.target                           static  
bluetooth.target                       static  
cryptsetup.target                      static  
ctrl-alt-del.target                    disabled
default.target                         enabled 
emergency.target                       static  
final.target                           static  
getty.target                           static  
graphical.target                       disabled
halt.target                            disabled
hibernate.target                       static  
hybrid-sleep.target                    static  
initrd-fs.target                       static  
initrd-root-fs.target                  static  
initrd-switch-root.target              static  
initrd.target                          static  
kexec.target                           disabled
local-fs-pre.target                    static  
local-fs.target                        static  
multi-user.target                      enabled 
network-online.target                  static  
network.target                         static  
nss-lookup.target                      static  
nss-user-lookup.target                 static  
paths.target                           static  
poweroff.target                        disabled
printer.target                         static  
reboot.target                          disabled
remote-fs-pre.target                   static  
remote-fs.target                       enabled 
rescue.target                          disabled
rpcbind.target                         static  
shutdown.target                        static  
sigpwr.target                          static  
sleep.target                           static  
slices.target                          static  
smartcard.target                       static  
sockets.target                         static  
sound.target                           static  
suspend.target                         static  
swap.target                            static  
sysinit.target                         static  
system-update.target                   static  
time-sync.target                       static  
timers.target                          static  
umount.target                          static  
systemd-readahead-done.timer           static  
systemd-tmpfiles-clean.timer           static  

185 unit files listed.

-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#15 2013-09-27 01:52:12

cfr
Member
From: Cymru
Registered: 2011-11-27
Posts: 7,148

Re: Much slower boot speed after upgrading to systemd-207

Thanoulis wrote:

journalctl shows these errors:

Cannot add dependency job for unit local-fs.target, ignoring: Unit local-fs.target failed to load: No such file or directory
Cannot add dependency job for unit swap.target, ignoring: Unit swap.target failed to load: No such file or directory. 
Cannot add dependency job for unit timers.target, ignoring: Unit timers.target failed to load: No such file or directory.
Cannot add dependency job for unit paths.target, ignoring: Unit paths.target failed to load: No such file or directory.
Cannot add dependency job for unit slices.target, ignoring: Unit slices.target failed to load: No such file or directory.

Look at the full output you posted from journalctl and notice it gives you a command for each of these failed targets.

EDIT: What you are looking at is just giving you the current status. But you want to know the history of those targets. The commands it is giving you should tell you that.

Last edited by cfr (2013-09-27 01:55:36)


CLI Paste | How To Ask Questions

Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L

Offline

#16 2013-09-27 10:17:26

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

cfr wrote:
Thanoulis wrote:

journalctl shows these errors:

Cannot add dependency job for unit local-fs.target, ignoring: Unit local-fs.target failed to load: No such file or directory
Cannot add dependency job for unit swap.target, ignoring: Unit swap.target failed to load: No such file or directory. 
Cannot add dependency job for unit timers.target, ignoring: Unit timers.target failed to load: No such file or directory.
Cannot add dependency job for unit paths.target, ignoring: Unit paths.target failed to load: No such file or directory.
Cannot add dependency job for unit slices.target, ignoring: Unit slices.target failed to load: No such file or directory.

Look at the full output you posted from journalctl and notice it gives you a command for each of these failed targets.

EDIT: What you are looking at is just giving you the current status. But you want to know the history of those targets. The commands it is giving you should tell you that.

Oh, you talk about these messages...it's nothing to worry about as seen in https://bugs.archlinux.org/task/37012?p … om=-1+week
Just to cover your curiosity, here is the output of systemctl status local-fs.target (the other {swap, timers, paths, slices}.target seem the same):

local-fs.target - Local File Systems
   Loaded: loaded (/usr/lib/systemd/system/local-fs.target; static)
   Active: active since Fri 2013-09-27 13:13:18 EEST; 1min 8s ago
     Docs: man:systemd.special(7)

Sep 27 13:13:18 LatitudePC systemd[1]: Starting Local File Systems.
Sep 27 13:13:18 LatitudePC systemd[1]: Reached target Local File Systems.

-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#17 2013-09-27 22:30:23

cfr
Member
From: Cymru
Registered: 2011-11-27
Posts: 7,148

Re: Much slower boot speed after upgrading to systemd-207

Oh, right. Thanks. That explains why I don't see those errors but you do. I didn't realise the systemd hook caused that. Sorry for polluting the thread.


CLI Paste | How To Ask Questions

Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L

Offline

#18 2013-09-27 22:58:52

Pse
Member
Registered: 2008-03-15
Posts: 413

Re: Much slower boot speed after upgrading to systemd-207

Do you have any files in /etc/tmpfiles.d? If so, what are their contents? Could you also please run systemd-bootchart to get a more detailed look at the init sequence? Just add init=/usr/lib/systemd/systemd-bootchart to the kernel command line and look for the output in /run/log.

Offline

#19 2013-09-27 23:31:24

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

Pse wrote:

Do you have any files in /etc/tmpfiles.d? If so, what are their contents?

No, my /etc/tmpfiles.d/ is completely empty.

Could you also please run systemd-bootchart to get a more detailed look at the init sequence? Just add init=/usr/lib/systemd/systemd-bootchart to the kernel command line and look for the output in /run/log.

I'm sorry, but I couldn't manage to successfully boot with init=/usr/lib/systemd/systemd-bootchart (tried it several times). It hangs at:

systemd-bootchart wrote /run/log/bootchart-20130928-0223.svg

Waited for it up to ~10 minutes, but it didn't seem to do anything. Unfortunately, /run/log/ directory is empty after normal reboot.

EDIT: Changed Output parameter in /etc/systemd/bootchart.conf to /var/log/ and this time I managed to get a bootchart.svg file (but I didn't manage to boot). Hope it's all there.

Last edited by Thanoulis (2013-09-28 00:06:20)


-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#20 2013-09-28 02:34:04

Pse
Member
Registered: 2008-03-15
Posts: 413

Re: Much slower boot speed after upgrading to systemd-207

Hmm, that looks incomplete. Would you mind disabling the initrd systemd hook, rebuilding the initrd image and running bootchart again? I think the systemd version in the initrd may be causing bootchart to misbehave.

Edit: would you mind posting the list of files in /usr/lib/tmpfiles.d and /run/tmpfiles.d?

Last edited by Pse (2013-09-28 02:35:36)

Offline

#21 2013-09-28 09:31:40

Thanoulis
Member
From: Lamia, Greece
Registered: 2009-05-03
Posts: 33
Website

Re: Much slower boot speed after upgrading to systemd-207

Pse wrote:

Hmm, that looks incomplete. Would you mind disabling the initrd systemd hook, rebuilding the initrd image and running bootchart again? I think the systemd version in the initrd may be causing bootchart to misbehave.

You were right. Here is the new bootchart.svg.  It seems funny systemd hook to block systemd-bootchart.

would you mind posting the list of files in /usr/lib/tmpfiles.d and /run/tmpfiles.d?

/usr/lib/tmpfiles.d/ :

-rw-r--r-- 1 root root   30 Sep 20 01:12 console.conf
-rw-r--r-- 1 root root   34 May 30 16:17 lastlog.conf
-rw-r--r-- 1 root root 1.2K Sep 20 01:12 legacy.conf
-rw-r--r-- 1 root root   29 Sep 15 14:28 lirc.conf
-rw-r--r-- 1 root root   61 Aug 13 23:22 lvm2.conf
-rw-r--r-- 1 root root  111 Sep 24 08:47 nscd.conf
-rw-r--r-- 1 root root  777 Sep 20 01:12 systemd.conf
-rw-r--r-- 1 root root  626 Sep 20 01:12 tmp.conf
-rw-r--r-- 1 root root   30 Jul 31 16:15 uuidd.conf
-rw-r--r-- 1 root root   33 Aug 20 16:58 wesnothd.conf
-rw-r--r-- 1 root root  622 Sep 20 01:12 x11.conf

/run/tmpfiles.d/ :

-rw-r--r-- 1 root root 494 Sep 28 12:23 kmod.conf

-- Beware of he who would deny you access to information, for in his heart he dreams himself your master.

Offline

#22 2013-09-30 15:30:54

Kalrish
Member
Registered: 2013-02-27
Posts: 62

Re: Much slower boot speed after upgrading to systemd-207

I'm suffering the same problems as you. I tried to find the source of the problem, but was unable to do so. Now, following the suggestions in this thread, I'm giving it a try again - hope this time gets solved.

I'm interested to see if the same has happened to anyone out there.

Best regards,
Kalrish

Offline

#23 2013-10-03 12:22:10

replabrobin
Member
Registered: 2010-05-06
Posts: 234

Re: Much slower boot speed after upgrading to systemd-207

With systemd-207 & systemd in the mkinitcpio.conf instead of udev I am also seeing a slow response to the sockets service. From my boot I see Sockets starting twice eg

.....
Oct 03 12:40:38 localhost systemd[1]: Starting Sockets.
Oct 03 12:40:38 localhost systemd[1]: Reached target Sockets.
......
Oct 03 12:40:39 localhost systemd[1]: Stopped target Basic System.
Oct 03 12:40:39 localhost systemd[1]: Stopping Sockets.
Oct 03 12:40:39 localhost systemd[1]: Stopped target Sockets.
Oct 03 12:40:39 localhost systemd[1]: Stopping System Initialization.
......
Oct 03 12:40:44 everest systemd[1]: Listening on D-Bus System Message Bus Socket.
Oct 03 12:40:44 everest systemd[1]: Starting Sockets.
Oct 03 12:40:44 everest systemd[1]: Reached target Sockets.
Oct 03 12:41:02 everest systemd[1]: Starting Daily Cleanup of Temporary Directories.

So I hang for 18 seconds after the last reached target Sockets.

I have no errors in journalctl -b -p err prior to 12:41:06 ("Writing to ADC failed!" sound related I think). So I am mystified. I have no entries in fstab on this machine.

Edit: In fact I think my slow speed has little to do with systemd hook; I'm seeing the same with udev replacing systemd. My critical chain slowdown is timers.target-->basic.target (20seconds).

Edit: The problem persists for me with systemd-208-1 still have a 20+second hang

Last edited by replabrobin (2013-10-04 14:56:42)

Offline

#24 2013-10-03 12:26:25

orschiro
Member
Registered: 2009-06-04
Posts: 2,136
Website

Re: Much slower boot speed after upgrading to systemd-207

I am also running systemd 207-5, yet without any issues. Where is it explicitly stated that you should replace udev with systemd in mkinitcpio.conf?

My line looks as follows:

HOOKS="base udev autodetect modconf block lvm2 resume filesystems keyboard fsck"

Offline

#25 2013-10-03 14:34:45

replabrobin
Member
Registered: 2010-05-06
Posts: 234

Re: Much slower boot speed after upgrading to systemd-207

I'm taking my cue from https://wiki.archlinux.org/index.php/Mkinitcpio.conf

systemd: 	This will install a basic systemd setup in your initramfs, and is meant to replace 
the 'base', 'usr', 'udev' and 'timestamp' hooks.
Other hooks (like encryption) would need to be ported, and may not work as intended. 
As of systemd 207, this hook does not work as intended when combined with lvm2 and may break your boot. 
You also may wish to still include the 'base' hook (before this hook) to ensure that a rescue shell exists
on your initramfs. 

Offline

Board footer

Powered by FluxBB