2024-06-11 06:10:59 depmod 2024-06-11 06:11:00 sleep 300 2024-06-11 06:16:00 rmmod rcutorture [ 57.367076] busted-torture:--- Start of test: nreaders=1 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=3 onoff_holdoff=30 read_exit_delay=13 read_exit_burst=16 nocbs_nthreads=0 nocbs_toggle=1000 test_nmis=0 [ 57.370631] busted-torture: Creating rcu_torture_writer task [ 57.387013] busted-torture: Creating rcu_torture_fakewriter task [ 57.387454] busted-torture: rcu_torture_writer task started [ 57.387832] busted-torture: Creating rcu_torture_fakewriter task [ 57.387832] busted-torture: rcu_torture_fakewriter task started [ 57.392829] busted-torture: Creating rcu_torture_fakewriter task [ 57.392829] busted-torture: rcu_torture_fakewriter task started [ 57.407064] busted-torture: Creating rcu_torture_fakewriter task [ 57.408622] busted-torture: Creating rcu_torture_reader task [ 57.409037] busted-torture: rcu_torture_fakewriter task started [ 57.410019] busted-torture: Creating rcu_torture_stats task [ 57.410542] busted-torture: rcu_torture_fakewriter task started [ 57.411393] busted-torture: rcu_torture_reader task started [ 57.415535] busted-torture: Creating torture_shuffle task [ 57.415596] busted-torture: rcu_torture_stats task started [ 57.417121] busted-torture: Creating torture_stutter task [ 57.418535] busted-torture: torture_shuffle task started [ 57.419441] busted-torture: Creating torture_onoff task [ 57.420290] busted-torture: torture_stutter task started [ 57.420654] busted-torture: rcu_torture_fwd_prog_init: Disabled, unsupported by RCU flavor under test [ 57.420656] busted-torture: torture_onoff task started [ 57.421194] busted-torture: Creating rcu_torture_read_exit task [ 57.421518] busted-torture: torture_onoff begin holdoff [ 57.439011] busted-torture: rcu_torture_read_exit: Start of test [ 57.439425] busted-torture: rcu_torture_read_exit: Start of episode [ 62.425163] busted-torture: rcu_torture_read_exit: End of episode [ 75.730833] busted-torture: rcu_torture_read_exit: Start of episode [ 75.794883] busted-torture: rcu_torture_read_exit: End of episode [ 87.422856] busted-torture: torture_onoff end holdoff [ 89.106838] busted-torture: rcu_torture_read_exit: Start of episode [ 92.418014] busted-torture: rcu_torture_read_exit: End of episode [ 105.810825] busted-torture: rcu_torture_read_exit: Start of episode [ 105.824679] busted-torture: rcu_torture_read_exit: End of episode [ 118.420181] busted-torture: rtc: 0000000005fd609d ver: 25149 tfle: 0 rta: 25149 rtaf: 0 rtf: 25140 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 3379 onoff: 268/268:268/269 2,79:1,82 1385:2441 (HZ=250) barrier: 0/0:0 read-exits: 64 nocb-toggles: 0:0 [ 118.424003] busted-torture: !!! [ 118.451754] busted-torture: Reader Batch: 10540051 0 0 0 0 0 0 0 0 0 0 [ 118.452164] busted-torture: Free-Block Circulation: 25148 25148 25147 25146 25145 25144 25143 25142 25141 25140 0 [ 119.154835] busted-torture: rcu_torture_read_exit: Start of episode [ 122.417215] busted-torture: rcu_torture_read_exit: End of episode [ 135.922856] busted-torture: rcu_torture_read_exit: Start of episode [ 135.928021] busted-torture: rcu_torture_read_exit: End of episode [ 149.266860] busted-torture: rcu_torture_read_exit: Start of episode [ 152.413743] busted-torture: rcu_torture_read_exit: End of episode [ 165.746978] busted-torture: rcu_torture_read_exit: Start of episode [ 165.754058] busted-torture: rcu_torture_read_exit: End of episode [ 179.058892] busted-torture: rcu_torture_read_exit: Start of episode [ 179.858836] busted-torture: rtc: 0000000096b0b64f ver: 49088 tfle: 0 rta: 49088 rtaf: 0 rtf: 49079 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 6494 onoff: 794/794:795/795 2,80:1,83 4427:7166 (HZ=250) barrier: 0/0:0 read-exits: 128 nocb-toggles: 0:0 [ 179.862572] busted-torture: !!! Reader Pipe: 23919365 1002 1283 18 13 11 6 9 5 7 656 [ 179.864129] busted-torture: Reader Batch: 23922375 0 0 0 0 0 0 0 0 0 0 [ 179.865377] busted-torture: Free-Block Circulation: 49087 49087 49086 49085 49084 49083 49082 49081 49080 49079 0 [ 182.390171] busted-torture: rcu_torture_read_exit: End of episode [ 195.698825] busted-torture: rcu_torture_read_exit: Start of episode [ 195.704456] busted-torture: rcu_torture_read_exit: End of episode [ 209.010856] busted-torture: rcu_torture_read_exit: Start of episode [ 212.641142] busted-torture: rcu_torture_read_exit: End of episode [ 226.066967] busted-torture: rcu_torture_read_exit: Start of episode [ 226.077625] busted-torture: rcu_torture_read_exit: End of episode [ 239.410858] busted-torture: rcu_torture_read_exit: Start of episode [ 241.298880] busted-torture: rtc: 000000001abe3176 ver: 73127 tfle: 0 rta: 73127 rtaf: 0 rtf: 73118 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 9735 onoff: 1335/1335:1335/1336 1,80:1,87 7083:12208 (HZ=250) barrier: 0/0:0 read-exits: 192 nocb-toggles: 0:0 [ 241.300822] busted-torture: !!! Reader Pipe: 37415945 1758 2276 44 33 22 16 12 17 17 1105 [ 241.301647] busted-torture: Reader Batch: 37421245 0 0 0 0 0 0 0 0 0 0 [ 241.302270] busted-torture: Free-Block Circulation: 73126 73126 73125 73124 73123 73122 73121 73120 73119 73118 0 [ 242.876798] busted-torture: rcu_torture_read_exit: End of episode [ 256.210825] busted-torture: rcu_torture_read_exit: Start of episode [ 256.217503] busted-torture: rcu_torture_read_exit: End of episode [ 269.523510] busted-torture: rcu_torture_read_exit: Start of episode [ 272.849457] busted-torture: rcu_torture_read_exit: End of episode [ 286.258828] busted-torture: rcu_torture_read_exit: Start of episode [ 286.261781] busted-torture: rcu_torture_read_exit: End of episode [ 299.570857] busted-torture: rcu_torture_read_exit: Start of episode [ 302.738846] busted-torture: rtc: 000000006cb5c1c4 ver: 98436 tfle: 0 rta: 98436 rtaf: 0 rtf: 98427 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 13005 onoff: 1870/1870:1870/1870 1,80:1,158 9711:17253 (HZ=250) barrier: 0/0:0 read-exits: 256 nocb-toggles: 0:0 [ 302.742728] busted-torture: !!! Reader Pipe: 52611347 2985 4028 77 59 34 33 27 33 29 1817 [ 302.744999] busted-torture: Reader Batch: 52620469 0 0 0 0 0 0 0 0 0 0 [ 302.746573] busted-torture: Free-Block Circulation: 98435 98435 98434 98433 98432 98431 98430 98429 98428 98427 0 [ 302.838174] busted-torture: rcu_torture_read_exit: End of episode [ 316.370828] busted-torture: rcu_torture_read_exit: Start of episode [ 316.377906] busted-torture: rcu_torture_read_exit: End of episode [ 329.682852] busted-torture: rcu_torture_read_exit: Start of episode [ 332.842747] busted-torture: rcu_torture_read_exit: End of episode [ 346.162865] busted-torture: rcu_torture_read_exit: Start of episode [ 346.170711] busted-torture: rcu_torture_read_exit: End of episode [ 357.488688] busted-torture: Stopping torture_shuffle task [ 357.490077] busted-torture: rcu_torture_writer is stopping [ 357.490424] busted-torture: torture_shuffle is stopping [ 357.490794] busted-torture: Stopping torture_stutter task [ 357.491895] busted-torture: torture_stutter is stopping [ 357.492274] busted-torture: torture_onoff is stopping [ 357.493059] busted-torture: rcu_torture_fakewriter is stopping [ 357.496485] busted-torture: Stopping torture_onoff task [ 357.496830] busted-torture: rcu_torture_fakewriter is stopping [ 357.497180] busted-torture: rcu_torture_fakewriter is stopping [ 357.497528] busted-torture: rcu_torture_reader is stopping [ 357.518773] busted-torture: rcu_torture_fakewriter is stopping [ 357.746888] busted-torture: rcu_torture_read_exit is stopping [ 357.746924] busted-torture: Stopping rcutorture_read_exit task [ 357.749181] busted-torture: Stopping rcu_torture_writer task [ 357.750254] busted-torture: Stopping rcu_torture_reader task [ 357.756560] busted-torture: Stopping rcu_torture_fakewriter task [ 357.757902] busted-torture: Stopping rcu_torture_fakewriter task [ 357.759444] busted-torture: Stopping rcu_torture_fakewriter task [ 357.762478] busted-torture: Stopping rcu_torture_fakewriter task [ 357.766275] busted-torture: Stopping rcu_torture_stats task [ 357.770396] busted-torture: rtc: 0000000000000000 VER: 122791 tfle: 0 rta: 122791 rtaf: 0 rtf: 122782 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 16395 onoff: 2372/2372:2373/2373 1,80:1,158 12097:21177 (HZ=250) barrier: 0/0:0 read-exits: 320 nocb-toggles: 0:0 [ 357.774836] busted-torture: !!! Reader Pipe: 66708623 3696 4957 93 67 43 42 31 37 37 2234 [ 357.775639] busted-torture: Reader Batch: 66719860 0 0 0 0 0 0 0 0 0 0 [ 357.776257] busted-torture: Free-Block Circulation: 122790 122790 122789 122788 122787 122786 122785 122784 122783 122782 0 [ 357.777235] busted-torture: rcu_torture_stats is stopping [ 357.830675] busted-torture: rtc: 0000000000000000 VER: 122791 tfle: 0 rta: 122791 rtaf: 0 rtf: 122782 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 16395 onoff: 2372/2372:2373/2373 1,80:1,158 12097:21177 (HZ=250) barrier: 0/0:0 read-exits: 320 nocb-toggles: 0:0 [ 357.831989] busted-torture: !!! Reader Pipe: 66708623 3696 4957 93 67 43 42 31 37 37 2234 [ 357.833258] busted-torture: Reader Batch: 66719860 0 0 0 0 0 0 0 0 0 0 [ 357.834430] busted-torture: Free-Block Circulation: 122790 122790 122789 122788 122787 122786 122785 122784 122783 122782 0 [ 357.840000] busted-torture:--- End of test: FAILURE: nreaders=1 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=3 onoff_holdoff=30 read_exit_delay=13 read_exit_burst=16 nocbs_nthreads=0 nocbs_toggle=1000 test_nmis=0