LTTng » LTTng-tools

DEBUG3 [3300/3300]: Creating LTTng run directory: /var/run/lttng (in create_lttng_rundir() at main.c:4170)

DEBUG2 [3300/3300]: Kernel consumer err path: /var/run/lttng/kconsumerd/error (in main() at main.c:4467)

DEBUG2 [3300/3300]: Kernel consumer cmd path: /var/run/lttng/kconsumerd/command (in main() at main.c:4469)

DEBUG1 [3300/3300]: Client socket path /var/run/lttng/client-lttng-sessiond (in main() at main.c:4522)

DEBUG1 [3300/3300]: Application socket path /var/run/lttng/lttng-ust-sock-5 (in main() at main.c:4523)

DEBUG1 [3300/3300]: Application wait path /lttng-ust-wait-5 (in main() at main.c:4524)

DEBUG1 [3300/3300]: LTTng run directory path: /var/run/lttng (in main() at main.c:4525)

DEBUG2 [3300/3300]: UST consumer 32 bits err path: /var/run/lttng/ustconsumerd32/error (in main() at main.c:4534)

DEBUG2 [3300/3300]: UST consumer 32 bits cmd path: /var/run/lttng/ustconsumerd32/command (in main() at main.c:4536)

DEBUG2 [3300/3300]: UST consumer 64 bits err path: /var/run/lttng/ustconsumerd64/error (in main() at main.c:4545)

DEBUG2 [3300/3300]: UST consumer 64 bits cmd path: /var/run/lttng/ustconsumerd64/command (in main() at main.c:4547)

DEBUG3 [3300/3300]: Created hashtable size 4 at 0x57a0a0 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3300]: Created hashtable size 4 at 0x57a440 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3300]: Created hashtable size 4 at 0x57a800 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG2 [3300/3300]: Creating consumer directory: /var/run/lttng/kconsumerd (in set_consumer_sockets() at main.c:4212)

DEBUG1 [3300/3300]: Modprobe successfully lttng-tracer (in modprobe_lttng_control() at modprobe.c:192)

DEBUG2 [3300/3300]: Kernel tracer version validated (major version 2) (in kernel_validate_version() at kernel.c:700)

DEBUG1 [3300/3300]: Modprobe successfully lttng-ftrace (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-kprobes (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-kretprobes (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-lib-ring-buffer (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-ring-buffer-client-discard (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-ring-buffer-client-overwrite (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-ring-buffer-metadata-client (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-ring-buffer-client-mmap-discard (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-ring-buffer-client-mmap-overwrite (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-ring-buffer-metadata-mmap-client (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-types (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-asoc (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-block (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-btrfs (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-compaction (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-ext3 (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-ext4 (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-gpio (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-irq (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-jbd (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-jbd2 (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-kmem (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-kvm (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-kvm-x86 (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-kvm-x86-mmu (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-lock (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-module (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-napi (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-net (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-power (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-printk (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-random (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-rcu (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-regmap (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-regulator (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-rpm (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-sched (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-scsi (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-signal (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-skb (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-sock (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-statedump (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-sunrpc (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-timer (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-udp (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-vmscan (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-workqueue (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Modprobe successfully lttng-probe-writeback (in modprobe_lttng_data() at modprobe.c:228)

DEBUG1 [3300/3300]: Kernel tracer fd 6 (in init_kernel_tracer() at main.c:2342)

DEBUG2 [3300/3300]: Creating consumer directory: /var/run/lttng/ustconsumerd64 (in set_consumer_sockets() at main.c:4212)

DEBUG2 [3300/3300]: Creating consumer directory: /var/run/lttng/ustconsumerd32 (in set_consumer_sockets() at main.c:4212)

DEBUG1 [3300/3300]: Signal handler set for SIGTERM, SIGPIPE and SIGINT (in set_signal_handler() at main.c:4314)

DEBUG3 [3300/3300]: Session daemon client socket 9 and application socket 10 created (in init_daemon_socket() at main.c:4075)

DEBUG1 [3300/3300]: All permissions are set (in set_permissions() at main.c:4158)

DEBUG3 [3300/3300]: Created hashtable size 4 at 0x57d250 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3300]: Global buffer per UID registry initialized (in buffer_reg_init_uid_registry() at buffer-registry.c:99)

DEBUG3 [3300/3300]: Created hashtable size 4 at 0x57d610 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3300]: Global buffer per PID registry initialized (in buffer_reg_init_pid_registry() at buffer-registry.c:220)

DEBUG1 [3300/3300]: epoll set max size is 205168 (in compat_epoll_set_max_size() at compat-epoll.c:274)

DEBUG1 [3300/3300]: Command subsystem initialized (in cmd_init() at cmd.c:2847)

DEBUG1 [3300/3300]: Pid 3300 written in file /var/run/lttng/lttng-sessiond.pid (in utils_create_pid_file() at utils.c:280)

DEBUG1 [3300/3300]: TCP inet operation timeout set to 180 sec (in lttcomm_inet_init() at inet.c:523)

DEBUG1 [3300/3300]: Health check time delta in seconds set to 200 (in health_init() at health.c:272)

DEBUG1 [3300/3405]: [ust-thread] Manage application notify command (in ust_thread_manage_notify() at ust-thread.c:37)

DEBUG3 [3300/3405]: [ust-thread] Manage notify polling on 2 fds (in ust_thread_manage_notify() at ust-thread.c:61)

DEBUG1 [3300/3406]: [thread] Thread manage kernel started (in thread_manage_kernel() at main.c:756)

DEBUG1 [3300/3406]: Updating kernel poll set (in update_kernel_poll() at main.c:616)

DEBUG1 [3300/3406]: Thread kernel polling on 2 fds (in thread_manage_kernel() at main.c:801)

DEBUG1 [3300/3404]: [thread] Manage application started (in thread_manage_apps() at main.c:1218)

DEBUG1 [3300/3404]: Apps thread polling on 2 fds (in thread_manage_apps() at main.c:1248)

DEBUG1 [3300/3403]: [thread] Manage application registration started (in thread_registration_apps() at main.c:1744)

DEBUG1 [3300/3403]: Notifying applications of session daemon state: 1 (in notify_ust_apps() at main.c:555)

DEBUG1 [3300/3403]: Got the wait shm fd 23 (in get_wait_shm() at shm.c:119)

DEBUG1 [3300/3403]: Futex wait update active 1 (in futex_wait_update() at futex.c:63)

DEBUG1 [3300/3403]: Accepting application registration (in thread_registration_apps() at main.c:1781)

DEBUG1 [3300/3402]: [thread] Dispatch UST command started (in thread_dispatch_ust_registration() at main.c:1521)

DEBUG1 [3300/3402]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)

DEBUG1 [3300/3402]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1544)

DEBUG1 [3300/3401]: [thread] Manage client started (in thread_manage_clients() at main.c:3621)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3400]: [thread] Manage health check started (in thread_manage_health() at main.c:3418)

DEBUG1 [3300/3400]: Health check ready (in thread_manage_health() at main.c:3460)

DEBUG1 [3300/3399]: [ht-thread] startup. (in thread_ht_cleanup() at ht-cleanup.c:34)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Processing client command 29 (in process_client_msg() at main.c:2578)

DEBUG1 [3300/3401]: Waiting for 1 URIs from client ... (in process_client_msg() at main.c:3359)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f3704005ea0 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG1 [3300/3401]: Tracing session snapsfind created with ID 0 by UID 1000 GID 1000 (in session_create() at session.c:224)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f370400b2b0 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG2 [3300/3401]: Session snapsfind created with no output (in cmd_create_session_uri() at cmd.c:1820)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f3704010830 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG1 [3300/3401]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3803)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Processing client command 5 (in process_client_msg() at main.c:2578)

DEBUG1 [3300/3401]: Getting session snapsfind by name (in process_client_msg() at main.c:2655)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG1 [3300/3401]: Creating UST session (in create_ust_session() at main.c:2459)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f3704003d60 of type 0 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f3704004120 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG2 [3300/3401]: UST trace session create successful (in trace_ust_create_session() at trace-ust.c:235)

DEBUG3 [3300/3401]: Copying tracing session consumer output in UST session (in copy_session_consumer() at main.c:2409)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f37040044e0 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3401]: Copy session consumer subdir /ust (in copy_session_consumer() at main.c:2427)

DEBUG1 [3300/3401]: Spawning consumerd (in spawn_consumerd() at main.c:2086)

DEBUG2 [3300/3401]: Consumer pid 3421 (in start_consumerd() at main.c:2269)

DEBUG2 [3300/3401]: Spawning consumer control thread (in start_consumerd() at main.c:2272)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG1 [3300/3422]: [thread] Manage consumer started (in thread_manage_consumer() at main.c:922)

DEBUG1 [3421/3421]: Using 64-bit UST consumer at: /usr/local/lib/lttng/libexec/lttng-consumerd (in spawn_consumerd() at main.c:2161)

DEBUG1 [3421/3421]: epoll set max size is 205168 (in compat_epoll_set_max_size() at compat-epoll.c:274)

DEBUG3 [3421/3421]: Created hashtable size 4 at 0x8e6030 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3421/3421]: Created hashtable size 4 at 0x8e63f0 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3421/3421]: Created hashtable size 4 at 0x8e67b0 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3421/3421]: Created hashtable size 4 at 0x8e6b70 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG1 [3421/3421]: Connecting to error socket /var/run/lttng/ustconsumerd64/error (in main() at lttng-consumerd.c:361)

DEBUG2 [3300/3422]: Receiving code from consumer err_sock (in thread_manage_consumer() at main.c:1007)

DEBUG1 [3421/3426]: Creating command socket /var/run/lttng/ustconsumerd64/command (in consumer_thread_sessiond_poll() at consumer.c:2891)

DEBUG1 [3421/3426]: Sending ready command to lttng-sessiond (in consumer_thread_sessiond_poll() at consumer.c:2904)

DEBUG1 [3300/3422]: Consumer command socket ready (fd: 30 (in thread_manage_consumer() at main.c:1042)

DEBUG1 [3300/3422]: Consumer metadata socket ready (fd: 31) (in thread_manage_consumer() at main.c:1044)

DEBUG3 [3300/3401]: Consumer socket created (fd: 30) and added to output (in consumer_create_socket() at consumer.c:298)

DEBUG1 [3300/3401]: Setting relayd for session snapsfind (in cmd_setup_relayd() at cmd.c:665)

DEBUG1 [3300/3401]: Enabling channel ch0 for session snapsfind (in cmd_enable_channel() at cmd.c:849)

DEBUG2 [3300/3401]: Trace UST channel ch0 not found by name (in trace_ust_find_channel_by_name() at trace-ust.c:149)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f37040049f0 of type 0 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3401]: Created hashtable size 4 at 0x7f3704004d20 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG2 [3300/3401]: Trace UST channel ch0 created (in trace_ust_create_channel() at trace-ust.c:302)

DEBUG2 [3300/3401]: Channel ch0 is being created for UST with buffer 0 and id 0 (in channel_ust_create() at channel.c:343)

DEBUG2 [3300/3401]: UST app adding channel ch0 to UST domain for session id 0 (in ust_app_create_channel_glb() at ust-app.c:3511)

DEBUG2 [3300/3401]: Channel ch0 created successfully (in channel_ust_create() at channel.c:367)

DEBUG1 [3300/3401]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3803)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3421/3426]: Connection on client_socket (in consumer_thread_sessiond_poll() at consumer.c:2921)

DEBUG1 [3421/3426]: Metadata connection on client_socket (in set_metadata_socket() at consumer.c:2860)

DEBUG3 [3421/3425]: Created hashtable size 4 at 0x7fa6200008e0 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG1 [3421/3425]: Updating poll fd array (in update_poll_array() at consumer.c:957)

DEBUG1 [3421/3425]: polling on 1 fd (in consumer_thread_data_poll() at consumer.c:2402)

DEBUG3 [3421/3424]: Created hashtable size 4 at 0x7fa6180008e0 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG1 [3421/3424]: Thread metadata poll started (in consumer_thread_metadata_poll() at consumer.c:2157)

DEBUG1 [3421/3424]: Metadata main loop started (in consumer_thread_metadata_poll() at consumer.c:2173)

DEBUG1 [3421/3424]: Metadata poll wait with 1 fd(s) (in consumer_thread_metadata_poll() at consumer.c:2182)

DEBUG3 [3421/3423]: Created hashtable size 4 at 0x7fa61c0008e0 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG1 [3421/3423]: Thread channel poll started (in consumer_thread_channel_poll() at consumer.c:2661)

DEBUG1 [3421/3423]: Channel main loop started (in consumer_thread_channel_poll() at consumer.c:2676)

DEBUG1 [3421/3423]: Channel poll wait with 1 fd(s) (in consumer_thread_channel_poll() at consumer.c:2685)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Processing client command 6 (in process_client_msg() at main.c:2578)

DEBUG1 [3300/3401]: Getting session snapsfind by name (in process_client_msg() at main.c:2655)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG3 [3300/3401]: Consumer socket created (fd: 30) and added to output (in consumer_create_socket() at consumer.c:298)

DEBUG1 [3300/3401]: Setting relayd for session snapsfind (in cmd_setup_relayd() at cmd.c:665)

DEBUG2 [3300/3401]: Trace UST channel ch0 found by name (in trace_ust_find_channel_by_name() at trace-ust.c:144)

DEBUG2 [3300/3401]: Trace UST event * NOT found (in trace_ust_find_event() at trace-ust.c:183)

DEBUG2 [3300/3401]: Trace UST event *, loglevel (0,-1) created (in trace_ust_create_event() at trace-ust.c:374)

DEBUG1 [3300/3401]: UST app creating event * for all apps for session id 0 (in ust_app_create_event_glb() at ust-app.c:3664)

DEBUG1 [3300/3401]: Event UST * created in channel ch0 (in event_ust_enable_tracepoint() at event.c:467)

DEBUG1 [3300/3401]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3803)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Processing client command 16 (in process_client_msg() at main.c:2578)

DEBUG1 [3300/3401]: Getting session snapsfind by name (in process_client_msg() at main.c:2655)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG1 [3300/3401]: Starting all UST traces (in ust_app_start_trace_all() at ust-app.c:4011)

DEBUG1 [3300/3401]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3803)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3403]: UST registration received with pid:3432 ppid:2683 uid:1000 gid:1000 sock:27 name:sample (version 5.0) (in thread_registration_apps() at main.c:1877)

DEBUG1 [3300/3403]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)

DEBUG1 [3300/3403]: Accepting application registration (in thread_registration_apps() at main.c:1781)

DEBUG1 [3300/3402]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)

DEBUG1 [3300/3402]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)

DEBUG1 [3300/3402]: Dispatching UST registration pid:3432 ppid:2683 uid:1000 gid:1000 sock:27 name:sample (version 5.0) (in thread_dispatch_ust_registration() at main.c:1556)

DEBUG3 [3300/3402]: UST app creating application for socket 27 (in ust_app_create() at ust-app.c:2763)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x57e680 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x57ea40 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG1 [3300/3402]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1544)

DEBUG1 [3300/3403]: UST registration received with pid:3432 ppid:2683 uid:1000 gid:1000 sock:32 name:sample (version 5.0) (in thread_registration_apps() at main.c:1877)

DEBUG1 [3300/3403]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)

DEBUG1 [3300/3403]: Accepting application registration (in thread_registration_apps() at main.c:1781)

DEBUG1 [3300/3402]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)

DEBUG1 [3300/3402]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.c:75)

DEBUG1 [3300/3402]: Dispatching UST registration pid:3432 ppid:2683 uid:1000 gid:1000 sock:32 name:sample (version 5.0) (in thread_dispatch_ust_registration() at main.c:1556)

DEBUG3 [3300/3402]: UST app notify socket 32 is set (in thread_dispatch_ust_registration() at main.c:1613)

DEBUG1 [3300/3402]: App registered with pid:3432 ppid:2683 uid:1000 gid:1000 sock:27 name:sample notify_sock:32 (version 5.0) (in ust_app_add() at ust-app.c:2851)

DEBUG2 [3300/3402]: UST app global update for app sock 27 for session id 0 (in ust_app_global_update() at ust-app.c:4150)

DEBUG2 [3300/3402]: UST app pid: 3432 session id 0 not found, creating it (in create_ust_app_session() at ust-app.c:1735)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x57feb0 of type 0 (in lttng_ht_new() at hashtable.c:112)

DEBUG2 [3300/3402]: Shadow copy of session handle -1 (in shadow_copy_session() at ust-app.c:1494)

DEBUG2 [3300/3402]: Channel ch0 not found on shadow session copy, creating it (in shadow_copy_session() at ust-app.c:1541)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x580f90 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x581230 of type 0 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3402]: UST app channel ch0 allocated (in alloc_ust_app_channel() at ust-app.c:844)

DEBUG2 [3300/3402]: UST app shadow copy of channel ch0 started (in shadow_copy_channel() at ust-app.c:1421)

DEBUG2 [3300/3402]: UST event * not found on shadow copy channel (in shadow_copy_channel() at ust-app.c:1461)

DEBUG3 [3300/3402]: UST app event * allocated (in alloc_ust_app_event() at ust-app.c:900)

DEBUG3 [3300/3402]: UST app shadow copy of channel ch0 done (in shadow_copy_channel() at ust-app.c:1471)

DEBUG3 [3300/3402]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x581980 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3402]: Buffer registry per PID created with session id: 1 (in buffer_reg_pid_create() at buffer-registry.c:262)

DEBUG3 [3300/3402]: Buffer registry per PID adding to global registry with id: 1 (in buffer_reg_pid_add() at buffer-registry.c:281)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x581de0 of type 2 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3402]: 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 = "c2daabde-3351-487c-ae17-d9d4413b0368";

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 [3300/3402]: Append to metadata: "env {

hostname = "sds-dut-vb";

domain = "ust";

tracer_name = "lttng-ust";

tracer_major = 2;

tracer_minor = 3;

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3402]: Append to metadata: " tracer_patchlevel = 0;

vpid = 3432;

procname = "sample";

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3402]: Append to metadata: "};

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3402]: Append to metadata: "clock {

name = monotonic;

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3402]: Append to metadata: " uuid = "c58b66f1-d93f-40c5-b471-c906e2e794e0";

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3402]: Append to metadata: " description = "Monotonic Clock";

freq = 1000000000; /* Frequency, in Hz */

/* clock value offset from Epoch is: offset * (1/freq) */

offset = 1378321059513453599;

};

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3402]: 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 [3300/3402]: 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 [3300/3402]: 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 [3300/3402]: UST app buffer registry per PID created successfully (in setup_buffer_reg_pid() at ust-app.c:1639)

DEBUG3 [3300/3405]: UST thread notify added sock 32 to pollset (in ust_thread_manage_notify() at ust-thread.c:131)

DEBUG3 [3300/3405]: [ust-thread] Manage notify polling on 3 fds (in ust_thread_manage_notify() at ust-thread.c:61)

DEBUG2 [3300/3402]: UST app session created successfully with handle 1 (in create_ust_app_session() at ust-app.c:1803)

DEBUG1 [3300/3402]: UST app creating channel ch0 with per PID buffers (in create_channel_per_pid() at ust-app.c:2405)

DEBUG3 [3300/3402]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x582220 of type 0 (in lttng_ht_new() at hashtable.c:112)

DEBUG2 [3300/3402]: Asking UST consumer for channel (in ask_channel_creation() at ust-consumer.c:118)

DEBUG3 [3300/3402]: UST registry channel finding key 1 (in ust_registry_channel_find() at ust-registry.c:489)

DEBUG1 [3421/3426]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2954)

DEBUG1 [3421/3426]: Allocated channel (key 1) (in consumer_allocate_channel() at consumer.c:889)

DEBUG3 [3421/3426]: Creating channel to ustctl with attr: [overwrite: 1, 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:353)

DEBUG3 [3421/3426]: Allocated stream ch0_0 (key 23, chan_key 1 relayd_id 18446744073709551615, session_id 0 (in consumer_allocate_stream() at consumer.c:538)

DEBUG1 [3421/3426]: UST consumer add stream ch0_0 (key: 23) with relayd id 0 (in create_ust_streams() at ust-consumer.c:313)

DEBUG1 [3421/3426]: UST consumer channel added (key: 1) (in add_channel() at ust-consumer.c:106)

DEBUG1 [3421/3426]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2972)

DEBUG2 [3300/3402]: UST ask channel 1 successfully done with 1 stream(s) (in ask_channel_creation() at ust-consumer.c:187)

DEBUG1 [3421/3426]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2954)

DEBUG1 [3421/3426]: UST consumer sending channel ch0 to sessiond (in send_sessiond_channel() at ust-consumer.c:409)

DEBUG1 [3421/3426]: UST consumer sending stream 23 to sessiond (in send_sessiond_stream() at ust-consumer.c:381)

DEBUG2 [3300/3402]: UST app stream 1 received succesfully (in ust_consumer_get_channel() at ust-consumer.c:302)

DEBUG3 [3300/3402]: UST app consumer has no more stream available (in ust_consumer_get_channel() at ust-consumer.c:285)

DEBUG1 [3421/3426]: UST consumer NULL stream sent to sessiond (in send_sessiond_channel() at ust-consumer.c:464)

DEBUG1 [3300/3402]: UST app sending channel ch0 to UST app sock 27 (in send_channel_pid_to_ust() at ust-app.c:1284)

DEBUG2 [3300/3402]: UST app send channel to sock 27 pid 3432 (name: ch0, key: 0) (in ust_consumer_send_channel_to_ust() at ust-consumer.c:405)

DEBUG1 [3421/3426]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2972)

DEBUG1 [3421/3423]: Channel event catched in thread (in consumer_thread_channel_poll() at consumer.c:2687)

DEBUG1 [3421/3423]: Adding channel 21 to poll set (in consumer_thread_channel_poll() at consumer.c:2729)

DEBUG1 [3421/3423]: Channel poll wait with 2 fd(s) (in consumer_thread_channel_poll() at consumer.c:2685)

DEBUG2 [3300/3402]: UST consumer send stream to app 27 (in ust_consumer_send_stream_to_ust() at ust-consumer.c:370)

DEBUG2 [3300/3402]: UST app event * created successfully for pid:3432 (in create_ust_event() at ust-app.c:1347)

DEBUG1 [3300/3402]: Starting tracing for ust app pid 3432 (in ust_app_start_trace() at ust-app.c:3719)

DEBUG3 [3300/3402]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x583fe0 of type 1 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3402]: Created hashtable size 4 at 0x584280 of type 0 (in lttng_ht_new() at hashtable.c:112)

DEBUG3 [3300/3402]: UST app channel metadata allocated (in alloc_ust_app_channel() at ust-app.c:844)

DEBUG2 [3300/3402]: Asking UST consumer for channel (in ask_channel_creation() at ust-consumer.c:118)

DEBUG1 [3421/3426]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2954)

DEBUG1 [3421/3426]: Allocated channel (key 2) (in consumer_allocate_channel() at consumer.c:889)

DEBUG3 [3421/3426]: Creating channel to ustctl with attr: [overwrite: 0, subbuf_size: 4096, num_subbuf: 2, switch_timer_interval: 0, read_timer_interval: 0, output: 0, type: 1 (in create_ust_channel() at ust-consumer.c:353)

DEBUG1 [3421/3426]: Allocated metadata cache of 4096 bytes (in consumer_metadata_cache_allocate() at consumer-metadata-cache.c:158)

DEBUG1 [3421/3426]: UST consumer channel added (key: 2) (in add_channel() at ust-consumer.c:106)

DEBUG1 [3421/3426]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2972)

DEBUG2 [3300/3402]: UST ask channel 2 successfully done with 0 stream(s) (in ask_channel_creation() at ust-consumer.c:187)

DEBUG2 [3300/3402]: Consumer setup metadata channel key 2 (in consumer_setup_metadata() at consumer.c:1169)

DEBUG1 [3421/3426]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2954)

DEBUG1 [3421/3426]: UST consumer setup metadata key 2 (in setup_metadata() at ust-consumer.c:700)

DEBUG1 [3421/3426]: Metadata channel in no monitor (in setup_metadata() at ust-consumer.c:714)

DEBUG1 [3421/3426]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2972)

DEBUG2 [3300/3402]: UST metadata with key 2 created for app pid 3432 (in create_ust_app_metadata() at ust-app.c:2707)

DEBUG3 [3300/3402]: UST app deleting channel metadata (in delete_ust_app_channel() at ust-app.c:357)

DEBUG3 [3300/3402]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3402]: UST registry channel finding key 2 (in ust_registry_channel_find() at ust-registry.c:489)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3405]: UST app receiving notify from sock 32 (in ust_app_recv_notify() at ust-app.c:4787)

DEBUG2 [3300/3405]: UST app ustctl register channel received (in ust_app_recv_notify() at ust-app.c:4840)

DEBUG3 [3300/3405]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3405]: UST registry channel finding key 1 (in ust_registry_channel_find() at ust-registry.c:489)

DEBUG3 [3300/3405]: 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 [3300/3405]: Append to metadata: "};

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3405]: UST app replying to register channel key 1 with id 0, type: 1, ret: 0 (in reply_ust_register_channel() at ust-app.c:4653)

DEBUG3 [3300/3405]: [ust-thread] Manage notify polling on 3 fds (in ust_thread_manage_notify() at ust-thread.c:61)

DEBUG2 [3300/3402]: UST trace started for app pid 3432 (in ust_app_global_update() at ust-app.c:4241)

DEBUG1 [3300/3402]: Woken up but nothing in the UST command queue (in thread_dispatch_ust_registration() at main.c:1544)

DEBUG1 [3300/3404]: Apps with sock 27 added to poll set (in thread_manage_apps() at main.c:1323)

DEBUG1 [3300/3404]: Apps thread polling on 3 fds (in thread_manage_apps() at main.c:1248)

DEBUG3 [3300/3405]: UST app receiving notify from sock 32 (in ust_app_recv_notify() at ust-app.c:4787)

DEBUG2 [3300/3405]: UST app ustctl register event received (in ust_app_recv_notify() at ust-app.c:4807)

DEBUG3 [3300/3405]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3405]: UST registry channel finding key 1 (in ust_registry_channel_find() at ust-registry.c:489)

DEBUG3 [3300/3405]: UST registry creating event with event: sample_component:message, sig: char *, text, id: 0, chan_objd: 2, sess_objd: 1, chan_id: 0 (in ust_registry_create_event() at ust-registry.c:298)

DEBUG3 [3300/3405]: Append to metadata: "event {

name = "sample_component:message";

id = 0;

stream_id = 0;

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3405]: Append to metadata: " loglevel = 4;

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3405]: Append to metadata: " fields := struct {

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3405]: Append to metadata: " string _message;

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3405]: Append to metadata: " };

};

" (in lttng_metadata_printf() at ust-metadata.c:144)

DEBUG3 [3300/3405]: UST registry event sample_component:message with id 0 added successfully (in add_event_ust_registry() at ust-app.c:4768)

DEBUG3 [3300/3405]: [ust-thread] Manage notify polling on 3 fds (in ust_thread_manage_notify() at ust-thread.c:61)

DEBUG1 [3300/3404]: PID 3432 unregistering with sock 27 (in ust_app_unregister() at ust-app.c:2902)

DEBUG3 [3300/3404]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG2 [3300/3404]: Consumer push metadata to consumer socket 30 (in consumer_push_metadata() at consumer.c:1202)

DEBUG1 [3421/3426]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2954)

DEBUG1 [3421/3426]: UST consumer push metadata key 2 of len 2483 (in lttng_ustconsumer_recv_cmd() at ust-consumer.c:1382)

DEBUG3 [3300/3404]: Consumer pushing metadata on sock 30 of len 2483 (in consumer_push_metadata() at consumer.c:1216)

DEBUG1 [3421/3426]: UST consumer push metadata key 2 of len 2483 (in lttng_ustconsumer_recv_metadata() at ust-consumer.c:1030)

DEBUG1 [3421/3426]: Writing 2483 bytes from offset 0 in metadata cache (in consumer_metadata_cache_write() at consumer-metadata-cache.c:90)

DEBUG1 [3421/3426]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2972)

DEBUG2 [3300/3404]: Consumer close metadata channel key 2 (in consumer_close_metadata() at consumer.c:1137)

DEBUG1 [3421/3426]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2954)

DEBUG1 [3421/3426]: UST consumer close metadata key 2 (in close_metadata() at ust-consumer.c:659)

DEBUG1 [3421/3426]: received command on sock (in consumer_thread_sessiond_poll() at consumer.c:2972)

DEBUG1 [3300/3404]: Apps thread polling on 2 fds (in thread_manage_apps() at main.c:1248)

DEBUG1 [3300/3405]: UST app notify socket unregister 32 (in ust_app_notify_sock_unregister() at ust-app.c:4914)

DEBUG2 [3300/3405]: UST app find by notify sock 32 not found (in find_app_by_notify_sock() at ust-app.c:992)

DEBUG3 [3300/3405]: [ust-thread] Manage notify polling on 2 fds (in ust_thread_manage_notify() at ust-thread.c:61)

DEBUG3 [3300/3435]: Call RCU deleting app PID 3432 (in delete_ust_app_rcu() at ust-app.c:743)

DEBUG3 [3300/3435]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3435]: UST app deleting channel ch0 (in delete_ust_app_channel() at ust-app.c:357)

DEBUG3 [3300/3435]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3435]: UST registry channel finding key 1 (in ust_registry_channel_find() at ust-registry.c:489)

DEBUG1 [3421/3423]: Channel event catched in thread (in consumer_thread_channel_poll() at consumer.c:2687)

DEBUG1 [3421/3423]: Channel fd 21 is hup|err. (in consumer_thread_channel_poll() at consumer.c:2819)

DEBUG1 [3421/3423]: Consumer delete channel key 1 (in consumer_del_channel() at consumer.c:291)

DEBUG1 [3421/3423]: Consumer stream destroy monitored key: 23 (in destroy_close_stream() at consumer-stream.c:230)

DEBUG1 [3421/3423]: Channel poll wait with 1 fd(s) (in consumer_thread_channel_poll() at consumer.c:2685)

DEBUG3 [3300/3435]: Buffer registry per PID find id: 1 (in buffer_reg_pid_find() at buffer-registry.c:301)

DEBUG3 [3300/3435]: Buffer registry per PID destroy with id: 1 (in buffer_reg_pid_destroy() at buffer-registry.c:686)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG2 [3300/3435]: UST app pid 3432 deleted (in delete_ust_app() at ust-app.c:728)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3435]: Buffer registry session destroy (in buffer_reg_session_destroy() at buffer-registry.c:543)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Processing client command 28 (in process_client_msg() at main.c:2578)

DEBUG1 [3300/3401]: Getting session snapsfind by name (in process_client_msg() at main.c:2655)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG1 [3300/3401]: Cmd snapshot record for session snapsfind (in cmd_snapshot_record() at cmd.c:2685)

DEBUG2 [3300/3401]: Set relayd object from snapshot output (in set_relayd_for_snapshot() at cmd.c:2507)

DEBUG1 [3300/3401]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3803)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Nothing recv() from client... continuing (in thread_manage_clients() at main.c:3758)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3401]: Wait for client response (in thread_manage_clients() at main.c:3709)

DEBUG1 [3300/3401]: Receiving data from client ... (in thread_manage_clients() at main.c:3754)

DEBUG1 [3300/3401]: Processing client command 9 (in process_client_msg() at main.c:2578)

DEBUG1 [3300/3401]: Getting session snapsfind by name (in process_client_msg() at main.c:2655)

DEBUG2 [3300/3401]: Trying to find session by name snapsfind (in session_find_by_name() at session.c:133)

DEBUG3 [3300/3401]: No kernel session when tearing down session (in kernel_destroy_session() at kernel.c:751)

DEBUG1 [3300/3401]: Destroy all UST traces (in ust_app_destroy_trace_all() at ust-app.c:4116)

DEBUG2 [3300/3401]: Trace UST destroy session 0 (in trace_ust_destroy_session() at trace-ust.c:676)

DEBUG1 [3300/3401]: Destroying session snapsfind (in session_destroy() at session.c:158)

DEBUG1 [3300/3401]: Sending response (size: 16, retcode: Success) (in thread_manage_clients() at main.c:3803)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Accepting client command ... (in thread_manage_clients() at main.c:3667)

DEBUG1 [3300/3406]: Updating kernel poll set (in update_kernel_poll() at main.c:616)

DEBUG1 [3300/3406]: Thread kernel polling on 2 fds (in thread_manage_kernel() at main.c:801)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG2 [3300/3435]: Trace destroy UST channel ch0 (in _trace_ust_destroy_channel() at trace-ust.c:573)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG3 [3300/3399]: [ht-thread] Polling on 2 fds. (in thread_ht_cleanup() at ht-cleanup.c:58)

DEBUG2 [3300/3435]: Trace destroy UST event * (in trace_ust_destroy_event() at trace-ust.c:524)

DEBUG1 [3421/3421]: ignoring first SIGINT (in sighandler() at lttng-consumerd.c:81)

DEBUG1 [3300/3300]: SIGINT caught (in sighandler() at main.c:4269)

DEBUG1 [3300/3300]: Terminating all threads (in stop_threads() at main.c:379)

DEBUG1 [3300/3300]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)

DEBUG1 [3300/3406]: Kernel thread dying (in thread_manage_kernel() at main.c:884)

DEBUG1 [3300/3422]: consumer thread cleanup completed (in thread_manage_consumer() at main.c:1204)

DEBUG1 [3300/3400]: Health check thread dying (in thread_manage_health() at main.c:3594)

DEBUG1 [3300/3403]: Notifying applications of session daemon state: 0 (in notify_ust_apps() at main.c:555)

DEBUG1 [3300/3403]: Got the wait shm fd 7 (in get_wait_shm() at shm.c:119)

DEBUG1 [3300/3403]: Futex wait update active 0 (in futex_wait_update() at futex.c:63)

DEBUG1 [3300/3403]: UST Registration thread cleanup complete (in thread_registration_apps() at main.c:1925)

DEBUG1 [3300/3404]: Application communication apps thread cleanup complete (in thread_manage_apps() at main.c:1370)

DEBUG1 [3300/3405]: Application notify communication apps thread cleanup complete (in ust_thread_manage_notify() at ust-thread.c:174)

DEBUG1 [3300/3402]: Futex n to 1 wait done (in futex_nto1_wait() at futex.c:90)

DEBUG1 [3300/3402]: Dispatch thread dying (in thread_dispatch_ust_registration() at main.c:1721)

DEBUG1 [3421/3426]: Incoming command on sock (in consumer_thread_sessiond_poll() at consumer.c:2954)

DEBUG1 [3421/3426]: Consumer received unexpected message size 0 (expects 4472) (in lttng_ustconsumer_recv_cmd() at ust-consumer.c:1089)

DEBUG1 [3421/3426]: Communication interrupted on command socket (in consumer_thread_sessiond_poll() at consumer.c:2965)

DEBUG1 [3421/3426]: Consumer thread sessiond poll exiting (in consumer_thread_sessiond_poll() at consumer.c:2975)

DEBUG1 [3421/3426]: UST consumer closing all metadata streams (in lttng_ustconsumer_close_metadata() at ust-consumer.c:1831)

DEBUG1 [3421/3425]: poll num_rdy : 1 (in consumer_thread_data_poll() at consumer.c:2404)

DEBUG1 [3421/3425]: consumer_data_pipe wake up (in consumer_thread_data_poll() at consumer.c:2428)

DEBUG1 [3421/3425]: Consumer delete flagged data stream (in validate_endpoint_status_data_stream() at consumer.c:2089)

DEBUG1 [3421/3425]: polling thread exiting (in consumer_thread_data_poll() at consumer.c:2547)

DEBUG1 [3421/3424]: Metadata event catched in thread (in consumer_thread_metadata_poll() at consumer.c:2184)

DEBUG1 [3421/3424]: Metadata thread pipe hung up (in consumer_thread_metadata_poll() at consumer.c:2202)

DEBUG1 [3421/3424]: Metadata poll thread exiting (in consumer_thread_metadata_poll() at consumer.c:2312)

DEBUG1 [3300/3300]: SIGINT caught (in sighandler() at main.c:4269)

DEBUG1 [3300/3300]: Terminating all threads (in stop_threads() at main.c:379)

DEBUG1 [3300/3300]: Futex n to 1 wake done (in futex_nto1_wake() at futex.c:104)

DEBUG1 [3300/3399]: [ust-thread] cleanup complete. (in thread_ht_cleanup() at ht-cleanup.c:130)

DEBUG1 [3300/3401]: Clean command context structure (in clean_command_ctx() at main.c:535)

DEBUG1 [3300/3401]: Client thread dying (in thread_manage_clients() at main.c:3851)

DEBUG1 [3300/3300]: Cleaning up (in cleanup() at main.c:444)

DEBUG1 [3300/3300]: Removing /var/run/lttng directory (in cleanup() at main.c:463)

DEBUG1 [3421/3423]: Channel event catched in thread (in consumer_thread_channel_poll() at consumer.c:2687)

DEBUG1 [3421/3423]: Channel poll thread exiting (in consumer_thread_channel_poll() at consumer.c:2843)

PERROR [3421/3421]: sendmsg: Broken pipe (in lttcomm_send_unix_sock() at unix.c:218)

DEBUG1 [3421/3421]: Consumer destroying it. Closing everything. (in lttng_consumer_destroy() at consumer.c:1245)

DEBUG1 [3421/3421]: Consumer delete channel key 2 (in consumer_del_channel() at consumer.c:291)

DEBUG1 [3421/3421]: Destroying metadata cache (in consumer_metadata_cache_destroy() at consumer-metadata-cache.c:180)

DEBUG1 [3300/3300]: Cleaning up all sessions (in cleanup() at main.c:477)

DEBUG1 [3300/3300]: Closing all UST sockets (in cleanup() at main.c:490)

DEBUG2 [3300/3300]: UST app cleaning registered apps hash table (in ust_app_clean_list() at ust-app.c:3216)

DEBUG3 [3300/3300]: Buffer registry destroy all registry (in buffer_reg_destroy_registries() at buffer-registry.c:699)

DEBUG2 [3300/3300]: Closing kernel fd (in cleanup() at main.c:495)

DEBUG1 [3300/3300]: Unloading kernel modules (in cleanup() at main.c:502)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-writeback (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-workqueue (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-vmscan (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-udp (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-timer (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-sunrpc (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-statedump (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-sock (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-skb (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-signal (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-scsi (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-sched (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-rpm (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-regulator (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-regmap (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-rcu (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-random (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-printk (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-power (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-net (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-napi (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-module (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-lock (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-kvm-x86-mmu (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-kvm-x86 (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-kvm (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-kmem (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-jbd2 (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-jbd (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-irq (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-gpio (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-ext4 (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-ext3 (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-compaction (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-btrfs (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-block (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-probe-asoc (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-types (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-ring-buffer-metadata-mmap-client (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-ring-buffer-client-mmap-overwrite (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-ring-buffer-client-mmap-discard (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-ring-buffer-metadata-client (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-ring-buffer-client-overwrite (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-ring-buffer-client-discard (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-lib-ring-buffer (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-kretprobes (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-kprobes (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-ftrace (in modprobe_remove_lttng_data() at modprobe.c:147)

DEBUG1 [3300/3300]: Modprobe removal successful lttng-tracer (in modprobe_remove_lttng_control() at modprobe.c:112)

DEBUG1 [3300/3300]: *** assert failed :-) *** ==> Matthew, BEET driven development works! (in cleanup() at main.c:511)