* commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs
@ 2014-06-17 21:35 Konstantinos Skarlatos
2014-06-17 21:38 ` Konstantinos Skarlatos
2014-06-18 2:11 ` Jens Axboe
0 siblings, 2 replies; 5+ messages in thread
From: Konstantinos Skarlatos @ 2014-06-17 21:35 UTC (permalink / raw)
To: axboe, linux-kernel; +Cc: linux-btrfs
[-- Attachment #1: Type: text/plain, Size: 3109 bytes --]
Hi all,
with 3.16-rc1 rsync stops writing to my btrfs filesystem and stays at a
D+ state.
git bisect showed that the problematic commit is:
762380ad9322951cea4ce9d24864265f9c66a916 is the first bad commit
commit 762380ad9322951cea4ce9d24864265f9c66a916
Author: Jens Axboe <axboe@fb.com>
Date: Thu Jun 5 13:38:39 2014 -0600
block: add notion of a chunk size for request merging
Some drivers have different limits on what size a request should
optimally be, depending on the offset of the request. Similar to
dividing a device into chunks. Add a setting that allows the driver
to inform the block layer of such a chunk size. The block layer will
then prevent merging across the chunks.
This is needed to optimally support NVMe with a non-zero stripe size.
Signed-off-by: Jens Axboe <axboe@fb.com>
sysrq w gives:
[ 3287.169569] SysRq : Show Blocked State
[ 3287.169655] task PC stack pid father
[ 3287.169675] rsync D 0000000000000001 0 626 613
0x00000000
[ 3287.169685] ffff8802037c7d08 0000000000000082 ffff8800cf2e7010
0000000000014500
[ 3287.169693] ffff8802037c7fd8 0000000000014500 ffff8800cf2e7010
ffff8802037c7c98
[ 3287.169700] 0000000000000292 0000000000000292 ffff8802037c7c50
ffff8802037c7c50
[ 3287.169706] Call Trace:
[ 3287.169722] [<ffffffff814f71d2>] ? do_page_fault+0x22/0x30
[ 3287.169733] [<ffffffff8101cd89>] ? read_tsc+0x9/0x20
[ 3287.169743] [<ffffffff811379d0>] ? sleep_on_page+0x20/0x20
[ 3287.169749] [<ffffffff814eff29>] schedule+0x29/0x70
[ 3287.169756] [<ffffffff814f0214>] io_schedule+0x94/0xf0
[ 3287.169763] [<ffffffff811379de>] sleep_on_page_killable+0xe/0x50
[ 3287.169770] [<ffffffff814f0748>] __wait_on_bit_lock+0x48/0xb0
[ 3287.169777] [<ffffffff8128c753>] ? radix_tree_lookup_slot+0x13/0x30
[ 3287.169785] [<ffffffff81137b7a>] __lock_page_killable+0x6a/0x70
[ 3287.169792] [<ffffffff810acec0>] ? autoremove_wake_function+0x40/0x40
[ 3287.169799] [<ffffffff811398c8>] generic_file_aio_read+0x458/0x6a0
[ 3287.169808] [<ffffffff811ab63a>] do_sync_read+0x5a/0x90
[ 3287.169816] [<ffffffff811abc47>] vfs_read+0x97/0x160
[ 3287.169823] [<ffffffff811ac886>] SyS_read+0x46/0xc0
[ 3287.169831] [<ffffffff814fb969>] system_call_fastpath+0x16/0x1b
$ btrfs filesystem show /storage/btrfs
Label: none uuid: bde3c349-9e08-45bb-8517-b9a6dda81e88
Total devices 6 FS bytes used 8.58TiB
devid 1 size 3.64TiB used 3.02TiB path /dev/sdf
devid 2 size 1.82TiB used 1.20TiB path /dev/sda
devid 3 size 1.82TiB used 1.20TiB path /dev/sdb
devid 4 size 1.82TiB used 1.20TiB path /dev/sdc
devid 5 size 1.82TiB used 1.20TiB path /dev/sdd
devid 6 size 1.82TiB used 1.20TiB path /dev/sdh
Btrfs v3.14.2-dirty
$ btrfs fi df /storage/btrfs
Data, single: total=8.89TiB, used=8.51TiB
System, RAID1: total=32.00MiB, used=992.00KiB
Metadata, RAID1: total=69.00GiB, used=67.83GiB
unknown, single: total=512.00MiB, used=0.00
full dmesg attached
Please CC me if replying on LKML, as I am not subscribed there
[-- Attachment #2: dmesg_blocked.txt --]
[-- Type: text/plain, Size: 117328 bytes --]
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 3.15.0-rc8-g762380a (root@fileserver) (gcc version 4.9.0 20140507 (prerelease) (GCC) ) #1 SMP PREEMPT Tue Jun 17 18:46:02 EEST 2014
[ 0.000000] Command line: BOOT_IMAGE=/vmlinuz-linux-git root=UUID=3c811f3d-6764-4890-a664-8ac86e3d49af rw quiet
[ 0.000000] e820: BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x0000000000093fff] usable
[ 0.000000] BIOS-e820: [mem 0x000000000009f800-0x000000000009ffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000cfceffff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000cfcf0000-0x00000000cfcf0fff] ACPI NVS
[ 0.000000] BIOS-e820: [mem 0x00000000cfcf1000-0x00000000cfcfffff] ACPI data
[ 0.000000] BIOS-e820: [mem 0x00000000cfd00000-0x00000000cfdfffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fec00000-0x00000000ffffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000020fffffff] usable
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] SMBIOS 2.4 present.
[ 0.000000] DMI: Gigabyte Technology Co., Ltd. GA-890GPA-UD3H/GA-890GPA-UD3H, BIOS FD 07/23/2010
[ 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 = 0x210000 max_arch_pfn = 0x400000000
[ 0.000000] MTRR default type: uncachable
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-BFFFF uncachable
[ 0.000000] C0000-C7FFF write-protect
[ 0.000000] C8000-FFFFF uncachable
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000000 mask FFFF80000000 write-back
[ 0.000000] 1 base 000080000000 mask FFFFC0000000 write-back
[ 0.000000] 2 base 0000C0000000 mask FFFFF0000000 write-back
[ 0.000000] 3 base 0000CFD00000 mask FFFFFFF00000 uncachable
[ 0.000000] 4 base 0000CFE00000 mask FFFFFFE00000 uncachable
[ 0.000000] 5 base 000100000000 mask FFFF00000000 write-back
[ 0.000000] 6 base 000200000000 mask FFFFF0000000 write-back
[ 0.000000] 7 disabled
[ 0.000000] TOM2: 0000000230000000 aka 8960M
[ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[ 0.000000] e820: update [mem 0xcfd00000-0xffffffff] usable ==> reserved
[ 0.000000] e820: last_pfn = 0xcfcf0 max_arch_pfn = 0x400000000
[ 0.000000] found SMP MP-table at [mem 0x000f44d0-0x000f44df] mapped at [ffff8800000f44d0]
[ 0.000000] Scanning 1 areas for low memory corruption
[ 0.000000] Base memory trampoline at [ffff88000008e000] 8e000 size 24576
[ 0.000000] Using GB pages for direct mapping
[ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[ 0.000000] [mem 0x00000000-0x000fffff] page 4k
[ 0.000000] BRK [0x01b40000, 0x01b40fff] PGTABLE
[ 0.000000] BRK [0x01b41000, 0x01b41fff] PGTABLE
[ 0.000000] BRK [0x01b42000, 0x01b42fff] PGTABLE
[ 0.000000] init_memory_mapping: [mem 0x20fe00000-0x20fffffff]
[ 0.000000] [mem 0x20fe00000-0x20fffffff] page 2M
[ 0.000000] BRK [0x01b43000, 0x01b43fff] PGTABLE
[ 0.000000] init_memory_mapping: [mem 0x20c000000-0x20fdfffff]
[ 0.000000] [mem 0x20c000000-0x20fdfffff] page 2M
[ 0.000000] init_memory_mapping: [mem 0x200000000-0x20bffffff]
[ 0.000000] [mem 0x200000000-0x20bffffff] page 2M
[ 0.000000] init_memory_mapping: [mem 0x00100000-0xcfceffff]
[ 0.000000] [mem 0x00100000-0x001fffff] page 4k
[ 0.000000] [mem 0x00200000-0x3fffffff] page 2M
[ 0.000000] [mem 0x40000000-0xbfffffff] page 1G
[ 0.000000] [mem 0xc0000000-0xcfbfffff] page 2M
[ 0.000000] [mem 0xcfc00000-0xcfceffff] page 4k
[ 0.000000] init_memory_mapping: [mem 0x100000000-0x1ffffffff]
[ 0.000000] [mem 0x100000000-0x1ffffffff] page 1G
[ 0.000000] RAMDISK: [mem 0x37a1c000-0x37d05fff]
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000F5E70 000014 (v00 GBT )
[ 0.000000] ACPI: RSDT 0x00000000CFCF1000 00003C (v01 GBT GBTUACPI 42302E31 GBTU 01010101)
[ 0.000000] ACPI: FACP 0x00000000CFCF1040 000074 (v01 GBT GBTUACPI 42302E31 GBTU 01010101)
[ 0.000000] ACPI: DSDT 0x00000000CFCF10C0 0076BC (v01 GBT GBTUACPI 00001000 MSFT 03000000)
[ 0.000000] ACPI: FACS 0x00000000CFCF0000 000040
[ 0.000000] ACPI: SSDT 0x00000000CFCF8840 00088C (v01 PTLTD POWERNOW 00000001 LTP 00000001)
[ 0.000000] ACPI: HPET 0x00000000CFCF9100 000038 (v01 GBT GBTUACPI 42302E31 GBTU 00000098)
[ 0.000000] ACPI: MCFG 0x00000000CFCF9140 00003C (v01 GBT GBTUACPI 42302E31 GBTU 01010101)
[ 0.000000] ACPI: MATS 0x00000000CFCF9180 000034 (v01 GBT 00000000 00000000)
[ 0.000000] ACPI: APIC 0x00000000CFCF8780 0000BC (v01 GBT GBTUACPI 42302E31 GBTU 01010101)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] Scanning NUMA topology in Northbridge 24
[ 0.000000] No NUMA configuration found
[ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000020fffffff]
[ 0.000000] Initmem setup node 0 [mem 0x00000000-0x20fffffff]
[ 0.000000] NODE_DATA [mem 0x20fff9000-0x20fffdfff]
[ 0.000000] [ffffea0000000000-ffffea00083fffff] PMD -> [ffff880207e00000-ffff88020f5fffff] on node 0
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x00001000-0x00ffffff]
[ 0.000000] DMA32 [mem 0x01000000-0xffffffff]
[ 0.000000] Normal [mem 0x100000000-0x20fffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x00001000-0x00093fff]
[ 0.000000] node 0: [mem 0x00100000-0xcfceffff]
[ 0.000000] node 0: [mem 0x100000000-0x20fffffff]
[ 0.000000] On node 0 totalpages: 1965187
[ 0.000000] DMA zone: 64 pages used for memmap
[ 0.000000] DMA zone: 21 pages reserved
[ 0.000000] DMA zone: 3987 pages, LIFO batch:0
[ 0.000000] DMA32 zone: 13236 pages used for memmap
[ 0.000000] DMA32 zone: 847088 pages, LIFO batch:31
[ 0.000000] Normal zone: 17408 pages used for memmap
[ 0.000000] Normal zone: 1114112 pages, LIFO batch:31
[ 0.000000] ACPI: PM-Timer IO Port: 0x4008
[ 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 (acpi_id[0x04] lapic_id[0x04] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x05] lapic_id[0x05] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x06] lapic_id[0x06] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x07] lapic_id[0x07] disabled)
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x00] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x02] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x03] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x04] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x05] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x06] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x07] dfl dfl lint[0x1])
[ 0.000000] ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 2, version 33, 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 9 global_irq 9 low level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] ACPI: HPET id: 0x10b9a201 base: 0xfed00000
[ 0.000000] smpboot: Allowing 8 CPUs, 4 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 40
[ 0.000000] PM: Registered nosave memory: [mem 0x00094000-0x0009ffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xcfcf0000-0xcfcf0fff]
[ 0.000000] PM: Registered nosave memory: [mem 0xcfcf1000-0xcfcfffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xcfd00000-0xcfdfffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xcfe00000-0xdfffffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xe0000000-0xefffffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xf0000000-0xfebfffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xfec00000-0xffffffff]
[ 0.000000] e820: [mem 0xcfe00000-0xdfffffff] available for PCI devices
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:8 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 29 pages/cpu @ffff88020fc00000 s86656 r8192 d23936 u262144
[ 0.000000] pcpu-alloc: s86656 r8192 d23936 u262144 alloc=1*2097152
[ 0.000000] pcpu-alloc: [0] 0 1 2 3 4 5 6 7
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 1934458
[ 0.000000] Policy zone: Normal
[ 0.000000] Kernel command line: BOOT_IMAGE=/vmlinuz-linux-git root=UUID=3c811f3d-6764-4890-a664-8ac86e3d49af rw quiet
[ 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] AGP: Node 0: aperture [bus addr 0xc4000000-0xc5ffffff] (32MB)
[ 0.000000] Aperture pointing to e820 RAM. Ignoring.
[ 0.000000] AGP: Your BIOS doesn't leave a aperture memory hole
[ 0.000000] AGP: Please enable the IOMMU option in the BIOS setup
[ 0.000000] AGP: This costs you 64MB of RAM
[ 0.000000] AGP: Mapping aperture over RAM [mem 0xc4000000-0xc7ffffff] (65536KB)
[ 0.000000] PM: Registered nosave memory: [mem 0xc4000000-0xc7ffffff]
[ 0.000000] Memory: 7590464K/7860748K available (5118K kernel code, 890K rwdata, 1660K rodata, 1116K init, 1288K bss, 270284K reserved)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] RCU dyntick-idle grace-period acceleration is enabled.
[ 0.000000] Dump stacks of tasks blocking RCU-preempt GP.
[ 0.000000] RCU restricting CPUs from NR_CPUS=128 to nr_cpu_ids=8.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8
[ 0.000000] NR_IRQS:8448 nr_irqs:744 16
[ 0.000000] spurious 8259A interrupt: IRQ7.
[ 0.000000] Console: colour dummy device 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] allocated 31457280 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: Fast TSC calibration using PIT
[ 0.000000] tsc: Detected 3214.094 MHz processor
[ 0.000024] Calibrating delay loop (skipped), value calculated using timer frequency.. 6430.02 BogoMIPS (lpj=10713646)
[ 0.000026] pid_max: default: 32768 minimum: 301
[ 0.000032] ACPI: Core revision 20140424
[ 0.002638] ACPI: All ACPI Tables successfully acquired
[ 0.020457] Security Framework initialized
[ 0.020465] Yama: becoming mindful.
[ 0.020878] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[ 0.022549] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
[ 0.023520] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.023528] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.023741] Initializing cgroup subsys memory
[ 0.023746] Initializing cgroup subsys devices
[ 0.023747] Initializing cgroup subsys freezer
[ 0.023749] Initializing cgroup subsys net_cls
[ 0.023750] Initializing cgroup subsys blkio
[ 0.023751] Initializing cgroup subsys net_prio
[ 0.023766] tseg: 00cfe00000
[ 0.023769] CPU: Physical Processor ID: 0
[ 0.023770] CPU: Processor Core ID: 0
[ 0.023772] mce: CPU supports 6 MCE banks
[ 0.023776] LVT offset 0 assigned for vector 0xf9
[ 0.023779] process: using AMD E400 aware idle routine
[ 0.023781] Last level iTLB entries: 4KB 512, 2MB 16, 4MB 8
Last level dTLB entries: 4KB 512, 2MB 128, 4MB 64, 1GB 0
tlb_flushall_shift: 6
[ 0.023851] Freeing SMP alternatives memory: 20K (ffffffff819f7000 - ffffffff819fc000)
[ 0.024373] ftrace: allocating 20344 entries in 80 pages
[ 0.031584] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.064630] smpboot: CPU0: AMD Phenom(tm) II X4 955 Processor (fam: 10, model: 04, stepping: 03)
[ 0.170361] Performance Events: AMD PMU driver.
[ 0.170364] ... version: 0
[ 0.170365] ... bit width: 48
[ 0.170366] ... generic registers: 4
[ 0.170367] ... value mask: 0000ffffffffffff
[ 0.170368] ... max period: 00007fffffffffff
[ 0.170368] ... fixed-purpose events: 0
[ 0.170369] ... event mask: 000000000000000f
[ 0.170402] process: System has AMD C1E enabled
[ 0.170411] process: Switch to broadcast mode on CPU0
[ 0.187174] NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
[ 0.193847] x86: Booting SMP configuration:
[ 0.193850] .... node #0, CPUs: #1
[ 0.207041] process: Switch to broadcast mode on CPU1
[ 0.210545] #2
[ 0.223736] process: Switch to broadcast mode on CPU2
[ 0.227260] #3
[ 0.240408] x86: Booted up 1 node, 4 CPUs
[ 0.240411] smpboot: Total of 4 processors activated (25723.11 BogoMIPS)
[ 0.240448] process: Switch to broadcast mode on CPU3
[ 0.244906] devtmpfs: initialized
[ 0.248117] PM: Registering ACPI NVS region [mem 0xcfcf0000-0xcfcf0fff] (4096 bytes)
[ 0.248963] pinctrl core: initialized pinctrl subsystem
[ 0.248993] RTC time: 16:24:30, date: 06/17/14
[ 0.249034] NET: Registered protocol family 16
[ 0.249130] cpuidle: using governor ladder
[ 0.249132] cpuidle: using governor menu
[ 0.249136] node 0 link 0: io port [9000, ffff]
[ 0.249138] TOM: 00000000d0000000 aka 3328M
[ 0.249140] Fam 10h mmconf [mem 0xe0000000-0xe00fffff]
[ 0.249141] node 0 link 0: mmio [a0000, bffff]
[ 0.249143] node 0 link 0: mmio [d0000000, dfffffff]
[ 0.249145] node 0 link 0: mmio [f0000000, fe02ffff]
[ 0.249146] node 0 link 0: mmio [e0000000, e06fffff] ==> [e0100000, e06fffff]
[ 0.249148] TOM2: 0000000230000000 aka 8960M
[ 0.249149] bus: [bus 00-06] on node 0 link 0
[ 0.249150] bus: 00 [io 0x0000-0xffff]
[ 0.249151] bus: 00 [mem 0x000a0000-0x000bffff]
[ 0.249152] bus: 00 [mem 0xd0000000-0xdfffffff]
[ 0.249153] bus: 00 [mem 0xe0700000-0xffffffff]
[ 0.249154] bus: 00 [mem 0xe0100000-0xe06fffff]
[ 0.249155] bus: 00 [mem 0x230000000-0xfcffffffff]
[ 0.249199] ACPI: bus type PCI registered
[ 0.249201] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[ 0.249254] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000)
[ 0.249256] PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820
[ 0.249593] PCI: Using configuration type 1 for base access
[ 0.249783] mtrr: your CPUs had inconsistent variable MTRR settings
[ 0.249783] mtrr: probably your BIOS does not setup all CPUs.
[ 0.249784] mtrr: corrected configuration.
[ 0.250461] ACPI: Added _OSI(Module Device)
[ 0.250463] ACPI: Added _OSI(Processor Device)
[ 0.250464] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.250465] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.254814] ACPI: Interpreter enabled
[ 0.254823] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20140424/hwxface-580)
[ 0.254827] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20140424/hwxface-580)
[ 0.254837] ACPI: (supports S0 S3 S4 S5)
[ 0.254839] ACPI: Using IOAPIC for interrupt routing
[ 0.254863] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.365899] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.365905] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[ 0.365909] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.366101] PCI host bridge to bus 0000:00
[ 0.366103] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.366105] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7]
[ 0.366107] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff]
[ 0.366108] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[ 0.366110] pci_bus 0000:00: root bus resource [mem 0x000c0000-0x000dffff]
[ 0.366111] pci_bus 0000:00: root bus resource [mem 0xcff00000-0xfebfffff]
[ 0.366120] pci 0000:00:00.0: [1022:9601] type 00 class 0x060000
[ 0.366130] pci 0000:00:00.0: reg 0x1c: [mem 0xe0000000-0xffffffff 64bit]
[ 0.366205] pci 0000:00:01.0: [1022:9602] type 01 class 0x060400
[ 0.366277] pci 0000:00:05.0: [1022:9605] type 01 class 0x060400
[ 0.366308] pci 0000:00:05.0: PME# supported from D0 D3hot D3cold
[ 0.366340] pci 0000:00:05.0: System wakeup disabled by ACPI
[ 0.366368] pci 0000:00:06.0: [1022:9606] type 01 class 0x060400
[ 0.366398] pci 0000:00:06.0: PME# supported from D0 D3hot D3cold
[ 0.366428] pci 0000:00:06.0: System wakeup disabled by ACPI
[ 0.366459] pci 0000:00:0a.0: [1022:9609] type 01 class 0x060400
[ 0.366489] pci 0000:00:0a.0: PME# supported from D0 D3hot D3cold
[ 0.366519] pci 0000:00:0a.0: System wakeup disabled by ACPI
[ 0.366558] pci 0000:00:11.0: [1002:4391] type 00 class 0x010601
[ 0.366574] pci 0000:00:11.0: reg 0x10: [io 0xff00-0xff07]
[ 0.366581] pci 0000:00:11.0: reg 0x14: [io 0xfe00-0xfe03]
[ 0.366588] pci 0000:00:11.0: reg 0x18: [io 0xfd00-0xfd07]
[ 0.366594] pci 0000:00:11.0: reg 0x1c: [io 0xfc00-0xfc03]
[ 0.366601] pci 0000:00:11.0: reg 0x20: [io 0xfb00-0xfb0f]
[ 0.366608] pci 0000:00:11.0: reg 0x24: [mem 0xfe02f000-0xfe02f3ff]
[ 0.366698] pci 0000:00:12.0: [1002:4397] type 00 class 0x0c0310
[ 0.366708] pci 0000:00:12.0: reg 0x10: [mem 0xfe02e000-0xfe02efff]
[ 0.366773] pci 0000:00:12.0: System wakeup disabled by ACPI
[ 0.366805] pci 0000:00:12.2: [1002:4396] type 00 class 0x0c0320
[ 0.366819] pci 0000:00:12.2: reg 0x10: [mem 0xfe02d000-0xfe02d0ff]
[ 0.366878] pci 0000:00:12.2: supports D1 D2
[ 0.366879] pci 0000:00:12.2: PME# supported from D0 D1 D2 D3hot
[ 0.366910] pci 0000:00:12.2: System wakeup disabled by ACPI
[ 0.366942] pci 0000:00:13.0: [1002:4397] type 00 class 0x0c0310
[ 0.366952] pci 0000:00:13.0: reg 0x10: [mem 0xfe02c000-0xfe02cfff]
[ 0.367018] pci 0000:00:13.0: System wakeup disabled by ACPI
[ 0.367051] pci 0000:00:13.2: [1002:4396] type 00 class 0x0c0320
[ 0.367064] pci 0000:00:13.2: reg 0x10: [mem 0xfe02b000-0xfe02b0ff]
[ 0.367123] pci 0000:00:13.2: supports D1 D2
[ 0.367124] pci 0000:00:13.2: PME# supported from D0 D1 D2 D3hot
[ 0.367157] pci 0000:00:13.2: System wakeup disabled by ACPI
[ 0.367188] pci 0000:00:14.0: [1002:4385] type 00 class 0x0c0500
[ 0.367282] pci 0000:00:14.3: [1002:439d] type 00 class 0x060100
[ 0.367393] pci 0000:00:14.4: [1002:4384] type 01 class 0x060401
[ 0.367442] pci 0000:00:14.4: System wakeup disabled by ACPI
[ 0.367470] pci 0000:00:14.5: [1002:4399] type 00 class 0x0c0310
[ 0.367479] pci 0000:00:14.5: reg 0x10: [mem 0xfe02a000-0xfe02afff]
[ 0.367544] pci 0000:00:14.5: System wakeup disabled by ACPI
[ 0.367576] pci 0000:00:15.0: [1002:43a0] type 01 class 0x060400
[ 0.367630] pci 0000:00:15.0: supports D1 D2
[ 0.367663] pci 0000:00:15.0: System wakeup disabled by ACPI
[ 0.367697] pci 0000:00:16.0: [1002:4397] type 00 class 0x0c0310
[ 0.367707] pci 0000:00:16.0: reg 0x10: [mem 0xfe029000-0xfe029fff]
[ 0.367772] pci 0000:00:16.0: System wakeup disabled by ACPI
[ 0.367804] pci 0000:00:16.2: [1002:4396] type 00 class 0x0c0320
[ 0.367817] pci 0000:00:16.2: reg 0x10: [mem 0xfe028000-0xfe0280ff]
[ 0.367876] pci 0000:00:16.2: supports D1 D2
[ 0.367877] pci 0000:00:16.2: PME# supported from D0 D1 D2 D3hot
[ 0.367908] pci 0000:00:16.2: System wakeup disabled by ACPI
[ 0.367938] pci 0000:00:18.0: [1022:1200] type 00 class 0x060000
[ 0.367990] pci 0000:00:18.1: [1022:1201] type 00 class 0x060000
[ 0.368038] pci 0000:00:18.2: [1022:1202] type 00 class 0x060000
[ 0.368088] pci 0000:00:18.3: [1022:1203] type 00 class 0x060000
[ 0.368138] pci 0000:00:18.4: [1022:1204] type 00 class 0x060000
[ 0.368220] pci 0000:01:05.0: [1002:9714] type 00 class 0x030000
[ 0.368226] pci 0000:01:05.0: reg 0x10: [mem 0xd0000000-0xdfffffff pref]
[ 0.368230] pci 0000:01:05.0: reg 0x14: [io 0xbe00-0xbeff]
[ 0.368234] pci 0000:01:05.0: reg 0x18: [mem 0xfd5e0000-0xfd5effff]
[ 0.368241] pci 0000:01:05.0: reg 0x24: [mem 0xfd400000-0xfd4fffff]
[ 0.368255] pci 0000:01:05.0: supports D1 D2
[ 0.368283] pci 0000:01:05.1: [1002:970f] type 00 class 0x040300
[ 0.368290] pci 0000:01:05.1: reg 0x10: [mem 0xfd5fc000-0xfd5fffff]
[ 0.368314] pci 0000:01:05.1: supports D1 D2
[ 0.368359] pci 0000:00:01.0: PCI bridge to [bus 01]
[ 0.368362] pci 0000:00:01.0: bridge window [io 0xb000-0xbfff]
[ 0.368364] pci 0000:00:01.0: bridge window [mem 0xfd400000-0xfd5fffff]
[ 0.368367] pci 0000:00:01.0: bridge window [mem 0xd0000000-0xdfffffff 64bit pref]
[ 0.368407] pci 0000:02:00.0: [1033:0194] type 00 class 0x0c0330
[ 0.368423] pci 0000:02:00.0: reg 0x10: [mem 0xfdffe000-0xfdffffff 64bit]
[ 0.368496] pci 0000:02:00.0: PME# supported from D0 D3hot D3cold
[ 0.374075] pci 0000:00:05.0: PCI bridge to [bus 02]
[ 0.374079] pci 0000:00:05.0: bridge window [io 0xe000-0xefff]
[ 0.374081] pci 0000:00:05.0: bridge window [mem 0xfdf00000-0xfdffffff]
[ 0.374084] pci 0000:00:05.0: bridge window [mem 0xfde00000-0xfdefffff 64bit pref]
[ 0.374142] pci 0000:03:00.0: [10ec:8168] type 00 class 0x020000
[ 0.374158] pci 0000:03:00.0: reg 0x10: [io 0xde00-0xdeff]
[ 0.374181] pci 0000:03:00.0: reg 0x18: [mem 0xfddff000-0xfddfffff 64bit]
[ 0.374206] pci 0000:03:00.0: reg 0x30: [mem 0x00000000-0x0001ffff pref]
[ 0.374280] pci 0000:03:00.0: supports D1 D2
[ 0.374281] pci 0000:03:00.0: PME# supported from D1 D2 D3hot D3cold
[ 0.374322] pci 0000:03:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.374328] pci 0000:00:06.0: PCI bridge to [bus 03]
[ 0.374331] pci 0000:00:06.0: bridge window [io 0xd000-0xdfff]
[ 0.374333] pci 0000:00:06.0: bridge window [mem 0xfdd00000-0xfddfffff]
[ 0.374336] pci 0000:00:06.0: bridge window [mem 0xfdc00000-0xfdcfffff 64bit pref]
[ 0.374375] pci 0000:04:00.0: [10ec:8168] type 00 class 0x020000
[ 0.374389] pci 0000:04:00.0: reg 0x10: [io 0xce00-0xceff]
[ 0.374408] pci 0000:04:00.0: reg 0x18: [mem 0xfd6ff000-0xfd6fffff 64bit pref]
[ 0.374420] pci 0000:04:00.0: reg 0x20: [mem 0xfd6f8000-0xfd6fbfff 64bit pref]
[ 0.374428] pci 0000:04:00.0: reg 0x30: [mem 0x00000000-0x0001ffff pref]
[ 0.374482] pci 0000:04:00.0: supports D1 D2
[ 0.374484] pci 0000:04:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.380752] pci 0000:00:0a.0: PCI bridge to [bus 04]
[ 0.380757] pci 0000:00:0a.0: bridge window [io 0xc000-0xcfff]
[ 0.380759] pci 0000:00:0a.0: bridge window [mem 0xfd900000-0xfd9fffff]
[ 0.380762] pci 0000:00:0a.0: bridge window [mem 0xfd600000-0xfd6fffff 64bit pref]
[ 0.380828] pci 0000:00:14.4: PCI bridge to [bus 05] (subtractive decode)
[ 0.380831] pci 0000:00:14.4: bridge window [io 0xa000-0xafff]
[ 0.380834] pci 0000:00:14.4: bridge window [mem 0xfdb00000-0xfdbfffff]
[ 0.380837] pci 0000:00:14.4: bridge window [mem 0xfda00000-0xfdafffff pref]
[ 0.380838] pci 0000:00:14.4: bridge window [io 0x0000-0x0cf7] (subtractive decode)
[ 0.380840] pci 0000:00:14.4: bridge window [io 0x0d00-0xffff] (subtractive decode)
[ 0.380841] pci 0000:00:14.4: bridge window [mem 0x000a0000-0x000bffff] (subtractive decode)
[ 0.380843] pci 0000:00:14.4: bridge window [mem 0x000c0000-0x000dffff] (subtractive decode)
[ 0.380844] pci 0000:00:14.4: bridge window [mem 0xcff00000-0xfebfffff] (subtractive decode)
[ 0.380906] pci 0000:06:00.0: [197b:2363] type 00 class 0x010601
[ 0.380989] pci 0000:06:00.0: reg 0x24: [mem 0xfd8fe000-0xfd8fffff]
[ 0.381050] pci 0000:06:00.0: PME# supported from D3hot
[ 0.381105] pci 0000:06:00.1: [197b:2363] type 00 class 0x010185
[ 0.381126] pci 0000:06:00.1: reg 0x10: [io 0x9f00-0x9f07]
[ 0.381138] pci 0000:06:00.1: reg 0x14: [io 0x9e00-0x9e03]
[ 0.381150] pci 0000:06:00.1: reg 0x18: [io 0x9d00-0x9d07]
[ 0.381162] pci 0000:06:00.1: reg 0x1c: [io 0x9c00-0x9c03]
[ 0.381174] pci 0000:06:00.1: reg 0x20: [io 0x9b00-0x9b0f]
[ 0.381267] pci 0000:06:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.381276] pci 0000:00:15.0: PCI bridge to [bus 06]
[ 0.381279] pci 0000:00:15.0: bridge window [io 0x9000-0x9fff]
[ 0.381282] pci 0000:00:15.0: bridge window [mem 0xfd800000-0xfd8fffff]
[ 0.381286] pci 0000:00:15.0: bridge window [mem 0xfd700000-0xfd7fffff 64bit pref]
[ 0.381306] pci_bus 0000:00: on NUMA node 0
[ 0.434200] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434233] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434262] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434290] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434317] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434345] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434372] ACPI: PCI Interrupt Link [LNK0] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434400] ACPI: PCI Interrupt Link [LNK1] (IRQs 3 4 5 6 7 10 11) *0
[ 0.434781] vgaarb: device added: PCI:0000:01:05.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.434783] vgaarb: loaded
[ 0.434784] vgaarb: bridge control possible 0000:01:05.0
[ 0.434807] PCI: Using ACPI for IRQ routing
[ 0.440857] PCI: pci_cache_line_size set to 64 bytes
[ 0.440863] pci 0000:00:00.0: can't claim BAR 3 [mem 0xe0000000-0xffffffff 64bit]: no compatible bridge window
[ 0.440910] e820: reserve RAM buffer [mem 0x00094000-0x0009ffff]
[ 0.440911] e820: reserve RAM buffer [mem 0xcfcf0000-0xcfffffff]
[ 0.441006] NetLabel: Initializing
[ 0.441007] NetLabel: domain hash size = 128
[ 0.441007] NetLabel: protocols = UNLABELED CIPSOv4
[ 0.441017] NetLabel: unlabeled traffic allowed by default
[ 0.441036] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.441039] hpet0: 3 comparators, 32-bit 14.318180 MHz counter
[ 0.443097] Switched to clocksource hpet
[ 0.446942] pnp: PnP ACPI init
[ 0.446954] ACPI: bus type PNP registered
[ 0.447018] system 00:00: [io 0x04d0-0x04d1] has been reserved
[ 0.447020] system 00:00: [io 0x0220-0x0225] has been reserved
[ 0.447022] system 00:00: [io 0x0290-0x0294] has been reserved
[ 0.447024] system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.550044] pnp 00:01: disabling [mem 0x00000000-0x00000fff window] because it overlaps 0000:00:00.0 BAR 3 [mem 0x00000000-0x1fffffff 64bit]
[ 0.550061] pnp 00:01: disabling [mem 0x00000000-0x00000fff window disabled] because it overlaps 0000:03:00.0 BAR 6 [mem 0x00000000-0x0001ffff pref]
[ 0.550064] pnp 00:01: disabling [mem 0x00000000-0x00000fff window disabled] because it overlaps 0000:04:00.0 BAR 6 [mem 0x00000000-0x0001ffff pref]
[ 0.550097] system 00:01: [io 0x4100-0x411f] has been reserved
[ 0.550099] system 00:01: [io 0x0228-0x022f] has been reserved
[ 0.550101] system 00:01: [io 0x040b] has been reserved
[ 0.550102] system 00:01: [io 0x04d6] has been reserved
[ 0.550103] system 00:01: [io 0x0c00-0x0c01] has been reserved
[ 0.550105] system 00:01: [io 0x0c14] has been reserved
[ 0.550106] system 00:01: [io 0x0c50-0x0c52] has been reserved
[ 0.550108] system 00:01: [io 0x0c6c-0x0c6d] has been reserved
[ 0.550109] system 00:01: [io 0x0c6f] has been reserved
[ 0.550110] system 00:01: [io 0x0cd0-0x0cd1] has been reserved
[ 0.550112] system 00:01: [io 0x0cd2-0x0cd3] has been reserved
[ 0.550113] system 00:01: [io 0x0cd4-0x0cdf] has been reserved
[ 0.550115] system 00:01: [io 0x4000-0x40fe] could not be reserved
[ 0.550116] system 00:01: [io 0x4210-0x4217] has been reserved
[ 0.550118] system 00:01: [io 0x0b00-0x0b0f] has been reserved
[ 0.550119] system 00:01: [io 0x0b10-0x0b1f] has been reserved
[ 0.550120] system 00:01: [io 0x0b20-0x0b3f] has been reserved
[ 0.550122] system 00:01: [mem 0xfee00400-0xfee00fff window] has been reserved
[ 0.550125] system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.550233] pnp 00:02: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 0.550388] pnp 00:03: Plug and Play ACPI device, IDs PNP0303 (active)
[ 0.550433] system 00:04: [mem 0xe0000000-0xefffffff] has been reserved
[ 0.550435] system 00:04: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.550520] pnp 00:05: disabling [mem 0x000f0000-0x000f3fff] because it overlaps 0000:00:00.0 BAR 3 [mem 0x00000000-0x1fffffff 64bit]
[ 0.550522] pnp 00:05: disabling [mem 0x000f4000-0x000f7fff] because it overlaps 0000:00:00.0 BAR 3 [mem 0x00000000-0x1fffffff 64bit]
[ 0.550524] pnp 00:05: disabling [mem 0x000f8000-0x000fbfff] because it overlaps 0000:00:00.0 BAR 3 [mem 0x00000000-0x1fffffff 64bit]
[ 0.550526] pnp 00:05: disabling [mem 0x000fc000-0x000fffff] because it overlaps 0000:00:00.0 BAR 3 [mem 0x00000000-0x1fffffff 64bit]
[ 0.550528] pnp 00:05: disabling [mem 0x00000000-0x0009ffff] because it overlaps 0000:00:00.0 BAR 3 [mem 0x00000000-0x1fffffff 64bit]
[ 0.550530] pnp 00:05: disabling [mem 0x00100000-0xcfceffff] because it overlaps 0000:00:00.0 BAR 3 [mem 0x00000000-0x1fffffff 64bit]
[ 0.550565] system 00:05: [mem 0xcfcf0000-0xcfcfffff] could not be reserved
[ 0.550566] system 00:05: [mem 0xffff0000-0xffffffff] has been reserved
[ 0.550568] system 00:05: [mem 0xcfd00000-0xcfdfffff] has been reserved
[ 0.550570] system 00:05: [mem 0xcfe00000-0xcfefffff] could not be reserved
[ 0.550571] system 00:05: [mem 0xfec00000-0xfec00fff] could not be reserved
[ 0.550573] system 00:05: [mem 0xfee00000-0xfee00fff] could not be reserved
[ 0.550575] system 00:05: [mem 0xfff80000-0xfffeffff] has been reserved
[ 0.550577] system 00:05: Plug and Play ACPI device, IDs PNP0c01 (active)
[ 0.550588] pnp: PnP ACPI: found 6 devices
[ 0.550589] ACPI: bus type PNP unregistered
[ 0.557199] pci 0000:00:01.0: PCI bridge to [bus 01]
[ 0.557201] pci 0000:00:01.0: bridge window [io 0xb000-0xbfff]
[ 0.557204] pci 0000:00:01.0: bridge window [mem 0xfd400000-0xfd5fffff]
[ 0.557206] pci 0000:00:01.0: bridge window [mem 0xd0000000-0xdfffffff 64bit pref]
[ 0.557209] pci 0000:00:05.0: PCI bridge to [bus 02]
[ 0.557211] pci 0000:00:05.0: bridge window [io 0xe000-0xefff]
[ 0.557213] pci 0000:00:05.0: bridge window [mem 0xfdf00000-0xfdffffff]
[ 0.557215] pci 0000:00:05.0: bridge window [mem 0xfde00000-0xfdefffff 64bit pref]
[ 0.557220] pci 0000:03:00.0: BAR 6: assigned [mem 0xfdd00000-0xfdd1ffff pref]
[ 0.557222] pci 0000:00:06.0: PCI bridge to [bus 03]
[ 0.557223] pci 0000:00:06.0: bridge window [io 0xd000-0xdfff]
[ 0.557226] pci 0000:00:06.0: bridge window [mem 0xfdd00000-0xfddfffff]
[ 0.557228] pci 0000:00:06.0: bridge window [mem 0xfdc00000-0xfdcfffff 64bit pref]
[ 0.557231] pci 0000:04:00.0: BAR 6: assigned [mem 0xfd900000-0xfd91ffff pref]
[ 0.557232] pci 0000:00:0a.0: PCI bridge to [bus 04]
[ 0.557234] pci 0000:00:0a.0: bridge window [io 0xc000-0xcfff]
[ 0.557236] pci 0000:00:0a.0: bridge window [mem 0xfd900000-0xfd9fffff]
[ 0.557238] pci 0000:00:0a.0: bridge window [mem 0xfd600000-0xfd6fffff 64bit pref]
[ 0.557241] pci 0000:00:14.4: PCI bridge to [bus 05]
[ 0.557243] pci 0000:00:14.4: bridge window [io 0xa000-0xafff]
[ 0.557246] pci 0000:00:14.4: bridge window [mem 0xfdb00000-0xfdbfffff]
[ 0.557249] pci 0000:00:14.4: bridge window [mem 0xfda00000-0xfdafffff pref]
[ 0.557254] pci 0000:00:15.0: PCI bridge to [bus 06]
[ 0.557256] pci 0000:00:15.0: bridge window [io 0x9000-0x9fff]
[ 0.557259] pci 0000:00:15.0: bridge window [mem 0xfd800000-0xfd8fffff]
[ 0.557262] pci 0000:00:15.0: bridge window [mem 0xfd700000-0xfd7fffff 64bit pref]
[ 0.557266] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7]
[ 0.557267] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff]
[ 0.557269] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[ 0.557270] pci_bus 0000:00: resource 7 [mem 0x000c0000-0x000dffff]
[ 0.557272] pci_bus 0000:00: resource 8 [mem 0xcff00000-0xfebfffff]
[ 0.557273] pci_bus 0000:01: resource 0 [io 0xb000-0xbfff]
[ 0.557274] pci_bus 0000:01: resource 1 [mem 0xfd400000-0xfd5fffff]
[ 0.557276] pci_bus 0000:01: resource 2 [mem 0xd0000000-0xdfffffff 64bit pref]
[ 0.557278] pci_bus 0000:02: resource 0 [io 0xe000-0xefff]
[ 0.557279] pci_bus 0000:02: resource 1 [mem 0xfdf00000-0xfdffffff]
[ 0.557280] pci_bus 0000:02: resource 2 [mem 0xfde00000-0xfdefffff 64bit pref]
[ 0.557282] pci_bus 0000:03: resource 0 [io 0xd000-0xdfff]
[ 0.557283] pci_bus 0000:03: resource 1 [mem 0xfdd00000-0xfddfffff]
[ 0.557285] pci_bus 0000:03: resource 2 [mem 0xfdc00000-0xfdcfffff 64bit pref]
[ 0.557286] pci_bus 0000:04: resource 0 [io 0xc000-0xcfff]
[ 0.557288] pci_bus 0000:04: resource 1 [mem 0xfd900000-0xfd9fffff]
[ 0.557289] pci_bus 0000:04: resource 2 [mem 0xfd600000-0xfd6fffff 64bit pref]
[ 0.557291] pci_bus 0000:05: resource 0 [io 0xa000-0xafff]
[ 0.557292] pci_bus 0000:05: resource 1 [mem 0xfdb00000-0xfdbfffff]
[ 0.557294] pci_bus 0000:05: resource 2 [mem 0xfda00000-0xfdafffff pref]
[ 0.557295] pci_bus 0000:05: resource 4 [io 0x0000-0x0cf7]
[ 0.557296] pci_bus 0000:05: resource 5 [io 0x0d00-0xffff]
[ 0.557298] pci_bus 0000:05: resource 6 [mem 0x000a0000-0x000bffff]
[ 0.557299] pci_bus 0000:05: resource 7 [mem 0x000c0000-0x000dffff]
[ 0.557301] pci_bus 0000:05: resource 8 [mem 0xcff00000-0xfebfffff]
[ 0.557302] pci_bus 0000:06: resource 0 [io 0x9000-0x9fff]
[ 0.557304] pci_bus 0000:06: resource 1 [mem 0xfd800000-0xfd8fffff]
[ 0.557305] pci_bus 0000:06: resource 2 [mem 0xfd700000-0xfd7fffff 64bit pref]
[ 0.557330] NET: Registered protocol family 2
[ 0.557493] TCP established hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.557659] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 0.557906] TCP: Hash tables configured (established 65536 bind 65536)
[ 0.557939] TCP: reno registered
[ 0.557947] UDP hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.557989] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.558066] NET: Registered protocol family 1
[ 0.558077] pci 0000:00:01.0: MSI quirk detected; subordinate MSI disabled
[ 0.827240] pci 0000:01:05.0: Boot video device
[ 0.827365] PCI: CLS 4 bytes, default 64
[ 0.827420] Unpacking initramfs...
[ 1.087471] Freeing initrd memory: 2984K (ffff880037a1c000 - ffff880037d06000)
[ 1.087480] PCI-DMA: Disabling AGP.
[ 1.087565] PCI-DMA: aperture base @ c4000000 size 65536 KB
[ 1.087566] PCI-DMA: using GART IOMMU.
[ 1.087568] PCI-DMA: Reserving 64MB of IOMMU area in the AGP aperture
[ 1.090582] LVT offset 1 assigned for vector 0x400
[ 1.090591] IBS: LVT offset 1 assigned
[ 1.090621] perf: AMD IBS detected (0x0000001f)
[ 1.090651] Scanning for low memory corruption every 60 seconds
[ 1.090929] futex hash table entries: 2048 (order: 5, 131072 bytes)
[ 1.099908] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 1.101012] zbud: loaded
[ 1.101200] VFS: Disk quotas dquot_6.5.2
[ 1.101228] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 1.101342] msgmni has been set to 14959
[ 1.101387] Key type big_key registered
[ 1.101539] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[ 1.101593] io scheduler noop registered
[ 1.101595] io scheduler deadline registered
[ 1.101618] io scheduler cfq registered (default)
[ 1.101689] pcieport 0000:00:05.0: irq 40 for MSI/MSI-X
[ 1.101836] pcieport 0000:00:06.0: irq 41 for MSI/MSI-X
[ 1.101945] pcieport 0000:00:0a.0: irq 42 for MSI/MSI-X
[ 1.102100] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 1.102113] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 1.102156] simple-framebuffer simple-framebuffer.0: framebuffer at 0xd0000000, 0x300000 bytes, mapped to 0xffffc90010e80000
[ 1.102158] simple-framebuffer simple-framebuffer.0: format=x8r8g8b8, mode=1024x768x32, linelength=4096
[ 1.104295] Console: switching to colour frame buffer device 128x48
[ 1.106334] simple-framebuffer simple-framebuffer.0: fb0: simplefb registered!
[ 1.106363] GHES: HEST is not enabled!
[ 1.106434] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 1.106733] Linux agpgart interface v0.103
[ 1.106768] rtc_cmos 00:02: RTC can wake from S4
[ 1.106859] rtc_cmos 00:02: rtc core: registered rtc_cmos as rtc0
[ 1.106885] rtc_cmos 00:02: alarms up to one month, 242 bytes nvram, hpet irqs
[ 1.106896] ledtrig-cpu: registered to indicate activity on CPUs
[ 1.106977] TCP: cubic registered
[ 1.107058] NET: Registered protocol family 10
[ 1.107246] NET: Registered protocol family 17
[ 1.107534] registered taskstats version 1
[ 1.107904] Magic number: 2:349:439
[ 1.107970] rtc_cmos 00:02: setting system clock to 2014-06-17 16:24:31 UTC (1403022271)
[ 1.108007] PM: Hibernation image not present or could not be loaded.
[ 1.108919] Freeing unused kernel memory: 1116K (ffffffff818e0000 - ffffffff819f7000)
[ 1.108920] Write protecting the kernel read-only data: 8192k
[ 1.111287] Freeing unused kernel memory: 1016K (ffff880001502000 - ffff880001600000)
[ 1.112174] Freeing unused kernel memory: 388K (ffff88000179f000 - ffff880001800000)
[ 1.117474] random: systemd-tmpfile urandom read with 68 bits of entropy available
[ 1.118581] systemd-udevd[57]: starting version 212
[ 1.126085] i8042: PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1
[ 1.126088] i8042: PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
[ 1.126236] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 1.130501] ACPI: bus type USB registered
[ 1.130520] usbcore: registered new interface driver usbfs
[ 1.130528] usbcore: registered new interface driver hub
[ 1.130608] usbcore: registered new device driver usb
[ 1.130889] SCSI subsystem initialized
[ 1.131358] QUIRK: Enable AMD PLL fix
[ 1.131373] xhci_hcd 0000:02:00.0: xHCI Host Controller
[ 1.131378] xhci_hcd 0000:02:00.0: new USB bus registered, assigned bus number 1
[ 1.131506] xhci_hcd 0000:02:00.0: irq 43 for MSI/MSI-X
[ 1.131509] xhci_hcd 0000:02:00.0: irq 44 for MSI/MSI-X
[ 1.131512] xhci_hcd 0000:02:00.0: irq 45 for MSI/MSI-X
[ 1.131515] xhci_hcd 0000:02:00.0: irq 46 for MSI/MSI-X
[ 1.131518] xhci_hcd 0000:02:00.0: irq 47 for MSI/MSI-X
[ 1.131719] hub 1-0:1.0: USB hub found
[ 1.131726] hub 1-0:1.0: 2 ports detected
[ 1.131830] xhci_hcd 0000:02:00.0: xHCI Host Controller
[ 1.131833] xhci_hcd 0000:02:00.0: new USB bus registered, assigned bus number 2
[ 1.131890] libata version 3.00 loaded.
[ 1.132360] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.132407] ahci 0000:00:11.0: version 3.0
[ 1.132462] ehci-pci: EHCI PCI platform driver
[ 1.132571] ahci 0000:00:11.0: irq 48 for MSI/MSI-X
[ 1.132594] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 1.132660] ahci 0000:00:11.0: AHCI 0001.0200 32 slots 6 ports 6 Gbps 0x3f impl SATA mode
[ 1.132663] ahci 0000:00:11.0: flags: 64bit ncq sntf ilck pm led clo pmp pio slum part
[ 1.132682] ohci-pci: OHCI PCI platform driver
[ 1.133316] scsi0 : ahci
[ 1.134867] scsi2 : pata_jmicron
[ 1.135171] hub 2-0:1.0: USB hub found
[ 1.135182] hub 2-0:1.0: 2 ports detected
[ 1.135274] scsi3 : pata_jmicron
[ 1.135327] ata7: PATA max UDMA/100 cmd 0x9f00 ctl 0x9e00 bmdma 0x9b00 irq 17
[ 1.135329] ata8: PATA max UDMA/100 cmd 0x9d00 ctl 0x9c00 bmdma 0x9b08 irq 17
[ 1.137402] scsi1 : ahci
[ 1.137514] scsi4 : ahci
[ 1.137654] scsi5 : ahci
[ 1.140690] scsi6 : ahci
[ 1.140798] scsi7 : ahci
[ 1.140842] ata1: SATA max UDMA/133 abar m1024@0xfe02f000 port 0xfe02f100 irq 48
[ 1.140845] ata2: SATA max UDMA/133 abar m1024@0xfe02f000 port 0xfe02f180 irq 48
[ 1.140847] ata3: SATA max UDMA/133 abar m1024@0xfe02f000 port 0xfe02f200 irq 48
[ 1.140849] ata4: SATA max UDMA/133 abar m1024@0xfe02f000 port 0xfe02f280 irq 48
[ 1.140851] ata5: SATA max UDMA/133 abar m1024@0xfe02f000 port 0xfe02f300 irq 48
[ 1.140853] ata6: SATA max UDMA/133 abar m1024@0xfe02f000 port 0xfe02f380 irq 48
[ 1.141005] ehci-pci 0000:00:12.2: EHCI Host Controller
[ 1.141012] ehci-pci 0000:00:12.2: new USB bus registered, assigned bus number 3
[ 1.141016] ehci-pci 0000:00:12.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[ 1.141032] ehci-pci 0000:00:12.2: debug port 1
[ 1.141083] ehci-pci 0000:00:12.2: irq 17, io mem 0xfe02d000
[ 1.141093] ahci 0000:06:00.0: AHCI 0001.0000 32 slots 2 ports 3 Gbps 0x3 impl SATA mode
[ 1.141096] ahci 0000:06:00.0: flags: 64bit ncq pm led clo pmp pio slum part
[ 1.141498] scsi8 : ahci
[ 1.143447] scsi9 : ahci
[ 1.143498] ata9: SATA max UDMA/133 abar m8192@0xfd8fe000 port 0xfd8fe100 irq 17
[ 1.143502] ata10: SATA max UDMA/133 abar m8192@0xfd8fe000 port 0xfd8fe180 irq 17
[ 1.150745] ehci-pci 0000:00:12.2: USB 2.0 started, EHCI 1.00
[ 1.150934] hub 3-0:1.0: USB hub found
[ 1.150941] hub 3-0:1.0: 5 ports detected
[ 1.151142] ehci-pci 0000:00:13.2: EHCI Host Controller
[ 1.151146] ehci-pci 0000:00:13.2: new USB bus registered, assigned bus number 4
[ 1.151149] ehci-pci 0000:00:13.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[ 1.151157] ehci-pci 0000:00:13.2: debug port 1
[ 1.151179] ehci-pci 0000:00:13.2: irq 17, io mem 0xfe02b000
[ 1.160744] ehci-pci 0000:00:13.2: USB 2.0 started, EHCI 1.00
[ 1.160873] hub 4-0:1.0: USB hub found
[ 1.160878] hub 4-0:1.0: 5 ports detected
[ 1.161074] ehci-pci 0000:00:16.2: EHCI Host Controller
[ 1.161078] ehci-pci 0000:00:16.2: new USB bus registered, assigned bus number 5
[ 1.161081] ehci-pci 0000:00:16.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[ 1.161089] ehci-pci 0000:00:16.2: debug port 1
[ 1.161112] ehci-pci 0000:00:16.2: irq 17, io mem 0xfe028000
[ 1.165211] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[ 1.170769] ehci-pci 0000:00:16.2: USB 2.0 started, EHCI 1.00
[ 1.170898] hub 5-0:1.0: USB hub found
[ 1.170903] hub 5-0:1.0: 4 ports detected
[ 1.171112] ohci-pci 0000:00:12.0: OHCI PCI host controller
[ 1.171119] ohci-pci 0000:00:12.0: new USB bus registered, assigned bus number 6
[ 1.171150] ohci-pci 0000:00:12.0: irq 18, io mem 0xfe02e000
[ 1.228336] hub 6-0:1.0: USB hub found
[ 1.228344] hub 6-0:1.0: 5 ports detected
[ 1.228542] ohci-pci 0000:00:13.0: OHCI PCI host controller
[ 1.228546] ohci-pci 0000:00:13.0: new USB bus registered, assigned bus number 7
[ 1.228561] ohci-pci 0000:00:13.0: irq 18, io mem 0xfe02c000
[ 1.285067] hub 7-0:1.0: USB hub found
[ 1.285074] hub 7-0:1.0: 5 ports detected
[ 1.285265] ohci-pci 0000:00:14.5: OHCI PCI host controller
[ 1.285269] ohci-pci 0000:00:14.5: new USB bus registered, assigned bus number 8
[ 1.285283] ohci-pci 0000:00:14.5: irq 18, io mem 0xfe02a000
[ 1.341803] hub 8-0:1.0: USB hub found
[ 1.341810] hub 8-0:1.0: 2 ports detected
[ 1.341968] ohci-pci 0000:00:16.0: OHCI PCI host controller
[ 1.341972] ohci-pci 0000:00:16.0: new USB bus registered, assigned bus number 9
[ 1.341987] ohci-pci 0000:00:16.0: irq 18, io mem 0xfe029000
[ 1.398540] hub 9-0:1.0: USB hub found
[ 1.398547] hub 9-0:1.0: 4 ports detected
[ 1.628050] ata9: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 1.628059] ata5: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 1.628083] ata10: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 1.628092] ata4: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1.628110] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1.628126] ata6: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1.628142] ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1.628156] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1.628782] ata9.00: ATA-8: ST2000DL003-9VT166, CC32, max UDMA/133
[ 1.628795] ata9.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32)
[ 1.628806] ata4.00: ATA-8: ST2000DL003-9VT166, CC32, max UDMA/133
[ 1.628809] ata4.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32)
[ 1.628811] ata10.00: ATA-8: ST2000DL003-9VT166, CC32, max UDMA/133
[ 1.628813] ata10.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32)
[ 1.628853] ata1.00: ATA-8: ST2000DL003-9VT166, CC32, max UDMA/133
[ 1.628854] ata1.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32)
[ 1.628906] ata3.00: ATA-8: ST2000DL003-9VT166, CC32, max UDMA/133
[ 1.628907] ata3.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32)
[ 1.628998] ata6.00: ATA-8: ST4000DM000-1F2168, CC52, max UDMA/133
[ 1.628999] ata6.00: 7814037168 sectors, multi 0: LBA48 NCQ (depth 31/32), AA
[ 1.629057] ata5.00: ATA-8: ST3160318AS, CC38, max UDMA/133
[ 1.629058] ata5.00: 312581808 sectors, multi 0: LBA48 NCQ (depth 31/32)
[ 1.629189] ata2.00: ATA-8: ST2000DM001-1CH164, CC24, max UDMA/133
[ 1.629191] ata2.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32), AA
[ 1.629575] ata9.00: configured for UDMA/133
[ 1.629587] ata10.00: configured for UDMA/133
[ 1.629612] ata4.00: configured for UDMA/133
[ 1.629669] ata1.00: configured for UDMA/133
[ 1.629720] ata3.00: configured for UDMA/133
[ 1.629779] scsi 0:0:0:0: Direct-Access ATA ST2000DL003-9VT1 CC32 PQ: 0 ANSI: 5
[ 1.629862] ata6.00: configured for UDMA/133
[ 1.630143] ata2.00: configured for UDMA/133
[ 1.630206] scsi 1:0:0:0: Direct-Access ATA ST2000DM001-1CH1 CC24 PQ: 0 ANSI: 5
[ 1.630232] ata5.00: configured for UDMA/133
[ 1.630446] scsi 4:0:0:0: Direct-Access ATA ST2000DL003-9VT1 CC32 PQ: 0 ANSI: 5
[ 1.630652] scsi 5:0:0:0: Direct-Access ATA ST2000DL003-9VT1 CC32 PQ: 0 ANSI: 5
[ 1.630851] scsi 6:0:0:0: Direct-Access ATA ST3160318AS CC38 PQ: 0 ANSI: 5
[ 1.631065] scsi 7:0:0:0: Direct-Access ATA ST4000DM000-1F21 CC52 PQ: 0 ANSI: 5
[ 1.631242] scsi 8:0:0:0: Direct-Access ATA ST2000DL003-9VT1 CC32 PQ: 0 ANSI: 5
[ 1.631458] scsi 9:0:0:0: Direct-Access ATA ST2000DL003-9VT1 CC32 PQ: 0 ANSI: 5
[ 1.633804] sd 0:0:0:0: [sda] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
[ 1.633830] sd 1:0:0:0: [sdb] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
[ 1.633833] sd 1:0:0:0: [sdb] 4096-byte physical blocks
[ 1.633838] sd 4:0:0:0: [sdc] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
[ 1.633846] sd 5:0:0:0: [sdd] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
[ 1.633881] sd 4:0:0:0: [sdc] Write Protect is off
[ 1.633883] sd 4:0:0:0: [sdc] Mode Sense: 00 3a 00 00
[ 1.633887] sd 6:0:0:0: [sde] 312581808 512-byte logical blocks: (160 GB/149 GiB)
[ 1.633892] sd 5:0:0:0: [sdd] Write Protect is off
[ 1.633894] sd 5:0:0:0: [sdd] Mode Sense: 00 3a 00 00
[ 1.633898] sd 7:0:0:0: [sdf] 7814037168 512-byte logical blocks: (4.00 TB/3.63 TiB)
[ 1.633900] sd 7:0:0:0: [sdf] 4096-byte physical blocks
[ 1.633903] sd 4:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.633924] sd 8:0:0:0: [sdg] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
[ 1.633939] sd 5:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.633968] sd 8:0:0:0: [sdg] Write Protect is off
[ 1.633969] sd 6:0:0:0: [sde] Write Protect is off
[ 1.633970] sd 7:0:0:0: [sdf] Write Protect is off
[ 1.633972] sd 6:0:0:0: [sde] Mode Sense: 00 3a 00 00
[ 1.633974] sd 7:0:0:0: [sdf] Mode Sense: 00 3a 00 00
[ 1.633977] sd 8:0:0:0: [sdg] Mode Sense: 00 3a 00 00
[ 1.633991] sd 6:0:0:0: [sde] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.633993] sd 7:0:0:0: [sdf] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.633996] sd 0:0:0:0: [sda] Write Protect is off
[ 1.633997] sd 8:0:0:0: [sdg] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.634000] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 1.634015] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.634096] sd 1:0:0:0: [sdb] Write Protect is off
[ 1.634098] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[ 1.634114] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.634281] sd 9:0:0:0: [sdh] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
[ 1.634320] sd 9:0:0:0: [sdh] Write Protect is off
[ 1.634322] sd 9:0:0:0: [sdh] Mode Sense: 00 3a 00 00
[ 1.634337] sd 9:0:0:0: [sdh] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.638054] sdd: unknown partition table
[ 1.638315] sd 5:0:0:0: [sdd] Attached SCSI disk
[ 1.646877] sde: sde1 sde2 sde3
[ 1.647271] sd 6:0:0:0: [sde] Attached SCSI disk
[ 1.655957] sda: unknown partition table
[ 1.656206] sd 0:0:0:0: [sda] Attached SCSI disk
[ 1.657323] sdh: unknown partition table
[ 1.657580] sd 9:0:0:0: [sdh] Attached SCSI disk
[ 1.657807] sdc: unknown partition table
[ 1.657814] sdb: unknown partition table
[ 1.658019] sd 4:0:0:0: [sdc] Attached SCSI disk
[ 1.658029] sd 1:0:0:0: [sdb] Attached SCSI disk
[ 1.658956] random: nonblocking pool is initialized
[ 1.658977] sdg: unknown partition table
[ 1.659249] sd 8:0:0:0: [sdg] Attached SCSI disk
[ 1.680741] sdf: unknown partition table
[ 1.680979] sd 7:0:0:0: [sdf] Attached SCSI disk
[ 1.778174] raid6: sse2x1 4290 MB/s
[ 1.834912] raid6: sse2x2 6975 MB/s
[ 1.891654] raid6: sse2x4 8016 MB/s
[ 1.891655] raid6: using algorithm sse2x4 (8016 MB/s)
[ 1.891656] raid6: using intx1 recovery algorithm
[ 1.891775] xor: measuring software checksum speed
[ 1.925033] prefetch64-sse: 12775.200 MB/sec
[ 1.958412] generic_sse: 12238.800 MB/sec
[ 1.958415] xor: using function: prefetch64-sse (12775.200 MB/sec)
[ 2.006533] Btrfs loaded, debug=on, assert=on
[ 2.007104] BTRFS: device fsid bde3c349-9e08-45bb-8517-b9a6dda81e88 devid 5 transid 92287 /dev/sdd
[ 2.010354] BTRFS: device fsid bde3c349-9e08-45bb-8517-b9a6dda81e88 devid 2 transid 92287 /dev/sda
[ 2.010573] BTRFS: device fsid bde3c349-9e08-45bb-8517-b9a6dda81e88 devid 1 transid 92287 /dev/sdf
[ 2.021882] BTRFS: device fsid bde3c349-9e08-45bb-8517-b9a6dda81e88 devid 6 transid 92287 /dev/sdh
[ 2.032468] BTRFS: device fsid bde3c349-9e08-45bb-8517-b9a6dda81e88 devid 4 transid 92287 /dev/sdc
[ 2.032694] BTRFS: device fsid bde3c349-9e08-45bb-8517-b9a6dda81e88 devid 3 transid 92287 /dev/sdb
[ 2.091952] tsc: Refined TSC clocksource calibration: 3214.196 MHz
[ 3.093332] Switched to clocksource tsc
[ 4.147981] floppy0: no floppy controllers found
[ 7.135658] EXT4-fs (sde3): mounted filesystem with ordered data mode. Opts: (null)
[ 8.007620] systemd[1]: systemd 212 running in system mode. (+PAM -AUDIT -SELINUX -IMA -SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ +SECCOMP -APPARMOR)
[ 8.007743] systemd[1]: Detected architecture 'x86-64'.
[ 8.025493] systemd[1]: Set hostname to <linuxserver>.
[ 9.188942] systemd[1]: Cannot add dependency job for unit postgresql.service, ignoring: Unit postgresql.service failed to load: No such file or directory.
[ 9.188950] systemd[1]: Cannot add dependency job for unit dcron.service, ignoring: Unit dcron.service failed to load: No such file or directory.
[ 9.188996] systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory.
[ 9.189253] systemd[1]: Starting Forward Password Requests to Wall Directory Watch.
[ 9.189293] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 9.189303] systemd[1]: Starting Remote File Systems.
[ 9.189310] systemd[1]: Reached target Remote File Systems.
[ 9.189317] systemd[1]: Expecting device sys-subsystem-net-devices-eth1.device...
[ 9.189331] systemd[1]: Starting Arbitrary Executable File Formats File System Automount Point.
[ 9.189387] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[ 9.189398] systemd[1]: Starting Dispatch Password Requests to Console Directory Watch.
[ 9.189416] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[ 9.189422] systemd[1]: Starting Paths.
[ 9.189428] systemd[1]: Reached target Paths.
[ 9.189434] systemd[1]: Starting Encrypted Volumes.
[ 9.189440] systemd[1]: Reached target Encrypted Volumes.
[ 9.189447] systemd[1]: Expecting device dev-disk-by\x2duuid-7e52eaf8\x2ddf66\x2d4c93\x2db557\x2d5094dc6a03fa.device...
[ 9.189454] systemd[1]: Expecting device dev-disk-by\x2duuid-bde3c349\x2d9e08\x2d45bb\x2d8517\x2db9a6dda81e88.device...
[ 9.189461] systemd[1]: Expecting device dev-disk-by\x2duuid-e3019ddf\x2d92bc\x2d4baa\x2db7b0\x2debba228a0dce.device...
[ 9.189467] systemd[1]: Starting Root Slice.
[ 9.194902] systemd[1]: Created slice Root Slice.
[ 9.194912] systemd[1]: Starting User and Session Slice.
[ 9.195016] systemd[1]: Created slice User and Session Slice.
[ 9.195023] systemd[1]: Starting Device-mapper event daemon FIFOs.
[ 9.195043] systemd[1]: Listening on Device-mapper event daemon FIFOs.
[ 9.195050] systemd[1]: Starting Delayed Shutdown Socket.
[ 9.195065] systemd[1]: Listening on Delayed Shutdown Socket.
[ 9.195072] systemd[1]: Starting /dev/initctl Compatibility Named Pipe.
[ 9.195084] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[ 9.195090] systemd[1]: Starting Syslog Socket.
[ 9.195107] systemd[1]: Listening on Syslog Socket.
[ 9.195113] systemd[1]: Starting LVM2 metadata daemon socket.
[ 9.195128] systemd[1]: Listening on LVM2 metadata daemon socket.
[ 9.195136] systemd[1]: Starting udev Kernel Socket.
[ 9.195147] systemd[1]: Listening on udev Kernel Socket.
[ 9.195155] systemd[1]: Starting udev Control Socket.
[ 9.195167] systemd[1]: Listening on udev Control Socket.
[ 9.195176] systemd[1]: Starting Journal Socket.
[ 9.195196] systemd[1]: Listening on Journal Socket.
[ 9.195209] systemd[1]: Starting System Slice.
[ 9.195307] systemd[1]: Created slice System Slice.
[ 9.195318] systemd[1]: Started File System Check on Root Device.
[ 9.195324] systemd[1]: Starting system-systemd\x2dfsck.slice.
[ 9.195428] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[ 9.195435] systemd[1]: Mounting Temporary Directory...
[ 9.253783] systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
[ 9.254061] systemd[1]: Starting system-netctl.slice.
[ 9.254213] systemd[1]: Created slice system-netctl.slice.
[ 9.254229] systemd[1]: Starting system-getty.slice.
[ 9.254368] systemd[1]: Created slice system-getty.slice.
[ 9.254386] systemd[1]: Mounting POSIX Message Queue File System...
[ 9.254663] systemd[1]: Mounting Debug File System...
[ 9.299175] systemd[1]: Started Set Up Additional Binary Formats.
[ 9.299194] systemd[1]: Starting Setup Virtual Console...
[ 9.299517] systemd[1]: Starting udev Coldplug all Devices...
[ 9.307307] systemd[1]: Starting Load Kernel Modules...
[ 9.307632] systemd[1]: Mounting Huge Pages File System...
[ 9.336230] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[ 9.336856] systemd[1]: Starting Apply Kernel Variables...
[ 9.337167] systemd[1]: Starting Journal Service...
[ 9.337526] systemd[1]: Started Journal Service.
[ 10.243954] systemd-udevd[194]: starting version 212
[ 10.276052] EXT4-fs (sde3): re-mounted. Opts: (null)
[ 10.382126] netpoll: netconsole: local port 6666
[ 10.382129] netpoll: netconsole: local IPv4 address 192.168.0.233
[ 10.382130] netpoll: netconsole: interface 'eth1'
[ 10.382131] netpoll: netconsole: remote port 6666
[ 10.382132] netpoll: netconsole: remote IPv4 address 192.168.0.3
[ 10.382133] netpoll: netconsole: remote ethernet address 38:60:77:ce:27:a1
[ 10.382135] netpoll: netconsole: eth1 doesn't exist, aborting
[ 10.382163] netconsole: cleaning up
[ 10.755288] ACPI: processor limited to max C-state 1
[ 10.783616] acpi-cpufreq: overriding BIOS provided _PSD data
[ 10.797575] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1
[ 10.797588] ACPI: Power Button [PWRB]
[ 10.797756] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
[ 10.797763] ACPI: Power Button [PWRF]
[ 10.867321] ACPI Warning: SystemIO range 0x0000000000000b00-0x0000000000000b07 conflicts with OpRegion 0x0000000000000b00-0x0000000000000b0f (\SOR1) (20140424/utaddress-258)
[ 10.867329] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[ 10.870499] wmi: Mapper loaded
[ 10.879912] sp5100_tco: SP5100/SB800 TCO WatchDog Timer Driver v0.05
[ 10.879984] sp5100_tco: PCI Revision ID: 0x41
[ 10.880017] sp5100_tco: Using 0xfed80b00 for watchdog MMIO address
[ 10.880030] sp5100_tco: Last reboot was not triggered by watchdog.
[ 10.880088] sp5100_tco: initialized (0xffffc90011f44b00). heartbeat=60 sec (nowayout=0)
[ 10.915162] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 10.948548] MCE: In-kernel MCE decoding enabled.
[ 11.057888] EDAC MC: Ver: 3.0.0
[ 11.083638] AMD64 EDAC driver v3.4.0
[ 11.083689] EDAC amd64: DRAM ECC disabled.
[ 11.083707] EDAC amd64: ECC disabled in the BIOS or no ECC capability, module will not load.
Either enable ECC checking or force module loading by setting 'ecc_enable_override'.
(Note that use of the override may cause unknown side effects.)
[ 11.156011] BTRFS info (device sdb): force zlib compression
[ 11.156021] BTRFS info (device sdb): disk space caching is enabled
[ 11.156025] BTRFS: has skinny extents
[ 11.172868] microcode: CPU0: patch_level=0x010000c8
[ 11.224859] [drm] Initialized drm 1.1.0 20060810
[ 11.228133] input: PC Speaker as /devices/platform/pcspkr/input/input3
[ 11.326107] BTRFS: bdev /dev/sda errs: wr 0, rd 0, flush 0, corrupt 0, gen 2
[ 11.385613] [drm] radeon kernel modesetting enabled.
[ 11.385675] checking generic (d0000000 300000) vs hw (d0000000 10000000)
[ 11.385676] fb: switching to radeondrmfb from simple
[ 11.385693] Console: switching to colour dummy device 80x25
[ 11.386003] [drm] initializing kernel modesetting (RS880 0x1002:0x9714 0x1458:0xD000).
[ 11.386018] [drm] register mmio base: 0xFD5E0000
[ 11.386019] [drm] register mmio size: 65536
[ 11.386267] ATOM BIOS: B43106_DVI
[ 11.386281] radeon 0000:01:05.0: VRAM: 624M 0x00000000C0000000 - 0x00000000E6FFFFFF (624M used)
[ 11.386283] radeon 0000:01:05.0: GTT: 512M 0x00000000A0000000 - 0x00000000BFFFFFFF
[ 11.386286] [drm] Detected VRAM RAM=624M, BAR=256M
[ 11.386287] [drm] RAM width 32bits DDR
[ 11.386486] [TTM] Zone kernel: Available graphics memory: 3830970 kiB
[ 11.386487] [TTM] Zone dma32: Available graphics memory: 2097152 kiB
[ 11.386488] [TTM] Initializing pool allocator
[ 11.386492] [TTM] Initializing DMA pool allocator
[ 11.386507] [drm] radeon: 624M of VRAM memory ready
[ 11.386508] [drm] radeon: 512M of GTT memory ready.
[ 11.386521] [drm] Loading RS780 Microcode
[ 11.393130] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded
[ 11.393150] r8169 0000:03:00.0: can't disable ASPM; OS doesn't have ASPM control
[ 11.393430] r8169 0000:03:00.0: irq 49 for MSI/MSI-X
[ 11.393861] r8169 0000:03:00.0 eth0: RTL8168b/8111b at 0xffffc900123f0000, 00:27:19:b0:a1:f6, XID 18000000 IRQ 49
[ 11.393869] r8169 0000:03:00.0 eth0: jumbo features [frames: 4080 bytes, tx checksumming: ko]
[ 11.393920] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded
[ 11.393933] r8169 0000:04:00.0: can't disable ASPM; OS doesn't have ASPM control
[ 11.394205] r8169 0000:04:00.0: irq 50 for MSI/MSI-X
[ 11.394626] r8169 0000:04:00.0 eth1: RTL8168d/8111d at 0xffffc900123f2000, 1c:6f:65:3f:f6:94, XID 083000c0 IRQ 50
[ 11.394633] r8169 0000:04:00.0 eth1: jumbo features [frames: 9200 bytes, tx checksumming: ko]
[ 11.483439] [drm] radeon: power management initialized
[ 11.483454] [drm] GART: num cpu pages 131072, num gpu pages 131072
[ 11.494591] [drm] PCIE GART of 512M enabled (table at 0x00000000C0040000).
[ 11.494617] radeon 0000:01:05.0: WB enabled
[ 11.494620] radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000a0000c00 and cpu addr 0xffff880203212c00
[ 11.494622] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 11.494623] [drm] Driver supports precise vblank timestamp query.
[ 11.494632] [drm] radeon: irq initialized.
[ 11.520537] microcode: CPU1: patch_level=0x010000c8
[ 11.520565] microcode: CPU2: patch_level=0x010000c8
[ 11.520597] microcode: CPU3: patch_level=0x010000c8
[ 11.520757] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[ 11.525934] [drm] ring test on 0 succeeded in 1 usecs
[ 11.526010] [drm] ib test on ring 0 succeeded in 0 usecs
[ 11.526176] [drm] Radeon Display Connectors
[ 11.526177] [drm] Connector 0:
[ 11.526178] [drm] VGA-1
[ 11.526180] [drm] DDC: 0x7e40 0x7e40 0x7e44 0x7e44 0x7e48 0x7e48 0x7e4c 0x7e4c
[ 11.526180] [drm] Encoders:
[ 11.526181] [drm] CRT1: INTERNAL_KLDSCP_DAC1
[ 11.526182] [drm] Connector 1:
[ 11.526183] [drm] DVI-D-1
[ 11.526184] [drm] HPD1
[ 11.526185] [drm] DDC: 0x7e50 0x7e50 0x7e54 0x7e54 0x7e58 0x7e58 0x7e5c 0x7e5c
[ 11.526186] [drm] Encoders:
[ 11.526187] [drm] DFP1: INTERNAL_KLDSCP_LVTMA
[ 11.558289] [drm] fb mappable at 0xD0141000
[ 11.558290] [drm] vram apper at 0xD0000000
[ 11.558291] [drm] size 3145728
[ 11.558291] [drm] fb depth is 24
[ 11.558292] [drm] pitch is 4096
[ 11.558387] fbcon: radeondrmfb (fb0) is primary device
[ 11.571133] Console: switching to colour frame buffer device 128x48
[ 11.575698] radeon 0000:01:05.0: fb0: radeondrmfb frame buffer device
[ 11.575700] radeon 0000:01:05.0: registered panic notifier
[ 11.575705] [drm] Initialized radeon 2.38.0 20080528 for 0000:01:05.0 on minor 0
[ 11.739630] input: HDA ATI HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.0/0000:01:05.1/sound/card0/input4
[ 11.756890] kvm: Nested Virtualization enabled
[ 11.756894] kvm: Nested Paging enabled
[ 11.943807] Adding 7815616k swap on /dev/sde2. Priority:-1 extents:1 across:7815616k FS
[ 12.727915] EXT4-fs (sde1): mounting ext2 file system using the ext4 subsystem
[ 12.731377] EXT4-fs (sde1): mounted filesystem without journal. Opts: (null)
[ 12.824550] systemd-journald[178]: Received request to flush runtime journal from PID 1
[ 13.860627] floppy0: no floppy controllers found
[ 15.190198] r8169 0000:04:00.0 eth1: link down
[ 15.190224] IPv6: ADDRCONF(NETDEV_UP): eth1: link is not ready
[ 15.190242] r8169 0000:04:00.0 eth1: link down
[ 18.276126] r8169 0000:04:00.0 eth1: link up
[ 18.276145] IPv6: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
[ 404.288945] BTRFS info (device sdb): force zlib compression
[ 404.288957] BTRFS info (device sdb): disk space caching is enabled
[ 404.288962] BTRFS: has skinny extents
[ 404.429777] BTRFS: bdev /dev/sda errs: wr 0, rd 0, flush 0, corrupt 0, gen 2
[ 777.696027] SysRq : Show Blocked State
[ 777.696115] task PC stack pid father
[ 777.696136] rsync D 0000000000000003 0 696 682 0x00000000
[ 777.696146] ffff8801f43d3d08 0000000000000086 ffff880202b965e0 0000000000014500
[ 777.696154] ffff8801f43d3fd8 0000000000014500 ffff880202b965e0 ffff8801f43d3c98
[ 777.696161] 0000000000000292 0000000000000292 ffff8801f43d3c50 ffff8801f43d3c50
[ 777.696167] Call Trace:
[ 777.696183] [<ffffffff814f7112>] ? do_page_fault+0x22/0x30
[ 777.696194] [<ffffffff8101cd89>] ? read_tsc+0x9/0x20
[ 777.696203] [<ffffffff811379d0>] ? sleep_on_page+0x20/0x20
[ 777.696210] [<ffffffff814efe49>] schedule+0x29/0x70
[ 777.696216] [<ffffffff814f0134>] io_schedule+0x94/0xf0
[ 777.696224] [<ffffffff811379de>] sleep_on_page_killable+0xe/0x50
[ 777.696230] [<ffffffff814f0668>] __wait_on_bit_lock+0x48/0xb0
[ 777.696237] [<ffffffff8128c673>] ? radix_tree_lookup_slot+0x13/0x30
[ 777.696245] [<ffffffff81137b7a>] __lock_page_killable+0x6a/0x70
[ 777.696252] [<ffffffff810acec0>] ? autoremove_wake_function+0x40/0x40
[ 777.696259] [<ffffffff811398c8>] generic_file_aio_read+0x458/0x6a0
[ 777.696267] [<ffffffff811ab63a>] do_sync_read+0x5a/0x90
[ 777.696275] [<ffffffff811abc47>] vfs_read+0x97/0x160
[ 777.696282] [<ffffffff811ac886>] SyS_read+0x46/0xc0
[ 777.696290] [<ffffffff814fb8a9>] system_call_fastpath+0x16/0x1b
[ 777.696298] Sched Debug Version: v0.11, 3.15.0-rc8-g762380a #1
[ 777.696303] ktime : 776619.874590
[ 777.696308] sched_clk : 777696.296523
[ 777.696311] cpu_clk : 777696.296625
[ 777.696315] jiffies : 4295110281
[ 777.696319] sched_clock_stable() : 1
[ 777.696324] sysctl_sched
[ 777.696328] .sysctl_sched_latency : 18.000000
[ 777.696332] .sysctl_sched_min_granularity : 2.250000
[ 777.696336] .sysctl_sched_wakeup_granularity : 3.000000
[ 777.696339] .sysctl_sched_child_runs_first : 0
[ 777.696342] .sysctl_sched_features : 77435
[ 777.696346] .sysctl_sched_tunable_scaling : 1 (logaritmic)
[ 777.696354] cpu#0, 3214.094 MHz
[ 777.696357] .nr_running : 0
[ 777.696360] .load : 0
[ 777.696364] .nr_switches : 86629
[ 777.696367] .nr_load_updates : 25748
[ 777.696370] .nr_uninterruptible : 13
[ 777.696374] .next_balance : 4295.110271
[ 777.696377] .curr->pid : 0
[ 777.696381] .clock : 777695.301204
[ 777.696384] .cpu_load[0] : 0
[ 777.696387] .cpu_load[1] : 0
[ 777.696390] .cpu_load[2] : 0
[ 777.696393] .cpu_load[3] : 0
[ 777.696396] .cpu_load[4] : 0
[ 777.696399] .yld_count : 3
[ 777.696402] .sched_count : 87090
[ 777.696405] .sched_goidle : 41836
[ 777.696408] .avg_idle : 883123
[ 777.696412] .max_idle_balance_cost : 500000
[ 777.696415] .ttwu_count : 30271
[ 777.696418] .ttwu_local : 12342
[ 777.696423]
cfs_rq[0]:/autogroup-24
[ 777.696429] .exec_clock : 12.347941
[ 777.696434] .MIN_vruntime : 0.000001
[ 777.696437] .min_vruntime : 11.299365
[ 777.696441] .max_vruntime : 0.000001
[ 777.696444] .spread : 0.000000
[ 777.696449] .spread0 : -5165.304070
[ 777.696452] .nr_spread_over : 0
[ 777.696456] .nr_running : 0
[ 777.696459] .load : 0
[ 777.696462] .runnable_load_avg : 0
[ 777.696465] .blocked_load_avg : 6
[ 777.696469] .tg_load_contrib : 6
[ 777.696472] .tg_runnable_contrib : 2
[ 777.696475] .tg_load_avg : 6
[ 777.696478] .tg->runnable_avg : 2
[ 777.696481] .tg->cfs_bandwidth.timer_active: 0
[ 777.696485] .throttled : 0
[ 777.696488] .throttle_count : 0
[ 777.696492] .se->exec_start : 777695.297763
[ 777.696496] .se->vruntime : 5167.841434
[ 777.696500] .se->sum_exec_runtime : 12.347941
[ 777.696503] .se->statistics.wait_start : 0.000000
[ 777.696507] .se->statistics.sleep_start : 0.000000
[ 777.696511] .se->statistics.block_start : 0.000000
[ 777.696514] .se->statistics.sleep_max : 0.000000
[ 777.696517] .se->statistics.block_max : 0.000000
[ 777.696521] .se->statistics.exec_max : 0.859431
[ 777.696525] .se->statistics.slice_max : 0.195040
[ 777.696528] .se->statistics.wait_max : 0.022000
[ 777.696532] .se->statistics.wait_sum : 0.022000
[ 777.696535] .se->statistics.wait_count : 69
[ 777.696538] .se->load.weight : 2
[ 777.696542] .se->avg.runnable_avg_sum : 291
[ 777.696545] .se->avg.runnable_avg_period : 48047
[ 777.696549] .se->avg.load_avg_contrib : 0
[ 777.696552] .se->avg.decay_count : 741669
[ 777.696557]
cfs_rq[0]:/autogroup-40
[ 777.696562] .exec_clock : 184.293324
[ 777.696565] .MIN_vruntime : 0.000001
[ 777.696569] .min_vruntime : 591.877522
[ 777.696573] .max_vruntime : 0.000001
[ 777.696576] .spread : 0.000000
[ 777.696580] .spread0 : -4584.725913
[ 777.696583] .nr_spread_over : 38
[ 777.696586] .nr_running : 0
[ 777.696589] .load : 0
[ 777.696592] .runnable_load_avg : 0
[ 777.696596] .blocked_load_avg : 126
[ 777.696599] .tg_load_contrib : 126
[ 777.696602] .tg_runnable_contrib : 11
[ 777.696605] .tg_load_avg : 644
[ 777.696609] .tg->runnable_avg : 137
[ 777.696612] .tg->cfs_bandwidth.timer_active: 0
[ 777.696615] .throttled : 0
[ 777.696618] .throttle_count : 0
[ 777.696622] .se->exec_start : 777695.058484
[ 777.696626] .se->vruntime : 5176.603435
[ 777.696629] .se->sum_exec_runtime : 184.293324
[ 777.696633] .se->statistics.wait_start : 0.000000
[ 777.696636] .se->statistics.sleep_start : 0.000000
[ 777.696640] .se->statistics.block_start : 0.000000
[ 777.696643] .se->statistics.sleep_max : 0.000000
[ 777.696646] .se->statistics.block_max : 0.000000
[ 777.696650] .se->statistics.exec_max : 3.344396
[ 777.696653] .se->statistics.slice_max : 0.395955
[ 777.696657] .se->statistics.wait_max : 0.054853
[ 777.696660] .se->statistics.wait_sum : 1.606908
[ 777.696664] .se->statistics.wait_count : 252
[ 777.696667] .se->load.weight : 2
[ 777.696670] .se->avg.runnable_avg_sum : 585
[ 777.696673] .se->avg.runnable_avg_period : 47502
[ 777.696677] .se->avg.load_avg_contrib : 22
[ 777.696680] .se->avg.decay_count : 741668
[ 777.696684]
cfs_rq[0]:/
[ 777.696689] .exec_clock : 5121.412185
[ 777.696693] .MIN_vruntime : 0.000001
[ 777.696696] .min_vruntime : 5176.603435
[ 777.696700] .max_vruntime : 0.000001
[ 777.696703] .spread : 0.000000
[ 777.696706] .spread0 : 0.000000
[ 777.696709] .nr_spread_over : 19
[ 777.696712] .nr_running : 0
[ 777.696716] .load : 0
[ 777.696719] .runnable_load_avg : 0
[ 777.696722] .blocked_load_avg : 20
[ 777.696725] .tg_load_contrib : 20
[ 777.696728] .tg_runnable_contrib : 22
[ 777.696732] .tg_load_avg : 839
[ 777.696735] .tg->runnable_avg : 280
[ 777.696738] .tg->cfs_bandwidth.timer_active: 0
[ 777.696741] .throttled : 0
[ 777.696744] .throttle_count : 0
[ 777.696748] .avg->runnable_avg_sum : 1047
[ 777.696751] .avg->runnable_avg_period : 47192
[ 777.696757]
rt_rq[0]:/
[ 777.696762] .rt_nr_running : 0
[ 777.696765] .rt_throttled : 0
[ 777.696768] .rt_time : 0.024328
[ 777.696772] .rt_runtime : 950.000000
[ 777.696775]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[ 777.696783] ksoftirqd/0 3 5167.573278 1069 120 5167.573278 37.287879 777442.725966 0 /
[ 777.696795] kworker/0:0H 5 668.411491 6 100 668.411491 3.366551 1747.874725 0 /
[ 777.696808] rcu_preempt 7 5167.569923 7398 120 5167.569923 187.586251 777305.207348 0 /
[ 777.696818] rcu_bh 9 155.263192 2 120 155.263192 0.001173 0.000000 0 /
[ 777.696829] migration/0 10 0.000000 89 0 0.000000 38.671312 0.000000 0 /
[ 777.696839] watchdog/0 11 0.000000 198 0 0.000000 4.578586 0.000000 0 /
[ 777.696851] kblockd 37 668.407208 4 100 668.407208 0.025149 1684.614320 0 /
[ 777.696861] kworker/0:1 50 1495.064148 62 120 1495.064148 1.444609 17464.079279 0 /
[ 777.696872] khubd 78 451.613137 11 120 451.613137 0.207903 367.116121 0 /
[ 777.696882] scsi_tmf_2 84 358.676999 2 100 358.676999 0.012141 0.189501 0 /
[ 777.696892] scsi_tmf_4 92 399.823600 2 100 399.823600 0.011947 0.004929 0 /
[ 777.696902] scsi_tmf_5 94 417.350890 2 100 417.350890 0.017084 0.008773 0 /
[ 777.696912] kworker/u16:9 104 5092.431478 8054 120 5092.431478 1026.897487 708657.467664 0 /
[ 777.696923] kworker/0:1H 137 5050.023301 56 100 5050.023301 2.050176 705784.251015 0 /
[ 777.696933] ext4-rsv-conver 155 773.634852 2 100 773.634852 0.008357 0.003145 0 /
[ 777.696943] kworker/0:2 183 5167.574242 10304 120 5167.574242 358.944465 767796.410459 0 /
[ 777.696953] systemd-udevd 194 197.720176 408 120 197.720176 398.638919 396841.953950 0 /autogroup-12
[ 777.696964] hd-audio0 252 1241.521523 2 100 1241.521523 0.048002 0.014246 0 /
[ 777.696975] ext4-rsv-conver 264 1336.049975 2 100 1336.049975 0.027726 0.016338 0 /
[ 777.696985] systemd-logind 275 1.537484 147 120 1.537484 18.008368 757941.451177 0 /autogroup-22
[ 777.696996] syslog-ng 282 11.299365 406 120 11.299365 91.492423 762785.776887 0 /autogroup-24
[ 777.697006] named 364 19.757217 56 120 19.757217 22.354739 1033.525131 0 /autogroup-27
[ 777.697016] named 369 17.608671 198 120 17.608671 6.502917 577.922179 0 /autogroup-27
[ 777.697027] named 371 18.635940 187 120 18.635940 6.794641 577.854588 0 /autogroup-27
[ 777.697039] btrfs-worker 508 3327.844182 2 100 3327.844182 0.023831 0.010155 0 /
[ 777.697049] btrfs-delalloc 511 3336.866736 2 100 3336.866736 0.025767 0.015455 0 /
[ 777.697059] btrfs-submit 514 3341.385104 2 100 3341.385104 0.021756 0.009838 0 /
[ 777.697068] btrfs-fixup 515 3347.405115 2 100 3347.405115 0.022670 0.008702 0 /
[ 777.697078] btrfs-endio 516 3353.423671 2 100 3353.423671 0.021030 0.008608 0 /
[ 777.697088] btrfs-endio-met 517 3359.441273 2 100 3359.441273 0.020180 0.008990 0 /
[ 777.697098] btrfs-endio-met 518 3365.458847 2 100 3365.458847 0.019899 0.008551 0 /
[ 777.697107] btrfs-endio-rai 519 3371.476299 2 100 3371.476299 0.019716 0.008737 0 /
[ 777.697117] btrfs-rmw 520 3377.493168 2 100 3377.493168 0.018948 0.008260 0 /
[ 777.697127] btrfs-endio-wri 521 3383.510916 2 100 3383.510916 0.020197 0.008445 0 /
[ 777.697136] btrfs-freespace 522 3389.528843 2 100 3389.528843 0.020479 0.008735 0 /
[ 777.697146] btrfs-delayed-m 523 3395.547136 2 100 3395.547136 0.021189 0.008845 0 /
[ 777.697155] btrfs-readahead 524 3401.564524 2 100 3401.564524 0.019797 0.008330 0 /
[ 777.697165] btrfs-qgroup-re 525 3407.583121 2 100 3407.583121 0.020792 0.009610 0 /
[ 777.697175] zsh 580 591.782989 361 120 591.782989 214.848921 164301.650197 0 /autogroup-40
[ 777.697186] rsync 698 1472.564112 4 120 1472.564112 0.772433 120282.680823 0 /autogroup-38
[ 777.697197] kworker/u16:2 700 5094.558099 263 120 5094.558099 35.204590 14613.401040 0 /
[ 777.697207] kworker/u16:10 705 4874.960964 4 120 4874.960964 0.319866 0.003647 0 /
[ 777.697217] kworker/u16:11 706 5045.915934 221 120 5045.915934 29.303180 9666.742219 0 /
[ 777.697226] kworker/u17:1 707 5099.100204 8 100 5099.100204 14.899745 0.032220 0 /
[ 777.697237] sudo 775 591.411219 21 120 591.411219 16.712239 112.207526 0 /autogroup-40
[ 777.697251] cpu#1, 3214.094 MHz
[ 777.697254] .nr_running : 0
[ 777.697258] .load : 0
[ 777.697261] .nr_switches : 81071
[ 777.697264] .nr_load_updates : 20791
[ 777.697268] .nr_uninterruptible : -34
[ 777.697271] .next_balance : 4295.110273
[ 777.697275] .curr->pid : 0
[ 777.697278] .clock : 777663.088393
[ 777.697281] .cpu_load[0] : 0
[ 777.697284] .cpu_load[1] : 0
[ 777.697287] .cpu_load[2] : 0
[ 777.697290] .cpu_load[3] : 0
[ 777.697293] .cpu_load[4] : 0
[ 777.697296] .yld_count : 0
[ 777.697300] .sched_count : 81469
[ 777.697303] .sched_goidle : 38329
[ 777.697306] .avg_idle : 1000000
[ 777.697310] .max_idle_balance_cost : 500000
[ 777.697313] .ttwu_count : 19819
[ 777.697316] .ttwu_local : 8047
[ 777.697320]
cfs_rq[1]:/autogroup-2
[ 777.697325] .exec_clock : 686.496068
[ 777.697329] .MIN_vruntime : 0.000001
[ 777.697333] .min_vruntime : 711.242038
[ 777.697336] .max_vruntime : 0.000001
[ 777.697340] .spread : 0.000000
[ 777.697343] .spread0 : -4465.361397
[ 777.697346] .nr_spread_over : 2
[ 777.697350] .nr_running : 0
[ 777.697353] .load : 0
[ 777.697356] .runnable_load_avg : 0
[ 777.697359] .blocked_load_avg : 0
[ 777.697362] .tg_load_contrib : 0
[ 777.697365] .tg_runnable_contrib : 3
[ 777.697368] .tg_load_avg : 0
[ 777.697371] .tg->runnable_avg : 3
[ 777.697374] .tg->cfs_bandwidth.timer_active: 0
[ 777.697377] .throttled : 0
[ 777.697381] .throttle_count : 0
[ 777.697384] .se->exec_start : 777642.715827
[ 777.697388] .se->vruntime : 3664.644162
[ 777.697392] .se->sum_exec_runtime : 686.524521
[ 777.697395] .se->statistics.wait_start : 0.000000
[ 777.697399] .se->statistics.sleep_start : 0.000000
[ 777.697402] .se->statistics.block_start : 0.000000
[ 777.697405] .se->statistics.sleep_max : 0.000000
[ 777.697409] .se->statistics.block_max : 0.000000
[ 777.697412] .se->statistics.exec_max : 3.340140
[ 777.697416] .se->statistics.slice_max : 0.182764
[ 777.697419] .se->statistics.wait_max : 4.043890
[ 777.697423] .se->statistics.wait_sum : 10.549633
[ 777.697426] .se->statistics.wait_count : 8551
[ 777.697429] .se->load.weight : 2
[ 777.697433] .se->avg.runnable_avg_sum : 147
[ 777.697436] .se->avg.runnable_avg_period : 47660
[ 777.697439] .se->avg.load_avg_contrib : 0
[ 777.697442] .se->avg.decay_count : 741618
[ 777.697447]
cfs_rq[1]:/autogroup-40
[ 777.697452] .exec_clock : 238.165689
[ 777.697455] .MIN_vruntime : 0.000001
[ 777.697459] .min_vruntime : 735.958474
[ 777.697462] .max_vruntime : 0.000001
[ 777.697465] .spread : 0.000000
[ 777.697469] .spread0 : -4440.644961
[ 777.697472] .nr_spread_over : 38
[ 777.697475] .nr_running : 0
[ 777.697479] .load : 0
[ 777.697482] .runnable_load_avg : 0
[ 777.697485] .blocked_load_avg : 0
[ 777.697488] .tg_load_contrib : 0
[ 777.697491] .tg_runnable_contrib : 11
[ 777.697494] .tg_load_avg : 644
[ 777.697498] .tg->runnable_avg : 137
[ 777.697501] .tg->cfs_bandwidth.timer_active: 0
[ 777.697504] .throttled : 0
[ 777.697507] .throttle_count : 0
[ 777.697511] .se->exec_start : 777566.233220
[ 777.697514] .se->vruntime : 3673.401777
[ 777.697518] .se->sum_exec_runtime : 238.165689
[ 777.697522] .se->statistics.wait_start : 0.000000
[ 777.697525] .se->statistics.sleep_start : 0.000000
[ 777.697528] .se->statistics.block_start : 0.000000
[ 777.697532] .se->statistics.sleep_max : 0.000000
[ 777.697535] .se->statistics.block_max : 0.000000
[ 777.697539] .se->statistics.exec_max : 3.342586
[ 777.697542] .se->statistics.slice_max : 0.000000
[ 777.697545] .se->statistics.wait_max : 0.056240
[ 777.697549] .se->statistics.wait_sum : 2.913644
[ 777.697552] .se->statistics.wait_count : 1186
[ 777.697555] .se->load.weight : 2
[ 777.697559] .se->avg.runnable_avg_sum : 508
[ 777.697562] .se->avg.runnable_avg_period : 46588
[ 777.697565] .se->avg.load_avg_contrib : 0
[ 777.697568] .se->avg.decay_count : 741545
[ 777.697572]
cfs_rq[1]:/
[ 777.697576] .exec_clock : 3977.085399
[ 777.697580] .MIN_vruntime : 0.000001
[ 777.697584] .min_vruntime : 3673.409353
[ 777.697587] .max_vruntime : 0.000001
[ 777.697590] .spread : 0.000000
[ 777.697594] .spread0 : -1503.194082
[ 777.697597] .nr_spread_over : 32
[ 777.697600] .nr_running : 0
[ 777.697603] .load : 0
[ 777.697606] .runnable_load_avg : 0
[ 777.697609] .blocked_load_avg : 500
[ 777.697613] .tg_load_contrib : 500
[ 777.697616] .tg_runnable_contrib : 104
[ 777.697619] .tg_load_avg : 839
[ 777.697622] .tg->runnable_avg : 280
[ 777.697625] .tg->cfs_bandwidth.timer_active: 0
[ 777.697628] .throttled : 0
[ 777.697631] .throttle_count : 0
[ 777.697635] .avg->runnable_avg_sum : 4859
[ 777.697638] .avg->runnable_avg_period : 47181
[ 777.697642]
rt_rq[1]:/
[ 777.697646] .rt_nr_running : 0
[ 777.697649] .rt_throttled : 0
[ 777.697653] .rt_time : 0.022578
[ 777.697656] .rt_runtime : 950.000000
[ 777.697660]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[ 777.697666] systemd 1 711.242038 999 120 711.242038 734.955537 776867.403013 0 /autogroup-2
[ 777.697678] rcu_sched 8 1574.198414 29 120 1574.198414 0.506276 118147.524258 0 /
[ 777.697689] watchdog/1 12 -2.977429 198 0 -2.977429 4.312473 0.000000 0 /
[ 777.697699] migration/1 13 0.000000 103 0 0.000000 5.485298 0.000000 0 /
[ 777.697708] ksoftirqd/1 14 3664.499737 854 120 3664.499737 24.619401 777427.296152 0 /
[ 777.697718] kworker/1:0H 16 314.272745 7 100 314.272745 0.046487 4323.556642 0 /
[ 777.697729] kdevtmpfs 28 649.876853 146 120 649.876853 2.261950 14573.638099 0 /
[ 777.697739] khungtaskd 30 3459.734760 8 120 3459.734760 0.273297 720876.757839 0 /
[ 777.697749] kthrotld 44 8.091400 2 100 8.091400 0.015555 0.007082 0 /
[ 777.697759] ipv6_addrconf 45 17.106643 2 100 17.106643 0.016500 0.007634 0 /
[ 777.697768] deferwq 46 26.122380 2 100 26.122380 0.017050 0.007365 0 /
[ 777.697778] kworker/1:1 72 771.649535 68 120 771.649535 0.613982 17469.084479 0 /
[ 777.697788] scsi_eh_2 83 243.017875 5 120 243.017875 0.197952 152.856454 0 /
[ 777.697798] scsi_tmf_3 86 195.038503 2 100 195.038503 0.006546 0.004825 0 /
[ 777.697808] kworker/u16:3 90 3468.686751 6818 120 3468.686751 915.486636 710982.177243 0 /
[ 777.697818] scsi_tmf_9 108 248.253960 2 100 248.253960 0.013197 0.009032 0 /
[ 777.697828] bioset 143 312.422065 2 100 312.422065 0.011770 0.000000 0 /
[ 777.697838] kworker/1:1H 150 3483.785837 34 100 3483.785837 1.176841 760633.032114 0 /
[ 777.697848] kworker/1:2 190 3664.591970 6417 120 3664.591970 169.182674 767725.547429 0 /
[ 777.697858] kvm-irqfd-clean 256 586.122582 2 100 586.122582 0.011624 0.018528 0 /
[ 777.697868] dbus-daemon 276 6.012880 162 120 6.012880 42.234947 598885.431476 0 /autogroup-23
[ 777.697878] agetty 286 1.834804 9 120 1.834804 16.210705 5164.820008 0 /autogroup-32
[ 777.697889] named 370 28.989981 167 120 28.989981 5.841385 579.078745 0 /autogroup-27
[ 777.697899] named 372 29.778229 254 120 29.778229 35.895419 548.160154 0 /autogroup-27
[ 777.697910] btrfs-flush_del 512 1789.624926 2 100 1789.624926 0.029969 0.010746 0 /
[ 777.697922] kworker/u17:2 708 3464.730080 6 100 3464.730080 14.868514 0.027461 0 /
[ 777.697936] cpu#2, 3214.094 MHz
[ 777.697939] .nr_running : 1
[ 777.697943] .load : 1015
[ 777.697946] .nr_switches : 102846
[ 777.697949] .nr_load_updates : 32356
[ 777.697952] .nr_uninterruptible : 22
[ 777.697956] .next_balance : 4295.110281
[ 777.697959] .curr->pid : 776
[ 777.697963] .clock : 777696.017615
[ 777.697966] .cpu_load[0] : 0
[ 777.697969] .cpu_load[1] : 0
[ 777.697972] .cpu_load[2] : 2
[ 777.697975] .cpu_load[3] : 8
[ 777.697978] .cpu_load[4] : 12
[ 777.697981] .yld_count : 0
[ 777.697984] .sched_count : 103264
[ 777.697988] .sched_goidle : 45461
[ 777.697991] .avg_idle : 890064
[ 777.697994] .max_idle_balance_cost : 500000
[ 777.697997] .ttwu_count : 103090
[ 777.698001] .ttwu_local : 52287
[ 777.698005]
cfs_rq[2]:/autogroup-40
[ 777.698010] .exec_clock : 201.382966
[ 777.698013] .MIN_vruntime : 0.000001
[ 777.698017] .min_vruntime : 405.734894
[ 777.698020] .max_vruntime : 0.000001
[ 777.698024] .spread : 0.000000
[ 777.698027] .spread0 : -4770.868541
[ 777.698031] .nr_spread_over : 25
[ 777.698034] .nr_running : 1
[ 777.698037] .load : 1024
[ 777.698040] .runnable_load_avg : 360
[ 777.698043] .blocked_load_avg : 132
[ 777.698047] .tg_load_contrib : 518
[ 777.698050] .tg_runnable_contrib : 112
[ 777.698053] .tg_load_avg : 644
[ 777.698056] .tg->runnable_avg : 137
[ 777.698059] .tg->cfs_bandwidth.timer_active: 0
[ 777.698062] .throttled : 0
[ 777.698065] .throttle_count : 0
[ 777.698069] .se->exec_start : 777696.017615
[ 777.698073] .se->vruntime : 3402.556864
[ 777.698076] .se->sum_exec_runtime : 201.382966
[ 777.698080] .se->statistics.wait_start : 0.000000
[ 777.698083] .se->statistics.sleep_start : 0.000000
[ 777.698087] .se->statistics.block_start : 0.000000
[ 777.698090] .se->statistics.sleep_max : 0.000000
[ 777.698094] .se->statistics.block_max : 0.000000
[ 777.698097] .se->statistics.exec_max : 3.340754
[ 777.698101] .se->statistics.slice_max : 1.454261
[ 777.698104] .se->statistics.wait_max : 0.064238
[ 777.698108] .se->statistics.wait_sum : 5.321528
[ 777.698111] .se->statistics.wait_count : 289
[ 777.698114] .se->load.weight : 1015
[ 777.698117] .se->avg.runnable_avg_sum : 5165
[ 777.698121] .se->avg.runnable_avg_period : 46827
[ 777.698124] .se->avg.load_avg_contrib : 109
[ 777.698127] .se->avg.decay_count : 0
[ 777.698131]
cfs_rq[2]:/autogroup-39
[ 777.698136] .exec_clock : 57.280841
[ 777.698140] .MIN_vruntime : 0.000001
[ 777.698143] .min_vruntime : 56.019591
[ 777.698146] .max_vruntime : 0.000001
[ 777.698150] .spread : 0.000000
[ 777.698153] .spread0 : -5120.583844
[ 777.698157] .nr_spread_over : 0
[ 777.698160] .nr_running : 0
[ 777.698163] .load : 0
[ 777.698166] .runnable_load_avg : 0
[ 777.698169] .blocked_load_avg : 0
[ 777.698172] .tg_load_contrib : 0
[ 777.698175] .tg_runnable_contrib : 0
[ 777.698178] .tg_load_avg : 0
[ 777.698181] .tg->runnable_avg : 0
[ 777.698185] .tg->cfs_bandwidth.timer_active: 0
[ 777.698188] .throttled : 0
[ 777.698191] .throttle_count : 0
[ 777.698194] .se->exec_start : 777565.032901
[ 777.698198] .se->vruntime : 3371.820086
[ 777.698202] .se->sum_exec_runtime : 57.280841
[ 777.698205] .se->statistics.wait_start : 0.000000
[ 777.698209] .se->statistics.sleep_start : 0.000000
[ 777.698212] .se->statistics.block_start : 0.000000
[ 777.698215] .se->statistics.sleep_max : 0.000000
[ 777.698219] .se->statistics.block_max : 0.000000
[ 777.698222] .se->statistics.exec_max : 3.337818
[ 777.698226] .se->statistics.slice_max : 0.092416
[ 777.698229] .se->statistics.wait_max : 0.149870
[ 777.698233] .se->statistics.wait_sum : 0.364397
[ 777.698236] .se->statistics.wait_count : 208
[ 777.698239] .se->load.weight : 2
[ 777.698242] .se->avg.runnable_avg_sum : 21
[ 777.698246] .se->avg.runnable_avg_period : 47340
[ 777.698249] .se->avg.load_avg_contrib : 0
[ 777.698252] .se->avg.decay_count : 741544
[ 777.698255]
cfs_rq[2]:/
[ 777.698260] .exec_clock : 3938.283323
[ 777.698264] .MIN_vruntime : 0.000001
[ 777.698267] .min_vruntime : 3402.556864
[ 777.698271] .max_vruntime : 0.000001
[ 777.698274] .spread : 0.000000
[ 777.698278] .spread0 : -1774.046571
[ 777.698281] .nr_spread_over : 32
[ 777.698284] .nr_running : 1
[ 777.698287] .load : 1015
[ 777.698290] .runnable_load_avg : 109
[ 777.698294] .blocked_load_avg : 204
[ 777.698297] .tg_load_contrib : 293
[ 777.698300] .tg_runnable_contrib : 119
[ 777.698303] .tg_load_avg : 839
[ 777.698306] .tg->runnable_avg : 280
[ 777.698310] .tg->cfs_bandwidth.timer_active: 0
[ 777.698313] .throttled : 0
[ 777.698316] .throttle_count : 0
[ 777.698319] .avg->runnable_avg_sum : 5642
[ 777.698322] .avg->runnable_avg_period : 48070
[ 777.698326]
rt_rq[2]:/
[ 777.698331] .rt_nr_running : 0
[ 777.698334] .rt_throttled : 0
[ 777.698337] .rt_time : 0.027476
[ 777.698341] .rt_runtime : 950.000000
[ 777.698344]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[ 777.698352] watchdog/2 17 -5.974018 198 0 -5.974018 5.023424 0.000000 0 /
[ 777.698362] migration/2 18 0.000000 79 0 0.000000 5.186827 0.000000 0 /
[ 777.698372] ksoftirqd/2 19 3391.613283 1375 120 3391.613283 29.645967 777417.025450 0 /
[ 777.698382] kworker/2:0H 21 276.416428 7 100 276.416428 0.041062 1449.512580 0 /
[ 777.698392] crypto 34 7.959417 2 100 7.959417 0.009277 0.002051 0 /
[ 777.698401] kintegrityd 35 16.965124 2 100 16.965124 0.006466 0.002173 0 /
[ 777.698411] bioset 36 25.971039 2 100 25.971039 0.006553 0.002116 0 /
[ 777.698421] kswapd0 39 240.490276 3 120 240.490276 0.046296 97.568037 0 /
[ 777.698431] fsnotify_mark 40 3228.349012 16 120 3228.349012 0.344184 762009.335133 0 /
[ 777.698441] ata_sff 79 141.983836 2 100 141.983836 0.014661 0.011459 0 /
[ 777.698451] scsi_eh_0 80 265.072299 24 120 265.072299 0.301585 495.816875 0 /
[ 777.698460] scsi_tmf_0 81 162.947376 2 100 162.947376 0.015436 0.007516 0 /
[ 777.698470] scsi_eh_1 82 265.090598 26 120 265.090598 0.376758 494.353886 0 /
[ 777.698480] scsi_eh_3 85 273.828008 5 120 273.828008 11.687633 305.757650 0 /
[ 777.698490] kworker/2:1 87 2426.223167 2651 120 2426.223167 78.424769 417912.182343 0 /
[ 777.698499] scsi_tmf_1 88 177.466235 2 100 177.466235 0.014676 0.009012 0 /
[ 777.698509] scsi_eh_4 91 265.056062 24 120 265.056062 0.330446 491.685562 0 /
[ 777.698519] scsi_eh_5 93 265.118782 24 120 265.118782 0.350483 491.361906 0 /
[ 777.698528] scsi_eh_6 95 265.060681 24 120 265.060681 0.359100 491.890923 0 /
[ 777.698538] scsi_eh_7 97 265.144191 26 120 265.144191 0.515840 488.171054 0 /
[ 777.698547] scsi_tmf_7 98 212.661097 2 100 212.661097 0.009961 0.001414 0 /
[ 777.698557] scsi_eh_8 105 265.192611 24 120 265.192611 0.460831 487.515304 0 /
[ 777.698567] scsi_tmf_8 106 239.712792 2 100 239.712792 0.018596 0.008056 0 /
[ 777.698577] kworker/2:1H 118 3392.458209 30449 100 3392.458209 688.148741 775320.935616 0 /
[ 777.698587] jbd2/sde3-8 154 3392.531370 200 120 3392.531370 13.226606 770543.560855 0 /
[ 777.698597] ttm_swap 249 1357.535248 2 100 1357.535248 0.005573 0.000000 0 /
[ 777.698608] sshd 365 0.386980 45 120 0.386980 19.950264 593728.143491 0 /autogroup-28
[ 777.698618] ntpd 368 69.923910 841 120 69.923910 71.809907 757861.750129 0 /autogroup-31
[ 777.698629] nmbd 375 36.706061 267 120 36.706061 39.067829 749927.063045 0 /autogroup-33
[ 777.698639] kworker/2:3 382 3393.582345 4458 120 3393.582345 141.761806 659156.002673 0 /
[ 777.698648] sshd 396 56.677768 329 120 56.677768 66.621232 391152.775548 0 /autogroup-36
[ 777.698659] kworker/u17:0 509 3208.192644 6 100 3208.192644 14.274699 304163.672929 0 /
[ 777.698669] btrfs-cache 513 2380.984458 2 100 2380.984458 0.014965 0.025295 0 /
[ 777.698679] kworker/u16:1 527 3200.443916 6423 120 3200.443916 929.304205 293890.413511 0 /
[ 777.698689] btrfs-transacti 536 3370.490288 9114 120 3370.490288 991.805059 261549.205565 0 /
[ 777.698699] ssh 697 525.649474 21 120 525.649474 27.475167 309.032020 0 /autogroup-38
[ 777.698710] kworker/u16:7 703 3200.342882 448 120 3200.342882 50.043906 10596.774296 0 /
[ 777.698719] kworker/u16:8 704 3199.367565 241 120 3199.367565 32.067571 9834.667394 0 /
[ 777.698730] R tee 776 405.734894 4 120 405.734894 2.129740 47.791242 0 /autogroup-40
[ 777.698743] cpu#3, 3214.094 MHz
[ 777.698747] .nr_running : 0
[ 777.698750] .load : 0
[ 777.698753] .nr_switches : 91167
[ 777.698756] .nr_load_updates : 26276
[ 777.698760] .nr_uninterruptible : 0
[ 777.698763] .next_balance : 4295.110283
[ 777.698766] .curr->pid : 0
[ 777.698770] .clock : 777696.119680
[ 777.698773] .cpu_load[0] : 0
[ 777.698776] .cpu_load[1] : 1
[ 777.698779] .cpu_load[2] : 8
[ 777.698782] .cpu_load[3] : 9
[ 777.698785] .cpu_load[4] : 6
[ 777.698788] .yld_count : 0
[ 777.698791] .sched_count : 91551
[ 777.698795] .sched_goidle : 43662
[ 777.698798] .avg_idle : 922051
[ 777.698801] .max_idle_balance_cost : 500000
[ 777.698804] .ttwu_count : 34075
[ 777.698808] .ttwu_local : 11425
[ 777.698812]
cfs_rq[3]:/autogroup-39
[ 777.698816] .exec_clock : 19.611233
[ 777.698820] .MIN_vruntime : 0.000001
[ 777.698824] .min_vruntime : 36.444967
[ 777.698827] .max_vruntime : 0.000001
[ 777.698830] .spread : 0.000000
[ 777.698834] .spread0 : -5140.158468
[ 777.698837] .nr_spread_over : 0
[ 777.698840] .nr_running : 0
[ 777.698844] .load : 0
[ 777.698847] .runnable_load_avg : 0
[ 777.698850] .blocked_load_avg : 0
[ 777.698853] .tg_load_contrib : 0
[ 777.698856] .tg_runnable_contrib : 0
[ 777.698859] .tg_load_avg : 0
[ 777.698862] .tg->runnable_avg : 0
[ 777.698865] .tg->cfs_bandwidth.timer_active: 0
[ 777.698868] .throttled : 0
[ 777.698871] .throttle_count : 0
[ 777.698875] .se->exec_start : 777696.117061
[ 777.698879] .se->vruntime : 4726.837466
[ 777.698883] .se->sum_exec_runtime : 19.611233
[ 777.698886] .se->statistics.wait_start : 0.000000
[ 777.698890] .se->statistics.sleep_start : 0.000000
[ 777.698893] .se->statistics.block_start : 0.000000
[ 777.698896] .se->statistics.sleep_max : 0.000000
[ 777.698900] .se->statistics.block_max : 0.000000
[ 777.698903] .se->statistics.exec_max : 3.303389
[ 777.698907] .se->statistics.slice_max : 0.000000
[ 777.698910] .se->statistics.wait_max : 0.027254
[ 777.698914] .se->statistics.wait_sum : 0.088775
[ 777.698917] .se->statistics.wait_count : 26
[ 777.698920] .se->load.weight : 2
[ 777.698923] .se->avg.runnable_avg_sum : 103
[ 777.698927] .se->avg.runnable_avg_period : 48309
[ 777.698930] .se->avg.load_avg_contrib : 0
[ 777.698933] .se->avg.decay_count : 741669
[ 777.698937]
cfs_rq[3]:/autogroup-8
[ 777.698942] .exec_clock : 39.151481
[ 777.698946] .MIN_vruntime : 0.000001
[ 777.698949] .min_vruntime : 38.102905
[ 777.698953] .max_vruntime : 0.000001
[ 777.698956] .spread : 0.000000
[ 777.698960] .spread0 : -5138.500530
[ 777.698963] .nr_spread_over : 0
[ 777.698966] .nr_running : 0
[ 777.698969] .load : 0
[ 777.698972] .runnable_load_avg : 0
[ 777.698975] .blocked_load_avg : 26
[ 777.698978] .tg_load_contrib : 26
[ 777.698982] .tg_runnable_contrib : 25
[ 777.698985] .tg_load_avg : 26
[ 777.698988] .tg->runnable_avg : 25
[ 777.698991] .tg->cfs_bandwidth.timer_active: 0
[ 777.698994] .throttled : 0
[ 777.698997] .throttle_count : 0
[ 777.699001] .se->exec_start : 777695.634525
[ 777.699005] .se->vruntime : 4728.119952
[ 777.699008] .se->sum_exec_runtime : 39.151481
[ 777.699012] .se->statistics.wait_start : 0.000000
[ 777.699015] .se->statistics.sleep_start : 0.000000
[ 777.699019] .se->statistics.block_start : 0.000000
[ 777.699022] .se->statistics.sleep_max : 0.000000
[ 777.699025] .se->statistics.block_max : 0.000000
[ 777.699029] .se->statistics.exec_max : 3.336757
[ 777.699032] .se->statistics.slice_max : 1.725516
[ 777.699036] .se->statistics.wait_max : 0.151641
[ 777.699039] .se->statistics.wait_sum : 0.396828
[ 777.699043] .se->statistics.wait_count : 70
[ 777.699046] .se->load.weight : 2
[ 777.699049] .se->avg.runnable_avg_sum : 1184
[ 777.699052] .se->avg.runnable_avg_period : 47194
[ 777.699056] .se->avg.load_avg_contrib : 24
[ 777.699059] .se->avg.decay_count : 741669
[ 777.699063]
cfs_rq[3]:/autogroup-40
[ 777.699068] .exec_clock : 254.520826
[ 777.699071] .MIN_vruntime : 0.000001
[ 777.699075] .min_vruntime : 307.028708
[ 777.699078] .max_vruntime : 0.000001
[ 777.699082] .spread : 0.000000
[ 777.699085] .spread0 : -4869.574727
[ 777.699088] .nr_spread_over : 19
[ 777.699091] .nr_running : 0
[ 777.699095] .load : 0
[ 777.699098] .runnable_load_avg : 0
[ 777.699101] .blocked_load_avg : 0
[ 777.699104] .tg_load_contrib : 0
[ 777.699107] .tg_runnable_contrib : 3
[ 777.699110] .tg_load_avg : 644
[ 777.699114] .tg->runnable_avg : 137
[ 777.699117] .tg->cfs_bandwidth.timer_active: 0
[ 777.699120] .throttled : 0
[ 777.699123] .throttle_count : 0
[ 777.699127] .se->exec_start : 777646.412497
[ 777.699130] .se->vruntime : 4735.731345
[ 777.699134] .se->sum_exec_runtime : 254.520826
[ 777.699137] .se->statistics.wait_start : 0.000000
[ 777.699141] .se->statistics.sleep_start : 0.000000
[ 777.699144] .se->statistics.block_start : 0.000000
[ 777.699148] .se->statistics.sleep_max : 0.000000
[ 777.699151] .se->statistics.block_max : 0.000000
[ 777.699155] .se->statistics.exec_max : 3.340994
[ 777.699158] .se->statistics.slice_max : 0.027196
[ 777.699162] .se->statistics.wait_max : 0.073285
[ 777.699165] .se->statistics.wait_sum : 3.128054
[ 777.699168] .se->statistics.wait_count : 347
[ 777.699171] .se->load.weight : 2
[ 777.699175] .se->avg.runnable_avg_sum : 155
[ 777.699178] .se->avg.runnable_avg_period : 46658
[ 777.699181] .se->avg.load_avg_contrib : 0
[ 777.699184] .se->avg.decay_count : 741622
[ 777.699188]
cfs_rq[3]:/
[ 777.699192] .exec_clock : 5194.687677
[ 777.699196] .MIN_vruntime : 0.000001
[ 777.699200] .min_vruntime : 4735.731345
[ 777.699203] .max_vruntime : 0.000001
[ 777.699206] .spread : 0.000000
[ 777.699210] .spread0 : -440.872090
[ 777.699213] .nr_spread_over : 30
[ 777.699216] .nr_running : 0
[ 777.699219] .load : 0
[ 777.699223] .runnable_load_avg : 0
[ 777.699226] .blocked_load_avg : 26
[ 777.699229] .tg_load_contrib : 26
[ 777.699232] .tg_runnable_contrib : 35
[ 777.699235] .tg_load_avg : 839
[ 777.699239] .tg->runnable_avg : 280
[ 777.699242] .tg->cfs_bandwidth.timer_active: 0
[ 777.699245] .throttled : 0
[ 777.699248] .throttle_count : 0
[ 777.699251] .avg->runnable_avg_sum : 1623
[ 777.699255] .avg->runnable_avg_period : 46908
[ 777.699258]
rt_rq[3]:/
[ 777.699263] .rt_nr_running : 0
[ 777.699266] .rt_throttled : 0
[ 777.699269] .rt_time : 0.022903
[ 777.699273] .rt_runtime : 950.000000
[ 777.699276]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[ 777.699283] kthreadd 2 4485.556961 152 120 4485.556961 2.750505 708432.454703 0 /
[ 777.699295] watchdog/3 22 -5.976746 198 0 -5.976746 4.375204 0.000000 0 /
[ 777.699304] migration/3 23 0.000000 89 0 0.000000 5.384439 0.000000 0 /
[ 777.699314] ksoftirqd/3 24 4726.819581 1606 120 4726.819581 55.413089 777376.402811 0 /
[ 777.699324] kworker/3:0H 26 550.155136 7 100 550.155136 0.048448 1484.681011 0 /
[ 777.699333] khelper 27 7.964692 2 100 7.964692 0.014908 0.005697 0 /
[ 777.699343] netns 29 26.057102 2 100 26.057102 0.023047 0.005816 0 /
[ 777.699353] writeback 31 44.081234 2 100 44.081234 0.007418 0.002039 0 /
[ 777.699362] ksmd 32 53.091945 2 125 53.091945 0.007793 0.002249 0 /
[ 777.699372] khugepaged 33 4692.016460 81 139 4692.016460 10.632036 771460.904464 0 /
[ 777.699382] kworker/3:1 38 4726.824439 8706 120 4726.824439 263.120526 776789.468859 0 /
[ 777.699393] scsi_tmf_6 96 507.104702 2 100 507.104702 0.009548 0.009052 0 /
[ 777.699403] kworker/u16:4 99 4440.826890 9152 120 4440.826890 1179.132272 705330.036016 0 /
[ 777.699413] scsi_eh_9 107 527.668794 24 120 527.668794 0.420877 487.375164 0 /
[ 777.699423] kworker/3:1H 124 4569.283388 136 100 4569.283388 4.737518 763407.337707 0 /
[ 777.699433] systemd-journal 178 38.102905 331 120 38.102905 205.781841 768146.601320 0 /autogroup-8
[ 777.699444] kworker/3:2 193 1206.989677 6 120 1206.989677 0.019023 3087.587763 0 /
[ 777.699454] edac-poller 227 1018.154494 2 100 1018.154494 0.031027 0.016345 0 /
[ 777.699464] crond 273 0.373109 25 120 0.373109 10.714488 738203.626831 0 /autogroup-20
[ 777.699475] named 373 2.513989 147 120 2.513989 2.383276 582.054993 0 /autogroup-27
[ 777.699485] named 374 0.469168 5 120 0.469168 0.210493 583.994025 0 /autogroup-27
[ 777.699495] smbd 377 190.040987 129 120 190.040987 73.817036 730623.038708 0 /autogroup-35
[ 777.699506] systemd 398 14.585524 20 120 14.585524 26.108250 127396.306380 0 /autogroup-37
[ 777.699516] (sd-pam) 399 8.145992 2 120 8.145992 0.194576 0.000000 0 /autogroup-37
[ 777.699526] zsh 401 900.779414 582 120 900.779414 324.360011 234863.546190 0 /autogroup-38
[ 777.699537] btrfs-worker-hi 510 2622.965331 2 100 2622.965331 0.024545 0.009680 0 /
[ 777.699548] kworker/u16:0 526 4538.151624 5010 120 4538.151624 641.873901 306327.454416 0 /
[ 777.699557] btrfs-cleaner 535 4725.933321 14 120 4725.933321 0.401377 262584.364137 0 /
[ 777.699567] sshd 578 36.444967 212 120 36.444967 63.483419 166120.578886 0 /autogroup-39
[ 777.699577] btrfs_vserver.s 682 948.515214 14 120 948.515214 11.309807 31295.594534 0 /autogroup-38
[ 777.699588] rsync 696 960.192733 57 120 960.192733 23.863283 549.709619 0 /autogroup-38
[ 777.699598] kworker/u16:5 701 4483.971667 323 120 4483.971667 40.628762 11365.605971 0 /
[ 777.699608] kworker/u16:6 702 4711.845107 451 120 4711.845107 53.178637 76095.348219 0 /
[ 777.699619] kworker/u17:3 709 4494.537446 4 100 4494.537446 0.960832 0.002998 0 /
[ 777.699628] kworker/u17:4 710 4494.737940 2 100 4494.737940 0.010137 0.000000 0 /
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs
2014-06-17 21:35 commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs Konstantinos Skarlatos
@ 2014-06-17 21:38 ` Konstantinos Skarlatos
2014-06-18 2:11 ` Jens Axboe
1 sibling, 0 replies; 5+ messages in thread
From: Konstantinos Skarlatos @ 2014-06-17 21:38 UTC (permalink / raw)
To: axboe, linux-kernel; +Cc: linux-btrfs
[-- Attachment #1: Type: text/plain, Size: 3343 bytes --]
On 18/6/2014 12:35 πμ, Konstantinos Skarlatos wrote:
> Hi all,
> with 3.16-rc1 rsync stops writing to my btrfs filesystem and stays at
> a D+ state.
> git bisect showed that the problematic commit is:
>
> 762380ad9322951cea4ce9d24864265f9c66a916 is the first bad commit
> commit 762380ad9322951cea4ce9d24864265f9c66a916
> Author: Jens Axboe <axboe@fb.com>
> Date: Thu Jun 5 13:38:39 2014 -0600
>
> block: add notion of a chunk size for request merging
>
> Some drivers have different limits on what size a request should
> optimally be, depending on the offset of the request. Similar to
> dividing a device into chunks. Add a setting that allows the driver
> to inform the block layer of such a chunk size. The block layer will
> then prevent merging across the chunks.
>
> This is needed to optimally support NVMe with a non-zero stripe size.
>
> Signed-off-by: Jens Axboe <axboe@fb.com>
>
> sysrq w gives:
Just ran another echo w > /proc/sysrq-trigger, attaching output.
>
> [ 3287.169569] SysRq : Show Blocked State
> [ 3287.169655] task PC stack pid father
> [ 3287.169675] rsync D 0000000000000001 0 626 613
> 0x00000000
> [ 3287.169685] ffff8802037c7d08 0000000000000082 ffff8800cf2e7010
> 0000000000014500
> [ 3287.169693] ffff8802037c7fd8 0000000000014500 ffff8800cf2e7010
> ffff8802037c7c98
> [ 3287.169700] 0000000000000292 0000000000000292 ffff8802037c7c50
> ffff8802037c7c50
> [ 3287.169706] Call Trace:
> [ 3287.169722] [<ffffffff814f71d2>] ? do_page_fault+0x22/0x30
> [ 3287.169733] [<ffffffff8101cd89>] ? read_tsc+0x9/0x20
> [ 3287.169743] [<ffffffff811379d0>] ? sleep_on_page+0x20/0x20
> [ 3287.169749] [<ffffffff814eff29>] schedule+0x29/0x70
> [ 3287.169756] [<ffffffff814f0214>] io_schedule+0x94/0xf0
> [ 3287.169763] [<ffffffff811379de>] sleep_on_page_killable+0xe/0x50
> [ 3287.169770] [<ffffffff814f0748>] __wait_on_bit_lock+0x48/0xb0
> [ 3287.169777] [<ffffffff8128c753>] ? radix_tree_lookup_slot+0x13/0x30
> [ 3287.169785] [<ffffffff81137b7a>] __lock_page_killable+0x6a/0x70
> [ 3287.169792] [<ffffffff810acec0>] ? autoremove_wake_function+0x40/0x40
> [ 3287.169799] [<ffffffff811398c8>] generic_file_aio_read+0x458/0x6a0
> [ 3287.169808] [<ffffffff811ab63a>] do_sync_read+0x5a/0x90
> [ 3287.169816] [<ffffffff811abc47>] vfs_read+0x97/0x160
> [ 3287.169823] [<ffffffff811ac886>] SyS_read+0x46/0xc0
> [ 3287.169831] [<ffffffff814fb969>] system_call_fastpath+0x16/0x1b
>
> $ btrfs filesystem show /storage/btrfs
> Label: none uuid: bde3c349-9e08-45bb-8517-b9a6dda81e88
> Total devices 6 FS bytes used 8.58TiB
> devid 1 size 3.64TiB used 3.02TiB path /dev/sdf
> devid 2 size 1.82TiB used 1.20TiB path /dev/sda
> devid 3 size 1.82TiB used 1.20TiB path /dev/sdb
> devid 4 size 1.82TiB used 1.20TiB path /dev/sdc
> devid 5 size 1.82TiB used 1.20TiB path /dev/sdd
> devid 6 size 1.82TiB used 1.20TiB path /dev/sdh
>
> Btrfs v3.14.2-dirty
>
> $ btrfs fi df /storage/btrfs
> Data, single: total=8.89TiB, used=8.51TiB
> System, RAID1: total=32.00MiB, used=992.00KiB
> Metadata, RAID1: total=69.00GiB, used=67.83GiB
> unknown, single: total=512.00MiB, used=0.00
>
> full dmesg attached
> Please CC me if replying on LKML, as I am not subscribed there
[-- Attachment #2: dmesg_blocked2.txt --]
[-- Type: text/plain, Size: 55982 bytes --]
[18278.207224] SysRq : Show Blocked State
[18278.207308] task PC stack pid father
[18278.207322] jbd2/sde3-8 D 0000000000000002 0 154 2 0x00000000
[18278.207332] ffff880202db7bd8 0000000000000046 ffff880203291e90 0000000000014500
[18278.207340] ffff880202db7fd8 0000000000014500 ffff880203291e90 ffff8801ed4be170
[18278.207347] ffff880202db7b38 ffffffff8125f45d ffff880203051168 ffff880203051048
[18278.207353] Call Trace:
[18278.207368] [<ffffffff8125f45d>] ? blk_insert_flush+0x1dd/0x1f0
[18278.207379] [<ffffffff81259443>] ? __blk_run_queue+0x33/0x40
[18278.207386] [<ffffffff8125d72a>] ? blk_queue_bio+0x23a/0x370
[18278.207394] [<ffffffff8101cd89>] ? read_tsc+0x9/0x20
[18278.207403] [<ffffffff811dc370>] ? generic_block_bmap+0x50/0x50
[18278.207410] [<ffffffff814efe49>] schedule+0x29/0x70
[18278.207416] [<ffffffff814f0134>] io_schedule+0x94/0xf0
[18278.207423] [<ffffffff811dc37e>] sleep_on_buffer+0xe/0x20
[18278.207429] [<ffffffff814f0573>] __wait_on_bit+0x83/0xa0
[18278.207437] [<ffffffff811dc370>] ? generic_block_bmap+0x50/0x50
[18278.207443] [<ffffffff814f0607>] out_of_line_wait_on_bit+0x77/0x90
[18278.207450] [<ffffffff810acec0>] ? autoremove_wake_function+0x40/0x40
[18278.207458] [<ffffffff811dc46a>] __wait_on_buffer+0x2a/0x30
[18278.207480] [<ffffffffa08a1e81>] jbd2_journal_commit_transaction+0x1941/0x1950 [jbd2]
[18278.207495] [<ffffffffa08a7299>] kjournald2+0xd9/0x280 [jbd2]
[18278.207501] [<ffffffff810ace80>] ? __wake_up_sync+0x20/0x20
[18278.207513] [<ffffffffa08a71c0>] ? commit_timeout+0x10/0x10 [jbd2]
[18278.207520] [<ffffffff8108933b>] kthread+0xdb/0x100
[18278.207527] [<ffffffff81089260>] ? kthread_create_on_node+0x180/0x180
[18278.207534] [<ffffffff814fb7fc>] ret_from_fork+0x7c/0xb0
[18278.207540] [<ffffffff81089260>] ? kthread_create_on_node+0x180/0x180
[18278.207545] systemd-journal D 0000000000000000 0 178 1 0x00000000
[18278.207552] ffff8800cb617e50 0000000000000082 ffff880203311460 0000000000014500
[18278.207558] ffff8800cb617fd8 0000000000014500 ffff880203311460 0000000000000046
[18278.207565] ffff8800cb617de0 ffffffff8109940f ffff880202079cb0 0000000000000000
[18278.207571] Call Trace:
[18278.207580] [<ffffffff8109940f>] ? try_to_wake_up+0x1ff/0x2e0
[18278.207589] [<ffffffff81099552>] ? default_wake_function+0x12/0x20
[18278.207595] [<ffffffff814efe49>] schedule+0x29/0x70
[18278.207607] [<ffffffffa08a62fd>] jbd2_log_wait_commit+0x9d/0x110 [jbd2]
[18278.207613] [<ffffffff810ace80>] ? __wake_up_sync+0x20/0x20
[18278.207625] [<ffffffffa08a7e5c>] jbd2_complete_transaction+0x6c/0x90 [jbd2]
[18278.207642] [<ffffffffa08cb6f8>] ext4_sync_file+0x1f8/0x370 [ext4]
[18278.207650] [<ffffffff811dad2e>] do_fsync+0x4e/0x80
[18278.207657] [<ffffffff811dafc0>] SyS_fsync+0x10/0x20
[18278.207663] [<ffffffff814fb8a9>] system_call_fastpath+0x16/0x1b
[18278.207674] rsync D 0000000000000003 0 696 682 0x00000000
[18278.207680] ffff8801f43d3d08 0000000000000086 ffff880202b965e0 0000000000014500
[18278.207686] ffff8801f43d3fd8 0000000000014500 ffff880202b965e0 ffff8801f43d3c98
[18278.207692] 0000000000000292 0000000000000292 ffff8801f43d3c50 ffff8801f43d3c50
[18278.207698] Call Trace:
[18278.207707] [<ffffffff814f7112>] ? do_page_fault+0x22/0x30
[18278.207714] [<ffffffff8101cd89>] ? read_tsc+0x9/0x20
[18278.207722] [<ffffffff811379d0>] ? sleep_on_page+0x20/0x20
[18278.207727] [<ffffffff814efe49>] schedule+0x29/0x70
[18278.207733] [<ffffffff814f0134>] io_schedule+0x94/0xf0
[18278.207740] [<ffffffff811379de>] sleep_on_page_killable+0xe/0x50
[18278.207746] [<ffffffff814f0668>] __wait_on_bit_lock+0x48/0xb0
[18278.207753] [<ffffffff8128c673>] ? radix_tree_lookup_slot+0x13/0x30
[18278.207761] [<ffffffff81137b7a>] __lock_page_killable+0x6a/0x70
[18278.207767] [<ffffffff810acec0>] ? autoremove_wake_function+0x40/0x40
[18278.207773] [<ffffffff811398c8>] generic_file_aio_read+0x458/0x6a0
[18278.207782] [<ffffffff811ab63a>] do_sync_read+0x5a/0x90
[18278.207790] [<ffffffff811abc47>] vfs_read+0x97/0x160
[18278.207797] [<ffffffff811ac886>] SyS_read+0x46/0xc0
[18278.207804] [<ffffffff814fb8a9>] system_call_fastpath+0x16/0x1b
[18278.207809] smbd D 0000000000000001 0 1440 377 0x00000000
[18278.207815] ffff8800bcc67d08 0000000000000082 ffff8801f42c8000 0000000000014500
[18278.207821] ffff8800bcc67fd8 0000000000014500 ffff8801f42c8000 ffffffff81446971
[18278.207827] 00000000000094a8 ffff8800bcc67ca8 ffffffff81453b14 ffff8800bcc67fd8
[18278.207833] Call Trace:
[18278.207842] [<ffffffff81446971>] ? tcp_sendmsg+0x941/0xd50
[18278.207848] [<ffffffff81453b14>] ? tcp_transmit_skb+0x504/0x980
[18278.207855] [<ffffffff814f330a>] ? _raw_spin_unlock_bh+0x1a/0x20
[18278.207862] [<ffffffff813e9238>] ? release_sock+0x118/0x170
[18278.207868] [<ffffffff8101cd89>] ? read_tsc+0x9/0x20
[18278.207876] [<ffffffff811379d0>] ? sleep_on_page+0x20/0x20
[18278.207881] [<ffffffff814efe49>] schedule+0x29/0x70
[18278.207887] [<ffffffff814f0134>] io_schedule+0x94/0xf0
[18278.207894] [<ffffffff811379de>] sleep_on_page_killable+0xe/0x50
[18278.207900] [<ffffffff814f0668>] __wait_on_bit_lock+0x48/0xb0
[18278.207906] [<ffffffff8128c673>] ? radix_tree_lookup_slot+0x13/0x30
[18278.207914] [<ffffffff81137b7a>] __lock_page_killable+0x6a/0x70
[18278.207920] [<ffffffff810acec0>] ? autoremove_wake_function+0x40/0x40
[18278.207926] [<ffffffff811398c8>] generic_file_aio_read+0x458/0x6a0
[18278.207934] [<ffffffff811ab63a>] do_sync_read+0x5a/0x90
[18278.207942] [<ffffffff811abc47>] vfs_read+0x97/0x160
[18278.207949] [<ffffffff811aca3a>] SyS_pread64+0x7a/0xa0
[18278.207956] [<ffffffff814fb8a9>] system_call_fastpath+0x16/0x1b
[18278.207964] Sched Debug Version: v0.11, 3.15.0-rc8-g762380a #1
[18278.207969] ktime : 18253931.549509
[18278.207973] sched_clk : 18278207.961561
[18278.207977] cpu_clk : 18278207.961662
[18278.207981] jiffies : 4300353476
[18278.207985] sched_clock_stable() : 1
[18278.207990] sysctl_sched
[18278.207994] .sysctl_sched_latency : 18.000000
[18278.207997] .sysctl_sched_min_granularity : 2.250000
[18278.208001] .sysctl_sched_wakeup_granularity : 3.000000
[18278.208004] .sysctl_sched_child_runs_first : 0
[18278.208008] .sysctl_sched_features : 77435
[18278.208012] .sysctl_sched_tunable_scaling : 1 (logaritmic)
[18278.208019] cpu#0, 3214.094 MHz
[18278.208022] .nr_running : 0
[18278.208026] .load : 0
[18278.208029] .nr_switches : 176134
[18278.208032] .nr_load_updates : 70761
[18278.208036] .nr_uninterruptible : 78
[18278.208039] .next_balance : 4300.353482
[18278.208043] .curr->pid : 0
[18278.208046] .clock : 18278206.221722
[18278.208050] .cpu_load[0] : 384
[18278.208053] .cpu_load[1] : 333
[18278.208056] .cpu_load[2] : 231
[18278.208059] .cpu_load[3] : 138
[18278.208062] .cpu_load[4] : 76
[18278.208065] .yld_count : 3
[18278.208069] .sched_count : 185307
[18278.208072] .sched_goidle : 93625
[18278.208075] .avg_idle : 885569
[18278.208079] .max_idle_balance_cost : 500000
[18278.208082] .ttwu_count : 67433
[18278.208085] .ttwu_local : 40416
[18278.208090]
cfs_rq[0]:/autogroup-40
[18278.208096] .exec_clock : 285.176604
[18278.208101] .MIN_vruntime : 0.000001
[18278.208104] .min_vruntime : 1299.959284
[18278.208108] .max_vruntime : 0.000001
[18278.208112] .spread : 0.000000
[18278.208116] .spread0 : -6679.735729
[18278.208119] .nr_spread_over : 99
[18278.208123] .nr_running : 0
[18278.208126] .load : 0
[18278.208129] .runnable_load_avg : 0
[18278.208133] .blocked_load_avg : 972
[18278.208136] .tg_load_contrib : 972
[18278.208140] .tg_runnable_contrib : 233
[18278.208143] .tg_load_avg : 2133
[18278.208146] .tg->runnable_avg : 473
[18278.208150] .tg->cfs_bandwidth.timer_active: 0
[18278.208153] .throttled : 0
[18278.208156] .throttle_count : 0
[18278.208161] .se->exec_start : 18278206.220209
[18278.208165] .se->vruntime : 7979.695013
[18278.208168] .se->sum_exec_runtime : 285.176604
[18278.208172] .se->statistics.wait_start : 0.000000
[18278.208176] .se->statistics.sleep_start : 0.000000
[18278.208179] .se->statistics.block_start : 0.000000
[18278.208183] .se->statistics.sleep_max : 0.000000
[18278.208186] .se->statistics.block_max : 0.000000
[18278.208190] .se->statistics.exec_max : 3.344396
[18278.208194] .se->statistics.slice_max : 0.395955
[18278.208197] .se->statistics.wait_max : 0.061146
[18278.208201] .se->statistics.wait_sum : 2.325952
[18278.208204] .se->statistics.wait_count : 396
[18278.208208] .se->load.weight : 2
[18278.208211] .se->avg.runnable_avg_sum : 10796
[18278.208215] .se->avg.runnable_avg_period : 48112
[18278.208218] .se->avg.load_avg_contrib : 205
[18278.208221] .se->avg.decay_count : 17431456
[18278.208226]
cfs_rq[0]:/
[18278.208231] .exec_clock : 8905.241023
[18278.208235] .MIN_vruntime : 0.000001
[18278.208238] .min_vruntime : 7979.695013
[18278.208242] .max_vruntime : 0.000001
[18278.208245] .spread : 0.000000
[18278.208248] .spread0 : 0.000000
[18278.208252] .nr_spread_over : 30
[18278.208255] .nr_running : 0
[18278.208258] .load : 0
[18278.208261] .runnable_load_avg : 0
[18278.208265] .blocked_load_avg : 205
[18278.208268] .tg_load_contrib : 205
[18278.208271] .tg_runnable_contrib : 226
[18278.208275] .tg_load_avg : 554
[18278.208278] .tg->runnable_avg : 507
[18278.208281] .tg->cfs_bandwidth.timer_active: 0
[18278.208284] .throttled : 0
[18278.208287] .throttle_count : 0
[18278.208291] .avg->runnable_avg_sum : 10737
[18278.208294] .avg->runnable_avg_period : 48429
[18278.208300]
rt_rq[0]:/
[18278.208305] .rt_nr_running : 0
[18278.208308] .rt_throttled : 0
[18278.208311] .rt_time : 0.000000
[18278.208315] .rt_runtime : 950.000000
[18278.208319]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[18278.208327] ksoftirqd/0 3 7970.650994 3216 120 7970.650994 122.690447 18277896.497368 0 /
[18278.208339] kworker/0:0H 5 668.411491 6 100 668.411491 3.366551 1747.874725 0 /
[18278.208351] rcu_bh 9 155.263192 2 120 155.263192 0.001173 0.000000 0 /
[18278.208361] migration/0 10 0.000000 112 0 0.000000 39.085159 0.000000 0 /
[18278.208372] watchdog/0 11 0.000000 4567 0 0.000000 106.337865 0.000000 0 /
[18278.208384] kblockd 37 668.407208 4 100 668.407208 0.025149 1684.614320 0 /
[18278.208394] khubd 78 451.613137 11 120 451.613137 0.207903 367.116121 0 /
[18278.208404] scsi_tmf_2 84 358.676999 2 100 358.676999 0.012141 0.189501 0 /
[18278.208414] kworker/u16:3 90 6376.831781 6992 120 6376.831781 1020.661868 15070323.727485 0 /
[18278.208424] scsi_tmf_4 92 399.823600 2 100 399.823600 0.011947 0.004929 0 /
[18278.208434] scsi_tmf_5 94 417.350890 2 100 417.350890 0.017084 0.008773 0 /
[18278.208445] kworker/0:1H 137 7769.714647 159 100 7769.714647 3.308124 16665119.522124 0 /
[18278.208456] ext4-rsv-conver 155 773.634852 2 100 773.634852 0.008357 0.003145 0 /
[18278.208466] kworker/0:2 183 7966.045472 30306 120 7966.045472 1211.404118 18267187.281035 0 /
[18278.208476] systemd-udevd 194 197.720176 408 120 197.720176 398.638919 396841.953950 0 /autogroup-12
[18278.208488] hd-audio0 252 1241.521523 2 100 1241.521523 0.048002 0.014246 0 /
[18278.208498] ext4-rsv-conver 264 1336.049975 2 100 1336.049975 0.027726 0.016338 0 /
[18278.208508] named 364 19.757217 56 120 19.757217 22.354739 1033.525131 0 /autogroup-27
[18278.208519] named 369 18.013616 208 120 18.013616 6.924516 18024080.220706 0 /autogroup-27
[18278.208529] named 370 19.779042 176 120 19.779042 6.580362 18024080.038764 0 /autogroup-27
[18278.208541] btrfs-worker 508 3327.844182 2 100 3327.844182 0.023831 0.010155 0 /
[18278.208551] btrfs-delalloc 511 3336.866736 2 100 3336.866736 0.025767 0.015455 0 /
[18278.208561] btrfs-submit 514 3341.385104 2 100 3341.385104 0.021756 0.009838 0 /
[18278.208571] btrfs-fixup 515 3347.405115 2 100 3347.405115 0.022670 0.008702 0 /
[18278.208581] btrfs-endio 516 3353.423671 2 100 3353.423671 0.021030 0.008608 0 /
[18278.208590] btrfs-endio-met 517 3359.441273 2 100 3359.441273 0.020180 0.008990 0 /
[18278.208600] btrfs-endio-met 518 3365.458847 2 100 3365.458847 0.019899 0.008551 0 /
[18278.208609] btrfs-endio-rai 519 3371.476299 2 100 3371.476299 0.019716 0.008737 0 /
[18278.208619] btrfs-rmw 520 3377.493168 2 100 3377.493168 0.018948 0.008260 0 /
[18278.208629] btrfs-endio-wri 521 3383.510916 2 100 3383.510916 0.020197 0.008445 0 /
[18278.208638] btrfs-freespace 522 3389.528843 2 100 3389.528843 0.020479 0.008735 0 /
[18278.208648] btrfs-delayed-m 523 3395.547136 2 100 3395.547136 0.021189 0.008845 0 /
[18278.208657] btrfs-readahead 524 3401.564524 2 100 3401.564524 0.019797 0.008330 0 /
[18278.208667] btrfs-qgroup-re 525 3407.583121 2 100 3407.583121 0.020792 0.009610 0 /
[18278.208677] rsync 698 1482.332372 295 120 1482.332372 10.795915 17620340.131198 0 /autogroup-38
[18278.208689] run-parts 1523 7499.289877 7 120 7499.289877 13.217625 44.049658 0 /
[18278.208699] kworker/0:0 1538 7804.547322 3 120 7804.547322 0.020380 301850.159506 0 /
[18278.208709] sudo 1661 1299.959284 5 120 1299.959284 12.822718 0.968634 0 /autogroup-40
[18278.208723] cpu#1, 3214.094 MHz
[18278.208727] .nr_running : 0
[18278.208730] .load : 0
[18278.208734] .nr_switches : 200715
[18278.208737] .nr_load_updates : 80291
[18278.208741] .nr_uninterruptible : -37
[18278.208745] .next_balance : 4300.353478
[18278.208748] .curr->pid : 0
[18278.208752] .clock : 18278205.575310
[18278.208755] .cpu_load[0] : 0
[18278.208758] .cpu_load[1] : 7
[18278.208761] .cpu_load[2] : 18
[18278.208764] .cpu_load[3] : 18
[18278.208768] .cpu_load[4] : 12
[18278.208771] .yld_count : 0
[18278.208774] .sched_count : 209801
[18278.208777] .sched_goidle : 101830
[18278.208781] .avg_idle : 989872
[18278.208784] .max_idle_balance_cost : 500000
[18278.208788] .ttwu_count : 73879
[18278.208791] .ttwu_local : 53717
[18278.208795]
cfs_rq[1]:/autogroup-8
[18278.208800] .exec_clock : 81.418140
[18278.208804] .MIN_vruntime : 0.000001
[18278.208808] .min_vruntime : 80.369564
[18278.208811] .max_vruntime : 0.000001
[18278.208815] .spread : 0.000000
[18278.208819] .spread0 : -7899.325449
[18278.208822] .nr_spread_over : 0
[18278.208825] .nr_running : 0
[18278.208828] .load : 0
[18278.208832] .runnable_load_avg : 0
[18278.208835] .blocked_load_avg : 0
[18278.208838] .tg_load_contrib : 0
[18278.208841] .tg_runnable_contrib : 8
[18278.208844] .tg_load_avg : 0
[18278.208848] .tg->runnable_avg : 8
[18278.208851] .tg->cfs_bandwidth.timer_active: 0
[18278.208854] .throttled : 0
[18278.208857] .throttle_count : 0
[18278.208861] .se->exec_start : 18278202.654051
[18278.208865] .se->vruntime : 6037.971773
[18278.208869] .se->sum_exec_runtime : 81.425530
[18278.208872] .se->statistics.wait_start : 0.000000
[18278.208876] .se->statistics.sleep_start : 0.000000
[18278.208879] .se->statistics.block_start : 0.000000
[18278.208883] .se->statistics.sleep_max : 0.000000
[18278.208886] .se->statistics.block_max : 0.000000
[18278.208890] .se->statistics.exec_max : 3.339075
[18278.208894] .se->statistics.slice_max : 0.153286
[18278.208897] .se->statistics.wait_max : 0.698593
[18278.208901] .se->statistics.wait_sum : 1.309107
[18278.208904] .se->statistics.wait_count : 110
[18278.208907] .se->load.weight : 2
[18278.208911] .se->avg.runnable_avg_sum : 391
[18278.208914] .se->avg.runnable_avg_period : 48608
[18278.208917] .se->avg.load_avg_contrib : 0
[18278.208921] .se->avg.decay_count : 17431453
[18278.208925]
cfs_rq[1]:/autogroup-40
[18278.208930] .exec_clock : 364.699921
[18278.208934] .MIN_vruntime : 0.000001
[18278.208938] .min_vruntime : 1174.176439
[18278.208941] .max_vruntime : 0.000001
[18278.208945] .spread : 0.000000
[18278.208948] .spread0 : -6805.518574
[18278.208952] .nr_spread_over : 56
[18278.208955] .nr_running : 0
[18278.208958] .load : 0
[18278.208961] .runnable_load_avg : 0
[18278.208965] .blocked_load_avg : 0
[18278.208968] .tg_load_contrib : 0
[18278.208971] .tg_runnable_contrib : 146
[18278.208974] .tg_load_avg : 2133
[18278.208978] .tg->runnable_avg : 473
[18278.208981] .tg->cfs_bandwidth.timer_active: 0
[18278.208984] .throttled : 0
[18278.208988] .throttle_count : 0
[18278.208991] .se->exec_start : 18278205.552269
[18278.208995] .se->vruntime : 6047.352628
[18278.208999] .se->sum_exec_runtime : 364.699921
[18278.209002] .se->statistics.wait_start : 0.000000
[18278.209006] .se->statistics.sleep_start : 0.000000
[18278.209010] .se->statistics.block_start : 0.000000
[18278.209013] .se->statistics.sleep_max : 0.000000
[18278.209016] .se->statistics.block_max : 0.000000
[18278.209020] .se->statistics.exec_max : 3.342586
[18278.209024] .se->statistics.slice_max : 0.000000
[18278.209027] .se->statistics.wait_max : 0.064633
[18278.209031] .se->statistics.wait_sum : 8.861315
[18278.209034] .se->statistics.wait_count : 4894
[18278.209037] .se->load.weight : 2
[18278.209041] .se->avg.runnable_avg_sum : 7088
[18278.209044] .se->avg.runnable_avg_period : 47826
[18278.209047] .se->avg.load_avg_contrib : 201
[18278.209051] .se->avg.decay_count : 17431456
[18278.209054]
cfs_rq[1]:/
[18278.209059] .exec_clock : 7397.026976
[18278.209063] .MIN_vruntime : 0.000001
[18278.209067] .min_vruntime : 6047.352628
[18278.209070] .max_vruntime : 0.000001
[18278.209074] .spread : 0.000000
[18278.209077] .spread0 : -1932.342385
[18278.209081] .nr_spread_over : 38
[18278.209084] .nr_running : 0
[18278.209087] .load : 0
[18278.209090] .runnable_load_avg : 0
[18278.209094] .blocked_load_avg : 209
[18278.209097] .tg_load_contrib : 209
[18278.209100] .tg_runnable_contrib : 158
[18278.209103] .tg_load_avg : 554
[18278.209107] .tg->runnable_avg : 507
[18278.209110] .tg->cfs_bandwidth.timer_active: 0
[18278.209113] .throttled : 0
[18278.209116] .throttle_count : 0
[18278.209120] .avg->runnable_avg_sum : 7602
[18278.209123] .avg->runnable_avg_period : 48909
[18278.209127]
rt_rq[1]:/
[18278.209132] .rt_nr_running : 0
[18278.209135] .rt_throttled : 0
[18278.209138] .rt_time : 0.000000
[18278.209142] .rt_runtime : 950.000000
[18278.209145]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[18278.209153] kthreadd 2 5826.999191 161 120 5826.999191 3.249500 16667120.269330 0 /
[18278.209164] rcu_sched 8 1574.198414 29 120 1574.198414 0.506276 118147.524258 0 /
[18278.209174] watchdog/1 12 -2.977429 4567 0 -2.977429 99.973449 0.000000 0 /
[18278.209184] migration/1 13 0.000000 139 0 0.000000 5.997613 0.000000 0 /
[18278.209194] ksoftirqd/1 14 6037.547356 2814 120 6037.547356 100.883884 18277888.142702 0 /
[18278.209203] kworker/1:0H 16 314.272745 7 100 314.272745 0.046487 4323.556642 0 /
[18278.209214] kdevtmpfs 28 649.876853 146 120 649.876853 2.261950 14573.638099 0 /
[18278.209225] kthrotld 44 8.091400 2 100 8.091400 0.015555 0.007082 0 /
[18278.209234] ipv6_addrconf 45 17.106643 2 100 17.106643 0.016500 0.007634 0 /
[18278.209244] deferwq 46 26.122380 2 100 26.122380 0.017050 0.007365 0 /
[18278.209254] scsi_eh_2 83 243.017875 5 120 243.017875 0.197952 152.856454 0 /
[18278.209263] scsi_tmf_3 86 195.038503 2 100 195.038503 0.006546 0.004825 0 /
[18278.209274] scsi_tmf_9 108 248.253960 2 100 248.253960 0.013197 0.009032 0 /
[18278.209283] bioset 143 312.422065 2 100 312.422065 0.011770 0.000000 0 /
[18278.209293] kworker/1:1H 150 5763.102018 110 100 5763.102018 2.210108 16659933.678318 0 /
[18278.209303] kvm-irqfd-clean 256 586.122582 2 100 586.122582 0.011624 0.018528 0 /
[18278.209313] crond 273 78.592984 326 120 78.592984 97.623152 18221928.795258 0 /autogroup-20
[18278.209324] agetty 286 1.834804 9 120 1.834804 16.210705 5164.820008 0 /autogroup-32
[18278.209334] named 372 30.752128 262 120 30.752128 36.869318 18024048.848870 0 /autogroup-27
[18278.209345] kworker/u17:0 509 3724.427873 10 100 3724.427873 14.351555 605549.420117 0 /
[18278.209355] btrfs-flush_del 512 1789.624926 2 100 1789.624926 0.029969 0.010746 0 /
[18278.209366] kworker/u17:2 708 3464.730080 6 100 3464.730080 14.868514 0.027461 0 /
[18278.209376] kworker/1:0 811 5837.017223 15654 120 5837.017223 669.179652 15952161.656976 0 /
[18278.209386] smbd 1440 216.408985 1151 120 216.408985 209.848892 3164.041373 0 /autogroup-35
[18278.209397] kworker/1:1 1509 6037.566504 7393 120 6037.566504 203.715981 1725106.065661 0 /
[18278.209407] crond 1522 71.214608 4 120 71.214608 10.396548 54.910307 0 /autogroup-20
[18278.209421] cpu#2, 3214.094 MHz
[18278.209424] .nr_running : 1
[18278.209428] .load : 325
[18278.209431] .nr_switches : 493146
[18278.209434] .nr_load_updates : 201909
[18278.209438] .nr_uninterruptible : -469
[18278.209442] .next_balance : 4300.353445
[18278.209445] .curr->pid : 1662
[18278.209449] .clock : 18278207.214750
[18278.209452] .cpu_load[0] : 0
[18278.209455] .cpu_load[1] : 0
[18278.209458] .cpu_load[2] : 3
[18278.209461] .cpu_load[3] : 4
[18278.209464] .cpu_load[4] : 2
[18278.209468] .yld_count : 0
[18278.209471] .sched_count : 502223
[18278.209474] .sched_goidle : 239378
[18278.209478] .avg_idle : 1000000
[18278.209481] .max_idle_balance_cost : 500000
[18278.209485] .ttwu_count : 329424
[18278.209488] .ttwu_local : 246380
[18278.209492]
cfs_rq[2]:/autogroup-8
[18278.209497] .exec_clock : 70.024794
[18278.209501] .MIN_vruntime : 0.000001
[18278.209505] .min_vruntime : 68.976218
[18278.209508] .max_vruntime : 0.000001
[18278.209511] .spread : 0.000000
[18278.209515] .spread0 : -7910.718795
[18278.209518] .nr_spread_over : 0
[18278.209522] .nr_running : 0
[18278.209525] .load : 0
[18278.209528] .runnable_load_avg : 0
[18278.209531] .blocked_load_avg : 0
[18278.209534] .tg_load_contrib : 0
[18278.209538] .tg_runnable_contrib : 0
[18278.209541] .tg_load_avg : 0
[18278.209544] .tg->runnable_avg : 8
[18278.209547] .tg->cfs_bandwidth.timer_active: 0
[18278.209550] .throttled : 0
[18278.209553] .throttle_count : 0
[18278.209557] .se->exec_start : 18278202.895677
[18278.209561] .se->vruntime : 15951.933539
[18278.209565] .se->sum_exec_runtime : 70.024794
[18278.209568] .se->statistics.wait_start : 0.000000
[18278.209572] .se->statistics.sleep_start : 0.000000
[18278.209576] .se->statistics.block_start : 0.000000
[18278.209579] .se->statistics.sleep_max : 0.000000
[18278.209583] .se->statistics.block_max : 0.000000
[18278.209586] .se->statistics.exec_max : 3.338288
[18278.209590] .se->statistics.slice_max : 0.710750
[18278.209593] .se->statistics.wait_max : 0.285020
[18278.209597] .se->statistics.wait_sum : 2.267731
[18278.209600] .se->statistics.wait_count : 149
[18278.209604] .se->load.weight : 2
[18278.209607] .se->avg.runnable_avg_sum : 45
[18278.209610] .se->avg.runnable_avg_period : 49013
[18278.209614] .se->avg.load_avg_contrib : 0
[18278.209617] .se->avg.decay_count : 17431453
[18278.209621]
cfs_rq[2]:/autogroup-24
[18278.209626] .exec_clock : 18.106602
[18278.209630] .MIN_vruntime : 0.000001
[18278.209634] .min_vruntime : 17.058026
[18278.209637] .max_vruntime : 0.000001
[18278.209641] .spread : 0.000000
[18278.209644] .spread0 : -7962.636987
[18278.209647] .nr_spread_over : 0
[18278.209651] .nr_running : 0
[18278.209654] .load : 0
[18278.209657] .runnable_load_avg : 0
[18278.209660] .blocked_load_avg : 0
[18278.209663] .tg_load_contrib : 0
[18278.209667] .tg_runnable_contrib : 7
[18278.209670] .tg_load_avg : 0
[18278.209673] .tg->runnable_avg : 7
[18278.209676] .tg->cfs_bandwidth.timer_active: 0
[18278.209679] .throttled : 0
[18278.209683] .throttle_count : 0
[18278.209686] .se->exec_start : 18278202.679109
[18278.209690] .se->vruntime : 15952.263644
[18278.209694] .se->sum_exec_runtime : 18.106602
[18278.209698] .se->statistics.wait_start : 0.000000
[18278.209701] .se->statistics.sleep_start : 0.000000
[18278.209705] .se->statistics.block_start : 0.000000
[18278.209708] .se->statistics.sleep_max : 0.000000
[18278.209712] .se->statistics.block_max : 0.000000
[18278.209715] .se->statistics.exec_max : 0.869085
[18278.209719] .se->statistics.slice_max : 0.381469
[18278.209722] .se->statistics.wait_max : 0.606158
[18278.209726] .se->statistics.wait_sum : 2.942373
[18278.209729] .se->statistics.wait_count : 131
[18278.209732] .se->load.weight : 2
[18278.209736] .se->avg.runnable_avg_sum : 352
[18278.209739] .se->avg.runnable_avg_period : 48835
[18278.209742] .se->avg.load_avg_contrib : 0
[18278.209746] .se->avg.decay_count : 17431453
[18278.209750]
cfs_rq[2]:/autogroup-40
[18278.209755] .exec_clock : 271.745697
[18278.209759] .MIN_vruntime : 0.000001
[18278.209763] .min_vruntime : 618.693623
[18278.209766] .max_vruntime : 0.000001
[18278.209769] .spread : 0.000000
[18278.209773] .spread0 : -7361.001390
[18278.209776] .nr_spread_over : 60
[18278.209780] .nr_running : 1
[18278.209783] .load : 1024
[18278.209786] .runnable_load_avg : 1023
[18278.209790] .blocked_load_avg : 0
[18278.209793] .tg_load_contrib : 1023
[18278.209796] .tg_runnable_contrib : 92
[18278.209799] .tg_load_avg : 2133
[18278.209803] .tg->runnable_avg : 473
[18278.209806] .tg->cfs_bandwidth.timer_active: 0
[18278.209809] .throttled : 0
[18278.209812] .throttle_count : 0
[18278.209816] .se->exec_start : 18278207.214750
[18278.209820] .se->vruntime : 15965.975136
[18278.209824] .se->sum_exec_runtime : 271.745697
[18278.209827] .se->statistics.wait_start : 0.000000
[18278.209831] .se->statistics.sleep_start : 0.000000
[18278.209834] .se->statistics.block_start : 0.000000
[18278.209838] .se->statistics.sleep_max : 0.000000
[18278.209841] .se->statistics.block_max : 0.000000
[18278.209845] .se->statistics.exec_max : 3.654235
[18278.209849] .se->statistics.slice_max : 1.454261
[18278.209852] .se->statistics.wait_max : 0.064238
[18278.209856] .se->statistics.wait_sum : 5.702704
[18278.209859] .se->statistics.wait_count : 403
[18278.209862] .se->load.weight : 325
[18278.209866] .se->avg.runnable_avg_sum : 4273
[18278.209869] .se->avg.runnable_avg_period : 47173
[18278.209872] .se->avg.load_avg_contrib : 224
[18278.209876] .se->avg.decay_count : 0
[18278.209880]
cfs_rq[2]:/autogroup-39
[18278.209885] .exec_clock : 506.152600
[18278.209889] .MIN_vruntime : 0.000001
[18278.209892] .min_vruntime : 504.891350
[18278.209896] .max_vruntime : 0.000001
[18278.209899] .spread : 0.000000
[18278.209903] .spread0 : -7474.803663
[18278.209906] .nr_spread_over : 0
[18278.209909] .nr_running : 0
[18278.209912] .load : 0
[18278.209916] .runnable_load_avg : 0
[18278.209919] .blocked_load_avg : 1
[18278.209922] .tg_load_contrib : 1
[18278.209925] .tg_runnable_contrib : 6
[18278.209928] .tg_load_avg : 7
[18278.209932] .tg->runnable_avg : 6
[18278.209935] .tg->cfs_bandwidth.timer_active: 0
[18278.209938] .throttled : 0
[18278.209941] .throttle_count : 0
[18278.209945] .se->exec_start : 18278191.644003
[18278.209949] .se->vruntime : 15951.198082
[18278.209953] .se->sum_exec_runtime : 506.152600
[18278.209956] .se->statistics.wait_start : 0.000000
[18278.209960] .se->statistics.sleep_start : 0.000000
[18278.209963] .se->statistics.block_start : 0.000000
[18278.209967] .se->statistics.sleep_max : 0.000000
[18278.209970] .se->statistics.block_max : 0.000000
[18278.209974] .se->statistics.exec_max : 3.353685
[18278.209977] .se->statistics.slice_max : 0.156887
[18278.209981] .se->statistics.wait_max : 0.187074
[18278.209985] .se->statistics.wait_sum : 1.106308
[18278.209988] .se->statistics.wait_count : 3976
[18278.209991] .se->load.weight : 2
[18278.209994] .se->avg.runnable_avg_sum : 283
[18278.209998] .se->avg.runnable_avg_period : 47775
[18278.210001] .se->avg.load_avg_contrib : 3
[18278.210005] .se->avg.decay_count : 17431442
[18278.210008]
cfs_rq[2]:/
[18278.210013] .exec_clock : 19922.277141
[18278.210017] .MIN_vruntime : 0.000001
[18278.210020] .min_vruntime : 15965.975136
[18278.210024] .max_vruntime : 0.000001
[18278.210027] .spread : 0.000000
[18278.210031] .spread0 : 7986.280123
[18278.210034] .nr_spread_over : 39
[18278.210037] .nr_running : 1
[18278.210041] .load : 325
[18278.210044] .runnable_load_avg : 224
[18278.210047] .blocked_load_avg : 9
[18278.210050] .tg_load_contrib : 140
[18278.210054] .tg_runnable_contrib : 111
[18278.210057] .tg_load_avg : 554
[18278.210060] .tg->runnable_avg : 507
[18278.210063] .tg->cfs_bandwidth.timer_active: 0
[18278.210067] .throttled : 0
[18278.210070] .throttle_count : 0
[18278.210073] .avg->runnable_avg_sum : 5235
[18278.210077] .avg->runnable_avg_period : 47883
[18278.210081]
rt_rq[2]:/
[18278.210085] .rt_nr_running : 0
[18278.210088] .rt_throttled : 0
[18278.210092] .rt_time : 0.000000
[18278.210095] .rt_runtime : 950.000000
[18278.210099]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[18278.210107] rcu_preempt 7 15951.932476 37104 120 15951.932476 1022.887166 18276900.871931 0 /
[18278.210118] watchdog/2 17 -5.974018 4567 0 -5.974018 120.436152 0.000000 0 /
[18278.210128] migration/2 18 0.000000 119 0 0.000000 5.660518 0.000000 0 /
[18278.210137] ksoftirqd/2 19 15951.894337 8307 120 15951.894337 229.277377 18277708.747551 0 /
[18278.210147] kworker/2:0H 21 276.416428 7 100 276.416428 0.041062 1449.512580 0 /
[18278.210157] khungtaskd 30 15947.222063 154 120 15947.222063 6.442826 18264126.468919 0 /
[18278.210167] khugepaged 33 15957.120347 1829 139 15957.120347 88.409265 18274584.971863 0 /
[18278.210177] crypto 34 7.959417 2 100 7.959417 0.009277 0.002051 0 /
[18278.210186] kintegrityd 35 16.965124 2 100 16.965124 0.006466 0.002173 0 /
[18278.210196] bioset 36 25.971039 2 100 25.971039 0.006553 0.002116 0 /
[18278.210205] kswapd0 39 240.490276 3 120 240.490276 0.046296 97.568037 0 /
[18278.210215] fsnotify_mark 40 3228.349012 16 120 3228.349012 0.344184 762009.335133 0 /
[18278.210226] ata_sff 79 141.983836 2 100 141.983836 0.014661 0.011459 0 /
[18278.210235] scsi_eh_0 80 265.072299 24 120 265.072299 0.301585 495.816875 0 /
[18278.210245] scsi_tmf_0 81 162.947376 2 100 162.947376 0.015436 0.007516 0 /
[18278.210255] scsi_eh_1 82 265.090598 26 120 265.090598 0.376758 494.353886 0 /
[18278.210265] scsi_eh_3 85 273.828008 5 120 273.828008 11.687633 305.757650 0 /
[18278.210274] scsi_tmf_1 88 177.466235 2 100 177.466235 0.014676 0.009012 0 /
[18278.210284] scsi_eh_4 91 265.056062 24 120 265.056062 0.330446 491.685562 0 /
[18278.210294] scsi_eh_5 93 265.118782 24 120 265.118782 0.350483 491.361906 0 /
[18278.210303] scsi_eh_6 95 265.060681 24 120 265.060681 0.359100 491.890923 0 /
[18278.210313] scsi_eh_7 97 265.144191 26 120 265.144191 0.515840 488.171054 0 /
[18278.210322] scsi_tmf_7 98 212.661097 2 100 212.661097 0.009961 0.001414 0 /
[18278.210332] scsi_eh_8 105 265.192611 24 120 265.192611 0.460831 487.515304 0 /
[18278.210341] scsi_tmf_8 106 239.712792 2 100 239.712792 0.018596 0.008056 0 /
[18278.210351] kworker/2:1H 118 15951.886249 60378 100 15951.886249 1198.258654 18275307.729425 0 /
[18278.210361] jbd2/sde3-8 154 15952.079433 3129 120 15952.079433 194.702700 18270819.273165 0 /
[18278.210371] systemd-journal 178 68.976218 873 120 68.976218 312.076972 18268546.579304 0 /autogroup-8
[18278.210382] ttm_swap 249 1357.535248 2 100 1357.535248 0.005573 0.000000 0 /
[18278.210392] systemd-logind 275 9.402403 623 120 9.402403 63.897840 18251085.646530 0 /autogroup-22
[18278.210402] dbus-daemon 276 9.011344 189 120 9.011344 50.443774 16653692.955031 0 /autogroup-23
[18278.210413] syslog-ng 282 17.058026 556 120 17.058026 133.791977 18263248.109966 0 /autogroup-24
[18278.210424] named 371 12.023273 196 120 12.023273 7.774733 18024078.558916 0 /autogroup-27
[18278.210435] sshd 365 0.386980 45 120 0.386980 19.950264 593728.143491 0 /autogroup-28
[18278.210445] ntpd 368 282.557234 18728 120 282.557234 1018.691618 18257114.331208 0 /autogroup-31
[18278.210455] nmbd 375 657.863321 5190 120 657.863321 668.050599 18250849.829850 0 /autogroup-33
[18278.210466] kworker/2:3 382 15957.004438 123098 120 15957.004438 4605.678232 18153906.648685 0 /
[18278.210475] sshd 396 486.114148 3854 120 486.114148 496.762518 17891790.776368 0 /autogroup-36
[18278.210487] btrfs-cache 513 2380.984458 2 100 2380.984458 0.014965 0.025295 0 /
[18278.210497] btrfs-transacti 536 15947.222946 9696 120 15947.222946 1008.805977 17744707.519829 0 /
[18278.210507] ssh 697 525.649474 21 120 525.649474 27.475167 309.032020 0 /autogroup-38
[18278.210518] kworker/2:0 810 3725.060067 3 120 3725.060067 0.030187 301232.196894 0 /
[18278.210529] sadc 1532 48.224005 11 120 48.224005 30.660732 1201587.980932 0 /autogroup-58
[18278.210539] R tee 1662 618.693623 2 120 618.693623 1.998424 0.000000 0 /autogroup-40
[18278.210553] cpu#3, 3214.094 MHz
[18278.210556] .nr_running : 0
[18278.210560] .load : 0
[18278.210563] .nr_switches : 184291
[18278.210566] .nr_load_updates : 74908
[18278.210570] .nr_uninterruptible : 432
[18278.210574] .next_balance : 4300.353476
[18278.210577] .curr->pid : 0
[18278.210581] .clock : 18278207.324923
[18278.210584] .cpu_load[0] : 0
[18278.210587] .cpu_load[1] : 0
[18278.210590] .cpu_load[2] : 0
[18278.210593] .cpu_load[3] : 0
[18278.210596] .cpu_load[4] : 0
[18278.210599] .yld_count : 0
[18278.210603] .sched_count : 193368
[18278.210606] .sched_goidle : 96670
[18278.210610] .avg_idle : 1000000
[18278.210613] .max_idle_balance_cost : 500000
[18278.210616] .ttwu_count : 74185
[18278.210620] .ttwu_local : 42025
[18278.210624]
cfs_rq[3]:/autogroup-39
[18278.210629] .exec_clock : 27.361298
[18278.210633] .MIN_vruntime : 0.000001
[18278.210636] .min_vruntime : 44.195032
[18278.210640] .max_vruntime : 0.000001
[18278.210643] .spread : 0.000000
[18278.210647] .spread0 : -7935.499981
[18278.210650] .nr_spread_over : 0
[18278.210654] .nr_running : 0
[18278.210657] .load : 0
[18278.210660] .runnable_load_avg : 0
[18278.210663] .blocked_load_avg : 6
[18278.210666] .tg_load_contrib : 6
[18278.210670] .tg_runnable_contrib : 0
[18278.210673] .tg_load_avg : 7
[18278.210676] .tg->runnable_avg : 6
[18278.210679] .tg->cfs_bandwidth.timer_active: 0
[18278.210682] .throttled : 0
[18278.210686] .throttle_count : 0
[18278.210690] .se->exec_start : 18278207.320182
[18278.210693] .se->vruntime : 7803.366221
[18278.210697] .se->sum_exec_runtime : 27.361298
[18278.210701] .se->statistics.wait_start : 0.000000
[18278.210704] .se->statistics.sleep_start : 0.000000
[18278.210708] .se->statistics.block_start : 0.000000
[18278.210711] .se->statistics.sleep_max : 0.000000
[18278.210715] .se->statistics.block_max : 0.000000
[18278.210718] .se->statistics.exec_max : 3.303389
[18278.210722] .se->statistics.slice_max : 0.000000
[18278.210725] .se->statistics.wait_max : 0.027254
[18278.210729] .se->statistics.wait_sum : 0.088775
[18278.210732] .se->statistics.wait_count : 80
[18278.210736] .se->load.weight : 2
[18278.210739] .se->avg.runnable_avg_sum : 113
[18278.210742] .se->avg.runnable_avg_period : 48804
[18278.210746] .se->avg.load_avg_contrib : 4
[18278.210749] .se->avg.decay_count : 17431457
[18278.210753]
cfs_rq[3]:/autogroup-2
[18278.210758] .exec_clock : 526.098730
[18278.210762] .MIN_vruntime : 0.000001
[18278.210766] .min_vruntime : 661.073836
[18278.210769] .max_vruntime : 0.000001
[18278.210773] .spread : 0.000000
[18278.210776] .spread0 : -7318.621177
[18278.210780] .nr_spread_over : 11
[18278.210783] .nr_running : 0
[18278.210786] .load : 0
[18278.210789] .runnable_load_avg : 0
[18278.210792] .blocked_load_avg : 3
[18278.210796] .tg_load_contrib : 3
[18278.210799] .tg_runnable_contrib : 4
[18278.210802] .tg_load_avg : 3
[18278.210805] .tg->runnable_avg : 4
[18278.210808] .tg->cfs_bandwidth.timer_active: 0
[18278.210812] .throttled : 0
[18278.210815] .throttle_count : 0
[18278.210819] .se->exec_start : 18278202.492620
[18278.210822] .se->vruntime : 7803.469792
[18278.210826] .se->sum_exec_runtime : 526.098730
[18278.210830] .se->statistics.wait_start : 0.000000
[18278.210833] .se->statistics.sleep_start : 0.000000
[18278.210837] .se->statistics.block_start : 0.000000
[18278.210840] .se->statistics.sleep_max : 0.000000
[18278.210844] .se->statistics.block_max : 0.000000
[18278.210847] .se->statistics.exec_max : 3.214201
[18278.210851] .se->statistics.slice_max : 0.385175
[18278.210855] .se->statistics.wait_max : 1.185065
[18278.210858] .se->statistics.wait_sum : 6.382706
[18278.210861] .se->statistics.wait_count : 6651
[18278.210865] .se->load.weight : 2
[18278.210868] .se->avg.runnable_avg_sum : 191
[18278.210871] .se->avg.runnable_avg_period : 48158
[18278.210875] .se->avg.load_avg_contrib : 3
[18278.210878] .se->avg.decay_count : 17431453
[18278.210882]
cfs_rq[3]:/autogroup-40
[18278.210888] .exec_clock : 376.743990
[18278.210891] .MIN_vruntime : 0.000001
[18278.210895] .min_vruntime : 420.882135
[18278.210898] .max_vruntime : 0.000001
[18278.210902] .spread : 0.000000
[18278.210905] .spread0 : -7558.812878
[18278.210909] .nr_spread_over : 25
[18278.210912] .nr_running : 0
[18278.210915] .load : 0
[18278.210918] .runnable_load_avg : 0
[18278.210922] .blocked_load_avg : 138
[18278.210925] .tg_load_contrib : 138
[18278.210928] .tg_runnable_contrib : 2
[18278.210932] .tg_load_avg : 2133
[18278.210935] .tg->runnable_avg : 473
[18278.210938] .tg->cfs_bandwidth.timer_active: 0
[18278.210941] .throttled : 0
[18278.210945] .throttle_count : 0
[18278.210949] .se->exec_start : 18278192.850797
[18278.210952] .se->vruntime : 7812.250380
[18278.210956] .se->sum_exec_runtime : 376.743990
[18278.210960] .se->statistics.wait_start : 0.000000
[18278.210963] .se->statistics.sleep_start : 0.000000
[18278.210967] .se->statistics.block_start : 0.000000
[18278.210970] .se->statistics.sleep_max : 0.000000
[18278.210974] .se->statistics.block_max : 0.000000
[18278.210977] .se->statistics.exec_max : 3.340994
[18278.210981] .se->statistics.slice_max : 0.027196
[18278.210985] .se->statistics.wait_max : 0.073285
[18278.210988] .se->statistics.wait_sum : 5.005784
[18278.210991] .se->statistics.wait_count : 652
[18278.210995] .se->load.weight : 2
[18278.210998] .se->avg.runnable_avg_sum : 116
[18278.211001] .se->avg.runnable_avg_period : 47850
[18278.211005] .se->avg.load_avg_contrib : 30
[18278.211008] .se->avg.decay_count : 17431444
[18278.211011]
cfs_rq[3]:/
[18278.211016] .exec_clock : 9560.433628
[18278.211020] .MIN_vruntime : 0.000001
[18278.211024] .min_vruntime : 7812.250380
[18278.211027] .max_vruntime : 0.000001
[18278.211031] .spread : 0.000000
[18278.211034] .spread0 : -167.444633
[18278.211038] .nr_spread_over : 35
[18278.211041] .nr_running : 0
[18278.211044] .load : 0
[18278.211047] .runnable_load_avg : 0
[18278.211050] .blocked_load_avg : 0
[18278.211054] .tg_load_contrib : 0
[18278.211057] .tg_runnable_contrib : 12
[18278.211060] .tg_load_avg : 554
[18278.211064] .tg->runnable_avg : 507
[18278.211067] .tg->cfs_bandwidth.timer_active: 0
[18278.211070] .throttled : 0
[18278.211073] .throttle_count : 0
[18278.211077] .avg->runnable_avg_sum : 599
[18278.211080] .avg->runnable_avg_period : 47751
[18278.211084]
rt_rq[3]:/
[18278.211088] .rt_nr_running : 0
[18278.211092] .rt_throttled : 0
[18278.211095] .rt_time : 0.000000
[18278.211099] .rt_runtime : 950.000000
[18278.211102]
runnable tasks:
task PID tree-key switches prio exec-runtime sum-exec sum-sleep
----------------------------------------------------------------------------------------------------------
[18278.211109] systemd 1 661.073836 2090 120 661.073836 957.362208 18277204.459858 0 /autogroup-2
[18278.211122] watchdog/3 22 -5.976746 4567 0 -5.976746 101.109125 0.000000 0 /
[18278.211131] migration/3 23 0.000000 107 0 0.000000 5.651260 0.000000 0 /
[18278.211141] ksoftirqd/3 24 7802.873509 4309 120 7802.873509 169.391611 18264149.354664 0 /
[18278.211151] kworker/3:0H 26 550.155136 7 100 550.155136 0.048448 1484.681011 0 /
[18278.211161] khelper 27 7.964692 2 100 7.964692 0.014908 0.005697 0 /
[18278.211170] netns 29 26.057102 2 100 26.057102 0.023047 0.005816 0 /
[18278.211180] writeback 31 44.081234 2 100 44.081234 0.007418 0.002039 0 /
[18278.211190] ksmd 32 53.091945 2 125 53.091945 0.007793 0.002249 0 /
[18278.211200] kworker/3:1 38 7803.933329 30195 120 7803.933329 1178.356198 18276141.922810 0 /
[18278.211211] scsi_tmf_6 96 507.104702 2 100 507.104702 0.009548 0.009052 0 /
[18278.211221] scsi_eh_9 107 527.668794 24 120 527.668794 0.420877 487.375164 0 /
[18278.211231] kworker/3:1H 124 7562.875528 299 100 7562.875528 8.507854 16664544.110267 0 /
[18278.211241] edac-poller 227 1018.154494 2 100 1018.154494 0.031027 0.016345 0 /
[18278.211252] named 373 3.566353 167 120 3.566353 3.435640 18024084.072643 0 /autogroup-27
[18278.211262] named 374 0.469168 5 120 0.469168 0.210493 583.994025 0 /autogroup-27
[18278.211272] smbd 377 4208.674038 1917 120 4208.674038 1096.417422 18215945.820318 0 /autogroup-35
[18278.211283] systemd 398 14.585524 20 120 14.585524 26.108250 127396.306380 0 /autogroup-37
[18278.211293] (sd-pam) 399 8.145992 2 120 8.145992 0.194576 0.000000 0 /autogroup-37
[18278.211303] zsh 401 900.779414 582 120 900.779414 324.360011 234863.546190 0 /autogroup-38
[18278.211314] btrfs-worker-hi 510 2622.965331 2 100 2622.965331 0.024545 0.009680 0 /
[18278.211325] btrfs-cleaner 535 7802.684648 596 120 7802.684648 17.986146 17745742.094767 0 /
[18278.211334] sshd 578 44.195032 4042 120 44.195032 520.727780 17666173.795735 0 /autogroup-39
[18278.211345] zsh 580 420.882135 724 120 420.882135 345.301299 17664795.585384 0 /autogroup-40
[18278.211355] btrfs_vserver.s 682 948.515214 14 120 948.515214 11.309807 31295.594534 0 /autogroup-38
[18278.211365] rsync 696 960.192733 57 120 960.192733 23.863283 549.709619 0 /autogroup-38
[18278.211376] kworker/u16:6 702 7803.097114 3302 120 7803.097114 334.630207 17579694.968254 0 /
[18278.211386] kworker/3:0 1515 7562.880576 4 120 7562.880576 0.038685 113728.381369 0 /
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs
2014-06-17 21:35 commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs Konstantinos Skarlatos
2014-06-17 21:38 ` Konstantinos Skarlatos
@ 2014-06-18 2:11 ` Jens Axboe
2014-06-18 7:21 ` Konstantinos Skarlatos
1 sibling, 1 reply; 5+ messages in thread
From: Jens Axboe @ 2014-06-18 2:11 UTC (permalink / raw)
To: Konstantinos Skarlatos, linux-kernel; +Cc: linux-btrfs
[-- Attachment #1: Type: text/plain, Size: 1131 bytes --]
On 2014-06-17 14:35, Konstantinos Skarlatos wrote:
> Hi all,
> with 3.16-rc1 rsync stops writing to my btrfs filesystem and stays at a
> D+ state.
> git bisect showed that the problematic commit is:
>
> 762380ad9322951cea4ce9d24864265f9c66a916 is the first bad commit
> commit 762380ad9322951cea4ce9d24864265f9c66a916
> Author: Jens Axboe <axboe@fb.com>
> Date: Thu Jun 5 13:38:39 2014 -0600
>
> block: add notion of a chunk size for request merging
>
> Some drivers have different limits on what size a request should
> optimally be, depending on the offset of the request. Similar to
> dividing a device into chunks. Add a setting that allows the driver
> to inform the block layer of such a chunk size. The block layer will
> then prevent merging across the chunks.
>
> This is needed to optimally support NVMe with a non-zero stripe size.
>
> Signed-off-by: Jens Axboe <axboe@fb.com>
That's odd, should not have any effect since nobody enables stripe sizes
in the kernel. I'll double check, perhaps it's not always being cleared.
Ah wait, does the attached help?
--
Jens Axboe
[-- Attachment #2: max-sectors.patch --]
[-- Type: text/x-patch, Size: 468 bytes --]
diff --git a/include/linux/blkdev.h b/include/linux/blkdev.h
index 31e11051f1ba..713f8b62b435 100644
--- a/include/linux/blkdev.h
+++ b/include/linux/blkdev.h
@@ -920,7 +920,7 @@ static inline unsigned int blk_max_size_offset(struct request_queue *q,
sector_t offset)
{
if (!q->limits.chunk_sectors)
- return q->limits.max_hw_sectors;
+ return q->limits.max_sectors;
return q->limits.chunk_sectors -
(offset & (q->limits.chunk_sectors - 1));
^ permalink raw reply related [flat|nested] 5+ messages in thread
* Re: commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs
2014-06-18 2:11 ` Jens Axboe
@ 2014-06-18 7:21 ` Konstantinos Skarlatos
2014-06-18 16:02 ` Jens Axboe
0 siblings, 1 reply; 5+ messages in thread
From: Konstantinos Skarlatos @ 2014-06-18 7:21 UTC (permalink / raw)
To: Jens Axboe, linux-kernel; +Cc: linux-btrfs
On 18/6/2014 5:11 πμ, Jens Axboe wrote:
> On 2014-06-17 14:35, Konstantinos Skarlatos wrote:
>> Hi all,
>> with 3.16-rc1 rsync stops writing to my btrfs filesystem and stays at a
>> D+ state.
>> git bisect showed that the problematic commit is:
>>
>> 762380ad9322951cea4ce9d24864265f9c66a916 is the first bad commit
>> commit 762380ad9322951cea4ce9d24864265f9c66a916
>> Author: Jens Axboe <axboe@fb.com>
>> Date: Thu Jun 5 13:38:39 2014 -0600
>>
>> block: add notion of a chunk size for request merging
>>
>> Some drivers have different limits on what size a request should
>> optimally be, depending on the offset of the request. Similar to
>> dividing a device into chunks. Add a setting that allows the driver
>> to inform the block layer of such a chunk size. The block layer
>> will
>> then prevent merging across the chunks.
>>
>> This is needed to optimally support NVMe with a non-zero stripe
>> size.
>>
>> Signed-off-by: Jens Axboe <axboe@fb.com>
>
> That's odd, should not have any effect since nobody enables stripe
> sizes in the kernel. I'll double check, perhaps it's not always being
> cleared.
>
> Ah wait, does the attached help?
Yes, it works! I recompiled at commit
762380ad9322951cea4ce9d24864265f9c66a916 with your patch and it looks
ok. Rebooted back to the unpatched kernel and the bug showed up again
immediately.
The funny thing is that the problem only showed on my (multi-disk) btrfs
filesystem. / which is on ext4 seems to work fine.
>
>
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs
2014-06-18 7:21 ` Konstantinos Skarlatos
@ 2014-06-18 16:02 ` Jens Axboe
0 siblings, 0 replies; 5+ messages in thread
From: Jens Axboe @ 2014-06-18 16:02 UTC (permalink / raw)
To: Konstantinos Skarlatos, linux-kernel; +Cc: linux-btrfs
On 2014-06-18 00:21, Konstantinos Skarlatos wrote:
> On 18/6/2014 5:11 πμ, Jens Axboe wrote:
>> On 2014-06-17 14:35, Konstantinos Skarlatos wrote:
>>> Hi all,
>>> with 3.16-rc1 rsync stops writing to my btrfs filesystem and stays at a
>>> D+ state.
>>> git bisect showed that the problematic commit is:
>>>
>>> 762380ad9322951cea4ce9d24864265f9c66a916 is the first bad commit
>>> commit 762380ad9322951cea4ce9d24864265f9c66a916
>>> Author: Jens Axboe <axboe@fb.com>
>>> Date: Thu Jun 5 13:38:39 2014 -0600
>>>
>>> block: add notion of a chunk size for request merging
>>>
>>> Some drivers have different limits on what size a request should
>>> optimally be, depending on the offset of the request. Similar to
>>> dividing a device into chunks. Add a setting that allows the driver
>>> to inform the block layer of such a chunk size. The block layer
>>> will
>>> then prevent merging across the chunks.
>>>
>>> This is needed to optimally support NVMe with a non-zero stripe
>>> size.
>>>
>>> Signed-off-by: Jens Axboe <axboe@fb.com>
>>
>> That's odd, should not have any effect since nobody enables stripe
>> sizes in the kernel. I'll double check, perhaps it's not always being
>> cleared.
>>
>> Ah wait, does the attached help?
>
> Yes, it works! I recompiled at commit
> 762380ad9322951cea4ce9d24864265f9c66a916 with your patch and it looks
> ok. Rebooted back to the unpatched kernel and the bug showed up again
> immediately.
>
> The funny thing is that the problem only showed on my (multi-disk) btrfs
> filesystem. / which is on ext4 seems to work fine.
Probably because the multi-disk setup doesn't have hw_sectors set, I'm
guessing. But great, I'll get this upstream asap. Thanks for testing!
--
Jens Axboe
^ permalink raw reply [flat|nested] 5+ messages in thread
end of thread, other threads:[~2014-06-18 16:04 UTC | newest]
Thread overview: 5+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2014-06-17 21:35 commit 762380a "block: add notion of a chunk size for request merging" stops io on btrfs Konstantinos Skarlatos
2014-06-17 21:38 ` Konstantinos Skarlatos
2014-06-18 2:11 ` Jens Axboe
2014-06-18 7:21 ` Konstantinos Skarlatos
2014-06-18 16:02 ` Jens Axboe
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.