dmesg_3.4

[    9.823042] ioatdma 0000:00:16.3: enabling device (0000 -> 0002)
[    9.823205] ioatdma 0000:00:16.3: irq 76 for MSI/MSI-X
[    9.823683] ioatdma 0000:00:16.4: enabling device (0000 -> 0002)
[    9.823838] ioatdma 0000:00:16.4: irq 77 for MSI/MSI-X
[    9.824289] ioatdma 0000:00:16.5: enabling device (0000 -> 0002)
[    9.824447] ioatdma 0000:00:16.5: irq 78 for MSI/MSI-X
[    9.824898] ioatdma 0000:00:16.6: enabling device (0000 -> 0002)
[    9.825054] ioatdma 0000:00:16.6: irq 79 for MSI/MSI-X
[    9.825593] ioatdma 0000:00:16.7: enabling device (0000 -> 0002)
[    9.825749] ioatdma 0000:00:16.7: irq 80 for MSI/MSI-X
[   10.020108] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro
[   10.097360] kvm: VM_EXIT_LOAD_IA32_PERF_GLOBAL_CTRL does not work properly. Using workaround
[   10.301474] type=1400 audit(1395163080.604:11): apparmor="STATUS" operation="profile_load" name="/usr/sbin/named" pid=1111 comm="apparmor_parser"
[   10.445954] RPC: Registered named UNIX socket transport module.
[   10.445958] RPC: Registered udp transport module.
[   10.445960] RPC: Registered tcp transport module.
[   10.445962] RPC: Registered tcp NFSv4.1 backchannel transport module.
[   10.689227] NFS: Registering the id_resolver key type
[   12.093160] e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx/Tx
[   12.094563] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   12.176937] svc: failed to register lockdv1 RPC service (errno 97).
[   14.131165] Bridge firewalling registered
[   14.137804] ADDRCONF(NETDEV_UP): virbr0: link is not ready
[   14.194546] ip_tables: (C) 2000-2006 Netfilter Core Team
[   14.669926] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[   14.921248] Installing knfsd (copyright (C) 1996 [email protected]).
[   14.990902] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory
[   15.002607] NFSD: starting 90-second grace period
[   22.754434] eth0: no IPv6 routers present
[ 1475.279723] nitro: new VM created, creating process: 3638
[ 1495.540196] ------------[ cut here ]------------
[ 1495.540199] kernel BUG at kernel/rtmutex_common.h:82!
[ 1495.540201] invalid opcode: 0000 [#1] PREEMPT SMP 
[ 1495.540204] CPU 3 
[ 1495.540205] Modules linked in: ipt_MASQUERADE iptable_nat nf_nat nfsd nf_conntrack_ipv4 nf_defrag_ipv4 xt_state nf_conntrack exportfs ipt_REJECT xt_tcpudp iptable_filter ip_tables x_tables bridge stp nfs lockd auth_rpcgss nfs_acl sunrpc kvm_intel kvm ioatdma coretemp psmouse crc32c_intel lp microcode parport dca serio_raw joydev usbhid hid e1000e
[ 1495.540230] 
[ 1495.540232] Pid: 3673, comm: nitro Not tainted 3.4.82-nitro+ #4 empty empty/S7002
[ 1495.540235] RIP: 0010:[<ffffffff810af909>]  [<ffffffff810af909>] task_blocks_on_rt_mutex+0x259/0x270
[ 1495.540243] RSP: 0018:ffff8801b1f47cb8  EFLAGS: 00010082
[ 1495.540245] RAX: ffff88032a4dd1e8 RBX: ffff8801b1f47d68 RCX: 0000000000000000
[ 1495.540247] RDX: ffff8801b0148e10 RSI: ffffffffa02598c8 RDI: ffff8801b0148740
[ 1495.540249] RBP: ffff8801b1f47d28 R08: 0000000000000000 R09: 0000000000000000
[ 1495.540251] R10: 0000000000000001 R11: 0000000000000000 R12: ffff8801b0148740
[ 1495.540253] R13: ffffffffa02598c0 R14: ffffea000b24eb69 R15: 0000000000000000
[ 1495.540255] FS:  00007f2fa896b700(0000) GS:ffff8801bfc60000(0000) knlGS:0000000000000000
[ 1495.540257] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 1495.540259] CR2: 00007f2fa84b0c30 CR3: 00000001b0286000 CR4: 00000000000027e0
[ 1495.540261] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 1495.540263] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[ 1495.540265] Process nitro (pid: 3673, threadinfo ffff8801b1f46000, task ffff8801b0148740)
[ 1495.540266] Stack:
[ 1495.540268]  ffff8801a9675580 ffff8801aa755800 ffff8801b1f47ce8 ffffffff810836a1
[ 1495.540271]  00007f2fa84b0000 ffff88032a4dd1e8 0000000000000286 ffff8801b0148e08
[ 1495.540275]  ffff8801a9675580 ffffffffa02598c0 ffff8801b0148740 ffff8801b0148e08
[ 1495.540278] Call Trace:
[ 1495.540282]  [<ffffffff810836a1>] ? get_parent_ip+0x11/0x50
[ 1495.540288]  [<ffffffff8160a432>] rt_spin_lock_slowlock+0xb2/0x2c0
[ 1495.540291]  [<ffffffff810836a1>] ? get_parent_ip+0x11/0x50
[ 1495.540295]  [<ffffffff8160ac86>] rt_spin_lock+0x26/0x30
[ 1495.540309]  [<ffffffffa020b211>] nitro_iotcl_num_vms+0x21/0x80 [kvm]
[ 1495.540319]  [<ffffffffa02120bd>] kvm_dev_ioctl+0x15d/0x600 [kvm]
[ 1495.540323]  [<ffffffff81182dd3>] do_vfs_ioctl+0x93/0x510
[ 1495.540326]  [<ffffffff811832f1>] sys_ioctl+0xa1/0xb0
[ 1495.540330]  [<ffffffff81612669>] system_call_fastpath+0x16/0x1b
[ 1495.540331] Code: 00 00 e9 2c fe ff ff 0f 1f 00 48 89 5d b8 e9 9c fe ff ff 48 8b 75 c0 48 8b 7d c8 e8 92 b8 55 00 b8 f5 ff ff ff eb bd 0f 0b eb fe <0f> 0b eb fe 0f 0b eb fe e8 9a 9c 55 00 e9 ed fe ff ff 0f 1f 44 
[ 1495.540360] RIP  [<ffffffff810af909>] task_blocks_on_rt_mutex+0x259/0x270
[ 1495.540364]  RSP <ffff8801b1f47cb8>
[ 1495.543672] ---[ end trace 0000000000000002 ]---
[ 1555.429870] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=6002 jiffies)
[ 1555.429876] INFO: Stall ended before state dump start
[ 1735.181459] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=24007 jiffies)
[ 1735.181463] INFO: Stall ended before state dump start
[ 1914.933047] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=42012 jiffies)
[ 1914.933052] INFO: Stall ended before state dump start
[ 2094.684637] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=60017 jiffies)
[ 2094.684642] INFO: Stall ended before state dump start
[ 2274.436526] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=78022 jiffies)
[ 2274.436533] INFO: Stall ended before state dump start
[ 2454.188111] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=96027 jiffies)
[ 2454.188117] INFO: Stall ended before state dump start
[ 2633.939704] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=114032 jiffies)
[ 2633.939710] INFO: Stall ended before state dump start
[ 2813.691293] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=132037 jiffies)
[ 2813.691299] INFO: Stall ended before state dump start
[ 2993.442877] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=150042 jiffies)
[ 2993.442883] INFO: Stall ended before state dump start
[ 3173.194468] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=168047 jiffies)
[ 3173.194475] INFO: Stall ended before state dump start
[ 3352.946059] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=186052 jiffies)
[ 3352.946065] INFO: Stall ended before state dump start
[ 3532.697652] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=204057 jiffies)
[ 3532.697658] INFO: Stall ended before state dump start
[ 3712.449248] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=222062 jiffies)
[ 3712.449254] INFO: Stall ended before state dump start
[ 3892.200831] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=240067 jiffies)
[ 3892.200837] INFO: Stall ended before state dump start
[ 4071.952418] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=258072 jiffies)
[ 4071.952425] INFO: Stall ended before state dump start
[ 4251.704009] INFO: rcu_preempt detected stalls on CPUs/tasks: { 3} (detected by 5, t=276077 jiffies)
[ 4251.704015] INFO: Stall ended before state dump start