|
DEBUG3 [30806/30806]: Creating LTTng run directory: /var/run/lttng (in create_lttng_rundir() at main.c:3836)
|
|
DEBUG2 [30806/30806]: Kernel consumer err path: /var/run/lttng/kconsumerd/error (in main() at main.c:4116)
|
|
DEBUG2 [30806/30806]: Kernel consumer cmd path: /var/run/lttng/kconsumerd/command (in main() at main.c:4118)
|
|
DEBUG1 [30806/30806]: Client socket path /var/run/lttng/client-lttng-sessiond (in main() at main.c:4171)
|
|
DEBUG1 [30806/30806]: Application socket path /var/run/lttng/lttng-ust-sock-4 (in main() at main.c:4172)
|
|
DEBUG1 [30806/30806]: Application wait path /lttng-ust-wait-4 (in main() at main.c:4173)
|
|
DEBUG1 [30806/30806]: LTTng run directory path: /var/run/lttng (in main() at main.c:4174)
|
|
DEBUG2 [30806/30806]: UST consumer 32 bits err path: /var/run/lttng/ustconsumerd32/error (in main() at main.c:4183)
|
|
DEBUG2 [30806/30806]: UST consumer 32 bits cmd path: /var/run/lttng/ustconsumerd32/command (in main() at main.c:4185)
|
|
DEBUG2 [30806/30806]: UST consumer 64 bits err path: /var/run/lttng/ustconsumerd64/error (in main() at main.c:4194)
|
|
DEBUG2 [30806/30806]: UST consumer 64 bits cmd path: /var/run/lttng/ustconsumerd64/command (in main() at main.c:4196)
|
|
DEBUG3 [30806/30806]: Created hashtable size 4 at 0x6580a0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30806]: Created hashtable size 4 at 0x6585c0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30806]: Created hashtable size 4 at 0x658b00 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30806]: Creating consumer directory: /var/run/lttng/kconsumerd (in set_consumer_sockets() at main.c:3878)
|
|
FATAL: Module lttng_tracer not found.
|
|
Error: Unable to load module lttng-tracer
|
|
DEBUG1 [30806/30806]: Failed to open /proc/lttng (in init_kernel_tracer() at main.c:2110)
|
|
Error: Unable to remove module lttng-tracer
|
|
Warning: No kernel tracer available
|
|
DEBUG2 [30806/30806]: Creating consumer directory: /var/run/lttng/ustconsumerd64 (in set_consumer_sockets() at main.c:3878)
|
|
DEBUG2 [30806/30806]: Creating consumer directory: /var/run/lttng/ustconsumerd32 (in set_consumer_sockets() at main.c:3878)
|
|
DEBUG1 [30806/30806]: Signal handler set for SIGTERM, SIGPIPE and SIGINT (in set_signal_handler() at main.c:3970)
|
|
DEBUG3 [30806/30806]: Session daemon client socket 8 and application socket 9 created (in init_daemon_socket() at main.c:3740)
|
|
Warning: No tracing group detected
|
|
DEBUG3 [30806/30806]: Created hashtable size 4 at 0x659480 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30806]: Global buffer per UID registry initialized (in buffer_reg_init_uid_registry() at buffer-registry.c:98)
|
|
DEBUG3 [30806/30806]: Created hashtable size 4 at 0x6599c0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30806]: Global buffer per PID registry initialized (in buffer_reg_init_pid_registry() at buffer-registry.c:219)
|
|
DEBUG1 [30806/30806]: epoll set max size is 403333 (in compat_epoll_set_max_size() at compat-epoll.c:270)
|
|
DEBUG1 [30806/30806]: Command subsystem initialized (in cmd_init() at cmd.c:2139)
|
|
DEBUG1 [30806/30806]: Pid 30806 written in file /var/run/lttng/lttng-sessiond.pid (in utils_create_pid_file() at utils.c:237)
|
|
DEBUG1 [30806/30809]: [thread] Manage health check started (in thread_manage_health() at main.c:3090)
|
|
DEBUG1 [30806/30810]: [thread] Manage client started (in thread_manage_clients() at main.c:3284)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30809]: Health check ready (in thread_manage_health() at main.c:3129)
|
|
DEBUG1 [30806/30811]: [thread] Dispatch UST command started (in thread_dispatch_ust_registration() at main.c:1349)
|
|
DEBUG1 [30806/30812]: [thread] Manage application registration started (in thread_registration_apps() at main.c:1528)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30812]: Notifying applications of session daemon state: 1 (in notify_ust_apps() at main.c:504)
|
|
DEBUG1 [30806/30813]: [thread] Manage application started (in thread_manage_apps() at main.c:1149)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 2 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG1 [30806/30815]: [thread] Thread manage kernel started (in thread_manage_kernel() at main.c:699)
|
|
DEBUG1 [30806/30815]: Updating kernel poll set (in update_kernel_poll() at main.c:565)
|
|
DEBUG1 [30806/30815]: Thread kernel polling on 2 fds (in thread_manage_kernel() at main.c:744)
|
|
DEBUG1 [30806/30812]: Got the wait shm fd 21 (in get_wait_shm() at shm.c:119)
|
|
DEBUG1 [30806/30812]: Futex wait update active 1 (in futex_wait_update() at futex.c:63)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG1 [30806/30814]: [ust-thread] Manage application notify command (in ust_thread_manage_notify() at ust-thread.c:36)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 2 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31079 ppid:1 uid:0 gid:0 sock:22 name:TestApp_type1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31079 ppid:1 uid:0 gid:0 sock:22 name:TestApp_type1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31079 ppid:1 uid:0 gid:0 sock:23 name:TestApp_type1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG3 [30806/30811]: UST app creating application for socket 22 (in ust_app_create() at ust-app.c:2650)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65abe0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65b120 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31079 ppid:1 uid:0 gid:0 sock:23 name:TestApp_type1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG3 [30806/30811]: UST app notify socket 23 is set (in thread_dispatch_ust_registration() at main.c:1423)
|
|
DEBUG1 [30806/30811]: App registered with pid:31079 ppid:1 uid:0 gid:0 sock:22 name:TestApp_type1 notify_sock:23 (version 4.0) (in ust_app_add() at ust-app.c:2738)
|
|
DEBUG3 [30806/30814]: UST thread notify added sock 23 to pollset (in ust_thread_manage_notify() at ust-thread.c:118)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 3 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30813]: Apps with sock 22 added to poll set (in thread_manage_apps() at main.c:1248)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 3 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31080 ppid:1 uid:0 gid:0 sock:24 name:TestApp_Fork1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31080 ppid:1 uid:0 gid:0 sock:25 name:TestApp_Fork1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31080 ppid:1 uid:0 gid:0 sock:24 name:TestApp_Fork1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG3 [30806/30811]: UST app creating application for socket 24 (in ust_app_create() at ust-app.c:2650)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65b7d0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65bcf0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31080 ppid:1 uid:0 gid:0 sock:25 name:TestApp_Fork1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG3 [30806/30811]: UST app notify socket 25 is set (in thread_dispatch_ust_registration() at main.c:1423)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG1 [30806/30811]: App registered with pid:31080 ppid:1 uid:0 gid:0 sock:24 name:TestApp_Fork1 notify_sock:25 (version 4.0) (in ust_app_add() at ust-app.c:2738)
|
|
DEBUG3 [30806/30814]: UST thread notify added sock 25 to pollset (in ust_thread_manage_notify() at ust-thread.c:118)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 4 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30813]: Apps with sock 24 added to poll set (in thread_manage_apps() at main.c:1248)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 4 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31081 ppid:1 uid:0 gid:0 sock:26 name:TestApp_Thread1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31081 ppid:1 uid:0 gid:0 sock:26 name:TestApp_Thread1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG3 [30806/30811]: UST app creating application for socket 26 (in ust_app_create() at ust-app.c:2650)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65c340 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65c880 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31081 ppid:1 uid:0 gid:0 sock:27 name:TestApp_Thread1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31081 ppid:1 uid:0 gid:0 sock:27 name:TestApp_Thread1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG3 [30806/30811]: UST app notify socket 27 is set (in thread_dispatch_ust_registration() at main.c:1423)
|
|
DEBUG1 [30806/30811]: App registered with pid:31081 ppid:1 uid:0 gid:0 sock:26 name:TestApp_Thread1 notify_sock:27 (version 4.0) (in ust_app_add() at ust-app.c:2738)
|
|
DEBUG3 [30806/30814]: UST thread notify added sock 27 to pollset (in ust_thread_manage_notify() at ust-thread.c:118)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 5 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30813]: Apps with sock 26 added to poll set (in thread_manage_apps() at main.c:1248)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 5 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31088 ppid:31080 uid:0 gid:0 sock:28 name:TestApp_Fork1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG1 [30806/30812]: UST registration received with pid:31088 ppid:31080 uid:0 gid:0 sock:29 name:TestApp_Fork1 (version 4.0) (in thread_registration_apps() at main.c:1661)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31088 ppid:31080 uid:0 gid:0 sock:28 name:TestApp_Fork1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG3 [30806/30811]: UST app creating application for socket 28 (in ust_app_create() at ust-app.c:2650)
|
|
DEBUG1 [30806/30812]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)
|
|
DEBUG1 [30806/30812]: Accepting application registration (in thread_registration_apps() at main.c:1565)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65cfb0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30811]: Created hashtable size 4 at 0x65d4f0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [30806/30811]: Dispatching UST registration pid:31088 ppid:31080 uid:0 gid:0 sock:29 name:TestApp_Fork1 (version 4.0) (in thread_dispatch_ust_registration() at main.c:1374)
|
|
DEBUG3 [30806/30811]: UST app notify socket 29 is set (in thread_dispatch_ust_registration() at main.c:1423)
|
|
DEBUG1 [30806/30811]: App registered with pid:31088 ppid:31080 uid:0 gid:0 sock:28 name:TestApp_Fork1 notify_sock:29 (version 4.0) (in ust_app_add() at ust-app.c:2738)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30811]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)
|
|
DEBUG1 [30806/30811]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)
|
|
DEBUG3 [30806/30814]: UST thread notify added sock 29 to pollset (in ust_thread_manage_notify() at ust-thread.c:118)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 6 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30811]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1362)
|
|
DEBUG1 [30806/30813]: Apps with sock 28 added to poll set (in thread_manage_apps() at main.c:1248)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 6 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 8 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Waiting for 1 URIs from client ... (in process_client_msg() at main.c:2848)
|
|
DEBUG2 [30806/30810]: Trying to find session by name _TraceCValidator_c7vrei (in session_find_by_name() at session.c:132)
|
|
DEBUG1 [30806/30810]: Tracing session _TraceCValidator_c7vrei created with ID 0 by UID 0 GID 0 (in session_create() at session.c:216)
|
|
DEBUG2 [30806/30810]: Trying to find session by name _TraceCValidator_c7vrei (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x666e60 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Setting trace directory path from URI to /tmp/_TraceCValidator_c7vrei (in add_uri_to_consumer() at cmd.c:427)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 5 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session _TraceCValidator_c7vrei by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name _TraceCValidator_c7vrei (in session_find_by_name() at session.c:132)
|
|
DEBUG1 [30806/30810]: Creating UST session (in create_ust_session() at main.c:2243)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x65fc70 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6601b0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: UST trace session create successful (in trace_ust_create_session() at trace-ust.c:226)
|
|
DEBUG3 [30806/30810]: Copying tracing session consumer output in UST session (in copy_session_consumer() at main.c:2193)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6601b0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Copy session consumer subdir /ust (in copy_session_consumer() at main.c:2211)
|
|
DEBUG1 [30806/30810]: Spawning consumerd (in spawn_consumerd() at main.c:1870)
|
|
DEBUG2 [30806/30810]: Consumer pid 31281 (in start_consumerd() at main.c:2053)
|
|
DEBUG2 [30806/30810]: Spawning consumer control thread (in start_consumerd() at main.c:2056)
|
|
DEBUG1 [30806/31282]: [thread] Manage consumer started (in thread_manage_consumer() at main.c:865)
|
|
DEBUG1 [31281/31281]: Using 64-bit UST consumer at: /usr/lib64/lttng/libexec/lttng-consumerd (in spawn_consumerd() at main.c:1945)
|
|
DEBUG1 [31281/31281]: epoll set max size is 403333 (in compat_epoll_set_max_size() at compat-epoll.c:270)
|
|
DEBUG3 [31281/31281]: Created hashtable size 4 at 0x62a030 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [31281/31281]: Created hashtable size 4 at 0x62a570 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [31281/31281]: Created hashtable size 4 at 0x62aab0 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [31281/31281]: Created hashtable size 4 at 0x62aff0 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [31281/31281]: Connecting to error socket /var/run/lttng/ustconsumerd64/error (in main() at lttng-consumerd.c:361)
|
|
DEBUG2 [30806/31282]: Receiving code from consumer err_sock (in thread_manage_consumer() at main.c:950)
|
|
DEBUG3 [31281/31283]: Created hashtable size 4 at 0x62b860 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [31281/31283]: Thread channel poll started (in consumer_thread_channel_poll() at consumer.c:2650)
|
|
DEBUG1 [31281/31283]: Channel main loop started (in consumer_thread_channel_poll() at consumer.c:2665)
|
|
DEBUG1 [31281/31283]: Channel poll wait with 1 fd(s) (in consumer_thread_channel_poll() at consumer.c:2674)
|
|
DEBUG1 [31281/31286]: Creating command socket /var/run/lttng/ustconsumerd64/command (in consumer_thread_sessiond_poll() at consumer.c:2852)
|
|
DEBUG3 [31281/31284]: Created hashtable size 4 at 0x7fd7580008b0 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [31281/31284]: Thread metadata poll started (in consumer_thread_metadata_poll() at consumer.c:2124)
|
|
DEBUG3 [31281/31285]: Created hashtable size 4 at 0x62c0a0 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG1 [31281/31284]: Metadata main loop started (in consumer_thread_metadata_poll() at consumer.c:2139)
|
|
DEBUG1 [31281/31284]: Metadata poll wait with 1 fd(s) (in consumer_thread_metadata_poll() at consumer.c:2148)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 1 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31286]: Sending ready command to lttng-sessiond (in consumer_thread_sessiond_poll() at consumer.c:2865)
|
|
DEBUG1 [30806/31282]: Consumer command socket ready (fd: 33 (in thread_manage_consumer() at main.c:984)
|
|
DEBUG1 [30806/31282]: Consumer metadata socket ready (fd: 34) (in thread_manage_consumer() at main.c:986)
|
|
DEBUG1 [31281/31286]: Connection on client_socket (in consumer_thread_sessiond_poll() at consumer.c:2888)
|
|
DEBUG1 [31281/31286]: Metadata connection on client_socket (in set_metadata_socket() at consumer.c:2821)
|
|
DEBUG1 [30806/30810]: Setting relayd for session _TraceCValidator_c7vrei (in cmd_setup_relayd() at cmd.c:671)
|
|
DEBUG1 [30806/30810]: Enabling channel channel0 for session _TraceCValidator_c7vrei (in cmd_enable_channel() at cmd.c:857)
|
|
DEBUG2 [30806/30810]: Trace UST channel channel0 not found by name (in trace_ust_find_channel_by_name() at trace-ust.c:140)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x660bb0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6610f0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Trace UST channel channel0 created (in trace_ust_create_channel() at trace-ust.c:283)
|
|
DEBUG2 [30806/30810]: Channel channel0 is being created for UST with buffer 1 and id 0 (in channel_ust_create() at channel.c:309)
|
|
DEBUG2 [30806/30810]: UST app adding channel channel0 to UST domain for session id 0 (in ust_app_create_channel_glb() at ust-app.c:3382)
|
|
DEBUG2 [30806/30810]: UST app pid: 31079 session id 0 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x661630 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66df20 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID created id: 0, ABI: 64, uid: 0, domain: 2 (in buffer_reg_uid_create() at buffer-registry.c:143)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID adding to global registry with id: 0 (in buffer_reg_uid_add() at buffer-registry.c:165)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66e2f0 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Append to metadata: "typealias integer { size = 8; align = 8; signed = false; } := uint8_t;
|
|
typealias integer { size = 16; align = 8; signed = false; } := uint16_t;
|
|
typealias integer { size = 32; align = 8; signed = false; } := uint32_t;
|
|
typealias integer { size = 64; align = 8; signed = false; } := uint64_t;
|
|
typealias integer { size = 64; align = 8; signed = false; } := unsigned long;
|
|
typealias integer { size = 5; align = 1; signed = false; } := uint5_t;
|
|
typealias integer { size = 27; align = 1; signed = false; } := uint27_t;
|
|
|
|
trace {
|
|
major = 1;
|
|
minor = 8;
|
|
uuid = "03fd55ec-b7ae-45c2-8b89-c1c11385e305";
|
|
byte_order = le;
|
|
packet.header := struct {
|
|
uint32_t magic;
|
|
uint8_t uuid[16];
|
|
uint32_t stream_id;
|
|
};
|
|
};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "env {
|
|
hostname = "SC-1";
|
|
domain = "ust";
|
|
tracer_name = "lttng-ust";
|
|
tracer_major = 2;
|
|
tracer_minor = 2;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "clock {
|
|
name = monotonic;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: " uuid = "9f660b0c-489c-454b-a5f4-eb26059e33af";
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: " description = "Monotonic Clock";
|
|
freq = 1000000000; /* Frequency, in Hz */
|
|
/* clock value offset from Epoch is: offset * (1/freq) */
|
|
offset = 1367613046741138224;
|
|
};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "typealias integer {
|
|
size = 27; align = 1; signed = false;
|
|
map = clock.monotonic.value;
|
|
} := uint27_clock_monotonic_t;
|
|
|
|
typealias integer {
|
|
size = 32; align = 8; signed = false;
|
|
map = clock.monotonic.value;
|
|
} := uint32_clock_monotonic_t;
|
|
|
|
typealias integer {
|
|
size = 64; align = 8; signed = false;
|
|
map = clock.monotonic.value;
|
|
} := uint64_clock_monotonic_t;
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "struct packet_context {
|
|
uint64_clock_monotonic_t timestamp_begin;
|
|
uint64_clock_monotonic_t timestamp_end;
|
|
uint64_t content_size;
|
|
uint64_t packet_size;
|
|
unsigned long events_discarded;
|
|
uint32_t cpu_id;
|
|
};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "struct event_header_compact {
|
|
enum : uint5_t { compact = 0 ... 30, extended = 31 } id;
|
|
variant <id> {
|
|
struct {
|
|
uint27_clock_monotonic_t timestamp;
|
|
} compact;
|
|
struct {
|
|
uint32_t id;
|
|
uint64_clock_monotonic_t timestamp;
|
|
} extended;
|
|
} v;
|
|
} align(8);
|
|
|
|
struct event_header_large {
|
|
enum : uint16_t { compact = 0 ... 65534, extended = 65535 } id;
|
|
variant <id> {
|
|
struct {
|
|
uint32_clock_monotonic_t timestamp;
|
|
} compact;
|
|
struct {
|
|
uint32_t id;
|
|
uint64_clock_monotonic_t timestamp;
|
|
} extended;
|
|
} v;
|
|
} align(8);
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: UST app buffer registry per UID created successfully (in setup_buffer_reg_uid() at ust-app.c:1600)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66ea40 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66ef80 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app creating buffer registry channel for channel0 (in create_buffer_reg_channel() at ust-app.c:2076)
|
|
DEBUG3 [30806/30810]: Buffer registry channel create with key: 0 (in buffer_reg_channel_create() at buffer-registry.c:324)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6707b0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Asking UST consumer for channel (in ask_channel_creation() at ust-consumer.c:118)
|
|
DEBUG3 [30806/30810]: mkdir() recursive /tmp/_TraceCValidator_c7vrei/ust/uid/0/64-bit with mode 504 for uid 0 and gid 0 (in run_as_mkdir_recursive() at runas.c:306)
|
|
DEBUG1 [30806/30810]: Using run_as_clone (in run_as() at runas.c:289)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 0 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: Allocated channel (key 1) (in consumer_allocate_channel() at consumer.c:879)
|
|
DEBUG3 [31281/31286]: Creating channel to ustctl with attr: [overwrite: 0, subbuf_size: 4096, num_subbuf: 4, switch_timer_interval: 0, read_timer_interval: 0, output: 0, type: 0 (in create_ust_channel() at ust-consumer.c:342)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_0 (key 24, chan_key 1 relayd_id 18446744073709551615, session_id 0 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG3 [31281/31286]: open() /tmp/_TraceCValidator_c7vrei/ust/uid/0/64-bit/channel0_0 with flags 241 mode 432 for uid 0 and gid 0 (in run_as_open() at runas.c:334)
|
|
DEBUG1 [31281/31286]: Using run_as_clone (in run_as() at runas.c:289)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_0 (key: 24) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_1 (key 27, chan_key 1 relayd_id 18446744073709551615, session_id 0 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG3 [31281/31286]: open() /tmp/_TraceCValidator_c7vrei/ust/uid/0/64-bit/channel0_1 with flags 241 mode 432 for uid 0 and gid 0 (in run_as_open() at runas.c:334)
|
|
DEBUG1 [31281/31286]: Using run_as_clone (in run_as() at runas.c:289)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_1 (key: 27) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_2 (key 30, chan_key 1 relayd_id 18446744073709551615, session_id 0 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG3 [31281/31286]: open() /tmp/_TraceCValidator_c7vrei/ust/uid/0/64-bit/channel0_2 with flags 241 mode 432 for uid 0 and gid 0 (in run_as_open() at runas.c:334)
|
|
DEBUG1 [31281/31286]: Using run_as_clone (in run_as() at runas.c:289)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_2 (key: 30) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_3 (key 33, chan_key 1 relayd_id 18446744073709551615, session_id 0 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG3 [31281/31286]: open() /tmp/_TraceCValidator_c7vrei/ust/uid/0/64-bit/channel0_3 with flags 241 mode 432 for uid 0 and gid 0 (in run_as_open() at runas.c:334)
|
|
DEBUG1 [31281/31286]: Using run_as_clone (in run_as() at runas.c:289)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_3 (key: 33) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG1 [31281/31286]: UST consumer channel added (key: 1) (in add_channel() at ust-consumer.c:105)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [31281/31283]: Channel event catched in thread (in consumer_thread_channel_poll() at consumer.c:2676)
|
|
DEBUG1 [31281/31283]: Adding channel 20 to poll set (in consumer_thread_channel_poll() at consumer.c:2718)
|
|
DEBUG1 [31281/31283]: Channel poll wait with 2 fd(s) (in consumer_thread_channel_poll() at consumer.c:2674)
|
|
DEBUG2 [30806/30810]: UST ask channel 1 successfully done with 4 stream(s) (in ask_channel_creation() at ust-consumer.c:180)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: UST consumer sending channel channel0 to sessiond (in send_sessiond_channel() at ust-consumer.c:398)
|
|
DEBUG1 [31281/31286]: UST consumer NULL stream sent to sessiond (in send_sessiond_channel() at ust-consumer.c:439)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 24 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 2 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 27 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 3 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 30 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 4 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 33 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG2 [30806/30810]: UST app stream 1 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG2 [30806/30810]: UST app stream 2 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG2 [30806/30810]: UST app stream 3 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG2 [30806/30810]: UST app stream 4 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG3 [30806/30810]: UST app consumer has no more stream available (in ust_consumer_get_channel() at ust-consumer.c:274)
|
|
DEBUG2 [30806/30810]: UST app setup buffer registry channel for channel0 (in setup_buffer_reg_channel() at ust-app.c:2123)
|
|
DEBUG2 [30806/30810]: UST app setup buffer registry stream (in setup_buffer_reg_streams() at ust-app.c:2031)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 22 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 22 pid 31079 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31079 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: UST app pid: 31088 session id 0 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6715a0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x671cf0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6737e0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 28 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 28 pid 31088 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31088 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: UST app pid: 31080 session id 0 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x674220 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x675ea0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x676350 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 24 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 24 pid 31080 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31080 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: UST app pid: 31081 session id 0 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x677c80 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x678340 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x678820 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 26 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 26 pid 31081 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31081 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: Channel channel0 created successfully (in channel_ust_create() at channel.c:333)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 9 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session _TraceCValidator_c7vrei by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name _TraceCValidator_c7vrei (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: No kernel session when tearing down session (in kernel_destroy_session() at kernel.c:739)
|
|
DEBUG1 [30806/30810]: Destroy all UST traces (in ust_app_destroy_trace_all() at ust-app.c:3959)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31079 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 1 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31088 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 2 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31080 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 3 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31081 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 4 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG2 [30806/30810]: Trace UST destroy session 0 (in trace_ust_destroy_session() at trace-ust.c:631)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID destroy with id: 0, ABI: 64, uid: 0 (in buffer_reg_uid_destroy() at buffer-registry.c:621)
|
|
DEBUG1 [30806/30810]: Destroying session _TraceCValidator_c7vrei (in session_destroy() at session.c:157)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30815]: Updating kernel poll set (in update_kernel_poll() at main.c:565)
|
|
DEBUG1 [30806/30815]: Thread kernel polling on 2 fds (in thread_manage_kernel() at main.c:744)
|
|
DEBUG2 [30806/31293]: Trace destroy UST channel channel0 (in _trace_ust_destroy_channel() at trace-ust.c:545)
|
|
DEBUG3 [30806/31293]: Buffer registry session destroy (in buffer_reg_session_destroy() at buffer-registry.c:540)
|
|
DEBUG3 [30806/31293]: Buffer registry channel destroy with key 0 and handle -1 (in buffer_reg_channel_destroy() at buffer-registry.c:496)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG1 [31281/31283]: Channel event catched in thread (in consumer_thread_channel_poll() at consumer.c:2676)
|
|
DEBUG1 [31281/31283]: Channel fd 20 is hup|err. (in consumer_thread_channel_poll() at consumer.c:2780)
|
|
DEBUG1 [31281/31283]: Channel poll wait with 1 fd(s) (in consumer_thread_channel_poll() at consumer.c:2674)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 4 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: fd 24 is hup|err|nval. Attempting flush and read. (in consumer_thread_data_poll() at consumer.c:2495)
|
|
DEBUG1 [31281/31285]: Polling fd 24 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: fd 33 is hup|err|nval. Attempting flush and read. (in consumer_thread_data_poll() at consumer.c:2495)
|
|
DEBUG1 [31281/31285]: Polling fd 33 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: fd 27 is hup|err|nval. Attempting flush and read. (in consumer_thread_data_poll() at consumer.c:2495)
|
|
DEBUG1 [31281/31285]: Polling fd 27 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: fd 30 is hup|err|nval. Attempting flush and read. (in consumer_thread_data_poll() at consumer.c:2495)
|
|
DEBUG1 [31281/31285]: Polling fd 30 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 4 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 24 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 4096 (len 4096) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 33 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 4096 (len 4096) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 27 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 4096 (len 4096) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 30 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 4096 (len 4096) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Polling fd 24 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: Polling fd 33 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: Polling fd 27 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: Polling fd 30 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 4 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 24 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Reserving sub buffer failed (everything is normal, it is due to concurrency) [ret: -11] (in lttng_ustconsumer_read_subbuffer() at ust-consumer.c:1266)
|
|
DEBUG1 [31281/31285]: Normal read on fd 33 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Reserving sub buffer failed (everything is normal, it is due to concurrency) [ret: -11] (in lttng_ustconsumer_read_subbuffer() at ust-consumer.c:1266)
|
|
DEBUG1 [31281/31285]: Normal read on fd 27 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Reserving sub buffer failed (everything is normal, it is due to concurrency) [ret: -11] (in lttng_ustconsumer_read_subbuffer() at ust-consumer.c:1266)
|
|
DEBUG1 [31281/31285]: Normal read on fd 30 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG1 [31281/31285]: Reserving sub buffer failed (everything is normal, it is due to concurrency) [ret: -11] (in lttng_ustconsumer_read_subbuffer() at ust-consumer.c:1266)
|
|
DEBUG1 [31281/31285]: Polling fd 24 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: Consumer del stream 24 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31285]: Polling fd 33 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: Consumer del stream 33 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31285]: Polling fd 27 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: Consumer del stream 27 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31285]: Polling fd 30 tells it has hung up. (in consumer_thread_data_poll() at consumer.c:2506)
|
|
DEBUG1 [31281/31285]: Consumer del stream 30 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31285]: Consumer delete channel key 1 (in consumer_del_channel() at consumer.c:289)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 1 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 8 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Waiting for 2 URIs from client ... (in process_client_msg() at main.c:2848)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG1 [30806/30810]: Tracing session TRACcin005_1 created with ID 1 by UID 0 GID 0 (in session_create() at session.c:216)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x65fdf0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Setting network URI to consumer (in add_uri_to_consumer() at cmd.c:381)
|
|
DEBUG3 [30806/30810]: Consumer control URI set with port 59383 (in consumer_set_network_uri() at consumer.c:518)
|
|
DEBUG3 [30806/30810]: Consumer set network uri subdir path SC-1/./ (in consumer_set_network_uri() at consumer.c:578)
|
|
DEBUG3 [30806/30810]: Append domain trace name to subdir SC-1/./ (in add_uri_to_consumer() at cmd.c:422)
|
|
DEBUG2 [30806/30810]: Setting network URI to consumer (in add_uri_to_consumer() at cmd.c:381)
|
|
DEBUG3 [30806/30810]: Consumer data URI set with port 50886 (in consumer_set_network_uri() at consumer.c:533)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 5 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG1 [30806/30810]: Creating UST session (in create_ust_session() at main.c:2243)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6602f0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x660b20 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: UST trace session create successful (in trace_ust_create_session() at trace-ust.c:226)
|
|
DEBUG3 [30806/30810]: Copying tracing session consumer output in UST session (in copy_session_consumer() at main.c:2193)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x660b20 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Copy session consumer subdir SC-1/.//ust (in copy_session_consumer() at main.c:2211)
|
|
DEBUG3 [30806/30810]: Consumer socket created (fd: 33) and added to output (in consumer_create_socket() at consumer.c:229)
|
|
DEBUG1 [30806/30810]: Setting relayd for session TRACcin005_1 (in cmd_setup_relayd() at cmd.c:671)
|
|
DEBUG3 [30806/30810]: Relayd connect ... (in relayd_connect() at relayd.c:355)
|
|
DEBUG3 [30806/30810]: Creating relayd stream socket from URI (in create_connect_relayd() at cmd.c:516)
|
|
DEBUG1 [30806/30810]: Relayd version check for major.minor 2.1 (in relayd_version_check() at relayd.c:254)
|
|
DEBUG3 [30806/30810]: Relayd sending command 5 of size 32 (in send_command() at relayd.c:78)
|
|
DEBUG3 [30806/30810]: Relayd waiting for reply of size 8 (in recv_reply() at relayd.c:98)
|
|
DEBUG2 [30806/30810]: Relayd version is compatible, using protocol version 2.1 (in relayd_version_check() at relayd.c:301)
|
|
DEBUG3 [30806/30810]: Sending relayd sock info to consumer on 33 (in consumer_send_relayd_socket() at consumer.c:854)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: Consumer adding relayd socket (idx: 2) (in consumer_add_relayd_socket() at consumer.c:3059)
|
|
DEBUG3 [30806/30810]: Sending relayd socket file descriptor to consumer (in consumer_send_relayd_socket() at consumer.c:867)
|
|
DEBUG1 [31281/31286]: Relayd create session (in relayd_create_session() at relayd.c:133)
|
|
DEBUG3 [31281/31286]: Relayd sending command 2 of size 24 (in send_command() at relayd.c:78)
|
|
DEBUG3 [31281/31286]: Relayd waiting for reply of size 12 (in recv_reply() at relayd.c:98)
|
|
DEBUG2 [30806/30810]: Consumer relayd socket sent (in consumer_send_relayd_socket() at consumer.c:873)
|
|
DEBUG3 [30806/30810]: Relayd closing socket 36 (in relayd_close() at relayd.c:386)
|
|
DEBUG3 [30806/30810]: Relayd connect ... (in relayd_connect() at relayd.c:355)
|
|
DEBUG3 [30806/30810]: Creating relayd data socket from URI (in create_connect_relayd() at cmd.c:525)
|
|
DEBUG3 [30806/30810]: Sending relayd sock info to consumer on 33 (in consumer_send_relayd_socket() at consumer.c:854)
|
|
DEBUG1 [31281/31286]: Relayd session created with id 3 (in relayd_create_session() at relayd.c:160)
|
|
DEBUG1 [31281/31286]: Consumer control socket created successfully with net idx 2 (fd: 20) (in consumer_add_relayd_socket() at consumer.c:3180)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: Consumer adding relayd socket (idx: 2) (in consumer_add_relayd_socket() at consumer.c:3059)
|
|
DEBUG3 [30806/30810]: Sending relayd socket file descriptor to consumer (in consumer_send_relayd_socket() at consumer.c:867)
|
|
DEBUG1 [31281/31286]: Consumer data socket created successfully with net idx 2 (fd: 23) (in consumer_add_relayd_socket() at consumer.c:3180)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG2 [30806/30810]: Consumer relayd socket sent (in consumer_send_relayd_socket() at consumer.c:873)
|
|
DEBUG3 [30806/30810]: Relayd closing socket 36 (in relayd_close() at relayd.c:386)
|
|
DEBUG1 [30806/30810]: Enabling channel channel0 for session TRACcin005_1 (in cmd_enable_channel() at cmd.c:857)
|
|
DEBUG2 [30806/30810]: Trace UST channel channel0 not found by name (in trace_ust_find_channel_by_name() at trace-ust.c:140)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6613d0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66ac90 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Trace UST channel channel0 created (in trace_ust_create_channel() at trace-ust.c:283)
|
|
DEBUG2 [30806/30810]: Channel channel0 is being created for UST with buffer 1 and id 0 (in channel_ust_create() at channel.c:309)
|
|
DEBUG2 [30806/30810]: UST app adding channel channel0 to UST domain for session id 1 (in ust_app_create_channel_glb() at ust-app.c:3382)
|
|
DEBUG2 [30806/30810]: UST app pid: 31079 session id 1 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66c270 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66c7d0 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID created id: 1, ABI: 64, uid: 0, domain: 2 (in buffer_reg_uid_create() at buffer-registry.c:143)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID adding to global registry with id: 1 (in buffer_reg_uid_add() at buffer-registry.c:165)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66cdb0 of type 2 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Append to metadata: "typealias integer { size = 8; align = 8; signed = false; } := uint8_t;
|
|
typealias integer { size = 16; align = 8; signed = false; } := uint16_t;
|
|
typealias integer { size = 32; align = 8; signed = false; } := uint32_t;
|
|
typealias integer { size = 64; align = 8; signed = false; } := uint64_t;
|
|
typealias integer { size = 64; align = 8; signed = false; } := unsigned long;
|
|
typealias integer { size = 5; align = 1; signed = false; } := uint5_t;
|
|
typealias integer { size = 27; align = 1; signed = false; } := uint27_t;
|
|
|
|
trace {
|
|
major = 1;
|
|
minor = 8;
|
|
uuid = "4b023aa6-6a62-437a-b553-f54cab76e422";
|
|
byte_order = le;
|
|
packet.header := struct {
|
|
uint32_t magic;
|
|
uint8_t uuid[16];
|
|
uint32_t stream_id;
|
|
};
|
|
};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "env {
|
|
hostname = "SC-1";
|
|
domain = "ust";
|
|
tracer_name = "lttng-ust";
|
|
tracer_major = 2;
|
|
tracer_minor = 2;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "clock {
|
|
name = monotonic;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: " uuid = "9f660b0c-489c-454b-a5f4-eb26059e33af";
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: " description = "Monotonic Clock";
|
|
freq = 1000000000; /* Frequency, in Hz */
|
|
/* clock value offset from Epoch is: offset * (1/freq) */
|
|
offset = 1367613046741138210;
|
|
};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "typealias integer {
|
|
size = 27; align = 1; signed = false;
|
|
map = clock.monotonic.value;
|
|
} := uint27_clock_monotonic_t;
|
|
|
|
typealias integer {
|
|
size = 32; align = 8; signed = false;
|
|
map = clock.monotonic.value;
|
|
} := uint32_clock_monotonic_t;
|
|
|
|
typealias integer {
|
|
size = 64; align = 8; signed = false;
|
|
map = clock.monotonic.value;
|
|
} := uint64_clock_monotonic_t;
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "struct packet_context {
|
|
uint64_clock_monotonic_t timestamp_begin;
|
|
uint64_clock_monotonic_t timestamp_end;
|
|
uint64_t content_size;
|
|
uint64_t packet_size;
|
|
unsigned long events_discarded;
|
|
uint32_t cpu_id;
|
|
};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: Append to metadata: "struct event_header_compact {
|
|
enum : uint5_t { compact = 0 ... 30, extended = 31 } id;
|
|
variant <id> {
|
|
struct {
|
|
uint27_clock_monotonic_t timestamp;
|
|
} compact;
|
|
struct {
|
|
uint32_t id;
|
|
uint64_clock_monotonic_t timestamp;
|
|
} extended;
|
|
} v;
|
|
} align(8);
|
|
|
|
struct event_header_large {
|
|
enum : uint16_t { compact = 0 ... 65534, extended = 65535 } id;
|
|
variant <id> {
|
|
struct {
|
|
uint32_clock_monotonic_t timestamp;
|
|
} compact;
|
|
struct {
|
|
uint32_t id;
|
|
uint64_clock_monotonic_t timestamp;
|
|
} extended;
|
|
} v;
|
|
} align(8);
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30810]: UST app buffer registry per UID created successfully (in setup_buffer_reg_uid() at ust-app.c:1600)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66d2d0 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66e1c0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app creating buffer registry channel for channel0 (in create_buffer_reg_channel() at ust-app.c:2076)
|
|
DEBUG3 [30806/30810]: Buffer registry channel create with key: 0 (in buffer_reg_channel_create() at buffer-registry.c:324)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x66f970 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Asking UST consumer for channel (in ask_channel_creation() at ust-consumer.c:118)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 0 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: Allocated channel (key 5) (in consumer_allocate_channel() at consumer.c:879)
|
|
DEBUG3 [31281/31286]: Creating channel to ustctl with attr: [overwrite: 0, subbuf_size: 16384, num_subbuf: 4, switch_timer_interval: 1000000, read_timer_interval: 0, output: 0, type: 0 (in create_ust_channel() at ust-consumer.c:342)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_0 (key 26, chan_key 5 relayd_id 2, session_id 1 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_0 (key: 26) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_1 (key 29, chan_key 5 relayd_id 2, session_id 1 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_1 (key: 29) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_2 (key 32, chan_key 5 relayd_id 2, session_id 1 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_2 (key: 32) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG3 [31281/31286]: Allocated stream channel0_3 (key 35, chan_key 5 relayd_id 2, session_id 1 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG1 [31281/31286]: UST consumer add stream channel0_3 (key: 35) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG1 [31281/31286]: UST consumer channel added (key: 5) (in add_channel() at ust-consumer.c:105)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [31281/31283]: Channel event catched in thread (in consumer_thread_channel_poll() at consumer.c:2676)
|
|
DEBUG1 [31281/31283]: Adding channel 24 to poll set (in consumer_thread_channel_poll() at consumer.c:2718)
|
|
DEBUG1 [31281/31283]: Channel poll wait with 2 fd(s) (in consumer_thread_channel_poll() at consumer.c:2674)
|
|
DEBUG2 [30806/30810]: UST ask channel 5 successfully done with 4 stream(s) (in ask_channel_creation() at ust-consumer.c:180)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: UST consumer sending channel channel0 to sessiond (in send_sessiond_channel() at ust-consumer.c:398)
|
|
DEBUG1 [31281/31286]: Relayd adding stream for channel name channel0_0 (in relayd_add_stream() at relayd.c:185)
|
|
DEBUG3 [31281/31286]: Relayd sending command 1 of size 4384 (in send_command() at relayd.c:78)
|
|
DEBUG3 [31281/31286]: Relayd waiting for reply of size 12 (in recv_reply() at relayd.c:98)
|
|
DEBUG1 [31281/31286]: Relayd stream added successfully with handle 4 (in relayd_add_stream() at relayd.c:232)
|
|
DEBUG1 [31281/31286]: Relayd adding stream for channel name channel0_1 (in relayd_add_stream() at relayd.c:185)
|
|
DEBUG3 [31281/31286]: Relayd sending command 1 of size 4384 (in send_command() at relayd.c:78)
|
|
DEBUG3 [31281/31286]: Relayd waiting for reply of size 12 (in recv_reply() at relayd.c:98)
|
|
DEBUG2 [30806/30810]: UST app stream 1 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG1 [31281/31286]: Relayd stream added successfully with handle 7 (in relayd_add_stream() at relayd.c:232)
|
|
DEBUG1 [31281/31286]: Relayd adding stream for channel name channel0_2 (in relayd_add_stream() at relayd.c:185)
|
|
DEBUG3 [31281/31286]: Relayd sending command 1 of size 4384 (in send_command() at relayd.c:78)
|
|
DEBUG3 [31281/31286]: Relayd waiting for reply of size 12 (in recv_reply() at relayd.c:98)
|
|
DEBUG2 [30806/30810]: UST app stream 2 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG1 [31281/31286]: Relayd stream added successfully with handle 8 (in relayd_add_stream() at relayd.c:232)
|
|
DEBUG1 [31281/31286]: Relayd adding stream for channel name channel0_3 (in relayd_add_stream() at relayd.c:185)
|
|
DEBUG3 [31281/31286]: Relayd sending command 1 of size 4384 (in send_command() at relayd.c:78)
|
|
DEBUG3 [31281/31286]: Relayd waiting for reply of size 12 (in recv_reply() at relayd.c:98)
|
|
DEBUG2 [30806/30810]: UST app stream 3 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG1 [31281/31286]: Relayd stream added successfully with handle 9 (in relayd_add_stream() at relayd.c:232)
|
|
DEBUG1 [31281/31286]: UST consumer NULL stream sent to sessiond (in send_sessiond_channel() at ust-consumer.c:439)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 26 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 2 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 29 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 3 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 32 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 4 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG3 [31281/31285]: Adding consumer stream 35 (in add_stream() at consumer.c:634)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG2 [30806/30810]: UST app stream 4 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:291)
|
|
DEBUG3 [30806/30810]: UST app consumer has no more stream available (in ust_consumer_get_channel() at ust-consumer.c:274)
|
|
DEBUG2 [30806/30810]: UST app setup buffer registry channel for channel0 (in setup_buffer_reg_channel() at ust-app.c:2123)
|
|
DEBUG2 [30806/30810]: UST app setup buffer registry stream (in setup_buffer_reg_streams() at ust-app.c:2031)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG3 [30806/30810]: Buffer registry creating stream (in buffer_reg_stream_create() at buffer-registry.c:354)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 22 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 22 pid 31079 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 22 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31079 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: UST app pid: 31088 session id 1 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x670cf0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x663180 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6636c0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 28 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 28 pid 31088 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 28 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31088 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: UST app pid: 31080 session id 1 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6651c0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x665910 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x6764e0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 24 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 24 pid 31080 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 24 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31080 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: UST app pid: 31081 session id 1 not found, creating it (in create_ust_app_session() at ust-app.c:1638)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x677f70 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1398)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1699)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x678630 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x678ae0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel channel0 allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: UST app shadow copy of channel channel0 started (in shadow_copy_channel() at ust-app.c:1326)
|
|
DEBUG3 [30806/30810]: UST app shadow copy of channel channel0 done (in shadow_copy_channel() at ust-app.c:1375)
|
|
DEBUG1 [30806/30810]: UST app creating channel channel0 with per UID buffers (in create_channel_per_uid() at ust-app.c:2222)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG1 [30806/30810]: UST app sending buffer registry channel to ust sock 26 (in send_channel_uid_to_ust() at ust-app.c:2159)
|
|
DEBUG2 [30806/30810]: UST app send channel to sock 26 pid 31081 (name: channel0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:395)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST consumer send stream to app 26 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:360)
|
|
DEBUG2 [30806/30810]: UST app create channel channel0 for PID 31081 completed (in create_ust_app_channel() at ust-app.c:2420)
|
|
DEBUG2 [30806/30810]: Channel channel0 created successfully (in channel_ust_create() at channel.c:333)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 5 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: Consumer socket created (fd: 33) and added to output (in consumer_create_socket() at consumer.c:229)
|
|
DEBUG1 [30806/30810]: Setting relayd for session TRACcin005_1 (in cmd_setup_relayd() at cmd.c:671)
|
|
DEBUG1 [30806/30810]: Enabling channel metadata for session TRACcin005_1 (in cmd_enable_channel() at cmd.c:857)
|
|
DEBUG2 [30806/30810]: Trace UST channel metadata not found by name (in trace_ust_find_channel_by_name() at trace-ust.c:140)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x679750 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x679c30 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG2 [30806/30810]: Trace UST channel metadata created (in trace_ust_create_channel() at trace-ust.c:283)
|
|
DEBUG2 [30806/30810]: Channel metadata is being created for UST with buffer 1 and id 1 (in channel_ust_create() at channel.c:309)
|
|
DEBUG2 [30806/30810]: UST app adding channel metadata to UST domain for session id 1 (in ust_app_create_channel_glb() at ust-app.c:3382)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x67a380 of type 1 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: Created hashtable size 4 at 0x67a8c0 of type 0 (in lttng_ht_new() at hashtable.c:112)
|
|
DEBUG3 [30806/30810]: UST app channel metadata allocated (in alloc_ust_app_channel() at ust-app.c:793)
|
|
DEBUG2 [30806/30810]: Asking UST consumer for channel (in ask_channel_creation() at ust-consumer.c:118)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: Allocated channel (key 9) (in consumer_allocate_channel() at consumer.c:879)
|
|
DEBUG3 [31281/31286]: Creating channel to ustctl with attr: [overwrite: 0, subbuf_size: 16384, num_subbuf: 4, switch_timer_interval: 1000000, read_timer_interval: 0, output: 0, type: 1 (in create_ust_channel() at ust-consumer.c:342)
|
|
DEBUG3 [31281/31286]: Allocated stream metadata (key 39, chan_key 9 relayd_id 2, session_id 1 (in consumer_allocate_stream() at consumer.c:607)
|
|
DEBUG1 [31281/31286]: UST consumer add stream metadata (key: 39) with relayd id 0 (in create_ust_streams() at ust-consumer.c:304)
|
|
DEBUG1 [31281/31286]: Allocated metadata cache of 4096 bytes (in consumer_metadata_cache_allocate() at consumer-metadata-cache.c:154)
|
|
DEBUG1 [31281/31286]: UST consumer channel added (key: 9) (in add_channel() at ust-consumer.c:105)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG2 [30806/30810]: UST ask channel 9 successfully done with 1 stream(s) (in ask_channel_creation() at ust-consumer.c:180)
|
|
DEBUG2 [30806/30810]: Consumer setup metadata channel key 9 (in consumer_setup_metadata() at consumer.c:1081)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: UST consumer setup metadata key 9 (in setup_metadata() at ust-consumer.c:655)
|
|
DEBUG1 [31281/31286]: Relayd adding stream for channel name metadata (in relayd_add_stream() at relayd.c:185)
|
|
DEBUG3 [31281/31286]: Relayd sending command 1 of size 4384 (in send_command() at relayd.c:78)
|
|
DEBUG3 [31281/31286]: Relayd waiting for reply of size 12 (in recv_reply() at relayd.c:98)
|
|
DEBUG1 [31281/31286]: Relayd stream added successfully with handle 14 (in relayd_add_stream() at relayd.c:232)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG2 [30806/30810]: UST metadata with key 9 created for app pid 31079 (in create_ust_app_metadata() at ust-app.c:2594)
|
|
DEBUG3 [30806/30810]: UST app deleting channel metadata (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 9 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [31281/31284]: Adding metadata stream 39 to poll set (in consumer_thread_metadata_poll() at consumer.c:2207)
|
|
DEBUG3 [31281/31284]: Adding metadata stream 39 to hash table (in add_metadata_stream() at consumer.c:1987)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG1 [31281/31284]: Metadata poll wait with 2 fd(s) (in consumer_thread_metadata_poll() at consumer.c:2148)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG2 [30806/30810]: Channel metadata created successfully (in channel_ust_create() at channel.c:333)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 0 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: Consumer socket created (fd: 33) and added to output (in consumer_create_socket() at consumer.c:229)
|
|
DEBUG1 [30806/30810]: Setting relayd for session TRACcin005_1 (in cmd_setup_relayd() at cmd.c:671)
|
|
DEBUG1 [30806/30810]: Context UST 1 added to channel metadata (in add_uctx_to_channel() at context.c:136)
|
|
DEBUG2 [30806/30810]: UST app adding context to channel channel0 (in create_ust_app_channel_context() at ust-app.c:1730)
|
|
DEBUG3 [30806/30810]: UST app context 1 allocated (in alloc_ust_app_ctx() at ust-app.c:874)
|
|
DEBUG2 [30806/30810]: UST app context handle -1 created successfully for channel channel0 (in create_ust_channel_context() at ust-app.c:1013)
|
|
DEBUG2 [30806/30810]: UST app adding context to channel channel0 (in create_ust_app_channel_context() at ust-app.c:1730)
|
|
DEBUG3 [30806/30810]: UST app context 1 allocated (in alloc_ust_app_ctx() at ust-app.c:874)
|
|
DEBUG2 [30806/30810]: UST app context handle -1 created successfully for channel channel0 (in create_ust_channel_context() at ust-app.c:1013)
|
|
DEBUG2 [30806/30810]: UST app adding context to channel channel0 (in create_ust_app_channel_context() at ust-app.c:1730)
|
|
DEBUG3 [30806/30810]: UST app context 1 allocated (in alloc_ust_app_ctx() at ust-app.c:874)
|
|
DEBUG2 [30806/30810]: UST app context handle -1 created successfully for channel channel0 (in create_ust_channel_context() at ust-app.c:1013)
|
|
DEBUG2 [30806/30810]: UST app adding context to channel channel0 (in create_ust_app_channel_context() at ust-app.c:1730)
|
|
DEBUG3 [30806/30810]: UST app context 1 allocated (in alloc_ust_app_ctx() at ust-app.c:874)
|
|
DEBUG2 [30806/30810]: UST app context handle -1 created successfully for channel channel0 (in create_ust_channel_context() at ust-app.c:1013)
|
|
DEBUG1 [30806/30810]: Context UST 1 added to channel channel0 (in add_uctx_to_channel() at context.c:136)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 6 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: Consumer socket created (fd: 33) and added to output (in consumer_create_socket() at consumer.c:229)
|
|
DEBUG1 [30806/30810]: Setting relayd for session TRACcin005_1 (in cmd_setup_relayd() at cmd.c:671)
|
|
DEBUG2 [30806/30810]: Trace UST channel channel0 found by name (in trace_ust_find_channel_by_name() at trace-ust.c:135)
|
|
DEBUG2 [30806/30810]: Trace UST event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA NOT found (in trace_ust_find_event() at trace-ust.c:174)
|
|
DEBUG2 [30806/30810]: Trace UST event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA, loglevel (1,14) created (in trace_ust_create_event() at trace-ust.c:355)
|
|
DEBUG1 [30806/30810]: UST app creating event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA for all apps for session id 1 (in ust_app_create_event_glb() at ust-app.c:3535)
|
|
DEBUG3 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA allocated (in alloc_ust_app_event() at ust-app.c:849)
|
|
DEBUG2 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA created successfully for pid:31079 (in create_ust_event() at ust-app.c:1252)
|
|
DEBUG2 [30806/30810]: UST app create event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA for PID 31079 completed (in create_ust_app_event() at ust-app.c:2479)
|
|
DEBUG3 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA allocated (in alloc_ust_app_event() at ust-app.c:849)
|
|
DEBUG2 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA created successfully for pid:31088 (in create_ust_event() at ust-app.c:1252)
|
|
DEBUG2 [30806/30810]: UST app create event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA for PID 31088 completed (in create_ust_app_event() at ust-app.c:2479)
|
|
DEBUG3 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA allocated (in alloc_ust_app_event() at ust-app.c:849)
|
|
DEBUG2 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA created successfully for pid:31080 (in create_ust_event() at ust-app.c:1252)
|
|
DEBUG2 [30806/30810]: UST app create event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA for PID 31080 completed (in create_ust_app_event() at ust-app.c:2479)
|
|
DEBUG3 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA allocated (in alloc_ust_app_event() at ust-app.c:849)
|
|
DEBUG2 [30806/30810]: UST app event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA created successfully for pid:31081 (in create_ust_event() at ust-app.c:1252)
|
|
DEBUG2 [30806/30810]: UST app create event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA for PID 31081 completed (in create_ust_app_event() at ust-app.c:2479)
|
|
DEBUG1 [30806/30810]: Event UST com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA created in channel channel0 (in event_ust_enable_tracepoint() at event.c:467)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 16 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG1 [30806/30810]: Starting all UST traces (in ust_app_start_trace_all() at ust-app.c:3862)
|
|
DEBUG1 [30806/30810]: Starting tracing for ust app pid 31079 (in ust_app_start_trace() at ust-app.c:3590)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST app receiving notify from sock 23 (in ust_app_recv_notify() at ust-app.c:4597)
|
|
DEBUG2 [30806/30814]: UST app ustctl register event received (in ust_app_recv_notify() at ust-app.c:4617)
|
|
DEBUG3 [30806/30814]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST registry channel finding key 0 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG3 [30806/30814]: UST registry creating event with event: com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA, sig: const char *, my_Time, int , OnePs, int , TenPs, float , unit_float, const char *, unit_string, const char *, stringAllSigns, id: 0, chan_objd: 2, sess_objd: 1, chan_id: 0 (in ust_registry_create_event() at ust-registry.c:233)
|
|
DEBUG3 [30806/30814]: Append to metadata: "event {
|
|
name = "com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA";
|
|
id = 0;
|
|
stream_id = 0;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " loglevel = 10;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " fields := struct {
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " string _my_Time;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " integer { size = 32; align = 8; signed = 1; encoding = none; base = 10; } _OnePs;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " integer { size = 32; align = 8; signed = 1; encoding = none; base = 10; } _TenPs;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " floating_point { exp_dig = 8; mant_dig = 24; align = 8; } _unit_float;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " string _unit_string;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " string _stringAllSigns;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " };
|
|
};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: UST registry event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA with id 0 added successfully (in add_event_ust_registry() at ust-app.c:4578)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 6 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG3 [30806/30814]: UST app receiving notify from sock 23 (in ust_app_recv_notify() at ust-app.c:4597)
|
|
DEBUG2 [30806/30814]: UST app ustctl register channel received (in ust_app_recv_notify() at ust-app.c:4645)
|
|
DEBUG3 [30806/30814]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST registry channel finding key 0 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG3 [30806/30814]: Append to metadata: "stream {
|
|
id = 0;
|
|
event.header := struct event_header_compact;
|
|
packet.context := struct packet_context;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " event.context := struct {
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " integer { size = 32; align = 8; signed = 1; encoding = none; base = 10; } _vpid;
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: " };
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: Append to metadata: "};
|
|
|
|
" (in lttng_metadata_printf() at ust-metadata.c:144)
|
|
DEBUG3 [30806/30814]: UST app replying to register channel key 0 with id 0, type: 1, ret: 0 (in reply_ust_register_channel() at ust-app.c:4483)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 6 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30810]: Starting tracing for ust app pid 31088 (in ust_app_start_trace() at ust-app.c:3590)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST app receiving notify from sock 29 (in ust_app_recv_notify() at ust-app.c:4597)
|
|
DEBUG2 [30806/30814]: UST app ustctl register channel received (in ust_app_recv_notify() at ust-app.c:4645)
|
|
DEBUG3 [30806/30814]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST registry channel finding key 0 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG3 [30806/30814]: UST app replying to register channel key 0 with id 0, type: 1, ret: 0 (in reply_ust_register_channel() at ust-app.c:4483)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 6 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30810]: Starting tracing for ust app pid 31080 (in ust_app_start_trace() at ust-app.c:3590)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST app receiving notify from sock 25 (in ust_app_recv_notify() at ust-app.c:4597)
|
|
DEBUG2 [30806/30814]: UST app ustctl register channel received (in ust_app_recv_notify() at ust-app.c:4645)
|
|
DEBUG3 [30806/30814]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST registry channel finding key 0 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG3 [30806/30814]: UST app replying to register channel key 0 with id 0, type: 1, ret: 0 (in reply_ust_register_channel() at ust-app.c:4483)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 6 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30810]: Starting tracing for ust app pid 31081 (in ust_app_start_trace() at ust-app.c:3590)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST app receiving notify from sock 27 (in ust_app_recv_notify() at ust-app.c:4597)
|
|
DEBUG2 [30806/30814]: UST app ustctl register channel received (in ust_app_recv_notify() at ust-app.c:4645)
|
|
DEBUG3 [30806/30814]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30814]: UST registry channel finding key 0 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG3 [30806/30814]: UST app replying to register channel key 0 with id 0, type: 1, ret: 0 (in reply_ust_register_channel() at ust-app.c:4483)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 6 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 4 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 35 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 68 (len 68) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 26 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 68 (len 68) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 29 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 698 (len 698) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 32 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 68 (len 68) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31284]: Metadata event catched in thread (in consumer_thread_metadata_poll() at consumer.c:2150)
|
|
DEBUG1 [31281/31284]: Metadata available on fd 39 (in consumer_thread_metadata_poll() at consumer.c:2267)
|
|
DEBUG1 [31281/31284]: Relayd sending metadata of size 49 (in relayd_send_metadata() at relayd.c:320)
|
|
DEBUG1 [31281/31287]: Switch timer for channel 9 (in metadata_switch_timer() at consumer-timer.c:73)
|
|
DEBUG1 [31281/31287]: Sending metadata request to sessiond, session 1 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1445)
|
|
DEBUG3 [31281/31284]: Relayd sending command 6 of size 24 (in send_command() at relayd.c:78)
|
|
DEBUG1 [31281/31284]: Metadata stream id 14 with padding 4059 written before data (in write_relayd_metadata_id() at consumer.c:1298)
|
|
DEBUG1 [31281/31284]: Consumer mmap write() ret 37 (len 37) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31284]: Metadata poll wait with 2 fd(s) (in consumer_thread_metadata_poll() at consumer.c:2148)
|
|
DEBUG2 [30806/31282]: Consumer push metadata to consumer socket 34 (in consumer_push_metadata() at consumer.c:1115)
|
|
DEBUG1 [31281/31287]: UST consumer push metadata key 9 of len 2847 (in lttng_ustconsumer_recv_metadata() at ust-consumer.c:708)
|
|
DEBUG3 [30806/31282]: Consumer pushing metadata on sock 34 of len 2847 (in consumer_push_metadata() at consumer.c:1128)
|
|
DEBUG1 [31281/31287]: Writing 2847 bytes from offset 0 in metadata cache (in consumer_metadata_cache_write() at consumer-metadata-cache.c:88)
|
|
DEBUG1 [31281/31287]: UST consumer writing metadata to channel metadata (in lttng_ustconsumer_push_metadata() at ust-consumer.c:553)
|
|
DEBUG1 [31281/31284]: Metadata event catched in thread (in consumer_thread_metadata_poll() at consumer.c:2150)
|
|
DEBUG1 [31281/31284]: Metadata available on fd 39 (in consumer_thread_metadata_poll() at consumer.c:2267)
|
|
DEBUG1 [31281/31284]: Relayd sending metadata of size 2896 (in relayd_send_metadata() at relayd.c:320)
|
|
DEBUG3 [31281/31284]: Relayd sending command 6 of size 24 (in send_command() at relayd.c:78)
|
|
DEBUG1 [31281/31284]: Metadata stream id 14 with padding 1212 written before data (in write_relayd_metadata_id() at consumer.c:1298)
|
|
DEBUG1 [31281/31284]: Consumer mmap write() ret 2884 (len 2884) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31284]: Metadata poll wait with 2 fd(s) (in consumer_thread_metadata_poll() at consumer.c:2148)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 2 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 29 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 689 (len 689) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 32 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 146 (len 146) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31287]: Switch timer for channel 9 (in metadata_switch_timer() at consumer-timer.c:73)
|
|
DEBUG1 [31281/31287]: Sending metadata request to sessiond, session 1 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1445)
|
|
DEBUG1 [30806/31282]: Metadata request received for session 1, key 9 (in ust_consumer_metadata_request() at ust-consumer.c:443)
|
|
DEBUG3 [30806/31282]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/31282]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG1 [30806/31282]: No metadata to push (in ust_app_push_metadata() at ust-app.c:413)
|
|
DEBUG2 [30806/31282]: Consumer push metadata to consumer socket 34 (in consumer_push_metadata() at consumer.c:1115)
|
|
DEBUG1 [31281/31287]: No new metadata to receive for key 9 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1486)
|
|
DEBUG1 [30806/31282]: UST Consumer metadata pushed successfully (in ust_consumer_metadata_request() at ust-consumer.c:477)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 2 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 35 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 362 (len 362) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Normal read on fd 32 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 491 (len 491) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31287]: Switch timer for channel 9 (in metadata_switch_timer() at consumer-timer.c:73)
|
|
DEBUG1 [31281/31287]: Sending metadata request to sessiond, session 1 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1445)
|
|
DEBUG1 [30806/31282]: Metadata request received for session 1, key 9 (in ust_consumer_metadata_request() at ust-consumer.c:443)
|
|
DEBUG3 [30806/31282]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/31282]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG1 [30806/31282]: No metadata to push (in ust_app_push_metadata() at ust-app.c:413)
|
|
DEBUG2 [30806/31282]: Consumer push metadata to consumer socket 34 (in consumer_push_metadata() at consumer.c:1115)
|
|
DEBUG1 [31281/31287]: No new metadata to receive for key 9 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1486)
|
|
DEBUG1 [30806/31282]: UST Consumer metadata pushed successfully (in ust_consumer_metadata_request() at ust-consumer.c:477)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 35 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 758 (len 758) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31287]: Switch timer for channel 9 (in metadata_switch_timer() at consumer-timer.c:73)
|
|
DEBUG1 [31281/31287]: Sending metadata request to sessiond, session 1 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1445)
|
|
DEBUG1 [30806/31282]: Metadata request received for session 1, key 9 (in ust_consumer_metadata_request() at ust-consumer.c:443)
|
|
DEBUG3 [30806/31282]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/31282]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG1 [30806/31282]: No metadata to push (in ust_app_push_metadata() at ust-app.c:413)
|
|
DEBUG2 [30806/31282]: Consumer push metadata to consumer socket 34 (in consumer_push_metadata() at consumer.c:1115)
|
|
DEBUG1 [31281/31287]: No new metadata to receive for key 9 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1486)
|
|
DEBUG1 [30806/31282]: UST Consumer metadata pushed successfully (in ust_consumer_metadata_request() at ust-consumer.c:477)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 35 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret 758 (len 758) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: polling on 5 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31287]: Switch timer for channel 9 (in metadata_switch_timer() at consumer-timer.c:73)
|
|
DEBUG1 [31281/31287]: Sending metadata request to sessiond, session 1 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1445)
|
|
DEBUG1 [30806/31282]: Metadata request received for session 1, key 9 (in ust_consumer_metadata_request() at ust-consumer.c:443)
|
|
DEBUG3 [30806/31282]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/31282]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG1 [30806/31282]: No metadata to push (in ust_app_push_metadata() at ust-app.c:413)
|
|
DEBUG2 [30806/31282]: Consumer push metadata to consumer socket 34 (in consumer_push_metadata() at consumer.c:1115)
|
|
DEBUG1 [31281/31287]: No new metadata to receive for key 9 (in lttng_ustconsumer_request_metadata() at ust-consumer.c:1486)
|
|
DEBUG1 [30806/31282]: UST Consumer metadata pushed successfully (in ust_consumer_metadata_request() at ust-consumer.c:477)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 13 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Counting number of available session for UID 0 GID 0 (in lttng_sessions_count() at main.c:2327)
|
|
DEBUG1 [30806/30810]: Getting all available session for UID 0 GID 0 (in cmd_list_lttng_sessions() at cmd.c:2048)
|
|
DEBUG1 [30806/30810]: Sending response (size: 4388, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: Normal read on fd 35 (in consumer_thread_data_poll() at consumer.c:2472)
|
|
DEBUG3 [31281/31285]: Relayd sending data header of size 32 (in relayd_send_data_hdr() at relayd.c:419)
|
|
DEBUG1 [31281/31285]: Consumer mmap write() ret -1 (len 758) (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1435)
|
|
DEBUG1 [31281/31285]: Error in file write mmap (in lttng_consumer_on_read_subbuffer_mmap() at consumer.c:1443)
|
|
DEBUG1 [31281/31285]: Cleaning up relayd sockets (in cleanup_relayd() at consumer.c:388)
|
|
DEBUG1 [31281/31285]: Consumer destroy and close relayd socket pair (in destroy_relayd() at consumer.c:267)
|
|
DEBUG1 [31281/31285]: Consumer set delete flag on stream by idx 2 (in update_endpoint_status_by_netidx() at consumer.c:351)
|
|
DEBUG1 [31281/31285]: Delete flag set to metadata stream 39 (in update_endpoint_status_by_netidx() at consumer.c:359)
|
|
DEBUG1 [31281/31285]: Delete flag set to data stream 35 (in update_endpoint_status_by_netidx() at consumer.c:367)
|
|
DEBUG1 [31281/31285]: Delete flag set to data stream 26 (in update_endpoint_status_by_netidx() at consumer.c:367)
|
|
DEBUG1 [31281/31285]: Delete flag set to data stream 29 (in update_endpoint_status_by_netidx() at consumer.c:367)
|
|
DEBUG1 [31281/31285]: Delete flag set to data stream 32 (in update_endpoint_status_by_netidx() at consumer.c:367)
|
|
DEBUG1 [31281/31285]: Error writing to tracefile (ret: -1 != len: 4096 != subbuf_size: 758) (in lttng_ustconsumer_read_subbuffer() at ust-consumer.c:1300)
|
|
DEBUG1 [31281/31285]: Consumer del stream 35 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31284]: Metadata event catched in thread (in consumer_thread_metadata_poll() at consumer.c:2150)
|
|
DEBUG1 [31281/31284]: Consumer delete flagged metadata stream (in validate_endpoint_status_metadata_stream() at consumer.c:2079)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG3 [31281/31284]: Consumer delete metadata stream 39 (in consumer_del_metadata_stream() at consumer.c:1874)
|
|
DEBUG1 [31281/31285]: polling on 1 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31285]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2376)
|
|
DEBUG1 [31281/31285]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2400)
|
|
DEBUG1 [31281/31285]: Consumer delete flagged data stream (in validate_endpoint_status_data_stream() at consumer.c:2056)
|
|
DEBUG1 [31281/31285]: Consumer del stream 26 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31287]: Signal timer metadata thread teardown (in consumer_timer_metadata_thread() at consumer-timer.c:244)
|
|
DEBUG1 [31281/31284]: Consumer delete channel key 9 (in consumer_del_channel() at consumer.c:289)
|
|
DEBUG1 [31281/31285]: Consumer del stream 29 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31285]: Consumer del stream 32 (in consumer_del_stream() at consumer.c:447)
|
|
DEBUG1 [31281/31285]: Updating poll fd array (in update_poll_array() at consumer.c:941)
|
|
DEBUG1 [31281/31285]: polling on 1 fd (in consumer_thread_data_poll() at consumer.c:2374)
|
|
DEBUG1 [31281/31284]: Destroying metadata cache (in consumer_metadata_cache_destroy() at consumer-metadata-cache.c:176)
|
|
DEBUG1 [31281/31284]: Metadata poll wait with 1 fd(s) (in consumer_thread_metadata_poll() at consumer.c:2148)
|
|
DEBUG3 [31281/31294]: Relayd closing socket 20 (in relayd_close() at relayd.c:386)
|
|
DEBUG3 [31281/31294]: Relayd closing socket 23 (in relayd_close() at relayd.c:386)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 13 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Counting number of available session for UID 0 GID 0 (in lttng_sessions_count() at main.c:2327)
|
|
DEBUG1 [30806/30810]: Getting all available session for UID 0 GID 0 (in cmd_list_lttng_sessions() at cmd.c:2048)
|
|
DEBUG1 [30806/30810]: Sending response (size: 4388, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 17 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG1 [30806/30810]: Stopping all UST traces (in ust_app_stop_trace_all() at ust-app.c:3888)
|
|
DEBUG1 [30806/30810]: Stopping tracing for ust app pid 31079 (in ust_app_stop_trace() at ust-app.c:3684)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG1 [30806/30810]: Stopping tracing for ust app pid 31088 (in ust_app_stop_trace() at ust-app.c:3684)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG1 [30806/30810]: Stopping tracing for ust app pid 31080 (in ust_app_stop_trace() at ust-app.c:3684)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG1 [30806/30810]: Stopping tracing for ust app pid 31081 (in ust_app_stop_trace() at ust-app.c:3684)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG2 [30806/30810]: Consumer flush channel key 5 (in consumer_flush_channel() at consumer.c:1015)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: UST consumer flush channel key 5 (in flush_channel() at ust-consumer.c:582)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 24 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: Consumer data pending for id 1 (in consumer_is_data_pending() at consumer.c:949)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: UST consumer data pending command for id 1 (in lttng_ustconsumer_recv_cmd() at ust-consumer.c:832)
|
|
DEBUG1 [31281/31286]: Consumer data pending command on session id 1 (in consumer_data_pending() at consumer.c:3280)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [30806/30810]: Consumer data is NOT pending for session id 1 (in consumer_is_data_pending() at consumer.c:994)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Unknown error code) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30810]: Wait for client response (in thread_manage_clients() at main.c:3372)
|
|
DEBUG1 [30806/30810]: Receiving data from client ... (in thread_manage_clients() at main.c:3417)
|
|
DEBUG1 [30806/30810]: Processing client command 9 (in process_client_msg() at main.c:2358)
|
|
DEBUG1 [30806/30810]: Getting session TRACcin005_1 by name (in process_client_msg() at main.c:2429)
|
|
DEBUG2 [30806/30810]: Trying to find session by name TRACcin005_1 (in session_find_by_name() at session.c:132)
|
|
DEBUG3 [30806/30810]: No kernel session when tearing down session (in kernel_destroy_session() at kernel.c:739)
|
|
DEBUG2 [30806/30810]: Sending destroy relayd command to consumer sock 33 (in consumer_send_destroy_relayd() at consumer.c:129)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: UST consumer destroying relayd 2 (in lttng_ustconsumer_recv_cmd() at ust-consumer.c:797)
|
|
DEBUG1 [31281/31286]: Unable to find relayd 2 (in lttng_ustconsumer_recv_cmd() at ust-consumer.c:802)
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [30806/30810]: Consumer ret code -109 (in consumer_recv_status_reply() at consumer.c:66)
|
|
DEBUG2 [30806/30810]: Consumer send destroy relayd command done (in consumer_send_destroy_relayd() at consumer.c:152)
|
|
DEBUG1 [30806/30810]: Unable to send destroy relayd command to consumer (in consumer_output_send_destroy_relayd() at consumer.c:181)
|
|
DEBUG1 [30806/30810]: Destroy all UST traces (in ust_app_destroy_trace_all() at ust-app.c:3959)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31079 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 5 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31088 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 6 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31080 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 7 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG1 [30806/30810]: Destroy tracing for ust app pid 31081 (in destroy_trace() at ust-app.c:3820)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: No metadata to push for metadata key 9 (in ust_app_push_metadata() at ust-app.c:410)
|
|
DEBUG3 [30806/30810]: UST app deleting channel channel0 (in delete_ust_app_channel() at ust-app.c:342)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID find id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_find() at buffer-registry.c:194)
|
|
DEBUG3 [30806/30810]: UST registry channel finding key 8 (in ust_registry_channel_find() at ust-registry.c:414)
|
|
DEBUG2 [30806/30810]: Trace UST destroy session 1 (in trace_ust_destroy_session() at trace-ust.c:631)
|
|
DEBUG3 [30806/30810]: Buffer registry per UID destroy with id: 1, ABI: 64, uid: 0 (in buffer_reg_uid_destroy() at buffer-registry.c:621)
|
|
DEBUG2 [30806/30810]: Consumer close metadata channel key 9 (in consumer_close_metadata() at consumer.c:1048)
|
|
DEBUG1 [31281/31286]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2926)
|
|
DEBUG1 [31281/31286]: UST consumer close metadata key 9 (in close_metadata() at ust-consumer.c:616)
|
|
Error: UST consumer close metadata 9 not found
|
|
DEBUG1 [31281/31286]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2944)
|
|
DEBUG1 [30806/30810]: Consumer ret code -59 (in consumer_recv_status_reply() at consumer.c:66)
|
|
DEBUG1 [30806/30810]: Destroying session TRACcin005_1 (in session_destroy() at session.c:157)
|
|
DEBUG1 [30806/30810]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3468)
|
|
DEBUG1 [30806/30810]: Clean command context structure (in clean_command_ctx() at main.c:484)
|
|
DEBUG1 [30806/30810]: Accepting client command ... (in thread_manage_clients() at main.c:3330)
|
|
DEBUG1 [30806/30815]: Updating kernel poll set (in update_kernel_poll() at main.c:565)
|
|
DEBUG1 [30806/30815]: Thread kernel polling on 2 fds (in thread_manage_kernel() at main.c:744)
|
|
DEBUG2 [30806/31293]: Trace destroy UST channel metadata (in _trace_ust_destroy_channel() at trace-ust.c:545)
|
|
DEBUG2 [30806/31293]: Trace destroy UST channel channel0 (in _trace_ust_destroy_channel() at trace-ust.c:545)
|
|
DEBUG3 [30806/31293]: Buffer registry session destroy (in buffer_reg_session_destroy() at buffer-registry.c:540)
|
|
DEBUG3 [30806/31293]: Buffer registry channel destroy with key 0 and handle -1 (in buffer_reg_channel_destroy() at buffer-registry.c:496)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG3 [30806/31293]: Buffer registry stream destroy with handle -1 (in buffer_reg_stream_destroy() at buffer-registry.c:443)
|
|
DEBUG1 [31281/31283]: Channel event catched in thread (in consumer_thread_channel_poll() at consumer.c:2676)
|
|
DEBUG1 [31281/31283]: Channel fd 24 is hup|err. (in consumer_thread_channel_poll() at consumer.c:2780)
|
|
DEBUG1 [31281/31283]: Consumer delete channel key 5 (in consumer_del_channel() at consumer.c:289)
|
|
DEBUG1 [31281/31283]: Channel poll wait with 1 fd(s) (in consumer_thread_channel_poll() at consumer.c:2674)
|
|
DEBUG2 [30806/31293]: Trace destroy UST event com_ericsson_cba_trace_testapp_lowtraf:TenPerSecA (in trace_ust_destroy_event() at trace-ust.c:496)
|
|
DEBUG1 [30806/30814]: UST app notify socket unregister 25 (in ust_app_notify_sock_unregister() at ust-app.c:4714)
|
|
DEBUG1 [30806/30813]: PID 31080 unregistering with sock 24 (in ust_app_unregister() at ust-app.c:2789)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 5 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG1 [30806/30813]: PID 31079 unregistering with sock 22 (in ust_app_unregister() at ust-app.c:2789)
|
|
DEBUG1 [30806/30814]: UST app notify socket unregister 23 (in ust_app_notify_sock_unregister() at ust-app.c:4714)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 4 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG2 [30806/30814]: UST app find by notify sock 23 not found (in find_app_by_notify_sock() at ust-app.c:939)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 4 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30814]: UST app notify socket unregister 29 (in ust_app_notify_sock_unregister() at ust-app.c:4714)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 3 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30814]: UST app notify socket unregister 27 (in ust_app_notify_sock_unregister() at ust-app.c:4714)
|
|
DEBUG3 [30806/30814]: [ust-thread] Manage notify polling on 2 fds (in ust_thread_manage_notify() at ust-thread.c:54)
|
|
DEBUG1 [30806/30813]: PID 31088 unregistering with sock 28 (in ust_app_unregister() at ust-app.c:2789)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 3 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG1 [30806/30813]: PID 31081 unregistering with sock 26 (in ust_app_unregister() at ust-app.c:2789)
|
|
DEBUG1 [30806/30813]: Apps thread polling on 2 fds (in thread_manage_apps() at main.c:1179)
|
|
DEBUG3 [30806/31293]: Call RCU deleting app PID 31080 (in delete_ust_app_rcu() at ust-app.c:693)
|
|
DEBUG2 [30806/31293]: UST app pid 31080 deleted (in delete_ust_app() at ust-app.c:678)
|
|
DEBUG3 [30806/31293]: Call RCU deleting app PID 31079 (in delete_ust_app_rcu() at ust-app.c:693)
|
|
DEBUG2 [30806/31293]: UST app pid 31079 deleted (in delete_ust_app() at ust-app.c:678)
|
|
DEBUG3 [30806/31293]: Call RCU deleting app PID 31088 (in delete_ust_app_rcu() at ust-app.c:693)
|
|
DEBUG2 [30806/31293]: UST app pid 31088 deleted (in delete_ust_app() at ust-app.c:678)
|
|
DEBUG3 [30806/31293]: Call RCU deleting app PID 31081 (in delete_ust_app_rcu() at ust-app.c:693)
|
|
DEBUG2 [30806/31293]: UST app pid 31081 deleted (in delete_ust_app() at ust-app.c:678)
|