Hi,
On 01/13/2015 09:32 PM, Dmitry Monakhov wrote:
> Xiaoguang Wang <wangxg.fnst@xxxxxxxxxxxxxx> writes:
>
>> Hi,
>>
>> On 12/10/2014 06:25 PM, Dmitry Monakhov wrote:
>>> Xiaoguang Wang <wangxg.fnst@xxxxxxxxxxxxxx> writes:
>>>
>>>> Hi,
>>>>
>>>> On 10/23/2014 09:03 PM, Dmitry Monakhov wrote:
>>>>> Dmitry Monakhov <dmonakhov@xxxxxxxxxx> writes:
>>>>>
>>>>>> In hard core test-cases such as ext4/301, ext4/302 some bh may
>>>>>> becomes dirty so try_to_release_page() will fail and result in
>>>>>> false positive EBUSY failures. We can easily fix that by
>>>>>> explicit ->invalidatepage() after we holds page which is locked
>>>>>> and uptodate.
>>>>> Sorry. This patch is not correct. Please ignore it.
>>>>
>>>> Sorry to bother.
>>>> I'd like to know whether you're going to send patches to fix this issue, thanks?
>>> My initial patch was wrong. It is incorrect to use ->invalidatepage()
>>> inside ext4_move_extents
>>>>
>>>> If try_to_release_page(...) failed, some bh's state would be BH_Uptodate, BH_Dirty,
>>>> BH_Mapped and BH_Unwritten. In this patch, against such page, you call mext_page_mkuptodate(),
>>>> but it then calls bh_submit_read()... I wonder whether we should start some write
>>>> operation, thanks!
>>> If we found BH_Dirty page the only thing we can to is to drop all locks
>>> and start writeback on that page and then repeat attempt. Normally pages are
>>> not dirty, because sane users call fsync before move_extents.
>>> At the same time xfstests ext4/301,ext4/302, ext4/303 are stress tests so EBUSY is
>>> expected to happen. IMHO it is reasonable to add explicit
>>> filemap_write_and_wait_range() at the beginning of ext4_move_extents()
>>> But this can not helps avoid EBUSY on stress tests complitely.
>>> So I'll change xfstests to ignore EBUSY similar to ENOSPC.
>>> I'll be back with the patches.
>> I spent some time to look into this case again, trying to figure out how it fails and
>> how to fix it. Here is my conclusion, please have a check.
>> As we know, there are 3 different data modes: writeback, ordered and journal, and
>> enableing journal would disable delayed allocation and O_DIRECT support. So I think
>> indeed we have 5 choices:
>> ordered mode with delalloc
>> ordered mode with nodelalloc
>> writeback mode with delalloc
>> writeback mode with nodelalloc
>> journal mode.
>>
>> When 302 test case fails to me, its data mode is ordered mode with delalloc. I think the
>> reason is that:
>> ext4/302 test case is ext4 defragmentation stress test, which performs defragmentation
>> on file under buffered io while third task does direct io to donor file.
>>
>> 1, this test case first uses fio to create a file(using fallocate()), so this file's
>> corresponding extents' status will be unwritten.
>> 2, When one process writes to this file, because delalloc is enabled and corresponding
>> extent status is unwritten, ext4_ext_convert_to_initialized() won't also be called,
>> data buffer will not be managed by jbd2, and its status would be BH_Uptodate, BH_Dirty,
>> BH_Mapped and BH_Unwritten.
>> 3. When another process does ioctl(EXT4_IOC_MOVE_EXT) against this file with a donor file,
>> the below code: in move_extent_per_page() in fs/ext4/move_extent.c.
>>
>> if (unwritten) {
>> ...
>> if ((page_has_private(pagep[0]) &&
>> !try_to_release_page(pagep[0], 0)) ||
>> (page_has_private(pagep[1]) &&
>> !try_to_release_page(pagep[1], 0))) {
>> *err = -EBUSY;
>> goto drop_data_sem;
>> }
>> ...
>> }
>>
>> Here the try_to_release_page(pagep[0], 0) will surely return 0. Some buffers in this
>> page is not managed by jbd2, and is dirty. I think it will wait that mm writeback
>> subsystem to write back this page, every 30 seconds? So we will get a EBUSY error.
>> Meanwhile for this EBUSY error, I think this code in move_extent_per_page() won't make
>> much sense(As it's not managed by jbd2):
>> if (*err == -EBUSY && retries++ < 4 && EXT4_SB(sb)->s_journal &&
>> jbd2_journal_force_commit_nested(EXT4_SB(sb)->s_journal))
> page can be busy due to JBD or because it is dirty, so force_commit is
> reasonable, and as you already said it does not helps if page was dirty
> in order to fix that we have to force writeback for that region, but it
> can be redirtied again, so we can not avoid EBUSY completely
Right, I see, still the page can be dirtied again.
>> goto again;
>>
>> As Dmitry has said, sane users should call fsync before move_extents, but 302 test case does not do that.
>> So as a workaround, I'd like to have 302 test case run in ordered mode with nodelalloc, this case
>> will starts to succeed in my test environment.
>>
>> Ted and Dmitry, would you please have a check my analysis, if you agree so, I'll send patches to
>> fix 302 case :) And I think 303 fails to me because of the same reason, thanks!
> We can change 302 and 303 to simply ignore EBUSY, IMHO this acceptable
> since this is hard-core stress test.
OK, I'll send this path, and cc you, thanks for your patience!
Regards,
Xiaoguang Wang
>>
>> Regards,
>> Xiaoguang Wang
>>
>>>> I attached a log, which I once sent to you, thanks!
>>>>
>>>> Regards,
>>>> Xiaoguang Wang
>>>>
>>>>>>
>>>>>> Tested-by: Xiaoguang Wang<wangxg.fnst@xxxxxxxxxxxxxx>
>>>>>> Signed-off-by: Dmitry Monakhov <dmonakhov@xxxxxxxxxx>
>>>>>> ---
>>>>>> fs/ext4/move_extent.c | 10 +++++++---
>>>>>> 1 files changed, 7 insertions(+), 3 deletions(-)
>>>>>>
>>>>>> diff --git a/fs/ext4/move_extent.c b/fs/ext4/move_extent.c
>>>>>> index c2b2b02..76c45b6 100644
>>>>>> --- a/fs/ext4/move_extent.c
>>>>>> +++ b/fs/ext4/move_extent.c
>>>>>> @@ -348,8 +348,9 @@ again:
>>>>>> !try_to_release_page(pagep[0], 0)) ||
>>>>>> (page_has_private(pagep[1]) &&
>>>>>> !try_to_release_page(pagep[1], 0))) {
>>>>>> - *err = -EBUSY;
>>>>>> - goto drop_data_sem;
>>>>>> + /* One of buffers is busy, fall back data copy */
>>>>>> + ext4_double_up_write_data_sem(orig_inode, donor_inode);
>>>>>> + goto data_copy;
>>>>>> }
>>>>>> replaced_count = ext4_swap_extents(handle, orig_inode,
>>>>>> donor_inode, orig_blk_offset,
>>>>>> @@ -360,12 +361,15 @@ again:
>>>>>> goto unlock_pages;
>>>>>> }
>>>>>> data_copy:
>>>>>> - *err = mext_page_mkuptodate(pagep[0], from, from + replaced_size);
>>>>>> + /* In order to drop all buffers we have to make page fully uptodate */
>>>>>> + *err = mext_page_mkuptodate(pagep[0], 0, PAGE_CACHE_SIZE);
>>>>>> if (*err)
>>>>>> goto unlock_pages;
>>>>>>
>>>>>> /* At this point all buffers in range are uptodate, old mapping layout
>>>>>> * is no longer required, try to drop it now. */
>>>>>> + do_invalidatepage(pagep[0], 0, PAGE_CACHE_SIZE);
>>>>>> + do_invalidatepage(pagep[1], 0, PAGE_CACHE_SIZE);
>>>>>> if ((page_has_private(pagep[0]) && !try_to_release_page(pagep[0], 0)) ||
>>>>>> (page_has_private(pagep[1]) && !try_to_release_page(pagep[1], 0))) {
>>>>>> *err = -EBUSY;
>>>>>> --
>>>>>> 1.7.1
>>>>>>
>>>>>> --
>>>>>> To unsubscribe from this list: send the line "unsubscribe linux-ext4" in
>>>>>> the body of a message to majordomo@xxxxxxxxxxxxxxx
>>>>>> More majordomo info at http://vger.kernel.org/majordomo-info.html
>>>>
>>>> >From a94dae03e2064548c2532ba7786a6cbc29b7bbc9 Mon Sep 17 00:00:00 2001
>>>> From: Dmitry Monakhov <dmonakhov@xxxxxxxxxx>
>>>> Date: Fri, 17 Oct 2014 11:24:37 +0400
>>>> Subject: [PATCH] patch bh-debug.patch
>>>>
>>>>
>>>> Signed-off-by: Dmitry Monakhov <dmonakhov@xxxxxxxxxx>
>>>> ---
>>>> fs/ext4/move_extent.c | 33 ++++++++++++++++++++++++++++-----
>>>> 1 files changed, 28 insertions(+), 5 deletions(-)
>>>>
>>>> diff --git a/fs/ext4/move_extent.c b/fs/ext4/move_extent.c
>>>> index c2b2b02..84ceed1 100644
>>>> --- a/fs/ext4/move_extent.c
>>>> +++ b/fs/ext4/move_extent.c
>>>> @@ -239,6 +239,21 @@ out:
>>>> return 0;
>>>> }
>>>>
>>>> +
>>>> +static void dump_buffers(struct page *page)
>>>> +{
>>>> + struct buffer_head *head = page_buffers(page);
>>>> + struct buffer_head *bh;
>>>> +
>>>> + printk("%s ino:%ld page:%p idx:%lx fl:%lx\n", __FUNCTION__,
>>>> + page->mapping->host->i_ino, page, page->index, page->flags);
>>>> + bh = head;
>>>> + do {
>>>> + printk("bh:%p count:%d state:%lx\n",
>>>> + bh, atomic_read(&bh->b_count), bh->b_state);
>>>> + bh = bh->b_this_page;
>>>> + } while (bh != head);
>>>> +}
>>>> /**
>>>> * move_extent_per_page - Move extent data per page
>>>> *
>>>> @@ -344,10 +359,17 @@ again:
>>>> ext4_double_up_write_data_sem(orig_inode, donor_inode);
>>>> goto data_copy;
>>>> }
>>>> - if ((page_has_private(pagep[0]) &&
>>>> - !try_to_release_page(pagep[0], 0)) ||
>>>> - (page_has_private(pagep[1]) &&
>>>> - !try_to_release_page(pagep[1], 0))) {
>>>> + if ((page_has_private(pagep[0]) && !try_to_release_page(pagep[0], 0))) {
>>>> + if (retries > 95)
>>>> + dump_buffers(pagep[0]);
>>>> +
>>>> + *err = -EBUSY;
>>>> + goto drop_data_sem;
>>>> + }
>>>> + if ((page_has_private(pagep[1]) && !try_to_release_page(pagep[1], 0))) {
>>>> + if (retries > 95)
>>>> + dump_buffers(pagep[1]);
>>>> +
>>>> *err = -EBUSY;
>>>> goto drop_data_sem;
>>>> }
>>>> @@ -408,10 +430,11 @@ stop_journal:
>>>> /* Buffer was busy because probably is pinned to journal transaction,
>>>> * force transaction commit may help to free it. */
>>>> if (*err == -EBUSY &&
>>>> - (retries++ < 4 && EXT4_SB(orig_inode->i_sb)->s_journal &&
>>>> + (retries++ < 100 && EXT4_SB(orig_inode->i_sb)->s_journal &&
>>>> jbd2_journal_force_commit_nested(
>>>> EXT4_SB(orig_inode->i_sb)->s_journal)))
>>>> goto again;
>>>> +
>>>> return replaced_count;
>>>>
>>>> repair_branches:
>>>> --
>>>> 1.7.1
>>>>
>>>> [ 0.000000] Initializing cgroup subsys cpuset
>>>> [ 0.000000] Initializing cgroup subsys cpu
>>>> [ 0.000000] Initializing cgroup subsys cpuacct
>>>> [ 0.000000] Linux version 3.17.0-rc2+ (root@localhost.localdomain) (gcc version 4.8.2 20140120 (Red Hat 4.8.2-16) (GCC) ) #7 SMP Tue Oct 21 03:22:38 EDT 2014
>>>> [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.17.0-rc2+ root=UUID=181da3e4-9fad-4bea-8f45-0d7fca5ae2b6 ro vconsole.keymap=us crashkernel=auto vconsole.font=latarcyrheb-sun16 rhgb quiet LANG=en_US.UTF-8 /dev/sda3
>>>> [ 0.000000] e820: BIOS-provided physical RAM map:
>>>> [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
>>>> [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
>>>> [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
>>>> [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007fffdfff] usable
>>>> [ 0.000000] BIOS-e820: [mem 0x000000007fffe000-0x000000007fffffff] reserved
>>>> [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
>>>> [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
>>>> [ 0.000000] NX (Execute Disable) protection: active
>>>> [ 0.000000] SMBIOS 2.4 present.
>>>> [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011
>>>> [ 0.000000] Hypervisor detected: KVM
>>>> [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
>>>> [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
>>>> [ 0.000000] AGP: No AGP bridge found
>>>> [ 0.000000] e820: last_pfn = 0x7fffe max_arch_pfn = 0x400000000
>>>> [ 0.000000] MTRR default type: write-back
>>>> [ 0.000000] MTRR fixed ranges enabled:
>>>> [ 0.000000] 00000-9FFFF write-back
>>>> [ 0.000000] A0000-BFFFF uncachable
>>>> [ 0.000000] C0000-FFFFF write-protect
>>>> [ 0.000000] MTRR variable ranges enabled:
>>>> [ 0.000000] 0 base 0080000000 mask FF80000000 uncachable
>>>> [ 0.000000] 1 disabled
>>>> [ 0.000000] 2 disabled
>>>> [ 0.000000] 3 disabled
>>>> [ 0.000000] 4 disabled
>>>> [ 0.000000] 5 disabled
>>>> [ 0.000000] 6 disabled
>>>> [ 0.000000] 7 disabled
>>>> [ 0.000000] PAT not supported by CPU.
>>>> [ 0.000000] found SMP MP-table at [mem 0x000fda90-0x000fda9f] mapped at [ffff8800000fda90]
>>>> [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
>>>> [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
>>>> [ 0.000000] [mem 0x00000000-0x000fffff] page 4k
>>>> [ 0.000000] BRK [0x01f9c000, 0x01f9cfff] PGTABLE
>>>> [ 0.000000] BRK [0x01f9d000, 0x01f9dfff] PGTABLE
>>>> [ 0.000000] BRK [0x01f9e000, 0x01f9efff] PGTABLE
>>>> [ 0.000000] init_memory_mapping: [mem 0x7fc00000-0x7fdfffff]
>>>> [ 0.000000] [mem 0x7fc00000-0x7fdfffff] page 2M
>>>> [ 0.000000] BRK [0x01f9f000, 0x01f9ffff] PGTABLE
>>>> [ 0.000000] init_memory_mapping: [mem 0x7c000000-0x7fbfffff]
>>>> [ 0.000000] [mem 0x7c000000-0x7fbfffff] page 2M
>>>> [ 0.000000] init_memory_mapping: [mem 0x00100000-0x7bffffff]
>>>> [ 0.000000] [mem 0x00100000-0x001fffff] page 4k
>>>> [ 0.000000] [mem 0x00200000-0x7bffffff] page 2M
>>>> [ 0.000000] init_memory_mapping: [mem 0x7fe00000-0x7fffdfff]
>>>> [ 0.000000] [mem 0x7fe00000-0x7fffdfff] page 4k
>>>> [ 0.000000] BRK [0x01fa0000, 0x01fa0fff] PGTABLE
>>>> [ 0.000000] RAMDISK: [mem 0x34d30000-0x3668ffff]
>>>> [ 0.000000] ACPI: Early table checksum verification disabled
>>>> [ 0.000000] ACPI: RSDP 0x00000000000FD8B0 000014 (v00 BOCHS )
>>>> [ 0.000000] ACPI: RSDT 0x000000007FFFE380 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
>>>> [ 0.000000] ACPI: FACP 0x000000007FFFFF80 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
>>>> [ 0.000000] ACPI: DSDT 0x000000007FFFE3C0 0011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528)
>>>> [ 0.000000] ACPI: FACS 0x000000007FFFFF40 000040
>>>> [ 0.000000] ACPI: SSDT 0x000000007FFFF6E0 000858 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001)
>>>> [ 0.000000] ACPI: APIC 0x000000007FFFF5B0 000090 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
>>>> [ 0.000000] ACPI: HPET 0x000000007FFFF570 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
>>>> [ 0.000000] ACPI: Local APIC address 0xfee00000
>>>> [ 0.000000] No NUMA configuration found
>>>> [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000007fffdfff]
>>>> [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x7fffdfff]
>>>> [ 0.000000] NODE_DATA [mem 0x7ffd8000-0x7fffdfff]
>>>> [ 0.000000] kexec: crashkernel: memory value expected
>>>> [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
>>>> [ 0.000000] kvm-clock: cpu 0, msr 0:7ff58001, primary cpu clock
>>>> [ 0.000000] [ffffea0000000000-ffffea0001ffffff] PMD -> [ffff88007d600000-ffff88007f5fffff] on node 0
>>>> [ 0.000000] Zone ranges:
>>>> [ 0.000000] DMA [mem 0x00001000-0x00ffffff]
>>>> [ 0.000000] DMA32 [mem 0x01000000-0xffffffff]
>>>> [ 0.000000] Normal empty
>>>> [ 0.000000] Movable zone start for each node
>>>> [ 0.000000] Early memory node ranges
>>>> [ 0.000000] node 0: [mem 0x00001000-0x0009efff]
>>>> [ 0.000000] node 0: [mem 0x00100000-0x7fffdfff]
>>>> [ 0.000000] On node 0 totalpages: 524188
>>>> [ 0.000000] DMA zone: 64 pages used for memmap
>>>> [ 0.000000] DMA zone: 21 pages reserved
>>>> [ 0.000000] DMA zone: 3998 pages, LIFO batch:0
>>>> [ 0.000000] DMA32 zone: 8128 pages used for memmap
>>>> [ 0.000000] DMA32 zone: 520190 pages, LIFO batch:31
>>>> [ 0.000000] ACPI: PM-Timer IO Port: 0xb008
>>>> [ 0.000000] ACPI: Local APIC address 0xfee00000
>>>> [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
>>>> [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
>>>> [ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] enabled)
>>>> [ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] enabled)
>>>> [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
>>>> [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
>>>> [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
>>>> [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
>>>> [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
>>>> [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
>>>> [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
>>>> [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
>>>> [ 0.000000] ACPI: IRQ0 used by override.
>>>> [ 0.000000] ACPI: IRQ5 used by override.
>>>> [ 0.000000] ACPI: IRQ9 used by override.
>>>> [ 0.000000] ACPI: IRQ10 used by override.
>>>> [ 0.000000] ACPI: IRQ11 used by override.
>>>> [ 0.000000] Using ACPI (MADT) for SMP configuration information
>>>> [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
>>>> [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
>>>> [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
>>>> [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
>>>> [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
>>>> [ 0.000000] e820: [mem 0x80000000-0xfeffbfff] available for PCI devices
>>>> [ 0.000000] Booting paravirtualized kernel on KVM
>>>> [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
>>>> [ 0.000000] PERCPU: Embedded 29 pages/cpu @ffff88007fc00000 s87232 r8192 d23360 u524288
>>>> [ 0.000000] pcpu-alloc: s87232 r8192 d23360 u524288 alloc=1*2097152
>>>> [ 0.000000] pcpu-alloc: [0] 0 1 2 3
>>>> [ 0.000000] KVM setup async PF for cpu 0
>>>> [ 0.000000] kvm-stealtime: cpu 0, msr 7fc0e000
>>>> [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 515975
>>>> [ 0.000000] Policy zone: DMA32
>>>> [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.17.0-rc2+ root=UUID=181da3e4-9fad-4bea-8f45-0d7fca5ae2b6 ro vconsole.keymap=us crashkernel=auto vconsole.font=latarcyrheb-sun16 rhgb quiet LANG=en_US.UTF-8 /dev/sda3
>>>> [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
>>>> [ 0.000000] AGP: Checking aperture...
>>>> [ 0.000000] AGP: No AGP bridge found
>>>> [ 0.000000] Memory: 2020524K/2096752K available (6864K kernel code, 1463K rwdata, 3240K rodata, 1724K init, 2640K bss, 76228K reserved)
>>>> [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
>>>> [ 0.000000] Hierarchical RCU implementation.
>>>> [ 0.000000] RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4.
>>>> [ 0.000000] Offload RCU callbacks from all CPUs
>>>> [ 0.000000] Offload RCU callbacks from CPUs: 0-3.
>>>> [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
>>>> [ 0.000000] NR_IRQS:524544 nr_irqs:456 0
>>>> [ 0.000000] Console: colour VGA+ 80x25
>>>> [ 0.000000] console [tty0] enabled
>>>> [ 0.000000] allocated 8388608 bytes of page_cgroup
>>>> [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
>>>> [ 0.000000] hpet clockevent registered
>>>> [ 0.000000] tsc: Detected 3192.746 MHz processor
>>>> [ 0.002000] Calibrating delay loop (skipped) preset value.. 6385.49 BogoMIPS (lpj=3192746)
>>>> [ 0.002000] pid_max: default: 32768 minimum: 301
>>>> [ 0.002000] ACPI: Core revision 20140724
>>>> [ 0.002000] ACPI: All ACPI Tables successfully acquired
>>>> [ 0.002000] Security Framework initialized
>>>> [ 0.002000] SELinux: Initializing.
>>>> [ 0.002000] SELinux: Starting in permissive mode
>>>> [ 0.002000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
>>>> [ 0.002356] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
>>>> [ 0.002529] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes)
>>>> [ 0.002532] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes)
>>>> [ 0.002649] Initializing cgroup subsys memory
>>>> [ 0.002652] Initializing cgroup subsys devices
>>>> [ 0.002654] Initializing cgroup subsys freezer
>>>> [ 0.002656] Initializing cgroup subsys net_cls
>>>> [ 0.002657] Initializing cgroup subsys blkio
>>>> [ 0.002658] Initializing cgroup subsys perf_event
>>>> [ 0.002660] Initializing cgroup subsys hugetlb
>>>> [ 0.002706] mce: CPU supports 10 MCE banks
>>>> [ 0.002739] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
>>>> Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
>>>> [ 0.002877] Freeing SMP alternatives memory: 28K (ffffffff81cff000 - ffffffff81d06000)
>>>> [ 0.005420] ftrace: allocating 25457 entries in 100 pages
>>>> [ 0.011272] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
>>>> [ 0.011275] smpboot: CPU0: Intel QEMU Virtual CPU version 1.4.2 (fam: 06, model: 02, stepping: 03)
>>>> [ 0.012000] APIC calibration not consistent with PM-Timer: 116ms instead of 100ms
>>>> [ 0.012000] APIC delta adjusted to PM-Timer: 6249964 (7250436)
>>>> [ 0.012000] Performance Events: unsupported p6 CPU model 2 no PMU driver, software events only.
>>>> [ 0.012015] NMI watchdog: disabled (cpu0): hardware events not enabled
>>>> [ 0.012044] x86: Booting SMP configuration:
>>>> [ 0.012045] .... node #0, CPUs: #1
>>>> [ 0.012000] kvm-clock: cpu 1, msr 0:7ff58041, secondary cpu clock
>>>> [ 0.025011] KVM setup async PF for cpu 1
>>>> [ 0.025016] kvm-stealtime: cpu 1, msr 7fc8e000
>>>> [ 0.025091] #2
>>>> [ 0.025014] kvm-clock: cpu 2, msr 0:7ff58081, secondary cpu clock
>>>> [ 0.038011] KVM setup async PF for cpu 2
>>>> [ 0.038016] kvm-stealtime: cpu 2, msr 7fd0e000
>>>> [ 0.038085] #3
>>>> [ 0.038016] kvm-clock: cpu 3, msr 0:7ff580c1, secondary cpu clock
>>>> [ 0.051032] x86: Booted up 1 node, 4 CPUs
>>>> [ 0.051036] smpboot: Total of 4 processors activated (25541.96 BogoMIPS)
>>>> [ 0.051016] KVM setup async PF for cpu 3
>>>> [ 0.051020] kvm-stealtime: cpu 3, msr 7fd8e000
>>>> [ 0.055004] devtmpfs: initialized
>>>> [ 0.056661] evm: security.selinux
>>>> [ 0.056663] evm: security.ima
>>>> [ 0.056663] evm: security.capability
>>>> [ 0.057559] atomic64_test: passed for x86-64 platform with CX8 and with SSE
>>>> [ 0.057637] NET: Registered protocol family 16
>>>> [ 0.057746] cpuidle: using governor menu
>>>> [ 0.058042] ACPI: bus type PCI registered
>>>> [ 0.058044] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
>>>> [ 0.058143] PCI: Using configuration type 1 for base access
>>>> [ 0.061021] ACPI: Added _OSI(Module Device)
>>>> [ 0.061023] ACPI: Added _OSI(Processor Device)
>>>> [ 0.061024] ACPI: Added _OSI(3.0 _SCP Extensions)
>>>> [ 0.061025] ACPI: Added _OSI(Processor Aggregator Device)
>>>> [ 0.062323] ACPI: Interpreter enabled
>>>> [ 0.062326] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20140724/hwxface-580)
>>>> [ 0.062329] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20140724/hwxface-580)
>>>> [ 0.062336] ACPI: (supports S0 S3 S4 S5)
>>>> [ 0.062338] ACPI: Using IOAPIC for interrupt routing
>>>> [ 0.062348] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
>>>> [ 0.064186] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
>>>> [ 0.064191] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
>>>> [ 0.064195] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
>>>> [ 0.064272] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
>>>> [ 0.064505] acpiphp: Slot [3] registered
>>>> [ 0.064521] acpiphp: Slot [4] registered
>>>> [ 0.064536] acpiphp: Slot [5] registered
>>>> [ 0.064551] acpiphp: Slot [6] registered
>>>> [ 0.064567] acpiphp: Slot [7] registered
>>>> [ 0.064583] acpiphp: Slot [8] registered
>>>> [ 0.064599] acpiphp: Slot [9] registered
>>>> [ 0.064614] acpiphp: Slot [10] registered
>>>> [ 0.064628] acpiphp: Slot [11] registered
>>>> [ 0.064643] acpiphp: Slot [12] registered
>>>> [ 0.064659] acpiphp: Slot [13] registered
>>>> [ 0.064675] acpiphp: Slot [14] registered
>>>> [ 0.064691] acpiphp: Slot [15] registered
>>>> [ 0.064705] acpiphp: Slot [16] registered
>>>> [ 0.064720] acpiphp: Slot [17] registered
>>>> [ 0.064735] acpiphp: Slot [18] registered
>>>> [ 0.064751] acpiphp: Slot [19] registered
>>>> [ 0.064766] acpiphp: Slot [20] registered
>>>> [ 0.064782] acpiphp: Slot [21] registered
>>>> [ 0.064798] acpiphp: Slot [22] registered
>>>> [ 0.064812] acpiphp: Slot [23] registered
>>>> [ 0.064827] acpiphp: Slot [24] registered
>>>> [ 0.064842] acpiphp: Slot [25] registered
>>>> [ 0.064857] acpiphp: Slot [26] registered
>>>> [ 0.064871] acpiphp: Slot [27] registered
>>>> [ 0.064887] acpiphp: Slot [28] registered
>>>> [ 0.064902] acpiphp: Slot [29] registered
>>>> [ 0.064917] acpiphp: Slot [30] registered
>>>> [ 0.064932] acpiphp: Slot [31] registered
>>>> [ 0.064940] PCI host bridge to bus 0000:00
>>>> [ 0.064942] pci_bus 0000:00: root bus resource [bus 00-ff]
>>>> [ 0.064943] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7]
>>>> [ 0.064945] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff]
>>>> [ 0.064946] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
>>>> [ 0.064948] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff]
>>>> [ 0.064977] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
>>>> [ 0.065262] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
>>>> [ 0.065654] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
>>>> [ 0.069415] pci 0000:00:01.1: reg 0x20: [io 0xc0e0-0xc0ef]
>>>> [ 0.071027] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
>>>> [ 0.071029] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
>>>> [ 0.071030] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
>>>> [ 0.071031] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
>>>> [ 0.071177] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
>>>> [ 0.075002] pci 0000:00:01.2: reg 0x20: [io 0xc040-0xc05f]
>>>> [ 0.077042] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
>>>> [ 0.077311] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI
>>>> [ 0.077318] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB
>>>> [ 0.077485] pci 0000:00:02.0: [1b36:0100] type 00 class 0x030000
>>>> [ 0.079007] pci 0000:00:02.0: reg 0x10: [mem 0xf4000000-0xf7ffffff]
>>>> [ 0.081006] pci 0000:00:02.0: reg 0x14: [mem 0xf8000000-0xfbffffff]
>>>> [ 0.083005] pci 0000:00:02.0: reg 0x18: [mem 0xfc024000-0xfc025fff]
>>>> [ 0.085002] pci 0000:00:02.0: reg 0x1c: [io 0xc060-0xc07f]
>>>> [ 0.091005] pci 0000:00:02.0: reg 0x30: [mem 0xfc000000-0xfc00ffff pref]
>>>> [ 0.091176] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
>>>> [ 0.092663] pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc09f]
>>>> [ 0.094003] pci 0000:00:03.0: reg 0x14: [mem 0xfc026000-0xfc026fff]
>>>> [ 0.100648] pci 0000:00:03.0: reg 0x30: [mem 0xfc010000-0xfc01ffff pref]
>>>> [ 0.101025] pci 0000:00:04.0: [8086:2668] type 00 class 0x040300
>>>> [ 0.101733] pci 0000:00:04.0: reg 0x10: [mem 0xfc020000-0xfc023fff]
>>>> [ 0.106070] pci 0000:00:05.0: [1af4:1003] type 00 class 0x078000
>>>> [ 0.107003] pci 0000:00:05.0: reg 0x10: [io 0xc0a0-0xc0bf]
>>>> [ 0.108743] pci 0000:00:05.0: reg 0x14: [mem 0xfc027000-0xfc027fff]
>>>> [ 0.115257] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
>>>> [ 0.116644] pci 0000:00:06.0: reg 0x10: [io 0xc000-0xc03f]
>>>> [ 0.118015] pci 0000:00:06.0: reg 0x14: [mem 0xfc028000-0xfc028fff]
>>>> [ 0.125150] pci 0000:00:07.0: [1af4:1002] type 00 class 0x00ff00
>>>> [ 0.125841] pci 0000:00:07.0: reg 0x10: [io 0xc0c0-0xc0df]
>>>> [ 0.130272] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
>>>> [ 0.130337] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
>>>> [ 0.130399] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
>>>> [ 0.130455] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
>>>> [ 0.130485] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
>>>> [ 0.130856] ACPI: Enabled 16 GPEs in block 00 to 0F
>>>> [ 0.131051] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
>>>> [ 0.131053] vgaarb: loaded
>>>> [ 0.131054] vgaarb: bridge control possible 0000:00:02.0
>>>> [ 0.131113] SCSI subsystem initialized
>>>> [ 0.131132] ACPI: bus type USB registered
>>>> [ 0.131145] usbcore: registered new interface driver usbfs
>>>> [ 0.131151] usbcore: registered new interface driver hub
>>>> [ 0.131178] usbcore: registered new device driver usb
>>>> [ 0.131178] PCI: Using ACPI for IRQ routing
>>>> [ 0.131178] PCI: pci_cache_line_size set to 64 bytes
>>>> [ 0.131236] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
>>>> [ 0.131238] e820: reserve RAM buffer [mem 0x7fffe000-0x7fffffff]
>>>> [ 0.131316] NetLabel: Initializing
>>>> [ 0.131317] NetLabel: domain hash size = 128
>>>> [ 0.131317] NetLabel: protocols = UNLABELED CIPSOv4
>>>> [ 0.131328] NetLabel: unlabeled traffic allowed by default
>>>> [ 0.131371] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
>>>> [ 0.131382] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
>>>> [ 0.131385] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
>>>> [ 0.135064] Switched to clocksource kvm-clock
>>>> [ 0.140209] pnp: PnP ACPI init
>>>> [ 0.140272] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
>>>> [ 0.140303] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
>>>> [ 0.140321] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
>>>> [ 0.140342] pnp 00:03: [dma 2]
>>>> [ 0.140352] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
>>>> [ 0.140422] pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active)
>>>> [ 0.140587] pnp: PnP ACPI: found 5 devices
>>>> [ 0.151666] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7]
>>>> [ 0.151669] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff]
>>>> [ 0.151670] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
>>>> [ 0.151671] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff]
>>>> [ 0.151709] NET: Registered protocol family 2
>>>> [ 0.151823] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
>>>> [ 0.151851] TCP bind hash table entries: 16384 (order: 6, 262144 bytes)
>>>> [ 0.151882] TCP: Hash tables configured (established 16384 bind 16384)
>>>> [ 0.151895] TCP: reno registered
>>>> [ 0.151898] UDP hash table entries: 1024 (order: 3, 32768 bytes)
>>>> [ 0.151905] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes)
>>>> [ 0.151938] NET: Registered protocol family 1
>>>> [ 0.151948] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
>>>> [ 0.151965] pci 0000:00:01.0: PIIX3: Enabling Passive Release
>>>> [ 0.151979] pci 0000:00:01.0: Activating ISA DMA hang workarounds
>>>> [ 0.152214] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
>>>> [ 0.152666] pci 0000:00:02.0: Boot video device
>>>> [ 0.152704] PCI: CLS 0 bytes, default 64
>>>> [ 0.152769] Unpacking initramfs...
>>>> [ 0.443991] Freeing initrd memory: 25984K (ffff880034d30000 - ffff880036690000)
>>>> [ 0.444414] microcode: CPU0 sig=0x623, pf=0x0, revision=0x1
>>>> [ 0.444452] microcode: CPU1 sig=0x623, pf=0x0, revision=0x1
>>>> [ 0.444490] microcode: CPU2 sig=0x623, pf=0x0, revision=0x1
>>>> [ 0.444527] microcode: CPU3 sig=0x623, pf=0x0, revision=0x1
>>>> [ 0.444614] microcode: Microcode Update Driver: v2.00 <tigran@xxxxxxxxxxxxxxxxxxxx>, Peter Oruba
>>>> [ 0.445044] futex hash table entries: 1024 (order: 4, 65536 bytes)
>>>> [ 0.445067] Initialise system trusted keyring
>>>> [ 0.445096] audit: initializing netlink subsys (disabled)
>>>> [ 0.445120] audit: type=2000 audit(1413877341.862:1): initialized
>>>> [ 0.445707] HugeTLB registered 2 MB page size, pre-allocated 0 pages
>>>> [ 0.447094] zpool: loaded
>>>> [ 0.447096] zbud: loaded
>>>> [ 0.447316] VFS: Disk quotas dquot_6.5.2
>>>> [ 0.447345] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
>>>> [ 0.447570] msgmni has been set to 3997
>>>> [ 0.447607] Key type big_key registered
>>>> [ 0.447610] SELinux: Registering netfilter hooks
>>>> [ 0.449183] alg: No test for stdrng (krng)
>>>> [ 0.449189] NET: Registered protocol family 38
>>>> [ 0.449195] Key type asymmetric registered
>>>> [ 0.449197] Asymmetric key parser 'x509' registered
>>>> [ 0.449235] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
>>>> [ 0.449296] io scheduler noop registered
>>>> [ 0.449299] io scheduler deadline registered (default)
>>>> [ 0.449322] io scheduler cfq registered
>>>> [ 0.449388] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
>>>> [ 0.449399] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
>>>> [ 0.449426] intel_idle: does not run on family 6 model 2
>>>> [ 0.449473] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
>>>> [ 0.449476] ACPI: Power Button [PWRF]
>>>> [ 0.449716] GHES: HEST is not enabled!
>>>> [ 0.449766] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
>>>> [ 0.471023] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
>>>> [ 0.471309] Non-volatile memory driver v1.3
>>>> [ 0.471311] Linux agpgart interface v0.103
>>>> [ 0.471393] rdac: device handler registered
>>>> [ 0.471472] hp_sw: device handler registered
>>>> [ 0.471474] emc: device handler registered
>>>> [ 0.471476] alua: device handler registered
>>>> [ 0.471499] libphy: Fixed MDIO Bus: probed
>>>> [ 0.471523] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
>>>> [ 0.471526] ehci-pci: EHCI PCI platform driver
>>>> [ 0.471533] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
>>>> [ 0.471535] ohci-pci: OHCI PCI platform driver
>>>> [ 0.471541] uhci_hcd: USB Universal Host Controller Interface driver
>>>> [ 0.472109] uhci_hcd 0000:00:01.2: UHCI Host Controller
>>>> [ 0.472135] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
>>>> [ 0.472149] uhci_hcd 0000:00:01.2: detected 2 ports
>>>> [ 0.472218] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c040
>>>> [ 0.472271] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
>>>> [ 0.472273] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
>>>> [ 0.472274] usb usb1: Product: UHCI Host Controller
>>>> [ 0.472275] usb usb1: Manufacturer: Linux 3.17.0-rc2+ uhci_hcd
>>>> [ 0.472276] usb usb1: SerialNumber: 0000:00:01.2
>>>> [ 0.472337] hub 1-0:1.0: USB hub found
>>>> [ 0.472341] hub 1-0:1.0: 2 ports detected
>>>> [ 0.472435] usbcore: registered new interface driver usbserial
>>>> [ 0.472439] usbcore: registered new interface driver usbserial_generic
>>>> [ 0.472444] usbserial: USB Serial support registered for generic
>>>> [ 0.472462] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
>>>> [ 0.473029] serio: i8042 KBD port at 0x60,0x64 irq 1
>>>> [ 0.473035] serio: i8042 AUX port at 0x60,0x64 irq 12
>>>> [ 0.473103] mousedev: PS/2 mouse device common for all mice
>>>> [ 0.473339] rtc_cmos 00:00: RTC can wake from S4
>>>> [ 0.473599] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
>>>> [ 0.473762] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram, hpet irqs
>>>> [ 0.473910] hidraw: raw HID events driver (C) Jiri Kosina
>>>> [ 0.474128] usbcore: registered new interface driver usbhid
>>>> [ 0.474130] usbhid: USB HID core driver
>>>> [ 0.474165] drop_monitor: Initializing network drop monitor service
>>>> [ 0.474268] TCP: cubic registered
>>>> [ 0.474277] Initializing XFRM netlink socket
>>>> [ 0.474430] NET: Registered protocol family 10
>>>> [ 0.475079] NET: Registered protocol family 17
>>>> [ 0.475799] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
>>>> [ 0.475890] Loading compiled-in X.509 certificates
>>>> [ 0.477235] Loaded X.509 cert 'Magrathea: Glacier signing key: 2fe9051af95b7482e9d55ea1ec379806e2f72232'
>>>> [ 0.477262] registered taskstats version 1
>>>> [ 0.479676] Key type trusted registered
>>>> [ 0.482046] Key type encrypted registered
>>>> [ 0.484077] ima: No TPM chip found, activating TPM-bypass!
>>>> [ 0.484109] evm: HMAC attrs: 0x1
>>>> [ 0.484740] rtc_cmos 00:00: setting system clock to 2014-10-21 07:42:21 UTC (1413877341)
>>>> [ 0.485729] Freeing unused kernel memory: 1724K (ffffffff81b50000 - ffffffff81cff000)
>>>> [ 0.489335] systemd[1]: systemd 208 running in system mode. (+PAM +LIBWRAP +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ)
>>>> [ 0.489391] systemd[1]: Detected virtualization 'kvm'.
>>>> [ 0.489396] systemd[1]: Running in initial RAM disk.
>>>> [ 0.489459] systemd[1]: Set hostname to <localhost.localdomain>.
>>>> [ 0.503906] random: systemd urandom read with 5 bits of entropy available
>>>> [ 0.533840] systemd[1]: Expecting device dev-disk-by\x2duuid-181da3e4\x2d9fad\x2d4bea\x2d8f45\x2d0d7fca5ae2b6.device...
>>>> [ 0.533861] systemd[1]: Starting -.slice.
>>>> [ 0.534268] systemd[1]: Created slice -.slice.
>>>> [ 0.534324] systemd[1]: Starting System Slice.
>>>> [ 0.534419] systemd[1]: Created slice System Slice.
>>>> [ 0.534466] systemd[1]: Starting Slices.
>>>> [ 0.534481] systemd[1]: Reached target Slices.
>>>> [ 0.534519] systemd[1]: Starting Timers.
>>>> [ 0.534532] systemd[1]: Reached target Timers.
>>>> [ 0.534574] systemd[1]: Starting udev Kernel Socket.
>>>> [ 0.534605] systemd[1]: Listening on udev Kernel Socket.
>>>> [ 0.534649] systemd[1]: Starting udev Control Socket.
>>>> [ 0.534687] systemd[1]: Listening on udev Control Socket.
>>>> [ 0.534730] systemd[1]: Starting Journal Socket.
>>>> [ 0.534785] systemd[1]: Listening on Journal Socket.
>>>> [ 0.535550] systemd[1]: Starting dracut cmdline hook...
>>>> [ 0.536124] systemd[1]: Starting Create list of required static device nodes for the current kernel...
>>>> [ 0.536700] systemd[1]: Started Load Kernel Modules.
>>>> [ 0.536721] systemd[1]: Starting Sockets.
>>>> [ 0.536735] systemd[1]: Reached target Sockets.
>>>> [ 0.536786] systemd[1]: Starting Setup Virtual Console...
>>>> [ 0.537189] systemd[1]: Starting Journal Service...
>>>> [ 0.537601] systemd[1]: Started Journal Service.
>>>> [ 0.543609] systemd-journald[108]: Vacuuming done, freed 0 bytes
>>>> [ 0.654429] systemd-udevd[213]: starting version 208
>>>> [ 0.683839] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
>>>> [ 0.690338] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
>>>> [ 0.690471] libata version 3.00 loaded.
>>>> [ 0.691758] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
>>>> [ 0.707546] ata_piix 0000:00:01.1: version 2.13
>>>> [ 0.709232] virtio-pci 0000:00:06.0: irq 24 for MSI/MSI-X
>>>> [ 0.709248] virtio-pci 0000:00:06.0: irq 25 for MSI/MSI-X
>>>> [ 0.709255] virtio-pci 0000:00:03.0: irq 26 for MSI/MSI-X
>>>> [ 0.709276] virtio-pci 0000:00:03.0: irq 27 for MSI/MSI-X
>>>> [ 0.709290] virtio-pci 0000:00:03.0: irq 28 for MSI/MSI-X
>>>> [ 0.709522] scsi host0: ata_piix
>>>> [ 0.709640] scsi host1: ata_piix
>>>> [ 0.709675] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0e0 irq 14
>>>> [ 0.709676] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0e8 irq 15
>>>> [ 0.743717] [drm] Initialized drm 1.1.0 20060810
>>>> [ 0.743895] FDC 0 is a S82078B
>>>> [ 0.792255] [drm] Device Version 0.0
>>>> [ 0.792257] [drm] Compression level 0 log level 0
>>>> [ 0.792258] [drm] Currently using mode #0, list at 0x488
>>>> [ 0.792259] [drm] 12286 io pages at offset 0x1000000
>>>> [ 0.792260] [drm] 16777216 byte draw area at offset 0x0
>>>> [ 0.792260] [drm] RAM header offset: 0x3ffe000
>>>> [ 0.792261] [drm] rom modes offset 0x488 for 118 modes
>>>> [ 0.792569] [TTM] Zone kernel: Available graphics memory: 1024130 kiB
>>>> [ 0.792571] [TTM] Initializing pool allocator
>>>> [ 0.792575] [TTM] Initializing DMA pool allocator
>>>> [ 0.792581] [drm] qxl: 16M of VRAM memory size
>>>> [ 0.792581] [drm] qxl: 63M of IO pages memory ready (VRAM domain)
>>>> [ 0.792582] [drm] qxl: 64M of Surface memory size
>>>> [ 0.794057] usb 1-1: new full-speed USB device number 2 using uhci_hcd
>>>> [ 0.795164] [drm] main mem slot 1 [f4000000,3ffe000]
>>>> [ 0.795166] [drm] surface mem slot 2 [f8000000,4000000]
>>>> [ 0.796755] [drm] fb mappable at 0xF4000000, size 3145728
>>>> [ 0.796759] [drm] fb: depth 24, pitch 4096, width 1024, height 768
>>>> [ 0.796851] fbcon: qxldrmfb (fb0) is primary device
>>>> [ 0.800086] vda: vda1
>>>> [ 0.807924] Console: switching to colour frame buffer device 128x48
>>>> [ 0.809915] qxl 0000:00:02.0: fb0: qxldrmfb frame buffer device
>>>> [ 0.809916] qxl 0000:00:02.0: registered panic notifier
>>>> [ 0.817301] [drm] Initialized qxl 0.1.0 20120117 for 0000:00:02.0 on minor 0
>>>> [ 0.893432] ata2.01: NODEV after polling detection
>>>> [ 0.893695] ata2.00: ATAPI: QEMU DVD-ROM, 1.4.2, max UDMA/100
>>>> [ 0.894291] ata2.00: configured for MWDMA2
>>>> [ 0.895457] ata1.01: NODEV after polling detection
>>>> [ 0.895828] ata1.00: ATA-7: QEMU HARDDISK, 1.4.2, max UDMA/100
>>>> [ 0.895832] ata1.00: 83886080 sectors, multi 16: LBA48
>>>> [ 0.896380] ata1.00: configured for MWDMA2
>>>> [ 0.896478] scsi 0:0:0:0: Direct-Access ATA QEMU HARDDISK 2 PQ: 0 ANSI: 5
>>>> [ 0.896983] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 1.4. PQ: 0 ANSI: 5
>>>> [ 0.916776] sd 0:0:0:0: [sda] 83886080 512-byte logical blocks: (42.9 GB/40.0 GiB)
>>>> [ 0.916801] sd 0:0:0:0: [sda] Write Protect is off
>>>> [ 0.916803] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
>>>> [ 0.916813] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
>>>> [ 0.917922] sda: sda1 sda2 sda3
>>>> [ 0.918117] sd 0:0:0:0: [sda] Attached SCSI disk
>>>> [ 0.927868] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
>>>> [ 0.927871] cdrom: Uniform CD-ROM driver Revision: 3.20
>>>> [ 0.928004] sr 1:0:0:0: Attached scsi CD-ROM sr0
>>>> [ 0.942668] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
>>>> [ 0.942673] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
>>>> [ 0.942676] usb 1-1: Product: QEMU USB Tablet
>>>> [ 0.942679] usb 1-1: Manufacturer: QEMU
>>>> [ 0.942681] usb 1-1: SerialNumber: 42
>>>> [ 0.951947] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input4
>>>> [ 0.952225] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Pointer [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0
>>>> [ 1.324142] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
>>>> [ 1.447051] tsc: Refined TSC clocksource calibration: 3192.751 MHz
>>>> [ 2.344620] random: nonblocking pool is initialized
>>>> [ 6.156783] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
>>>> [ 6.455997] systemd-journald[108]: Received SIGTERM
>>>> [ 7.125358] audit: type=1404 audit(1413877348.140:2): enforcing=1 old_enforcing=0 auid=4294967295 ses=4294967295
>>>> [ 7.227565] SELinux: 2048 avtab hash slots, 106409 rules.
>>>> [ 7.239107] SELinux: 2048 avtab hash slots, 106409 rules.
>>>> [ 7.259541] SELinux: 8 users, 86 roles, 4801 types, 280 bools, 1 sens, 1024 cats
>>>> [ 7.259544] SELinux: 83 classes, 106409 rules
>>>> [ 7.263004] SELinux: Permission audit_read in class capability2 not defined in policy.
>>>> [ 7.263014] SELinux: the above unknown classes and permissions will be allowed
>>>> [ 7.263017] SELinux: Completing initialization.
>>>> [ 7.263018] SELinux: Setting up existing superblocks.
>>>> [ 7.263022] SELinux: initialized (dev rootfs, type rootfs), uses genfs_contexts
>>>> [ 7.263030] SELinux: initialized (dev bdev, type bdev), uses genfs_contexts
>>>> [ 7.263033] SELinux: initialized (dev proc, type proc), uses genfs_contexts
>>>> [ 7.263055] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>>>> [ 7.263106] SELinux: initialized (dev devtmpfs, type devtmpfs), uses transition SIDs
>>>> [ 7.263552] SELinux: initialized (dev sockfs, type sockfs), uses task SIDs
>>>> [ 7.263555] SELinux: initialized (dev debugfs, type debugfs), uses genfs_contexts
>>>> [ 7.264107] SELinux: initialized (dev pipefs, type pipefs), uses task SIDs
>>>> [ 7.264110] SELinux: initialized (dev anon_inodefs, type anon_inodefs), uses genfs_contexts
>>>> [ 7.264111] SELinux: initialized (dev aio, type aio), not configured for labeling
>>>> [ 7.264113] SELinux: initialized (dev devpts, type devpts), uses transition SIDs
>>>> [ 7.264124] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>>>> [ 7.264128] SELinux: initialized (dev mqueue, type mqueue), uses transition SIDs
>>>> [ 7.264132] SELinux: initialized (dev selinuxfs, type selinuxfs), uses genfs_contexts
>>>> [ 7.264139] SELinux: initialized (dev securityfs, type securityfs), uses genfs_contexts
>>>> [ 7.264142] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
>>>> [ 7.264286] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>>>> [ 7.264290] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>>>> [ 7.264348] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>>>> [ 7.264368] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264371] SELinux: initialized (dev pstore, type pstore), uses genfs_contexts
>>>> [ 7.264373] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264374] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264376] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264380] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264382] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264383] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264385] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264389] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264391] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>>>> [ 7.264393] SELinux: initialized (dev configfs, type configfs), uses genfs_contexts
>>>> [ 7.264394] SELinux: initialized (dev drm, type drm), not configured for labeling
>>>> [ 7.264400] SELinux: initialized (dev vda1, type ext4), uses xattr
>>>> [ 7.268037] audit: type=1403 audit(1413877348.283:3): policy loaded auid=4294967295 ses=4294967295
>>>> [ 7.271168] systemd[1]: Successfully loaded SELinux policy in 180.914ms.
>>>> [ 7.388068] systemd[1]: Relabelled /dev and /run in 13.488ms.
>>>> [ 7.569808] systemd-fstab-generator[336]: Failed to create mount unit file /run/systemd/generator/-.mount, as it already exists. Duplicate entry in /etc/fstab?
>>>> [ 9.794388] SELinux: initialized (dev autofs, type autofs), uses genfs_contexts
>>>> [ 9.800800] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>>>> [ 9.986207] systemd-journald[376]: Vacuuming done, freed 0 bytes
>>>> [ 10.425178] systemd-udevd[386]: starting version 208
>>>> [ 10.875906] EXT4-fs (vda1): re-mounted. Opts: (null)
>>>> [ 10.876059] EXT4-fs (vda1): re-mounted. Opts: (null)
>>>> [ 11.326782] RPC: Registered named UNIX socket transport module.
>>>> [ 11.326786] RPC: Registered udp transport module.
>>>> [ 11.326787] RPC: Registered tcp transport module.
>>>> [ 11.326788] RPC: Registered tcp NFSv4.1 backchannel transport module.
>>>> [ 11.327476] SELinux: initialized (dev rpc_pipefs, type rpc_pipefs), uses genfs_contexts
>>>> [ 11.598578] input: PC Speaker as /devices/platform/pcspkr/input/input5
>>>> [ 11.853365] ppdev: user-space parallel port driver
>>>> [ 11.905215] virtio-pci 0000:00:05.0: irq 29 for MSI/MSI-X
>>>> [ 11.905243] virtio-pci 0000:00:05.0: irq 30 for MSI/MSI-X
>>>> [ 12.125787] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0
>>>> [ 12.145622] device-mapper: uevent: version 1.0.3
>>>> [ 12.145859] device-mapper: ioctl: 4.27.0-ioctl (2013-10-30) initialised: dm-devel@xxxxxxxxxx
>>>> [ 12.907774] systemd-journald[376]: Received request to flush runtime journal from PID 1
>>>> [ 12.909274] Installing knfsd (copyright (C) 1996 okir@xxxxxxxxxxxx).
>>>> [ 12.909939] SELinux: initialized (dev nfsd, type nfsd), uses genfs_contexts
>>>> [ 13.508495] audit: type=1305 audit(1413877354.523:4): audit_pid=464 old=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:auditd_t:s0 res=1
>>>> [ 14.534154] snd_hda_intel 0000:00:04.0: irq 31 for MSI/MSI-X
>>>> [ 15.807689] sound hdaudioC0D0: autoconfig: line_outs=1 (0x3/0x0/0x0/0x0/0x0) type:line
>>>> [ 15.807693] sound hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
>>>> [ 15.807694] sound hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0)
>>>> [ 15.807695] sound hdaudioC0D0: mono: mono_out=0x0
>>>> [ 15.807696] sound hdaudioC0D0: inputs:
>>>> [ 15.807698] sound hdaudioC0D0: Line=0x5
>>>> [ 16.057312] sd 0:0:0:0: Attached scsi generic sg0 type 0
>>>> [ 16.057350] sr 1:0:0:0: Attached scsi generic sg1 type 5
>>>> [ 20.574760] ip_tables: (C) 2000-2006 Netfilter Core Team
>>>> [ 20.778209] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
>>>> [ 20.987215] ip6_tables: (C) 2000-2006 Netfilter Core Team
>>>> [ 21.553523] Ebtables v2.0 registered
>>>> [ 21.944469] Bridge firewalling registered
>>>> [ 23.491468] cfg80211: Calling CRDA to update world regulatory domain
>>>> [ 23.517907] cfg80211: World regulatory domain updated:
>>>> [ 23.517909] cfg80211: DFS Master region: unset
>>>> [ 23.517910] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
>>>> [ 23.517912] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
>>>> [ 23.517914] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
>>>> [ 23.517915] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
>>>> [ 23.517916] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
>>>> [ 23.517917] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
>>>> [ 23.517918] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
>>>> [ 32.318308] snd_hda_intel 0000:00:04.0: Invalid position buffer, using LPIB read method instead.
>>>> [ 32.484087] snd_hda_intel 0000:00:04.0: IRQ timing workaround is activated for card #0. Suggest a bigger bdl_pos_adj.
>>>> [ 120.475365] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts:
>>>> [ 120.475562] SELinux: initialized (dev sda1, type ext4), uses mountpoint labeling
>>>> [ 124.510163] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: acl,user_xattr
>>>> [ 124.510341] SELinux: initialized (dev sda2, type ext4), uses mountpoint labeling
>>>> [ 125.618362] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: acl,user_xattr
>>>> [ 125.618369] SELinux: initialized (dev sda1, type ext4), uses xattr
>>>> [ 130.084150] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: acl,user_xattr
>>>> [ 130.084233] SELinux: initialized (dev sda2, type ext4), uses mountpoint labeling
>>>> [ 136.050773] dump_buffers ino:12 page:ffffea00000b4a80 idx:2740 fl:1fffff8000087d
>>>> [ 136.050777] bh:ffff8800783401a0 count:0 state:1023
>>>> [ 136.087165] dump_buffers ino:12 page:ffffea00000b4a80 idx:2740 fl:1fffff8000087d
>>>> [ 136.087167] bh:ffff8800783401a0 count:0 state:1023
>>>> [ 136.140289] dump_buffers ino:12 page:ffffea00000b4a80 idx:2740 fl:1fffff8000087d
>>>> [ 136.140294] bh:ffff8800783401a0 count:0 state:1023
>>>> [ 136.177953] dump_buffers ino:12 page:ffffea00000b4a80 idx:2740 fl:1fffff8000087d
>>>> [ 136.177957] bh:ffff8800783401a0 count:0 state:1023
>>>> [ 136.214371] dump_buffers ino:12 page:ffffea00000b4a80 idx:2740 fl:1fffff8000087d
>>>> [ 136.214374] bh:ffff8800783401a0 count:0 state:1023
>>>> [ 208.162760] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: acl,user_xattr
>>>> [ 208.162768] SELinux: initialized (dev sda2, type ext4), uses xattr
>>
>> --
>> To unsubscribe from this list: send the line "unsubscribe linux-ext4" in
>> the body of a message to majordomo@xxxxxxxxxxxxxxx
>> More majordomo info at http://vger.kernel.org/majordomo-info.html
--
To unsubscribe from this list: send the line "unsubscribe linux-ext4" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
