|
[SC-1:Node16 Mon Apr 22 11:44:30/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:45:46/cluster/temp/log] # export TC=bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 11:45:46/cluster/temp/log] # DOMAIN_EVENT="com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec"
|
|
[SC-1:Node16 Mon Apr 22 11:45:46/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:45:46/cluster/temp/log] # sleep 1
|
|
sar -u 1 300 >> $TC.load.log &
|
|
netstat -etanp | head -n 2 ; netstat -etanp |egrep 'lttng'
|
|
sleep 1
|
|
echo "Start to launch apps when no session is active." >> $TC.load.log
|
|
#----------------------------------------------------------------------
|
|
date; time for n in $(seq 1 8000); do (/home/test_apps/TestApp_100perSecOnly 200 np &); done
|
|
#----------------------------------------------------------------------
|
|
echo "End of launching apps when no session is active" >> $TC.load.log
|
|
ps -ef |grep -c TestApp
|
|
sleep 1
|
|
|
|
#---------------------------- Get PID to trace on --------------------------------------------------
|
|
export my_pid=$(ps -e |grep TestApp | tail -n 1 | awk {'print $1'}); echo $my_pid
|
|
sleep 10
|
|
|
|
ps -ef |egrep 'lttng'
|
|
lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC &
|
|
echo "Create the session." >> $TC.load.log
|
|
date; lttng create $TC -U net://192.168.0.1:53000:53001/./
|
|
lttng list
|
|
sleep 5
|
|
echo "Enable channel...." >> $TC.load.log
|
|
date; lttng enable-channel chan1 -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
echo "Enable channel done." >> $TC.load.log
|
|
echo "Enable channel metadata...." >> $TC.load.log
|
|
date; lttng enable-channel metadata -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
echo "Enable channel metadata done." >> $TC.load.log
|
|
sleep 5
|
|
lttng add-context -t vpid -u -s $TC
|
|
echo "Enable Event...." >> $TC.load.log
|
|
date; lttng enable-event -s $TC -u -c chan1 $DOMAIN_EVENT --filter "PID == $my_pid"
|
|
echo "Enable Event done." >> $TC.load.log
|
|
sleep 5
|
|
|
|
echo "Activate the session." >> $TC.load.log
|
|
#---------------------------------------------------- activate session -----------------------
|
|
date; lttng start;
|
|
echo "Activate session Done." >> $TC.load.log
|
|
sleep 1
|
|
lttng list $TC
|
|
sleep 1
|
|
ps -e |grep -c TestApp
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
|
|
for c in $(seq 1 10); do (sleep 1; date; dir -R $TC/SC-1/ust/uid/0/64-bit); done
|
|
|
|
echo "Stopping the session..." >> $TC.load.log
|
|
#---------------------------------------------------- De-activate session -----------------------
|
|
lttng stop
|
|
echo "Stopping done." >> $TC.load.log
|
|
sleep 1
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
sleep 5
|
|
echo "Destroying the session..." >> $TC.load.log
|
|
lttng destroy
|
|
echo "Destroy done! " >> $TC.load.log
|
|
sleep 5
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
pkill relayd
|
|
|
|
babeltrace $TC | head -n 10
|
|
sleep 1
|
|
dir /cluster/dumps
|
|
sleep 5
|
|
echo "Killing TestApp" >> $TC.load.log
|
|
ps -e |grep -c TestApp
|
|
pkill TestApp
|
|
echo "Killing Done ." >> $TC.load.log
|
|
ps -e |grep -c TestApp
|
|
sleep 5
|
|
pkill sar
|
|
|
|
cat $TC.load.log
|
|
sleep 1
|
|
rm $TC.load.log
|
|
babeltrace $TC | grep -c $DOMAIN_EVENT
|
|
babeltrace $TC | wc -l
|
|
|
|
du -h $TC | tail -n 1
|
|
[SC-1:Node16 Mon Apr 22 11:45:47/cluster/temp/log] # sar -u 1 300 >> $TC.load.log &
|
|
[1] 32727
|
|
[SC-1:Node16 Mon Apr 22 11:45:47/cluster/temp/log] # netstat -etanp | head -n 2 ; netstat -etanp |egrep 'lttng'
|
|
Active Internet connections (servers and established)
|
|
Proto Recv-Q Send-Q Local Address Foreign Address State User Inode PID/Program name
|
|
[SC-1:Node16 Mon Apr 22 11:45:47/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 11:45:48/cluster/temp/log] # echo "Start to launch apps when no session is active." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:45:48/cluster/temp/log] # #----------------------------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 11:45:48/cluster/temp/log] # date; time for n in $(seq 1 8000); do (/home/test_apps/TestApp_100perSecOnly 200 np &); done
|
|
Mon Apr 22 11:45:48 EDT 2013
|
|
|
|
real 0m26.229s
|
|
user 0m2.908s
|
|
sys 0m1.608s
|
|
[SC-1:Node16 Mon Apr 22 11:46:15/cluster/temp/log] # #----------------------------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 11:46:15/cluster/temp/log] # echo "End of launching apps when no session is active" >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:15/cluster/temp/log] # ps -ef |grep -c TestApp
|
|
8001
|
|
[SC-1:Node16 Mon Apr 22 11:46:16/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 11:46:17/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:46:17/cluster/temp/log] # #---------------------------- Get PID to trace on --------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 11:46:17/cluster/temp/log] # export my_pid=$(ps -e |grep TestApp | tail -n 1 | awk {'print $1'}); echo $my_pid
|
|
32765
|
|
[SC-1:Node16 Mon Apr 22 11:46:18/cluster/temp/log] # sleep 10
|
|
[SC-1:Node16 Mon Apr 22 11:46:28/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:46:28/cluster/temp/log] # ps -ef |egrep 'lttng'
|
|
root 13763 30507 0 10:10 ? 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd 64/error
|
|
root 30507 1 0 09:03 ? 00:00:57 lttng-sessiond -d
|
|
root 32613 17713 0 11:46 pts/1 00:00:00 egrep lttng
|
|
root 32614 30496 0 11:46 ? 00:00:00 /bin/bash /opt/trace_ea/bin/lttng-proxy start
|
|
root 32615 32614 0 11:46 ? 00:00:00 pgrep lttng-sessiond
|
|
[SC-1:Node16 Mon Apr 22 11:46:29/cluster/temp/log] # lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC &
|
|
[2] 32616
|
|
[SC-1:Node16 Mon Apr 22 11:46:29/cluster/temp/log] # echo "Create the session." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:29/cluster/temp/log] # date; lttng create $TC -U net://192.168.0.1:53000:53001/./
|
|
Mon Apr 22 11:46:29 EDT 2013
|
|
Session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7 created.
|
|
Traces will be written in net://192.168.0.1:53000:53001/./
|
|
[SC-1:Node16 Mon Apr 22 11:46:29/cluster/temp/log] # lttng list
|
|
Available tracing sessions:
|
|
1) bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7 (net://192.168.0.1:53000/./ [data: 5343]) [inactive]
|
|
|
|
Use lttng list <session_name> for more details
|
|
[SC-1:Node16 Mon Apr 22 11:46:29/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 11:46:34/cluster/temp/log] # echo "Enable channel...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:34/cluster/temp/log] # date; lttng enable-channel chan1 -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
Mon Apr 22 11:46:34 EDT 2013
|
|
UST channel chan1 enabled for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 11:46:42/cluster/temp/log] # echo "Enable channel done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:42/cluster/temp/log] # echo "Enable channel metadata...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:42/cluster/temp/log] # date; lttng enable-channel metadata -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
Mon Apr 22 11:46:42 EDT 2013
|
|
UST channel metadata enabled for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 11:46:42/cluster/temp/log] # echo "Enable channel metadata done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:42/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 11:46:47/cluster/temp/log] # lttng add-context -t vpid -u -s $TC
|
|
UST context vpid added to all channels
|
|
[SC-1:Node16 Mon Apr 22 11:46:48/cluster/temp/log] # echo "Enable Event...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:48/cluster/temp/log] # date; lttng enable-event -s $TC -u -c chan1 $DOMAIN_EVENT --filter "PID == $my_pid"
|
|
Mon Apr 22 11:46:48 EDT 2013
|
|
Filter 'PID == 32765' successfully set
|
|
[SC-1:Node16 Mon Apr 22 11:46:48/cluster/temp/log] # echo "Enable Event done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:48/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 11:46:53/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:46:53/cluster/temp/log] # echo "Activate the session." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:53/cluster/temp/log] # #---------------------------------------------------- activate session -----------------------
|
|
[SC-1:Node16 Mon Apr 22 11:46:53/cluster/temp/log] # date; lttng start;
|
|
Mon Apr 22 11:46:53 EDT 2013
|
|
Tracing started for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 11:46:58/cluster/temp/log] # echo "Activate session Done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:46:58/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 11:46:59/cluster/temp/log] # lttng list $TC
|
|
Tracing session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7: [active]
|
|
Trace path: net://192.168.0.1:53000/./ [data: 53001]
|
|
|
|
=== Domain: UST global ===
|
|
|
|
Buffer type: per UID
|
|
|
|
Channels:
|
|
-------------
|
|
- metadata: [enabled]
|
|
|
|
Attributes:
|
|
write mode: discard
|
|
subbufers size: 16384 bytes
|
|
number of subbufers: 4
|
|
switch timer interval: 0 usec
|
|
read timer interval: 0 usec
|
|
output: mmap()
|
|
|
|
Events:
|
|
None
|
|
|
|
- chan1: [enabled]
|
|
|
|
Attributes:
|
|
write mode: discard
|
|
subbufers size: 16384 bytes
|
|
number of subbufers: 4
|
|
switch timer interval: 0 usec
|
|
read timer interval: 0 usec
|
|
output: mmap()
|
|
|
|
Events:
|
|
com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec (type: tracepoint) [enabled] [with filter]
|
|
|
|
[SC-1:Node16 Mon Apr 22 11:46:59/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 11:47:00/cluster/temp/log] # ps -e |grep -c TestApp
|
|
8000
|
|
[SC-1:Node16 Mon Apr 22 11:47:02/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 16
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 11:47 chan1_2
|
|
[SC-1:Node16 Mon Apr 22 11:47:02/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:02/cluster/temp/log] # for c in $(seq 1 10); do (sleep 1; date; dir -R $TC/SC-1/ust/uid/0/64-bit); done
|
|
Mon Apr 22 11:47:04 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:05 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:06 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:07 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:08 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:09 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:11 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:12 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 32
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
Mon Apr 22 11:47:13 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 48
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
-rw-rw---- 1 root root 16384 Apr 22 11:47 chan1_9
|
|
Mon Apr 22 11:47:14 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 48
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_4
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_10
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 11:46 metadata
|
|
-rw-rw---- 1 root root 32768 Apr 22 11:47 chan1_2
|
|
-rw-rw---- 1 root root 16384 Apr 22 11:47 chan1_9
|
|
[SC-1:Node16 Mon Apr 22 11:47:14/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:14/cluster/temp/log] # echo "Stopping the session..." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:14/cluster/temp/log] # #---------------------------------------------------- De-activate session -----------------------
|
|
[SC-1:Node16 Mon Apr 22 11:47:14/cluster/temp/log] # lttng stop
|
|
Waiting for data availability
|
|
Tracing stopped for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 11:47:18/cluster/temp/log] # echo "Stopping done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:18/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 11:47:19/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 1180
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 metadata
|
|
-rw-rw---- 1 root root 20480 Apr 22 11:47 chan1_9
|
|
-rw-rw---- 1 root root 1081344 Apr 22 11:47 chan1_8
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_7
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_6
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_5
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_4
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_3
|
|
-rw-rw---- 1 root root 53248 Apr 22 11:47 chan1_2
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_10
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_1
|
|
-rw-rw---- 1 root root 4096 Apr 22 11:47 chan1_0
|
|
[SC-1:Node16 Mon Apr 22 11:47:19/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 11:47:24/cluster/temp/log] # echo "Destroying the session..." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:24/cluster/temp/log] # lttng destroy
|
|
Session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7 destroyed
|
|
[SC-1:Node16 Mon Apr 22 11:47:27/cluster/temp/log] # echo "Destroy done! " >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:27/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 11:47:32/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit:
|
|
total 1232
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 metadata
|
|
-rw-rw---- 1 root root 24576 Apr 22 11:47 chan1_9
|
|
-rw-rw---- 1 root root 1085440 Apr 22 11:47 chan1_8
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_6
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_5
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_4
|
|
-rw-rw---- 1 root root 12288 Apr 22 11:47 chan1_3
|
|
-rw-rw---- 1 root root 57344 Apr 22 11:47 chan1_2
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_11
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_10
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_1
|
|
-rw-rw---- 1 root root 8192 Apr 22 11:47 chan1_0
|
|
[SC-1:Node16 Mon Apr 22 11:47:32/cluster/temp/log] # pkill relayd
|
|
[SC-1:Node16 Mon Apr 22 11:47:32/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:32/cluster/temp/log] # babeltrace $TC | head -n 10
|
|
[11:46:55.296906582] (+?.?????????) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 2, HundredPs = 5, unit_float = 5.1234, unit_string = "unit_5" }
|
|
[11:46:55.306882784] (+0.009976202) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 2, HundredPs = 6, unit_float = 6.1234, unit_string = "unit_6" }
|
|
[11:46:55.316890430] (+0.010007646) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 2, HundredPs = 7, unit_float = 7.1234, unit_string = "unit_7" }
|
|
[11:46:55.326884084] (+0.009993654) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 2, HundredPs = 8, unit_float = 8.1234, unit_string = "unit_8" }
|
|
[11:46:55.336882404] (+0.009998320) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 2, HundredPs = 9, unit_float = 9.1234, unit_string = "unit_9" }
|
|
[11:46:55.346886383] (+0.010003979) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 3, HundredPs = 0, unit_float = 0.1234, unit_string = "unit_0" }
|
|
[11:46:55.356891114] (+0.010004731) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 3, HundredPs = 1, unit_float = 1.1234, unit_string = "unit_1" }
|
|
[11:46:55.366884291] (+0.009993177) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 3, HundredPs = 2, unit_float = 2.1234, unit_string = "unit_2" }
|
|
[11:46:55.376889601] (+0.010005310) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 3, HundredPs = 3, unit_float = 3.1234, unit_string = "unit_3" }
|
|
[11:46:55.386893328] (+0.010003727) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 2 }, { vpid = 32765 }, { my_Time = "11:46:55", PID = 32765, OnePs = 66, TenPs = 3, HundredPs = 4, unit_float = 4.1234, unit_string = "unit_4" }
|
|
[2]+ Done lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC
|
|
[SC-1:Node16 Mon Apr 22 11:47:32/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 11:47:33/cluster/temp/log] # dir /cluster/dumps
|
|
total 4
|
|
drwxr-xr-x 2 root root 4096 Apr 22 10:28 old
|
|
[SC-1:Node16 Mon Apr 22 11:47:33/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 11:47:38/cluster/temp/log] # echo "Killing TestApp" >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:39/cluster/temp/log] # ps -e |grep -c TestApp
|
|
8000
|
|
[SC-1:Node16 Mon Apr 22 11:47:39/cluster/temp/log] # pkill TestApp
|
|
[SC-1:Node16 Mon Apr 22 11:47:44/cluster/temp/log] # echo "Killing Done ." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:44/cluster/temp/log] # ps -e |grep -c TestApp
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 11:47:44/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 11:47:49/cluster/temp/log] # pkill sar
|
|
[SC-1:Node16 Mon Apr 22 11:47:49/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:49/cluster/temp/log] # cat $TC.load.log
|
|
Linux 3.0.42-0.7.3.4775.1.PTF-default (SC-1) 04/22/13 _x86_64_
|
|
|
|
11:45:47 CPU %user %nice %system %iowait %steal %idle
|
|
11:45:48 all 0.00 0.00 0.58 0.00 0.00 99.42
|
|
Start to launch apps when no session is active.
|
|
11:45:49 all 8.28 0.00 10.15 0.26 0.00 81.31
|
|
11:45:50 all 10.88 0.00 11.83 0.00 0.00 77.29
|
|
11:45:51 all 11.80 0.00 13.64 0.00 0.00 74.56
|
|
11:45:52 all 13.80 0.00 12.99 0.00 0.00 73.21
|
|
11:45:53 all 13.86 0.00 15.74 0.00 0.00 70.39
|
|
11:45:54 all 17.49 0.00 16.88 0.00 0.00 65.63
|
|
11:45:55 all 16.97 0.00 21.24 0.00 0.00 61.79
|
|
11:45:56 all 16.68 0.00 21.54 0.00 0.00 61.78
|
|
11:45:57 all 18.45 0.00 22.33 0.00 0.00 59.22
|
|
11:45:58 all 19.64 0.00 25.50 0.00 0.00 54.87
|
|
11:45:59 all 21.10 0.00 26.92 0.00 0.00 51.98
|
|
11:46:00 all 23.40 0.00 26.86 0.00 0.00 49.75
|
|
11:46:01 all 25.08 0.00 28.04 0.00 0.00 46.88
|
|
11:46:02 all 24.70 0.00 27.21 0.00 0.00 48.09
|
|
11:46:03 all 25.22 0.00 28.84 0.00 0.00 45.94
|
|
11:46:04 all 27.84 0.00 31.38 0.00 0.00 40.77
|
|
11:46:05 all 27.99 0.00 29.86 0.00 0.00 42.15
|
|
11:46:06 all 27.10 0.00 31.21 0.00 0.00 41.70
|
|
11:46:07 all 28.94 0.00 33.76 0.00 0.00 37.30
|
|
11:46:08 all 30.53 0.00 31.54 0.00 0.00 37.93
|
|
11:46:09 all 30.25 0.00 32.24 0.00 0.00 37.51
|
|
11:46:10 all 30.88 0.00 33.63 0.00 0.00 35.49
|
|
11:46:11 all 29.46 0.00 32.94 0.00 0.00 37.60
|
|
11:46:12 all 30.46 0.00 34.01 0.00 0.00 35.52
|
|
11:46:13 all 32.09 0.00 36.09 0.00 0.00 31.82
|
|
11:46:14 all 33.66 0.00 34.36 0.00 0.00 31.99
|
|
End of launching apps when no session is active
|
|
11:46:15 all 31.33 0.00 33.89 0.18 0.00 34.60
|
|
11:46:16 all 31.13 0.00 32.26 0.00 0.00 36.61
|
|
11:46:17 all 29.74 0.00 33.51 0.00 0.00 36.75
|
|
11:46:18 all 28.56 0.00 31.06 0.17 0.00 40.21
|
|
11:46:19 all 28.07 0.00 33.03 0.00 0.00 38.91
|
|
11:46:20 all 29.08 0.00 32.71 0.00 0.00 38.21
|
|
11:46:21 all 28.07 0.00 31.68 0.00 0.00 40.25
|
|
11:46:22 all 29.49 0.00 29.32 0.00 0.00 41.19
|
|
11:46:23 all 28.44 0.00 30.72 0.00 0.00 40.84
|
|
11:46:24 all 30.11 0.00 27.90 0.00 0.00 41.99
|
|
11:46:25 all 29.35 0.00 29.78 0.00 0.00 40.87
|
|
11:46:26 all 30.59 0.00 31.95 0.00 0.00 37.47
|
|
11:46:27 all 30.52 0.00 29.52 0.00 0.00 39.97
|
|
11:46:28 all 30.12 0.00 35.94 0.00 0.00 33.94
|
|
Create the session.
|
|
11:46:29 all 33.44 0.00 32.23 0.08 0.00 34.25
|
|
11:46:30 all 30.13 0.00 30.86 0.00 0.00 39.01
|
|
11:46:31 all 32.37 0.00 30.25 0.00 0.00 37.38
|
|
11:46:32 all 33.60 0.00 31.37 0.00 0.00 35.03
|
|
11:46:33 all 31.61 0.00 30.42 0.00 0.00 37.97
|
|
Enable channel....
|
|
11:46:34 all 31.89 0.00 32.39 0.42 0.00 35.31
|
|
11:46:35 all 31.48 0.00 36.78 0.00 0.00 31.74
|
|
11:46:36 all 31.20 0.00 34.77 0.00 0.00 34.02
|
|
11:46:37 all 33.22 0.00 33.63 0.00 0.00 33.14
|
|
11:46:38 all 32.51 0.00 37.11 0.00 0.00 30.38
|
|
11:46:39 all 30.46 0.00 34.98 0.00 0.00 34.56
|
|
11:46:40 all 28.92 0.00 34.92 0.00 0.00 36.16
|
|
11:46:41 all 32.79 0.00 35.45 0.00 0.00 31.76
|
|
Enable channel done.
|
|
Enable channel metadata....
|
|
Enable channel metadata done.
|
|
11:46:42 all 30.30 0.00 33.42 0.17 0.00 36.12
|
|
11:46:43 all 28.29 0.00 30.84 0.00 0.00 40.87
|
|
11:46:44 all 28.31 0.00 34.81 0.00 0.00 36.87
|
|
11:46:45 all 30.32 0.00 29.73 0.00 0.00 39.95
|
|
11:46:46 all 29.73 0.00 30.71 0.00 0.00 39.56
|
|
11:46:47 all 28.89 0.00 34.17 0.00 0.00 36.93
|
|
Enable Event....
|
|
11:46:48 all 31.17 0.00 35.80 0.18 0.00 32.86
|
|
Enable Event done.
|
|
11:46:49 all 31.81 0.00 29.12 0.24 0.00 38.83
|
|
11:46:50 all 29.07 0.00 30.20 0.00 0.00 40.73
|
|
11:46:51 all 31.23 0.00 29.45 0.00 0.00 39.32
|
|
11:46:52 all 30.79 0.00 29.14 0.00 0.00 40.07
|
|
11:46:53 all 29.62 0.00 29.01 0.00 0.00 41.38
|
|
Activate the session.
|
|
11:46:54 all 37.03 0.00 34.39 0.17 0.00 28.41
|
|
11:46:55 all 45.31 0.00 34.54 0.00 0.00 20.15
|
|
11:46:56 all 50.94 0.00 35.04 0.00 0.00 14.02
|
|
11:46:57 all 55.72 0.00 37.79 0.00 0.00 6.49
|
|
Activate session Done.
|
|
11:46:58 all 59.58 0.00 34.33 0.00 0.00 6.09
|
|
11:46:59 all 59.82 0.00 31.96 0.00 0.00 8.22
|
|
11:47:00 all 63.64 0.00 31.86 0.00 0.00 4.50
|
|
11:47:01 all 61.53 0.00 34.18 0.00 0.00 4.28
|
|
11:47:02 all 61.74 0.00 34.32 0.08 0.00 3.86
|
|
11:47:03 all 61.51 0.00 33.22 0.00 0.00 5.27
|
|
11:47:04 all 60.67 0.00 32.58 0.00 0.00 6.75
|
|
11:47:05 all 59.65 0.00 32.11 0.00 0.00 8.24
|
|
11:47:06 all 60.32 0.00 33.77 0.00 0.00 5.91
|
|
11:47:07 all 60.47 0.00 33.55 0.00 0.00 5.97
|
|
11:47:08 all 60.69 0.00 31.10 0.00 0.00 8.21
|
|
11:47:09 all 61.21 0.00 33.25 0.00 0.00 5.54
|
|
11:47:10 all 61.70 0.00 31.73 0.00 0.00 6.57
|
|
11:47:11 all 60.08 0.00 31.89 0.00 0.00 8.03
|
|
11:47:12 all 60.36 0.00 33.02 0.00 0.00 6.62
|
|
11:47:13 all 60.89 0.00 33.92 0.00 0.00 5.19
|
|
Stopping the session...
|
|
11:47:14 all 58.88 0.00 33.25 0.08 0.00 7.79
|
|
11:47:15 all 58.24 0.00 33.31 0.00 0.00 8.45
|
|
11:47:16 all 55.17 0.00 35.12 0.00 0.00 9.70
|
|
11:47:17 all 45.95 0.00 34.20 0.00 0.00 19.85
|
|
Stopping done.
|
|
11:47:18 all 35.16 0.00 35.16 0.17 0.00 29.51
|
|
11:47:19 all 29.19 0.00 32.73 0.90 0.00 37.17
|
|
11:47:20 all 31.51 0.00 29.05 0.00 0.00 39.44
|
|
11:47:21 all 28.28 0.00 33.17 0.00 0.00 38.56
|
|
11:47:22 all 29.23 0.00 31.44 0.00 0.00 39.34
|
|
11:47:23 all 29.00 0.00 29.52 0.00 0.00 41.48
|
|
11:47:24 all 28.32 0.00 31.29 0.00 0.00 40.39
|
|
Destroying the session...
|
|
11:47:25 all 33.92 0.00 34.87 0.16 0.00 31.05
|
|
11:47:26 all 31.81 0.00 32.66 0.00 0.00 35.53
|
|
Destroy done!
|
|
11:47:27 all 31.91 0.00 29.20 1.31 0.00 37.59
|
|
11:47:28 all 31.81 0.00 31.31 0.00 0.00 36.89
|
|
11:47:29 all 30.00 0.00 29.15 0.00 0.00 40.85
|
|
11:47:30 all 31.27 0.00 29.48 0.00 0.00 39.25
|
|
11:47:31 all 32.58 0.00 30.67 0.00 0.00 36.75
|
|
11:47:32 all 30.64 0.00 30.64 0.00 0.00 38.73
|
|
11:47:33 all 31.76 0.00 29.81 0.00 0.00 38.42
|
|
11:47:34 all 30.86 0.00 32.03 0.00 0.00 37.11
|
|
11:47:35 all 28.65 0.00 31.54 0.00 0.00 39.80
|
|
11:47:36 all 30.25 0.00 30.00 0.00 0.00 39.75
|
|
11:47:37 all 29.05 0.00 32.84 0.00 0.00 38.10
|
|
11:47:38 all 29.47 0.00 29.21 0.00 0.00 41.32
|
|
Killing TestApp
|
|
11:47:39 all 33.84 0.00 33.44 0.16 0.00 32.56
|
|
11:47:40 all 29.33 0.00 50.24 0.00 0.00 20.43
|
|
11:47:41 all 24.14 0.00 59.55 0.00 0.00 16.32
|
|
11:47:42 all 20.97 0.00 54.70 0.00 0.00 24.33
|
|
11:47:43 all 15.25 0.00 55.65 0.00 0.00 29.10
|
|
Killing Done .
|
|
11:47:44 all 5.76 0.00 39.29 0.43 0.00 54.51
|
|
11:47:45 all 0.08 0.00 0.08 0.00 0.00 99.83
|
|
11:47:46 all 0.00 0.00 0.17 0.00 0.00 99.83
|
|
11:47:47 all 0.00 0.00 0.17 0.00 0.00 99.83
|
|
11:47:48 all 0.00 0.00 0.17 0.00 0.00 99.83
|
|
[1]+ Terminated sar -u 1 300 >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:49/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 11:47:50/cluster/temp/log] # rm $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 11:47:50/cluster/temp/log] # babeltrace $TC | grep -c $DOMAIN_EVENT
|
|
2202
|
|
[SC-1:Node16 Mon Apr 22 11:47:50/cluster/temp/log] # babeltrace $TC | wc -l
|
|
2202
|
|
[SC-1:Node16 Mon Apr 22 11:47:50/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:50/cluster/temp/log] # du -h $TC | tail -n 1
|
|
1.3M bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 11:47:50/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:56/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:56/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:56/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:56/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:56/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:57/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:57/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:57/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:57/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:57/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:57/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:47:58/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 2"
|
|
929
|
|
[SC-1:Node16 Mon Apr 22 11:50:20/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 9"
|
|
442
|
|
[SC-1:Node16 Mon Apr 22 11:50:25/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 11:52:08/cluster/temp/log] # babeltrace $TC | wc -l
|
|
2202
|
|
[SC-1:Node16 Mon Apr 22 11:52:14/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 8"
|
|
650
|
|
[SC-1:Node16 Mon Apr 22 11:52:23/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 3"
|
|
129
|
|
[SC-1:Node16 Mon Apr 22 11:52:37/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 1"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 11:52:49/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 4"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 11:52:54/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 5"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 11:52:56/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 6"
|
|
5
|
|
[SC-1:Node16 Mon Apr 22 11:52:58/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 7"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 11:53:07/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 10"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 11:53:17/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 11"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 11:53:20/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 0"
|
|
47
|
|
[SC-1:Node16 Mon Apr 22 11:55:48/cluster/temp/log] # dir
|
|
total 2008
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:28 LTTNGgbf_007_a_timer1000ms
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:32 LTTNGgbf_007_a_timerDefault
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:36 LTTNGgbf_008
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:51 LTTNGgbf_009
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:42 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:48 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:50 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 5 12:08 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run4
|
|
-rw-r--r-- 1 root root 1060667 Apr 9 08:21 TC17_apr5.tar
|
|
-rw-r--r-- 1 root root 112575 Apr 12 06:45 TC17_apr9.tar
|
|
-rw-r--r-- 1 root root 21745 Apr 12 08:36 run4.tar
|
|
-rw-r--r-- 1 root root 25123 Apr 12 08:36 run5.tar
|
|
-rw-r--r-- 1 root root 269623 Apr 12 09:05 TC17_apr12_a.tar
|
|
drwxr-x--- 3 root root 4096 Apr 16 08:55 LTTNGgbf_006
|
|
drwxr-x--- 3 root root 4096 Apr 17 09:44 LTTNGgbf_007_a_timer100ms
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:51 LTTNGgbf_010
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_b
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_c
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:23 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:25 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:28 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:31 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run4
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:34 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run5
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:41 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run6
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 11:58:07/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:43/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:43/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:43/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:43/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:43/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:44/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:44/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:54/cluster/temp/log] # export TC=bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
[SC-1:Node16 Mon Apr 22 12:00:54/cluster/temp/log] # DOMAIN_EVENT="com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec"
|
|
[SC-1:Node16 Mon Apr 22 12:00:54/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:00:54/cluster/temp/log] # sleep 1
|
|
sar -u 1 300 >> $TC.load.log &
|
|
netstat -etanp | head -n 2 ; netstat -etanp |egrep 'lttng'
|
|
sleep 1
|
|
echo "Start to launch apps when no session is active." >> $TC.load.log
|
|
#----------------------------------------------------------------------
|
|
date; time for n in $(seq 1 8000); do (/home/test_apps/TestApp_100perSecOnly 200 np &); done
|
|
#----------------------------------------------------------------------
|
|
echo "End of launching apps when no session is active" >> $TC.load.log
|
|
ps -ef |grep -c TestApp
|
|
sleep 1
|
|
|
|
#---------------------------- Get PID to trace on --------------------------------------------------
|
|
export my_pid=$(ps -e |grep TestApp | tail -n 1 | awk {'print $1'}); echo $my_pid
|
|
sleep 10
|
|
|
|
ps -ef |egrep 'lttng'
|
|
lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC &
|
|
echo "Create the session." >> $TC.load.log
|
|
date; lttng create $TC -U net://192.168.0.1:53000:53001/./
|
|
lttng list
|
|
sleep 5
|
|
echo "Enable channel...." >> $TC.load.log
|
|
date; lttng enable-channel chan1 -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
echo "Enable channel done." >> $TC.load.log
|
|
echo "Enable channel metadata...." >> $TC.load.log
|
|
date; lttng enable-channel metadata -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
echo "Enable channel metadata done." >> $TC.load.log
|
|
sleep 5
|
|
lttng add-context -t vpid -u -s $TC
|
|
echo "Enable Event...." >> $TC.load.log
|
|
date; lttng enable-event -s $TC -u -c chan1 $DOMAIN_EVENT --filter "PID == $my_pid"
|
|
echo "Enable Event done." >> $TC.load.log
|
|
sleep 5
|
|
|
|
echo "Activate the session." >> $TC.load.log
|
|
#---------------------------------------------------- activate session -----------------------
|
|
date; lttng start;
|
|
echo "Activate session Done." >> $TC.load.log
|
|
sleep 1
|
|
lttng list $TC
|
|
sleep 1
|
|
ps -e |grep -c TestApp
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
|
|
for c in $(seq 1 10); do (sleep 1; date; dir -R $TC/SC-1/ust/uid/0/64-bit); done
|
|
|
|
echo "Stopping the session..." >> $TC.load.log
|
|
#---------------------------------------------------- De-activate session -----------------------
|
|
lttng stop
|
|
echo "Stopping done." >> $TC.load.log
|
|
sleep 1
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
sleep 5
|
|
echo "Destroying the session..." >> $TC.load.log
|
|
lttng destroy
|
|
echo "Destroy done! " >> $TC.load.log
|
|
sleep 5
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
pkill relayd
|
|
|
|
babeltrace $TC | head -n 10
|
|
sleep 1
|
|
dir /cluster/dumps
|
|
sleep 5
|
|
echo "Killing TestApp" >> $TC.load.log
|
|
ps -e |grep -c TestApp
|
|
pkill TestApp
|
|
echo "Killing Done ." >> $TC.load.log
|
|
ps -e |grep -c TestApp
|
|
sleep 5
|
|
pkill sar
|
|
|
|
cat $TC.load.log
|
|
sleep 1
|
|
rm $TC.load.log
|
|
babeltrace $TC | grep -c $DOMAIN_EVENT
|
|
babeltrace $TC | wc -l
|
|
|
|
du -h $TC | tail -n 1
|
|
[SC-1:Node16 Mon Apr 22 12:00:55/cluster/temp/log] # sar -u 1 300 >> $TC.load.log &
|
|
[1] 981
|
|
[SC-1:Node16 Mon Apr 22 12:00:55/cluster/temp/log] # netstat -etanp | head -n 2 ; netstat -etanp |egrep 'lttng'
|
|
Active Internet connections (servers and established)
|
|
Proto Recv-Q Send-Q Local Address Foreign Address State User Inode PID/Program name
|
|
[SC-1:Node16 Mon Apr 22 12:00:55/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:00:56/cluster/temp/log] # echo "Start to launch apps when no session is active." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:00:56/cluster/temp/log] # #----------------------------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 12:00:56/cluster/temp/log] # date; time for n in $(seq 1 8000); do (/home/test_apps/TestApp_100perSecOnly 200 np &); done
|
|
Mon Apr 22 12:00:56 EDT 2013
|
|
|
|
real 0m26.755s
|
|
user 0m2.756s
|
|
sys 0m1.612s
|
|
[SC-1:Node16 Mon Apr 22 12:01:23/cluster/temp/log] # #----------------------------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 12:01:23/cluster/temp/log] # echo "End of launching apps when no session is active" >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:23/cluster/temp/log] # ps -ef |grep -c TestApp
|
|
8001
|
|
[SC-1:Node16 Mon Apr 22 12:01:24/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:01:25/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:01:25/cluster/temp/log] # #---------------------------- Get PID to trace on --------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 12:01:25/cluster/temp/log] # export my_pid=$(ps -e |grep TestApp | tail -n 1 | awk {'print $1'}); echo $my_pid
|
|
32767
|
|
[SC-1:Node16 Mon Apr 22 12:01:26/cluster/temp/log] # sleep 10
|
|
[SC-1:Node16 Mon Apr 22 12:01:36/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:01:36/cluster/temp/log] # ps -ef |egrep 'lttng'
|
|
root 871 17713 0 12:01 pts/1 00:00:00 egrep lttng
|
|
root 13763 30507 0 10:10 ? 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
|
|
root 30507 1 0 09:03 ? 00:01:04 lttng-sessiond -d
|
|
[SC-1:Node16 Mon Apr 22 12:01:37/cluster/temp/log] # lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC &
|
|
[2] 874
|
|
[SC-1:Node16 Mon Apr 22 12:01:37/cluster/temp/log] # echo "Create the session." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:37/cluster/temp/log] # date; lttng create $TC -U net://192.168.0.1:53000:53001/./
|
|
Mon Apr 22 12:01:37 EDT 2013
|
|
Session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8 created.
|
|
Traces will be written in net://192.168.0.1:53000:53001/./
|
|
[SC-1:Node16 Mon Apr 22 12:01:37/cluster/temp/log] # lttng list
|
|
Available tracing sessions:
|
|
1) bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8 (net://192.168.0.1:53000/./ [data: 5343]) [inactive]
|
|
|
|
Use lttng list <session_name> for more details
|
|
[SC-1:Node16 Mon Apr 22 12:01:37/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:01:42/cluster/temp/log] # echo "Enable channel...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:42/cluster/temp/log] # date; lttng enable-channel chan1 -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
Mon Apr 22 12:01:42 EDT 2013
|
|
UST channel chan1 enabled for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
[SC-1:Node16 Mon Apr 22 12:01:50/cluster/temp/log] # echo "Enable channel done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:50/cluster/temp/log] # echo "Enable channel metadata...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:50/cluster/temp/log] # date; lttng enable-channel metadata -u -s $TC --buffers-uid --subbuf-size 16384 #--switch-timer 1000000
|
|
Mon Apr 22 12:01:50 EDT 2013
|
|
UST channel metadata enabled for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
[SC-1:Node16 Mon Apr 22 12:01:50/cluster/temp/log] # echo "Enable channel metadata done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:50/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:01:55/cluster/temp/log] # lttng add-context -t vpid -u -s $TC
|
|
UST context vpid added to all channels
|
|
[SC-1:Node16 Mon Apr 22 12:01:56/cluster/temp/log] # echo "Enable Event...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:56/cluster/temp/log] # date; lttng enable-event -s $TC -u -c chan1 $DOMAIN_EVENT --filter "PID == $my_pid"
|
|
Mon Apr 22 12:01:56 EDT 2013
|
|
Filter 'PID == 32767' successfully set
|
|
[SC-1:Node16 Mon Apr 22 12:01:57/cluster/temp/log] # echo "Enable Event done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:01:57/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:02:02/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:02:02/cluster/temp/log] # echo "Activate the session." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:02/cluster/temp/log] # #---------------------------------------------------- activate session -----------------------
|
|
[SC-1:Node16 Mon Apr 22 12:02:02/cluster/temp/log] # date; lttng start;
|
|
Mon Apr 22 12:02:02 EDT 2013
|
|
Tracing started for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
[SC-1:Node16 Mon Apr 22 12:02:10/cluster/temp/log] # echo "Activate session Done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:10/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:02:11/cluster/temp/log] # lttng list $TC
|
|
Tracing session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8: [active]
|
|
Trace path: net://192.168.0.1:53000/./ [data: 53001]
|
|
|
|
=== Domain: UST global ===
|
|
|
|
Buffer type: per UID
|
|
|
|
Channels:
|
|
-------------
|
|
- metadata: [enabled]
|
|
|
|
Attributes:
|
|
write mode: discard
|
|
subbufers size: 16384 bytes
|
|
number of subbufers: 4
|
|
switch timer interval: 0 usec
|
|
read timer interval: 0 usec
|
|
output: mmap()
|
|
|
|
Events:
|
|
None
|
|
|
|
- chan1: [enabled]
|
|
|
|
Attributes:
|
|
write mode: discard
|
|
subbufers size: 16384 bytes
|
|
number of subbufers: 4
|
|
switch timer interval: 0 usec
|
|
read timer interval: 0 usec
|
|
output: mmap()
|
|
|
|
Events:
|
|
com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec (type: tracepoint) [enabled] [with filter]
|
|
|
|
[SC-1:Node16 Mon Apr 22 12:02:11/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:02:12/cluster/temp/log] # ps -e |grep -c TestApp
|
|
8000
|
|
[SC-1:Node16 Mon Apr 22 12:02:14/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 48
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 32768 Apr 22 12:02 chan1_10
|
|
[SC-1:Node16 Mon Apr 22 12:02:15/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:02:15/cluster/temp/log] # for c in $(seq 1 10); do (sleep 1; date; dir -R $TC/SC-1/ust/uid/0/64-bit); done
|
|
Mon Apr 22 12:02:16 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 48
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 32768 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:17 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 48
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 32768 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:18 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 48
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 32768 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:19 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 64
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:20 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 64
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:21 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 64
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:22 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 64
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:24 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 64
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:25 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 64
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:02 chan1_10
|
|
Mon Apr 22 12:02:26 EDT 2013
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 64
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_9
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_8
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_7
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_6
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_5
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_3
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_2
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_11
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_1
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 chan1_0
|
|
-rw-rw---- 1 root root 0 Apr 22 12:01 metadata
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:02 chan1_10
|
|
[SC-1:Node16 Mon Apr 22 12:02:26/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:02:26/cluster/temp/log] # echo "Stopping the session..." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:26/cluster/temp/log] # #---------------------------------------------------- De-activate session -----------------------
|
|
[SC-1:Node16 Mon Apr 22 12:02:26/cluster/temp/log] # lttng stop
|
|
Waiting for data availability
|
|
Tracing stopped for session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
[SC-1:Node16 Mon Apr 22 12:02:31/cluster/temp/log] # echo "Stopping done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:31/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:02:32/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 760
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 metadata
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_9
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_8
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_7
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_6
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_5
|
|
-rw-rw---- 1 root root 643072 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_3
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_2
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:02 chan1_11
|
|
-rw-rw---- 1 root root 57344 Apr 22 12:02 chan1_10
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_1
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:02 chan1_0
|
|
[SC-1:Node16 Mon Apr 22 12:02:32/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:02:37/cluster/temp/log] # echo "Destroying the session..." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:37/cluster/temp/log] # lttng destroy
|
|
Session bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8 destroyed
|
|
[SC-1:Node16 Mon Apr 22 12:02:39/cluster/temp/log] # echo "Destroy done! " >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:39/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:02:44/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit:
|
|
total 812
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 metadata
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_9
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_8
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_6
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:02 chan1_5
|
|
-rw-rw---- 1 root root 647168 Apr 22 12:02 chan1_4
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_3
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_2
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:02 chan1_11
|
|
-rw-rw---- 1 root root 61440 Apr 22 12:02 chan1_10
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_1
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:02 chan1_0
|
|
[SC-1:Node16 Mon Apr 22 12:02:44/cluster/temp/log] # pkill relayd
|
|
[SC-1:Node16 Mon Apr 22 12:02:45/cluster/temp/log] #
|
|
[2]+ Done lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC
|
|
[SC-1:Node16 Mon Apr 22 12:02:45/cluster/temp/log] # babeltrace $TC | head -n 10
|
|
[12:02:03.205216304] (+?.?????????) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 5 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 1, HundredPs = 6, unit_float = 6.1234, unit_string = "unit_6" }
|
|
[12:02:03.215170206] (+0.009953902) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 1, HundredPs = 7, unit_float = 7.1234, unit_string = "unit_7" }
|
|
[12:02:03.225152997] (+0.009982791) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 1, HundredPs = 8, unit_float = 8.1234, unit_string = "unit_8" }
|
|
[12:02:03.235142905] (+0.009989908) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 1, HundredPs = 9, unit_float = 9.1234, unit_string = "unit_9" }
|
|
[12:02:03.245157436] (+0.010014531) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 2, HundredPs = 0, unit_float = 0.1234, unit_string = "unit_0" }
|
|
[12:02:03.255143057] (+0.009985621) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 2, HundredPs = 1, unit_float = 1.1234, unit_string = "unit_1" }
|
|
[12:02:03.265136532] (+0.009993475) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 2, HundredPs = 2, unit_float = 2.1234, unit_string = "unit_2" }
|
|
[12:02:03.275155336] (+0.010018804) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 2, HundredPs = 3, unit_float = 3.1234, unit_string = "unit_3" }
|
|
[12:02:03.285131152] (+0.009975816) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 2, HundredPs = 4, unit_float = 4.1234, unit_string = "unit_4" }
|
|
[12:02:03.295126217] (+0.009995065) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:02:03", PID = 32767, OnePs = 41, TenPs = 2, HundredPs = 5, unit_float = 5.1234, unit_string = "unit_5" }
|
|
[SC-1:Node16 Mon Apr 22 12:02:45/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:02:46/cluster/temp/log] # dir /cluster/dumps
|
|
total 4
|
|
drwxr-xr-x 2 root root 4096 Apr 22 10:28 old
|
|
[SC-1:Node16 Mon Apr 22 12:02:46/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:02:51/cluster/temp/log] # echo "Killing TestApp" >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:51/cluster/temp/log] # ps -e |grep -c TestApp
|
|
8000
|
|
[SC-1:Node16 Mon Apr 22 12:02:51/cluster/temp/log] # pkill TestApp
|
|
[SC-1:Node16 Mon Apr 22 12:02:55/cluster/temp/log] # echo "Killing Done ." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:02:55/cluster/temp/log] # ps -e |grep -c TestApp
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:02:55/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:03:00/cluster/temp/log] # pkill sar
|
|
[SC-1:Node16 Mon Apr 22 12:03:00/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:03:00/cluster/temp/log] # cat $TC.load.log
|
|
Linux 3.0.42-0.7.3.4775.1.PTF-default (SC-1) 04/22/13 _x86_64_
|
|
|
|
12:00:55 CPU %user %nice %system %iowait %steal %idle
|
|
12:00:56 all 0.08 0.00 0.33 0.00 0.00 99.58
|
|
Start to launch apps when no session is active.
|
|
12:00:57 all 8.60 0.00 10.21 0.17 0.00 81.02
|
|
12:00:58 all 10.39 0.00 11.44 0.00 0.00 78.17
|
|
12:00:59 all 13.01 0.00 11.86 0.00 0.00 75.13
|
|
12:01:00 all 13.36 0.00 15.13 0.00 0.00 71.50
|
|
12:01:01 all 14.72 0.00 15.25 0.00 0.00 70.03
|
|
12:01:02 all 15.43 0.00 17.29 0.18 0.00 67.11
|
|
12:01:03 all 17.61 0.00 19.53 0.00 0.00 62.86
|
|
12:01:04 all 16.34 0.00 21.53 0.00 0.00 62.13
|
|
12:01:05 all 18.37 0.00 22.53 0.00 0.00 59.10
|
|
12:01:06 all 19.79 0.00 25.28 0.00 0.00 54.93
|
|
12:01:07 all 21.29 0.00 24.22 0.00 0.00 54.48
|
|
12:01:08 all 22.02 0.00 27.27 0.00 0.00 50.71
|
|
12:01:09 all 23.46 0.00 27.83 0.00 0.00 48.72
|
|
12:01:10 all 23.41 0.00 27.80 0.00 0.00 48.80
|
|
12:01:11 all 26.45 0.00 25.93 0.00 0.00 47.61
|
|
12:01:12 all 23.82 0.00 31.26 0.00 0.00 44.92
|
|
12:01:13 all 26.70 0.00 30.81 0.00 0.00 42.49
|
|
12:01:14 all 26.87 0.00 30.99 0.00 0.00 42.15
|
|
12:01:15 all 27.23 0.00 33.53 0.00 0.00 39.23
|
|
12:01:16 all 29.33 0.00 31.24 0.00 0.00 39.43
|
|
12:01:17 all 29.18 0.00 31.81 0.00 0.00 39.00
|
|
12:01:18 all 30.29 0.00 34.39 0.00 0.00 35.32
|
|
12:01:19 all 31.60 0.00 34.98 0.00 0.00 33.42
|
|
12:01:20 all 32.00 0.00 34.42 0.00 0.00 33.58
|
|
12:01:21 all 34.50 0.00 35.38 0.00 0.00 30.12
|
|
12:01:22 all 34.83 0.00 36.55 0.00 0.00 28.62
|
|
End of launching apps when no session is active
|
|
12:01:23 all 33.01 0.00 36.02 0.16 0.00 30.81
|
|
12:01:24 all 33.31 0.00 35.36 0.00 0.00 31.33
|
|
12:01:25 all 30.60 0.00 35.21 0.00 0.00 34.18
|
|
12:01:26 all 32.00 0.00 35.60 0.00 0.00 32.39
|
|
12:01:27 all 28.30 0.00 33.14 0.00 0.00 38.56
|
|
12:01:28 all 29.62 0.00 33.22 0.00 0.00 37.16
|
|
12:01:29 all 30.16 0.00 31.39 0.00 0.00 38.46
|
|
12:01:30 all 31.78 0.00 29.02 0.00 0.00 39.20
|
|
12:01:31 all 28.91 0.00 33.88 0.00 0.00 37.21
|
|
12:01:32 all 33.55 0.00 28.57 0.08 0.00 37.80
|
|
12:01:33 all 32.32 0.00 29.05 0.00 0.00 38.63
|
|
12:01:34 all 31.95 0.00 33.83 0.00 0.00 34.22
|
|
12:01:35 all 29.23 0.00 34.11 0.00 0.00 36.66
|
|
12:01:36 all 29.81 0.00 36.30 0.00 0.00 33.89
|
|
Create the session.
|
|
12:01:37 all 32.74 0.00 38.51 0.15 0.00 28.59
|
|
12:01:38 all 30.78 0.00 31.26 0.00 0.00 37.96
|
|
12:01:39 all 28.62 0.00 33.60 0.00 0.00 37.78
|
|
12:01:40 all 33.28 0.00 31.74 0.00 0.00 34.98
|
|
12:01:41 all 29.61 0.00 31.17 0.00 0.00 39.23
|
|
Enable channel....
|
|
12:01:42 all 31.60 0.00 32.07 0.39 0.00 35.93
|
|
12:01:43 all 31.92 0.00 38.71 0.00 0.00 29.37
|
|
12:01:44 all 32.78 0.00 35.46 0.00 0.00 31.76
|
|
12:01:45 all 31.59 0.00 35.27 0.00 0.00 33.14
|
|
12:01:46 all 34.78 0.00 35.49 0.00 0.00 29.72
|
|
12:01:47 all 34.12 0.00 34.51 0.00 0.00 31.37
|
|
12:01:48 all 33.75 0.00 33.50 0.00 0.00 32.75
|
|
12:01:49 all 32.57 0.00 35.37 0.00 0.00 32.06
|
|
Enable channel done.
|
|
Enable channel metadata....
|
|
Enable channel metadata done.
|
|
12:01:50 all 31.58 0.00 35.96 0.40 0.00 32.06
|
|
12:01:51 all 30.61 0.00 30.45 0.00 0.00 38.94
|
|
12:01:52 all 32.08 0.00 29.88 0.00 0.00 38.04
|
|
12:01:53 all 32.92 0.00 32.14 0.00 0.00 34.95
|
|
12:01:54 all 32.10 0.00 30.94 0.00 0.00 36.96
|
|
12:01:55 all 32.19 0.00 32.94 0.00 0.00 34.87
|
|
Enable Event....
|
|
12:01:56 all 32.42 0.00 37.73 0.16 0.00 29.69
|
|
Enable Event done.
|
|
12:01:57 all 31.69 0.00 32.69 0.17 0.00 35.45
|
|
12:01:58 all 30.50 0.00 31.46 0.00 0.00 38.04
|
|
12:01:59 all 30.29 0.00 33.20 0.00 0.00 36.51
|
|
12:02:00 all 32.13 0.00 31.37 0.00 0.00 36.50
|
|
12:02:01 all 31.07 0.00 33.16 0.00 0.00 35.77
|
|
Activate the session.
|
|
12:02:02 all 32.67 0.00 33.39 0.16 0.00 33.78
|
|
12:02:03 all 38.88 0.00 32.78 0.00 0.00 28.35
|
|
12:02:04 all 44.04 0.00 33.23 0.00 0.00 22.73
|
|
12:02:05 all 50.28 0.00 35.43 0.00 0.00 14.29
|
|
12:02:06 all 53.55 0.00 33.08 0.00 0.00 13.37
|
|
12:02:07 all 51.71 0.00 36.34 0.00 0.00 11.96
|
|
12:02:08 all 56.79 0.00 35.11 0.00 0.00 8.10
|
|
12:02:09 all 59.42 0.00 35.72 0.00 0.00 4.86
|
|
Activate session Done.
|
|
12:02:10 all 61.13 0.00 32.24 0.08 0.00 6.55
|
|
12:02:11 all 60.95 0.00 32.24 0.00 0.00 6.82
|
|
12:02:12 all 61.86 0.00 33.25 0.00 0.00 4.89
|
|
12:02:13 all 61.00 0.00 34.73 0.00 0.00 4.27
|
|
12:02:14 all 60.74 0.00 35.57 0.00 0.00 3.69
|
|
12:02:15 all 59.31 0.00 35.91 0.00 0.00 4.78
|
|
12:02:16 all 60.51 0.00 31.66 0.00 0.00 7.83
|
|
12:02:17 all 60.92 0.00 31.64 0.00 0.00 7.44
|
|
12:02:18 all 61.13 0.00 33.99 0.00 0.00 4.88
|
|
12:02:19 all 60.18 0.00 31.80 0.00 0.00 8.01
|
|
12:02:20 all 59.32 0.00 33.11 0.00 0.00 7.57
|
|
12:02:21 all 62.55 0.00 33.03 0.00 0.00 4.42
|
|
12:02:22 all 60.03 0.00 31.25 0.00 0.00 8.72
|
|
12:02:23 all 60.73 0.00 30.87 0.00 0.00 8.40
|
|
12:02:24 all 59.61 0.00 35.55 0.00 0.00 4.84
|
|
12:02:25 all 60.81 0.00 31.59 0.00 0.00 7.60
|
|
Stopping the session...
|
|
12:02:26 all 59.77 0.00 32.00 0.00 0.00 8.23
|
|
12:02:27 all 60.43 0.00 32.68 0.00 0.00 6.90
|
|
12:02:28 all 58.94 0.00 32.07 0.00 0.00 8.98
|
|
12:02:29 all 51.57 0.00 32.74 0.00 0.00 15.69
|
|
12:02:30 all 44.13 0.00 33.03 0.00 0.00 22.84
|
|
Stopping done.
|
|
12:02:31 all 31.23 0.00 30.61 0.26 0.00 37.89
|
|
12:02:32 all 28.44 0.00 30.84 0.77 0.00 39.95
|
|
12:02:33 all 28.43 0.00 32.42 0.00 0.00 39.15
|
|
12:02:34 all 27.62 0.00 30.24 0.00 0.00 42.13
|
|
12:02:35 all 29.85 0.00 28.56 0.00 0.00 41.59
|
|
12:02:36 all 29.10 0.00 30.98 0.00 0.00 39.93
|
|
Destroying the session...
|
|
12:02:37 all 28.40 0.00 31.52 0.26 0.00 39.83
|
|
12:02:38 all 30.01 0.00 34.43 0.00 0.00 35.56
|
|
Destroy done!
|
|
12:02:39 all 29.07 0.00 35.51 1.38 0.00 34.04
|
|
12:02:40 all 29.10 0.00 28.83 0.00 0.00 42.07
|
|
12:02:41 all 30.61 0.00 27.26 0.00 0.00 42.13
|
|
12:02:42 all 28.14 0.00 34.84 0.00 0.00 37.02
|
|
12:02:43 all 28.30 0.00 30.78 0.00 0.00 40.92
|
|
12:02:44 all 31.60 0.00 29.83 0.00 0.00 38.57
|
|
12:02:45 all 32.20 0.00 31.35 0.00 0.00 36.46
|
|
12:02:46 all 28.91 0.00 32.08 0.08 0.00 38.93
|
|
12:02:47 all 30.79 0.00 29.64 0.00 0.00 39.57
|
|
12:02:48 all 29.78 0.00 32.59 0.00 0.00 37.63
|
|
12:02:49 all 29.98 0.00 30.24 0.00 0.00 39.78
|
|
12:02:50 all 31.40 0.00 29.36 0.00 0.00 39.23
|
|
Killing TestApp
|
|
12:02:51 all 31.84 0.00 34.75 0.25 0.00 33.17
|
|
12:02:52 all 29.32 0.00 44.92 0.00 0.00 25.76
|
|
12:02:53 all 19.97 0.00 66.39 0.00 0.00 13.64
|
|
12:02:54 all 18.34 0.00 57.43 0.00 0.00 24.23
|
|
Killing Done .
|
|
12:02:55 all 11.22 0.00 47.76 0.34 0.00 40.68
|
|
12:02:56 all 0.00 0.00 0.00 0.00 0.00 100.00
|
|
12:02:57 all 0.00 0.00 0.17 0.00 0.00 99.83
|
|
12:02:58 all 0.00 0.00 0.00 0.00 0.00 100.00
|
|
12:02:59 all 0.08 0.00 0.08 0.00 0.00 99.83
|
|
[1]+ Terminated sar -u 1 300 >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:03:00/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:03:01/cluster/temp/log] # rm $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:03:01/cluster/temp/log] # babeltrace $TC | grep -c $DOMAIN_EVENT
|
|
2543
|
|
[SC-1:Node16 Mon Apr 22 12:03:01/cluster/temp/log] # babeltrace $TC | wc -l
|
|
2543
|
|
[SC-1:Node16 Mon Apr 22 12:03:02/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:03:02/cluster/temp/log] # du -h $TC | tail -n 1
|
|
836K bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
[SC-1:Node16 Mon Apr 22 12:03:02/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 0 "
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:32/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 1 "
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:35/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 2"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:38/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 3"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:40/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 4"
|
|
684
|
|
[SC-1:Node16 Mon Apr 22 12:07:42/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 5"
|
|
279
|
|
[SC-1:Node16 Mon Apr 22 12:07:44/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 6"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:46/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 7"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:48/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 8"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:50/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 9"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:07:52/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 10"
|
|
1274
|
|
[SC-1:Node16 Mon Apr 22 12:07:55/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 11"
|
|
306
|
|
[SC-1:Node16 Mon Apr 22 12:07:57/cluster/temp/log] # babeltrace $TC | grep wc -l
|
|
[SC-1:Node16 Mon Apr 22 12:08:04/cluster/temp/log] # babeltrace $TC | wc -l
|
|
2543
|
|
[SC-1:Node16 Mon Apr 22 12:08:10/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:35/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:35/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:35/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:35/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:35/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:36/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:36/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:36/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:36/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:10:36/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:11:25/cluster/temp/log] # export TC=bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
[SC-1:Node16 Mon Apr 22 12:11:25/cluster/temp/log] # DOMAIN_EVENT="com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec"
|
|
[SC-1:Node16 Mon Apr 22 12:11:25/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:11:25/cluster/temp/log] # sleep 1
|
|
sar -u 1 300 >> $TC.load.log &
|
|
netstat -etanp | head -n 2 ; netstat -etanp |egrep 'lttng'
|
|
sleep 1
|
|
echo "Start to launch apps when no session is active." >> $TC.load.log
|
|
#----------------------------------------------------------------------
|
|
date; time for n in $(seq 1 8000); do (/home/test_apps/TestApp_100perSecOnly 200 np &); done
|
|
#----------------------------------------------------------------------
|
|
echo "End of launching apps when no session is active" >> $TC.load.log
|
|
ps -ef |grep -c TestApp
|
|
sleep 1
|
|
|
|
#---------------------------- Get PID to trace on --------------------------------------------------
|
|
export my_pid=$(ps -e |grep TestApp | tail -n 1 | awk {'print $1'}); echo $my_pid
|
|
sleep 10
|
|
|
|
ps -ef |egrep 'lttng'
|
|
lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC &
|
|
echo "Create the session." >> $TC.load.log
|
|
date; lttng create $TC -U net://192.168.0.1:53000:53001/./
|
|
lttng list
|
|
sleep 5
|
|
echo "Enable channel...." >> $TC.load.log
|
|
date; lttng enable-channel chan1 -u -s $TC --buffers-uid --subbuf-size 16384 --switch-timer 1000000
|
|
echo "Enable channel done." >> $TC.load.log
|
|
echo "Enable channel metadata...." >> $TC.load.log
|
|
date; lttng enable-channel metadata -u -s $TC --buffers-uid --subbuf-size 16384 --switch-timer 1000000
|
|
echo "Enable channel metadata done." >> $TC.load.log
|
|
sleep 5
|
|
lttng add-context -t vpid -u -s $TC
|
|
echo "Enable Event...." >> $TC.load.log
|
|
date; lttng enable-event -s $TC -u -c chan1 $DOMAIN_EVENT --filter "PID == $my_pid"
|
|
echo "Enable Event done." >> $TC.load.log
|
|
sleep 5
|
|
|
|
echo "Activate the session." >> $TC.load.log
|
|
#---------------------------------------------------- activate session -----------------------
|
|
date; lttng start;
|
|
echo "Activate session Done." >> $TC.load.log
|
|
sleep 1
|
|
lttng list $TC
|
|
sleep 1
|
|
ps -e |grep -c TestApp
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
|
|
for c in $(seq 1 10); do (sleep 1; date; dir -R $TC/SC-1/ust/uid/0/64-bit); done
|
|
|
|
echo "Stopping the session..." >> $TC.load.log
|
|
#---------------------------------------------------- De-activate session -----------------------
|
|
lttng stop
|
|
echo "Stopping done." >> $TC.load.log
|
|
sleep 1
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
sleep 5
|
|
echo "Destroying the session..." >> $TC.load.log
|
|
lttng destroy
|
|
echo "Destroy done! " >> $TC.load.log
|
|
sleep 5
|
|
dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
pkill relayd
|
|
|
|
babeltrace $TC | head -n 10
|
|
sleep 1
|
|
dir /cluster/dumps
|
|
sleep 5
|
|
echo "Killing TestApp" >> $TC.load.log
|
|
ps -e |grep -c TestApp
|
|
pkill TestApp
|
|
echo "Killing Done ." >> $TC.load.log
|
|
ps -e |grep -c TestApp
|
|
sleep 5
|
|
pkill sar
|
|
|
|
cat $TC.load.log
|
|
sleep 1
|
|
rm $TC.load.log
|
|
babeltrace $TC | grep -c $DOMAIN_EVENT
|
|
babeltrace $TC | wc -l
|
|
|
|
du -h $TC | tail -n 1
|
|
[SC-1:Node16 Mon Apr 22 12:11:26/cluster/temp/log] # sar -u 1 300 >> $TC.load.log &
|
|
[1] 1413
|
|
[SC-1:Node16 Mon Apr 22 12:11:26/cluster/temp/log] # netstat -etanp | head -n 2 ; netstat -etanp |egrep 'lttng'
|
|
Active Internet connections (servers and established)
|
|
Proto Recv-Q Send-Q Local Address Foreign Address State User Inode PID/Program name
|
|
[SC-1:Node16 Mon Apr 22 12:11:26/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:11:27/cluster/temp/log] # echo "Start to launch apps when no session is active." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:11:27/cluster/temp/log] # #----------------------------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 12:11:27/cluster/temp/log] # date; time for n in $(seq 1 8000); do (/home/test_apps/TestApp_100perSecOnly 200 np &); done
|
|
Mon Apr 22 12:11:27 EDT 2013
|
|
|
|
real 0m28.731s
|
|
user 0m3.608s
|
|
sys 0m1.568s
|
|
[SC-1:Node16 Mon Apr 22 12:11:56/cluster/temp/log] # #----------------------------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 12:11:56/cluster/temp/log] # echo "End of launching apps when no session is active" >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:11:56/cluster/temp/log] # ps -ef |grep -c TestApp
|
|
8001
|
|
[SC-1:Node16 Mon Apr 22 12:11:57/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:11:58/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:11:58/cluster/temp/log] # #---------------------------- Get PID to trace on --------------------------------------------------
|
|
[SC-1:Node16 Mon Apr 22 12:11:58/cluster/temp/log] # export my_pid=$(ps -e |grep TestApp | tail -n 1 | awk {'print $1'}); echo $my_pid
|
|
32767
|
|
[SC-1:Node16 Mon Apr 22 12:11:59/cluster/temp/log] # sleep 10
|
|
[SC-1:Node16 Mon Apr 22 12:12:09/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:12:09/cluster/temp/log] # ps -ef |egrep 'lttng'
|
|
root 1300 17713 0 12:12 pts/1 00:00:00 egrep lttng
|
|
root 13763 30507 0 10:10 ? 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
|
|
root 30507 1 0 09:03 ? 00:01:10 lttng-sessiond -d
|
|
[SC-1:Node16 Mon Apr 22 12:12:10/cluster/temp/log] # lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC &
|
|
[2] 1303
|
|
[SC-1:Node16 Mon Apr 22 12:12:10/cluster/temp/log] # echo "Create the session." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:10/cluster/temp/log] # date; lttng create $TC -U net://192.168.0.1:53000:53001/./
|
|
Mon Apr 22 12:12:10 EDT 2013
|
|
Session bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1 created.
|
|
Traces will be written in net://192.168.0.1:53000:53001/./
|
|
[SC-1:Node16 Mon Apr 22 12:12:10/cluster/temp/log] # lttng list
|
|
Available tracing sessions:
|
|
1) bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1 (net://192.168.0.1:53000/./ [data: 5343]) [inactive]
|
|
|
|
Use lttng list <session_name> for more details
|
|
[SC-1:Node16 Mon Apr 22 12:12:10/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:12:15/cluster/temp/log] # echo "Enable channel...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:15/cluster/temp/log] # date; lttng enable-channel chan1 -u -s $TC --buffers-uid --subbuf-size 16384 --switch-timer 1000000
|
|
Mon Apr 22 12:12:15 EDT 2013
|
|
UST channel chan1 enabled for session bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
[SC-1:Node16 Mon Apr 22 12:12:23/cluster/temp/log] # echo "Enable channel done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:23/cluster/temp/log] # echo "Enable channel metadata...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:23/cluster/temp/log] # date; lttng enable-channel metadata -u -s $TC --buffers-uid --subbuf-size 16384 --switch-timer 1000000
|
|
Mon Apr 22 12:12:23 EDT 2013
|
|
UST channel metadata enabled for session bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
[SC-1:Node16 Mon Apr 22 12:12:23/cluster/temp/log] # echo "Enable channel metadata done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:23/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:12:28/cluster/temp/log] # lttng add-context -t vpid -u -s $TC
|
|
UST context vpid added to all channels
|
|
[SC-1:Node16 Mon Apr 22 12:12:29/cluster/temp/log] # echo "Enable Event...." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:29/cluster/temp/log] # date; lttng enable-event -s $TC -u -c chan1 $DOMAIN_EVENT --filter "PID == $my_pid"
|
|
Mon Apr 22 12:12:29 EDT 2013
|
|
Filter 'PID == 32767' successfully set
|
|
[SC-1:Node16 Mon Apr 22 12:12:30/cluster/temp/log] # echo "Enable Event done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:30/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:12:35/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:12:35/cluster/temp/log] # echo "Activate the session." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:35/cluster/temp/log] # #---------------------------------------------------- activate session -----------------------
|
|
[SC-1:Node16 Mon Apr 22 12:12:35/cluster/temp/log] # date; lttng start;
|
|
Mon Apr 22 12:12:35 EDT 2013
|
|
Tracing started for session bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
[SC-1:Node16 Mon Apr 22 12:12:40/cluster/temp/log] # echo "Activate session Done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:40/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:12:41/cluster/temp/log] # lttng list $TC
|
|
Tracing session bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1: [active]
|
|
Trace path: net://192.168.0.1:53000/./ [data: 53001]
|
|
|
|
=== Domain: UST global ===
|
|
|
|
Buffer type: per UID
|
|
|
|
Channels:
|
|
-------------
|
|
- metadata: [enabled]
|
|
|
|
Attributes:
|
|
write mode: discard
|
|
subbufers size: 16384 bytes
|
|
number of subbufers: 4
|
|
switch timer interval: 1000000 usec
|
|
read timer interval: 0 usec
|
|
output: mmap()
|
|
|
|
Events:
|
|
None
|
|
|
|
- chan1: [enabled]
|
|
|
|
Attributes:
|
|
write mode: discard
|
|
subbufers size: 16384 bytes
|
|
number of subbufers: 4
|
|
switch timer interval: 1000000 usec
|
|
read timer interval: 0 usec
|
|
output: mmap()
|
|
|
|
Events:
|
|
com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec (type: tracepoint) [enabled] [with filter]
|
|
|
|
[SC-1:Node16 Mon Apr 22 12:12:41/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:12:42/cluster/temp/log] # ps -e |grep -c TestApp
|
|
8000
|
|
[SC-1:Node16 Mon Apr 22 12:12:44/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 148
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_0
|
|
[SC-1:Node16 Mon Apr 22 12:12:44/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:12:44/cluster/temp/log] # for c in $(seq 1 10); do (sleep 1; date; dir -R $TC/SC-1/ust/uid/0/64-bit); done
|
|
Mon Apr 22 12:12:46 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 160
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
Mon Apr 22 12:12:47 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 168
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 chan1_2
|
|
Mon Apr 22 12:12:48 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 176
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_2
|
|
Mon Apr 22 12:12:49 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 188
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
Mon Apr 22 12:12:50 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 196
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_9
|
|
Mon Apr 22 12:12:51 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 216
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:12 chan1_1
|
|
Mon Apr 22 12:12:53 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 224
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:12 chan1_7
|
|
Mon Apr 22 12:12:54 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 232
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 32768 Apr 22 12:12 chan1_7
|
|
Mon Apr 22 12:12:55 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 240
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:12 chan1_0
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 40960 Apr 22 12:12 chan1_7
|
|
Mon Apr 22 12:12:56 EDT 2013
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 252
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 45056 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 chan1_6
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_0
|
|
[SC-1:Node16 Mon Apr 22 12:12:56/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:12:56/cluster/temp/log] # echo "Stopping the session..." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:12:56/cluster/temp/log] # #---------------------------------------------------- De-activate session -----------------------
|
|
[SC-1:Node16 Mon Apr 22 12:12:56/cluster/temp/log] # lttng stop
|
|
Waiting for data availability
|
|
Tracing stopped for session bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
[SC-1:Node16 Mon Apr 22 12:13:00/cluster/temp/log] # echo "Stopping done." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:13:00/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:13:01/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 772
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:12 metadata
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:12 chan1_5
|
|
-rw-rw---- 1 root root 36864 Apr 22 12:12 chan1_4
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_11
|
|
-rw-rw---- 1 root root 4096 Apr 22 12:12 chan1_10
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:12 chan1_8
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_3
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_2
|
|
-rw-rw---- 1 root root 20480 Apr 22 12:12 chan1_9
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:12 chan1_1
|
|
-rw-rw---- 1 root root 45056 Apr 22 12:12 chan1_7
|
|
-rw-rw---- 1 root root 516096 Apr 22 12:13 chan1_6
|
|
-rw-rw---- 1 root root 45056 Apr 22 12:13 chan1_0
|
|
[SC-1:Node16 Mon Apr 22 12:13:01/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:13:06/cluster/temp/log] # echo "Destroying the session..." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:13:06/cluster/temp/log] # lttng destroy
|
|
Session bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1 destroyed
|
|
[SC-1:Node16 Mon Apr 22 12:13:08/cluster/temp/log] # echo "Destroy done! " >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:13:08/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:13:13/cluster/temp/log] # dir -R $TC/SC-1/ust/uid/0/64-bit
|
|
bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit:
|
|
total 824
|
|
-rw-rw---- 1 root root 16384 Apr 22 12:13 metadata
|
|
-rw-rw---- 1 root root 12288 Apr 22 12:13 chan1_8
|
|
-rw-rw---- 1 root root 520192 Apr 22 12:13 chan1_6
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:13 chan1_3
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:13 chan1_10
|
|
-rw-rw---- 1 root root 28672 Apr 22 12:13 chan1_1
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:13 chan1_0
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:13 chan1_9
|
|
-rw-rw---- 1 root root 49152 Apr 22 12:13 chan1_7
|
|
-rw-rw---- 1 root root 32768 Apr 22 12:13 chan1_5
|
|
-rw-rw---- 1 root root 40960 Apr 22 12:13 chan1_4
|
|
-rw-rw---- 1 root root 24576 Apr 22 12:13 chan1_2
|
|
-rw-rw---- 1 root root 8192 Apr 22 12:13 chan1_11
|
|
[SC-1:Node16 Mon Apr 22 12:13:13/cluster/temp/log] # pkill relayd
|
|
[2]+ Done lttng-relayd -C tcp://0.0.0.0:53000 -D tcp://0.0.0.0:53001 -o /cluster/temp/log/$TC
|
|
[SC-1:Node16 Mon Apr 22 12:13:14/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:13:14/cluster/temp/log] # babeltrace $TC | head -n 10
|
|
[12:12:35.422066383] (+?.?????????) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 5 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 3, HundredPs = 7, unit_float = 7.1234, unit_string = "unit_7" }
|
|
[12:12:35.432075976] (+0.010009593) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 3, HundredPs = 8, unit_float = 8.1234, unit_string = "unit_8" }
|
|
[12:12:35.442063124] (+0.009987148) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 3, HundredPs = 9, unit_float = 9.1234, unit_string = "unit_9" }
|
|
[12:12:35.452048386] (+0.009985262) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 4, HundredPs = 0, unit_float = 0.1234, unit_string = "unit_0" }
|
|
[12:12:35.462022249] (+0.009973863) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 4, HundredPs = 1, unit_float = 1.1234, unit_string = "unit_1" }
|
|
[12:12:35.472025298] (+0.010003049) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 4, HundredPs = 2, unit_float = 2.1234, unit_string = "unit_2" }
|
|
[12:12:35.482120146] (+0.010094848) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 4, HundredPs = 3, unit_float = 3.1234, unit_string = "unit_3" }
|
|
[12:12:35.492028904] (+0.009908758) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 4, HundredPs = 4, unit_float = 4.1234, unit_string = "unit_4" }
|
|
[12:12:35.502019651] (+0.009990747) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 4, HundredPs = 5, unit_float = 5.1234, unit_string = "unit_5" }
|
|
[12:12:35.512024870] (+0.010005219) SC-1 com_ericsson_cba_trace_testapp100_hightraf:HundredPerSec: { cpu_id = 4 }, { vpid = 32767 }, { my_Time = "12:12:35", PID = 32767, OnePs = 40, TenPs = 4, HundredPs = 6, unit_float = 6.1234, unit_string = "unit_6" }
|
|
[SC-1:Node16 Mon Apr 22 12:13:14/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:13:15/cluster/temp/log] # dir /cluster/dumps
|
|
total 4
|
|
drwxr-xr-x 2 root root 4096 Apr 22 10:28 old
|
|
[SC-1:Node16 Mon Apr 22 12:13:15/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:13:20/cluster/temp/log] # echo "Killing TestApp" >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:13:20/cluster/temp/log] # ps -e |grep -c TestApp
|
|
8000
|
|
[SC-1:Node16 Mon Apr 22 12:13:21/cluster/temp/log] # pkill TestApp
|
|
[SC-1:Node16 Mon Apr 22 12:13:26/cluster/temp/log] # echo "Killing Done ." >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:13:26/cluster/temp/log] # ps -e |grep -c TestApp
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:13:26/cluster/temp/log] # sleep 5
|
|
[SC-1:Node16 Mon Apr 22 12:13:31/cluster/temp/log] # pkill sar
|
|
[SC-1:Node16 Mon Apr 22 12:13:31/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:13:31/cluster/temp/log] # cat $TC.load.log
|
|
Linux 3.0.42-0.7.3.4775.1.PTF-default (SC-1) 04/22/13 _x86_64_
|
|
|
|
12:11:26 CPU %user %nice %system %iowait %steal %idle
|
|
12:11:27 all 0.00 0.00 0.42 0.00 0.00 99.58
|
|
Start to launch apps when no session is active.
|
|
12:11:28 all 7.88 0.00 10.00 0.51 0.00 81.61
|
|
12:11:29 all 10.71 0.00 11.48 0.00 0.00 77.81
|
|
12:11:30 all 10.64 0.00 12.49 0.00 0.00 76.87
|
|
12:11:31 all 13.21 0.00 12.77 0.00 0.00 74.02
|
|
12:11:32 all 12.97 0.00 16.77 0.00 0.00 70.26
|
|
12:11:33 all 14.09 0.00 16.59 0.00 0.00 69.31
|
|
12:11:34 all 15.84 0.00 18.72 0.00 0.00 65.44
|
|
12:11:35 all 17.59 0.00 20.65 0.00 0.00 61.77
|
|
12:11:36 all 17.91 0.00 21.48 0.00 0.00 60.61
|
|
12:11:37 all 18.72 0.00 22.22 0.00 0.00 59.06
|
|
12:11:38 all 21.52 0.00 23.25 0.00 0.00 55.23
|
|
12:11:39 all 22.18 0.00 24.25 0.00 0.00 53.57
|
|
12:11:40 all 23.76 0.00 24.68 0.00 0.00 51.56
|
|
12:11:41 all 23.70 0.00 26.25 0.00 0.00 50.04
|
|
12:11:42 all 25.45 0.00 28.09 0.00 0.00 46.47
|
|
12:11:43 all 24.29 0.00 28.24 0.00 0.00 47.47
|
|
12:11:44 all 26.37 0.00 28.56 0.00 0.00 45.07
|
|
12:11:45 all 26.50 0.00 30.37 0.00 0.00 43.13
|
|
12:11:46 all 27.92 0.00 29.52 0.00 0.00 42.56
|
|
12:11:47 all 28.46 0.00 31.54 0.00 0.00 40.00
|
|
12:11:48 all 28.24 0.00 33.28 0.00 0.00 38.49
|
|
12:11:49 all 27.40 0.00 34.06 0.00 0.00 38.53
|
|
12:11:50 all 28.85 0.00 32.12 0.00 0.00 39.03
|
|
12:11:51 all 29.46 0.00 34.16 0.00 0.00 36.38
|
|
12:11:52 all 31.27 0.00 32.24 0.00 0.00 36.48
|
|
12:11:53 all 32.36 0.00 32.01 0.00 0.00 35.63
|
|
12:11:54 all 31.50 0.00 37.26 0.00 0.00 31.24
|
|
12:11:55 all 33.44 0.00 34.69 0.00 0.00 31.87
|
|
End of launching apps when no session is active
|
|
12:11:56 all 33.66 0.00 34.73 0.25 0.00 31.36
|
|
12:11:57 all 29.73 0.00 39.25 0.09 0.00 30.93
|
|
12:11:58 all 33.31 0.00 29.54 0.00 0.00 37.15
|
|
12:11:59 all 31.53 0.00 36.08 0.00 0.00 32.39
|
|
12:12:00 all 32.19 0.00 32.43 0.00 0.00 35.39
|
|
12:12:01 all 31.59 0.00 30.20 0.00 0.00 38.20
|
|
12:12:02 all 30.52 0.00 28.98 0.00 0.00 40.50
|
|
12:12:03 all 29.55 0.00 30.88 0.00 0.00 39.57
|
|
12:12:04 all 33.91 0.00 29.74 0.00 0.00 36.35
|
|
12:12:05 all 31.32 0.00 32.98 0.00 0.00 35.70
|
|
12:12:06 all 31.32 0.00 32.35 0.00 0.00 36.33
|
|
12:12:07 all 33.54 0.00 31.62 0.00 0.00 34.84
|
|
12:12:08 all 32.41 0.00 32.04 0.00 0.00 35.55
|
|
12:12:09 all 32.86 0.00 31.60 0.00 0.00 35.53
|
|
Create the session.
|
|
12:12:10 all 30.75 0.00 39.31 0.24 0.00 29.70
|
|
12:12:11 all 31.35 0.00 30.96 0.00 0.00 37.69
|
|
12:12:12 all 29.60 0.00 31.00 0.00 0.00 39.41
|
|
12:12:13 all 30.56 0.00 33.74 0.00 0.00 35.70
|
|
12:12:14 all 29.46 0.00 31.51 0.00 0.00 39.03
|
|
Enable channel....
|
|
12:12:15 all 28.42 0.00 32.70 0.25 0.00 38.63
|
|
12:12:16 all 30.82 0.00 37.54 0.25 0.00 31.39
|
|
12:12:17 all 34.68 0.00 32.29 0.00 0.00 33.03
|
|
12:12:18 all 32.47 0.00 35.15 0.00 0.00 32.38
|
|
12:12:19 all 33.30 0.00 35.62 0.00 0.00 31.07
|
|
12:12:20 all 34.38 0.00 33.25 0.00 0.00 32.37
|
|
12:12:21 all 33.91 0.00 33.99 0.00 0.00 32.09
|
|
12:12:22 all 33.88 0.00 37.05 0.00 0.00 29.07
|
|
Enable channel done.
|
|
Enable channel metadata....
|
|
Enable channel metadata done.
|
|
12:12:23 all 32.60 0.00 33.11 0.25 0.00 34.04
|
|
12:12:24 all 34.45 0.00 28.59 0.00 0.00 36.95
|
|
12:12:25 all 29.56 0.00 35.38 0.00 0.00 35.06
|
|
12:12:26 all 30.30 0.00 31.33 0.00 0.00 38.37
|
|
12:12:27 all 29.01 0.00 30.86 0.00 0.00 40.13
|
|
12:12:28 all 27.07 0.00 32.14 0.09 0.00 40.70
|
|
Enable Event....
|
|
12:12:29 all 31.13 0.00 31.70 0.09 0.00 37.08
|
|
Enable Event done.
|
|
12:12:30 all 28.80 0.00 31.17 0.26 0.00 39.77
|
|
12:12:31 all 28.15 0.00 30.90 0.00 0.00 40.95
|
|
12:12:32 all 28.05 0.00 31.34 0.00 0.00 40.61
|
|
12:12:33 all 29.76 0.00 31.07 0.00 0.00 39.17
|
|
12:12:34 all 28.99 0.00 32.80 0.00 0.00 38.21
|
|
Activate the session.
|
|
12:12:35 all 33.19 0.00 33.71 0.18 0.00 32.92
|
|
12:12:36 all 44.65 0.00 33.53 0.00 0.00 21.82
|
|
12:12:37 all 51.91 0.00 33.36 0.00 0.00 14.73
|
|
12:12:38 all 57.28 0.00 35.11 0.00 0.00 7.61
|
|
12:12:39 all 58.45 0.00 34.13 0.00 0.00 7.42
|
|
Activate session Done.
|
|
12:12:40 all 62.05 0.00 31.07 0.00 0.00 6.88
|
|
12:12:41 all 62.67 0.00 32.63 0.00 0.00 4.70
|
|
12:12:42 all 58.49 0.00 35.15 0.00 0.00 6.36
|
|
12:12:43 all 59.95 0.00 34.80 0.00 0.00 5.25
|
|
12:12:44 all 61.33 0.00 36.27 0.08 0.00 2.32
|
|
12:12:45 all 63.02 0.00 30.94 0.00 0.00 6.04
|
|
12:12:46 all 60.85 0.00 30.43 0.00 0.00 8.72
|
|
12:12:47 all 60.34 0.00 34.94 0.00 0.00 4.73
|
|
12:12:48 all 61.96 0.00 30.81 0.00 0.00 7.23
|
|
12:12:49 all 60.29 0.00 30.74 0.08 0.00 8.89
|
|
12:12:50 all 59.79 0.00 35.42 0.00 0.00 4.79
|
|
12:12:51 all 60.52 0.00 31.26 0.00 0.00 8.23
|
|
12:12:52 all 58.33 0.00 33.14 0.00 0.00 8.54
|
|
12:12:53 all 58.54 0.00 35.00 0.08 0.00 6.38
|
|
12:12:54 all 60.17 0.00 34.33 0.00 0.00 5.50
|
|
12:12:55 all 58.67 0.00 32.70 0.00 0.00 8.63
|
|
Stopping the session...
|
|
12:12:56 all 61.38 0.00 32.21 0.00 0.00 6.41
|
|
12:12:57 all 61.04 0.00 32.90 0.00 0.00 6.06
|
|
12:12:58 all 55.88 0.00 32.10 0.00 0.00 12.02
|
|
12:12:59 all 49.31 0.00 33.99 0.00 0.00 16.71
|
|
Stopping done.
|
|
12:13:00 all 40.93 0.00 31.15 0.25 0.00 27.67
|
|
12:13:01 all 29.39 0.00 29.65 0.00 0.00 40.96
|
|
12:13:02 all 28.72 0.00 32.46 0.00 0.00 38.82
|
|
12:13:03 all 26.82 0.00 32.38 0.09 0.00 40.71
|
|
12:13:04 all 27.96 0.00 28.32 0.00 0.00 43.72
|
|
12:13:05 all 29.28 0.00 31.19 0.00 0.00 39.53
|
|
Destroying the session...
|
|
12:13:06 all 28.81 0.00 33.47 0.08 0.00 37.64
|
|
12:13:07 all 33.47 0.00 32.03 0.00 0.00 34.49
|
|
Destroy done!
|
|
12:13:08 all 30.17 0.00 35.40 0.09 0.00 34.35
|
|
12:13:09 all 30.30 0.00 31.23 1.28 0.00 37.19
|
|
12:13:10 all 29.64 0.00 29.72 0.00 0.00 40.64
|
|
12:13:11 all 31.62 0.00 29.99 0.00 0.00 38.39
|
|
12:13:12 all 28.78 0.00 33.05 0.00 0.00 38.17
|
|
12:13:13 all 30.52 0.00 31.70 0.00 0.00 37.78
|
|
12:13:14 all 28.86 0.00 32.69 0.00 0.00 38.45
|
|
12:13:15 all 29.49 0.00 32.20 0.00 0.00 38.31
|
|
12:13:16 all 28.41 0.00 31.73 0.00 0.00 39.87
|
|
12:13:17 all 30.54 0.00 29.19 0.00 0.00 40.27
|
|
12:13:18 all 29.40 0.00 34.69 0.00 0.00 35.91
|
|
12:13:19 all 30.20 0.00 31.00 0.00 0.00 38.80
|
|
Killing TestApp
|
|
12:13:20 all 30.70 0.00 32.30 0.17 0.00 36.83
|
|
12:13:21 all 32.58 0.00 41.47 0.00 0.00 25.95
|
|
12:13:22 all 26.19 0.00 63.50 0.00 0.00 10.31
|
|
12:13:23 all 22.72 0.00 60.05 0.00 0.00 17.23
|
|
12:13:24 all 19.73 0.00 61.28 0.00 0.00 18.98
|
|
12:13:25 all 13.66 0.00 55.13 0.00 0.00 31.21
|
|
Killing Done .
|
|
12:13:26 all 4.30 0.00 21.92 0.42 0.00 73.36
|
|
12:13:27 all 0.00 0.00 0.08 0.00 0.00 99.92
|
|
12:13:28 all 0.00 0.00 0.08 0.00 0.00 99.92
|
|
12:13:29 all 0.00 0.00 0.17 0.00 0.00 99.83
|
|
12:13:30 all 0.00 0.00 0.25 0.00 0.00 99.75
|
|
[1]+ Terminated sar -u 1 300 >> $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:13:31/cluster/temp/log] # sleep 1
|
|
[SC-1:Node16 Mon Apr 22 12:13:32/cluster/temp/log] # rm $TC.load.log
|
|
[SC-1:Node16 Mon Apr 22 12:13:32/cluster/temp/log] # babeltrace $TC | grep -c $DOMAIN_EVENT
|
|
2276
|
|
[SC-1:Node16 Mon Apr 22 12:13:32/cluster/temp/log] # babeltrace $TC | wc -l
|
|
2276
|
|
[SC-1:Node16 Mon Apr 22 12:13:32/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:13:32/cluster/temp/log] # du -h $TC | tail -n 1
|
|
848K bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
[SC-1:Node16 Mon Apr 22 12:13:32/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:14:27/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:14:27/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:14:28/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:14:28/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 0"
|
|
94
|
|
[SC-1:Node16 Mon Apr 22 12:14:37/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 1"
|
|
130
|
|
[SC-1:Node16 Mon Apr 22 12:14:48/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 2"
|
|
225
|
|
[SC-1:Node16 Mon Apr 22 12:14:51/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 3"
|
|
168
|
|
[SC-1:Node16 Mon Apr 22 12:14:54/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 4"
|
|
340
|
|
[SC-1:Node16 Mon Apr 22 12:14:58/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 5"
|
|
273
|
|
[SC-1:Node16 Mon Apr 22 12:15:01/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 6"
|
|
337
|
|
[SC-1:Node16 Mon Apr 22 12:15:04/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 7"
|
|
510
|
|
[SC-1:Node16 Mon Apr 22 12:15:07/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 8"
|
|
39
|
|
[SC-1:Node16 Mon Apr 22 12:15:09/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id = 9"
|
|
160
|
|
[SC-1:Node16 Mon Apr 22 12:15:12/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id =10"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:15:17/cluster/temp/log] # babeltrace $TC | grep -c "cpu_id =11"
|
|
0
|
|
[SC-1:Node16 Mon Apr 22 12:15:20/cluster/temp/log] # dir
|
|
total 2016
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:28 LTTNGgbf_007_a_timer1000ms
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:32 LTTNGgbf_007_a_timerDefault
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:36 LTTNGgbf_008
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:51 LTTNGgbf_009
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:42 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:48 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:50 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 5 12:08 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run4
|
|
-rw-r--r-- 1 root root 1060667 Apr 9 08:21 TC17_apr5.tar
|
|
-rw-r--r-- 1 root root 112575 Apr 12 06:45 TC17_apr9.tar
|
|
-rw-r--r-- 1 root root 21745 Apr 12 08:36 run4.tar
|
|
-rw-r--r-- 1 root root 25123 Apr 12 08:36 run5.tar
|
|
-rw-r--r-- 1 root root 269623 Apr 12 09:05 TC17_apr12_a.tar
|
|
drwxr-x--- 3 root root 4096 Apr 16 08:55 LTTNGgbf_006
|
|
drwxr-x--- 3 root root 4096 Apr 17 09:44 LTTNGgbf_007_a_timer100ms
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:51 LTTNGgbf_010
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_b
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_c
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:23 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:25 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:28 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:31 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run4
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:34 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run5
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:41 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run6
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
drwxr-x--- 3 root root 4096 Apr 22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
drwxr-x--- 3 root root 4096 Apr 22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
[SC-1:Node16 Mon Apr 22 12:24:09/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:24:53/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:37:22/cluster/temp/log] # tar zcf bug497_apr22.tar bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
[SC-1:Node16 Mon Apr 22 12:43:24/cluster/temp/log] # dir
|
|
total 1648
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:28 LTTNGgbf_007_a_timer1000ms
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:32 LTTNGgbf_007_a_timerDefault
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:36 LTTNGgbf_008
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:51 LTTNGgbf_009
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:42 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:48 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:50 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 5 12:08 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run4
|
|
-rw-r--r-- 1 root root 1060667 Apr 9 08:21 TC17_apr5.tar
|
|
-rw-r--r-- 1 root root 112575 Apr 12 06:45 TC17_apr9.tar
|
|
-rw-r--r-- 1 root root 21745 Apr 12 08:36 run4.tar
|
|
-rw-r--r-- 1 root root 25123 Apr 12 08:36 run5.tar
|
|
-rw-r--r-- 1 root root 269623 Apr 12 09:05 TC17_apr12_a.tar
|
|
drwxr-x--- 3 root root 4096 Apr 16 08:55 LTTNGgbf_006
|
|
drwxr-x--- 3 root root 4096 Apr 17 09:44 LTTNGgbf_007_a_timer100ms
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:51 LTTNGgbf_010
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_b
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_c
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:23 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:25 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:28 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:31 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run4
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:34 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run5
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:41 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run6
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
drwxr-x--- 3 root root 4096 Apr 22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
drwxr-x--- 3 root root 4096 Apr 22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
-rw-r--r-- 1 root root 80843 Apr 22 12:43 bug497_apr22.tar
|
|
[SC-1:Node16 Mon Apr 22 12:43:26/cluster/temp/log] # tar ztvf bug497_apr22.tar
|
|
drwxr-x--- root/root 0 2013-04-22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/
|
|
drwxr-x--- root/root 0 2013-04-22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/
|
|
drwxr-x--- root/root 0 2013-04-22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/
|
|
drwxr-x--- root/root 0 2013-04-22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/
|
|
drwxr-x--- root/root 0 2013-04-22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/
|
|
drwxr-x--- root/root 0 2013-04-22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/
|
|
-rw-rw---- root/root 520192 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_6
|
|
-rw-rw---- root/root 16384 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/metadata
|
|
-rw-rw---- root/root 8192 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_11
|
|
-rw-rw---- root/root 24576 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_9
|
|
-rw-rw---- root/root 49152 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_0
|
|
-rw-rw---- root/root 40960 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_4
|
|
-rw-rw---- root/root 8192 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_10
|
|
-rw-rw---- root/root 28672 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_1
|
|
-rw-rw---- root/root 24576 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_3
|
|
-rw-rw---- root/root 49152 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_7
|
|
-rw-rw---- root/root 24576 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_2
|
|
-rw-rw---- root/root 12288 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_8
|
|
-rw-rw---- root/root 32768 2013-04-22 12:13 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1/SC-1/ust/uid/0/64-bit/chan1_5
|
|
drwxr-x--- root/root 0 2013-04-22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/
|
|
drwxr-x--- root/root 0 2013-04-22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/
|
|
drwxr-x--- root/root 0 2013-04-22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/
|
|
drwxr-x--- root/root 0 2013-04-22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/
|
|
drwxr-x--- root/root 0 2013-04-22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/
|
|
drwxr-x--- root/root 0 2013-04-22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_6
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/metadata
|
|
-rw-rw---- root/root 20480 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_11
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_9
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_0
|
|
-rw-rw---- root/root 647168 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_4
|
|
-rw-rw---- root/root 61440 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_10
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_1
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_3
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_7
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_2
|
|
-rw-rw---- root/root 8192 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_8
|
|
-rw-rw---- root/root 20480 2013-04-22 12:02 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8/SC-1/ust/uid/0/64-bit/chan1_5
|
|
drwxr-x--- root/root 0 2013-04-22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/
|
|
drwxr-x--- root/root 0 2013-04-22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/
|
|
drwxr-x--- root/root 0 2013-04-22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/
|
|
drwxr-x--- root/root 0 2013-04-22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/
|
|
drwxr-x--- root/root 0 2013-04-22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/
|
|
drwxr-x--- root/root 0 2013-04-22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_6
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/metadata
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_11
|
|
-rw-rw---- root/root 24576 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_9
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_0
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_4
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_10
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_1
|
|
-rw-rw---- root/root 12288 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_3
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_7
|
|
-rw-rw---- root/root 57344 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_2
|
|
-rw-rw---- root/root 1085440 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_8
|
|
-rw-rw---- root/root 8192 2013-04-22 11:47 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7/SC-1/ust/uid/0/64-bit/chan1_5
|
|
[SC-1:Node16 Mon Apr 22 12:43:39/cluster/temp/log] # dir
|
|
total 1648
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:28 LTTNGgbf_007_a_timer1000ms
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:32 LTTNGgbf_007_a_timerDefault
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:36 LTTNGgbf_008
|
|
drwxr-x--- 3 root root 4096 Apr 3 14:51 LTTNGgbf_009
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:42 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:48 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 5 11:50 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 5 12:08 LTTNGgbf_019_1s_TraceOnPid_buf16k_100ps_run4
|
|
-rw-r--r-- 1 root root 1060667 Apr 9 08:21 TC17_apr5.tar
|
|
-rw-r--r-- 1 root root 112575 Apr 12 06:45 TC17_apr9.tar
|
|
-rw-r--r-- 1 root root 21745 Apr 12 08:36 run4.tar
|
|
-rw-r--r-- 1 root root 25123 Apr 12 08:36 run5.tar
|
|
-rw-r--r-- 1 root root 269623 Apr 12 09:05 TC17_apr12_a.tar
|
|
drwxr-x--- 3 root root 4096 Apr 16 08:55 LTTNGgbf_006
|
|
drwxr-x--- 3 root root 4096 Apr 17 09:44 LTTNGgbf_007_a_timer100ms
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:51 LTTNGgbf_010
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_b
|
|
drwxr-x--- 3 root root 4096 Apr 17 14:52 LTTNGgbf_010_c
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:23 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run1
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:25 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run2
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:28 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run3
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:31 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run4
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:34 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run5
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:41 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run6
|
|
drwxr-x--- 3 root root 4096 Apr 22 11:46 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run7
|
|
drwxr-x--- 3 root root 4096 Apr 22 12:01 bug497_8kAppFirst_NoTimer_Pid_buf16k_100ps_run8
|
|
drwxr-x--- 3 root root 4096 Apr 22 12:12 bug497_8kAppFirst_Timer1sec_Pid_buf16k_100ps_run1
|
|
-rw-r--r-- 1 root root 80843 Apr 22 12:43 bug497_apr22.tar
|
|
[SC-1:Node16 Mon Apr 22 12:43:54/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:43:54/cluster/temp/log] #
|
|
[SC-1:Node16 Mon Apr 22 12:43:55/cluster/temp/log] #
|