lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Date:   Wed, 16 Dec 2020 15:40:04 +0530
From:   Naresh Kamboju <naresh.kamboju@...aro.org>
To:     rcu@...r.kernel.org,
        Linux-Next Mailing List <linux-next@...r.kernel.org>,
        open list <linux-kernel@...r.kernel.org>,
        lkft-triage@...ts.linaro.org
Cc:     "Paul E. McKenney" <paulmck@...nel.org>,
        Peter Zijlstra <peterz@...radead.org>,
        Jakub Kicinski <kuba@...nel.org>,
        Greg Kroah-Hartman <gregkh@...uxfoundation.org>,
        Thomas Gleixner <tglx@...utronix.de>
Subject: i386: rcu-torture: WARNING: at kernel/rcu/rcutorture.c:1169
 rcu_torture_writer [rcutorture]

Linux Kernel Functional Testing (LKFT) started running rcu-torture tests on
qemu_arm64, qemu_arm qemu_x86_64 and qemu_i386 from our CI build systems.

The following warning(s) noticed on qemu_i386 while running rcu-torture test
on Linux mainline and Linux -next master branch. Since we do not have baseline
results i can not comment this as regression but when compared with
stable-rc 5.4 kernel this warning is new on mainline and next.

rcu-torture test log
----------------------
[    8.191718] 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
[    8.196860] rcu:  Start-test grace-period state: g973 f0x2
[    8.198122] rcu-torture: Creating rcu_torture_writer task
[    8.199823] rcu-torture: Creating rcu_torture_fakewriter task
[    8.199864] rcu-torture: rcu_torture_writer task started
[    8.201174] rcu-torture: Creating rcu_torture_fakewriter task
[    8.201245] rcu-torture: rcu_torture_fakewriter task started
[    8.202099] rcu_torture_writer: Testing conditional GPs.
[    8.203056] rcu-torture: Creating rcu_torture_fakewriter task
[    8.204450] rcu_torture_writer: Testing expedited GPs.
[    8.204474] rcu-torture: rcu_torture_fakewriter task started
[    8.205441] rcu-torture: Creating rcu_torture_fakewriter task
[    8.205483] rcu-torture: rcu_torture_fakewriter task started
[    8.206599] rcu_torture_writer: Testing asynchronous GPs.
[    8.206602] rcu_torture_writer: Testing normal GPs.
[    8.211609] rcu-torture: Creating rcu_torture_reader task
[    8.211743] rcu-torture: rcu_torture_fakewriter task started
[    8.212627] rcu-torture: Creating rcu_torture_reader task
[    8.212707] rcu-torture: rcu_torture_reader task started
[    8.215613] rcu-torture: Creating rcu_torture_reader task
[    8.215733] rcu-torture: rcu_torture_reader task started
[    8.216454] rcu-torture: Creating rcu_torture_stats task
[    8.217774] rcu-torture: rcu_torture_reader task started
[    8.218562] rcu-torture: Creating torture_shuffle task
[    8.219696] rcu-torture: rcu_torture_stats task started
[    8.220385] rcu-torture: Creating torture_stutter task
[    8.222150] rcu-torture: torture_shuffle task started
[    8.222990] rcu-torture: Creating rcu_torture_fwd_prog task
[    8.222999] rcu-torture: torture_stutter task started
[    8.224683] rcu-torture: Creating rcu_torture_read_exit task
[    8.224755] rcu-torture: rcu_torture_fwd_progress task started
[    8.225923] rcu-torture: rcu_torture_read_exit: Start of test
modprobe-rcutorture pass
[    8.230300] Dumping ftrace buffer:
[    8.230659]    (ftrace buffer empty)
[    8.231586] ------------[ cut here ]------------
[    8.232483] rcu_torture_writer: rtort_pipe_count: 4
[    8.233265] WARNING: CPU: 2 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
Broadcast messag[    8.234683] Modules linked in: rcutorture torture
e from systemd-j[    8.235456] CPU: 2 PID: 407 Comm: rcu_torture_wri
Not tainted 5.10.0-next-20201215 #2
ournald@...el-co[    8.236755] Hardware name: QEMU Standard PC (i440FX
+ PIIX, 1996), BIOS 1.12.0-1 04/01/2014
re2-32 (Wed 2020[    8.237910] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
-12-16 09:24:22 [    8.238840] Code: f7 85 c0 75 13 b8 01 00 00 00 87
05 4c 28 87 f7 85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19
03 87 f7 e8 6e a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b
2f ce e4 83 fb 03 0f
UTC):[    8.241511] EAX: 00000027 EBX: 00000000 ECX: f51cd9d0 EDX: f51c3e68
[    8.242438] ESI: f7872bf0 EDI: f7872bcc EBP: c1207f8c ESP: c1207f4c
[    8.243300] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
kernel[263]: [  [    8.244219] CR0: 80050033 CR2: b7c8eb96 CR3:
1d9a0000 CR4: 003506d0
  8.230300] Dump[    8.245228] Call Trace:
ing ftrace buffe[    8.245752]  ?
rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
r:[    8.246573]  kthread+0xe2/0x110
[    8.247114]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[    8.247978]  ? kthread_park+0xa0/0xa0
[    8.248483]  ret_from_fork+0x1c/0x28
[    8.249031] ---[ end trace f0d5ead0494363c8 ]---

Broadcast message from systemd-journald@...el-core2-32 (Wed 2020-12-16
09:24:22 UTC):
kernel[263]: [    8.230659]    (ftrace buffer empty)
[    8.255498] rcu-torture: rcu_torture_read_exit: End of episode
[    8.191718] 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
rcutorture-start pass
INFO: Running rcutorture for 600 seconds...
[   21.553686] rcu-torture: rcu_torture_read_exit: Start of episode
[   21.565513] rcu-torture: rcu_torture_read_exit: End of episode
[   35.123776] rcu-torture: rcu_torture_read_exit: Start of episode
[   35.145399] rcu-torture: rcu_torture_read_exit: End of episode
[   48.498693] rcu-torture: rcu_torture_read_exit: Start of episode
[   48.508719] rcu-torture: rcu_torture_read_exit: End of episode
[   50.870536] ------------[ cut here ]------------
[   50.871283] rcu_torture_writer: rtort_pipe_count: 3
[   50.872180] WARNING: CPU: 1 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[   50.874884] Modules linked in: rcutorture torture
[   50.876156] CPU: 1 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[   50.878280] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[   50.880083] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[   50.880978] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[   50.883639] EAX: 00000027 EBX: 0000000d ECX: f51aa9d0 EDX: f51a0e68
[   50.884763] ESI: f7872e18 EDI: f7872d04 EBP: c1207f8c ESP: c1207f4c
[   50.885800] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[   50.886988] CR0: 80050033 CR2: 01e2e850 CR3: 026f6000 CR4: 003506d0
[   50.888048] Call Trace:
[   50.888465]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[   50.889471]  kthread+0xe2/0x110
[   50.890069]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[   50.891171]  ? kthread_park+0xa0/0xa0
[   50.891801]  ret_from_fork+0x1c/0x28
[   50.892374] ---[ end trace f0d5ead0494363c9 ]---
[   50.893237] ------------[ cut here ]------------
[   50.894035] rcu_torture_writer: rtort_pipe_count: 5
[   50.894947] WARNING: CPU: 1 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[   50.896682] Modules linked in: rcutorture torture
[   50.897452] CPU: 1 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[   50.898959] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[   50.900357] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[   50.901361] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[   50.904305] EAX: 00000027 EBX: 00000013 ECX: f51aa9d0 EDX: f51a0e68
[   50.905379] ESI: f7872e18 EDI: f7872d94 EBP: c1207f8c ESP: c1207f4c
[   50.906449] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[   50.907606] CR0: 80050033 CR2: 01e2e850 CR3: 026f6000 CR4: 003506d0
[   50.908699] Call Trace:
[   50.909150]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[   50.910165]  kthread+0xe2/0x110
[   50.910770]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[   50.911818]  ? kthread_park+0xa0/0xa0
[   50.912468]  ret_from_fork+0x1c/0x28
[   50.913104] ---[ end trace f0d5ead0494363ca ]---
[   61.809941] rcu-torture: rcu_torture_read_exit: Start of episode
[   61.831604] rcu-torture: rcu_torture_read_exit: End of episode
[   70.833679] rcu-torture: rtc: 8da7414f ver: 3947 tfle: 0 rta: 3948
rtaf: 0 rtf: 3936 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0
nt: 60924 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0
read-exits: 84
[   70.836316] rcu-torture: Reader Pipe:  73349046 5958 0 0 0 0 0 0 0 0 0
[   70.837292] rcu-torture: Reader Batch:  73342557 12447 0 0 0 0 0 0 0 0 0
[   70.838309] rcu-torture: Free-Block Circulation:  3948 3946 3945
3944 3943 3942 3941 3939 3938 3937 0
[   75.188816] rcu-torture: rcu_torture_read_exit: Start of episode
[   75.205268] rcu-torture: rcu_torture_read_exit: End of episode
[   83.332733] rcu_torture_fwd_prog_nr: Duration 12493 cver 825 gps 1473
[   83.507200] rcu_torture_fwd_prog_cr Duration 29 barrier: 17 pending
48369 n_launders: 135108 n_launders_sa: 23105 n_max_gps: 100
n_max_cbs: 75135 cver 4 gps 9
[   83.509533] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 48 jiffies): 1s/10: 210243:12
[   88.562713] rcu-torture: rcu_torture_read_exit: Start of episode
[   88.580007] rcu-torture: rcu_torture_read_exit: End of episode
[   93.879744] ------------[ cut here ]------------
[   93.880447] rcu_torture_writer: rtort_pipe_count: 4
[   93.881303] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[   93.883192] Modules linked in: rcutorture torture
[   93.883951] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[   93.885334] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[   93.886619] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[   93.887454] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[   93.890561] EAX: 00000027 EBX: 0000005a ECX: f51879d0 EDX: f517de68
[   93.891678] ESI: f7872c08 EDI: f787343c EBP: c1207f8c ESP: c1207f4c
[   93.892633] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[   93.893811] CR0: 80050033 CR2: b7435000 CR3: 0239a000 CR4: 003506d0
[   93.894810] Call Trace:
[   93.895233]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[   93.896258]  kthread+0xe2/0x110
[   93.896883]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[   93.897897]  ? kthread_park+0xa0/0xa0
[   93.898485]  ret_from_fork+0x1c/0x28
[   93.899098] ---[ end trace f0d5ead0494363cb ]---
[  101.937743] rcu-torture: rcu_torture_read_exit: Start of episode
[  101.943604] rcu-torture: rcu_torture_read_exit: End of episode
[  115.313700] rcu-torture: rcu_torture_read_exit: Start of episode
[  115.317066] rcu-torture: rcu_torture_read_exit: End of episode
[  128.690866] rcu-torture: rcu_torture_read_exit: Start of episode
[  128.710091] rcu-torture: rcu_torture_read_exit: End of episode
[  132.273932] rcu-torture: rtc: 534006fa ver: 8004 tfle: 0 rta: 8005
rtaf: 0 rtf: 7992 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0
nt: 121506 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0
read-exits: 169
[  132.279351] rcu-torture: Reader Pipe:  144997915 11987 0 0 0 0 0 0 0 0 0
[  132.281446] rcu-torture: Reader Batch:  144985493 24409 0 0 0 0 0 0 0 0 0
[  132.283404] rcu-torture: Free-Block Circulation:  8004 8004 8003
8001 8000 7998 7996 7995 7994 7993 0
[  136.886764] ------------[ cut here ]------------
[  136.888083] rcu_torture_writer: rtort_pipe_count: 7
[  136.889707] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  136.892439] Modules linked in: rcutorture torture
[  136.893572] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  136.895679] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  136.896989] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  136.897869] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  136.900449] EAX: 00000027 EBX: 00000018 ECX: f51879d0 EDX: f517de68
[  136.901417] ESI: f78732b0 EDI: f7872e0c EBP: c1207f8c ESP: c1207f4c
[  136.902334] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  136.903338] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  136.904279] Call Trace:
[  136.904620]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.905496]  kthread+0xe2/0x110
[  136.906010]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.906961]  ? kthread_park+0xa0/0xa0
[  136.907506]  ret_from_fork+0x1c/0x28
[  136.908084] ---[ end trace f0d5ead0494363cc ]---
[  136.908810] ------------[ cut here ]------------
[  136.909462] rcu_torture_writer: rtort_pipe_count: 7
[  136.910306] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  136.912209] Modules linked in: rcutorture torture
[  136.912936] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  136.914308] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  136.915556] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  136.916384] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  136.919065] EAX: 00000027 EBX: 00000023 ECX: f51879d0 EDX: f517de68
[  136.920054] ESI: f78732b0 EDI: f7872f14 EBP: c1207f8c ESP: c1207f4c
[  136.920974] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  136.922004] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  136.922958] Call Trace:
[  136.923310]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.924198]  kthread+0xe2/0x110
[  136.924686]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.925532]  ? kthread_park+0xa0/0xa0
[  136.926100]  ret_from_fork+0x1c/0x28
[  136.926628] ---[ end trace f0d5ead0494363cd ]---
[  136.927336] ------------[ cut here ]------------
[  136.928027] rcu_torture_writer: rtort_pipe_count: 5
[  136.928738] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  136.930145] Modules linked in: rcutorture torture
[  136.930879] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  136.932121] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  136.933294] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  136.934156] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  136.936797] EAX: 00000027 EBX: 0000002f ECX: f51879d0 EDX: f517de68
[  136.937842] ESI: f78732b0 EDI: f7873034 EBP: c1207f8c ESP: c1207f4c
[  136.938916] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  136.940002] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  136.941046] Call Trace:
[  136.941437]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.942413]  kthread+0xe2/0x110
[  136.942998]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.944010]  ? kthread_park+0xa0/0xa0
[  136.944580]  ret_from_fork+0x1c/0x28
[  136.945204] ---[ end trace f0d5ead0494363ce ]---
[  136.945973] ------------[ cut here ]------------
[  136.946764] rcu_torture_writer: rtort_pipe_count: 2
[  136.947546] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  136.949114] Modules linked in: rcutorture torture
[  136.949869] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  136.951223] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  136.952432] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  136.953292] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  136.956015] EAX: 00000027 EBX: 00000034 ECX: 00000027 EDX: f517de6c
[  136.957052] ESI: f78732b0 EDI: f78730ac EBP: c1207f8c ESP: c1207f4c
[  136.958066] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  136.959177] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  136.960169] Call Trace:
[  136.960574]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.961554]  kthread+0xe2/0x110
[  136.962116]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.963133]  ? kthread_park+0xa0/0xa0
[  136.963759]  ret_from_fork+0x1c/0x28
[  136.964329] ---[ end trace f0d5ead0494363cf ]---
[  136.965075] ------------[ cut here ]------------
[  136.965847] rcu_torture_writer: rtort_pipe_count: 3
[  136.966724] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  136.968186] Modules linked in: rcutorture torture
[  136.968931] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  136.970238] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  136.971455] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  136.972295] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  136.975121] EAX: 00000027 EBX: 00000037 ECX: f51879d0 EDX: f517de68
[  136.976704] ESI: f78732b0 EDI: f78730f4 EBP: c1207f8c ESP: c1207f4c
[  136.978794] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  136.980909] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  136.982918] Call Trace:
[  136.983840]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.985583]  kthread+0xe2/0x110
[  136.986776]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  136.987998]  ? kthread_park+0xa0/0xa0
[  136.988474]  ret_from_fork+0x1c/0x28
[  136.988994] ---[ end trace f0d5ead0494363d0 ]---
[  136.989593] ------------[ cut here ]------------
[  136.990235] rcu_torture_writer: rtort_pipe_count: 4
[  136.990995] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  136.992425] Modules linked in: rcutorture torture
[  136.993153] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  136.994470] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  136.995696] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  136.996479] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  137.000802] EAX: 00000027 EBX: 0000003a ECX: f51879d0 EDX: f517de68
[  137.001770] ESI: f78732b0 EDI: f787313c EBP: c1207f8c ESP: c1207f4c
[  137.002700] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  137.003616] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  137.004533] Call Trace:
[  137.004938]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.005859]  kthread+0xe2/0x110
[  137.006307]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.007211]  ? kthread_park+0xa0/0xa0
[  137.007795]  ret_from_fork+0x1c/0x28
[  137.008317] ---[ end trace f0d5ead0494363d1 ]---
[  137.008994] ------------[ cut here ]------------
[  137.009681] rcu_torture_writer: rtort_pipe_count: 3
[  137.010394] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  137.011858] Modules linked in: rcutorture torture
[  137.012518] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  137.013825] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  137.015055] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  137.015931] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  137.018481] EAX: 00000027 EBX: 00000040 ECX: 00000027 EDX: f517de6c
[  137.019483] ESI: f78732b0 EDI: f78731cc EBP: c1207f8c ESP: c1207f4c
[  137.020507] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  137.021623] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  137.022858] Call Trace:
[  137.023288]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.024333]  kthread+0xe2/0x110
[  137.024960]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.026037]  ? kthread_park+0xa0/0xa0
[  137.026760]  ret_from_fork+0x1c/0x28
[  137.027364] ---[ end trace f0d5ead0494363d2 ]---
[  137.028181] ------------[ cut here ]------------
[  137.029011] rcu_torture_writer: rtort_pipe_count: 5
[  137.029927] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  137.031676] Modules linked in: rcutorture torture
[  137.032474] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  137.034006] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  137.035480] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  137.036482] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  137.039609] EAX: 00000027 EBX: 00000042 ECX: f51879d0 EDX: f517de68
[  137.040717] ESI: f78732b0 EDI: f78731fc EBP: c1207f8c ESP: c1207f4c
[  137.041842] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  137.043060] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  137.044170] Call Trace:
[  137.044605]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.045670]  kthread+0xe2/0x110
[  137.046227]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.047302]  ? kthread_park+0xa0/0xa0
[  137.047993]  ret_from_fork+0x1c/0x28
[  137.048612] ---[ end trace f0d5ead0494363d3 ]---
[  137.049436] ------------[ cut here ]------------
[  137.050276] rcu_torture_writer: rtort_pipe_count: 3
[  137.051203] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  137.052983] Modules linked in: rcutorture torture
[  137.053860] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  137.055453] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  137.056876] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  137.057892] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  137.061002] EAX: 00000027 EBX: 00000043 ECX: f51879d0 EDX: f517de68
[  137.062090] ESI: f78732b0 EDI: f7873214 EBP: c1207f8c ESP: c1207f4c
[  137.063197] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  137.064366] CR0: 80050033 CR2: 01dfe948 CR3: 02213000 CR4: 003506d0
[  137.065505] Call Trace:
[  137.066004]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.067079]  kthread+0xe2/0x110
[  137.067621]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  137.068701]  ? kthread_park+0xa0/0xa0
[  137.069333]  ret_from_fork+0x1c/0x28
[  137.070018] ---[ end trace f0d5ead0494363d4 ]---
[  142.073705] rcu-torture: rcu_torture_read_exit: Start of episode
[  142.088951] rcu-torture: rcu_torture_read_exit: End of episode
[  153.214282] rcu_torture_fwd_prog_nr: Duration 8357 cver 633 gps 1138
[  153.403732] rcu_torture_fwd_prog_cr Duration 36 barrier: 21 pending
42167 n_launders: 143281 n_launders_sa: 131263 n_max_gps: 100
n_max_cbs: 73728 cver 3 gps 11
[  153.405785] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 59 jiffies): 1s/10: 217009:13
[  155.609937] rcu-torture: rcu_torture_read_exit: Start of episode
[  155.624814] rcu-torture: rcu_torture_read_exit: End of episode
[  168.946827] rcu-torture: rcu_torture_read_exit: Start of episode
[  168.950063] rcu-torture: rcu_torture_read_exit: End of episode
[  182.322683] rcu-torture: rcu_torture_read_exit: Start of episode
[  182.332632] rcu-torture: rcu_torture_read_exit: End of episode
[  193.713783] rcu-torture: rtc: de3a40d9 ver: 12094 tfle: 0 rta:
12095 rtaf: 0 rtf: 12080 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 181149 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 237
[  193.716334] rcu-torture: Reader Pipe:  217230509 17887 0 0 0 0 0 0 0 0 0
[  193.717302] rcu-torture: Reader Batch:  217211460 36936 0 0 0 0 0 0 0 0 0
[  193.718383] rcu-torture: Free-Block Circulation:  12094 12093 12092
12090 12089 12088 12087 12083 12082 12080 0
[  195.698429] rcu-torture: rcu_torture_read_exit: Start of episode
[  195.706057] rcu-torture: rcu_torture_read_exit: End of episode
[  209.009727] rcu-torture: rcu_torture_read_exit: Start of episode
[  209.034830] rcu-torture: rcu_torture_read_exit: End of episode
[  222.707669] rcu-torture: rcu_torture_read_exit: Start of episode
[  222.717228] rcu-torture: rcu_torture_read_exit: End of episode
[  225.107668] rcu_torture_fwd_prog_nr: Duration 6423 cver 431 gps 674
[  225.304625] rcu_torture_fwd_prog_cr Duration 30 barrier: 18 pending
45670 n_launders: 115071 n_launders_sa: 45670 n_max_gps: 100
n_max_cbs: 81535 cver 4 gps 9
[  225.306721] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 51 jiffies): 1s/10: 196606:12
[  236.082696] rcu-torture: rcu_torture_read_exit: Start of episode
[  236.084184] rcu-torture: rcu_torture_read_exit: End of episode
[  249.842725] rcu-torture: rcu_torture_read_exit: Start of episode
[  249.862693] rcu-torture: rcu_torture_read_exit: End of episode
[  255.155700] rcu-torture: rtc: 5147673e ver: 16080 tfle: 0 rta:
16081 rtaf: 0 rtf: 16070 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 241269 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 322
[  255.159747] rcu-torture: Reader Pipe:  289687395 23676 0 0 0 0 0 0 0 0 0
[  255.160768] rcu-torture: Reader Batch:  289662008 49063 0 0 0 0 0 0 0 0 0
[  255.161738] rcu-torture: Free-Block Circulation:  16080 16079 16078
16077 16075 16074 16073 16072 16071 16070 0
[  263.345759] rcu-torture: rcu_torture_read_exit: Start of episode
[  263.357968] rcu-torture: rcu_torture_read_exit: End of episode
[  276.731679] rcu-torture: rcu_torture_read_exit: Start of episode
[  276.736175] rcu-torture: rcu_torture_read_exit: End of episode
[  290.610555] rcu-torture: rcu_torture_read_exit: Start of episode
[  290.613925] rcu-torture: rcu_torture_read_exit: End of episode
[  294.416672] rcu_torture_fwd_prog_nr: Duration 6473 cver 600 gps 1034
[  294.594441] rcu_torture_fwd_prog_cr Duration 30 barrier: 15 pending
45334 n_launders: 111298 n_launders_sa: 109603 n_max_gps: 100
n_max_cbs: 66046 cver 7 gps 9
[  294.596462] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 47 jiffies): 1s/10: 177344:11
[  303.930698] rcu-torture: rcu_torture_read_exit: Start of episode
[  303.956670] rcu-torture: rcu_torture_read_exit: End of episode
[  316.594672] rcu-torture: rtc: 8f3d94ed ver: 20172 tfle: 0 rta:
20172 rtaf: 0 rtf: 20156 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 300958 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 390
[  316.597784] rcu-torture: Reader Pipe:  361208386 29738 0 0 0 0 0 0 0 0 0
[  316.598799] rcu-torture: Reader Batch:  361176291 61833 0 0 0 0 0 0 0 0 0
[  316.599808] rcu-torture: Free-Block Circulation:  20173 20171 20170
20169 20168 20167 20166 20162 20157 20156 0
[  317.491787] rcu-torture: rcu_torture_read_exit: Start of episode
[  317.505037] rcu-torture: rcu_torture_read_exit: End of episode
[  330.801705] rcu-torture: rcu_torture_read_exit: Start of episode
[  330.821143] rcu-torture: rcu_torture_read_exit: End of episode
[  344.434695] rcu-torture: rcu_torture_read_exit: Start of episode
[  344.442238] rcu-torture: rcu_torture_read_exit: End of episode
[  357.745692] rcu-torture: rcu_torture_read_exit: Start of episode
[  357.756548] rcu-torture: rcu_torture_read_exit: End of episode
[  371.059226] rcu-torture: rcu_torture_read_exit: Start of episode
[  371.062913] rcu-torture: rcu_torture_read_exit: End of episode
[  373.393666] rcu_torture_fwd_prog_nr: Duration 15830 cver 1321 gps 2188
[  373.569775] rcu_torture_fwd_prog_cr Duration 28 barrier: 15 pending
29689 n_launders: 57048 n_launders_sa: 20971 n_max_gps: 100 n_max_cbs:
64403 cver 4 gps 7
[  373.573491] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 46 jiffies): 1s/10: 121451:10
[  378.033717] rcu-torture: rtc: 464d2699 ver: 24665 tfle: 0 rta:
24665 rtaf: 0 rtf: 24651 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 363383 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 475
[  378.036372] rcu-torture: Reader Pipe:  434351896 36155 0 0 0 0 0 0 0 0 0
[  378.037357] rcu-torture: Reader Batch:  434313110 74941 0 0 0 0 0 0 0 0 0
[  378.038364] rcu-torture: Free-Block Circulation:  24664 24664 24662
24661 24660 24658 24654 24653 24652 24651 0
[  384.370675] rcu-torture: rcu_torture_read_exit: Start of episode
[  384.390681] rcu-torture: rcu_torture_read_exit: End of episode
[  397.745729] rcu-torture: rcu_torture_read_exit: Start of episode
[  397.759462] rcu-torture: rcu_torture_read_exit: End of episode
[  411.326181] rcu-torture: rcu_torture_read_exit: Start of episode
[  411.339801] rcu-torture: rcu_torture_read_exit: End of episode
[  424.755666] rcu-torture: rcu_torture_read_exit: Start of episode
[  424.764716] rcu-torture: rcu_torture_read_exit: End of episode
[  438.323670] rcu-torture: rcu_torture_read_exit: Start of episode
[  438.396888] rcu-torture: rcu_torture_read_exit: End of episode
[  439.473735] rcu-torture: rtc: bb0c988a ver: 28319 tfle: 0 rta:
28320 rtaf: 0 rtf: 28306 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 421382 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 560
[  439.476457] rcu-torture: Reader Pipe:  504507253 41547 0 0 0 0 0 0 0 0 0
[  439.477456] rcu-torture: Reader Batch:  504462623 86177 0 0 0 0 0 0 0 0 0
[  439.478487] rcu-torture: Free-Block Circulation:  28319 28318 28316
28314 28313 28311 28310 28309 28307 28306 0
[  447.839666] rcu_torture_fwd_prog_nr: Duration 12252 cver 972 gps 1685
[  448.014701] rcu_torture_fwd_prog_cr Duration 27 barrier: 15 pending
26505 n_launders: 129796 n_launders_sa: 101 n_max_gps: 100 n_max_cbs:
77442 cver 2 gps 10
[  448.017945] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 45 jiffies): 1s/10: 207238:13
[  451.697700] rcu-torture: rcu_torture_read_exit: Start of episode
[  451.713990] rcu-torture: rcu_torture_read_exit: End of episode
[  459.446720] ------------[ cut here ]------------
[  459.447333] rcu_torture_writer: rtort_pipe_count: 8
[  459.448071] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  459.449496] Modules linked in: rcutorture torture
[  459.450233] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  459.451518] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  459.452691] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  459.453459] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  459.456034] EAX: 00000027 EBX: 00000007 ECX: f51879d0 EDX: f517de68
[  459.456928] ESI: f7873208 EDI: f7872c74 EBP: c1207f8c ESP: c1207f4c
[  459.457828] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  459.458816] CR0: 80050033 CR2: 0960df5c CR3: 023ee000 CR4: 003506d0
[  459.459719] Call Trace:
[  459.460062]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  459.460942]  kthread+0xe2/0x110
[  459.461403]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  459.462286]  ? kthread_park+0xa0/0xa0
[  459.462848]  ret_from_fork+0x1c/0x28
[  459.463335] ---[ end trace f0d5ead0494363d5 ]---
[  459.464015] ------------[ cut here ]------------
[  459.464706] rcu_torture_writer: rtort_pipe_count: 7
[  459.465371] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  459.466841] Modules linked in: rcutorture torture
[  459.467509] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  459.468802] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  459.470003] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  459.470845] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  459.473403] EAX: 00000027 EBX: 0000003e ECX: 00000027 EDX: f517de6c
[  459.474329] ESI: f7873208 EDI: f787319c EBP: c1207f8c ESP: c1207f4c
[  459.475255] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  459.476220] CR0: 80050033 CR2: 0960df5c CR3: 023ee000 CR4: 003506d0
[  459.477142] Call Trace:
[  459.477481]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  459.478365]  kthread+0xe2/0x110
[  459.478871]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  459.479811]  ? kthread_park+0xa0/0xa0
[  459.480363]  ret_from_fork+0x1c/0x28
[  459.480951] ---[ end trace f0d5ead0494363d6 ]---
[  465.137695] rcu-torture: rcu_torture_read_exit: Start of episode
[  465.140903] rcu-torture: rcu_torture_read_exit: End of episode
[  478.577719] rcu-torture: rcu_torture_read_exit: Start of episode
[  478.592864] rcu-torture: rcu_torture_read_exit: End of episode
[  491.954723] rcu-torture: rcu_torture_read_exit: Start of episode
[  491.969890] rcu-torture: rcu_torture_read_exit: End of episode
[  500.913672] rcu-torture: rtc: 7ec35e96 ver: 32454 tfle: 0 rta:
32455 rtaf: 0 rtf: 32444 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 481015 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 628
[  500.920282] rcu-torture: Reader Pipe:  575629825 47586 0 0 0 0 0 0 0 0 0
[  500.922184] rcu-torture: Reader Batch:  575579057 98354 0 0 0 0 0 0 0 0 0
[  500.924002] rcu-torture: Free-Block Circulation:  32454 32454 32453
32452 32451 32450 32449 32448 32447 32445 0
[  505.586699] rcu-torture: rcu_torture_read_exit: Start of episode
[  505.600489] rcu-torture: rcu_torture_read_exit: End of episode
[  518.962750] rcu-torture: rcu_torture_read_exit: Start of episode
[  518.978017] rcu-torture: rcu_torture_read_exit: End of episode
[  519.472694] rcu_torture_fwd_prog_nr: Duration 10360 cver 706 gps 1175
[  519.659707] rcu_torture_fwd_prog_cr Duration 34 barrier: 13 pending
32601 n_launders: 118865 n_launders_sa: 32601 n_max_gps: 100
n_max_cbs: 59919 cver 5 gps 10
[  519.661865] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 49 jiffies): 1s/10: 178784:12
[  523.958007] ------------[ cut here ]------------
[  523.958780] rcu_torture_writer: rtort_pipe_count: 3
[  523.959453] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  523.960903] Modules linked in: rcutorture torture
[  523.961580] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  523.962919] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  523.964136] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  523.964978] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  523.967565] EAX: 00000027 EBX: 0000000d ECX: 00000027 EDX: f517de6c
[  523.968507] ESI: f7873268 EDI: f7872d04 EBP: c1207f8c ESP: c1207f4c
[  523.969426] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  523.970458] CR0: 80050033 CR2: 09314f5c CR3: 1d9a0000 CR4: 003506d0
[  523.971378] Call Trace:
[  523.971803]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  523.972691]  kthread+0xe2/0x110
[  523.973145]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  523.974012]  ? kthread_park+0xa0/0xa0
[  523.974560]  ret_from_fork+0x1c/0x28
[  523.975127] ---[ end trace f0d5ead0494363d7 ]---
[  523.975826] ------------[ cut here ]------------
[  523.976463] rcu_torture_writer: rtort_pipe_count: 3
[  523.977202] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  523.978681] Modules linked in: rcutorture torture
[  523.979335] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  523.980606] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  523.981852] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  523.982720] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  523.985256] EAX: 00000027 EBX: 0000001d ECX: f51879d0 EDX: f517de68
[  523.986190] ESI: f7873268 EDI: f7872e84 EBP: c1207f8c ESP: c1207f4c
[  523.987106] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  523.988123] CR0: 80050033 CR2: 09314f5c CR3: 1d9a0000 CR4: 003506d0
[  523.989042] Call Trace:
[  523.989397]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  523.990311]  kthread+0xe2/0x110
[  523.990822]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  523.991696]  ? kthread_park+0xa0/0xa0
[  523.992220]  ret_from_fork+0x1c/0x28
[  523.992762] ---[ end trace f0d5ead0494363d8 ]---
[  523.993417] ------------[ cut here ]------------
[  523.994099] rcu_torture_writer: rtort_pipe_count: 3
[  523.994868] WARNING: CPU: 0 PID: 407 at
kernel/rcu/rcutorture.c:1169 rcu_torture_writer+0x673/0x770
[rcutorture]
[  523.996299] Modules linked in: rcutorture torture
[  523.997009] CPU: 0 PID: 407 Comm: rcu_torture_wri Tainted: G
W         5.10.0-next-20201215 #2
[  523.998335] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996),
BIOS 1.12.0-1 04/01/2014
[  523.999523] EIP: rcu_torture_writer+0x673/0x770 [rcutorture]
[  524.000376] Code: f7 85 c0 75 13 b8 01 00 00 00 87 05 4c 28 87 f7
85 c0 0f 84 97 00 00 00 ff 77 fc 68 78 16 87 f7 68 19 03 87 f7 e8 6e
a8 86 e5 <0f> 0b 83 c4 0c eb 9e 8d b6 00 00 00 00 e8 2b 2f ce e4 83 fb
03 0f
[  524.003009] EAX: 00000027 EBX: 0000001e ECX: f51879d0 EDX: f517de68
[  524.003921] ESI: f7873268 EDI: f7872e9c EBP: c1207f8c ESP: c1207f4c
[  524.004854] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010296
[  524.005838] CR0: 80050033 CR2: 09314f5c CR3: 1d9a0000 CR4: 003506d0
[  524.006776] Call Trace:
[  524.007128]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  524.008017]  kthread+0xe2/0x110
[  524.008476]  ? rcu_torture_read_exit_child+0x40/0x40 [rcutorture]
[  524.009362]  ? kthread_park+0xa0/0xa0
[  524.009931]  ret_from_fork+0x1c/0x28
[  524.010475] ---[ end trace f0d5ead0494363d9 ]---
[  532.416286] rcu-torture: rcu_torture_read_exit: Start of episode
[  532.434712] rcu-torture: rcu_torture_read_exit: End of episode
[  545.779676] rcu-torture: rcu_torture_read_exit: Start of episode
[  545.795961] rcu-torture: rcu_torture_read_exit: End of episode
[  559.154678] rcu-torture: rcu_torture_read_exit: Start of episode
[  559.177267] rcu-torture: rcu_torture_read_exit: End of episode
[  562.353751] rcu-torture: rtc: c4aca2af ver: 36863 tfle: 0 rta:
36864 rtaf: 0 rtf: 36852 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 543473 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 713
[  562.356467] rcu-torture: Reader Pipe:  649527074 54135 0 0 0 0 0 0 0 0 0
[  562.357608] rcu-torture: Reader Batch:  649469764 111445 0 0 0 0 0 0 0 0 0
[  562.358740] rcu-torture: Free-Block Circulation:  36863 36862 36861
36860 36858 36857 36856 36855 36854 36852 0
[  572.593718] rcu-torture: rcu_torture_read_exit: Start of episode
[  572.602551] rcu-torture: rcu_torture_read_exit: End of episode
[  585.970759] rcu-torture: rcu_torture_read_exit: Start of episode
[  585.975978] rcu-torture: rcu_torture_read_exit: End of episode
[  595.984670] rcu_torture_fwd_prog_nr: Duration 13138 cver 790 gps 1388
[  596.183830] rcu_torture_fwd_prog_cr Duration 38 barrier: 15 pending
43040 n_launders: 127889 n_launders_sa: 104125 n_max_gps: 100
n_max_cbs: 67685 cver 3 gps 10
[  596.186079] rcu_torture_fwd_cb_hist: Callback-invocation histogram
(duration 55 jiffies): 1s/10: 195574:13
[  599.346737] rcu-torture: rcu_torture_read_exit: Start of episode
[  599.361681] rcu-torture: rcu_torture_read_exit: End of episode
[  612.662698] rcu-torture: rcu_torture_read_exit: Start of episode
[  612.801463] rcu-torture: rcu_torture_read_exit: End of episode
[  618.248862] rcu-torture: Stopping rcu_torture_reader
[  618.248862] rcu-torture: Stopping torture_shuffle task
[  618.249752] rcu-torture: Stopping rcu_torture_reader
[  618.252955] rcu-torture: Stopping torture_shuffle
[  618.254334] rcu-torture: Stopping torture_stutter task
[  618.256699] rcu-torture: Stopping torture_stutter
[  618.257484] rcu: rcu_sched: wait state: RCU_GP_WAIT_FQS(5) ->state:
0x402 delta ->gp_activity 4 ->gp_req_activity 261 ->gp_wake_time 261
->gp_wake_seq 272805 ->gp_seq 272809 ->gp_seq_needed 272816 ->gp_flags
0x0
[  618.260860] rcu: rcu_node 0:3 ->gp_seq 272809 ->gp_seq_needed 272816
[  618.261883] rcu: cpu 0 ->gp_seq_needed 272816
[  618.262618] rcu: cpu 1 ->gp_seq_needed 272816
[  618.263364] rcu: cpu 2 ->gp_seq_needed 272812
[  618.264141] rcu: cpu 3 ->gp_seq_needed 272816
[  618.265089] rcu: RCU callbacks invoked since boot: 2381909
[  618.266316] rcu_tasks: RTGS_INIT(0) since 318056 g:0 i:0/0 k.
[  618.267203] rcu_tasks_rude: RTGS_INIT(0) since 318057 g:0 i:0/0 k.
[  618.268144] rcu_tasks_trace: RTGS_INIT(0) since 318058 g:0 i:0/0 k.
N0 h:0/0/0
[  618.299515] rcu-torture: Stopping rcu_torture_reader
[  618.299585] rcu-torture: Stopping rcu_torture_fakewriter
[  618.302051] rcu-torture: Stopping rcu_torture_fakewriter
[  618.302209] rcu-torture: Stopping rcu_torture_fakewriter
[  618.304284] rcu-torture: Stopping rcu_torture_writer
[  618.305734] rcu-torture: Stopping rcu_torture_fakewriter
[  619.249840] rcu-torture: Stopping rcu_torture_read_exit
[  619.250000] rcu-torture: Stopping rcutorture_read_exit task
[  619.252823] rcu-torture: Stopping rcu_torture_fwd_prog task
[  620.401707] rcu_torture_fwd_prog: tested 8 tested_tries 9
[  620.402596] rcu-torture: Stopping rcu_torture_fwd_prog
[  620.403580] rcu-torture: Stopping rcu_torture_writer task
[  620.405247] rcu-torture: Stopping rcu_torture_reader task
[  620.406615] rcu-torture: Stopping rcu_torture_reader task
[  620.407817] rcu-torture: Stopping rcu_torture_reader task
[  620.409431] rcu-torture: Stopping rcu_torture_fakewriter task
[  620.411135] rcu-torture: Stopping rcu_torture_fakewriter task
[  620.412773] rcu-torture: Stopping rcu_torture_fakewriter task
[  620.414392] rcu-torture: Stopping rcu_torture_fakewriter task
[  620.416074] rcu:  End-test grace-period state: g272877 f0x0 total-gps=67976
[  620.417940] rcu-torture: Stopping rcu_torture_stats task
[  620.419132] rcu-torture: rtc: 00000000 VER: 40657 tfle: 0 rta:
40657 rtaf: 0 rtf: 40647 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 599512 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 781
[  620.423816] rcu-torture: Reader Pipe:  715152697 59638 0 0 0 0 0 0 0 0 0
[  620.425933] rcu-torture: Reader Batch:  715089910 122425 0 0 0 0 0 0 0 0 0
[  620.428019] rcu-torture: Free-Block Circulation:  40656 40655 40654
40653 40652 40651 40650 40649 40648 40647 0
[  620.430867] rcu-torture: Stopping rcu_torture_stats
[  620.438806] rcu-torture: rtc: 00000000 VER: 40657 tfle: 0 rta:
40657 rtaf: 0 rtf: 40647 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0
rtb: 0 nt: 599512 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier:
0/0:0 read-exits: 781
[  620.444478] rcu-torture: Reader Pipe:  715152697 59638 0 0 0 0 0 0 0 0 0
[  620.446691] rcu-torture: Reader Batch:  715089910 122425 0 0 0 0 0 0 0 0 0
[  620.448894] rcu-torture: Free-Block Circulation:  40656 40655 40654
40653 40652 40651 40650 40649 40648 40647 0
[  620.451315] rcu-torture:--- End of test: SUCCESS: 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
rmmod-rcutorture pass
[  620.451315] rcu-torture:--- End of test: SUCCESS: 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


metadata:
  git branch: master
  git repo: https://gitlab.com/aroxell/lkft-linux-next
  git commit: 9317f948b0b188b8d2fded75957e6d42c460df1b
  git describe: next-20201215
  make_kernelversion: 5.10.0
  kernel-config: https://builds.tuxbuild.com/1ljRF6wqoO5OmOHSQgKBvEv8dxG/config

full test log link,
https://lkft.validation.linaro.org/scheduler/job/2052992#L842

-- 
Linaro LKFT
https://lkft.linaro.org

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ