aboutsummaryrefslogtreecommitdiff
path: root/tests/trace_empty.txt
blob: b35ba6fe6d048c2a42e700b6565717aaf8354744 (plain)
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
version = 6
cpus=5
       trace-cmd-2461  [000]    34.896920: sched_stat_runtime:   comm=trace-cmd pid=2461 runtime=7778999 [ns] vruntime=6087430069 [ns]
       trace-cmd-2461  [000]    34.896941: sched_stat_sleep:     comm=sshd pid=2450 delay=1802051076 [ns]
       trace-cmd-2461  [000]    34.896972: sched_wakeup:         sshd:2450 [120] success=1 CPU:000
       trace-cmd-2461  [000]    34.897022: sched_stat_wait:      comm=sshd pid=2450 delay=0 [ns]
       trace-cmd-2461  [000]    34.897053: sched_switch:         trace-cmd:2461 [120] R ==> sshd:2450 [120]
          <idle>-0     [001]    34.897147: sched_stat_wait:      comm=rcuos/0 pid=9 delay=0 [ns]
          <idle>-0     [001]    34.897153: sched_switch:         swapper/1:0 [120] R ==> rcuos/0:9 [120]
         rcuos/0-9     [001]    34.897169: sched_stat_runtime:   comm=sshd pid=2450 runtime=258292 [ns] vruntime=6078688361 [ns]
         rcuos/0-9     [001]    34.897175: sched_stat_sleep:     comm=rcu_sched pid=7 delay=26617125 [ns]
         rcuos/0-9     [001]    34.897182: sched_wakeup:         rcu_sched:7 [120] success=1 CPU:000
         rcuos/0-9     [001]    34.897186: sched_stat_runtime:   comm=rcuos/0 pid=9 runtime=445750 [ns] vruntime=6730976621 [ns]
         rcuos/0-9     [001]    34.897230: sched_switch:         rcuos/0:9 [120] S ==> swapper/1:0 [120]
            sshd-2450  [000]    34.897303: sched_stat_runtime:   comm=sshd pid=2450 runtime=134042 [ns] vruntime=6078822403 [ns]
            sshd-2450  [000]    34.897313: sched_stat_wait:      comm=rcu_sched pid=7 delay=134042 [ns]
            sshd-2450  [000]    34.897319: sched_switch:         sshd:2450 [120] S ==> rcu_sched:7 [120]
       rcu_sched-7     [000]    34.897329: sched_stat_runtime:   comm=rcu_sched pid=7 runtime=25916 [ns] vruntime=6078455985 [ns]
       rcu_sched-7     [000]    34.897338: sched_stat_wait:      comm=trace-cmd pid=2461 delay=418250 [ns]
       rcu_sched-7     [000]    34.897343: sched_switch:         rcu_sched:7 [120] S ==> trace-cmd:2461 [120]
       trace-cmd-2461  [000]    34.897641: sched_process_exit:   comm=trace-cmd pid=2461 prio=120
       trace-cmd-2461  [000]    34.897665: sched_stat_runtime:   comm=trace-cmd pid=2461 runtime=335875 [ns] vruntime=6087765944 [ns]
       trace-cmd-2461  [000]    34.897675: sched_stat_runtime:   comm=trace-cmd pid=2461 runtime=10459 [ns] vruntime=6087776403 [ns]
       trace-cmd-2461  [000]    34.897697: sched_stat_sleep:     comm=bash pid=2459 delay=696151164 [ns]
       trace-cmd-2461  [000]    34.897703: sched_wakeup:         bash:2459 [120] success=1 CPU:001
       trace-cmd-2461  [000]    34.897708: sched_stat_runtime:   comm=trace-cmd pid=2461 runtime=33500 [ns] vruntime=6087809903 [ns]
       trace-cmd-2461  [000]    34.897738: sched_switch:         trace-cmd:2461 [120] x ==> swapper/0:0 [120]
          <idle>-0     [001]    34.898076: sched_stat_wait:      comm=bash pid=2459 delay=0 [ns]
          <idle>-0     [001]    34.898082: sched_switch:         swapper/1:0 [120] R ==> bash:2459 [120]
            bash-2459  [001]    34.898188: sched_process_wait:   comm=bash pid=0 prio=120
            bash-2459  [001]    34.898653: sched_process_exit:   comm=bash pid=2459 prio=120
            bash-2459  [001]    34.898702: sched_stat_sleep:     comm=sshd pid=2450 delay=1394541 [ns]
            bash-2459  [001]    34.898708: sched_wakeup:         sshd:2450 [120] success=1 CPU:000
          <idle>-0     [000]    34.898720: sched_stat_wait:      comm=sshd pid=2450 delay=0 [ns]
            bash-2459  [001]    34.898721: sched_stat_runtime:   comm=bash pid=2459 runtime=1027542 [ns] vruntime=6723004163 [ns]
          <idle>-0     [000]    34.898726: sched_switch:         swapper/0:0 [120] R ==> sshd:2450 [120]
            bash-2459  [001]    34.898732: sched_stat_runtime:   comm=bash pid=2459 runtime=11000 [ns] vruntime=6723015163 [ns]
            bash-2459  [001]    34.898745: sched_stat_runtime:   comm=bash pid=2459 runtime=13458 [ns] vruntime=6723028621 [ns]
            bash-2459  [001]    34.898758: sched_switch:         bash:2459 [120] x ==> swapper/1:0 [120]
            sshd-2450  [000]    34.898825: sched_process_wait:   comm=sshd pid=0 prio=120
            sshd-2450  [000]    34.898927: sched_process_wait:   comm=sshd pid=0 prio=120
            sshd-2450  [000]    34.898983: sched_stat_runtime:   comm=sshd pid=2450 runtime=285875 [ns] vruntime=6079108278 [ns]
            sshd-2450  [000]    34.898996: sched_switch:         sshd:2450 [120] S ==> swapper/0:0 [120]
          <idle>-0     [000]    34.899144: sched_stat_sleep:     comm=rcu_sched pid=7 delay=1810584 [ns]
          <idle>-0     [000]    34.899149: sched_wakeup:         rcu_sched:7 [120] success=1 CPU:000
          <idle>-0     [000]    34.899175: sched_stat_wait:      comm=rcu_sched pid=7 delay=0 [ns]
          <idle>-0     [000]    34.899180: sched_switch:         swapper/0:0 [120] R ==> rcu_sched:7 [120]
       rcu_sched-7     [000]    34.899194: sched_stat_sleep:     comm=rcuos/0 pid=9 delay=2004042 [ns]
       rcu_sched-7     [000]    34.899200: sched_wakeup:         rcuos/0:9 [120] success=1 CPU:001
       rcu_sched-7     [000]    34.899205: sched_stat_runtime:   comm=rcu_sched pid=7 runtime=65375 [ns] vruntime=6078875278 [ns]
       rcu_sched-7     [000]    34.899216: sched_switch:         rcu_sched:7 [120] S ==> swapper/0:0 [120]
          <idle>-0     [001]    34.899620: sched_stat_wait:      comm=rcuos/0 pid=9 delay=0 [ns]
          <idle>-0     [001]    34.899628: sched_switch:         swapper/1:0 [120] R ==> rcuos/0:9 [120]
         rcuos/0-9     [001]    34.899770: sched_stat_sleep:     comm=rcu_sched pid=7 delay=538708 [ns]
         rcuos/0-9     [001]    34.899807: sched_wakeup:         rcu_sched:7 [120] success=1 CPU:000
         rcuos/0-9     [001]    34.899848: sched_stat_runtime:   comm=rcuos/0 pid=9 runtime=653458 [ns] vruntime=6731630079 [ns]
         rcuos/0-9     [001]    34.899877: sched_switch:         rcuos/0:9 [120] S ==> swapper/1:0 [120]
          <idle>-0     [000]    34.899988: sched_stat_sleep:     comm=sshd pid=2450 delay=1003959 [ns]
          <idle>-0     [000]    34.899995: sched_wakeup:         sshd:2450 [120] success=1 CPU:001
          <idle>-0     [000]    34.900052: sched_stat_wait:      comm=rcu_sched pid=7 delay=0 [ns]
          <idle>-0     [000]    34.900058: sched_switch:         swapper/0:0 [120] R ==> rcu_sched:7 [120]
       rcu_sched-7     [000]    34.900069: sched_stat_runtime:   comm=rcu_sched pid=7 runtime=325042 [ns] vruntime=6079200320 [ns]
       rcu_sched-7     [000]    34.900086: sched_switch:         rcu_sched:7 [120] S ==> swapper/0:0 [120]
          <idle>-0     [001]    34.900452: sched_stat_wait:      comm=sshd pid=2450 delay=0 [ns]
          <idle>-0     [001]    34.900460: sched_switch:         swapper/1:0 [120] R ==> sshd:2450 [120]
            sshd-2450  [001]    34.900756: sched_stat_sleep:     comm=in:imuxsock pid=1767 delay=1926798326 [ns]
            sshd-2450  [001]    34.900767: sched_wakeup:         in:imuxsock:1767 [120] success=1 CPU:000
          <idle>-0     [000]    34.901148: sched_stat_wait:      comm=in:imuxsock pid=1767 delay=0 [ns]
          <idle>-0     [000]    34.901155: sched_switch:         swapper/0:0 [120] R ==> in:imuxsock:1767 [120]
     in:imuxsock-1767  [000]    34.901243: sched_stat_runtime:   comm=in:imuxsock pid=1767 runtime=496084 [ns] vruntime=6079305987 [ns]
     in:imuxsock-1767  [000]    34.901250: sched_stat_sleep:     comm=rs:main Q:Reg pid=1769 delay=1925639660 [ns]
     in:imuxsock-1767  [000]    34.901256: sched_wakeup:         rs:main Q:Reg:1769 [120] success=1 CPU:000
     in:imuxsock-1767  [000]    34.901271: sched_stat_runtime:   comm=in:imuxsock pid=1767 runtime=28500 [ns] vruntime=6079334487 [ns]
     in:imuxsock-1767  [000]    34.901282: sched_stat_wait:      comm=rs:main Q:Reg pid=1769 delay=28500 [ns]
     in:imuxsock-1767  [000]    34.901287: sched_switch:         in:imuxsock:1767 [120] S ==> rs:main Q:Reg:1769 [120]
            sshd-2450  [001]    34.901431: sched_stat_runtime:   comm=rs:main Q:Reg pid=1769 runtime=160500 [ns] vruntime=6078970403 [ns]
            sshd-2450  [001]    34.901437: sched_stat_sleep:     comm=in:imuxsock pid=1767 delay=160500 [ns]
            sshd-2450  [001]    34.901443: sched_wakeup:         in:imuxsock:1767 [120] success=1 CPU:000
         rs:main-1769  [000]    34.901447: sched_stat_runtime:   comm=rs:main Q:Reg pid=1769 runtime=15833 [ns] vruntime=6078986236 [ns]
         rs:main-1769  [000]    34.901457: sched_stat_wait:      comm=in:imuxsock pid=1767 delay=15833 [ns]
         rs:main-1769  [000]    34.901462: sched_switch:         rs:main Q:Reg:1769 [120] S ==> in:imuxsock:1767 [120]
     in:imuxsock-1767  [000]    34.901490: sched_stat_runtime:   comm=in:imuxsock pid=1767 runtime=43125 [ns] vruntime=6079377612 [ns]
     in:imuxsock-1767  [000]    34.901495: sched_stat_sleep:     comm=rs:main Q:Reg pid=1769 delay=43125 [ns]
     in:imuxsock-1767  [000]    34.901501: sched_wakeup:         rs:main Q:Reg:1769 [120] success=1 CPU:000
     in:imuxsock-1767  [000]    34.901511: sched_stat_runtime:   comm=in:imuxsock pid=1767 runtime=21333 [ns] vruntime=6079398945 [ns]