Project

General

Profile

Bug #367 ยป terminal.log

terminal log - Tan le tran, 10/10/2012 01:37 PM

 
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng-sessiond -vvv &
[1] 21232
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG3: Creating LTTng run directory: /var/run/lttng [in create_lttng_rundir() at main.c:3519]
DEBUG2: Kernel consumer err path: /var/run/lttng/kconsumerd/error [in main() at main.c:3767]
DEBUG2: Kernel consumer cmd path: /var/run/lttng/kconsumerd/command [in main() at main.c:3769]
DEBUG1: Client socket path /var/run/lttng/client-lttng-sessiond [in main() at main.c:3822]
DEBUG1: Application socket path /var/run/lttng/apps-lttng-sessiond [in main() at main.c:3823]
DEBUG1: LTTng run directory path: /var/run/lttng [in main() at main.c:3824]
DEBUG2: UST consumer 32 bits err path: /var/run/lttng/ustconsumerd32/error [in main() at main.c:3833]
DEBUG2: UST consumer 32 bits cmd path: /var/run/lttng/ustconsumerd32/command [in main() at main.c:3835]
DEBUG2: UST consumer 64 bits err path: /var/run/lttng/ustconsumerd64/error [in main() at main.c:3844]
DEBUG2: UST consumer 64 bits cmd path: /var/run/lttng/ustconsumerd64/command [in main() at main.c:3846]
DEBUG3: Created hashtable size 4 at 0x6400a0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Created hashtable size 4 at 0x640340 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Creating consumer directory: /var/run/lttng/kconsumerd [in set_consumer_sockets() at main.c:3561]
FATAL: Module lttng_tracer not found.
Error: Unable to load module lttng-tracer
DEBUG1: Failed to open /proc/lttng [in init_kernel_tracer() at main.c:1864]
Error: Unable to remove module lttng-tracer
Warning: No kernel tracer available
DEBUG2: Creating consumer directory: /var/run/lttng/ustconsumerd64 [in set_consumer_sockets() at main.c:3561]
DEBUG2: Creating consumer directory: /var/run/lttng/ustconsumerd32 [in set_consumer_sockets() at main.c:3561]
DEBUG1: Signal handler set for SIGTERM, SIGPIPE and SIGINT [in set_signal_handler() at main.c:3653]
Warning: No tracing group detected
DEBUG1: epoll set max size is 403271 [in compat_epoll_set_max_size() at compat-epoll.c:224]
DEBUG1: Command subsystem initialized [in cmd_init() at cmd.c:2343]
DEBUG1: [thread] Manage health check started [in thread_manage_health() at main.c:2827]
DEBUG1: [thread] Manage client started [in thread_manage_clients() at main.c:3009]
DEBUG1: Health check ready [in thread_manage_health() at main.c:2860]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: [thread] Dispatch UST command started [in thread_dispatch_ust_registration() at main.c:1240]
DEBUG1: Futex n to 1 prepare done [in futex_nto1_prepare() at futex.c:75]
DEBUG1: Woken up but nothing in the UST command queue [in thread_dispatch_ust_registration() at main.c:1250]
DEBUG1: [thread] Manage application registration started [in thread_registration_apps() at main.c:1308]
DEBUG1: Notifying applications of session daemon state: 1 [in notify_ust_apps() at main.c:494]
DEBUG1: [thread] Manage application started [in thread_manage_apps() at main.c:1066]
DEBUG1: Apps thread polling on 2 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Got the wait shm fd 19 [in get_wait_shm() at shm.c:117]
DEBUG1: Futex wait update active 1 [in futex_wait_update() at futex.c:63]
DEBUG1: Accepting application registration [in thread_registration_apps() at main.c:1341]
DEBUG1: Thread manage kernel started [in thread_manage_kernel() at main.c:690]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 0 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x64b820 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 1 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x64d840 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 2 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x64f860 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 3 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x651880 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 4 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x6538a0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]

SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|testapp'
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21509 7738 0 13:16 pts/0 00:00:00 egrep -i lttng|testapp
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo
> '
UID PID PPID C STIME TTY TIME CMD
root 1 0 0 11:14 ? 00:00:02 init [3]
root 2 0 0 11:14 ? 00:00:00 [kthreadd]
root 3 2 0 11:14 ? 00:00:01 [ksoftirqd/0]
root 4 2 0 11:14 ? 00:00:02 [kworker/0:0]
root 5 2 0 11:14 ? 00:00:00 [kworker/u:0]
root 6 2 0 11:14 ? 00:00:00 [migration/0]
root 7 2 0 11:14 ? 00:00:00 [watchdog/0]
root 8 2 0 11:14 ? 00:00:00 [migration/1]
root 10 2 0 11:14 ? 00:00:00 [ksoftirqd/1]
root 12 2 0 11:14 ? 00:00:00 [watchdog/1]
root 13 2 0 11:14 ? 00:00:00 [migration/2]
root 14 2 0 11:14 ? 00:00:00 [kworker/2:0]
root 15 2 0 11:14 ? 00:00:00 [ksoftirqd/2]
root 16 2 0 11:14 ? 00:00:00 [watchdog/2]
root 17 2 0 11:14 ? 00:00:00 [migration/3]
root 18 2 0 11:14 ? 00:00:00 [kworker/3:0]
root 19 2 0 11:14 ? 00:00:00 [ksoftirqd/3]
root 20 2 0 11:14 ? 00:00:00 [watchdog/3]
root 21 2 0 11:14 ? 00:00:00 [cpuset]
root 22 2 0 11:14 ? 00:00:00 [khelper]
root 23 2 0 11:14 ? 00:00:00 [netns]
root 24 2 0 11:14 ? 00:00:00 [sync_supers]
root 25 2 0 11:14 ? 00:00:00 [bdi-default]
root 26 2 0 11:14 ? 00:00:00 [kintegrityd]
root 27 2 0 11:14 ? 00:00:00 [kblockd]
root 28 2 0 11:14 ? 00:00:00 [md]
root 29 2 0 11:14 ? 00:00:00 [kworker/1:1]
root 30 2 0 11:14 ? 00:00:00 [kworker/3:1]
root 31 2 0 11:14 ? 00:00:00 [kworker/2:1]
root 32 2 0 11:14 ? 00:00:00 [khungtaskd]
root 33 2 0 11:14 ? 00:00:00 [kswapd0]
root 34 2 0 11:14 ? 00:00:00 [ksmd]
root 35 2 0 11:14 ? 00:00:00 [khugepaged]
root 36 2 0 11:14 ? 00:00:00 [fsnotify_mark]
root 37 2 0 11:14 ? 00:00:00 [crypto]
root 39 2 0 11:14 ? 00:00:00 [kthrotld]
root 40 2 0 11:14 ? 00:00:00 [kpsmoused]
root 41 2 0 11:14 ? 00:00:00 [kworker/1:2]
root 118 2 0 11:14 ? 00:00:00 [xenwatch]
root 119 2 0 11:14 ? 00:00:00 [xenbus]
root 130 1 0 11:14 ? 00:00:00 /sbin/udevd --daemon
root 201 130 0 11:14 ? 00:00:00 /sbin/udevd --daemon
root 233 2 0 11:14 ? 00:00:00 [net_accel]
root 244 2 0 11:14 ? 00:00:00 [kworker/u:1]
root 257 2 0 11:14 ? 00:00:00 [ata_sff]
root 269 2 0 11:14 ? 00:00:00 [scsi_eh_0]
root 270 2 0 11:14 ? 00:00:00 [scsi_eh_1]
root 335 2 0 11:14 ? 00:00:00 [kauditd]
root 799 1 0 11:14 ? 00:00:00 monitord: rpcbind
root 801 799 0 11:14 ? 00:00:00 /sbin/rpcbind -d
106 807 1 0 11:14 ? 00:00:00 /bin/dbus-daemon --system
root 814 1 0 11:14 ? 00:00:00 /usr/sbin/irqbalance
root 882 2 0 11:14 ? 00:00:00 [kjournald]
root 913 2 0 11:14 ? 00:00:00 [kjournald]
root 1445 1 0 11:14 ? 00:00:00 monitord: nscd
root 1446 1445 0 11:14 ? 00:00:00 /usr/sbin/nscd -d
root 1547 1 0 11:14 ? 00:00:00 monitord: syslogd
root 1549 1547 0 11:14 ? 00:00:00 /sbin/syslog-ng -F
root 1613 1 0 11:14 ? 00:00:00 monitord: logrotd
root 1621 1613 0 11:14 ? 00:00:00 /usr/sbin/logrotd
root 1627 1 0 11:14 ? 00:00:00 monitord: lde-alarmd
root 1632 1 0 11:14 ? 00:00:00 monitord: crond
root 1634 1632 0 11:14 ? 00:00:00 /usr/sbin/cron -n
root 1635 1 0 11:14 ? 00:00:00 monitord: noded
root 1638 1635 0 11:14 ? 00:00:00 /usr/sbin/noded
root 1639 1627 0 11:14 ? 00:00:02 /usr/sbin/alarmd -d ERIC-LINUX_CONTROL-CXP9013151_3-R1A01 -t control
root 1653 1 0 11:14 ? 00:00:00 monitord: acpid
root 1654 1653 0 11:14 ? 00:00:00 /sbin/acpid -f
root 1664 1 0 11:14 ? 00:00:00 monitord: failoverd
root 1665 1664 0 11:14 ? 00:00:01 /usr/sbin/failoverd
root 1677 2 0 11:14 ? 00:00:00 [drbd_w_drbd0]
root 1678 130 0 11:14 ? 00:00:00 /sbin/udevd --daemon
root 1684 2 0 11:14 ? 00:00:02 [drbd_r_drbd0]
root 1686 1 0 11:14 ? 00:00:01 /sbin/haveged -w 1024 -v 1
root 1687 2 0 11:14 ? 00:00:01 [drbd_a_drbd0]
root 1741 1 0 11:14 ? 00:00:00 monitord: tftpd.boot_b
nobody 1742 1741 0 11:14 ? 00:00:00 /usr/sbin/tftpd -v --no-fork --daemon --bind-address 192.168.0.104 /cluster
root 1744 1 0 11:14 ? 00:00:00 monitord: ntpd
ntp 1746 1744 0 11:14 ? 00:00:00 /usr/sbin/ntpd -n -u ntp:ntp
root 1799 1 0 11:14 ? 00:00:00 monitord: inetd
root 1802 1799 0 11:14 ? 00:00:00 /usr/sbin/xinetd -dontfork
root 1816 1 0 11:14 ? 00:00:00 monitord: sshd
root 1818 1816 0 11:14 ? 00:00:00 /usr/sbin/sshd -D
root 1822 1 0 11:14 ? 00:00:00 monitord: sshd_internal
root 1825 1822 0 11:14 ? 00:00:00 /usr/sbin/sshd -D -f /etc/ssh/sshd_config_internal
root 1855 2 0 11:14 ? 00:00:00 [rpciod]
root 1865 2 0 11:14 ? 00:00:00 [nfsiod]
root 1915 1 0 11:14 ? 00:00:00 monitord: dumpd
root 1922 1915 0 11:14 ? 00:00:00 /usr/sbin/dumpd
root 1958 1 0 11:14 ? 00:00:00 monitord: watchdogd
root 1959 1958 0 11:14 ? 00:00:00 /usr/sbin/watchdogd
108 1971 1 0 11:14 ? 00:00:00 /usr/sbin/hald --daemon=yes
root 1979 1971 0 11:14 ? 00:00:00 hald-runner
root 1998 1 0 11:14 ? 00:00:00 monitord: userd
root 2002 1998 0 11:14 ? 00:00:02 /usr/sbin/userd
root 2011 1 0 11:14 ? 00:00:00 monitord: dhcpd
root 2012 2011 0 11:14 ? 00:00:00 /usr/sbin/dhcpd -q -f eth0
root 2019 1 0 11:14 ? 00:00:00 monitord: syncd
root 2020 2019 0 11:14 ? 00:00:02 /usr/sbin/syncd -c
root 2117 1979 0 11:14 ? 00:00:00 hald-addon-input: Listening on /dev/input/event0 /dev/input/event3 /dev/input/event2
108 2142 1979 0 11:14 ? 00:00:00 hald-addon-acpi: listening on acpid socket /var/run/acpid.socket
root 5928 1 0 11:14 ? 00:00:00 /bin/bash /etc/start.d/ordered/S01opensaf_log_sync
root 6308 1 0 11:14 ? 00:00:00 /bin/bash /usr/lib64/opensaf/nid_tipc start eth0 4711
root 6333 1 0 11:14 ? 00:00:00 /usr/lib64/opensaf/osafrded
root 6342 1 0 11:14 ? 00:00:00 /usr/lib64/opensaf/osaffmd
root 6351 1 0 11:14 ? 00:00:00 /usr/lib64/opensaf/osafimmd
root 6361 1 0 11:14 ? 00:00:01 /usr/lib64/opensaf/osafimmnd
root 6370 1 0 11:14 ? 00:00:00 /usr/lib64/opensaf/osaflogd
root 6380 1 0 11:14 ? 00:00:00 /usr/lib64/opensaf/osafntfd
root 6390 1 0 11:14 ? 00:00:00 /usr/lib64/opensaf/osafclmd
root 6409 1 0 11:14 ? 00:00:00 /usr/lib64/opensaf/osafamfd
root 6420 1 0 11:15 ? 00:00:01 /usr/lib64/opensaf/osafamfnd
root 6480 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafckptnd
root 6496 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafamfwd
root 6501 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafsmfd
root 6507 1 0 11:15 tty1 00:00:00 /sbin/mingetty --noclear tty1
root 6508 1 0 11:15 tty2 00:00:00 /sbin/mingetty tty2
root 6509 1 0 11:15 tty3 00:00:00 /sbin/mingetty tty3
root 6510 1 0 11:15 tty4 00:00:00 /sbin/mingetty tty4
root 6511 1 0 11:15 tty5 00:00:00 /sbin/mingetty tty5
root 6513 1 0 11:15 tty6 00:00:00 /sbin/mingetty tty6
root 6514 1 0 11:15 ttyS0 00:00:00 /sbin/agetty -L 115200 ttyS0 vt100
root 6529 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafsmfnd
root 6541 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafpmnd
root 6551 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafpmd
root 6561 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafckptd
root 6576 1 0 11:15 ? 00:00:00 /usr/lib64/opensaf/osafdtd
root 7729 1818 0 11:20 ? 00:00:00 sshd: root@pts/0
root 7738 7729 0 11:20 pts/0 00:00:00 -bash
root 8137 1818 0 11:21 ? 00:00:00 sshd: root@pts/1
root 8144 8137 0 11:21 pts/1 00:00:00 -bash
root 13593 1 0 11:28 ? 00:00:00 /opt/coremw/lib/ecimswm instantiate
root 13609 1 0 11:28 ? 00:00:07 /opt/coremw/lib/clustermonitor instantiate
root 13659 1 0 11:28 ? 00:00:00 /opt/coremw/lib/cmwmdf_gcc SC-1
root 13675 1 0 11:28 ? 00:00:00 /opt/coremw/lib/cmwpm instantiate
root 13731 1 0 11:28 ? 00:00:00 /opt/coremw/lib/cmwmdf_immcc SC-1
root 14311 1 0 11:29 ? 00:00:01 /opt/trace_ea/bin/TraceEa
root 14334 14311 0 11:29 ? 00:00:00 /opt/trace_ea/bin/TraceEa
root 17443 2 0 12:10 ? 00:00:00 [kworker/0:2]
root 19874 2 0 12:51 ? 00:00:00 [flush-202:0]
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21259 8144 0 13:12 pts/1 00:00:00 tail -f /var/log/messages
root 21433 5928 0 13:15 ? 00:00:00 sleep 120
root 21515 6308 0 13:16 ? 00:00:00 sleep 15
root 21518 7738 0 13:16 pts/0 00:00:00 ps -ef
root 21519 7738 0 13:16 pts/0 00:00:00 egrep -i lttng|demo?
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21523 7738 0 13:16 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # more /home/test_apps/demo-trace
#!/bin/sh

LD_PRELOAD=/home/test_apps/liblttng-ust-provider-ust-tests-demo.so:/home/test_apps/liblttng-ust-provider-ust-tests-demo3.so /home/test_apps/demo ${*}
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # /home/test_apps/demo-trace 500 np &
[2] 21561
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG1: UST registration received with pid:21562 ppid:21561 uid:0 gid:0 sock:20 name:demo (version 2.0) [in thread_registration_apps() at main.c:1435]
DEBUG1: Futex n to 1 wake done [in futex_nto1_wake() at futex.c:104]
DEBUG1: Accepting application registration [in thread_registration_apps() at main.c:1341]
DEBUG1: Futex n to 1 wait done [in futex_nto1_wait() at futex.c:90]
DEBUG1: Futex n to 1 prepare done [in futex_nto1_prepare() at futex.c:75]
DEBUG1: Dispatching UST registration pid:21562 ppid:21561 uid:0 gid:0 sock:20 name:demo (version 2.0) [in thread_dispatch_ust_registration() at main.c:1262]
DEBUG1: Woken up but nothing in the UST command queue [in thread_dispatch_ust_registration() at main.c:1250]
DEBUG3: Created hashtable size 4 at 0x641430 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG1: App registered with pid:21562 ppid:21561 uid:0 gid:0 sock:20 name:demo (version 2.0) [in ust_app_register() at ust-app.c:1474]
DEBUG2: UST app PID 21562 is compatible with internal major version 3 (supporting == 3) [in ust_app_validate_version() at ust-app.c:2934]
DEBUG1: Apps with sock 20 added to poll set [in thread_manage_apps() at main.c:1186]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
Demo program starting.
Tracing... done.
DEBUG1: PID 21562 unregistering with sock 20 [in ust_app_unregister() at ust-app.c:1504]
DEBUG1: Apps thread polling on 2 fds [in thread_manage_apps() at main.c:1095]
DEBUG3: Call RCU deleting app PID 21562 [in delete_ust_app_rcu() at ust-app.c:240]
DEBUG2: UST app pid 21562 deleted [in delete_ust_app() at ust-app.c:223]

[2]+ Done /home/test_apps/demo-trace 500 np
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 5 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x6413c0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]

SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21587 7738 0 13:17 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # /home/test_apps/demo-trace 500 &
[2] 21592
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG1: UST registration received with pid:21593 ppid:21592 uid:0 gid:0 sock:20 name:demo (version 2.0) [in thread_registration_apps() at main.c:1435]
DEBUG1: Futex n to 1 wake done [in futex_nto1_wake() at futex.c:104]
DEBUG1: Accepting application registration [in thread_registration_apps() at main.c:1341]
DEBUG1: Futex n to 1 wait done [in futex_nto1_wait() at futex.c:90]
DEBUG1: Futex n to 1 prepare done [in futex_nto1_prepare() at futex.c:75]
DEBUG1: Dispatching UST registration pid:21593 ppid:21592 uid:0 gid:0 sock:20 name:demo (version 2.0) [in thread_dispatch_ust_registration() at main.c:1262]
DEBUG1: Woken up but nothing in the UST command queue [in thread_dispatch_ust_registration() at main.c:1250]
DEBUG3: Created hashtable size 4 at 0x641930 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG1: App registered with pid:21593 ppid:21592 uid:0 gid:0 sock:20 name:demo (version 2.0) [in ust_app_register() at ust-app.c:1474]
DEBUG2: UST app PID 21593 is compatible with internal major version 3 (supporting == 3) [in ust_app_validate_version() at ust-app.c:2934]
DEBUG1: Apps with sock 20 added to poll set [in thread_manage_apps() at main.c:1186]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
Demo program starting.

SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng list -u
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 14 [in process_client_msg() at main.c:2094]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG2: UST app list events done (4 events) [in ust_app_list_events() at ust-app.c:1604]
DEBUG1: Sending response (size: 2352, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
UST events:
-------------

PID: 21593 - Name: /home/test_apps/demo
ust_tests_demo2:loop (loglevel: TRACE_WARNING (4)) (type: tracepoint)
ust_tests_demo:done (loglevel: TRACE_CRIT (2)) (type: tracepoint)
ust_tests_demo:starting (loglevel: TRACE_CRIT (2)) (type: tracepoint)
ust_tests_demo3:done (loglevel: TRACE_WARNING (4)) (type: tracepoint)

SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng list
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 13 [in process_client_msg() at main.c:2094]
DEBUG1: Counting number of available session for UID 0 GID 0 [in lttng_sessions_count() at main.c:2065]
DEBUG1: Getting all available session for UID 0 GID 0 [in cmd_list_lttng_sessions() at cmd.c:2024]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
Currently no available tracing session
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng create s1
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session s1 created in (null) with ID 6 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x642d50 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /root/lttng-traces/s1-20121010-131815 [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
Session s1 created.
Traces will be written in /root/lttng-traces/s1-20121010-131815
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 7 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x642ff0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng list s1
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 13 [in process_client_msg() at main.c:2094]
DEBUG1: Counting number of available session for UID 0 GID 0 [in lttng_sessions_count() at main.c:2065]
DEBUG1: Getting all available session for UID 0 GID 0 [in cmd_list_lttng_sessions() at cmd.c:2024]
DEBUG1: Sending response (size: 4388, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
Tracing session s1: [inactive]
Trace path: /root/lttng-traces/s1-20121010-131815

DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 11 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session s1 by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng enable-event ust_tests_demo2:loop -u
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 6 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session s1 by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG1: Creating UST session [in create_ust_session() at main.c:1981]
DEBUG3: Created hashtable size 4 at 0x642ff0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Created hashtable size 4 at 0x6432b0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Created hashtable size 4 at 0x65ba00 of type 0 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Created hashtable size 4 at 0x660d00 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: UST trace session create successful [in trace_ust_create_session() at trace-ust.c:143]
DEBUG3: Copying tracing session consumer output in UST session [in copy_session_consumer() at main.c:1936]
DEBUG3: Created hashtable size 4 at 0x666000 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Created hashtable size 4 at 0x6662a0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Copy session consumer subdir /ust [in copy_session_consumer() at main.c:1951]
DEBUG1: Spawning consumerd [in spawn_consumerd() at main.c:1643]
DEBUG2: Consumer pid 21659 [in start_consumerd() at main.c:1814]
DEBUG2: Spawning consumer control thread [in start_consumerd() at main.c:1817]
DEBUG1: [thread] Manage consumer started [in thread_manage_consumer() at main.c:838]
DEBUG1: Using 64-bit UST consumer at: /usr/lib64/lttng/libexec/lttng-consumerd [in spawn_consumerd() at main.c:1717]
DEBUG2: Receiving code from consumer err_sock [in thread_manage_consumer() at main.c:913]
DEBUG1: Consumer command socket ready [in thread_manage_consumer() at main.c:934]
DEBUG3: Consumer socket created (fd: 24) and added to output [in consumer_create_socket() at consumer.c:141]
DEBUG2: Trace UST channel channel0 not found by name [in trace_ust_find_channel_by_name() at trace-ust.c:52]
DEBUG1: Enabling channel channel0 for session s1 [in cmd_enable_channel() at cmd.c:744]
DEBUG2: Trace UST channel channel0 not found by name [in trace_ust_find_channel_by_name() at trace-ust.c:52]
DEBUG3: Created hashtable size 4 at 0x667a40 of type 0 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Created hashtable size 4 at 0x667ce0 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Trace UST channel channel0 created [in trace_ust_create_channel() at trace-ust.c:205]
DEBUG2: Channel channel0 being created in UST global domain [in channel_ust_create() at channel.c:267]
DEBUG2: UST app adding channel channel0 to global domain for session id 6 [in ust_app_create_channel_glb() at ust-app.c:1985]
DEBUG2: UST app pid: 21593 session id 6 not found, creating it [in create_ust_app_session() at ust-app.c:964]
DEBUG3: Created hashtable size 4 at 0x668fe0 of type 0 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Shadow copy of session handle -1 [in shadow_copy_session() at ust-app.c:873]
DEBUG2: UST app session created successfully with handle 2 [in create_ust_app_session() at ust-app.c:990]
DEBUG3: Created hashtable size 4 at 0x66a050 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: Created hashtable size 4 at 0x66a2f0 of type 0 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: UST app channel channel0 allocated [in alloc_ust_app_channel() at ust-app.c:301]
DEBUG2: UST app shadow copy of channel channel0 started [in shadow_copy_channel() at ust-app.c:813]
DEBUG3: UST app shadow copy of channel channel0 done [in shadow_copy_channel() at ust-app.c:850]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG2: UST app channel channel0 created successfully for pid:21593 and sock:20 [in create_ust_channel() at ust-app.c:682]
DEBUG2: UST app create channel channel0 for PID 21593 completed [in create_ust_app_channel() at ust-app.c:1240]
DEBUG2: Channel channel0 created successfully [in channel_ust_create() at channel.c:292]
DEBUG2: Trace UST channel channel0 found by name [in trace_ust_find_channel_by_name() at trace-ust.c:47]
DEBUG2: Trace UST event NOT found by name ust_tests_demo2:loop [in trace_ust_find_event_by_name() at trace-ust.c:79]
DEBUG3: Created hashtable size 4 at 0x66a810 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Trace UST event ust_tests_demo2:loop, loglevel (0,-1) created [in trace_ust_create_event() at trace-ust.c:284]
DEBUG1: UST app creating event ust_tests_demo2:loop for all apps for session id 6 [in ust_app_create_event_glb() at ust-app.c:2109]
DEBUG3: Created hashtable size 4 at 0x66ae40 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG3: UST app event ust_tests_demo2:loop allocated [in alloc_ust_app_event() at ust-app.c:336]
DEBUG2: UST app event ust_tests_demo2:loop created successfully for pid:21593 [in create_ust_event() at ust-app.c:726]
DEBUG2: UST app create event ust_tests_demo2:loop for PID 21593 completed [in create_ust_app_event() at ust-app.c:1291]
DEBUG1: Event UST ust_tests_demo2:loop created in channel channel0 [in event_ust_enable_tracepoint() at event.c:486]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
UST event ust_tests_demo2:loop created in channel channel0
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng list s1
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 13 [in process_client_msg() at main.c:2094]
DEBUG1: Counting number of available session for UID 0 GID 0 [in lttng_sessions_count() at main.c:2065]
DEBUG1: Getting all available session for UID 0 GID 0 [in cmd_list_lttng_sessions() at cmd.c:2024]
DEBUG1: Sending response (size: 4388, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
Tracing session s1: [inactive]
Trace path: /root/lttng-traces/s1-20121010-131815

DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 11 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session s1 by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG3: Listing domains found UST global domain [in cmd_list_domains() at cmd.c:1888]
DEBUG1: Sending response (size: 324, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
=== Domain: UST global ===

DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 10 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session s1 by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG3: Consumer socket created (fd: 24) and added to output [in consumer_create_socket() at consumer.c:141]
DEBUG3: Number of UST global channels 1 [in cmd_list_channels() at cmd.c:1940]
DEBUG1: Listing channels for session s1 [in list_lttng_channels() at cmd.c:124]
DEBUG1: Sending response (size: 624, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
Channels:
-------------
- channel0: [enabled]

Attributes:
overwrite mode: 0
subbufers size: 4096
number of subbufers: 4
switch timer interval: 0
read timer interval: 200
output: mmap()
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 12 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session s1 by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG3: Consumer socket created (fd: 24) and added to output [in consumer_create_socket() at consumer.c:141]
DEBUG1: Listing UST global events for channel channel0 [in list_lttng_ust_global_events() at cmd.c:184]
DEBUG3: Listing UST global 1 events [in list_lttng_ust_global_events() at cmd.c:204]
DEBUG1: Sending response (size: 600, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]

Events:
ust_tests_demo2:loop (type: tracepoint) [enabled]

SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng start
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 16 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session s1 by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name s1 [in session_find_by_name() at session.c:122]
DEBUG2: Setting relayd for session s1 [in setup_relayd() at cmd.c:630]
DEBUG1: Starting all UST traces [in ust_app_start_trace_all() at ust-app.c:2452]
DEBUG1: Starting tracing for ust app pid 21593 [in ust_app_start_trace() at ust-app.c:2163]
DEBUG3: mkdir() recursive /root/lttng-traces/s1-20121010-131815 with mode 504 for uid 0 and gid 0 [in run_as_mkdir_recursive() at runas.c:342]
DEBUG1: Using run_as_clone [in run_as() at runas.c:325]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG2: UST metadata opened for app pid 21593 [in create_ust_app_metadata() at ust-app.c:1332]
DEBUG1: Apps thread polling on 3 fds [in thread_manage_apps() at main.c:1095]
DEBUG2: UST metadata stream object created for app pid 21593 [in create_ust_app_metadata() at ust-app.c:1350]
DEBUG2: UST stream 1 ready (handle: 7) [in ust_app_start_trace() at ust-app.c:2253]
DEBUG2: UST stream 2 ready (handle: 8) [in ust_app_start_trace() at ust-app.c:2253]
DEBUG2: UST stream 3 ready (handle: 9) [in ust_app_start_trace() at ust-app.c:2253]
DEBUG2: UST stream 4 ready (handle: 10) [in ust_app_start_trace() at ust-app.c:2253]
DEBUG1: Sending metadata stream fd to consumer on 24 [in ust_consumer_send_session() at ust-consumer.c:301]
DEBUG1: UST consumer sending metadata stream fd [in send_metadata() at ust-consumer.c:205]
DEBUG3: mkdir() recursive /root/lttng-traces/s1-20121010-131815//ust/demo-21593-20121010-131858/ with mode 504 for uid 0 and gid 0 [in run_as_mkdir_recursive() at runas.c:342]
DEBUG1: Using run_as_clone [in run_as() at runas.c:325]
DEBUG1: Sending streams of channel channel0 to UST consumer [in send_channel_streams() at ust-consumer.c:130]
DEBUG2: Sending channel channel0 to UST consumer [in send_channel() at ust-consumer.c:48]
DEBUG3: UST local consumer tracefile path: /root/lttng-traces/s1-20121010-131815//ust/demo-21593-20121010-131858/ [in send_channel_streams() at ust-consumer.c:147]
DEBUG2: Sending stream 31 of channel channel0 to kernel consumer [in send_channel_stream() at ust-consumer.c:90]
DEBUG2: Sending stream 33 of channel channel0 to kernel consumer [in send_channel_stream() at ust-consumer.c:90]
DEBUG2: Sending stream 35 of channel channel0 to kernel consumer [in send_channel_stream() at ust-consumer.c:90]
DEBUG2: Sending stream 37 of channel channel0 to kernel consumer [in send_channel_stream() at ust-consumer.c:90]
DEBUG1: UST consumer channel streams sent [in send_channel_streams() at ust-consumer.c:171]
DEBUG1: consumer fds (metadata and channel streams) sent [in ust_consumer_send_session() at ust-consumer.c:331]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
Tracing started for session s1
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21592 7738 0 13:17 pts/0 00:00:00 /bin/sh /home/test_apps/demo-trace 500
root 21593 21592 0 13:17 pts/0 00:00:00 /home/test_apps/demo 500
root 21659 21232 0 13:18 pts/0 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
root 21688 7738 0 13:19 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # date
Wed Oct 10 13:19:15 EDT 2012
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21592 7738 0 13:17 pts/0 00:00:00 /bin/sh /home/test_apps/demo-trace 500
root 21593 21592 0 13:17 pts/0 00:00:00 /home/test_apps/demo 500
root 21659 21232 0 13:18 pts/0 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
root 21697 7738 0 13:19 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # date; ps -ef |egrep -i 'lttng|demo'
Wed Oct 10 13:19:27 EDT 2012
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21592 7738 0 13:17 pts/0 00:00:00 /bin/sh /home/test_apps/demo-trace 500
root 21593 21592 0 13:17 pts/0 00:00:00 /home/test_apps/demo 500
root 21659 21232 0 13:18 pts/0 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
root 21710 7738 0 13:19 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Nothing recv() from client... continuing [in thread_manage_clients() at main.c:3134]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 8 [in process_client_msg() at main.c:2094]
DEBUG1: Waiting for 1 URIs from client ... [in process_client_msg() at main.c:2597]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG1: Tracing session _Trace_EA created in (null) with ID 8 by UID 0 GID 0 [in session_create() at session.c:236]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: Created hashtable size 4 at 0x679090 of type 1 [in lttng_ht_new() at hashtable.c:96]
DEBUG2: Setting trace directory path from URI to /tmp/ [in add_uri_to_consumer() at cmd.c:396]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Wait for client response [in thread_manage_clients() at main.c:3091]
DEBUG1: Receiving data from client ... [in thread_manage_clients() at main.c:3130]
DEBUG1: Processing client command 9 [in process_client_msg() at main.c:2094]
DEBUG1: Getting session _Trace_EA by name [in process_client_msg() at main.c:2164]
DEBUG2: Trying to find session by name _Trace_EA [in session_find_by_name() at session.c:122]
DEBUG3: No kernel session when tearing down session [in kernel_destroy_session() at kernel.c:729]
DEBUG1: Destroying session _Trace_EA [in session_destroy() at session.c:149]
DEBUG1: Sending response (size: 16, retcode: Success) [in thread_manage_clients() at main.c:3181]
DEBUG1: Clean command context structure [in clean_command_ctx() at main.c:474]
DEBUG1: Accepting client command ... [in thread_manage_clients() at main.c:3049]
DEBUG1: Updating kernel poll set [in update_kernel_poll() at main.c:555]
DEBUG1: Thread kernel polling on 2 fds [in thread_manage_kernel() at main.c:727]
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21232 7738 0 13:12 pts/0 00:00:00 lttng-sessiond -vvv
root 21592 7738 0 13:17 pts/0 00:00:00 /bin/sh /home/test_apps/demo-trace 500
root 21593 21592 0 13:17 pts/0 00:00:00 /home/test_apps/demo 500
root 21659 21232 0 13:18 pts/0 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
root 21726 7738 0 13:19 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # kill -9 21232
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
[1]- Killed lttng-sessiond -vvv
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21592 7738 0 13:17 pts/0 00:00:00 /bin/sh /home/test_apps/demo-trace 500
root 21593 21592 0 13:17 pts/0 00:00:00 /home/test_apps/demo 500
root 21659 1 0 13:18 pts/0 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
root 21746 7738 0 13:19 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng-sessiond -vvv &
[3] 21776
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG3: Creating LTTng run directory: /var/run/lttng [in create_lttng_rundir() at main.c:3519]
DEBUG2: Kernel consumer err path: /var/run/lttng/kconsumerd/error [in main() at main.c:3767]
DEBUG2: Kernel consumer cmd path: /var/run/lttng/kconsumerd/command [in main() at main.c:3769]
DEBUG1: Client socket path /var/run/lttng/client-lttng-sessiond [in main() at main.c:3822]
DEBUG1: Application socket path /var/run/lttng/apps-lttng-sessiond [in main() at main.c:3823]
DEBUG1: LTTng run directory path: /var/run/lttng [in main() at main.c:3824]
DEBUG2: UST consumer 32 bits err path: /var/run/lttng/ustconsumerd32/error [in main() at main.c:3833]
DEBUG2: UST consumer 32 bits cmd path: /var/run/lttng/ustconsumerd32/command [in main() at main.c:3835]
DEBUG2: UST consumer 64 bits err path: /var/run/lttng/ustconsumerd64/error [in main() at main.c:3844]
DEBUG2: UST consumer 64 bits cmd path: /var/run/lttng/ustconsumerd64/command [in main() at main.c:3846]
Error: Already running daemon.


[3]+ Exit 1 lttng-sessiond -vvv
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # lttng-sessiond -vvv &
[3] 21782
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # DEBUG3: Creating LTTng run directory: /var/run/lttng [in create_lttng_rundir() at main.c:3519]
DEBUG2: Kernel consumer err path: /var/run/lttng/kconsumerd/error [in main() at main.c:3767]
DEBUG2: Kernel consumer cmd path: /var/run/lttng/kconsumerd/command [in main() at main.c:3769]
DEBUG1: Client socket path /var/run/lttng/client-lttng-sessiond [in main() at main.c:3822]
DEBUG1: Application socket path /var/run/lttng/apps-lttng-sessiond [in main() at main.c:3823]
DEBUG1: LTTng run directory path: /var/run/lttng [in main() at main.c:3824]
DEBUG2: UST consumer 32 bits err path: /var/run/lttng/ustconsumerd32/error [in main() at main.c:3833]
DEBUG2: UST consumer 32 bits cmd path: /var/run/lttng/ustconsumerd32/command [in main() at main.c:3835]
DEBUG2: UST consumer 64 bits err path: /var/run/lttng/ustconsumerd64/error [in main() at main.c:3844]
DEBUG2: UST consumer 64 bits cmd path: /var/run/lttng/ustconsumerd64/command [in main() at main.c:3846]
Error: Already running daemon.


[3]+ Exit 1 lttng-sessiond -vvv
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21592 7738 0 13:17 pts/0 00:00:00 /bin/sh /home/test_apps/demo-trace 500
root 21593 21592 0 13:17 pts/0 00:00:00 /home/test_apps/demo 500
root 21659 1 0 13:18 pts/0 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
root 21793 7738 0 13:20 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21592 7738 0 13:17 pts/0 00:00:00 /bin/sh /home/test_apps/demo-trace 500
root 21593 21592 0 13:17 pts/0 00:00:00 /home/test_apps/demo 500
root 21659 1 0 13:18 pts/0 00:00:00 lttng-consumerd --quiet -u --consumerd-cmd-sock /var/run/lttng/ustconsumerd64/command --consumerd-err-sock /var/run/lttng/ustconsumerd64/error
root 21810 7738 0 13:20 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # kill 21593
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # /home/test_apps/demo-trace: line 3: 21593 Terminated LD_PRELOAD=/home/test_apps/liblttng-ust-provider-ust-tests-demo.so:/home/test_apps/liblttng-ust-provider-ust-tests-demo3.so /home/test_apps/demo ${*}

[2]+ Exit 143 /home/test_apps/demo-trace 500
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed # ps -ef |egrep -i 'lttng|demo'
root 21857 1 0 13:20 ? 00:00:00 lttng-sessiond -d
root 21869 7738 0 13:20 pts/0 00:00:00 egrep -i lttng|demo
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
SC-1:/cluster/temp/SDPs/EA_Oct10_wed #
    (1-1/1)