2024-02-19 02:49:43 depmod 2024-02-19 02:51:25 sleep 300 2024-02-19 02:56:25 rmmod rcutorture [ 292.354401] busted_srcud-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 [ 292.368131] busted_srcud-torture: Creating rcu_torture_writer task [ 292.419427] busted_srcud-torture: Creating rcu_torture_fakewriter task [ 292.421383] busted_srcud-torture: rcu_torture_writer task started [ 292.423102] busted_srcud-torture: GP expediting controlled from boot/sysfs for busted_srcud. [ 292.441458] busted_srcud-torture: Creating rcu_torture_fakewriter task [ 292.443451] busted_srcud-torture: rcu_torture_fakewriter task started [ 292.460905] busted_srcud-torture: Creating rcu_torture_fakewriter task [ 292.463942] busted_srcud-torture: rcu_torture_fakewriter task started [ 292.473959] busted_srcud-torture: Creating rcu_torture_fakewriter task [ 292.475843] busted_srcud-torture: rcu_torture_fakewriter task started [ 292.491418] busted_srcud-torture: Creating rcu_torture_reader task [ 292.493296] busted_srcud-torture: rcu_torture_fakewriter task started [ 292.506271] busted_srcud-torture: Creating rcu_torture_stats task [ 292.509179] busted_srcud-torture: rcu_torture_reader task started [ 292.586460] busted_srcud-torture: Creating torture_shuffle task [ 292.590128] busted_srcud-torture: rcu_torture_stats task started [ 292.592724] busted_srcud-torture: Creating torture_stutter task [ 292.596818] busted_srcud-torture: torture_shuffle task started [ 292.614029] busted_srcud-torture: rcu_torture_fwd_prog_init: Limiting fwd_progress to # CPUs. [ 292.616474] busted_srcud-torture: rcu_torture_fwd_prog_init: Disabled, unsupported by RCU flavor under test [ 292.617954] busted_srcud-torture: Creating rcu_torture_read_exit task [ 292.622913] busted_srcud-torture: torture_stutter task started [ 292.652633] busted_srcud-torture: rcu_torture_read_exit: Start of test [ 292.654081] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 298.326583] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 312.230272] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 318.022006] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 331.814972] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 337.641947] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 351.271105] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 351.713112] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 353.737921] busted_srcud-torture: rtc: 0000000047ca36af ver: 10510 tfle: 0 rta: 10510 rtaf: 0 rtf: 10501 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 244 barrier: 0/0:0 read-exits: 64 nocb-toggles: 0:0 [ 353.742123] busted_srcud-torture: Reader Pipe: 32371 0 0 0 0 0 0 0 0 0 0 [ 353.744076] busted_srcud-torture: Reader Batch: 32371 0 0 0 0 0 0 0 0 0 0 [ 353.746040] busted_srcud-torture: Free-Block Circulation: 10509 10509 10508 10507 10506 10505 10504 10503 10502 10501 0 [ 353.748085] busted_srcud-torture: Tiny SRCU per-CPU(idx=1): (0,0) gp: 84186->84186 [ 365.385921] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 368.383073] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 382.117948] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 388.153436] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 402.086524] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 407.719832] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 415.190003] busted_srcud-torture: rtc: 0000000028c406bc ver: 21367 tfle: 0 rta: 21367 rtaf: 0 rtf: 21358 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 504 barrier: 0/0:0 read-exits: 112 nocb-toggles: 0:0 [ 415.197313] busted_srcud-torture: Reader Pipe: 55114 0 0 0 0 0 0 0 0 0 0 [ 415.200843] busted_srcud-torture: Reader Batch: 55114 0 0 0 0 0 0 0 0 0 0 [ 415.204333] busted_srcud-torture: Free-Block Circulation: 21366 21366 21365 21364 21363 21362 21361 21360 21359 21358 0 [ 415.208095] busted_srcud-torture: Tiny SRCU per-CPU(idx=1): (0,0) gp: 170238->170238 [ 421.737411] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 427.890078] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 441.957999] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 447.966730] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 462.054644] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 462.461272] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 476.137993] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 476.630033] busted_srcud-torture: rtc: 000000008c9d6322 ver: 31765 tfle: 0 rta: 31765 rtaf: 0 rtf: 31756 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 731 barrier: 0/0:0 read-exits: 160 nocb-toggles: 0:0 [ 476.636636] busted_srcud-torture: Reader Pipe: 77566 0 0 0 0 0 0 0 0 0 0 [ 476.639799] busted_srcud-torture: Reader Batch: 77566 0 0 0 0 0 0 0 0 0 0 [ 476.643045] busted_srcud-torture: Free-Block Circulation: 31764 31764 31763 31762 31761 31760 31759 31758 31757 31756 0 [ 476.646807] busted_srcud-torture: Tiny SRCU per-CPU(idx=1): (0,0) gp: 251922->251922 [ 478.140709] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 492.101974] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 498.407535] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 511.846810] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 517.557277] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 531.018042] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 531.690307] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 538.068751] busted_srcud-torture: rtc: 00000000478f685b ver: 43097 tfle: 0 rta: 43097 rtaf: 0 rtf: 43088 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 1023 barrier: 0/0:0 read-exits: 224 nocb-toggles: 0:0 [ 538.071021] busted_srcud-torture: Reader Pipe: 99515 0 0 0 0 0 0 0 0 0 0 [ 538.071909] busted_srcud-torture: Reader Batch: 99515 0 0 0 0 0 0 0 0 0 0 [ 538.072746] busted_srcud-torture: Free-Block Circulation: 43096 43096 43095 43094 43093 43092 43091 43090 43089 43088 0 [ 538.074018] busted_srcud-torture: Tiny SRCU per-CPU(idx=0): (0,0) gp: 341076->341076 [ 545.157985] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 548.257655] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 561.895334] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 567.601831] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 581.158680] busted_srcud-torture: rcu_torture_read_exit: Start of episode [ 581.914612] busted_srcud-torture: rcu_torture_read_exit: End of episode [ 592.933722] busted_srcud-torture: Stopping torture_shuffle task [ 592.934676] busted_srcud-torture: torture_shuffle is stopping [ 592.954324] busted_srcud-torture: Stopping torture_stutter task [ 592.955135] busted_srcud-torture: torture_stutter is stopping [ 593.414161] busted_srcud-torture: rcu_torture_read_exit is stopping [ 593.419826] busted_srcud-torture: Stopping rcutorture_read_exit task [ 593.602193] busted_srcud-torture: Stopping rcu_torture_writer task [ 593.603055] busted_srcud-torture: Dynamic grace-period expediting was disabled. [ 593.603890] busted_srcud-torture: rcu_torture_writer is stopping [ 593.614127] busted_srcud-torture: Stopping rcu_torture_reader task [ 593.623145] busted_srcud-torture: rcu_torture_reader is stopping [ 593.634082] busted_srcud-torture: Stopping rcu_torture_fakewriter task [ 593.670153] busted_srcud-torture: rcu_torture_fakewriter is stopping [ 593.675912] busted_srcud-torture: Stopping rcu_torture_fakewriter task [ 593.678600] busted_srcud-torture: rcu_torture_fakewriter is stopping [ 593.686395] busted_srcud-torture: Stopping rcu_torture_fakewriter task [ 593.687284] busted_srcud-torture: rcu_torture_fakewriter is stopping [ 593.698080] busted_srcud-torture: Stopping rcu_torture_fakewriter task [ 593.710004] busted_srcud-torture: rcu_torture_fakewriter is stopping [ 593.715836] busted_srcud-torture: Stopping rcu_torture_stats task [ 593.729970] busted_srcud-torture: rtc: 0000000000000000 VER: 53609 tfle: 0 rta: 53609 rtaf: 0 rtf: 53600 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 1295 barrier: 0/0:0 read-exits: 272 nocb-toggles: 0:0 [ 593.734638] busted_srcud-torture: Reader Pipe: 121902 0 0 0 0 0 0 0 0 0 0 [ 593.738016] busted_srcud-torture: Reader Batch: 121902 0 0 0 0 0 0 0 0 0 0 [ 593.741399] busted_srcud-torture: Free-Block Circulation: 53608 53608 53607 53606 53605 53604 53603 53602 53601 53600 0 [ 593.745212] busted_srcud-torture: Tiny SRCU per-CPU(idx=0): (0,0) gp: 424788->424788 [ 593.748741] busted_srcud-torture: rcu_torture_stats is stopping [ 594.422025] busted_srcud-torture: rtc: 0000000000000000 VER: 53609 tfle: 0 rta: 53609 rtaf: 0 rtf: 53600 rtmbe: 0 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 1295 barrier: 0/0:0 read-exits: 272 nocb-toggles: 0:0 [ 594.430774] busted_srcud-torture: Reader Pipe: 121902 0 0 0 0 0 0 0 0 0 0 [ 594.435091] busted_srcud-torture: Reader Batch: 121902 0 0 0 0 0 0 0 0 0 0 [ 594.439392] busted_srcud-torture: Free-Block Circulation: 53608 53608 53607 53606 53605 53604 53603 53602 53601 53600 0 [ 594.444025] busted_srcud-torture: Tiny SRCU per-CPU(idx=0): (0,0) gp: 0->0 [ 594.448365] busted_srcud-torture:--- End of test: SUCCESS: 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