From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1753468AbcC3OQs (ORCPT ); Wed, 30 Mar 2016 10:16:48 -0400 Received: from mail-pa0-f53.google.com ([209.85.220.53]:34792 "EHLO mail-pa0-f53.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751379AbcC3OQp (ORCPT ); Wed, 30 Mar 2016 10:16:45 -0400 Date: Wed, 30 Mar 2016 22:15:52 +0800 From: Boqun Feng To: "Paul E. McKenney" Cc: Peter Zijlstra , Jacob Pan , Josh Triplett , Ross Green , Mathieu Desnoyers , John Stultz , Thomas Gleixner , lkml , Ingo Molnar , Lai Jiangshan , dipankar@in.ibm.com, Andrew Morton , rostedt , David Howells , Eric Dumazet , Darren Hart , =?iso-8859-1?Q?Fr=E9d=E9ric?= Weisbecker , Oleg Nesterov , pranith kumar , "Chatre, Reinette" Subject: Re: rcu_preempt self-detected stall on CPU from 4.5-rc3, since 3.17 Message-ID: <20160330141552.GA25236@fixme-laptop.cn.ibm.com> References: <20160226005638.GV3522@linux.vnet.ibm.com> <20160318210011.GA571@cloud> <20160318235641.GH4287@linux.vnet.ibm.com> <20160321092230.75f23fa9@yairi> <20160327205439.GY6356@twins.programming.kicks-ass.net> <20160327210914.GD4287@linux.vnet.ibm.com> <20160328062851.GE6344@twins.programming.kicks-ass.net> <20160328132932.GF4287@linux.vnet.ibm.com> <20160330125837.GC14352@fixme-laptop.cn.ibm.com> <20160330133038.GE4287@linux.vnet.ibm.com> MIME-Version: 1.0 Content-Type: multipart/signed; micalg=pgp-sha256; protocol="application/pgp-signature"; boundary="cmJC7u66zC7hs+87" Content-Disposition: inline In-Reply-To: <20160330133038.GE4287@linux.vnet.ibm.com> User-Agent: Mutt/1.5.24 (2015-08-30) Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org --cmJC7u66zC7hs+87 Content-Type: multipart/mixed; boundary="HlL+5n6rz5pIUxbD" Content-Disposition: inline --HlL+5n6rz5pIUxbD Content-Type: text/plain; charset=us-ascii Content-Disposition: inline Content-Transfer-Encoding: quoted-printable On Wed, Mar 30, 2016 at 06:30:38AM -0700, Paul E. McKenney wrote: [...] > > >=20 > >=20 > > I ran several tests similar to this setup in a guest, the guest was > > running in a 12-core Xeon X5690 host with kernel 4.4.5. The guest was > > given 16 VCPUs and 2G memory. > >=20 > > Rather than RCU stall warnings, I was able to see a bug like this nearly To be accurate, I did see RCU stall warnings, after the NULL pointer dereference, but for every run, the NULL pointer dereference always happened first.=20 > > *everytime*: > >=20 > > [ 308.291635] BUG: unable to handle kernel NULL pointer dereference at= (null) > > [ 308.292063] IP: [] migrate_timer_list+0x32/0xc0 >=20 > New one on me! >=20 > > [ 308.292063] PGD 0=20 > > [ 308.292063] Oops: 0002 [#1] PREEMPT SMP=20 > > [ 308.292063] Modules linked in: > > [ 308.292063] CPU: 11 PID: 798 Comm: torture_onoff Not tainted 4.5.0-r= c1+ #14 > > [ 308.292063] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), B= IOS 1.9.1-20160216_104851-anatol 04/01/2014 > > [ 308.292063] task: ffff88007cafcb00 ti: ffff88007c6f4000 task.ti: fff= f88007c6f4000 > > [ 308.292063] RIP: 0010:[] [] mig= rate_timer_list+0x32/0xc0 > > [ 308.292063] RSP: 0018:ffff88007c6f7c98 EFLAGS: 00010086 > > [ 308.292063] RAX: dead000000000200 RBX: ffff88007fb6cc00 RCX: ffff880= 07fa2cc00 > > [ 308.292063] RDX: 0000000000000000 RSI: ffff88007fa2d6d0 RDI: ffff880= 07fb6cc00 > > [ 308.292063] RBP: ffff88007c6f7cc0 R08: 0000000000000000 R09: fffffff= f81e4d360 > > [ 308.292063] R10: ffffea0001f2daa0 R11: 0000000000000000 R12: ffff880= 07fa2d6d0 > > [ 308.292063] R13: ffff88007fb6cc00 R14: 000000000000000b R15: ffff880= 07fa2c420 > > [ 308.292063] FS: 0000000000000000(0000) GS:ffff88007fb60000(0000) kn= lGS:0000000000000000 > > [ 308.292063] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b > > [ 308.292063] CR2: 0000000000000000 CR3: 0000000001e0f000 CR4: 0000000= 0000006e0 > > [ 308.292063] Stack: > > [ 308.292063] ffff88007fb6cc00 ffff88007fa2d6d8 ffff88007fa2dad0 ffff= 88007fa2d8d0 > > [ 308.292063] ffff88007fa2d4d8 ffff88007c6f7d08 ffffffff810b95c4 ffff= 88007fa2cc00 > > [ 308.292063] ffff88007fa2d648 00000000fffffff0 ffffffff81e4e0c0 0000= 000000000007 > > [ 308.292063] Call Trace: > > [ 308.292063] [] timer_cpu_notify+0xe4/0x160 > > [ 308.292063] [] notifier_call_chain+0x45/0x70 > > [ 308.292063] [] __raw_notifier_call_chain+0x9/0x10 > > [ 308.292063] [] cpu_notify_nofail+0x1e/0x30 > > [ 308.292063] [] _cpu_down+0x212/0x350 > > [ 308.292063] [] ? __call_rcu.constprop.74+0x380/0x= 380 > > [ 308.292063] [] ? call_rcu_bh+0x20/0x20 > > [ 308.292063] [] ? __rcu_read_unlock+0x50/0x50 > > [ 308.292063] [] ? __rcu_read_unlock+0x50/0x50 > > [ 308.292063] [] cpu_down+0x2f/0x50 > > [ 308.292063] [] torture_onoff+0x115/0x380 > > [ 308.292063] [] ? torture_kthread_stopping+0x70/0x= 70 > > [ 308.292063] [] kthread+0xd6/0xf0 > > [ 308.292063] [] ? kthread_worker_fn+0x180/0x180 > > [ 308.292063] [] ret_from_fork+0x3f/0x70 > > [ 308.292063] [] ? kthread_worker_fn+0x180/0x180 > > [ 308.292063] Code: 56 41 55 41 54 53 48 8b 06 44 8b 77 40 48 85 c0 74= 53 49 89 fd 49 89 f4 4d 8b 3c 24 66 66 66 66 90 49 8b 07 49 8b 57 08 48 85= c0 <48> 89 02 74 04 48 89 50 08 48 b8 00 02 00 00 00 00 ad de 4c 89=20 > > [ 308.292063] RIP [] migrate_timer_list+0x32/0xc0 > > [ 308.292063] RSP > > [ 308.292063] CR2: 0000000000000000 > > [ 308.292063] ---[ end trace 29cb5d70ad875872 ]--- > >=20 > >=20 > > I'm not sure whether this is relevant, maybe this was caused by my > > setup? But I attach two kernel logs and my config in case this could > > help us solve the problem. > >=20 > > Another interesting I observed was that the time stamps of printk went > > back in a while in some run, please note the log named "dmesg.1" in the > > attachments. >=20 > That can cause all sorts of problems, including RCU CPU stall warnings. >=20 > So I see the following in dmesg.1, courtesy of: >=20 > sed -e 's/].*$//' < /tmp/dmesg.1 | awk '{ if (oldtime !=3D "" && oldtime = > $2) print; oldtime =3D $2 }' >=20 > 1.128644 -> 1.128642: Only two microseconds backwards, so not enough > to cause a stall warning (need about 21 seconds for that). > 1.143582 -> 1.143575: Seven microseconds backwards. > 316.386056 -> 421.191446: 104.8 seconds backwards, plenty to cause > all sorts of problems, including stall warnings. > 311.122004 -> 316.338053: 5.2 seconds backwards, can cause all sorts > of problems, but not likely stall warnings. >=20 > > A quick analysis of this bug is the null dereference happened at: > >=20 > > migrate_timer_list() > > detach_timer(); > > __list_del(); > > WRITE_ONCE(*pprev, next); <- pprev is NULL > >=20 > > This seems highly unlikely, but as I said, I hit this almost every time > > after a few minutes of starting rcutoture. >=20 > Looks like a malformed list, which does look quite ugly. No idea > whether or not this could be related to backwards-going time, but > fixing the backwards-going time is a good first step. >=20 > > Any idea about whether this could be related to the RCU stall problem, > > or this is another bug, or this actually happend by design for some > > reasons? >=20 > One of your backwards-time incidents could cause both the RCU CPU stall > warnings and also the soft lockup I see there. >=20 > If this is an older system, it might have an unreliable TSC. If the > kernel is nevertheless using TSC, this sort of thing could happen. > The usual advice is to boot using HPET, but perhaps others on the > list have more specific advice. >=20 I tried another run, the kernel was compiled with HPET=3Dy and boot parameters "hpet=3Dforce notsc" and I still hit the same problem, any suggestion for me to go further to get rid of TSC's impact? Kernel log attached. Regards, Boqun > Thanx, Paul >=20 --HlL+5n6rz5pIUxbD Content-Type: text/plain; charset=us-ascii Content-Disposition: attachment; filename="dmesg.3" Content-Transfer-Encoding: quoted-printable [ 0.000000] Linux version 4.5.0-rc1+ (root@insomnia) (gcc version 5.3.0 = (GCC) ) #14 SMP PREEMPT Wed Mar 30 20:01:04 CST 2016=0D [ 0.000000] Command line: hpet=3Dforce notsc selinux=3D0 console=3DttyS0= rcutorture.onoff_interval=3D1 rcutorture.onff_holdoff=3D30=0D [ 0.000000] x86/fpu: Legacy x87 FPU detected.=0D [ 0.000000] x86/fpu: Using 'lazy' FPU context switches.=0D [ 0.000000] e820: BIOS-provided physical RAM map:=0D [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usabl= e=0D [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reser= ved=0D [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reser= ved=0D [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffdefff] usabl= e=0D [ 0.000000] BIOS-e820: [mem 0x000000007ffdf000-0x000000007fffffff] reser= ved=0D [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reser= ved=0D [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reser= ved=0D [ 0.000000] NX (Execute Disable) protection: active=0D [ 0.000000] SMBIOS 2.8 present.=0D [ 0.000000] e820: last_pfn =3D 0x7ffdf max_arch_pfn =3D 0x400000000=0D [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- WT= =0D [ 0.000000] found SMP MP-table at [mem 0x000f6a50-0x000f6a5f] mapped at = [ffff8800000f6a50]=0D [ 0.000000] Scanning 1 areas for low memory corruption=0D [ 0.000000] Using GB pages for direct mapping=0D [ 0.000000] RAMDISK: [mem 0x7fcd4000-0x7ffcffff]=0D [ 0.000000] ACPI: Early table checksum verification disabled=0D [ 0.000000] ACPI: RSDP 0x00000000000F6A00 000014 (v00 BOCHS )=0D [ 0.000000] ACPI: RSDT 0x000000007FFE1580 000034 (v01 BOCHS BXPCRSDT 00= 000001 BXPC 00000001)=0D [ 0.000000] ACPI: FACP 0x000000007FFE061A 000074 (v01 BOCHS BXPCFACP 00= 000001 BXPC 00000001)=0D [ 0.000000] ACPI: DSDT 0x000000007FFDFA80 000B9A (v01 BOCHS BXPCDSDT 00= 000001 BXPC 00000001)=0D [ 0.000000] ACPI: FACS 0x000000007FFDFA40 000040=0D [ 0.000000] ACPI: SSDT 0x000000007FFE068E 000DCA (v01 BOCHS BXPCSSDT 00= 000001 BXPC 00000001)=0D [ 0.000000] ACPI: APIC 0x000000007FFE1458 0000F0 (v01 BOCHS BXPCAPIC 00= 000001 BXPC 00000001)=0D [ 0.000000] ACPI: HPET 0x000000007FFE1548 000038 (v01 BOCHS BXPCHPET 00= 000001 BXPC 00000001)=0D [ 0.000000] No NUMA configuration found=0D [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000007ffdefff]= =0D [ 0.000000] NODE_DATA(0) allocated [mem 0x7ffdb000-0x7ffdefff]=0D [ 0.000000] Zone ranges:=0D [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]=0D [ 0.000000] DMA32 [mem 0x0000000001000000-0x000000007ffdefff]=0D [ 0.000000] Normal empty=0D [ 0.000000] Movable zone start for each node=0D [ 0.000000] Early memory node ranges=0D [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]=0D [ 0.000000] node 0: [mem 0x0000000000100000-0x000000007ffdefff]=0D [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffde= fff]=0D [ 0.000000] ACPI: PM-Timer IO Port: 0x608=0D [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])=0D [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-= 23=0D [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)=0D [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)= =0D [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)= =0D [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level= )=0D [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level= )=0D [ 0.000000] Using ACPI (MADT) for SMP configuration information=0D [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000=0D [ 0.000000] smpboot: Allowing 16 CPUs, 0 hotplug CPUs=0D [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]=0D [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]=0D [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]=0D [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]=0D [ 0.000000] e820: [mem 0x80000000-0xfeffbfff] available for PCI devices= =0D [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0= xffffffff, max_idle_ns: 1910969940391419 ns=0D [ 0.000000] setup_percpu: NR_CPUS:16 nr_cpumask_bits:16 nr_cpu_ids:16 nr= _node_ids:1=0D [ 0.000000] PERCPU: Embedded 32 pages/cpu @ffff88007fa00000 s92008 r8192= d30872 u131072=0D [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Tota= l pages: 515944=0D [ 0.000000] Policy zone: DMA32=0D [ 0.000000] Kernel command line: hpet=3Dforce notsc selinux=3D0 console= =3DttyS0 rcutorture.onoff_interval=3D1 rcutorture.onff_holdoff=3D30=0D [ 0.000000] tsc: Kernel compiled with CONFIG_X86_TSC, cannot disable TSC= completely=0D [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)=0D [ 0.000000] Memory: 2040780K/2096628K available (8931K kernel code, 1258= K rwdata, 3700K rodata, 1092K init, 984K bss, 55848K reserved, 0K cma-reser= ved)=0D [ 0.000000] SLUB: HWalign=3D64, Order=3D0-3, MinObjects=3D0, CPUs=3D16, = Nodes=3D1=0D [ 0.000000] Preemptible hierarchical RCU implementation.=0D [ 0.000000] RCU debugfs-based tracing is enabled.=0D [ 0.000000] CONFIG_RCU_FANOUT set to non-default value of 2=0D [ 0.000000] RCU torture testing starts during boot.=0D [ 0.000000] Four(or more)-level hierarchy is enabled.=0D [ 0.000000] Build-time adjustment of leaf fanout to 2.=0D [ 0.000000] RCU kthread priority: 2.=0D [ 0.000000] NR_IRQS:4352 nr_irqs:552 16=0D [ 0.000000] Console: colour *CGA 80x25=0D [ 0.000000] console [ttyS0] enabled=0D [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, = max_idle_ns: 19112604467 ns=0D [ 0.000000] tsc: Fast TSC calibration using PIT=0D [ 0.000000] tsc: Detected 3467.095 MHz processor=0D [ 0.003000] Calibrating delay loop... 3416.06 BogoMIPS (lpj=3D1708032)=0D [ 0.009000] pid_max: default: 32768 minimum: 301=0D [ 0.009000] ACPI: Core revision 20160108=0D [ 0.010000] ACPI: 2 ACPI AML tables successfully acquired and loaded=0D [ 0.011000] =0D [ 0.011000] Security Framework initialized=0D [ 0.011000] SELinux: Disabled at boot.=0D [ 0.012000] Dentry cache hash table entries: 262144 (order: 9, 2097152 b= ytes)=0D [ 0.013000] Inode-cache hash table entries: 131072 (order: 8, 1048576 by= tes)=0D [ 0.013000] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes)= =0D [ 0.014000] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 b= ytes)=0D [ 0.015000] mce: CPU supports 10 MCE banks=0D [ 0.015000] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0=0D [ 0.016000] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0=0D [ 0.017000] Freeing SMP alternatives memory: 32K (ffffffff8204d000 - fff= fffff82055000)=0D [ 0.018000] Switched APIC routing to physical flat.=0D [ 0.019000] ..TIMER: vector=3D0x30 apic1=3D0 pin1=3D2 apic2=3D-1 pin2=3D= -1=0D [ 0.029000] smpboot: CPU0: Intel(R) Xeon(R) CPU X5690 @ 3.47G= Hz (family: 0x6, model: 0x2c, stepping: 0x2)=0D [ 0.030000] Performance Events: 16-deep LBR, Westmere events, Intel PMU = driver.=0D [ 0.030000] perf_event_intel: CPUID marked event: 'bus cycles' unavailab= le=0D [ 0.031000] ... version: 2=0D [ 0.031000] ... bit width: 48=0D [ 0.031000] ... generic registers: 4=0D [ 0.032000] ... value mask: 0000ffffffffffff=0D [ 0.032000] ... max period: 000000007fffffff=0D [ 0.032000] ... fixed-purpose events: 3=0D [ 0.033000] ... event mask: 000000070000000f=0D [ 0.042000] x86: Booting SMP configuration:=0D [ 0.042000] .... node #0, CPUs: #1 #2 #3 #4 #5 #6 #7 #8 = #9 #10 #11 #12 #13 #14 #15=0D [ 0.200000] x86: Booted up 1 node, 16 CPUs=0D [ 0.200000] smpboot: Total of 16 processors activated (49061.88 BogoMIPS= )=0D [ 0.203000] devtmpfs: initialized=0D [ 0.204000] kworker/u32:0 (98) used greatest stack depth: 14264 bytes le= ft=0D [ 0.204000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xfffffff= f, max_idle_ns: 1911260446275000 ns=0D [ 0.204000] RTC time: 14:05:24, date: 03/30/16=0D [ 0.204000] NET: Registered protocol family 16=0D [ 0.206000] kworker/u32:0 (106) used greatest stack depth: 13928 bytes l= eft=0D [ 0.211000] cpuidle: using governor menu=0D [ 0.211000] ACPI: bus type PCI registered=0D [ 0.211000] PCI: Using configuration type 1 for base access=0D [ 0.226000] HugeTLB registered 2 MB page size, pre-allocated 0 pages=0D [ 0.228000] ACPI: Added _OSI(Module Device)=0D [ 0.228000] ACPI: Added _OSI(Processor Device)=0D [ 0.229000] ACPI: Added _OSI(3.0 _SCP Extensions)=0D [ 0.229000] ACPI: Added _OSI(Processor Aggregator Device)=0D [ 0.231000] ACPI: Interpreter enabled=0D [ 0.232000] ACPI: (supports S0 S3 S4 S5)=0D [ 0.232000] ACPI: Using IOAPIC for interrupt routing=0D [ 0.232000] PCI: Using host bridge windows from ACPI; if necessary, use = "pci=3Dnocrs" and report a bug=0D [ 0.237000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])=0D [ 0.238000] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MS= I]=0D [ 0.238000] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM= =0D [ 0.239000] acpi PNP0A03:00: fail to add MMCONFIG information, can't acc= ess extended PCI configuration space under this bridge.=0D [ 0.240000] PCI host bridge to bus 0000:00=0D [ 0.240000] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window= ]=0D [ 0.241000] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window= ]=0D [ 0.241000] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bfff= f window]=0D [ 0.242000] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebffff= f window]=0D [ 0.242000] pci_bus 0000:00: root bus resource [bus 00-ff]=0D [ 0.246000] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x= 01f7]=0D [ 0.247000] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]=0D [ 0.247000] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x= 0177]=0D [ 0.247000] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]=0D [ 0.248000] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX= 4 ACPI=0D [ 0.248000] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX= 4 SMB=0D [ 0.250000] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)=0D [ 0.251000] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)=0D [ 0.251000] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)=0D [ 0.252000] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)=0D [ 0.252000] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)=0D [ 0.254000] ACPI: Enabled 16 GPEs in block 00 to 0F=0D [ 0.254000] vgaarb: loaded=0D [ 0.254000] SCSI subsystem initialized=0D [ 0.256000] ACPI: bus type USB registered=0D [ 0.256000] usbcore: registered new interface driver usbfs=0D [ 0.257000] usbcore: registered new interface driver hub=0D [ 0.257000] usbcore: registered new device driver usb=0D [ 0.258000] pps_core: LinuxPPS API ver. 1 registered=0D [ 0.258000] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo = Giometti =0D [ 0.259000] PTP clock support registered=0D [ 0.261000] Advanced Linux Sound Architecture Driver Initialized.=0D [ 0.261000] PCI: Using ACPI for IRQ routing=0D [ 0.262000] NetLabel: Initializing=0D [ 0.262000] NetLabel: domain hash size =3D 128=0D [ 0.262000] NetLabel: protocols =3D UNLABELED CIPSOv4=0D [ 0.263000] NetLabel: unlabeled traffic allowed by default=0D [ 0.263000] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0=0D [ 0.264000] hpet0: 3 comparators, 64-bit 100.000000 MHz counter=0D [ 0.269000] clocksource: Switched to clocksource hpet=0D [ 0.277032] VFS: Disk quotas dquot_6.6.0=0D [ 0.277276] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 byte= s)=0D [ 0.277276] pnp: PnP ACPI init=0D [ 0.279112] pnp: PnP ACPI: found 5 devices=0D [ 0.286022] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, m= ax_idle_ns: 2085701024 ns=0D [ 0.286116] NET: Registered protocol family 2=0D [ 0.286116] TCP established hash table entries: 16384 (order: 5, 131072 = bytes)=0D [ 0.287310] TCP bind hash table entries: 16384 (order: 7, 524288 bytes)= =0D [ 0.287310] TCP: Hash tables configured (established 16384 bind 16384)=0D [ 0.288622] UDP hash table entries: 1024 (order: 4, 98304 bytes)=0D [ 0.289225] UDP-Lite hash table entries: 1024 (order: 4, 98304 bytes)=0D [ 0.289225] NET: Registered protocol family 1=0D [ 0.291131] RPC: Registered named UNIX socket transport module.=0D [ 0.291131] RPC: Registered udp transport module.=0D [ 0.291399] RPC: Registered tcp transport module.=0D [ 0.291399] RPC: Registered tcp NFSv4.1 backchannel transport module.=0D [ 0.292367] pci 0000:00:00.0: Limiting direct PCI/PCI transfers=0D [ 0.292367] pci 0000:00:01.0: PIIX3: Enabling Passive Release=0D [ 0.293400] pci 0000:00:01.0: Activating ISA DMA hang workarounds=0D [ 0.293400] Unpacking initramfs...=0D [ 0.339036] Freeing initrd memory: 3056K (ffff88007fcd4000 - ffff88007ff= d0000)=0D [ 0.342028] Scanning for low memory corruption every 60 seconds=0D [ 0.342044] rcu-torture:--- Start of test: nreaders=3D15 nfakewriters=3D= 4 stat_interval=3D60 verbose=3D1 test_no_idle_hz=3D1 shuffle_interval=3D3 s= tutter=3D5 irqreader=3D1 fqs_duration=3D0 fqs_holdoff=3D0 fqs_stutter=3D3 t= est_boost=3D1/0 test_boost_interval=3D7 test_boost_duration=3D4 shutdown_se= cs=3D0 stall_cpu=3D0 stall_cpu_holdoff=3D10 n_barrier_cbs=3D0 onoff_interva= l=3D1 onoff_holdoff=3D0=0D [ 0.344754] rcu-torture: Creating rcu_torture_writer task=0D [ 0.345314] rcu-torture: Creating rcu_torture_fakewriter task=0D [ 0.345314] rcu-torture: rcu_torture_writer task started=0D [ 0.346409] rcu-torture: Creating rcu_torture_fakewriter task=0D [ 0.346409] rcu-torture: rcu_torture_fakewriter task started=0D [ 0.347428] rcu-torture: Grace periods expedited from boot/sysfs for rcu= ,=0D [ 0.347428] rcu-torture: Creating rcu_torture_fakewriter task=0D [ 0.348084] rcu-torture: rcu_torture_fakewriter task started=0D [ 0.348513] rcu-torture: Testing of dynamic grace-period expediting diab= led.=0D [ 0.349513] rcu-torture: Creating rcu_torture_fakewriter task=0D [ 0.349513] rcu-torture: rcu_torture_fakewriter task started=0D [ 0.349513] rcu-torture: Creating rcu_torture_reader task=0D [ 0.349513] rcu-torture: rcu_torture_fakewriter task started=0D [ 0.351030] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351040] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351040] rcu-torture: rcu_torture_reader task started=0D [ 0.351053] rcu-torture: Creating rcu_torture_reader task=0D [ 0.351097] rcu-torture: Creating rcu_torture_stats task=0D [ 0.351097] rcu-torture: rcu_torture_reader task started=0D [ 0.351163] rcu-torture: rcu_torture_reader task started=0D [ 0.351162] rcu-torture: Creating torture_shuffle task=0D [ 0.351162] rcu-torture: rcu_torture_stats task started=0D [ 0.351162] rcu-torture: Creating torture_stutter task=0D [ 0.351162] rcu-torture: torture_shuffle task started=0D [ 0.351162] rcu-torture: Creating torture_onoff task=0D [ 0.351162] rcu-torture: torture_stutter task started=0D [ 0.351162] rcu-torture: Creating rcu_torture_cbflood task=0D [ 0.351162] rcu-torture: torture_onoff task started=0D [ 0.351162] rcu-torture:torture_onoff task: offlining 13=0D [ 0.351163] rcu-torture: Creating rcu_torture_cbflood task=0D [ 0.351163] rcu-torture: rcu_torture_cbflood task started=0D [ 0.351163] rcu-torture: Creating rcu_torture_cbflood task=0D [ 0.351163] rcu-torture: Creating rcu_torture_cbflood task=0D [ 0.353035] rcu-torture: rcu_torture_cbflood task started=0D [ 0.352049] rcu-torture: rcu_torture_cbflood task started=0D [ 0.353035] rcu-torture: rcu_torture_cbflood task started=0D [ 0.389053] rcu-torture:torture_onoff task: offlined 13=0D [ 0.389141] futex hash table entries: 4096 (order: 6, 262144 bytes)=0D [ 0.389141] audit: initializing netlink subsys (disabled)=0D [ 0.389141] audit: type=3D2000 audit(1459346724.389:1): initialized=0D [ 0.394035] NFS: Registering the id_resolver key type=0D [ 0.394270] Key type id_resolver registered=0D [ 0.394270] Key type id_legacy registered=0D [ 0.397105] Block layer SCSI generic (bsg) driver version 0.4 loaded (ma= jor 251)=0D [ 0.397762] io scheduler noop registered=0D [ 0.398252] io scheduler deadline registered=0D [ 0.398252] io scheduler cfq registered (default)=0D [ 0.400031] pci_hotplug: PCI Hot Plug PCI Core version: 0.5=0D [ 0.400031] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/inpu= t/input0=0D [ 0.400530] ACPI: Power Button [PWRF]=0D [ 0.402040] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled=0D [ 0.422759] 00:04: ttyS0 at I/O 0x3f8 (irq =3D 4, base_baud =3D 115200) = is a 16550A=0D [ 0.425041] Non-volatile memory driver v1.3=0D [ 0.425041] Linux agpgart interface v0.103=0D [ 0.425041] [drm] Initialized drm 1.1.0 20060810=0D [ 0.431041] loop: module loaded=0D [ 0.432226] scsi host0: ata_piix=0D [ 0.432237] scsi host1: ata_piix=0D [ 0.432237] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc000 irq 1= 4=0D [ 0.433721] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc008 irq 1= 5=0D [ 0.434358] e100: Intel(R) PRO/100 Network Driver, 3.5.24-k2-NAPI=0D [ 0.435140] e100: Copyright(c) 1999-2006 Intel Corporation=0D [ 0.435140] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-= NAPI=0D [ 0.436277] e1000: Copyright (c) 1999-2006 Intel Corporation.=0D [ 0.436277] sky2: driver version 1.30=0D [ 0.437178] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver=0D [ 0.437178] ehci-pci: EHCI PCI platform driver=0D [ 0.438346] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver=0D [ 0.438346] ohci-pci: OHCI PCI platform driver=0D [ 0.439361] uhci_hcd: USB Universal Host Controller Interface driver=0D [ 0.439361] usbcore: registered new interface driver usblp=0D [ 0.440474] usbcore: registered new interface driver usb-storage=0D [ 0.442029] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x6= 0,0x64 irq 1,12=0D [ 0.443023] serio: i8042 KBD port at 0x60,0x64 irq 1=0D [ 0.443023] serio: i8042 AUX port at 0x60,0x64 irq 12=0D [ 0.444065] mousedev: PS/2 mouse device common for all mice=0D [ 0.444184] rtc_cmos 00:00: RTC can wake from S4=0D [ 0.444184] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0=0D [ 0.445646] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram, hpet = irqs=0D [ 0.446675] device-mapper: ioctl: 4.34.0-ioctl (2015-10-28) initialised:= dm-devel@redhat.com=0D [ 0.447659] hidraw: raw HID events driver (C) Jiri Kosina=0D [ 0.448258] usbcore: registered new interface driver usbhid=0D [ 0.448258] usbhid: USB HID core driver=0D [ 0.450040] input: AT Translated Set 2 keyboard as /devices/platform/i80= 42/serio0/input/input1=0D [ 0.451072] Netfilter messages via NETLINK v0.30.=0D [ 0.451072] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)=0D [ 0.451072] ctnetlink v0.93: registering with nfnetlink.=0D [ 0.466084] ip_tables: (C) 2000-2006 Netfilter Core Team=0D [ 0.471062] Initializing XFRM netlink socket=0D [ 0.471598] NET: Registered protocol family 10=0D [ 0.473087] ip6_tables: (C) 2000-2006 Netfilter Core Team=0D [ 0.490021] sit: IPv6 over IPv4 tunneling driver=0D [ 0.491183] NET: Registered protocol family 17=0D [ 0.492024] Key type dns_resolver registered=0D [ 0.493114] microcode: CPU0 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.495107] microcode: CPU1 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.495168] microcode: CPU2 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.495589] microcode: CPU3 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.502194] microcode: CPU4 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.503126] microcode: CPU5 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.504091] microcode: CPU6 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.504036] microcode: CPU7 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.504053] microcode: CPU8 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.505116] microcode: CPU9 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.505061] microcode: CPU10 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.506053] microcode: CPU11 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.506026] microcode: CPU12 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.508095] microcode: CPU14 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.507139] microcode: CPU15 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 0.509067] microcode: Microcode Update Driver: v2.01 , Peter Oruba=0D [ 0.509329] registered taskstats version 1=0D [ 0.511033] Magic number: 8:234:82=0D [ 0.511033] console [netcon0] enabled=0D [ 0.511033] netconsole: network logging started=0D [ 0.511254] ALSA device list:=0D [ 0.511254] No soundcards found.=0D [ 0.588057] Freeing unused kernel memory: 1092K (ffffffff81f3c000 - ffff= ffff8204d000)=0D [ 0.589129] Write protecting the kernel read-only data: 14336k=0D [ 0.592046] Freeing unused kernel memory: 1296K (ffff8800018bc000 - ffff= 880001a00000)=0D [ 0.594022] Freeing unused kernel memory: 396K (ffff880001d9d000 - ffff8= 80001e00000)=0D :: running early hook [udev]=0D Warning: /lib/modules/4.5.0-rc1+/modules.devname not found - ignoring=0D [ 0.605171] random: systemd-tmpfile urandom read with 2 bits of entropy = available=0D [ 0.606659] systemd-tmpfile (1176) used greatest stack depth: 13896 byte= s left=0D starting version 228=0D :: running hook [udev]=0D :: Triggering uevents...=0D [ 0.699039] systemd-udevd (1190) used greatest stack depth: 13888 bytes = left=0D ERROR: device '' not found. Skipping fsck.=0D ERROR: Unable to find root device ''.=0D You are being dropped to a recovery shell=0D Type 'exit' to try and continue booting=0D sh: can't access tty; job control turned off=0D [rootfs /]# [ 1.057112] input: ImExPS/2 Generic Explorer Mouse as /devic= es/platform/i8042/serio1/input/input3=0D [ 1.392056] rcu-torture:torture_onoff task: offlining 8=0D [ 1.607043] hrtimer: interrupt took 5051140 ns=0D [ 1.616058] smpboot: CPU 8 is now offline=0D [ 1.663068] rcu-torture:torture_onoff task: offlined 8=0D [ 2.663063] rcu-torture:torture_onoff task: offlining 2=0D [ 3.017066] smpboot: CPU 2 is now offline=0D [ 3.071046] rcu-torture:torture_onoff task: offlined 2=0D [ 4.072035] rcu-torture:torture_onoff task: offlining 9=0D [ 4.240047] smpboot: CPU 9 is now offline=0D [ 4.295063] rcu-torture:torture_onoff task: offlined 9=0D [ 5.297036] rcu-torture:torture_onoff task: offlining 12=0D [ 5.399044] smpboot: CPU 12 is now offline=0D [ 5.454051] rcu-torture:torture_onoff task: offlined 12=0D [ 6.454036] rcu-torture:torture_onoff task: onlining 13=0D [ 6.509046] smpboot: Booting Node 0 Processor 13 APIC 0xd=0D [ 6.546026] microcode: CPU13 sig=3D0x206c2, pf=3D0x1, revision=3D0x1=0D [ 6.546026] rcu-torture:torture_onoff task: onlined 13=0D [ 7.546045] rcu-torture:torture_onoff task: offlining 11=0D [ 7.602125] smpboot: CPU 11 is now offline=0D [ 7.695044] rcu-torture:torture_onoff task: offlined 11=0D [ 8.695045] rcu-torture:torture_onoff task: offlining 5=0D [ 8.751103] smpboot: CPU 5 is now offline=0D [ 8.808024] rcu-torture:torture_onoff task: offlined 5=0D [ 9.807032] rcu-torture:torture_onoff task: onlining 12=0D [ 9.861053] smpboot: Booting Node 0 Processor 12 APIC 0xc=0D [ 9.905032] rcu-torture:torture_onoff task: onlined 12=0D [ 10.905040] rcu-torture:torture_onoff task: offlining 14=0D [ 10.912099] smpboot: CPU 14 is now offline=0D [ 10.966050] rcu-torture:torture_onoff task: offlined 14=0D [ 11.966038] rcu-torture:torture_onoff task: offlining 13=0D [ 12.173064] smpboot: CPU 13 is now offline=0D [ 12.173064] BUG: unable to handle kernel NULL pointer dereference at = (null)=0D [ 12.174064] IP: [] migrate_timer_list+0x32/0xc0=0D [ 12.174064] PGD 0 =0D [ 12.174064] Oops: 0002 [#1] PREEMPT SMP =0D [ 12.174064] Modules linked in:=0D [ 12.174064] CPU: 1 PID: 795 Comm: torture_onoff Not tainted 4.5.0-rc1+ #= 14=0D [ 12.174064] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 12.174064] task: ffff88007c651900 ti: ffff88007c660000 task.ti: ffff880= 07c660000=0D [ 12.174064] RIP: 0010:[] [] migrate= _timer_list+0x32/0xc0=0D [ 12.174064] RSP: 0018:ffff88007c663c98 EFLAGS: 00010086=0D [ 12.174064] RAX: dead000000000200 RBX: ffff88007fa2cc00 RCX: 00000000000= 000af=0D [ 12.174064] RDX: 0000000000000000 RSI: ffff88007fbad648 RDI: ffff88007fa= 2cc00=0D [ 12.174064] RBP: ffff88007c663cc0 R08: 0000000000000000 R09: ffff88007fa= 2cc00=0D [ 12.174064] R10: ffff88007c61be30 R11: 0000000000018f70 R12: ffff88007fb= ad648=0D [ 12.174064] R13: ffff88007fa2cc00 R14: 0000000000000001 R15: ffff88007fb= ac420=0D [ 12.174064] FS: 0000000000000000(0000) GS:ffff88007fa20000(0000) knlGS:= 0000000000000000=0D [ 12.174064] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 12.174064] CR2: 0000000000000000 CR3: 000000007b124000 CR4: 00000000000= 006e0=0D [ 12.174064] Stack:=0D [ 12.174064] ffff88007fa2cc00 ffff88007fbad650 ffff88007fbada48 ffff8800= 7fbad848=0D [ 12.174064] ffff88007fbad450 ffff88007c663d08 ffffffff810b95c4 ffff8800= 7fbacc00=0D [ 12.174064] ffff88007fbad648 00000000fffffff0 ffffffff81e4e0c0 00000000= 00000007=0D [ 12.174064] Call Trace:=0D [ 12.174064] [] timer_cpu_notify+0xe4/0x160=0D [ 12.174064] [] notifier_call_chain+0x45/0x70=0D [ 12.174064] [] __raw_notifier_call_chain+0x9/0x10=0D [ 12.174064] [] cpu_notify_nofail+0x1e/0x30=0D [ 12.174064] [] _cpu_down+0x212/0x350=0D [ 12.174064] [] ? __call_rcu.constprop.74+0x380/0x380= =0D [ 12.174064] [] ? call_rcu_bh+0x20/0x20=0D [ 12.174064] [] ? __rcu_read_unlock+0x50/0x50=0D [ 12.174064] [] ? __rcu_read_unlock+0x50/0x50=0D [ 12.174064] [] cpu_down+0x2f/0x50=0D [ 12.174064] [] torture_onoff+0x115/0x380=0D [ 12.174064] [] ? torture_kthread_stopping+0x70/0x70=0D [ 12.174064] [] kthread+0xd6/0xf0=0D [ 12.174064] [] ? kthread_worker_fn+0x180/0x180=0D [ 12.174064] [] ret_from_fork+0x3f/0x70=0D [ 12.174064] [] ? kthread_worker_fn+0x180/0x180=0D [ 12.174064] Code: 56 41 55 41 54 53 48 8b 06 44 8b 77 40 48 85 c0 74 53 = 49 89 fd 49 89 f4 4d 8b 3c 24 66 66 66 66 90 49 8b 07 49 8b 57 08 48 85 c0 = <48> 89 02 74 04 48 89 50 08 48 b8 00 02 00 00 00 00 ad de 4c 89 =0D [ 12.174064] RIP [] migrate_timer_list+0x32/0xc0=0D [ 12.174064] RSP =0D [ 12.174064] CR2: 0000000000000000=0D [ 12.174064] ---[ end trace 3ef597e7ab20460c ]---=0D [ 12.174064] note: torture_onoff[795] exited with preempt_count 3=0D [ 15.414020] BUG: spinlock lockup suspected on CPU#3, rcu_torture_fak/773= =0D [ 15.414020] lock: 0xffff88007fa2cc00, .magic: dead4ead, .owner: torture= _onoff/795, .owner_cpu: 1=0D [ 15.414020] CPU: 3 PID: 773 Comm: rcu_torture_fak Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] ffff88007fa2cc00 ffff88007c64bce8 ffffffff8132cd6c ffff8800= 7c651900=0D [ 15.414020] ffff88007c64bd08 ffffffff81092fb3 ffff88007fa2cc00 00000000= 57288000=0D [ 15.414020] ffff88007c64bd38 ffffffff810930db 0000000000000286 ffff8800= 7fa2cc00=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] dump_stack+0x4e/0x82=0D [ 15.414020] [] spin_dump+0x73/0xc0=0D [ 15.414020] [] do_raw_spin_lock+0x9b/0x150=0D [ 15.414020] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 15.414020] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 15.414020] [] try_to_del_timer_sync+0x1b/0x60=0D [ 15.414020] [] del_timer_sync+0x43/0x50=0D [ 15.414020] [] schedule_timeout+0x116/0x230=0D [ 15.414020] [] ? detach_if_pending+0xf0/0xf0=0D [ 15.414020] [] ? sched_torture_read_unlock+0x30/0x30= =0D [ 15.414020] [] schedule_timeout_uninterruptible+0x19/= 0x20=0D [ 15.414020] [] rcu_torture_fakewriter+0x87/0x160=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Sending NMI to all CPUs:=0D [ 15.414020] NMI backtrace for cpu 0=0D [ 15.414020] CPU: 0 PID: 779 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007c644b00 ti: ffff88007cab0000 task.ti: ffff880= 07cab0000=0D [ 15.414020] RIP: 0010:[] [] _cond_r= esched+0x0/0x20=0D [ 15.414020] RSP: 0018:ffff88007cab3df0 EFLAGS: 00000202=0D [ 15.414020] RAX: 0000000000000001 RBX: ffffffff81c9f0eb RCX: 00000000000= 00001=0D [ 15.414020] RDX: 0000000080000000 RSI: 0000000000000286 RDI: ffffffff81c= 9f0eb=0D [ 15.414020] RBP: ffff88007cab3e00 R08: ffff88007cab0000 R09: ffff88007fa= 0cc00=0D [ 15.414020] R10: ffff88007cab3e30 R11: 0000000000000001 R12: 00000000000= 00000=0D [ 15.414020] R13: 0000000392ee6980 R14: 0000000000000072 R15: ffffffff820= d6e80=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fa00000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 00007ffd0da7e3bc CR3: 0000000001e0f000 CR4: 00000000000= 006f0=0D [ 15.414020] Stack:=0D [ 15.414020] ffffffff81126479 0000000000000000 ffff88007cab3ea8 ffffffff= 810ad3ce=0D [ 15.414020] 0000000000000000 0000000081a0a240 e24ff85eb6c56d81 00000000= 000023ff=0D [ 15.414020] dead000000000200 0000000000000000 00000000fffba817 ffffffff= 810ad590=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] ? stutter_wait+0x49/0xc0=0D [ 15.414020] [] rcu_torture_reader+0x11e/0x2e0=0D [ 15.414020] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 15.414020] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Code: 75 7e a9 ff ff ff 7f 74 01 c3 9c 58 f6 c4 02 74 f8 55 = 48 89 e5 e8 a1 ff ff ff 5d c3 0f 1f 44 00 00 66 2e 0f 1f 84 00 00 00 00 00 = <65> 8b 15 49 b4 75 7e 85 d2 74 03 31 c0 c3 55 48 89 e5 e8 79 ff =0D [ 12.315013] BUG: spinlock lockup suspected on CPU#7, rcu_torture_rea/791= =0D [ 12.315013] lock: 0xffff88007fbacc00, .magic: dead4ead, .owner: torture= _onoff/795, .owner_cpu: 1=0D [ 12.315013] CPU: 7 PID: 791 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 12.315013] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 12.315013] ffff88007fbacc00 ffff88007c60bd10 ffffffff8132cd6c ffff8800= 7c651900=0D [ 12.315013] ffff88007c60bd30 ffffffff81092fb3 ffff88007fbacc00 00000000= 57288000=0D [ 12.315013] ffff88007c60bd60 ffffffff810930db 0000000000000286 ffff8800= 7fbacc00=0D [ 12.315013] Call Trace:=0D [ 12.315013] [] dump_stack+0x4e/0x82=0D [ 12.315013] [] spin_dump+0x73/0xc0=0D [ 12.315013] [] do_raw_spin_lock+0x9b/0x150=0D [ 12.315013] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 12.315013] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 12.315013] [] mod_timer+0x6a/0x200=0D [ 12.315013] [] rcu_torture_reader+0x2a7/0x2e0=0D [ 12.315013] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 12.315013] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 12.315013] [] kthread+0xd6/0xf0=0D [ 12.315013] [] ? kthread_worker_fn+0x180/0x180=0D [ 12.315013] [] ret_from_fork+0x3f/0x70=0D [ 12.315013] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] NMI backtrace for cpu 1=0D [ 15.414020] CPU: 1 PID: 795 Comm: torture_onoff Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007c651900 ti: ffff88007c660000 task.ti: ffff880= 07c660000=0D [ 15.414020] RIP: 0010:[] [] delay_l= oop+0x0/0x30=0D [ 15.414020] RSP: 0018:ffff88007fa23e68 EFLAGS: 00000002=0D [ 15.414020] RAX: 0000000000000001 RBX: ffff88007fa2cc00 RCX: 00000000002= 08044=0D [ 15.414020] RDX: 0000000000000000 RSI: ffffffff81ca0d44 RDI: 00000000000= 00001=0D [ 15.414020] RBP: ffff88007fa23e70 R08: ffff88007fa2e140 R09: 00000000000= 0000e=0D [ 15.414020] R10: 000000000000022d R11: 0000000000000020 R12: 00000000546= c6ab5=0D [ 15.414020] R13: 0000000000000001 R14: 0000000057288000 R15: 00000000000= 00000=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fa20000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 0000000000000000 CR3: 000000007b124000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] ffffffff8133930a ffff88007fa23ea0 ffffffff810930c7 ffff8800= 7fa2cc00=0D [ 15.414020] ffffffff81e080c8 0000000000000001 0000000000000001 ffff8800= 7fa23eb8=0D [ 15.414020] ffffffff818b3ffb ffff88007fa2cc00 ffff88007fa23f20 ffffffff= 810b91b0=0D [ 15.414020] Call Trace:=0D [ 15.414020] =01d [] ? __delay+0xa/0x10=0D [ 15.414020] [] do_raw_spin_lock+0x87/0x150=0D [ 15.414020] [] _raw_spin_lock_irq+0x1b/0x20=0D [ 15.414020] [] run_timer_softirq+0x40/0x2b0=0D [ 15.414020] [] ? clockevents_program_event+0x7d/0x120= =0D [ 15.414020] [] __do_softirq+0xd3/0x280=0D [ 15.414020] [] irq_exit+0x42/0x50=0D [ 15.414020] [] smp_apic_timer_interrupt+0x3d/0x50=0D [ 15.414020] [] apic_timer_interrupt+0x7f/0x90=0D [ 15.414020] =01d [] ? _raw_spin_unlock_irq+0xf/= 0x30=0D [ 15.414020] [] ? _raw_spin_unlock_irq+0x9/0x30=0D [ 15.414020] [] acct_collect+0x166/0x1a0=0D [ 15.414020] [] do_exit+0x4f9/0xc00=0D [ 15.414020] [] oops_end+0x84/0xb0=0D [ 15.414020] [] no_context+0x102/0x330=0D [ 15.414020] [] __bad_area_nosemaphore+0x75/0x1f0=0D [ 15.414020] [] bad_area_nosemaphore+0xe/0x10=0D [ 15.414020] [] __do_page_fault+0x85/0x450=0D [ 15.414020] [] do_page_fault+0xc/0x10=0D [ 15.414020] [] page_fault+0x22/0x30=0D [ 15.414020] [] ? migrate_timer_list+0x32/0xc0=0D [ 15.414020] [] ? migrate_timer_list+0x63/0xc0=0D [ 15.414020] [] timer_cpu_notify+0xe4/0x160=0D [ 15.414020] [] notifier_call_chain+0x45/0x70=0D [ 15.414020] [] __raw_notifier_call_chain+0x9/0x10=0D [ 15.414020] [] cpu_notify_nofail+0x1e/0x30=0D [ 15.414020] [] _cpu_down+0x212/0x350=0D [ 15.414020] [] ? __call_rcu.constprop.74+0x380/0x380= =0D [ 15.414020] [] ? call_rcu_bh+0x20/0x20=0D [ 15.414020] [] ? __rcu_read_unlock+0x50/0x50=0D [ 15.414020] [] ? __rcu_read_unlock+0x50/0x50=0D [ 15.414020] [] cpu_down+0x2f/0x50=0D [ 15.414020] [] torture_onoff+0x115/0x380=0D [ 15.414020] [] ? torture_kthread_stopping+0x70/0x70=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Code: c3 66 2e 0f 1f 84 00 00 00 00 00 55 41 89 d2 48 89 e5 = e8 54 fe ff ff 5d 44 01 d0 83 d0 00 c3 90 90 90 90 90 90 90 90 90 90 90 90 = <55> 48 89 f8 48 89 e5 48 85 c0 74 19 eb 02 66 90 eb 0e 0f 1f 40 =0D [ 15.414020] NMI backtrace for cpu 3=0D [ 15.414020] CPU: 3 PID: 773 Comm: rcu_torture_fak Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007c640000 ti: ffff88007c648000 task.ti: ffff880= 07c648000=0D [ 15.414020] RIP: 0010:[] [] default= _send_IPI_mask_sequence_phys+0x9d/0xd0=0D [ 15.414020] RSP: 0018:ffff88007c64bc68 EFLAGS: 00000046=0D [ 15.414020] RAX: 0000000000000400 RBX: 000000000000a130 RCX: 00000000000= 00003=0D [ 15.414020] RDX: 0000000000000003 RSI: 0000000000000010 RDI: 00000000000= 00300=0D [ 15.414020] RBP: ffff88007c64bca0 R08: 0000000000000000 R09: 00000000000= 094db=0D [ 15.414020] R10: ffff88007c64bf58 R11: 00000000000001f8 R12: ffffffff81f= 31740=0D [ 15.414020] R13: 0000000000000400 R14: 0000000000000002 R15: 00000000000= 00003=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fa60000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] 0000000000000082 000000037c64bc78 000000000000ff40 00000000= 00000001=0D [ 15.414020] ffffffff8103fd20 0000000057288000 ffff88007c64bda0 ffff8800= 7c64bcb0=0D [ 15.414020] ffffffff8103fd36 ffff88007c64bcf8 ffffffff81331299 ffffffff= 81008b50=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] ? irq_force_complete_move+0x20/0x20=0D [ 15.414020] [] nmi_raise_cpu_backtrace+0x16/0x20=0D [ 15.414020] [] nmi_trigger_all_cpu_backtrace+0x259/0x= 270=0D [ 15.414020] [] ? show_stack+0x20/0x50=0D [ 15.414020] [] arch_trigger_all_cpu_backtrace+0x14/0x= 20=0D [ 15.414020] [] do_raw_spin_lock+0xa5/0x150=0D [ 15.414020] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 15.414020] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 15.414020] [] try_to_del_timer_sync+0x1b/0x60=0D [ 15.414020] [] del_timer_sync+0x43/0x50=0D [ 15.414020] [] schedule_timeout+0x116/0x230=0D [ 15.414020] [] ? detach_if_pending+0xf0/0xf0=0D [ 15.414020] [] ? sched_torture_read_unlock+0x30/0x30= =0D [ 15.414020] [] schedule_timeout_uninterruptible+0x19/= 0x20=0D [ 15.414020] [] rcu_torture_fakewriter+0x87/0x160=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Code: 90 8b 0c 25 00 c3 5f ff 80 e5 10 75 f2 89 d0 c1 e0 18 = 89 04 25 10 c3 5f ff 41 83 fe 02 44 89 e8 41 0f 45 c6 89 04 25 00 c3 5f ff = 91 48 8b 05 32 09 ef 00 89 55 d4 ff 90 18 01 00 00 8b 55 d4 =0D [ 15.414020] NMI backtrace for cpu 4=0D [ 15.414020] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G D 4.5.= 0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007cc63e80 ti: ffff88007cc7c000 task.ti: ffff880= 07cc7c000=0D [ 15.414020] RIP: 0010:[] [] default= _idle+0x13/0xd0=0D [ 15.414020] RSP: 0018:ffff88007cc7fec0 EFLAGS: 00000202=0D [ 15.414020] RAX: 0000000000000004 RBX: ffff88007cc80000 RCX: 00000000000= 00000=0D [ 15.414020] RDX: 0000000000000000 RSI: ffffffff81ca0d44 RDI: ffffffff81c= bdfe7=0D [ 15.414020] RBP: ffff88007cc7fed0 R08: 0000000000000000 R09: 00000000000= 00000=0D [ 15.414020] R10: 0000000000000400 R11: 0000000000000002 R12: 00000000000= 00000=0D [ 15.414020] R13: 0000000000000000 R14: ffff88007cc7c000 R15: ffff88007cc= 7c000=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fa80000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] ffff88007cc80000 0000000000000000 ffff88007cc7fee0 ffffffff= 8100fafa=0D [ 15.414020] ffff88007cc7fef0 ffffffff8108fd65 ffff88007cc7ff30 ffffffff= 8108fff7=0D [ 15.414020] ffff88007cc80000 0000000000000004 0000000000000000 00000000= 00000000=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] arch_cpu_idle+0xa/0x10=0D [ 15.414020] [] default_idle_call+0x25/0x30=0D [ 15.414020] [] cpu_startup_entry+0x287/0x2e0=0D [ 15.414020] [] start_secondary+0xf9/0x100=0D [ 15.414020] Code: 0f 1f 84 00 00 00 00 00 55 89 ff 48 89 e5 f0 48 0f ab = 3e 5d c3 0f 1f 00 55 48 89 e5 41 54 53 e8 c4 8d 33 00 66 66 66 66 90 fb f4 = b8 8d 33 00 41 89 c4 66 66 66 66 90 5b 41 5c 5d c3 41 89 c4 =0D [ 15.414020] NMI backtrace for cpu 6=0D [ 15.414020] CPU: 6 PID: 775 Comm: rcu_torture_fak Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007c641900 ti: ffff88007c610000 task.ti: ffff880= 07c610000=0D [ 15.414020] RIP: 0010:[] [] delay_l= oop+0x0/0x30=0D [ 15.414020] RSP: 0018:ffff88007c613d00 EFLAGS: 00000006=0D [ 15.414020] RAX: 0000000000000001 RBX: ffff88007fa2cc00 RCX: 00000000000= 00001=0D [ 15.414020] RDX: 0000000000000000 RSI: ffff88007c613da0 RDI: 00000000000= 00001=0D [ 15.414020] RBP: ffff88007c613d08 R08: ffff88007c610000 R09: 00000000000= 00002=0D [ 15.414020] R10: 0000000000000000 R11: 0000000000000b6e R12: 000000002ec= 4668b=0D [ 15.414020] R13: 0000000000000001 R14: 0000000057288000 R15: ffff88007c6= 13da0=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fac0000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] ffffffff8133930a ffff88007c613d38 ffffffff810930c7 00000000= 00000286=0D [ 15.414020] ffff88007fa2cc00 ffff88007fa2cc00 000000000000cc00 ffff8800= 7c613d58=0D [ 15.414020] ffffffff818b401f 0000000000000001 ffff88007c613e18 ffff8800= 7c613d90=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] ? __delay+0xa/0x10=0D [ 15.414020] [] do_raw_spin_lock+0x87/0x150=0D [ 15.414020] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 15.414020] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 15.414020] [] try_to_del_timer_sync+0x1b/0x60=0D [ 15.414020] [] del_timer_sync+0x43/0x50=0D [ 15.414020] [] schedule_timeout+0x116/0x230=0D [ 15.414020] [] ? detach_if_pending+0xf0/0xf0=0D [ 15.414020] [] ? sched_torture_read_unlock+0x30/0x30= =0D [ 15.414020] [] schedule_timeout_uninterruptible+0x19/= 0x20=0D [ 15.414020] [] rcu_torture_fakewriter+0x87/0x160=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Code: c3 66 2e 0f 1f 84 00 00 00 00 00 55 41 89 d2 48 89 e5 = e8 54 fe ff ff 5d 44 01 d0 83 d0 00 c3 90 90 90 90 90 90 90 90 90 90 90 90 = <55> 48 89 f8 48 89 e5 48 85 c0 74 19 eb 02 66 90 eb 0e 0f 1f 40 =0D [ 15.414020] NMI backtrace for cpu 7=0D [ 15.414020] CPU: 7 PID: 791 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007c5fe400 ti: ffff88007c608000 task.ti: ffff880= 07c608000=0D [ 15.414020] RIP: 0010:[] [] do_raw_= spin_lock+0x6a/0x150=0D [ 15.414020] RSP: 0018:ffff88007c60bd40 EFLAGS: 00000012=0D [ 15.414020] RAX: ffffffffffffffff RBX: ffff88007fbacc00 RCX: 00000000000= 00001=0D [ 15.414020] RDX: 0000000000000000 RSI: ffff88007c60bdd0 RDI: 00000000000= 00001=0D [ 15.414020] RBP: ffff88007c60bd60 R08: ffffffff81e496f8 R09: ffff88007fb= acc00=0D [ 15.414020] R10: ffff88007c60be30 R11: 0000000000094c00 R12: 0000000056f= b33d6=0D [ 15.414020] R13: 0000000000000001 R14: 0000000057288000 R15: ffff88007c6= 0bdd0=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fae0000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] 0000000000000286 ffff88007fbacc00 ffff88007fbacc00 00000000= 0000cc00=0D [ 15.414020] ffff88007c60bd80 ffffffff818b401f 000000000000000d ffff8800= 7c60be58=0D [ 15.414020] ffff88007c60bdb8 ffffffff810b8faf ffff88007c60be30 00000000= fffb9c3c=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 15.414020] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 15.414020] [] mod_timer+0x6a/0x200=0D [ 15.414020] [] rcu_torture_reader+0x2a7/0x2e0=0D [ 15.414020] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 15.414020] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Code: 03 85 c0 75 0d ba 01 00 00 00 f0 0f b1 13 85 c0 74 67 = 4c 69 35 b4 0f d8 00 e8 03 00 00 45 31 e4 41 bd 01 00 00 00 4d 85 f6 74 22 = <8b> 03 85 c0 75 09 f0 44 0f b1 2b 85 c0 74 3f bf 01 00 00 00 49 =0D [ 15.414020] NMI backtrace for cpu 10=0D [ 15.414020] CPU: 10 PID: 785 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007c5f9900 ti: ffff88007c510000 task.ti: ffff880= 07c510000=0D [ 15.414020] RIP: 0010:[] [] stutter= _wait+0x49/0xc0=0D [ 15.414020] RSP: 0018:ffff88007c513df8 EFLAGS: 00000246=0D [ 15.414020] RAX: 0000000000000000 RBX: ffffffff81c9f0eb RCX: 00000000000= 00001=0D [ 15.414020] RDX: 0000000080000000 RSI: 0000000000000286 RDI: ffffffff81c= 9f0eb=0D [ 15.414020] RBP: ffff88007c513e00 R08: ffff88007c510000 R09: ffff88007fb= 4cc00=0D [ 15.414020] R10: ffff88007c513e30 R11: 0000000000000001 R12: 00000000000= 00000=0D [ 15.414020] R13: 0000000392b16080 R14: 0000000000000072 R15: ffffffff820= d6e80=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fb40000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] 0000000000000000 ffff88007c513ea8 ffffffff810ad3ce 00000000= 00000000=0D [ 15.414020] 0000000081a0a240 3d2f7d49a663713f 000000000000160d dead0000= 00000200=0D [ 15.414020] 0000000000000000 00000000fffba813 ffffffff810ad590 00000000= 00000000=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] rcu_torture_reader+0x11e/0x2e0=0D [ 15.414020] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 15.414020] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Code: 0e af fd 00 48 85 c0 74 66 8b 00 85 c0 75 60 8b 05 61 = ae fd 00 85 c0 74 26 8b 05 57 ae fd 00 83 f8 01 75 07 eb 35 e8 c7 94 78 00 = <8b> 05 45 ae fd 00 85 c0 75 f1 48 89 df e8 65 ff ff ff eb b4 bf =0D [ 15.414020] NMI backtrace for cpu 12=0D [ 15.414020] CPU: 12 PID: 0 Comm: swapper/12 Tainted: G D 4.= 5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007cc9a580 ti: ffff88007ccac000 task.ti: ffff880= 07ccac000=0D [ 15.414020] RIP: 0010:[] [] default= _idle+0x13/0xd0=0D [ 15.414020] RSP: 0018:ffff88007ccafec0 EFLAGS: 00000202=0D [ 15.414020] RAX: 000000000000000c RBX: ffff88007ccb0000 RCX: 00000000000= 00000=0D [ 15.414020] RDX: 0000000000000000 RSI: ffffffff81ca0d44 RDI: ffffffff81c= bdfe7=0D [ 15.414020] RBP: ffff88007ccafed0 R08: 0000000000000000 R09: 00000000000= 00000=0D [ 15.414020] R10: 0000000000000000 R11: 0000000000000000 R12: 00000000000= 00000=0D [ 15.414020] R13: 0000000000000000 R14: ffff88007ccac000 R15: ffff88007cc= ac000=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fb80000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 0000000000000000 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] ffff88007ccb0000 0000000000000000 ffff88007ccafee0 ffffffff= 8100fafa=0D [ 15.414020] ffff88007ccafef0 ffffffff8108fd65 ffff88007ccaff30 ffffffff= 8108fff7=0D [ 15.414020] ffff88007ccb0000 000000000000000c 0000000000000000 00000000= 00000000=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] arch_cpu_idle+0xa/0x10=0D [ 15.414020] [] default_idle_call+0x25/0x30=0D [ 15.414020] [] cpu_startup_entry+0x287/0x2e0=0D [ 15.414020] [] start_secondary+0xf9/0x100=0D [ 15.414020] Code: 0f 1f 84 00 00 00 00 00 55 89 ff 48 89 e5 f0 48 0f ab = 3e 5d c3 0f 1f 00 55 48 89 e5 41 54 53 e8 c4 8d 33 00 66 66 66 66 90 fb f4 = b8 8d 33 00 41 89 c4 66 66 66 66 90 5b 41 5c 5d c3 41 89 c4 =0D [ 15.414020] NMI backtrace for cpu 15=0D [ 15.414020] CPU: 15 PID: 788 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 15.414020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 15.414020] task: ffff88007c5fbe80 ti: ffff88007c51c000 task.ti: ffff880= 07c51c000=0D [ 15.414020] RIP: 0010:[] [] _cond_r= esched+0x0/0x20=0D [ 15.414020] RSP: 0018:ffff88007c51fdf0 EFLAGS: 00000202=0D [ 15.414020] RAX: 0000000000000001 RBX: ffffffff81c9f0eb RCX: 00000000000= 00001=0D [ 15.414020] RDX: 0000000080000000 RSI: ffffffff81d29759 RDI: ffffffff81c= 9f0eb=0D [ 15.414020] RBP: ffff88007c51fe00 R08: ffff88007c51c000 R09: ffff88007fb= 8cc00=0D [ 15.414020] R10: ffff88007c51fe30 R11: 0000000000000001 R12: 00000000000= 00000=0D [ 15.414020] R13: 0000000392ee6980 R14: 0000000000000072 R15: ffffffff820= d6e80=0D [ 15.414020] FS: 0000000000000000(0000) GS:ffff88007fbe0000(0000) knlGS:= 0000000000000000=0D [ 15.414020] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 15.414020] CR2: 00007fa3445ac000 CR3: 000000007b2ba000 CR4: 00000000000= 006e0=0D [ 15.414020] Stack:=0D [ 15.414020] ffffffff81126479 0000000000000000 ffff88007c51fea8 ffffffff= 810ad3ce=0D [ 15.414020] 0000000000000000 0000000081a0a240 036fde59d7641143 00000000= 00001385=0D [ 15.414020] dead000000000200 0000000000000000 00000000fffba817 ffffffff= 810ad590=0D [ 15.414020] Call Trace:=0D [ 15.414020] [] ? stutter_wait+0x49/0xc0=0D [ 15.414020] [] rcu_torture_reader+0x11e/0x2e0=0D [ 15.414020] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 15.414020] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 15.414020] [] kthread+0xd6/0xf0=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] [] ret_from_fork+0x3f/0x70=0D [ 15.414020] [] ? kthread_worker_fn+0x180/0x180=0D [ 15.414020] Code: 75 7e a9 ff ff ff 7f 74 01 c3 9c 58 f6 c4 02 74 f8 55 = 48 89 e5 e8 a1 ff ff ff 5d c3 0f 1f 44 00 00 66 2e 0f 1f 84 00 00 00 00 00 = <65> 8b 15 49 b4 75 7e 85 d2 74 03 31 c0 c3 55 48 89 e5 e8 79 ff =0D [ 16.616031] BUG: spinlock lockup suspected on CPU#1, torture_onoff/795=0D [ 16.616031] lock: 0xffff88007fa2cc00, .magic: dead4ead, .owner: torture= _onoff/795, .owner_cpu: 1=0D [ 16.616031] CPU: 1 PID: 795 Comm: torture_onoff Tainted: G D = 4.5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] ffff88007fa2cc00 ffff88007fa23e50 ffffffff8132cd6c ffff8800= 7c651900=0D [ 16.616031] ffff88007fa23e70 ffffffff81092fb3 ffff88007fa2cc00 00000000= 57288000=0D [ 16.616031] ffff88007fa23ea0 ffffffff810930db ffff88007fa2cc00 ffffffff= 81e080c8=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] dump_stack+0x4e/0x82=0D [ 16.616031] [] spin_dump+0x73/0xc0=0D [ 16.616031] [] do_raw_spin_lock+0x9b/0x150=0D [ 16.616031] [] _raw_spin_lock_irq+0x1b/0x20=0D [ 16.616031] [] run_timer_softirq+0x40/0x2b0=0D [ 16.616031] [] ? clockevents_program_event+0x7d/0x120= =0D [ 16.616031] [] __do_softirq+0xd3/0x280=0D [ 16.616031] [] irq_exit+0x42/0x50=0D [ 16.616031] [] smp_apic_timer_interrupt+0x3d/0x50=0D [ 16.616031] [] apic_timer_interrupt+0x7f/0x90=0D [ 16.616031] [] ? _raw_spin_unlock_irq+0xf/0x30= =0D [ 16.616031] [] ? _raw_spin_unlock_irq+0x9/0x30=0D [ 16.616031] [] acct_collect+0x166/0x1a0=0D [ 16.616031] [] do_exit+0x4f9/0xc00=0D [ 16.616031] [] oops_end+0x84/0xb0=0D [ 16.616031] [] no_context+0x102/0x330=0D [ 16.616031] [] __bad_area_nosemaphore+0x75/0x1f0=0D [ 16.616031] [] bad_area_nosemaphore+0xe/0x10=0D [ 16.616031] [] __do_page_fault+0x85/0x450=0D [ 16.616031] [] do_page_fault+0xc/0x10=0D [ 16.616031] [] page_fault+0x22/0x30=0D [ 16.616031] [] ? migrate_timer_list+0x32/0xc0=0D [ 16.616031] [] ? migrate_timer_list+0x63/0xc0=0D [ 16.616031] [] timer_cpu_notify+0xe4/0x160=0D [ 16.616031] [] notifier_call_chain+0x45/0x70=0D [ 16.616031] [] __raw_notifier_call_chain+0x9/0x10=0D [ 16.616031] [] cpu_notify_nofail+0x1e/0x30=0D [ 16.616031] [] _cpu_down+0x212/0x350=0D [ 16.616031] [] ? __call_rcu.constprop.74+0x380/0x380= =0D [ 16.616031] [] ? call_rcu_bh+0x20/0x20=0D [ 16.616031] [] ? __rcu_read_unlock+0x50/0x50=0D [ 16.616031] [] ? __rcu_read_unlock+0x50/0x50=0D [ 16.616031] [] cpu_down+0x2f/0x50=0D [ 16.616031] [] torture_onoff+0x115/0x380=0D [ 16.616031] [] ? torture_kthread_stopping+0x70/0x70=0D [ 16.616031] [] kthread+0xd6/0xf0=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] [] ret_from_fork+0x3f/0x70=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] Sending NMI to all CPUs:=0D [ 16.616031] NMI backtrace for cpu 0=0D [ 16.616031] CPU: 0 PID: 779 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007c644b00 ti: ffff88007cab0000 task.ti: ffff880= 07cab0000=0D [ 16.616031] RIP: 0010:[] [] _cond_r= esched+0x0/0x20=0D [ 16.616031] RSP: 0018:ffff88007cab3df0 EFLAGS: 00000202=0D [ 16.616031] RAX: 0000000000000001 RBX: ffffffff81c9f0eb RCX: 00000000000= 00001=0D [ 16.616031] RDX: 0000000080000000 RSI: 0000000000000286 RDI: ffffffff81c= 9f0eb=0D [ 16.616031] RBP: ffff88007cab3e00 R08: ffff88007cab0000 R09: ffff88007fa= 0cc00=0D [ 16.616031] R10: ffff88007cab3e30 R11: 0000000000000001 R12: 00000000000= 00000=0D [ 16.616031] R13: 0000000392ee6980 R14: 0000000000000072 R15: ffffffff820= d6e80=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fa00000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 00007ffd0da7e3bc CR3: 0000000001e0f000 CR4: 00000000000= 006f0=0D [ 16.616031] Stack:=0D [ 16.616031] ffffffff81126479 0000000000000000 ffff88007cab3ea8 ffffffff= 810ad3ce=0D [ 16.616031] 0000000000000000 0000000081a0a240 e24ff85eb6c56d81 00000000= 000023ff=0D [ 16.616031] dead000000000200 0000000000000000 00000000fffba817 ffffffff= 810ad590=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] ? stutter_wait+0x49/0xc0=0D [ 16.616031] [] rcu_torture_reader+0x11e/0x2e0=0D [ 16.616031] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 16.616031] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 16.616031] [] kthread+0xd6/0xf0=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] [] ret_from_fork+0x3f/0x70=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] Code: 75 7e a9 ff ff ff 7f 74 01 c3 9c 58 f6 c4 02 74 f8 55 = 48 89 e5 e8 a1 ff ff ff 5d c3 0f 1f 44 00 00 66 2e 0f 1f 84 00 00 00 00 00 = <65> 8b 15 49 b4 75 7e 85 d2 74 03 31 c0 c3 55 48 89 e5 e8 79 ff =0D [ 16.616031] NMI backtrace for cpu 1=0D [ 16.616031] CPU: 1 PID: 795 Comm: torture_onoff Tainted: G D = 4.5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007c651900 ti: ffff88007c660000 task.ti: ffff880= 07c660000=0D [ 16.616031] RIP: 0010:[] [] default= _send_IPI_mask_sequence_phys+0x9d/0xd0=0D [ 16.616031] RSP: 0018:ffff88007fa23dd0 EFLAGS: 00000046=0D [ 16.616031] RAX: 0000000000000400 RBX: 000000000000a130 RCX: 00000000000= 00001=0D [ 16.616031] RDX: 0000000000000001 RSI: 0000000000000010 RDI: 00000000000= 00300=0D [ 16.616031] RBP: ffff88007fa23e08 R08: 0000000000000000 R09: 00000000000= 094db=0D [ 16.616031] R10: ffff88007c663f58 R11: 0000000000000362 R12: ffffffff81f= 31740=0D [ 16.616031] R13: 0000000000000400 R14: 0000000000000002 R15: 00000000000= 00001=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fa20000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 0000000000000000 CR3: 000000007b124000 CR4: 00000000000= 006e0=0D [ 16.616031] Stack:=0D [ 16.616031] 0000000000000082 000000017fa23de0 000000000000ff40 00000000= 00000001=0D [ 16.616031] ffffffff8103fd20 0000000057288000 0000000000000000 ffff8800= 7fa23e18=0D [ 16.616031] ffffffff8103fd36 ffff88007fa23e60 ffffffff81331299 ffffffff= 81008b50=0D [ 16.616031] Call Trace:=0D [ 16.616031] =01d [] ? irq_force_complete_move+0= x20/0x20=0D [ 16.616031] [] nmi_raise_cpu_backtrace+0x16/0x20=0D [ 16.616031] [] nmi_trigger_all_cpu_backtrace+0x259/0x= 270=0D [ 16.616031] [] ? show_stack+0x20/0x50=0D [ 16.616031] [] arch_trigger_all_cpu_backtrace+0x14/0x= 20=0D [ 16.616031] [] do_raw_spin_lock+0xa5/0x150=0D [ 16.616031] [] _raw_spin_lock_irq+0x1b/0x20=0D [ 16.616031] [] run_timer_softirq+0x40/0x2b0=0D [ 16.616031] [] ? clockevents_program_event+0x7d/0x120= =0D [ 16.616031] [] __do_softirq+0xd3/0x280=0D [ 16.616031] [] irq_exit+0x42/0x50=0D [ 16.616031] [] smp_apic_timer_interrupt+0x3d/0x50=0D [ 16.616031] [] apic_timer_interrupt+0x7f/0x90=0D [ 16.616031] =01d [] ? _raw_spin_unlock_irq+0xf/= 0x30=0D [ 16.616031] [] ? _raw_spin_unlock_irq+0x9/0x30=0D [ 16.616031] [] acct_collect+0x166/0x1a0=0D [ 16.616031] [] do_exit+0x4f9/0xc00=0D [ 16.616031] [] oops_end+0x84/0xb0=0D [ 16.616031] [] no_context+0x102/0x330=0D [ 16.616031] [] __bad_area_nosemaphore+0x75/0x1f0=0D [ 16.616031] [] bad_area_nosemaphore+0xe/0x10=0D [ 16.616031] [] __do_page_fault+0x85/0x450=0D [ 16.616031] [] do_page_fault+0xc/0x10=0D [ 16.616031] [] page_fault+0x22/0x30=0D [ 16.616031] [] ? migrate_timer_list+0x32/0xc0=0D [ 16.616031] [] ? migrate_timer_list+0x63/0xc0=0D [ 16.616031] [] timer_cpu_notify+0xe4/0x160=0D [ 16.616031] [] notifier_call_chain+0x45/0x70=0D [ 16.616031] [] __raw_notifier_call_chain+0x9/0x10=0D [ 16.616031] [] cpu_notify_nofail+0x1e/0x30=0D [ 16.616031] [] _cpu_down+0x212/0x350=0D [ 16.616031] [] ? __call_rcu.constprop.74+0x380/0x380= =0D [ 16.616031] [] ? call_rcu_bh+0x20/0x20=0D [ 16.616031] [] ? __rcu_read_unlock+0x50/0x50=0D [ 16.616031] [] ? __rcu_read_unlock+0x50/0x50=0D [ 16.616031] [] cpu_down+0x2f/0x50=0D [ 16.616031] [] torture_onoff+0x115/0x380=0D [ 16.616031] [] ? torture_kthread_stopping+0x70/0x70=0D [ 16.616031] [] kthread+0xd6/0xf0=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] [] ret_from_fork+0x3f/0x70=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] Code: 90 8b 0c 25 00 c3 5f ff 80 e5 10 75 f2 89 d0 c1 e0 18 = 89 04 25 10 c3 5f ff 41 83 fe 02 44 89 e8 41 0f 45 c6 89 04 25 00 c3 5f ff = 91 48 8b 05 32 09 ef 00 89 55 d4 ff 90 18 01 00 00 8b 55 d4 =0D [ 16.616031] NMI backtrace for cpu 3=0D [ 16.616031] CPU: 3 PID: 773 Comm: rcu_torture_fak Tainted: G D = 4.5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007c640000 ti: ffff88007c648000 task.ti: ffff880= 07c648000=0D [ 16.616031] RIP: 0010:[] [] queued_= spin_lock_slowpath+0x16f/0x1a0=0D [ 16.616031] RSP: 0018:ffff88007c64bcf0 EFLAGS: 00000002=0D [ 16.616031] RAX: 0000000000000101 RBX: ffff88007fa2cc00 RCX: 00000000000= 00001=0D [ 16.616031] RDX: 0000000000000101 RSI: 0000000000000001 RDI: 00000000000= 00101=0D [ 16.616031] RBP: ffff88007c64bd08 R08: 0000000000000716 R09: 00000000000= 00332=0D [ 16.616031] R10: ffff88007c64bf58 R11: 0000000000000332 R12: 00000000572= 88000=0D [ 16.616031] R13: 0000000000000001 R14: 0000000057288000 R15: ffff88007c6= 4bda0=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fa60000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 16.616031] Stack:=0D [ 16.616031] ffff88007fa2cc00 0000000057288000 0000000000000001 ffff8800= 7c64bd38=0D [ 16.616031] ffffffff81093185 0000000000000286 ffff88007fa2cc00 ffff8800= 7fa2cc00=0D [ 16.616031] 000000000000cc00 ffff88007c64bd58 ffffffff818b401f 00000000= 00000001=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] do_raw_spin_lock+0x145/0x150=0D [ 16.616031] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 16.616031] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 16.616031] [] try_to_del_timer_sync+0x1b/0x60=0D [ 16.616031] [] del_timer_sync+0x43/0x50=0D [ 16.616031] [] schedule_timeout+0x116/0x230=0D [ 16.616031] [] ? detach_if_pending+0xf0/0xf0=0D [ 16.616031] [] ? sched_torture_read_unlock+0x30/0x30= =0D [ 16.616031] [] schedule_timeout_uninterruptible+0x19/= 0x20=0D [ 16.616031] [] rcu_torture_fakewriter+0x87/0x160=0D [ 16.616031] [] kthread+0xd6/0xf0=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] [] ret_from_fork+0x3f/0x70=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] Code: c2 89 d0 66 31 c0 39 c7 74 e7 4d 85 c0 c6 03 01 74 30 = 41 c7 40 08 01 00 00 00 e9 4e ff ff ff 83 fa 01 75 07 e9 4b ff ff ff f3 90 = <8b> 03 84 c0 75 f8 b8 01 00 00 00 66 89 03 5b 41 5c 41 5d 5d c3 =0D [ 16.616031] NMI backtrace for cpu 4=0D [ 16.616031] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G D 4.5.= 0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007cc63e80 ti: ffff88007cc7c000 task.ti: ffff880= 07cc7c000=0D [ 16.616031] RIP: 0010:[] [] default= _idle+0x13/0xd0=0D [ 16.616031] RSP: 0018:ffff88007cc7fec0 EFLAGS: 00000202=0D [ 16.616031] RAX: 0000000000000004 RBX: ffff88007cc80000 RCX: 00000000000= 00000=0D [ 16.616031] RDX: 0000000000000000 RSI: ffffffff81ca0d44 RDI: ffffffff81c= bdfe7=0D [ 16.616031] RBP: ffff88007cc7fed0 R08: 0000000000000000 R09: 00000000000= 00000=0D [ 16.616031] R10: 0000000000000000 R11: 0000000000000002 R12: 00000000000= 00000=0D [ 16.616031] R13: 0000000000000000 R14: ffff88007cc7c000 R15: ffff88007cc= 7c000=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fa80000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 16.616031] Stack:=0D [ 16.616031] ffff88007cc80000 0000000000000000 ffff88007cc7fee0 ffffffff= 8100fafa=0D [ 16.616031] ffff88007cc7fef0 ffffffff8108fd65 ffff88007cc7ff30 ffffffff= 8108fff7=0D [ 16.616031] ffff88007cc80000 0000000000000004 0000000000000000 00000000= 00000000=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] arch_cpu_idle+0xa/0x10=0D [ 16.616031] [] default_idle_call+0x25/0x30=0D [ 16.616031] [] cpu_startup_entry+0x287/0x2e0=0D [ 16.616031] [] start_secondary+0xf9/0x100=0D [ 16.616031] Code: 0f 1f 84 00 00 00 00 00 55 89 ff 48 89 e5 f0 48 0f ab = 3e 5d c3 0f 1f 00 55 48 89 e5 41 54 53 e8 c4 8d 33 00 66 66 66 66 90 fb f4 = b8 8d 33 00 41 89 c4 66 66 66 66 90 5b 41 5c 5d c3 41 89 c4 =0D [ 16.616031] NMI backtrace for cpu 6=0D [ 16.616031] CPU: 6 PID: 775 Comm: rcu_torture_fak Tainted: G D = 4.5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007c641900 ti: ffff88007c610000 task.ti: ffff880= 07c610000=0D [ 16.616031] RIP: 0010:[] [] __delay= +0x0/0x10=0D [ 16.616031] RSP: 0018:ffff88007c613d10 EFLAGS: 00000002=0D [ 16.616031] RAX: 0000000000000101 RBX: ffff88007fa2cc00 RCX: 00000000000= 00001=0D [ 16.616031] RDX: 0000000000000000 RSI: ffff88007c613da0 RDI: 00000000000= 00001=0D [ 16.616031] RBP: ffff88007c613d38 R08: ffff88007c610000 R09: 00000000000= 00002=0D [ 16.616031] R10: 0000000000000000 R11: 0000000000000b6e R12: 0000000030b= eeb3b=0D [ 16.616031] R13: 0000000000000001 R14: 0000000057288000 R15: ffff88007c6= 13da0=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fac0000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 16.616031] Stack:=0D [ 16.616031] ffffffff810930c7 0000000000000286 ffff88007fa2cc00 ffff8800= 7fa2cc00=0D [ 16.616031] 000000000000cc00 ffff88007c613d58 ffffffff818b401f 00000000= 00000001=0D [ 16.616031] ffff88007c613e18 ffff88007c613d90 ffffffff810b8faf ffff8800= 7c613df0=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] ? do_raw_spin_lock+0x87/0x150=0D [ 16.616031] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 16.616031] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 16.616031] [] try_to_del_timer_sync+0x1b/0x60=0D [ 16.616031] [] del_timer_sync+0x43/0x50=0D [ 16.616031] [] schedule_timeout+0x116/0x230=0D [ 16.616031] [] ? detach_if_pending+0xf0/0xf0=0D [ 16.616031] [] ? sched_torture_read_unlock+0x30/0x30= =0D [ 16.616031] [] schedule_timeout_uninterruptible+0x19/= 0x20=0D [ 16.616031] [] rcu_torture_fakewriter+0x87/0x160=0D [ 16.616031] [] kthread+0xd6/0xf0=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] [] ret_from_fork+0x3f/0x70=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] Code: 89 e5 48 85 c0 74 19 eb 02 66 90 eb 0e 0f 1f 40 00 66 = 2e 0f 1f 84 00 00 00 00 00 48 ff c8 75 fb 48 ff c8 5d c3 66 0f 1f 44 00 00 = <55> 48 89 e5 ff 15 2e 2b b6 00 5d c3 0f 1f 40 00 55 48 8d 04 bd =0D [ 16.616031] NMI backtrace for cpu 7=0D [ 16.616031] CPU: 7 PID: 791 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007c5fe400 ti: ffff88007c608000 task.ti: ffff880= 07c608000=0D [ 16.616031] RIP: 0010:[] [] queued_= spin_lock_slowpath+0x16f/0x1a0=0D [ 16.616031] RSP: 0018:ffff88007c60bd18 EFLAGS: 00000002=0D [ 16.616031] RAX: 0000000000000101 RBX: ffff88007fbacc00 RCX: 00000000000= 00001=0D [ 16.616031] RDX: 0000000000000101 RSI: 0000000000000001 RDI: 00000000000= 00101=0D [ 16.616031] RBP: ffff88007c60bd30 R08: 0000000000000000 R09: 00000000000= 00035=0D [ 16.616031] R10: ffff88007c60bf58 R11: 0000000000036a30 R12: 00000000572= 88000=0D [ 16.616031] R13: 0000000000000001 R14: 0000000057288000 R15: ffff88007c6= 0bdd0=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fae0000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 16.616031] Stack:=0D [ 16.616031] ffff88007fbacc00 0000000057288000 0000000000000001 ffff8800= 7c60bd60=0D [ 16.616031] ffffffff81093185 0000000000000286 ffff88007fbacc00 ffff8800= 7fbacc00=0D [ 16.616031] 000000000000cc00 ffff88007c60bd80 ffffffff818b401f 00000000= 0000000d=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] do_raw_spin_lock+0x145/0x150=0D [ 16.616031] [] _raw_spin_lock_irqsave+0x1f/0x30=0D [ 16.616031] [] lock_timer_base.isra.23+0x4f/0x70=0D [ 16.616031] [] mod_timer+0x6a/0x200=0D [ 16.616031] [] rcu_torture_reader+0x2a7/0x2e0=0D [ 16.616031] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 16.616031] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 16.616031] [] kthread+0xd6/0xf0=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] [] ret_from_fork+0x3f/0x70=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] Code: c2 89 d0 66 31 c0 39 c7 74 e7 4d 85 c0 c6 03 01 74 30 = 41 c7 40 08 01 00 00 00 e9 4e ff ff ff 83 fa 01 75 07 e9 4b ff ff ff f3 90 = <8b> 03 84 c0 75 f8 b8 01 00 00 00 66 89 03 5b 41 5c 41 5d 5d c3 =0D [ 16.616031] NMI backtrace for cpu 10=0D [ 16.616031] CPU: 10 PID: 785 Comm: rcu_torture_rea Tainted: G D = 4.5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007c5f9900 ti: ffff88007c510000 task.ti: ffff880= 07c510000=0D [ 16.616031] RIP: 0010:[] [] _cond_r= esched+0xb/0x20=0D [ 16.616031] RSP: 0018:ffff88007c513df0 EFLAGS: 00000286=0D [ 16.616031] RAX: 0000000000000001 RBX: ffffffff81c9f0eb RCX: 00000000000= 00001=0D [ 16.616031] RDX: 0000000080000000 RSI: 0000000000000286 RDI: ffffffff81c= 9f0eb=0D [ 16.616031] RBP: ffff88007c513e00 R08: ffff88007c510000 R09: ffff88007fb= 4cc00=0D [ 16.616031] R10: ffff88007c513e30 R11: 0000000000000001 R12: 00000000000= 00000=0D [ 16.616031] R13: 0000000392b16080 R14: 0000000000000072 R15: ffffffff820= d6e80=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fb40000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 0000560af8460720 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 16.616031] Stack:=0D [ 16.616031] ffffffff81126479 0000000000000000 ffff88007c513ea8 ffffffff= 810ad3ce=0D [ 16.616031] 0000000000000000 0000000081a0a240 3d2f7d49a663713f 00000000= 0000160d=0D [ 16.616031] dead000000000200 0000000000000000 00000000fffba813 ffffffff= 810ad590=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] ? stutter_wait+0x49/0xc0=0D [ 16.616031] [] rcu_torture_reader+0x11e/0x2e0=0D [ 16.616031] [] ? rcu_torture_reader+0x2e0/0x2e0=0D [ 16.616031] [] ? rcutorture_trace_dump.part.7+0x20/0x= 20=0D [ 16.616031] [] kthread+0xd6/0xf0=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] [] ret_from_fork+0x3f/0x70=0D [ 16.616031] [] ? kthread_worker_fn+0x180/0x180=0D [ 16.616031] Code: 58 f6 c4 02 74 f8 55 48 89 e5 e8 a1 ff ff ff 5d c3 0f = 1f 44 00 00 66 2e 0f 1f 84 00 00 00 00 00 65 8b 15 49 b4 75 7e 85 d2 74 03 = <31> c0 c3 55 48 89 e5 e8 79 ff ff ff b8 01 00 00 00 5d c3 66 90 =0D [ 16.616031] NMI backtrace for cpu 12=0D [ 16.616031] CPU: 12 PID: 0 Comm: swapper/12 Tainted: G D 4.= 5.0-rc1+ #14=0D [ 16.616031] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS = 1.9.1-20160216_104851-anatol 04/01/2014=0D [ 16.616031] task: ffff88007cc9a580 ti: ffff88007ccac000 task.ti: ffff880= 07ccac000=0D [ 16.616031] RIP: 0010:[] [] default= _idle+0x13/0xd0=0D [ 16.616031] RSP: 0018:ffff88007ccafec0 EFLAGS: 00000202=0D [ 16.616031] RAX: 000000000000000c RBX: ffff88007ccb0000 RCX: 00000000000= 00000=0D [ 16.616031] RDX: 0000000000000000 RSI: ffffffff81ca0d44 RDI: ffffffff81c= bdfe7=0D [ 16.616031] RBP: ffff88007ccafed0 R08: 0000000000000000 R09: 00000000000= 00000=0D [ 16.616031] R10: 0000000000000400 R11: 0000000000000002 R12: 00000000000= 00000=0D [ 16.616031] R13: 0000000000000000 R14: ffff88007ccac000 R15: ffff88007cc= ac000=0D [ 16.616031] FS: 0000000000000000(0000) GS:ffff88007fb80000(0000) knlGS:= 0000000000000000=0D [ 16.616031] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b=0D [ 16.616031] CR2: 0000000000000000 CR3: 0000000001e0f000 CR4: 00000000000= 006e0=0D [ 16.616031] Stack:=0D [ 16.616031] ffff88007ccb0000 0000000000000000 ffff88007ccafee0 ffffffff= 8100fafa=0D [ 16.616031] ffff88007ccafef0 ffffffff8108fd65 ffff88007ccaff30 ffffffff= 8108fff7=0D [ 16.616031] ffff88007ccb0000 000000000000000c 0000000000000000 00000000= 00000000=0D [ 16.616031] Call Trace:=0D [ 16.616031] [] arch_cpu_idle+0xa/0x10=0D [ 16.616031] [] default_idle_call+0x25/0x30=0D [ 16.616031] [] cpu_startup_entry+0x287/0x2e0=0D [ 16.616031] [] start_secondary+0xf9/0x100=0D [ 16.616031] Code: 0f 1f 84 00 00 00 00 00 55 89 ff 48 89 e5 f0 48 0f ab = 3e 5d c3 0f 1f 00 55 48 89 e5 41 54 53 e8 c4 8d 33 00 66 66 66 66 90 fb f4 =