Project

General

Profile

Bug #1333 » 20111118_tcs_ga_after_boot_some_dtrace_output.txt

info_2_with_dtrace - Jon Strabala, 2011-11-18 06:34 PM

 
1
lab10# dtrace -n "apix_do_interrupt:entry/cpu==0/ { @a[stack()]=count()} END { trunc(@a, 5); }" -c "sleep 10"
2
dtrace: description 'apix_do_interrupt:entry' matched 2 probes
3
dtrace: pid 102279 has exited
4
CPU     ID                    FUNCTION:NAME
5
  2      2                             :END
6

    
7

    
8
              unix`_interrupt+0x1e9
9
              unix`do_splx+0x6e
10
              unix`hr_clock_unlock+0x18
11
              genunix`dtrace_hres_tick+0x69
12
              unix`cbe_hres_tick+0x11
13
              genunix`cyclic_expire+0x1aa
14
              genunix`cyclic_fire+0x2f9
15
              unix`cbe_fire+0x4a
16
              apix`apix_dispatch_by_vector+0x8a
17
              apix`apix_dispatch_hilevel+0x15
18
              unix`switch_sp_and_call+0x13
19
              apix`apix_do_interrupt+0x5b9
20
              unix`_interrupt+0x1e9
21
              unix`acpi_cpu_cstate+0x11e
22
              unix`cpu_acpi_idle+0xcb
23
              unix`cpu_idle_adaptive+0x13
24
              unix`idle+0x89
25
              unix`thread_start+0x8
26
                3
27

    
28
              unix`_interrupt+0x1e9
29
              genunix`thread_free_prevent+0x2b
30
              unix`clock_tick_process+0x4f
31
              unix`clock_tick_execute_common+0x6b
32
              unix`clock_tick_schedule+0xa5
33
              genunix`clock+0x31d
34
              genunix`cyclic_softint+0x3bb
35
              unix`cbe_softclock+0x17
36
              unix`av_dispatch_softvect+0x8d
37
              apix`apix_dispatch_softint+0x35
38
              unix`switch_sp_and_call+0x13
39
                5
40

    
41
              unix`_interrupt+0x1e9
42
              unix`mutex_enter+0x10
43
              genunix`cyclic_softint+0x3bb
44
              unix`cbe_softclock+0x17
45
              unix`av_dispatch_softvect+0x8d
46
              apix`apix_dispatch_softint+0x35
47
              unix`switch_sp_and_call+0x13
48
                5
49

    
50
              unix`_interrupt+0x1e9
51
               16
52

    
53
              unix`_interrupt+0x1e9
54
              unix`acpi_cpu_cstate+0x11e
55
              unix`cpu_acpi_idle+0xcb
56
              unix`cpu_idle_adaptive+0x13
57
              unix`idle+0x89
58
              unix`thread_start+0x8
59
             1092
60
lab10#
61

    
62

    
63

    
64

    
65
lab10# cat hotkernel_30sec.2011-11-18_1000.out
66
Sampling... Hit Ctrl-C to end. -OR- wait 30 seconds for autoquit
67

    
68
FUNCTION                                                COUNT   PCNT
69
dtrace`dtrace_speculation_clean                             1   0.0%
70
unix`0xfffffffffb86                                         1   0.0%
71
unix`lock_set                                               1   0.0%
72
genunix`scalehrtime                                         1   0.0%
73
unix`lock_set_spl                                           1   0.0%
74
unix`setbackdq                                              1   0.0%
75
genunix`cv_signal                                           1   0.0%
76
unix`cpu_resched                                            1   0.0%
77
genunix`taskq_ent_alloc                                     1   0.0%
78
sha1`sha1_block_data_order                                  1   0.0%
79
genunix`exp_x                                               1   0.0%
80
dtrace`dtrace_dynvar_clean                                  1   0.0%
81
unix`disp                                                   1   0.0%
82
genunix`as_segcompar                                        1   0.0%
83
unix`cpupm_next_cstate                                      1   0.0%
84
unix`splr                                                   1   0.0%
85
unix`splx                                                   1   0.0%
86
unix`idle                                                   1   0.0%
87
unix`cpu_idle_enter                                         1   0.0%
88
unix`tsc_gethrtimeunscaled                                  1   0.0%
89
genunix`timeout_generic                                     1   0.0%
90
unix`mul32                                                  1   0.0%
91
unix`atomic_add_32_nv                                       1   0.0%
92
genunix`ddi_get_lbolt                                       1   0.0%
93
unix`do_splx                                                1   0.0%
94
genunix`getpcstack                                          1   0.0%
95
genunix`timeout_dispatch                                    1   0.0%
96
apix`apix_dispatch_softint                                  2   0.0%
97
unix`ddi_get32                                              2   0.0%
98
unix`disp_getwork                                           2   0.0%
99
unix`i86_monitor                                            2   0.0%
100
unix`av_check_softint_pending                               2   0.0%
101
unix`cpupm_is_ready                                         2   0.0%
102
unix`bitset_atomic_del                                      2   0.0%
103
unix`membar_enter                                           2   0.0%
104
unix`atomic_add_32                                          3   0.0%
105
unix`bitset_atomic_add                                      3   0.0%
106
genunix`vmem_hash_delete                                    3   0.0%
107
unix`tsc_read                                               4   0.0%
108
unix`fakesoftint_return                                     4   0.0%
109
unix`mutex_enter                                            5   0.0%
110
genunix`cyclic_coverage                                     5   0.0%
111
genunix`fsflush_do_pages                                    5   0.0%
112
genunix`vmem_hash_rescale                                   6   0.0%
113
genunix`cyclic_coverage_hash                                8   0.0%
114
unix`page_nextn                                            12   0.0%
115
unix`acpi_cpu_cstate                                      362   0.3%
116
unix`i86_mwait                                         123609  99.6%
117
lab10#
118

    
119

    
120

    
121
lab10# wc -l aubrey.deadline_timer_reprogram.d.2011-11-18_1000.out
122
7989 aubrey.deadline_timer_reprogram.d.2011-11-18_1000.out
123
lab10# head -20 aubrey.deadline_timer_reprogram.d.2011-11-18_1000.out
124
dtrace: script '/root/hotkernel_30/aubrey.deadline_timer_reprogram.d' matched 3 probes
125
CPU     ID                    FUNCTION:NAME
126
  3      1                           :BEGIN looking at deadline_timer_reprogram:entry (requested by Aubrey Li)
127
  0  29787   deadline_timer_reprogram:entry target = 6651fe6277100 - now = 6651fe58f2b15
128

    
129
  0  29787   deadline_timer_reprogram:entry target = 6651fe6647a00 - now = 6651fe627afdd
130

    
131
  0  29787   deadline_timer_reprogram:entry target = 6651fe6c00780 - now = 6651fe664a862
132

    
133
  0  29787   deadline_timer_reprogram:entry target = 6651fe7589e00 - now = 6651fe6c0466a
134

    
135
  0  29787   deadline_timer_reprogram:entry target = 6651fe7f13480 - now = 6651fe758ef59
136

    
137
  0  29787   deadline_timer_reprogram:entry target = 6651fe889cb00 - now = 6651fe7f186be
138

    
139
  0  29787   deadline_timer_reprogram:entry target = 6651fe9226180 - now = 6651fe88a04a3
140

    
141
  0  29787   deadline_timer_reprogram:entry target = 6651fe9baf800 - now = 6651fe922b3c0
142

    
143
  0  29787   deadline_timer_reprogram:entry target = 6651fea538e80 - now = 6651fe9bb33c2
144
lab10# tail -20 aubrey.deadline_timer_reprogram.d.2011-11-18_1000.out
145
  3  29787   deadline_timer_reprogram:entry target = 6652235dbb308 - now = 665223544d0b4
146

    
147
  3  29787   deadline_timer_reprogram:entry target = 6652236073780 - now = 6652235dbeda1
148

    
149
  3  29787   deadline_timer_reprogram:entry target = 665223672c6c6 - now = 66522360788f7
150

    
151
  3  29787   deadline_timer_reprogram:entry target = 665223709da84 - now = 665223672f51e
152

    
153
  3  29787   deadline_timer_reprogram:entry target = 6652237a0ee42 - now = 66522370a1305
154

    
155
  3  29787   deadline_timer_reprogram:entry target = 6652238380200 - now = 6652237a129c0
156

    
157
  3  29787   deadline_timer_reprogram:entry target = 6652238cf15be - now = 66522383838bc
158

    
159
  3  29787   deadline_timer_reprogram:entry target = 6652239022800 - now = 6652238cf4815
160

    
161
  3  29787   deadline_timer_reprogram:entry target = 66522391f3820 - now = 6652239027303
162

    
163
  3  65571                        :tick-10s
164

    
165
lab10#
166

    
167

    
168

    
169

    
170
lab10# cat cpu_idle_exit_1ms.d.2011-11-18_1000.out
171
dtrace: script '/root/hotkernel_30/cpu_idle_exit_1ms.d' matched 2 probes
172
CPU     ID                    FUNCTION:NAME
173
  0   7183              cpu_idle_exit:entry
174
              unix`acpi_cpu_cstate+0x26a
175
              unix`cpu_acpi_idle+0xcb
176
              unix`cpu_idle_adaptive+0x13
177
              unix`idle+0x89
178
              unix`thread_start+0x8
179

    
180
  0   7183              cpu_idle_exit:entry
181
              apix`apix_do_interrupt+0x7b
182
              unix`_interrupt+0x1e9
183
              unix`acpi_cpu_cstate+0x11e
184
              unix`cpu_acpi_idle+0xcb
185
              unix`cpu_idle_adaptive+0x13
186
              unix`idle+0x89
187
              unix`thread_start+0x8
188

    
189
  2   7183              cpu_idle_exit:entry
190
              unix`acpi_cpu_cstate+0x26a
191
              unix`cpu_acpi_idle+0xcb
192
              unix`cpu_idle_adaptive+0x13
193
              unix`idle+0x89
194
              unix`thread_start+0x8
195

    
196
  2   7183              cpu_idle_exit:entry
197
              apix`apix_do_interrupt+0x7b
198
              unix`_interrupt+0x1e9
199
              unix`acpi_cpu_cstate+0x11e
200
              unix`cpu_acpi_idle+0xcb
201
              unix`cpu_idle_adaptive+0x13
202
              unix`idle+0x89
203
              unix`thread_start+0x8
204

    
205
  3   7183              cpu_idle_exit:entry
206
              unix`acpi_cpu_cstate+0x26a
207
              unix`cpu_acpi_idle+0xcb
208
              unix`cpu_idle_adaptive+0x13
209
              unix`idle+0x89
210
              unix`thread_start+0x8
211

    
212
  3   7183              cpu_idle_exit:entry
213
              apix`apix_do_interrupt+0x7b
214
              unix`_interrupt+0x1e9
215
              unix`acpi_cpu_cstate+0x11e
216
              unix`cpu_acpi_idle+0xcb
217
              unix`cpu_idle_adaptive+0x13
218
              unix`idle+0x89
219
              unix`thread_start+0x8
220

    
221
  0   7183              cpu_idle_exit:entry
222
              unix`acpi_cpu_cstate+0x26a
223
              unix`cpu_acpi_idle+0xcb
224
              unix`cpu_idle_adaptive+0x13
225
              unix`idle+0x89
226
              unix`thread_start+0x8
227

    
228
  0   7183              cpu_idle_exit:entry
229
              apix`apix_do_interrupt+0x7b
230
              unix`_interrupt+0x1e9
231
              unix`acpi_cpu_cstate+0x11e
232
              unix`cpu_acpi_idle+0xcb
233
              unix`cpu_idle_adaptive+0x13
234
              unix`idle+0x89
235
              unix`thread_start+0x8
236

    
237
  2   7183              cpu_idle_exit:entry
238
              unix`acpi_cpu_cstate+0x26a
239
              unix`cpu_acpi_idle+0xcb
240
              unix`cpu_idle_adaptive+0x13
241
              unix`idle+0x89
242
              unix`thread_start+0x8
243

    
244
  2   7183              cpu_idle_exit:entry
245
              apix`apix_do_interrupt+0x7b
246
              unix`_interrupt+0x1e9
247
              unix`acpi_cpu_cstate+0x11e
248
              unix`cpu_acpi_idle+0xcb
249
              unix`cpu_idle_adaptive+0x13
250
              unix`idle+0x89
251
              unix`thread_start+0x8
252

    
253
  3   7183              cpu_idle_exit:entry
254
              unix`acpi_cpu_cstate+0x26a
255
              unix`cpu_acpi_idle+0xcb
256
              unix`cpu_idle_adaptive+0x13
257
              unix`idle+0x89
258
              unix`thread_start+0x8
259

    
260
  3   7183              cpu_idle_exit:entry
261
              apix`apix_do_interrupt+0x7b
262
              unix`_interrupt+0x1e9
263
              unix`acpi_cpu_cstate+0x11e
264
              unix`cpu_acpi_idle+0xcb
265
              unix`cpu_idle_adaptive+0x13
266
              unix`idle+0x89
267
              unix`thread_start+0x8
268

    
269
  1   7183              cpu_idle_exit:entry
270
              apix`apix_do_interrupt+0x7b
271
              unix`_interrupt+0x1e9
272
              unix`do_splx+0x6e
273
              unix`xc_common+0x13d
274
              unix`xc_call+0x39
275
              unix`speedstep_power+0xcd
276
              unix`cpupm_state_change+0xe4
277
              unix`cpupm_plat_change_state+0x3e
278
              unix`cpupm_change_state+0x2a
279
              unix`cpupm_utilization_event+0x104
280
              unix`cmt_ev_thread_swtch_pwr+0xc1
281
              unix`pg_ev_thread_swtch+0x71
282
              unix`swtch+0x99
283
              genunix`cv_timedwait_sig_hires+0x331
284
              genunix`cv_waituntil_sig+0x14e
285
              genunix`lwp_park+0x1ca
286
              genunix`syslwp_park+0x44
287
              unix`sys_syscall+0x26e
288

    
289
  1  52674                        :tick-1ms
290

    
291
lab10#
292

    
293

    
294
lab10# cat acpi_cpu_cstate_10ms.d.2011-11-18_1000.out
295
dtrace: script '/root/hotkernel_30/acpi_cpu_cstate_10ms.d' matched 2 probes
296
CPU     ID                    FUNCTION:NAME
297
  0   2960            acpi_cpu_cstate:entry
298
              unix`cpu_acpi_idle+0xcb
299
              unix`cpu_idle_adaptive+0x13
300
              unix`idle+0x89
301
              unix`thread_start+0x8
302

    
303
  2   2960            acpi_cpu_cstate:entry
304
              unix`cpu_acpi_idle+0xcb
305
              unix`cpu_idle_adaptive+0x13
306
              unix`idle+0x89
307
              unix`thread_start+0x8
308

    
309
  3   2960            acpi_cpu_cstate:entry
310
              unix`cpu_acpi_idle+0xcb
311
              unix`cpu_idle_adaptive+0x13
312
              unix`idle+0x89
313
              unix`thread_start+0x8
314

    
315
  0   2960            acpi_cpu_cstate:entry
316
              unix`cpu_acpi_idle+0xcb
317
              unix`cpu_idle_adaptive+0x13
318
              unix`idle+0x89
319
              unix`thread_start+0x8
320

    
321
  0   2960            acpi_cpu_cstate:entry
322
              unix`cpu_acpi_idle+0xcb
323
              unix`cpu_idle_adaptive+0x13
324
              unix`idle+0x89
325
              unix`thread_start+0x8
326

    
327
  0   2960            acpi_cpu_cstate:entry
328
              unix`cpu_acpi_idle+0xcb
329
              unix`cpu_idle_adaptive+0x13
330
              unix`idle+0x89
331
              unix`thread_start+0x8
332

    
333
  0   2960            acpi_cpu_cstate:entry
334
              unix`cpu_acpi_idle+0xcb
335
              unix`cpu_idle_adaptive+0x13
336
              unix`idle+0x89
337
              unix`thread_start+0x8
338

    
339
  2   2960            acpi_cpu_cstate:entry
340
              unix`cpu_acpi_idle+0xcb
341
              unix`cpu_idle_adaptive+0x13
342
              unix`idle+0x89
343
              unix`thread_start+0x8
344

    
345
  2   2960            acpi_cpu_cstate:entry
346
              unix`cpu_acpi_idle+0xcb
347
              unix`cpu_idle_adaptive+0x13
348
              unix`idle+0x89
349
              unix`thread_start+0x8
350

    
351
  2   2960            acpi_cpu_cstate:entry
352
              unix`cpu_acpi_idle+0xcb
353
              unix`cpu_idle_adaptive+0x13
354
              unix`idle+0x89
355
              unix`thread_start+0x8
356

    
357
  3   2960            acpi_cpu_cstate:entry
358
              unix`cpu_acpi_idle+0xcb
359
              unix`cpu_idle_adaptive+0x13
360
              unix`idle+0x89
361
              unix`thread_start+0x8
362

    
363
  3   2960            acpi_cpu_cstate:entry
364
              unix`cpu_acpi_idle+0xcb
365
              unix`cpu_idle_adaptive+0x13
366
              unix`idle+0x89
367
              unix`thread_start+0x8
368

    
369
  3   2960            acpi_cpu_cstate:entry
370
              unix`cpu_acpi_idle+0xcb
371
              unix`cpu_idle_adaptive+0x13
372
              unix`idle+0x89
373
              unix`thread_start+0x8
374

    
375
  1  52673                       :tick-10ms
376

    
377
lab10#
378

    
379

    
380

    
381
lab10# wc -l psm_get_cpu_id_1ms.d.2011-11-18_1000.out
382
3718 psm_get_cpu_id_1ms.d.2011-11-18_1000.out
383
lab10# head -10 psm_get_cpu_id_1ms.d.2011-11-18_1000.out
384
dtrace: script '/root/hotkernel_30/psm_get_cpu_id_1ms.d' matched 2 probes
385
CPU     ID                    FUNCTION:NAME
386
  1   7091             psm_get_cpu_id:entry
387
              apix`apix_setspl+0x17
388
              unix`splr+0x59
389
              unix`xc_common+0xc0
390
              unix`xc_sync+0x39
391
              unix`dtrace_xcall+0xa6
392
              dtrace`dtrace_state_go+0x5b6
393
              dtrace`dtrace_ioctl+0xb47
394
lab10# tail -100 psm_get_cpu_id_1ms.d.2011-11-18_1000.out
395
  1   7091             psm_get_cpu_id:entry
396
              apix`apix_setspl+0x17
397
              unix`splr+0x59
398
              genunix`thread_lock+0x28
399
              genunix`post_syscall+0x455
400
              unix`0xfffffffffb8011db
401

    
402
  1   7091             psm_get_cpu_id:entry
403
              apix`apix_setspl+0x17
404
              unix`do_splx+0x54
405
              genunix`disp_lock_exit+0x88
406
              genunix`post_syscall+0x48b
407
              unix`0xfffffffffb8011db
408

    
409
  1   7091             psm_get_cpu_id:entry
410
              apix`apix_setspl+0x17
411
              unix`splr+0x59
412
              genunix`thread_lock+0x28
413
              genunix`post_syscall+0x455
414
              unix`0xfffffffffb8011db
415

    
416
  1   7091             psm_get_cpu_id:entry
417
              apix`apix_setspl+0x17
418
              unix`do_splx+0x54
419
              genunix`disp_lock_exit+0x88
420
              genunix`post_syscall+0x48b
421
              unix`0xfffffffffb8011db
422

    
423
  1   7091             psm_get_cpu_id:entry
424
              apix`apix_setspl+0x17
425
              unix`splr+0x59
426
              genunix`thread_lock+0x28
427
              genunix`post_syscall+0x455
428
              unix`0xfffffffffb8011db
429

    
430
  1   7091             psm_get_cpu_id:entry
431
              apix`apix_setspl+0x17
432
              unix`do_splx+0x54
433
              genunix`disp_lock_exit+0x88
434
              genunix`post_syscall+0x48b
435
              unix`0xfffffffffb8011db
436

    
437
  1   7091             psm_get_cpu_id:entry
438
              apix`apix_setspl+0x17
439
              unix`splr+0x59
440
              genunix`thread_lock+0x28
441
              genunix`post_syscall+0x455
442
              unix`0xfffffffffb8011db
443

    
444
  1   7091             psm_get_cpu_id:entry
445
              apix`apix_setspl+0x17
446
              unix`do_splx+0x54
447
              genunix`disp_lock_exit+0x88
448
              genunix`post_syscall+0x48b
449
              unix`0xfffffffffb8011db
450

    
451
  1   7091             psm_get_cpu_id:entry
452
              apix`apix_setspl+0x17
453
              unix`splr+0x59
454
              genunix`thread_lock+0x28
455
              genunix`post_syscall+0x455
456
              unix`0xfffffffffb8011db
457

    
458
  1   7091             psm_get_cpu_id:entry
459
              apix`apix_setspl+0x17
460
              unix`do_splx+0x54
461
              genunix`disp_lock_exit+0x88
462
              genunix`post_syscall+0x48b
463
              unix`0xfffffffffb8011db
464

    
465
  1   7091             psm_get_cpu_id:entry
466
              apix`apix_setspl+0x17
467
              unix`splr+0x59
468
              genunix`thread_lock+0x28
469
              genunix`post_syscall+0x455
470
              unix`0xfffffffffb8011db
471

    
472
  1   7091             psm_get_cpu_id:entry
473
              apix`apix_setspl+0x17
474
              unix`do_splx+0x54
475
              genunix`disp_lock_exit+0x88
476
              genunix`post_syscall+0x48b
477
              unix`0xfffffffffb8011db
478

    
479
  1   7091             psm_get_cpu_id:entry
480
              apix`apix_setspl+0x17
481
              unix`splr+0x59
482
              genunix`thread_lock+0x28
483
              genunix`post_syscall+0x455
484
              unix`0xfffffffffb8011db
485

    
486
  1   7091             psm_get_cpu_id:entry
487
              apix`apix_setspl+0x17
488
              unix`do_splx+0x54
489
              genunix`disp_lock_exit+0x88
490
              genunix`post_syscall+0x48b
491
              unix`0xfffffffffb8011db
492

    
493
  1  52674                        :tick-1ms
494

    
495
lab10#
496

    
497

    
498
lab10# cat i86_cpu_wait_idle_power_thread.d.2011-11-18_1000.out
499
dtrace: script '/root/hotkernel_30/i86_cpu_wait_idle_power_thread.d' matched 2574 probes
500
CPU     ID                    FUNCTION:NAME
501
  1      1                           :BEGIN
502
100 ms sample of all kernel entry and returns
503

    
504
  1  65570                      :tick-100ms
505
  1      2                             :END
506
             PROGRAM    entries    returns
507
cv_timedwait_sig_hires          1          0
508
    cv_waituntil_sig          1          0
509
cmt_ev_thread_remain_pwr          1          1
510
          cpuset_all          1          1
511
 pg_ev_thread_remain          1          1
512
   thread_transition          1          1
513
            zio_wait          1          1
514
apix_intr_thread_epilog          2          2
515
apix_intr_thread_prolog          2          2
516
            poke_cpu          3          3
517
       cpu_get_state          4          4
518
     cv_reltimedwait          6          6
519
  cv_timedwait_hires          6          6
520
zio_wait_for_children          6          6
521
             cv_wait          7          7
522
  page_lookup_nowait          7          7
523
  cpupm_change_state          9          9
524
      cpupm_is_ready          9          9
525
cpupm_plat_change_state          9          9
526
  cpupm_state_change          9          9
527
       cpuset_isnull          9          9
528
     disp_lowpri_cpu          9          9
529
     speedstep_power          9          9
530
     kmem_cpu_reload         10         10
531
           idle_exit         12         12
532
         cpu_resched         13         13
533
          idle_enter         13         13
534
   taskq_thread_wait         14         14
535
cpupm_utilization_event         20         20
536
  apic_unset_idlecpu         24         24
537
      unset_idle_cpu         24         24
538
    apic_set_idlecpu         26         26
539
cmt_ev_thread_swtch_pwr         26         26
540
  pg_ev_thread_swtch         26         26
541
        set_idle_cpu         26         26
542
     acpi_cpu_cstate         26         27
543
  cpu_set_curr_clock         36         36
544
         i86_monitor         36         36
545
   thread_free_allow         36         36
546
 thread_free_prevent         36         36
547
  cpu_acpi_read_port         51         50
548
cpupm_wakeup_cstate_data         61         61
549
cpu_acpi_get_max_cstates         62         62
550
   cpupm_next_cstate         62         62
551
      tlb_going_idle         62         62
552
           i86_mwait         72         68
553
 cmt_ev_thread_swtch        104        104
554
      cpu_idle_mwait        108        102
555
cpu_idle_dtrace_exit        118        118
556
 cpu_idle_exit_state        118        118
557
       cpu_acpi_idle        124        122
558
   cpu_idle_adaptive        124        122
559
cpu_idle_dtrace_enter        124        124
560
      cpu_idle_enter        124        124
561
cpu_idle_enter_state        124        124
562
cpu_idle_prop_get_intptr        124        124
563
            cpu_grow        247        247
564
       cpu_idle_exit        250        250
565
             cpu_get        256        256
566
         cpu_get_all        256        256
567
           cpu_decay        260        260
568
      cpu_update_pct        260        260
569
      new_cpu_mstate        269        269
570
         thread_lock        528        528
571
      psm_get_cpu_id       1303       1303
572

    
573

    
574
lab10#
575

    
576

    
577

    
578
OTHER:
579

    
580

    
581
  uname -a
582
    SunOS lab10 5.11 tsc-ga-20111118 i86pc i386 i86pc Solaris
583

    
584
  top -n 5
585
    last pid: 102249;  load avg:  0.00,  0.00,  0.01;  up 0+01:03:42       10:28:27
586
    48 processes: 47 sleeping, 1 on cpu
587
    CPU states: 99.8% idle,  0.0% user,  0.2% kernel,  0.0% iowait,  0.0% swap
588
    Kernel: 303 ctxsw, 9 trap, 561 intr, 385 syscall, 8 flt
589
    Memory: 16G phys mem, 14G free mem, 8187M total swap, 8187M free swap
590
       PID USERNAME NLWP PRI NICE  SIZE   RES STATE    TIME    CPU COMMAND
591
    102248 root        1  52    0 3352K 1664K cpu/3    0:00  0.04% top
592
    100003 root       16  59    0   14M   12M sleep    0:01  0.00% svc.startd
593
    100725 root        4  59    0 6448K 3628K sleep    0:00  0.00% inetd
594
    100005 root       22  59    0   14M   13M sleep    0:03  0.00% svc.configd
595
    100200 root        5  60  -20 2476K 1532K sleep    0:00  0.00% zonestatd
596

    
597
  beadm list
598
    BE                 Active Mountpoint      Space Policy Created
599
    nightly-2011-11-18 NR     /               64.1G static 2011-11-18 08:18
600
    oi_151a            -      -               13.0M static 2011-09-14 09:01
601
    tsc-fix            -      -               820M  static 2011-10-28 15:08
602

    
603
  psrinfo -vp
604
    The physical processor has 4 virtual processors (0-3)
605
      x86 (GenuineIntel 206A7 family 6 model 42 step 7 clock 3392 MHz)
606
        Intel(r) Xeon(r) CPU E31270 @ 3.40GHz
607

    
608
  psrinfo -v
609
    Status of virtual processor 0 as of: 11/18/2011 10:28:27
610
      on-line since 11/18/2011 09:25:10.
611
      The i386 processor operates at 3392 MHz,
612
        and has an i387 compatible floating point processor.
613
    Status of virtual processor 1 as of: 11/18/2011 10:28:27
614
      on-line since 11/18/2011 09:25:15.
615
      The i386 processor operates at 3392 MHz,
616
        and has an i387 compatible floating point processor.
617
    Status of virtual processor 2 as of: 11/18/2011 10:28:27
618
      on-line since 11/18/2011 09:25:15.
619
      The i386 processor operates at 3392 MHz,
620
        and has an i387 compatible floating point processor.
621
    Status of virtual processor 3 as of: 11/18/2011 10:28:27
622
      on-line since 11/18/2011 09:25:15.
623
      The i386 processor operates at 3392 MHz,
624
        and has an i387 compatible floating point processor.
625

    
626
  ucodeadm -v
627
    CPU Microcode Version
628
    0   0x18
629
    1   0x18
630
    2   0x18
631
    3   0x18
632

    
633
  prtdiag
634
    System Configuration: Supermicro X9SCI/X9SCA
635
    BIOS Configuration: American Megatrends Inc. 1.10 08/19/2011
636
    BMC Configuration: IPMI 2.0 (KCS: Keyboard Controller Style)
637
    ==== Processor Sockets ====================================
638
    Version                          Location Tag
639
    -------------------------------- --------------------------
640
    Intel(R) Xeon(R) CPU E31270 @ 3.40GHz CPU
641
    ==== Memory Device Sockets ================================
642
    Type        Status Set Device Locator      Bank Locator
643
    ----------- ------ --- ------------------- ----------------
644
    Unknown     in use 0   DIMM_1A             BANK0
645
    Unknown     in use 0   DIMM_2A             BANK1
646
    Unknown     in use 0   DIMM_1B             BANK2
647
    Unknown     in use 0   DIMM_2B             BANK3
648
    ==== On-Board Devices =====================================
649
       To Be Filled By O.E.M.
650
    ==== Upgradeable Slots ====================================
651
    ID  Status    Type             Description
652
    --- --------- ---------------- ----------------------------
653
    0   in use    PCI              SLOT 1
654
    1   in use    PCI              SLOT 2
655
    2   in use    PCI              SLOT 3
656
    3   in use    Unknown          SLOT 4
657
    4   in use    Unknown          SLOT 5
658
    5   in use    Unknown          SLOT 6
659

    
660
  cat /etc/system | egrep -v '(^\*|^$)'
661
    set ip:ip_squeue_worker_wait=0
662
    set snooping=1
663
    set pcplusmp:apic_panic_on_nmi=1
664

    
665
  cat /etc/power.conf | egrep -v '(^#|^$)'
666
    cpu_deep_idle enable
667
    cpu-threshold 10s
668
    cpupm enable
669

    
670
  echo hz/D | sudo mdb -k
671
    hz:
672
    hz:             100
673

    
674
  echo apic_timer::print apic_timer_t | sudo mdb -k
675
    {
676
        mode = 0x2
677
        apic_timer_enable_ops = deadline_timer_enable
678
        apic_timer_disable_ops = deadline_timer_disable
679
        apic_timer_reprogram_ops = deadline_timer_reprogram
680
    }
681

    
682
  kstat -m cpu_info | egrep "current_clock_Hz"
683
        current_clock_Hz                3401000000
684
        current_clock_Hz                3401000000
685
        current_clock_Hz                3401000000
686
        current_clock_Hz                3401000000
687

    
688
  kstat -m cpu_info | egrep "supported_frequencies_Hz"\|"supported_max_cstates"\|"brand" | sort -u
689
        brand                           Intel(r) Xeon(r) CPU E31270 @ 3.40GHz
690
        supported_frequencies_Hz        1600000000:1800000000:2000000000:2200000000:2400000000:2600000000:2800000000:3000000000:3200000000:3400000000:3401000000
691
        supported_max_cstates           2
692

    
693
  dtrace -n "apix_do_interrupt:entry/cpu==0/ { @a[stack()]=count()} END { trunc(@a, 5); }" -c "sleep 10"
694
dtrace: description 'apix_do_interrupt:entry' matched 2 probes
695
dtrace: pid 102276 has exited
696
    CPU     ID                    FUNCTION:NAME
697
      2      2                             :END
698
                  unix`_interrupt+0x1e9
699
                  genunix`thread_free_prevent+0x1
700
                  unix`clock_tick_execute_common+0x6b
701
                  unix`clock_tick_schedule+0xa5
702
                  genunix`clock+0x31d
703
                  genunix`cyclic_softint+0x3bb
704
                  unix`cbe_softclock+0x17
705
                  unix`av_dispatch_softvect+0x8d
706
                  apix`apix_dispatch_softint+0x35
707
                  unix`switch_sp_and_call+0x13
708
                    4
709
                  unix`_interrupt+0x1e9
710
                  genunix`clock+0x188
711
                  genunix`cyclic_softint+0x3bb
712
                  unix`cbe_softclock+0x17
713
                  unix`av_dispatch_softvect+0x8d
714
                  apix`apix_dispatch_softint+0x35
715
                  unix`switch_sp_and_call+0x13
716
                    5
717
                  unix`_interrupt+0x1e9
718
                  apix`apix_dispatch_softint+0x29
719
                  unix`switch_sp_and_call+0x13
720
                    9
721
                  unix`_interrupt+0x1e9
722
                  genunix`clock+0x18c
723
                  genunix`cyclic_softint+0x3bb
724
                  unix`cbe_softclock+0x17
725
                  unix`av_dispatch_softvect+0x8d
726
                  apix`apix_dispatch_softint+0x35
727
                  unix`switch_sp_and_call+0x13
728
                   15
729
                  unix`_interrupt+0x1e9
730
                  unix`acpi_cpu_cstate+0x11e
731
                  unix`cpu_acpi_idle+0xcb
732
                  unix`cpu_idle_adaptive+0x13
733
                  unix`idle+0x89
734
                  unix`thread_start+0x8
735
                 1116
736

    
737
Sampling... Will quit after 100ms, you can also Hit Ctrl-C to end.
738

    
739
FUNCTION                                                COUNT   PCNT
740
unix`splr                                                   1   0.0%
741
unix`hwblkclr                                               1   0.0%
742
genunix`segvn_faultpage                                     1   0.0%
743
unix`cpu_idle_adaptive                                      2   0.0%
744
unix`i86_mwait                                            109   1.4%
745
i86_mwait                                                 124   1.6%
746
cpu_grow                                                  214   2.7%
747
cpu_update_pct                                            230   2.9%
748
cpu_decay                                                 230   2.9%
749
new_cpu_mstate                                            237   3.0%
750
unix`acpi_cpu_cstate                                      238   3.0%
751
cpu_get                                                   256   3.3%
752
cpu_get_all                                               256   3.3%
753
acpi_cpu_cstate                                           261   3.3%
754
apic_timer_reprogram                                      378   4.8%
755
deadline_timer_reprogram                                  378   4.8%
756
cyclic_fire                                               379   4.8%
757
cpu_idle_exit_state                                       382   4.9%
758
cpu_acpi_idle                                             385   4.9%
759
cpu_idle_adaptive                                         385   4.9%
760
apix_intr_enter                                           387   4.9%
761
apix_do_interrupt                                         387   4.9%
762
thread_lock                                               543   6.9%
763
cpu_idle_exit                                             768   9.8%
764
psm_get_cpu_id                                           1318  16.8%
765

    
766

    
767

    
(15-15/18)