2017-10-05 18:14:55 modprobe rcutorture onoff_interval=3 onoff_holdoff=30 2017-10-05 18:14:55 sleep 300 2017-10-05 18:19:55 rmmod rcutorture [ 88.877894] 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 n_barrier_cbs=0 onoff_interval=3 onoff_holdoff=30 [ 88.883483] rcu-torture: Creating rcu_torture_writer task [ 88.885142] rcu-torture: Creating rcu_torture_fakewriter task [ 88.885143] rcu-torture: rcu_torture_writer task started [ 88.888330] rcu-torture: Creating rcu_torture_fakewriter task [ 88.888350] rcu-torture: rcu_torture_fakewriter task started [ 88.891591] rcu-torture: Creating rcu_torture_fakewriter task [ 88.891596] rcu-torture: rcu_torture_fakewriter task started [ 88.894944] rcu-torture: Creating rcu_torture_fakewriter task [ 88.894948] rcu-torture: rcu_torture_fakewriter task started [ 88.897787] rcu-torture: Creating rcu_torture_reader task [ 88.897788] rcu-torture: rcu_torture_fakewriter task started [ 88.900925] rcu-torture: Creating rcu_torture_reader task [ 88.900928] rcu-torture: rcu_torture_reader task started [ 88.904380] rcu-torture: Creating rcu_torture_reader task [ 88.904380] rcu-torture: rcu_torture_reader task started [ 88.908686] rcu-torture: Creating rcu_torture_stats task [ 88.908688] rcu-torture: rcu_torture_reader task started [ 88.912718] rcu-torture: Creating torture_shuffle task [ 88.914545] rcu-torture: rcu_torture_stats task started [ 88.919842] rcu-torture: Creating torture_stutter task [ 88.919849] rcu-torture: torture_shuffle task started [ 88.925092] rcu-torture: Creating torture_onoff task [ 88.925093] rcu-torture: torture_stutter task started [ 88.930023] rcu-torture: Creating rcu_torture_cbflood task [ 88.930024] rcu-torture: torture_onoff task started [ 88.930026] rcu-torture: torture_onoff begin holdoff [ 88.936001] rcu-torture: rcu_torture_cbflood task started [ 119.263976] rcu-torture: torture_onoff end holdoff [ 119.265244] rcu-torture:torture_onoff task: offlining 2 [ 119.301762] rcu-torture:torture_onoff task: offlined 2 [ 122.335100] rcu-torture:torture_onoff task: offlining 3 [ 122.369405] rcu-torture:torture_onoff task: offlined 3 [ 125.406965] rcu-torture:torture_onoff task: offlining 0 [ 125.454783] rcu-torture:torture_onoff task: offlined 0 [ 128.478967] rcu-torture:torture_onoff task: onlining 0 [ 128.490336] rcu-torture:torture_onoff task: onlined 0 [ 131.551111] rcu-torture:torture_onoff task: onlining 2 [ 131.562452] rcu-torture:torture_onoff task: onlined 2 [ 134.664346] rcu-torture:torture_onoff task: offlining 0 [ 134.735284] rcu-torture:torture_onoff task: offlined 0 [ 137.758969] rcu-torture:torture_onoff task: onlining 0 [ 137.772351] rcu-torture:torture_onoff task: onlined 0 [ 140.890696] rcu-torture:torture_onoff task: offlining 2 [ 140.963589] rcu-torture:torture_onoff task: offlined 2 [ 144.016103] rcu-torture:torture_onoff task: onlining 2 [ 144.061018] rcu-torture:torture_onoff task: onlined 2 [ 147.102964] rcu-torture:torture_onoff task: offlining 1 [ 147.150646] rcu-torture:torture_onoff task: offlined 1 [ 148.958963] rcu-torture: rtc: ffffffffa044a350 ver: 3879 tfle: 0 rta: 3879 rtaf: 0 rtf: 3870 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 25666 onoff: 4/4:6/6 12,44:35,73 82:310 (HZ=1000) barrier: 0/0:0 cbflood: 32 [ 148.961270] rcu-torture: !!! [ 149.006994] rcu-torture: Reader Batch: 176545121 187407 5 22 6 2 0 6 4 6 492 [ 149.008640] rcu-torture: Free-Block Circulation: 3878 3878 3877 3876 3875 3874 3873 3872 3871 3870 0 [ 150.174970] rcu-torture:torture_onoff task: onlining 1 [ 150.192323] rcu-torture:torture_onoff task: onlined 1 [ 153.282254] rcu-torture:torture_onoff task: onlining 3 [ 153.298169] rcu-torture:torture_onoff task: onlined 3 [ 156.318974] rcu-torture:torture_onoff task: offlining 2 [ 156.354027] rcu-torture:torture_onoff task: offlined 2 [ 159.390975] rcu-torture:torture_onoff task: onlining 2 [ 159.404070] rcu-torture:torture_onoff task: onlined 2 [ 162.462966] rcu-torture:torture_onoff task: offlining 3 [ 162.527802] rcu-torture:torture_onoff task: offlined 3 [ 165.560915] rcu-torture:torture_onoff task: offlining 1 [ 165.581488] rcu-torture:torture_onoff task: offlined 1 [ 168.606962] rcu-torture:torture_onoff task: offlining 0 [ 168.656066] rcu-torture:torture_onoff task: offlined 0 [ 171.723087] rcu-torture:torture_onoff task: onlining 3 [ 171.730711] rcu-torture:torture_onoff task: onlined 3 [ 174.750965] rcu-torture:torture_onoff task: offlining 3 [ 174.772746] rcu-torture:torture_onoff task: offlined 3 [ 177.822964] rcu-torture:torture_onoff task: offlining 2 [ 177.823855] rcu-torture:torture_onoff task: offline 2 failed: errno -16 [ 180.830963] rcu-torture:torture_onoff task: offlining 2 [ 180.831836] rcu-torture:torture_onoff task: offline 2 failed: errno -16 [ 183.839914] rcu-torture:torture_onoff task: onlining 1 [ 183.847220] rcu-torture:torture_onoff task: onlined 1 [ 186.910961] rcu-torture:torture_onoff task: onlining 0 [ 186.923317] rcu-torture:torture_onoff task: onlined 0 [ 189.982962] rcu-torture:torture_onoff task: offlining 2 [ 190.062090] rcu-torture:torture_onoff task: offlined 2 [ 193.119107] rcu-torture:torture_onoff task: onlining 3 [ 193.133891] rcu-torture:torture_onoff task: onlined 3 [ 196.191099] rcu-torture:torture_onoff task: offlining 3 [ 196.371519] rcu-torture:torture_onoff task: offlined 3 [ 199.390964] rcu-torture:torture_onoff task: onlining 2 [ 199.401712] rcu-torture:torture_onoff task: onlined 2 [ 202.462965] rcu-torture:torture_onoff task: offlining 0 [ 202.556090] rcu-torture:torture_onoff task: offlined 0 [ 205.602194] rcu-torture:torture_onoff task: onlining 3 [ 205.613928] rcu-torture:torture_onoff task: onlined 3 [ 208.670962] rcu-torture:torture_onoff task: offlining 2 [ 208.692872] rcu-torture:torture_onoff task: offlined 2 [ 209.374961] rcu-torture: rtc: ffffffffa044a0b0 ver: 7451 tfle: 0 rta: 7451 rtaf: 0 rtf: 7442 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 46866 onoff: 13/13:15/17 7,44:20,180 194:874 (HZ=1000) barrier: 0/0:0 cbflood: 62 [ 209.377378] rcu-torture: !!! Reader Pipe: 327212294 4076 850 42 65 98 98 85 64 36 78 [ 209.378712] rcu-torture: Reader Batch: 326500728 716178 12 53 12 6 4 14 9 16 754 [ 209.379910] rcu-torture: Free-Block Circulation: 7450 7450 7449 7448 7447 7446 7445 7444 7443 7442 0 [ 211.742962] rcu-torture:torture_onoff task: onlining 2 [ 211.753820] rcu-torture:torture_onoff task: onlined 2 [ 214.816029] rcu-torture:torture_onoff task: onlining 0 [ 214.942377] rcu-torture:torture_onoff task: onlined 0 [ 217.950963] rcu-torture:torture_onoff task: offlining 3 [ 217.978435] rcu-torture:torture_onoff task: offlined 3 [ 221.022963] rcu-torture:torture_onoff task: offlining 0 [ 221.047659] rcu-torture:torture_onoff task: offlined 0 [ 224.094993] rcu-torture:torture_onoff task: offlining 2 [ 224.117450] rcu-torture:torture_onoff task: offlined 2 [ 227.167016] rcu-torture:torture_onoff task: onlining 2 [ 227.176877] rcu-torture:torture_onoff task: onlined 2 [ 230.238972] rcu-torture:torture_onoff task: offlining 2 [ 230.263058] rcu-torture:torture_onoff task: offlined 2 [ 233.310963] rcu-torture:torture_onoff task: onlining 3 [ 233.324368] rcu-torture:torture_onoff task: onlined 3 [ 236.383069] rcu-torture:torture_onoff task: offlining 1 [ 236.531135] rcu-torture:torture_onoff task: offlined 1 [ 239.582962] rcu-torture:torture_onoff task: onlining 2 [ 239.590437] rcu-torture:torture_onoff task: onlined 2 [ 242.654964] rcu-torture:torture_onoff task: onlining 0 [ 242.728523] rcu-torture:torture_onoff task: onlined 0 [ 245.841034] rcu-torture:torture_onoff task: offlining 2 [ 245.861652] rcu-torture:torture_onoff task: offlined 2 [ 248.862962] rcu-torture:torture_onoff task: offlining 0 [ 248.882868] rcu-torture:torture_onoff task: offlined 0 [ 251.934962] rcu-torture:torture_onoff task: onlining 1 [ 251.942285] rcu-torture:torture_onoff task: onlined 1 [ 255.007051] rcu-torture:torture_onoff task: onlining 2 [ 255.016075] rcu-torture:torture_onoff task: onlined 2 [ 258.079965] rcu-torture:torture_onoff task: offlining 2 [ 258.108277] rcu-torture:torture_onoff task: offlined 2 [ 261.150971] rcu-torture:torture_onoff task: offlining 1 [ 261.173064] rcu-torture:torture_onoff task: offlined 1 [ 264.224034] rcu-torture:torture_onoff task: onlining 2 [ 264.231470] rcu-torture:torture_onoff task: onlined 2 [ 267.303289] rcu-torture:torture_onoff task: offlining 3 [ 267.354524] rcu-torture:torture_onoff task: offlined 3 [ 269.406962] rcu-torture: rtc: ffffffffa04493c0 ver: 10955 tfle: 0 rta: 10955 rtaf: 0 rtf: 10946 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 65781 onoff: 22/22:25/27 7,126:20,180 461:1262 (HZ=1000) barrier: 0/0:0 cbflood: 92 [ 269.409097] rcu-torture: !!! Reader Pipe: 455827059 5147 1109 59 87 114 111 97 80 50 98 [ 269.410967] rcu-torture: Reader Batch: 454668734 1164092 27 94 29 19 13 22 14 26 941 [ 269.411944] rcu-torture: Free-Block Circulation: 10954 10954 10953 10952 10951 10950 10949 10948 10947 10946 0 [ 270.366961] rcu-torture:torture_onoff task: onlining 1 [ 270.374343] rcu-torture:torture_onoff task: onlined 1 [ 273.483696] rcu-torture:torture_onoff task: onlining 3 [ 273.540932] rcu-torture:torture_onoff task: onlined 3 [ 276.581516] rcu-torture:torture_onoff task: offlining 2 [ 276.804166] rcu-torture:torture_onoff task: offlined 2 [ 279.838970] rcu-torture:torture_onoff task: offlining 3 [ 279.866059] rcu-torture:torture_onoff task: offlined 3 [ 282.910959] rcu-torture:torture_onoff task: onlining 2 [ 282.921094] rcu-torture:torture_onoff task: onlined 2 [ 285.984072] rcu-torture:torture_onoff task: offlining 2 [ 286.008657] rcu-torture:torture_onoff task: offlined 2 [ 289.054962] rcu-torture:torture_onoff task: onlining 3 [ 289.063404] rcu-torture:torture_onoff task: onlined 3 [ 292.126985] rcu-torture:torture_onoff task: onlining 2 [ 292.135779] rcu-torture:torture_onoff task: onlined 2 [ 295.199968] rcu-torture:torture_onoff task: offlining 2 [ 295.224675] rcu-torture:torture_onoff task: offlined 2 [ 298.271811] rcu-torture:torture_onoff task: onlining 2 [ 298.287589] rcu-torture:torture_onoff task: onlined 2 [ 301.342965] rcu-torture:torture_onoff task: offlining 3 [ 301.368996] rcu-torture:torture_onoff task: offlined 3 [ 304.414963] rcu-torture:torture_onoff task: offlining 1 [ 304.545003] rcu-torture:torture_onoff task: offlined 1 [ 307.551121] rcu-torture:torture_onoff task: offlining 2 [ 307.551880] rcu-torture:torture_onoff task: offline 2 failed: errno -16 [ 310.558960] rcu-torture:torture_onoff task: onlining 0 [ 310.571161] rcu-torture:torture_onoff task: onlined 0 [ 313.630963] rcu-torture:torture_onoff task: offlining 2 [ 313.679068] rcu-torture:torture_onoff task: offlined 2 [ 316.703120] rcu-torture:torture_onoff task: onlining 3 [ 316.712133] rcu-torture:torture_onoff task: onlined 3 [ 319.774970] rcu-torture:torture_onoff task: offlining 3 [ 319.796064] rcu-torture:torture_onoff task: offlined 3 [ 322.846961] rcu-torture:torture_onoff task: onlining 3 [ 322.853221] rcu-torture:torture_onoff task: onlined 3 [ 325.855044] rcu-torture:torture_onoff task: onlining 2 [ 325.920463] rcu-torture:torture_onoff task: onlined 2 [ 328.948225] rcu-torture:torture_onoff task: offlining 0 [ 329.124339] rcu-torture:torture_onoff task: offlined 0 [ 329.415080] rcu-torture: rtc: ffffffffa0449a50 ver: 14643 tfle: 0 rta: 14644 rtaf: 0 rtf: 14632 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 84527 onoff: 32/32:34/37 6,126:20,223 666:1970 (HZ=1000) barrier: 0/0:0 cbflood: 121 [ 329.417607] rcu-torture: !!! Reader Pipe: 580771692 6217 1306 73 103 125 119 104 86 65 112 [ 329.419098] rcu-torture: Reader Batch: 579066090 1712499 34 134 42 27 20 27 27 32 1070 [ 329.420374] rcu-torture: Free-Block Circulation: 14644 14643 14642 14641 14639 14638 14637 14636 14635 14633 0 [ 332.126962] rcu-torture:torture_onoff task: onlining 1 [ 332.140190] rcu-torture:torture_onoff task: onlined 1 [ 335.199128] rcu-torture:torture_onoff task: onlining 0 [ 335.246868] rcu-torture:torture_onoff task: onlined 0 [ 338.271158] rcu-torture:torture_onoff task: offlining 1 [ 338.302747] rcu-torture:torture_onoff task: offlined 1 [ 341.342965] rcu-torture:torture_onoff task: onlining 1 [ 341.352626] rcu-torture:torture_onoff task: onlined 1 [ 344.414964] rcu-torture:torture_onoff task: offlining 2 [ 344.435088] rcu-torture:torture_onoff task: offlined 2 [ 347.486961] rcu-torture:torture_onoff task: offlining 1 [ 347.527603] rcu-torture:torture_onoff task: offlined 1 [ 350.558960] rcu-torture:torture_onoff task: onlining 2 [ 350.569149] rcu-torture:torture_onoff task: onlined 2 [ 353.630966] rcu-torture:torture_onoff task: offlining 0 [ 353.677338] rcu-torture:torture_onoff task: offlined 0 [ 356.702965] rcu-torture:torture_onoff task: onlining 0 [ 356.737728] rcu-torture:torture_onoff task: onlined 0 [ 359.790238] rcu-torture:torture_onoff task: offlining 0 [ 359.962698] rcu-torture:torture_onoff task: offlined 0 [ 362.974966] rcu-torture:torture_onoff task: offlining 2 [ 363.025078] rcu-torture:torture_onoff task: offlined 2 [ 366.085564] rcu-torture:torture_onoff task: offlining 3 [ 366.086272] rcu-torture:torture_onoff task: offline 3 failed: errno -16 [ 369.119101] rcu-torture:torture_onoff task: onlining 2 [ 369.126078] rcu-torture:torture_onoff task: onlined 2 [ 372.126964] rcu-torture:torture_onoff task: onlining 1 [ 372.138427] rcu-torture:torture_onoff task: onlined 1 [ 375.198973] rcu-torture:torture_onoff task: offlining 3 [ 375.274096] rcu-torture:torture_onoff task: offlined 3 [ 378.354815] rcu-torture:torture_onoff task: offlining 2 [ 378.390427] rcu-torture:torture_onoff task: offlined 2 [ 381.406959] rcu-torture:torture_onoff task: onlining 0 [ 381.419083] rcu-torture:torture_onoff task: onlined 0 [ 384.478971] rcu-torture:torture_onoff task: onlining 2 [ 384.487487] rcu-torture:torture_onoff task: onlined 2 [ 387.550962] rcu-torture:torture_onoff task: onlining 3 [ 387.568812] rcu-torture:torture_onoff task: onlined 3 [ 388.998751] rcu-torture: Stopping rcu_torture_reader [ 388.998754] rcu-torture: Stopping torture_shuffle task [ 388.998762] rcu-torture: Stopping torture_shuffle [ 388.998775] rcu-torture: Stopping torture_stutter task [ 389.000961] rcu-torture: Stopping torture_stutter [ 389.000976] rcu-torture: Stopping torture_onoff task [ 389.000984] rcu-torture: Stopping rcu_torture_fakewriter [ 389.000986] rcu-torture: Stopping rcu_torture_fakewriter [ 389.000992] rcu-torture: Stopping torture_onoff [ 389.001002] rcu-torture: Stopping rcu_torture_writer task [ 389.004593] rcu-torture: Stopping rcu_torture_fakewriter [ 389.006858] rcu-torture: Stopping rcu_torture_writer [ 389.006869] rcu-torture: Stopping rcu_torture_reader task [ 389.008331] rcu-torture: Stopping rcu_torture_reader [ 389.008336] rcu-torture: Stopping rcu_torture_reader task [ 389.009973] rcu-torture: Stopping rcu_torture_fakewriter [ 389.013784] rcu-torture: Stopping rcu_torture_reader task [ 389.016656] rcu-torture: Stopping rcu_torture_reader [ 389.017390] rcu-torture: Stopping rcu_torture_fakewriter task [ 389.018512] rcu-torture: Stopping rcu_torture_fakewriter task [ 389.019532] rcu-torture: Stopping rcu_torture_fakewriter task [ 389.020576] rcu-torture: Stopping rcu_torture_fakewriter task [ 389.021611] rcu-torture: Stopping rcu_torture_stats task [ 389.022622] rcu-torture: rtc: (null) ver: 18111 tfle: 0 rta: 18111 rtaf: 0 rtf: 18102 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 105108 onoff: 42/42:42/46 6,126:20,223 841:2442 (HZ=1000) barrier: 0/0:0 cbflood: 150 [ 389.025326] rcu-torture: !!! Reader Pipe: 725714465 7729 1634 95 128 148 150 120 98 73 128 [ 389.026639] rcu-torture: Reader Batch: 723479724 2243320 42 181 49 37 25 35 33 37 1285 [ 389.027942] rcu-torture: Free-Block Circulation: 18110 18110 18109 18108 18107 18106 18105 18104 18103 18102 0 [ 389.029101] rcu-torture: Stopping rcu_torture_stats [ 389.029984] rcu-torture: Stopping rcu_torture_cbflood task [ 389.049140] rcu-torture: Stopping rcu_torture_cbflood [ 389.058102] rcu-torture: rtc: (null) ver: 18111 tfle: 0 rta: 18111 rtaf: 0 rtf: 18102 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 105108 onoff: 42/42:42/46 6,126:20,223 841:2442 (HZ=1000) barrier: 0/0:0 cbflood: 151 [ 389.062954] rcu-torture: !!! Reader Pipe: 725714465 7729 1634 95 128 148 150 120 98 73 128 [ 389.065429] rcu-torture: Reader Batch: 723479724 2243320 42 181 49 37 25 35 33 37 1285 [ 389.067874] rcu-torture: Free-Block Circulation: 18110 18110 18109 18108 18107 18106 18105 18104 18103 18102 0 [ 389.070533] rcu-torture:--- End of test: FAILURE: 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 n_barrier_cbs=0 onoff_interval=3 onoff_holdoff=30