On Sat, Dec 31, 2022 at 11:26:25PM +0800, kernel test robot wrote:
>
> Greeting,
>
> FYI, we noticed kernel_BUG_at_include/linux/mm.h due to commit (built with gcc-11):
>
> commit: 0af8489b0216fa1dd83e264bef8063f2632633d7 ("mm, slub: remove percpu slabs with CONFIG_SLUB_TINY")
> https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
>
> [test failed on linux-next/master c76083fac3bae1a87ae3d005b5cb1cbc761e31d5]
>
> in testcase: rcutorture
> version:
> with following parameters:
>
> runtime: 300s
> test: default
> torture_type: tasks-tracing
>
> test-description: rcutorture is rcutorture kernel module load/unload test.
> test-url: https://www.kernel.org/doc/Documentation/RCU/torture.txt
>
>
> on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G
>
> caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
>
>
> If you fix the issue, kindly add following tag
> | Reported-by: kernel test robot <oliver.sang@xxxxxxxxx>
> | Link: https://lore.kernel.org/oe-lkp/202212312021.bc1efe86-oliver.sang@xxxxxxxxx
>
>
<snip>
>
>
> To reproduce:
>
> # build kernel
> cd linux
> cp config-6.1.0-rc2-00014-g0af8489b0216 .config
> make HOSTCC=gcc-11 CC=gcc-11 ARCH=i386 olddefconfig prepare modules_prepare bzImage modules
> make HOSTCC=gcc-11 CC=gcc-11 ARCH=i386 INSTALL_MOD_PATH=<mod-install-dir> modules_install
> cd <mod-install-dir>
> find lib/ | cpio -o -H newc --quiet | gzip > modules.cgz
>
>
> git clone https://github.com/intel/lkp-tests.git
> cd lkp-tests
> bin/lkp qemu -k <bzImage> -m modules.cgz job-script # job-script is attached in this email
>
> # if come across any failure that blocks the test,
> # please remove ~/.lkp and /lkp dir to run from a clean state.
I was unable to reproduce in the same way as described above
because some files referenced in job-script couldn't be downloaded from
download.01.org/0day :(
So I just built rcutorture module as builtin
and I got weird spinlock bug on commit: 0af8489b0216
("mm, slub: remove percpu slabs with CONFIG_SLUB_TINY")
full dmesg added as attachment
[ 1387.564837][ T57] BUG: unable to handle page fault for address: c108f5f4
[ 1387.566649][ T57] #PF: supervisor write access in kernel mode
[ 1387.567965][ T57] #PF: error_code(0x0003) - permissions violation
[ 1387.569439][ T57] *pde = 010001e1
[ 1387.570276][ T57] Oops: 0003 [#1] SMP
[ 1387.571149][ T57] CPU: 2 PID: 57 Comm: rcu_torture_rea Tainted: G S 6.1.0-rc2-00010-g0af8489b0216 #2130 63d19ac2b985fca570c354d8750f489755de37ed
[ 1387.574673][ T57] EIP: kvm_kick_cpu+0x54/0x90
[ 1387.575802][ T57] Code: 2f c5 01 8b 04 9d e0 d4 4e c4 83 15 14 7b 2f c5 00 83 05 08 6d 2f c5 01 0f b7 0c 30 b8 05 00 00 00 83 15 0c 6d 2f c5 00 31 db <0f> 01 c1 83 05 10 6d 2f c5 01 8b 5d f8 8b 75 fc 83 15 14 6d 2f c5
[ 1387.580456][ T57] EAX: 00000005 EBX: 00000000 ECX: 00000003 EDX: c108f5a0
[ 1387.582071][ T57] ESI: c5153580 EDI: 00000046 EBP: c69cddf8 ESP: c69cddf0
[ 1387.583775][ T57] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010046
[ 1387.585643][ T57] CR0: 80050033 CR2: c108f5f4 CR3: 0776b000 CR4: 00350e90
[ 1387.587492][ T57] Call Trace:
[ 1387.588365][ T57] __pv_queued_spin_unlock_slowpath+0x66/0x110
[ 1387.589898][ T57] __pv_queued_spin_unlock+0x4b/0x60
[ 1387.591040][ T57] __raw_callee_save___pv_queued_spin_unlock+0x9/0x10
[ 1387.592771][ T57] do_raw_spin_unlock+0x49/0xa0
[ 1387.593805][ T57] _raw_spin_unlock_irqrestore+0x53/0xd0
[ 1387.594927][ T57] swake_up_one+0x4f/0x70
[ 1387.595739][ T57] __rcu_report_exp_rnp+0x26b/0x470
[ 1387.596730][ T57] rcu_report_exp_cpu_mult+0x82/0x2f0
[ 1387.597770][ T57] rcu_qs+0xac/0x160
[ 1387.598503][ T57] rcu_note_context_switch+0x31/0x1e0
[ 1387.599460][ T57] __schedule+0xc5/0x770
[ 1387.600195][ T57] __cond_resched+0x7a/0x100
[ 1387.600996][ T57] stutter_wait+0x9e/0x2c0
[ 1387.601956][ T57] rcu_torture_reader+0x162/0x3e0
[ 1387.603048][ T57] ? rcu_torture_reader+0x3e0/0x3e0
[ 1387.604269][ T57] ? __kthread_parkme+0xab/0xf0
[ 1387.605420][ T57] kthread+0x167/0x1d0
[ 1387.606383][ T57] ? rcu_torture_read_exit_child+0xa0/0xa0
[ 1387.607516][ T57] ? kthread_exit+0x50/0x50
[ 1387.608517][ T57] ret_from_fork+0x19/0x24
[ 1387.609548][ T57] Modules linked in:
[ 1387.610187][ T57] CR2: 00000000c108f5f4
[ 1387.610873][ T57] ---[ end trace 0000000000000000 ]---
[ 1387.611829][ T57] EIP: kvm_kick_cpu+0x54/0x90
[ 1387.612653][ T57] Code: 2f c5 01 8b 04 9d e0 d4 4e c4 83 15 14 7b 2f c5 00 83 05 08 6d 2f c5 01 0f b7 0c 30 b8 05 00 00 00 83 15 0c 6d 2f c5 00 31 db <0f> 01 c1 83 05 10 6d 2f c5 01 8b 5d f8 8b 75 fc 83 15 14 6d 2f c5
[ 1387.616715][ T57] EAX: 00000005 EBX: 00000000 ECX: 00000003 EDX: c108f5a0
[ 1387.618242][ T57] ESI: c5153580 EDI: 00000046 EBP: c69cddf8 ESP: c69cddf0
[ 1387.619912][ T57] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010046
[ 1387.621666][ T57] CR0: 80050033 CR2: c108f5f4 CR3: 0776b000 CR4: 00350e90
[ 1387.623128][ T57] Kernel panic - not syncing: Fatal exception
[ 1389.285045][ T57] Shutting down cpus with NMI
[ 1389.297949][ T57] Kernel Offset: disabled
[ 1389.299174][ T57] ---[ end Kernel panic - not syncing: Fatal exception ]---
c[?7l[2J[0mSeaBIOS (version 1.14.0-2)
iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+BFF8B330+BFECB330 CA00
Press Ctrl-B to configure iPXE (PCI 00:03.0)...
Booting from ROM..c[?7l[2J[ 0.000000][ T0] Linux version 6.1.0-rc2-00010-g0af8489b0216 (hyeyoo@hyeyoo) (gcc-11 (Ubuntu 11.2.0-7ubuntu2) 11.2.0, GNU ld (GNU Binutils for Ubuntu) 2.37) #2130 SMP Sun Jan 1 15:16:04 KST 2023
[ 0.000000][ T0] KERNEL supported cpus:
[ 0.000000][ T0] Intel GenuineIntel
[ 0.000000][ T0] Vortex Vortex86 SoC
[ 0.000000][ T0] CPU: vendor_id 'AuthenticAMD' unknown, using generic init.
[ 0.000000][ T0] CPU: Your system may be unstable.
[ 0.000000][ T0] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[ 0.000000][ T0] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[ 0.000000][ T0] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[ 0.000000][ T0] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'
[ 0.000000][ T0] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
[ 0.000000][ T0] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8
[ 0.000000][ T0] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format.
[ 0.000000][ T0] signal: max sigframe size: 3376
[ 0.000000][ T0] BIOS-provided physical RAM map:
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[ 0.000000][ T0] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdefff] usable
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000bffdf000-0x00000000bfffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable
[ 0.000000][ T0] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel!
[ 0.000000][ T0] Hypervisor detected: KVM
[ 0.000000][ T0] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000004][ T0] kvm-clock: using sched offset of 400952663 cycles
[ 0.000006][ T0] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.000012][ T0] tsc: Detected 3693.060 MHz processor
[ 0.000388][ T0] last_pfn = 0xbffdf max_arch_pfn = 0x100000
[ 0.000392][ T0] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC
[ 0.001738][ T0] found SMP MP-table at [mem 0x000f5ca0-0x000f5caf]
[ 0.001788][ T0] RAMDISK: [mem 0x773d8000-0x7fffffff]
[ 0.001790][ T0] Allocated new RAMDISK: [mem 0x2e3d6000-0x36ffda19]
[ 0.020456][ T0] Move RAMDISK from [mem 0x773d8000-0x7ffffa19] to [mem 0x2e3d6000-0x36ffda19]
[ 0.020466][ T0] ACPI: Early table checksum verification disabled
[ 0.020473][ T0] ACPI: RSDP 0x00000000000F5C60 000014 (v00 BOCHS )
[ 0.020480][ T0] ACPI: RSDT 0x00000000BFFE1795 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.020485][ T0] ACPI: FACP 0x00000000BFFE1631 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.020490][ T0] ACPI: DSDT 0x00000000BFFDFDC0 001871 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.020493][ T0] ACPI: FACS 0x00000000BFFDFD80 000040
[ 0.020495][ T0] ACPI: APIC 0x00000000BFFE16A5 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.020498][ T0] ACPI: HPET 0x00000000BFFE1735 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.020501][ T0] ACPI: WAET 0x00000000BFFE176D 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.020504][ T0] ACPI: Reserving FACP table memory at [mem 0xbffe1631-0xbffe16a4]
[ 0.020506][ T0] ACPI: Reserving DSDT table memory at [mem 0xbffdfdc0-0xbffe1630]
[ 0.020506][ T0] ACPI: Reserving FACS table memory at [mem 0xbffdfd80-0xbffdfdbf]
[ 0.020507][ T0] ACPI: Reserving APIC table memory at [mem 0xbffe16a5-0xbffe1734]
[ 0.020508][ T0] ACPI: Reserving HPET table memory at [mem 0xbffe1735-0xbffe176c]
[ 0.020509][ T0] ACPI: Reserving WAET table memory at [mem 0xbffe176d-0xbffe1794]
[ 0.020525][ T0] 2191MB HIGHMEM available.
[ 0.020526][ T0] 879MB LOWMEM available.
[ 0.020527][ T0] mapped low ram: 0 - 36ffe000
[ 0.020528][ T0] low ram: 0 - 36ffe000
[ 0.020535][ T0] Zone ranges:
[ 0.020536][ T0] Normal [mem 0x0000000000001000-0x0000000036ffdfff]
[ 0.020538][ T0] HighMem [mem 0x0000000036ffe000-0x00000000bffdefff]
[ 0.020539][ T0] Movable zone start for each node
[ 0.020540][ T0] Early memory node ranges
[ 0.020541][ T0] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.020542][ T0] node 0: [mem 0x0000000000100000-0x00000000bffdefff]
[ 0.020550][ T0] Initmem setup node 0 [mem 0x0000000000001000-0x00000000bffdefff]
[ 0.023822][ T0] On node 0, zone Normal: 1 pages in unavailable ranges
[ 0.026469][ T0] On node 0, zone Normal: 97 pages in unavailable ranges
[ 0.033027][ T0] Using APIC driver default
[ 0.033189][ T0] ACPI: PM-Timer IO Port: 0x608
[ 0.033193][ T0] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[ 0.033221][ T0] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[ 0.033224][ T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.033226][ T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[ 0.033227][ T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.033229][ T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[ 0.033230][ T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[ 0.033232][ T0] ACPI: Using ACPI (MADT) for SMP configuration information
[ 0.033233][ T0] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.033236][ T0] TSC deadline timer available
[ 0.033242][ T0] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
[ 0.033262][ T0] kvm-guest: KVM setup pv remote TLB flush
[ 0.033265][ T0] kvm-guest: setup PV sched yield
[ 0.033277][ T0] [mem 0xc0000000-0xfeffbfff] available for PCI devices
[ 0.033279][ T0] Booting paravirtualized kernel on KVM
[ 0.033283][ T0] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.033288][ T0] setup_percpu: NR_CPUS:8 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[ 0.034139][ T0] percpu: Embedded 351 pages/cpu s1407772 r0 d29924 u1437696
[ 0.034184][ T0] kvm-guest: PV spinlocks enabled
[ 0.034186][ T0] PV qspinlock hash table entries: 512 (order: 0, 4096 bytes, linear)
[ 0.034201][ T0] Built 1 zonelists, mobility grouping on. Total pages: 784101
[ 0.034203][ T0] Kernel command line: console=ttyS0 nokaslr numa=fake=4 page_owner=on mminit_loglevel=7 slub_max_order=0
[ 0.034356][ T0] Unknown kernel command line parameters "nokaslr numa=fake=4", will be passed to user space.
[ 0.034391][ T0] random: crng init done
[ 0.034515][ T0] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[ 0.034520][ T0] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.039432][ T0] allocated 47245320 bytes of page_ext
[ 0.039434][ T0] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.039438][ T0] stackdepot hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.039440][ T0] Initializing HighMem for node 0 (00036ffe:000bffdf)
[ 0.255783][ T0] Initializing Movable for node 0 (00000000:00000000)
[ 0.257032][ T0] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.257039][ T0] Memory: 2830080K/3145204K available (39873K kernel code, 10453K rwdata, 15080K rodata, 2656K init, 19064K bss, 315124K reserved, 0K cma-reserved, 2244484K highmem)
[ 0.257083][ T0] SLUB: HWalign=64, Order=0-0, MinObjects=0, CPUs=4, Nodes=1
[ 0.257413][ T0] Node 0, zone Normal: page owner found early allocated 10 pages
[ 0.257431][ T0] Node 0, zone HighMem: page owner found early allocated 0 pages
[ 0.257559][ T0] trace event string verifier disabled
[ 0.257722][ T0] Running RCU self tests
[ 0.257736][ T0] rcu: Hierarchical RCU implementation.
[ 0.257737][ T0] rcu: RCU lockdep checking is enabled.
[ 0.257738][ T0] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4.
[ 0.257740][ T0] Trampoline variant of Tasks RCU enabled.
[ 0.257742][ T0] Rude variant of Tasks RCU enabled.
[ 0.257743][ T0] Tracing variant of Tasks RCU enabled.
[ 0.257744][ T0] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
[ 0.257746][ T0] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[ 0.261721][ T0] NR_IRQS: 2304, nr_irqs: 72, preallocated irqs: 16
[ 0.261974][ T0] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[ 0.309659][ T0] printk: console [ttyS0] enabled
[ 0.309923][ T0] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.310363][ T0] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.310612][ T0] ... MAX_LOCK_DEPTH: 48
[ 0.310865][ T0] ... MAX_LOCKDEP_KEYS: 8192
[ 0.311132][ T0] ... CLASSHASH_SIZE: 4096
[ 0.311398][ T0] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.311663][ T0] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.311929][ T0] ... CHAINHASH_SIZE: 32768
[ 0.312205][ T0] memory used by lock dependency info: 4061 kB
[ 0.312557][ T0] memory used for stack traces: 2112 kB
[ 0.312849][ T0] per task-struct memory footprint: 2112 bytes
[ 0.313179][ T0] ACPI: Core revision 20220331
[ 0.313558][ T0] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[ 0.314154][ T0] APIC: Switch to symmetric I/O mode setup
[ 0.314455][ T0] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.314780][ T0] kvm-guest: setup PV IPIs
[ 0.315763][ T0] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.316143][ T0] tsc: Marking TSC unstable due to TSCs unsynchronized
[ 0.316515][ T0] Calibrating delay loop (skipped) preset value.. 7386.12 BogoMIPS (lpj=3693060)
[ 0.316987][ T0] pid_max: default: 32768 minimum: 301
[ 0.317531][ T0] LSM: Security Framework initializing
[ 0.317821][ T0] landlock: Up and running.
[ 0.318055][ T0] LoadPin: ready to pin (currently not enforcing)
[ 0.318547][ T0] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 0.318976][ T0] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 0.320037][ T0] x86/cpu: User Mode Instruction Prevention (UMIP) activated
[ 0.320436][ T0] mce: unknown CPU type - not enabling MCE support
[ 0.320518][ T0] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[ 0.320839][ T0] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[ 0.321194][ T0] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[ 0.321512][ T0] Spectre V2 : Kernel not compiled with retpoline; no mitigation available!
[ 0.321514][ T0] Spectre V2 : Vulnerable
[ 0.322511][ T0] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[ 0.322982][ T0] Spectre V2 : Enabling Restricted Speculation for firmware calls
[ 0.323513][ T0] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
[ 0.323995][ T0] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
[ 0.324511][ T0] MMIO Stale Data: Unknown: No mitigations
[ 0.325241][ T0] Freeing SMP alternatives memory: 40K
[ 0.325701][ T1] smpboot: CPU0: AuthenticAMD AMD Ryzen 9 5900X 12-Core Processor (family: 0x19, model: 0x21, stepping: 0x0)
[ 0.326509][ T1] cblist_init_generic: Setting adjustable number of callback queues.
[ 0.326514][ T1] cblist_init_generic: Setting shift to 2 and lim to 1.
[ 0.326931][ T1] cblist_init_generic: Setting shift to 2 and lim to 1.
[ 0.327343][ T1] cblist_init_generic: Setting shift to 2 and lim to 1.
[ 0.327564][ T1] Running RCU-tasks wait API self tests
[ 0.435625][ T1] Performance Events: no PMU driver, software events only.
[ 0.436197][ T1] rcu: Hierarchical SRCU implementation.
[ 0.436514][ T1] rcu: Max phase no-delay instances is 400.
[ 0.438238][ T1] NMI watchdog: Perf NMI watchdog permanently disabled
[ 0.438708][ T1] smp: Bringing up secondary CPUs ...
[ 0.439395][ T1] x86: Booting SMP configuration:
[ 0.439520][ T1] .... node #0, CPUs: #1
[ 0.054529][ T0] smpboot: CPU 1 Converting physical 0 to logical die 1
[ 0.451921][ T1] #2
[ 0.054529][ T0] smpboot: CPU 2 Converting physical 0 to logical die 2
[ 0.463949][ T11] Callback from call_rcu_tasks_trace() invoked.
[ 0.464582][ T1] #3
[ 0.054529][ T0] smpboot: CPU 3 Converting physical 0 to logical die 3
[ 0.476576][ T1] smp: Brought up 1 node, 4 CPUs
[ 0.476842][ T1] smpboot: Max logical packages: 4
[ 0.477108][ T1] smpboot: Total of 4 processors activated (29544.48 BogoMIPS)
[ 0.478017][ T1] devtmpfs: initialized
[ 0.478696][ T1] version magic: 0x4231322a
[ 0.481205][ T1] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.481524][ T1] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[ 0.481988][ T1] pinctrl core: initialized pinctrl subsystem
[ 0.482310][ T1] pinctrl core: failed to create debugfs directory
[ 0.482894][ T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 0.484036][ T1] thermal_sys: Registered thermal governor 'step_wise'
[ 0.484039][ T1] thermal_sys: Registered thermal governor 'user_space'
[ 0.484438][ T1] cpuidle: using governor ladder
[ 0.485136][ T1] PCI: PCI BIOS revision 2.10 entry at 0xfd1d0, last bus=0
[ 0.485514][ T1] PCI: Using configuration type 1 for base access
[ 0.510154][ T1] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
[ 0.513790][ T1] HugeTLB: registered 4.00 MiB page size, pre-allocated 0 pages
[ 0.514394][ T1] HugeTLB: 0 KiB vmemmap can be freed for a 4.00 MiB page
[ 0.515443][ T1] cryptd: max_cpu_qlen set to 1000
[ 0.516103][ T1] gpio-f7188x: Unsupported Fintek device 0xffff
[ 0.516531][ T1] gpio-f7188x: Unsupported Fintek device 0xffff
[ 0.517344][ T1] ACPI: Added _OSI(Module Device)
[ 0.518520][ T1] ACPI: Added _OSI(Processor Device)
[ 0.518876][ T1] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.519245][ T1] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.523634][ T1] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 0.526125][ T1] ACPI: Interpreter enabled
[ 0.526429][ T1] ACPI: PM: (supports S0 S5)
[ 0.526519][ T1] ACPI: Using IOAPIC for interrupt routing
[ 0.526865][ T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.527479][ T1] PCI: Using E820 reservations for host bridge windows
[ 0.527886][ T1] ACPI: Enabled 2 GPEs in block 00 to 0F
[ 0.538914][ T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.539353][ T1] acpi PNP0A03:00: _OSC: OS supports [Segments HPX-Type3]
[ 0.539515][ T1] acpi PNP0A03:00: PCIe port services disabled; not requesting _OSC control
[ 0.540001][ T1] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 0.541534][ T1] acpi resource window ([0x140000000-0x1bfffffff] ignored, not CPU addressable)
[ 0.542592][ T1] PCI host bridge to bus 0000:00
[ 0.542960][ T1] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.543515][ T1] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 0.543524][ T1] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 0.543972][ T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[ 0.544795][ T10] Callback from call_rcu_tasks_rude() invoked.
[ 0.544411][ T1] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.544931][ T1] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 0.546349][ T1] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 0.546918][ T1] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 0.549342][ T1] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f]
[ 0.549955][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.550405][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.550514][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.550934][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.551461][ T1] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 0.551733][ T1] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
[ 0.552297][ T1] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 0.553684][ T1] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[ 0.557520][ T1] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[ 0.569520][ T1] pci 0000:00:02.0: reg 0x18: [mem 0xfebb0000-0xfebb0fff]
[ 0.591522][ T1] pci 0000:00:02.0: reg 0x30: [mem 0xfeba0000-0xfebaffff pref]
[ 0.592342][ T1] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 0.594709][ T1] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[ 0.608517][ T1] pci 0000:00:03.0: reg 0x10: [mem 0xfeb80000-0xfeb9ffff]
[ 0.620534][ T1] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f]
[ 0.686517][ T1] pci 0000:00:03.0: reg 0x30: [mem 0xfeb00000-0xfeb7ffff pref]
[ 0.689517][ T1] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
[ 0.690272][ T1] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
[ 0.690814][ T1] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
[ 0.691571][ T1] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
[ 0.692206][ T1] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
[ 0.694072][ T1] iommu: Default domain type: Translated
[ 0.694448][ T1] iommu: DMA domain TLB invalidation policy: lazy mode
[ 0.695523][ T1] SCSI subsystem initialized
[ 0.695857][ T1] ACPI: bus type USB registered
[ 0.696170][ T1] usbcore: registered new interface driver usbfs
[ 0.696534][ T1] usbcore: registered new interface driver hub
[ 0.696879][ T1] usbcore: registered new device driver usb
[ 0.697390][ T1] cec: Failed to create debugfs cec dir
[ 0.698669][ T1] FPGA manager framework
[ 0.699350][ T1] PCI: Using ACPI for IRQ routing
[ 0.699660][ T1] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.4)
[ 0.700364][ T1] clocksource: Switched to clocksource kvm-clock
[ 0.755598][ T9] Callback from call_rcu_tasks() invoked.
[ 0.779906][ T1] VFS: Disk quotas dquot_6.6.0
[ 0.780256][ T1] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.780832][ T1] FS-Cache: Loaded
[ 0.781358][ T1] CacheFiles: Loaded
[ 0.781694][ T1] pnp: PnP ACPI init
[ 0.783150][ T1] pnp: PnP ACPI: found 6 devices
[ 0.819007][ T1] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 0.819835][ T1] intel_rapl_common: driver does not support CPU family 25 model 33
[ 0.820309][ T1] NET: Registered PF_INET protocol family
[ 0.820702][ T1] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 0.821502][ T1] tcp_listen_portaddr_hash hash table entries: 512 (order: 2, 24576 bytes, linear)
[ 0.822023][ T1] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.822494][ T1] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[ 0.823083][ T1] TCP bind hash table entries: 8192 (order: 7, 786432 bytes, linear)
[ 0.823728][ T1] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.824161][ T1] UDP hash table entries: 512 (order: 3, 57344 bytes, linear)
[ 0.824587][ T1] UDP-Lite hash table entries: 512 (order: 3, 57344 bytes, linear)
[ 0.825068][ T1] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 0.825860][ T1] RPC: Registered named UNIX socket transport module.
[ 0.826233][ T1] RPC: Registered udp transport module.
[ 0.826550][ T1] RPC: Registered tcp transport module.
[ 0.826841][ T1] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.827226][ T1] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 0.827605][ T1] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
[ 0.827972][ T1] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[ 0.828377][ T1] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
[ 0.828909][ T1] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 0.829260][ T1] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 0.829629][ T1] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 0.830014][ T1] PCI: CLS 0 bytes, default 64
[ 0.830287][ T1] sta2x11_mfd_init
[ 0.830692][ T7] Unpacking initramfs...
[ 0.833441][ T50] cryptomgr_test (50) used greatest stack depth: 7128 bytes left
[ 0.833531][ T1] The force parameter has not been set to 1. The Iris poweroff handler will not be installed.
[ 0.834811][ T1] rcu-torture:--- Start of test: nreaders=3 nfakewriters=4 stat_interval=60 verbose=1 test_no_idle_hz=1 shuffle_interval=3 stutter=5 irqreader=1 fqs_duration=0 fqs_holdoff=0 fqs_stutter=3 test_boost=1/0 test_boost_interval=7 test_boost_duration=4 shutdown_secs=0 stall_cpu=0 stall_cpu_holdoff=10 stall_cpu_irqsoff=0 stall_cpu_block=0 n_barrier_cbs=0 onoff_interval=0 onoff_holdoff=0 read_exit_delay=13 read_exit_burst=16 nocbs_nthreads=0 nocbs_toggle=1000
[ 0.837004][ T1] rcu: Start-test grace-period state: g-1159 f0x0
[ 0.837345][ T1] rcu_torture_write_types: Testing conditional GPs.
[ 0.837699][ T1] rcu_torture_write_types: Testing conditional expedited GPs.
[ 0.838090][ T1] rcu_torture_write_types: Testing conditional full-state GPs.
[ 0.838493][ T1] rcu_torture_write_types: Testing expedited GPs.
[ 0.838844][ T1] rcu_torture_write_types: Testing asynchronous GPs.
[ 0.839194][ T1] rcu_torture_write_types: Testing polling GPs.
[ 0.839540][ T1] rcu_torture_write_types: Testing polling full-state GPs.
[ 0.839916][ T1] rcu_torture_write_types: Testing polling expedited GPs.
[ 0.840290][ T1] rcu_torture_write_types: Testing polling full-state expedited GPs.
[ 0.840726][ T1] rcu_torture_write_types: Testing normal GPs.
[ 0.841050][ T1] rcu-torture: Creating rcu_torture_writer task
[ 0.841657][ T52] rcu-torture: rcu_torture_writer task started
[ 0.841660][ T1] rcu-torture: Creating rcu_torture_fakewriter task
[ 0.842181][ T52] rcu-torture: GP expediting controlled from boot/sysfs for rcu.
[ 0.842820][ T1] rcu-torture: Creating rcu_torture_fakewriter task
[ 0.843566][ T53] rcu-torture: rcu_torture_fakewriter task started
[ 0.843783][ T1] rcu-torture: Creating rcu_torture_fakewriter task
[ 0.844502][ T54] rcu-torture: rcu_torture_fakewriter task started
[ 0.844883][ T1] rcu-torture: Creating rcu_torture_fakewriter task
[ 0.844893][ T55] rcu-torture: rcu_torture_fakewriter task started
[ 0.845989][ T1] rcu-torture: Creating rcu_torture_reader task
[ 0.846008][ T56] rcu-torture: rcu_torture_fakewriter task started
[ 0.846467][ T1] rcu-torture: Creating rcu_torture_reader task
[ 0.847179][ T57] rcu-torture: rcu_torture_reader task started
[ 0.847625][ T1] rcu-torture: Creating rcu_torture_reader task
[ 0.847644][ T58] rcu-torture: rcu_torture_reader task started
[ 0.848995][ T1] rcu-torture: Creating rcu_torture_stats task
[ 0.849002][ T59] rcu-torture: rcu_torture_reader task started
[ 0.850229][ T1] rcu-torture: Creating torture_shuffle task
[ 0.850246][ T60] rcu-torture: rcu_torture_stats task started
[ 0.854723][ T1] rcu-torture: Creating torture_stutter task
[ 0.854749][ T61] rcu-torture: torture_shuffle task started
[ 0.858792][ T63] rcu-torture: torture_stutter task started
[ 0.858810][ T1] rcu-torture: Creating rcu_torture_fwd_prog task
[ 0.859832][ T1] rcu-torture: Creating rcu_torture_read_exit task
[ 0.859847][ T64] rcu-torture: rcu_torture_fwd_progress task started
[ 0.861650][ T65] rcu-torture: rcu_torture_read_exit: Start of test
[ 0.862138][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1.394362][ T1] Initialise system trusted keyrings
[ 1.394744][ T1] Key type blacklist registered
[ 1.395125][ T1] workingset: timestamp_bits=14 max_order=20 bucket_order=6
[ 1.396147][ T1] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 1.397619][ T1] ntfs: driver 2.1.32 [Flags: R/O DEBUG].
[ 1.397942][ T1] ntfs3: Max link count 4000
[ 1.398184][ T1] ntfs3: Enabled Linux POSIX ACLs support
[ 1.398492][ T1] ntfs3: Read-only LZX/Xpress compression included
[ 1.398859][ T1] efs: 1.0a - http://aeschi.ch.eu.org/efs/
[ 1.399170][ T1] romfs: ROMFS MTD (C) 2007 Red Hat, Inc.
[ 1.399472][ T1] QNX4 filesystem 0.2.3 registered.
[ 1.399760][ T1] qnx6: QNX6 filesystem 1.0.0 registered.
[ 1.400096][ T1] orangefs_debugfs_init: called with debug mask: :none: :0:
[ 1.400830][ T1] orangefs_init: module version upstream loaded
[ 1.401203][ T1] JFS: nTxBlock = 8192, nTxLock = 65536
[ 1.405663][ T1] SGI XFS with ACLs, security attributes, scrub, repair, no debug enabled
[ 1.406663][ T1] NILFS version 2 loaded
[ 1.406893][ T1] befs: version: 0.9.3
[ 1.408130][ T1] gfs2: GFS2 installed
[ 1.416244][ T1] Key type asymmetric registered
[ 1.416555][ T1] Asymmetric key parser 'x509' registered
[ 1.416880][ T1] Asymmetric key parser 'pkcs8' registered
[ 1.417238][ T1] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246)
[ 1.417690][ T1] io scheduler mq-deadline registered
[ 1.417976][ T1] io scheduler kyber registered
[ 1.418245][ T1] io scheduler bfq registered
[ 1.420957][ T1] gpio_it87: no device
[ 1.421938][ T1] gpio_winbond: chip ID at 2e is ffff
[ 1.422229][ T1] gpio_winbond: not an our chip
[ 1.422499][ T1] gpio_winbond: chip ID at 4e is ffff
[ 1.422792][ T1] gpio_winbond: not an our chip
[ 1.423332][ T1] switchtec: loaded.
[ 1.423720][ T1] SPI driver hx8357 has no spi_device_id for himax,hx8369
[ 1.424644][ T1] rivafb_setup START
[ 1.424899][ T1] nvidiafb_setup START
[ 1.425203][ T1] VIA Graphics Integration Chipset framebuffer 2.4 initializing
[ 1.426542][ T1] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 1.426989][ T1] ACPI: button: Power Button [PWRF]
[ 1.501113][ T1] N_HDLC line discipline registered with maxframe=4096
[ 1.501483][ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 1.502093][ T1] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 1.504412][ T1] MOXA Intellio family driver version 6.0k
[ 1.504967][ T1] SyncLink GT
[ 1.505158][ T1] SyncLink GT, tty major#235
[ 1.505427][ T1] SyncLink GT no devices found
[ 3.288449][ T7] Freeing initrd memory: 143520K
[ 3.289124][ T86] kworker/u8:1 (86) used greatest stack depth: 6536 bytes left
[ 3.289229][ T1] lp: driver loaded but no devices found
[ 3.290324][ T1] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $
[ 3.290860][ T1] ac.o: No PCI boards found.
[ 3.291158][ T1] ac.o: For an ISA board you must supply memory and irq parameters.
[ 3.291826][ T1] Non-volatile memory driver v1.3
[ 3.292171][ T1] toshiba: not a supported Toshiba laptop
[ 3.293122][ T1] platform pc8736x_gpio.0: NatSemi pc8736x GPIO Driver Initializing
[ 3.293666][ T1] platform pc8736x_gpio.0: no device found
[ 3.294089][ T1] smapi::smapi_init, ERROR invalid usSmapiID
[ 3.294483][ T1] mwave: tp3780i::tp3780I_InitializeBoardData: Error: SMAPI is not available on this machine
[ 3.295155][ T1] mwave: mwavedd::mwave_init: Error: Failed to initialize board data
[ 3.295687][ T1] mwave: mwavedd::mwave_init: Error: Failed to initialize
[ 3.296227][ T1] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds).
[ 3.296916][ T1] usbcore: registered new interface driver xillyusb
[ 3.297360][ T1] ACPI: bus type drm_connector registered
[ 3.298300][ T1] [drm] Initialized vgem 1.0.0 20120112 for vgem on minor 0
[ 3.299049][ T1] SPI driver panel-innolux-ej030na has no spi_device_id for innolux,ej030na
[ 3.299875][ T1] SPI driver nv3052c has no spi_device_id for leadtek,ltk035c5444t
[ 3.300437][ T1] SPI driver nt39016 has no spi_device_id for kingdisplay,kd035g6-54nt
[ 3.301111][ T1] SPI driver db7430-panel has no spi_device_id for samsung,lms397kf04
[ 3.301930][ T1] SPI driver ws2401-panel has no spi_device_id for samsung,lms380kf01
[ 3.303558][ T1] [drm] Found bochs VGA, ID 0xb0c0.
[ 3.303832][ T1] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebb0000.
[ 3.304907][ T1] [drm] Found EDID data blob.
[ 3.305401][ T1] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 1
[ 3.308072][ T1] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device
[ 3.308664][ T1] usbcore: registered new interface driver gm12u320
[ 3.309046][ T1] SPI driver ili9163 has no spi_device_id for newhaven,1.8-128160EF
[ 3.309481][ T1] SPI driver ili9486 has no spi_device_id for waveshare,rpi-lcd-35
[ 3.309908][ T1] SPI driver ili9486 has no spi_device_id for ozzmaker,piscreen
[ 3.310430][ T1] usbcore: registered new interface driver gud
[ 3.311132][ T1] parport_pc 00:03: reported by Plug and Play ACPI
[ 3.311627][ T1] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[ 3.403962][ T1] lp0: using parport0 (interrupt-driven).
[ 3.404346][ T1] lp0: console ready
[ 3.404777][ T1] parport_pc parport_pc.956: Unable to set coherent dma mask: disabling DMA
[ 3.405773][ T1] parport_pc parport_pc.888: Unable to set coherent dma mask: disabling DMA
[ 3.406724][ T1] parport_pc parport_pc.632: Unable to set coherent dma mask: disabling DMA
[ 3.407917][ T1] ibmasm: IBM ASM Service Processor Driver version 1.0 loaded
[ 3.408400][ T1] dummy-irq: no IRQ given. Use irq=N
[ 3.408943][ T1] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti
[ 3.409851][ T1] usbcore: registered new interface driver rtsx_usb
[ 3.410334][ T1] habanalabs: loading driver
[ 3.412216][ T1] snic:SNIC Driver is supported only for x86_64 platforms!
[ 3.412694][ T1] snic:Cisco SCSI NIC Driver, ver 0.0.1.18
[ 3.413101][ T1] snic:Trace Facility Enabled.
[ 3.413101][ T1] Trace Buffer SZ 16 Pages.
[ 3.414604][ T1] Adaptec aacraid driver 1.2.1[50983]-custom
[ 3.415035][ T1] aic94xx: Adaptec aic94xx SAS/SATA driver version 1.0.3 loaded
[ 3.415760][ T1] isci: Intel(R) C600 SAS Controller Driver - version 1.2.0
[ 3.416315][ T1] Microchip SmartPQI Driver (v2.1.18-045)
[ 3.416752][ T1] megaraid cmm: 2.20.2.7 (Release Date: Sun Jul 16 00:01:03 EST 2006)
[ 3.417279][ T1] megaraid: 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006)
[ 3.417735][ T1] megasas: 07.719.03.00-rc1
[ 3.418020][ T1] mpt3sas version 43.100.00.00 loaded
[ 3.418629][ T1] 3ware Storage Controller device driver for Linux v1.26.02.003.
[ 3.419064][ T1] 3ware 9000 Storage Controller device driver for Linux v2.26.02.014.
[ 3.419611][ T1] LSI 3ware SAS/SATA-RAID Controller device driver for Linux v3.26.02.000.
[ 3.420728][ T1] nsp32: loading...
[ 3.420955][ T1] RocketRAID 3xxx/4xxx Controller driver v1.10.0
[ 3.421312][ T1] stex: Promise SuperTrak EX Driver version: 6.02.0000.01
[ 3.421866][ T1] VMware PVSCSI driver - version 1.0.7.0-k
[ 3.426713][ T1] scsi_debug:sdebug_driver_probe: scsi_debug: trim poll_queues to 0. poll_q/nr_hw = (0/1)
[ 3.427238][ T1] scsi host0: scsi_debug: version 0191 [20210520]
[ 3.427238][ T1] dev_size_mb=8, opts=0x0, submit_queues=1, statistics=0
[ 3.429009][ T35] scsi 0:0:0:0: Direct-Access Linux scsi_debug 0191 PQ: 0 ANSI: 7
[ 3.432040][ T1] SSFDC read-only Flash Translation layer
[ 3.432368][ T1] mtdoops: mtd device (mtddev=name/number) must be supplied
[ 3.432578][ T35] scsi 0:0:0:0: Attached scsi generic sg0 type 0
[ 3.432792][ T1] L440GX flash mapping: failed to find PIIX4 ISA bridge, cannot continue
[ 3.433993][ T1] Ramix PMC551 PCI Mezzanine Ram Driver. (C) 1999,2000 Nortel Networks.
[ 3.434441][ T1] pmc551: not detected
[ 3.434908][ T1] Driver 'dfl-spi-altera' was unable to register with bus_type 'dfl' because the bus was not initialized.
[ 3.549960][ T1] parport0: AVR Butterfly
[ 3.550748][ T1] e1000: Intel(R) PRO/1000 Network Driver
[ 3.551120][ T1] e1000: Copyright (c) 1999-2006 Intel Corporation.
[ 3.765706][ T1] ACPI: \_SB_.LNKC: Enabled at IRQ 11
[ 4.055076][ T1] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56
[ 4.055685][ T1] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection
[ 4.056949][ T1] VFIO - User Level meta-driver version: 0.3
[ 4.057771][ T1] parport0: cannot grant exclusive access for device ks0108
[ 4.058310][ T1] ks0108: ERROR: parport didn't register new device
[ 4.058809][ T1] cfag12864b: ERROR: ks0108 is not initialized
[ 4.059253][ T1] cfag12864bfb: ERROR: cfag12864b is not initialized
[ 4.060122][ T1] panel: could not claim access to parport0. Aborting.
[ 4.060740][ T1] panel: panel driver not yet registered
[ 4.061918][ T1] Warning! fotg210_hcd should always be loaded before uhci_hcd and ohci_hcd, not after
[ 4.062774][ T1] usbcore: registered new interface driver cdc_acm
[ 4.063248][ T1] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
[ 4.063953][ T1] usbcore: registered new interface driver usblp
[ 4.064425][ T1] usbcore: registered new interface driver cdc_wdm
[ 4.064798][ T1] usbcore: registered new interface driver usbtmc
[ 4.065158][ T1] usbcore: registered new interface driver mdc800
[ 4.065618][ T1] mdc800: v0.7.5 (30/10/2000):USB Driver for Mustek MDC800 Digital Camera
[ 4.066272][ T1] usbcore: registered new interface driver microtekX6
[ 4.066860][ T1] usbcore: registered new interface driver belkin_sa
[ 4.067396][ T1] usbserial: USB Serial support registered for Belkin / Peracom / GoHubs USB Serial Adapter
[ 4.068160][ T1] usbcore: registered new interface driver cp210x
[ 4.068675][ T1] usbserial: USB Serial support registered for cp210x
[ 4.069195][ T1] usbcore: registered new interface driver cyberjack
[ 4.069728][ T1] usbserial: USB Serial support registered for Reiner SCT Cyberjack USB card reader
[ 4.070458][ T1] usbcore: registered new interface driver cypress_m8
[ 4.070990][ T1] usbserial: USB Serial support registered for DeLorme Earthmate USB
[ 4.071637][ T1] usbserial: USB Serial support registered for HID->COM RS232 Adapter
[ 4.072303][ T1] usbserial: USB Serial support registered for Nokia CA-42 V2 Adapter
[ 4.072942][ T1] usbcore: registered new interface driver io_edgeport
[ 4.073481][ T1] usbserial: USB Serial support registered for Edgeport 2 port adapter
[ 4.074096][ T1] usbserial: USB Serial support registered for Edgeport 4 port adapter
[ 4.074735][ T1] usbserial: USB Serial support registered for Edgeport 8 port adapter
[ 4.075360][ T1] usbserial: USB Serial support registered for EPiC device
[ 4.075922][ T1] usbcore: registered new interface driver empeg
[ 4.076412][ T1] usbserial: USB Serial support registered for empeg
[ 4.076836][ T1] usbcore: registered new interface driver f81534a_ctrl
[ 4.077217][ T1] usbcore: registered new interface driver f81232
[ 4.077722][ T1] usbserial: USB Serial support registered for f81232
[ 4.078255][ T1] usbserial: USB Serial support registered for f81534a
[ 4.078799][ T1] usbcore: registered new interface driver garmin_gps
[ 4.079313][ T1] usbserial: USB Serial support registered for Garmin GPS usb/tty
[ 4.079920][ T1] usbcore: registered new interface driver ipaq
[ 4.080417][ T1] usbserial: USB Serial support registered for PocketPC PDA
[ 4.080973][ T1] usbcore: registered new interface driver ir_usb
[ 4.081464][ T1] usbserial: USB Serial support registered for IR Dongle
[ 4.082026][ T1] usbcore: registered new interface driver iuu_phoenix
[ 4.082717][ T1] usbserial: USB Serial support registered for iuu_phoenix
[ 4.083273][ T1] usbcore: registered new interface driver keyspan
[ 4.083826][ T1] usbserial: USB Serial support registered for Keyspan - (without firmware)
[ 4.084538][ T1] usbserial: USB Serial support registered for Keyspan 1 port adapter
[ 4.085172][ T1] usbserial: USB Serial support registered for Keyspan 2 port adapter
[ 4.085814][ T1] usbserial: USB Serial support registered for Keyspan 4 port adapter
[ 4.086433][ T1] usbcore: registered new interface driver keyspan_pda
[ 4.086973][ T1] usbserial: USB Serial support registered for Keyspan PDA
[ 4.087564][ T1] usbserial: USB Serial support registered for Keyspan PDA - (prerenumeration)
[ 4.088251][ T1] usbcore: registered new interface driver kl5kusb105
[ 4.088655][ T1] usbserial: USB Serial support registered for KL5KUSB105D / PalmConnect
[ 4.089112][ T1] usbcore: registered new interface driver mct_u232
[ 4.089588][ T1] usbserial: USB Serial support registered for MCT U232
[ 4.090117][ T1] usbcore: registered new interface driver mxuport
[ 4.090632][ T1] usbserial: USB Serial support registered for MOXA UPort
[ 4.091179][ T1] usbcore: registered new interface driver omninet
[ 4.091697][ T1] usbserial: USB Serial support registered for ZyXEL - omni.net usb
[ 4.092309][ T1] usbcore: registered new interface driver opticon
[ 4.092820][ T1] usbserial: USB Serial support registered for opticon
[ 4.093348][ T1] usbcore: registered new interface driver qcaux
[ 4.093843][ T1] usbserial: USB Serial support registered for qcaux
[ 4.094371][ T1] usbcore: registered new interface driver safe_serial
[ 4.094927][ T1] usbserial: USB Serial support registered for safe_serial
[ 4.095498][ T1] usbcore: registered new interface driver sierra
[ 4.096050][ T1] usbserial: USB Serial support registered for Sierra USB modem
[ 4.096662][ T1] usbcore: registered new interface driver usb_serial_simple
[ 4.097217][ T1] usbserial: USB Serial support registered for carelink
[ 4.097752][ T1] usbserial: USB Serial support registered for zio
[ 4.098285][ T1] usbserial: USB Serial support registered for funsoft
[ 4.098886][ T1] usbserial: USB Serial support registered for flashloader
[ 4.099497][ T1] usbserial: USB Serial support registered for google
[ 4.100086][ T1] usbserial: USB Serial support registered for libtransistor
[ 4.100726][ T1] usbserial: USB Serial support registered for vivopay
[ 4.101308][ T1] usbserial: USB Serial support registered for moto_modem
[ 4.101921][ T1] usbserial: USB Serial support registered for motorola_tetra
[ 4.102575][ T1] usbserial: USB Serial support registered for nokia
[ 4.103100][ T1] usbserial: USB Serial support registered for novatel_gps
[ 4.103493][ T1] usbserial: USB Serial support registered for hp4x
[ 4.103860][ T1] usbserial: USB Serial support registered for suunto
[ 4.104226][ T1] usbserial: USB Serial support registered for siemens_mpi
[ 4.104630][ T1] usbcore: registered new interface driver spcp8x5
[ 4.104986][ T1] usbserial: USB Serial support registered for SPCP8x5
[ 4.105363][ T1] usbcore: registered new interface driver ssu100
[ 4.105724][ T1] usbserial: USB Serial support registered for Quatech SSU-100 USB to Serial Driver
[ 4.106229][ T1] usbcore: registered new interface driver symbolserial
[ 4.106620][ T1] usbserial: USB Serial support registered for symbol
[ 4.106991][ T1] usbcore: registered new interface driver visor
[ 4.107334][ T1] usbserial: USB Serial support registered for Handspring Visor / Palm OS
[ 4.107799][ T1] usbserial: USB Serial support registered for Sony Clie 5.0
[ 4.108191][ T1] usbserial: USB Serial support registered for Sony Clie 3.5
[ 4.108602][ T1] usbcore: registered new interface driver wishbone_serial
[ 4.108992][ T1] usbserial: USB Serial support registered for wishbone_serial
[ 4.109403][ T1] usbcore: registered new interface driver xsens_mt
[ 4.109771][ T1] usbserial: USB Serial support registered for xsens_mt
[ 4.110154][ T1] usbcore: registered new interface driver cypress_cy7c63
[ 4.110624][ T1] usbcore: registered new interface driver cytherm
[ 4.110983][ T1] usbcore: registered new interface driver emi26 - firmware loader
[ 4.111413][ T1] usbcore: registered new interface driver emi62 - firmware loader
[ 4.111852][ T1] usbcore: registered new device driver apple-mfi-fastcharge
[ 4.112255][ T1] usbcore: registered new interface driver idmouse
[ 4.112624][ T1] usbcore: registered new interface driver iowarrior
[ 4.112992][ T1] usbcore: registered new interface driver usblcd
[ 4.113345][ T1] usbcore: registered new interface driver legousbtower
[ 4.113739][ T1] usbcore: registered new interface driver trancevibrator
[ 4.114130][ T1] usbcore: registered new interface driver uss720
[ 4.114471][ T1] uss720: USB Parport Cable driver for Cables using the Lucent Technologies USS720 Chip
[ 4.114989][ T1] uss720: NOTE: this is a special purpose driver to allow nonstandard
[ 4.115412][ T1] uss720: protocols (eg. bitbang) over USS720 usb to parallel cables
[ 4.115842][ T1] uss720: If you just want to connect to a printer, use usblp instead
[ 4.116289][ T1] usbcore: registered new interface driver usbsevseg
[ 4.116668][ T1] usbcore: registered new interface driver yurex
[ 4.117081][ T1] usbcore: registered new interface driver sisusb
[ 4.117449][ T1] usbcore: registered new device driver onboard-usb-hub
[ 4.117993][ T1] dummy_hcd dummy_hcd.0: USB Host+Gadget Emulator, driver 02 May 2005
[ 4.118425][ T1] dummy_hcd dummy_hcd.0: Dummy host controller
[ 4.118917][ T1] dummy_hcd dummy_hcd.0: new USB bus registered, assigned bus number 1
[ 4.119954][ T1] hub 1-0:1.0: USB hub found
[ 4.120238][ T1] hub 1-0:1.0: 1 port detected
[ 4.121464][ T1] SPI driver max3420-udc has no spi_device_id for maxim,max3421-udc
[ 4.121996][ T1] zero gadget.0: Gadget Zero, version: Cinco de Mayo 2008
[ 4.122376][ T1] zero gadget.0: zero ready
[ 4.122826][ T1] gadgetfs: USB Gadget filesystem, version 24 Aug 2004
[ 4.123203][ T1] UDC core: g_serial: couldn't find an available UDC
[ 4.123640][ T1] UDC core: printer: couldn't find an available UDC
[ 4.124031][ T1] UDC core: g_acm_ms: couldn't find an available UDC
[ 4.124454][ T1] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 4.125495][ T1] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 4.125836][ T1] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 4.126353][ T1] parport0: cannot grant exclusive access for device parkbd
[ 4.150061][ T1] SPI driver ads7846 has no spi_device_id for ti,tsc2046
[ 4.150434][ T1] SPI driver ads7846 has no spi_device_id for ti,ads7843
[ 4.150817][ T1] SPI driver ads7846 has no spi_device_id for ti,ads7845
[ 4.151184][ T1] SPI driver ads7846 has no spi_device_id for ti,ads7873
[ 4.151732][ T40] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 4.153051][ T1] SPI driver cyttsp-spi has no spi_device_id for cypress,cy8ctma340
[ 4.153471][ T1] SPI driver cyttsp-spi has no spi_device_id for cypress,cy8ctst341
[ 4.154250][ T1] mk712: device not present
[ 4.154589][ T1] usbcore: registered new interface driver usbtouchscreen
[ 4.155424][ T1] i2c_dev: i2c /dev entries driver
[ 4.155857][ T1] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
[ 4.159088][ T1] usbcore: registered new interface driver i2c-diolan-u2c
[ 4.159584][ T1] usbcore: registered new interface driver i2c-cp2615
[ 4.159968][ T1] i2c-parport: adapter type unspecified
[ 4.160301][ T1] usbcore: registered new interface driver RobotFuzz Open Source InterFace, OSIF
[ 4.160837][ T1] usbcore: registered new interface driver i2c-tiny-usb
[ 4.161369][ T1] IR JVC protocol handler initialized
[ 4.161661][ T1] IR RC5(x/sz) protocol handler initialized
[ 4.161969][ T1] IR RC6 protocol handler initialized
[ 4.162249][ T1] IR RCMM protocol handler initialized
[ 4.162559][ T1] IR SANYO protocol handler initialized
[ 4.162857][ T1] IR Sharp protocol handler initialized
[ 4.163146][ T1] IR XMP protocol handler initialized
[ 4.163482][ T1] usbcore: registered new interface driver iguanair
[ 4.163862][ T1] usbcore: registered new interface driver imon
[ 4.164207][ T1] usbcore: registered new interface driver imon_raw
[ 4.164583][ T1] SPI driver ir-spi has no spi_device_id for ir-spi-led
[ 4.164987][ T1] usbcore: registered new interface driver streamzap
[ 4.165351][ T1] usbcore: registered new interface driver ir_toy
[ 4.165717][ T1] usbcore: registered new interface driver ttusbir
[ 4.166087][ T1] usbcore: registered new interface driver ati_remote
[ 4.166455][ T1] Registered IR keymap rc-empty
[ 4.166766][ T1] rc rc0: rc-core loopback device as /devices/virtual/rc/rc0
[ 4.167251][ T1] rc rc0: lirc_dev: driver rc-loopback registered at minor = 0, raw IR receiver, raw IR transmitter
[ 4.167887][ T1] input: rc-core loopback device as /devices/virtual/rc/rc0/input3
[ 4.168826][ T1] Driver for 1-wire Dallas network protocol.
[ 4.169219][ T1] usbcore: registered new interface driver DS9490R
[ 4.346595][ T81] usb 1-1: new high-speed USB device number 2 using dummy_hcd
[ 4.484113][ T1] pc87360: PC8736x not detected, module not inserted
[ 4.515160][ T1] intel_powerclamp: CPU does not support MWAIT
[ 4.515717][ T1] cpufreq_nforce2: No nForce2 chipset
[ 4.519164][ T1] SPI driver leds_cr0014114 has no spi_device_id for crane,cr0014114
[ 4.519763][ T1] SPI driver leds_el15203000 has no spi_device_id for crane,el15203000
[ 4.520322][ T1] SPI driver leds_spi_byte has no spi_device_id for ubnt,acb-spi-led
[ 4.521798][ T1] hid: raw HID events driver (C) Jiri Kosina
[ 4.525018][ T1] usbcore: registered new interface driver usbhid
[ 4.525357][ T1] usbhid: USB HID core driver
[ 4.525733][ T1] usbcore: registered new interface driver es2_ap_driver
[ 4.526099][ T1] comedi: version 0.7.76 - http://www.comedi.org
[ 4.527644][ T1] usbcore: registered new interface driver dt9812
[ 4.528001][ T1] usbcore: registered new interface driver ni6501
[ 4.528353][ T1] usbcore: registered new interface driver usbdux
[ 4.528732][ T1] usbcore: registered new interface driver vmk80xx
[ 4.529781][ T1] dell_smbios: Unable to run on non-Dell system
[ 4.530110][ T1] hdaps: supported laptop not found!
[ 4.530400][ T1] hdaps: driver init failed (ret=-19)!
[ 4.531011][ T1] Driver 'dfl-emif' was unable to register with bus_type 'dfl' because the bus was not initialized.
[ 4.531666][ T1] IDT PCI-E Non-Transparent Bridge Driver 2.0
[ 4.532143][ T1] SPI driver xlnx-slave-spi has no spi_device_id for xlnx,fpga-slave-serial
[ 4.533163][ T1] NET: Registered PF_INET6 protocol family
[ 4.534089][ T1] Segment Routing with IPv6
[ 4.534453][ T1] In-situ OAM (IOAM) with IPv6
[ 4.535005][ T1] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 4.535965][ T1] NET: Registered PF_PACKET protocol family
[ 4.536362][ T1] 9pnet: Installing 9P2000 support
[ 4.537968][ T1] mce: Unable to init MCE device (rc: -5)
[ 4.538456][ T1] IPI shorthand broadcast: enabled
[ 4.539386][ T1] sched_clock: Marking stable (4485310219, 53529074)->(4544895601, -6056308)
[ 4.540253][ T1] Loading compiled-in X.509 certificates
[ 4.542973][ T1] Key type encrypted registered
[ 4.543328][ T1] evm: Initialising EVM extended attributes:
[ 4.543785][ T1] evm: security.selinux (disabled)
[ 4.544136][ T1] evm: security.SMACK64 (disabled)
[ 4.544519][ T1] evm: security.SMACK64EXEC (disabled)
[ 4.544935][ T1] evm: security.SMACK64TRANSMUTE (disabled)
[ 4.545392][ T1] evm: security.SMACK64MMAP (disabled)
[ 4.545806][ T1] evm: security.apparmor (disabled)
[ 4.546177][ T1] evm: security.ima (disabled)
[ 4.546502][ T1] evm: security.capability
[ 4.546830][ T1] evm: HMAC attrs: 0x1
[ 4.547113][ T1] evm: Error registering secfs
[ 4.559141][ T1] UBI error: cannot create "ubi" debugfs directory, error -2
[ 4.559783][ T1] UBI error: cannot initialize UBI, error -2
[ 4.560258][ T1] RAS: Correctable Errors collector initialized.
[ 4.562187][ T1] Freeing unused kernel image (initmem) memory: 2656K
[ 4.568828][ T1] Write protecting kernel text and read-only data: 54956k
[ 4.569148][ T1] Run /init as init process
[ 4.573991][ T190] mount (190) used greatest stack depth: 5984 bytes left
[ 4.582099][ T193] mount (193) used greatest stack depth: 5884 bytes left
[ 4.602429][ T202] hostname (202) used greatest stack depth: 5808 bytes left
Starting syslogd: OK
Starting klogd: OK
Running sysctl: OK
Initializing random number generator: FAIL
Starting network: [ 4.815998][ T228] ip (228) used greatest stack depth: 5292 bytes left
OK
[ 4.830720][ T231] process 231 (getty) attempted a POSIX timer syscall while CONFIG_POSIX_TIMERS is not set
Welcome to Buildroot
buildroot login: [ 5.884632][ T65] rcu-torture: rcu_torture_read_exit: End of episode
root
# [ 19.357547][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 19.382758][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 32.923558][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 36.866196][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 50.204568][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 50.231495][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 62.747571][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 62.747613][ T60] rcu-torture:
[ 62.747929][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 62.747941][ T60] rtc: b97a5dc1 ver: 3870 tfle: 0 rta: 3871 rtaf: 0 rtf: 3859 rtmbe: 0 rtmbkf: 0/3791 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 67093 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 64 nocb-toggles: 0:0
[ 62.749738][ T60] rcu-torture: Reader Pipe: 14136359 6565 0 0 0 0 0 0 0 0 0
[ 62.750255][ T60] rcu-torture: Reader Batch: 14123614 19310 0 0 0 0 0 0 0 0 0
[ 62.750859][ T60] rcu-torture: Free-Block Circulation: 3870 3869 3868 3867 3865 3864 3863 3862 3861 3859 0
[ 62.803988][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 62.844049][ T64] rcu_torture_fwd_prog_cr Duration 51 barrier: 40 pending 2332 n_launders: 3996 n_launders_sa: 2331 n_max_gps: 100 n_max_cbs: 3653 cver 3 gps 11
[ 62.844739][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 92 jiffies): 1s/10: 7649:15
[ 63.579565][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 63.899577][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 67.889256][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 81.244589][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 81.322773][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 85.467552][ T64] rcu_torture_fwd_prog_nr: 0 Duration 21564 cver 1397 gps 3186
[ 85.477771][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 94.683554][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 98.878967][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 112.219608][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 112.244947][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 124.187763][ T60] rcu-torture: rtc: 95a097f9 ver: 7773 tfle: 0 rta: 7774 rtaf: 0 rtf: 7764 rtmbe: 0 rtmbkf: 0/7597 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 133791 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 128 nocb-toggles: 0:0
[ 124.188983][ T60] rcu-torture: Reader Pipe: 28865891 12621 0 0 0 0 0 0 0 0 0
[ 124.189449][ T60] rcu-torture: Reader Batch: 28840036 38476 0 0 0 0 0 0 0 0 0
[ 124.189988][ T60] rcu-torture: Free-Block Circulation: 7773 7772 7771 7770 7769 7768 7767 7766 7765 7764 0
[ 125.595547][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 129.880819][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 143.199610][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 143.211459][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 148.764308][ T64] rcu_torture_fwd_prog n_max_cbs: 3653
[ 148.764659][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 148.765057][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 148.822646][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 148.859499][ T64] rcu_torture_fwd_prog_cr Duration 48 barrier: 36 pending 1078 n_launders: 3046 n_launders_sa: 1078 n_max_gps: 100 n_max_cbs: 5399 cver 4 gps 12
[ 148.860878][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 86 jiffies): 1s/10: 8445:15
[ 149.917720][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 156.635560][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 160.910597][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 169.199522][ T64] rcu_torture_fwd_prog_nr: 0 Duration 19274 cver 1084 gps 2337
[ 169.203548][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 174.235623][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 174.246525][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 185.627570][ T60] rcu-torture: rtc: 6676a49e ver: 11677 tfle: 0 rta: 11678 rtaf: 0 rtf: 11666 rtmbe: 0 rtmbkf: 0/11410 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 199193 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 192 nocb-toggles: 0:0
[ 185.628467][ T60] rcu-torture: Reader Pipe: 47487019 18700 0 0 0 0 0 0 0 0 0
[ 185.628834][ T60] rcu-torture: Reader Batch: 47450547 55172 0 0 0 0 0 0 0 0 0
[ 185.629178][ T60] rcu-torture: Free-Block Circulation: 11677 11676 11674 11673 11672 11671 11669 11668 11667 11666 0
[ 187.675604][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 191.885763][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 205.212632][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 205.241551][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 218.587572][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 222.887759][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 230.684573][ T64] rcu_torture_fwd_prog n_max_cbs: 5399
[ 230.684797][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 230.685055][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 230.752870][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 230.802305][ T64] rcu_torture_fwd_prog_cr Duration 57 barrier: 49 pending 1833 n_launders: 4772 n_launders_sa: 1832 n_max_gps: 100 n_max_cbs: 3450 cver 5 gps 10
[ 230.804741][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 109 jiffies): 1s/10: 8222:14
[ 231.836618][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 236.252558][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 236.265482][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 247.067790][ T60] rcu-torture: rtc: 96a6e0fa ver: 15479 tfle: 0 rta: 15480 rtaf: 0 rtf: 15470 rtmbe: 0 rtmbkf: 0/14500 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 264000 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 256 nocb-toggles: 0:0
[ 247.068922][ T60] rcu-torture: Reader Pipe: 61400414 24556 0 0 0 0 0 0 0 0 0
[ 247.069410][ T60] rcu-torture: Reader Batch: 61352754 72216 0 0 0 0 0 0 0 0 0
[ 247.069899][ T60] rcu-torture: Free-Block Circulation: 15479 15478 15477 15476 15475 15474 15473 15472 15471 15470 0
[ 249.627564][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 253.929566][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 255.668556][ T64] rcu_torture_fwd_prog_nr: 0 Duration 23816 cver 1383 gps 3272
[ 255.680605][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 267.292546][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 267.304825][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 280.731632][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 284.898469][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 298.204555][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 298.233602][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 308.508176][ T60] rcu-torture: rtc: 852baa3e ver: 19609 tfle: 0 rta: 19610 rtaf: 0 rtf: 19600 rtmbe: 0 rtmbkf: 0/17896 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 329697 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 320 nocb-toggles: 0:0
[ 308.509043][ T60] rcu-torture: Reader Pipe: 75783891 31604 0 0 0 0 0 0 0 0 0
[ 308.509346][ T60] rcu-torture: Reader Batch: 75723940 91555 0 0 0 0 0 0 0 0 0
[ 308.509666][ T60] rcu-torture: Free-Block Circulation: 19609 19608 19607 19606 19605 19604 19603 19602 19601 19600 0
[ 311.643552][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 315.897989][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 316.699800][ T64] rcu_torture_fwd_prog n_max_cbs: 3450
[ 316.700102][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 316.700388][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 316.739177][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 316.769676][ T64] rcu_torture_fwd_prog_cr Duration 31 barrier: 31 pending 1462 n_launders: 2959 n_launders_sa: 1461 n_max_gps: 100 n_max_cbs: 1945 cver 5 gps 9
[ 316.770369][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 62 jiffies): 1s/10: 4904:13
[ 317.788672][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 329.243591][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 329.258583][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 339.293545][ T64] rcu_torture_fwd_prog_nr: 0 Duration 21498 cver 1551 gps 3581
[ 339.305596][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 342.619550][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 346.896413][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 360.219667][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 360.254579][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 369.947602][ T60] rcu-torture: rtc: 5ae9494e ver: 23450 tfle: 0 rta: 23451 rtaf: 0 rtf: 23440 rtmbe: 0 rtmbkf: 0/20913 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 394847 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 384 nocb-toggles: 0:0
[ 369.948506][ T60] rcu-torture: Reader Pipe: 89758302 37513 0 0 0 0 0 0 0 0 0
[ 369.948938][ T60] rcu-torture: Reader Batch: 89688416 107399 0 0 0 0 0 0 0 0 0
[ 369.949288][ T60] rcu-torture: Free-Block Circulation: 23450 23449 23448 23447 23446 23445 23444 23443 23442 23440 0
[ 373.595561][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 377.892901][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 391.196676][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 391.226482][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 402.716677][ T64] rcu_torture_fwd_prog n_max_cbs: 1945
[ 402.716975][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 402.717330][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 402.768928][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 402.801062][ T64] rcu_torture_fwd_prog_cr Duration 39 barrier: 32 pending 5478 n_launders: 11916 n_launders_sa: 5477 n_max_gps: 100 n_max_cbs: 7758 cver 3 gps 10
[ 402.801704][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 72 jiffies): 1s/10: 19674:15
[ 403.804666][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 404.571546][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 408.898722][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 422.237547][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 422.258168][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 424.870528][ T64] rcu_torture_fwd_prog_nr: 0 Duration 21054 cver 1248 gps 2895
[ 424.875551][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 431.387631][ T60] rcu-torture: rtc: 7649a5a1 ver: 27582 tfle: 0 rta: 27583 rtaf: 0 rtf: 27571 rtmbe: 0 rtmbkf: 0/24163 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 460134 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 448 nocb-toggles: 0:0
[ 431.388567][ T60] rcu-torture: Reader Pipe: 105561984 43871 0 0 0 0 0 0 0 0 0
[ 431.389109][ T60] rcu-torture: Reader Batch: 105481803 124052 0 0 0 0 0 0 0 0 0
[ 431.389738][ T60] rcu-torture: Free-Block Circulation: 27582 27581 27580 27579 27578 27577 27575 27573 27572 27571 0
[ 435.611593][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 439.894053][ T65] rcu-torture: rcu_torture_read_exit: End of episode
#
#
#
# [ 453.340580][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 453.349864][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 466.715584][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 470.898469][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 484.315624][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 484.325560][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 488.802553][ T64] rcu_torture_fwd_prog n_max_cbs: 7758
[ 488.802783][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 488.803031][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 488.944630][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 488.986025][ T64] rcu_torture_fwd_prog_cr Duration 72 barrier: 41 pending 2174 n_launders: 6366 n_launders_sa: 102 n_max_gps: 100 n_max_cbs: 7056 cver 9 gps 18
[ 488.986578][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 114 jiffies): 1s/10: 13422:21
[ 490.012556][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 492.827574][ T60] rcu-torture: rtc: 3d8b2018 ver: 31618 tfle: 0 rta: 31618 rtaf: 0 rtf: 31606 rtmbe: 0 rtmbkf: 0/27441 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 526391 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 512 nocb-toggles: 0:0
[ 492.828740][ T60] rcu-torture: Reader Pipe: 118729585 50554 0 0 0 0 0 0 0 0 0
[ 492.829186][ T60] rcu-torture: Reader Batch: 118638692 141447 0 0 0 0 0 0 0 0 0
[ 492.829601][ T60] rcu-torture: Free-Block Circulation: 31618 31617 31616 31615 31613 31612 31610 31609 31608 31606 0
[ 497.691593][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 500.356516][ T64] rcu_torture_fwd_prog_nr: 0 Duration 10331 cver 562 gps 1287
[ 500.360566][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 501.916616][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 515.228591][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 515.236128][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 528.603566][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 532.907282][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 546.268555][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 546.297080][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 554.267614][ T60] rcu-torture: rtc: e5f7467c ver: 35676 tfle: 0 rta: 35677 rtaf: 0 rtf: 35667 rtmbe: 0 rtmbkf: 0/30755 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 593990 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 576 nocb-toggles: 0:0
[ 554.268563][ T60] rcu-torture: Reader Pipe: 132644545 57177 0 0 0 0 0 0 0 0 0
[ 554.268946][ T60] rcu-torture: Reader Batch: 132540498 161224 0 0 0 0 0 0 0 0 0
[ 554.269368][ T60] rcu-torture: Free-Block Circulation: 35676 35675 35674 35673 35672 35671 35670 35669 35668 35667 0
[ 559.643585][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 562.459610][ T64] rcu_torture_fwd_prog n_max_cbs: 7056
[ 562.459950][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 562.460386][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 562.586882][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 562.639058][ T64] rcu_torture_fwd_prog_cr Duration 122 barrier: 52 pending 45603 n_launders: 64825 n_launders_sa: 0 n_max_gps: 100 n_max_cbs: 45605 cver 0 gps 8
[ 562.639599][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 175 jiffies): 1s/10: 57960:8 2s/10: 52470:3
[ 563.675563][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 563.943659][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 573.691537][ T64] rcu_torture_fwd_prog_nr: 0 Duration 10012 cver 285 gps 449
[ 573.698562][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 577.436682][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 577.462573][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 590.811566][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 594.915102][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 608.285539][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 608.322593][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 615.707583][ T60] rcu-torture: rtc: 6427cd30 ver: 39157 tfle: 0 rta: 39158 rtaf: 0 rtf: 39148 rtmbe: 0 rtmbkf: 0/33590 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 660823 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 640 nocb-toggles: 0:0
[ 615.709088][ T60] rcu-torture: Reader Pipe: 144754337 62887 0 0 0 0 0 0 0 0 0
[ 615.709773][ T60] rcu-torture: Reader Batch: 144639626 177598 0 0 0 0 0 0 0 0 0
[ 615.710359][ T60] rcu-torture: Free-Block Circulation: 39157 39156 39155 39154 39153 39152 39151 39150 39149 39148 0
[ 621.659556][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 625.913387][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 636.187623][ T64] rcu_torture_fwd_prog n_max_cbs: 45605
[ 636.187951][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 636.188290][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 636.302754][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 636.405716][ T64] rcu_torture_fwd_prog_cr Duration 98 barrier: 103 pending 13037 n_launders: 16067 n_launders_sa: 1779 n_max_gps: 100 n_max_cbs: 13882 cver 6 gps 11
[ 636.406276][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 201 jiffies): 1s/10: 17144:11 2s/10: 12805:10
[ 637.467591][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 639.261549][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 639.297561][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 651.939529][ T64] rcu_torture_fwd_prog_nr: 0 Duration 14465 cver 419 gps 702
[ 651.943546][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 652.827556][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 656.916874][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 670.236550][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 670.274406][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 677.147639][ T60] rcu-torture: rtc: e5f7467c ver: 42378 tfle: 0 rta: 42379 rtaf: 0 rtf: 42367 rtmbe: 0 rtmbkf: 0/36177 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 725665 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 704 nocb-toggles: 0:0
[ 677.148593][ T60] rcu-torture: Reader Pipe: 159668023 68330 0 0 0 0 0 0 0 0 0
[ 677.148924][ T60] rcu-torture: Reader Batch: 159543651 192702 0 0 0 0 0 0 0 0 0
[ 677.149260][ T60] rcu-torture: Free-Block Circulation: 42378 42377 42376 42375 42374 42373 42371 42369 42368 42367 0
[ 683.740637][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 687.928759][ T65] rcu-torture: rcu_torture_read_exit: End of episode
#
# [ 701.339596][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 701.370673][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 714.715588][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 718.107614][ T64] rcu_torture_fwd_prog n_max_cbs: 13882
[ 718.107902][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 718.108212][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 718.158717][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 718.200397][ T64] rcu_torture_fwd_prog_cr Duration 45 barrier: 41 pending 27639 n_launders: 6467 n_launders_sa: 686 n_max_gps: 100 n_max_cbs: 33324 cver 0 gps 10
[ 718.201030][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 87 jiffies): 1s/10: 39791:12
[ 718.919225][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 719.259645][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 731.613533][ T64] rcu_torture_fwd_prog_nr: 0 Duration 12340 cver 330 gps 587
[ 731.617576][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 732.252593][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 732.284588][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 738.587626][ T60] rcu-torture: rtc: d0a05544 ver: 45628 tfle: 0 rta: 45629 rtaf: 0 rtf: 45615 rtmbe: 0 rtmbkf: 0/38838 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 790266 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 768 nocb-toggles: 0:0
[ 738.588755][ T60] rcu-torture: Reader Pipe: 173621003 73874 0 0 0 0 0 0 0 0 0
[ 738.589149][ T60] rcu-torture: Reader Batch: 173486760 208117 0 0 0 0 0 0 0 0 0
[ 738.589570][ T60] rcu-torture: Free-Block Circulation: 45628 45626 45625 45624 45623 45622 45619 45617 45616 45615 0
[ 745.627561][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 749.928558][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 763.293597][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 763.312616][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 776.667601][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 780.923479][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 791.835614][ T64] rcu_torture_fwd_prog n_max_cbs: 33324
[ 791.835899][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 791.836206][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 791.931738][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 792.008965][ T64] rcu_torture_fwd_prog_cr Duration 86 barrier: 77 pending 9858 n_launders: 11600 n_launders_sa: 565 n_max_gps: 100 n_max_cbs: 11758 cver 11 gps 18
[ 792.009736][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 164 jiffies): 1s/10: 17460:20 2s/10: 5898:3
[ 793.052581][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 794.267579][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 794.340027][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 800.027607][ T60] rcu-torture: rtc: d6c66008 ver: 49199 tfle: 0 rta: 49200 rtaf: 0 rtf: 49189 rtmbe: 0 rtmbkf: 0/41729 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 856948 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 832 nocb-toggles: 0:0
[ 800.029169][ T60] rcu-torture: Reader Pipe: 185516787 79930 0 0 0 0 0 0 0 0 0
[ 800.029667][ T60] rcu-torture: Reader Batch: 185371895 224822 0 0 0 0 0 0 0 0 0
[ 800.030109][ T60] rcu-torture: Free-Block Circulation: 49199 49198 49197 49196 49195 49194 49193 49192 49190 49189 0
[ 807.899612][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 811.958800][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 813.725538][ T64] rcu_torture_fwd_prog_nr: 0 Duration 20652 cver 501 gps 885
[ 813.731591][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 825.307640][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 825.344608][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 838.684575][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 842.930663][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 856.347625][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 856.377787][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 861.467590][ T60] rcu-torture: rtc: 9e3d1d49 ver: 52925 tfle: 0 rta: 52926 rtaf: 0 rtf: 52916 rtmbe: 0 rtmbkf: 0/44724 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 923645 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 896 nocb-toggles: 0:0
[ 861.468969][ T60] rcu-torture: Reader Pipe: 197584694 86209 0 0 0 0 0 0 0 0 0
[ 861.469682][ T60] rcu-torture: Reader Batch: 197428492 242411 0 0 0 0 0 0 0 0 0
[ 861.470325][ T60] rcu-torture: Free-Block Circulation: 52925 52924 52923 52922 52921 52920 52919 52918 52917 52916 0
[ 869.980614][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 873.932326][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 877.851579][ T64] rcu_torture_fwd_prog n_max_cbs: 11758
[ 877.851911][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 877.852205][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 877.950820][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 878.015259][ T64] rcu_torture_fwd_prog_cr Duration 86 barrier: 64 pending 6639 n_launders: 7023 n_launders_sa: 1305 n_max_gps: 100 n_max_cbs: 8243 cver 5 gps 16
[ 878.015805][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 151 jiffies): 1s/10: 11748:19 2s/10: 3518:4
[ 879.067599][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 887.259710][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 887.336578][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 892.545538][ T64] rcu_torture_fwd_prog_nr: 0 Duration 13464 cver 341 gps 560
[ 892.551484][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 900.955630][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 904.925316][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 918.492553][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 918.522843][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 922.907596][ T60] rcu-torture: rtc: 24d10813 ver: 55997 tfle: 0 rta: 55998 rtaf: 0 rtf: 55988 rtmbe: 0 rtmbkf: 0/47209 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 986529 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 960 nocb-toggles: 0:0
[ 922.909055][ T60] rcu-torture: Reader Pipe: 212630928 91396 0 0 0 0 0 0 0 0 0
[ 922.909611][ T60] rcu-torture: Reader Batch: 212465760 256564 0 0 0 0 0 0 0 0 0
[ 922.910048][ T60] rcu-torture: Free-Block Circulation: 55997 55997 55996 55995 55994 55993 55992 55991 55990 55989 0
[ 931.931612][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 935.929476][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 949.276565][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 949.295762][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 955.675655][ T64] rcu_torture_fwd_prog n_max_cbs: 8243
[ 955.675950][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 955.676343][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 955.802922][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 955.869905][ T64] rcu_torture_fwd_prog_cr Duration 116 barrier: 67 pending 3265 n_launders: 8149 n_launders_sa: 438 n_max_gps: 100 n_max_cbs: 10610 cver 3 gps 17
[ 955.870752][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 184 jiffies): 1s/10: 11784:17 2s/10: 6975:2
[ 956.891608][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 962.651616][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 966.947195][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 980.444585][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 980.470335][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 981.841533][ T64] rcu_torture_fwd_prog_nr: 0 Duration 24945 cver 483 gps 820
[ 981.851575][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 984.347606][ T60] rcu-torture: rtc: d1aaf70d ver: 58705 tfle: 0 rta: 58706 rtaf: 0 rtf: 58692 rtmbe: 0 rtmbkf: 0/49373 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1049833 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 1024 nocb-toggles: 0:0
[ 984.348905][ T60] rcu-torture: Reader Pipe: 226283172 95629 0 0 0 0 0 0 0 0 0
[ 984.349433][ T60] rcu-torture: Reader Batch: 226110045 268756 0 0 0 0 0 0 0 0 0
[ 984.349990][ T60] rcu-torture: Free-Block Circulation: 58705 58704 58702 58701 58700 58699 58697 58696 58695 58692 0
[ 993.883557][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 997.930917][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1011.355637][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1011.367205][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1024.923575][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1028.953250][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1042.268564][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1042.275284][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1045.788605][ T64] rcu_torture_fwd_prog n_max_cbs: 10610
[ 1045.789065][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 1045.789416][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 1045.797620][ T60] rcu-torture: rtc: 95c46427 ver: 62528 tfle: 0 rta: 62529 rtaf: 0 rtf: 62519 rtmbe: 0 rtmbkf: 0/52519 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1114931 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 1088 nocb-toggles: 0:0
[ 1045.798989][ T60] rcu-torture: Reader Pipe: 239877834 101975 0 0 0 0 0 0 0 0 0
[ 1045.799413][ T60] rcu-torture: Reader Batch: 239691474 288335 0 0 0 0 0 0 0 0 0
[ 1045.799841][ T60] rcu-torture: Free-Block Circulation: 62528 62527 62526 62525 62524 62523 62522 62521 62520 62519 0
[ 1046.002835][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1046.066369][ T64] rcu_torture_fwd_prog_cr Duration 77 barrier: 63 pending 4335 n_launders: 5668 n_launders_sa: 721 n_max_gps: 100 n_max_cbs: 5528 cver 6 gps 14
[ 1046.067188][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 141 jiffies): 1s/10: 10432:22 2s/10: 764:1
[ 1047.131586][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 1055.579703][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1059.979621][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1063.827537][ T64] rcu_torture_fwd_prog_nr: 0 Duration 16690 cver 329 gps 591
[ 1063.837575][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1073.627610][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1073.638312][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1087.067560][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1090.944907][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1104.283699][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1104.317864][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1107.227650][ T60] rcu-torture: rtc: c90e97ce ver: 65803 tfle: 0 rta: 65804 rtaf: 0 rtf: 65794 rtmbe: 0 rtmbkf: 0/55158 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1179667 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 1152 nocb-toggles: 0:0
[ 1107.228891][ T60] rcu-torture: Reader Pipe: 254957334 107271 0 0 0 0 0 0 0 0 0
[ 1107.229370][ T60] rcu-torture: Reader Batch: 254760207 304398 0 0 0 0 0 0 0 0 0
[ 1107.229883][ T60] rcu-torture: Free-Block Circulation: 65803 65802 65801 65800 65799 65798 65797 65796 65795 65794 0
[ 1117.980623][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1121.954837][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1127.707545][ T64] rcu_torture_fwd_prog n_max_cbs: 5528
[ 1127.707770][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 1127.708036][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 1127.814918][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1127.857123][ T64] rcu_torture_fwd_prog_cr Duration 95 barrier: 42 pending 5527 n_launders: 13719 n_launders_sa: 1410 n_max_gps: 100 n_max_cbs: 12864 cver 6 gps 14
[ 1127.857709][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 138 jiffies): 1s/10: 21056:14 2s/10: 5527:2
[ 1128.859572][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 1135.261536][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1135.301723][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1142.367537][ T64] rcu_torture_fwd_prog_nr: 0 Duration 13486 cver 364 gps 601
[ 1142.373565][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1148.763542][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1152.950765][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1166.301546][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1166.331265][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1168.667635][ T60] rcu-torture: rtc: 3d8b2018 ver: 69109 tfle: 0 rta: 69110 rtaf: 0 rtf: 69099 rtmbe: 0 rtmbkf: 0/57818 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1246251 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 1216 nocb-toggles: 0:0
[ 1168.669023][ T60] rcu-torture: Reader Pipe: 266801324 112570 0 0 0 0 0 0 0 0 0
[ 1168.669677][ T60] rcu-torture: Reader Batch: 266593993 319901 0 0 0 0 0 0 0 0 0
[ 1168.670244][ T60] rcu-torture: Free-Block Circulation: 69109 69108 69107 69106 69105 69104 69102 69101 69100 69099 0
[ 1179.675566][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1183.953236][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1197.340558][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1197.354245][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1205.532733][ T64] rcu_torture_fwd_prog n_max_cbs: 12864
[ 1205.532957][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 1205.533211][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 1205.624619][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1205.680208][ T64] rcu_torture_fwd_prog_cr Duration 84 barrier: 55 pending 5718 n_launders: 13146 n_launders_sa: 101 n_max_gps: 100 n_max_cbs: 25617 cver 5 gps 9
[ 1205.680794][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 140 jiffies): 1s/10: 38763:11
[ 1206.683638][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 1210.716598][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1214.953653][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1215.067532][ T64] rcu_torture_fwd_prog_nr: 0 Duration 8377 cver 78 gps 192
[ 1215.079556][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1228.379632][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1228.412617][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1230.107570][ T60] rcu-torture: rtc: b1e2aaaf ver: 72898 tfle: 0 rta: 72899 rtaf: 0 rtf: 72888 rtmbe: 0 rtmbkf: 0/60881 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1313750 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 1280 nocb-toggles: 0:0
[ 1230.108482][ T60] rcu-torture: Reader Pipe: 280290667 118939 0 0 0 0 0 0 0 0 0
[ 1230.108938][ T60] rcu-torture: Reader Batch: 280071335 338271 0 0 0 0 0 0 0 0 0
[ 1230.109318][ T60] rcu-torture: Free-Block Circulation: 72898 72897 72896 72895 72894 72893 72892 72891 72890 72888 0
[ 1241.755560][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
#
#
# [ 1245.956624][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1259.292539][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1259.323685][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1272.667581][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1276.963622][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1279.259692][ T64] rcu_torture_fwd_prog n_max_cbs: 25617
[ 1279.259925][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 1279.260180][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 1279.347482][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1279.408212][ T64] rcu_torture_fwd_prog_cr Duration 72 barrier: 61 pending 7991 n_launders: 15426 n_launders_sa: 5938 n_max_gps: 100 n_max_cbs: 10183 cver 4 gps 11
[ 1279.408985][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 134 jiffies): 1s/10: 25464:13 2s/10: 145:0
[ 1280.411577][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 1288.605554][ T64] rcu_torture_fwd_prog_nr: 0 Duration 8189 cver 301 gps 534
[ 1288.613661][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1290.267659][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1290.299427][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1291.547605][ T60] rcu-torture: rtc: 2bd26944 ver: 76565 tfle: 0 rta: 76566 rtaf: 0 rtf: 76556 rtmbe: 0 rtmbkf: 0/63899 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1379987 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 1344 nocb-toggles: 0:0
[ 1291.548846][ T60] rcu-torture: Reader Pipe: 292909371 125004 0 0 0 0 0 0 0 0 0
[ 1291.549212][ T60] rcu-torture: Reader Batch: 292679765 354610 0 0 0 0 0 0 0 0 0
[ 1291.549784][ T60] rcu-torture: Free-Block Circulation: 76565 76564 76563 76562 76561 76560 76559 76558 76557 76556 0
[ 1303.644599][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1307.971378][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1321.309238][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1321.342042][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1334.683555][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1338.961360][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1348.892610][ T64] rcu_torture_fwd_prog n_max_cbs: 10183
[ 1348.892847][ T64] rcu_torture_fwd_prog: Starting forward-progress test 0
[ 1348.893107][ T64] rcu_torture_fwd_prog_cr: Starting forward-progress test 0
[ 1349.000724][ T64] rcu_torture_fwd_prog_cr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1349.103799][ T64] rcu_torture_fwd_prog_cr Duration 102 barrier: 103 pending 15090 n_launders: 14482 n_launders_sa: 991 n_max_gps: 100 n_max_cbs: 15732 cver 9 gps 21
[ 1349.104444][ T64] rcu_torture_fwd_cb_hist: Callback-invocation histogram 0 (duration 205 jiffies): 1s/10: 14459:19 2s/10: 15755:15
[ 1350.107572][ T64] rcu_torture_fwd_prog_nr: Starting forward-progress test 0
[ 1352.286555][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1352.317605][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1352.987638][ T60] rcu-torture: rtc: e312f6a8 ver: 80364 tfle: 0 rta: 80365 rtaf: 0 rtf: 80353 rtmbe: 0 rtmbkf: 0/67001 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1445780 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 read-exits: 1408 nocb-toggles: 0:0
[ 1352.988582][ T60] rcu-torture: Reader Pipe: 304814561 131599 0 0 0 0 0 0 0 0 0
[ 1352.988883][ T60] rcu-torture: Reader Batch: 304574702 371458 0 0 0 0 0 0 0 0 0
[ 1352.989251][ T60] rcu-torture: Free-Block Circulation: 80364 80363 80361 80360 80359 80358 80357 80356 80354 80353 0
[ 1365.659647][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1370.014587][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1371.695531][ T64] rcu_torture_fwd_prog_nr: 0 Duration 21577 cver 537 gps 953
[ 1371.705601][ T64] rcu_torture_fwd_prog_nr: Waiting for CBs: rcu_barrier+0x0/0x5c0() 0
[ 1383.452571][ T65] rcu-torture: rcu_torture_read_exit: Start of episode
[ 1383.468925][ T65] rcu-torture: rcu_torture_read_exit: End of episode
[ 1387.564837][ T57] BUG: unable to handle page fault for address: c108f5f4
[ 1387.566649][ T57] #PF: supervisor write access in kernel mode
[ 1387.567965][ T57] #PF: error_code(0x0003) - permissions violation
[ 1387.569439][ T57] *pde = 010001e1
[ 1387.570276][ T57] Oops: 0003 [#1] SMP
[ 1387.571149][ T57] CPU: 2 PID: 57 Comm: rcu_torture_rea Tainted: G S 6.1.0-rc2-00010-g0af8489b0216 #2130 63d19ac2b985fca570c354d8750f489755de37ed
[ 1387.574673][ T57] EIP: kvm_kick_cpu+0x54/0x90
[ 1387.575802][ T57] Code: 2f c5 01 8b 04 9d e0 d4 4e c4 83 15 14 7b 2f c5 00 83 05 08 6d 2f c5 01 0f b7 0c 30 b8 05 00 00 00 83 15 0c 6d 2f c5 00 31 db <0f> 01 c1 83 05 10 6d 2f c5 01 8b 5d f8 8b 75 fc 83 15 14 6d 2f c5
[ 1387.580456][ T57] EAX: 00000005 EBX: 00000000 ECX: 00000003 EDX: c108f5a0
[ 1387.582071][ T57] ESI: c5153580 EDI: 00000046 EBP: c69cddf8 ESP: c69cddf0
[ 1387.583775][ T57] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010046
[ 1387.585643][ T57] CR0: 80050033 CR2: c108f5f4 CR3: 0776b000 CR4: 00350e90
[ 1387.587492][ T57] Call Trace:
[ 1387.588365][ T57] __pv_queued_spin_unlock_slowpath+0x66/0x110
[ 1387.589898][ T57] __pv_queued_spin_unlock+0x4b/0x60
[ 1387.591040][ T57] __raw_callee_save___pv_queued_spin_unlock+0x9/0x10
[ 1387.592771][ T57] do_raw_spin_unlock+0x49/0xa0
[ 1387.593805][ T57] _raw_spin_unlock_irqrestore+0x53/0xd0
[ 1387.594927][ T57] swake_up_one+0x4f/0x70
[ 1387.595739][ T57] __rcu_report_exp_rnp+0x26b/0x470
[ 1387.596730][ T57] rcu_report_exp_cpu_mult+0x82/0x2f0
[ 1387.597770][ T57] rcu_qs+0xac/0x160
[ 1387.598503][ T57] rcu_note_context_switch+0x31/0x1e0
[ 1387.599460][ T57] __schedule+0xc5/0x770
[ 1387.600195][ T57] __cond_resched+0x7a/0x100
[ 1387.600996][ T57] stutter_wait+0x9e/0x2c0
[ 1387.601956][ T57] rcu_torture_reader+0x162/0x3e0
[ 1387.603048][ T57] ? rcu_torture_reader+0x3e0/0x3e0
[ 1387.604269][ T57] ? __kthread_parkme+0xab/0xf0
[ 1387.605420][ T57] kthread+0x167/0x1d0
[ 1387.606383][ T57] ? rcu_torture_read_exit_child+0xa0/0xa0
[ 1387.607516][ T57] ? kthread_exit+0x50/0x50
[ 1387.608517][ T57] ret_from_fork+0x19/0x24
[ 1387.609548][ T57] Modules linked in:
[ 1387.610187][ T57] CR2: 00000000c108f5f4
[ 1387.610873][ T57] ---[ end trace 0000000000000000 ]---
[ 1387.611829][ T57] EIP: kvm_kick_cpu+0x54/0x90
[ 1387.612653][ T57] Code: 2f c5 01 8b 04 9d e0 d4 4e c4 83 15 14 7b 2f c5 00 83 05 08 6d 2f c5 01 0f b7 0c 30 b8 05 00 00 00 83 15 0c 6d 2f c5 00 31 db <0f> 01 c1 83 05 10 6d 2f c5 01 8b 5d f8 8b 75 fc 83 15 14 6d 2f c5
[ 1387.616715][ T57] EAX: 00000005 EBX: 00000000 ECX: 00000003 EDX: c108f5a0
[ 1387.618242][ T57] ESI: c5153580 EDI: 00000046 EBP: c69cddf8 ESP: c69cddf0
[ 1387.619912][ T57] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010046
[ 1387.621666][ T57] CR0: 80050033 CR2: c108f5f4 CR3: 0776b000 CR4: 00350e90
[ 1387.623128][ T57] Kernel panic - not syncing: Fatal exception
[ 1389.285045][ T57] Shutting down cpus with NMI
[ 1389.297949][ T57] Kernel Offset: disabled
[ 1389.299174][ T57] ---[ end Kernel panic - not syncing: Fatal exception ]---
