// Take a look at the license at the top of the repository in the LICENSE file. use crate::DebugLevel; use libc::c_char; use std::borrow::Cow; use std::ffi::CStr; use std::fmt; use std::ptr; use once_cell::sync::Lazy; use glib::ffi::gpointer; use glib::prelude::*; use glib::translate::*; #[derive(PartialEq, Eq)] pub struct DebugMessage(ptr::NonNull); impl fmt::Debug for DebugMessage { fn fmt(&self, f: &mut fmt::Formatter) -> fmt::Result { f.debug_tuple("DebugMessage").field(&self.get()).finish() } } impl DebugMessage { pub fn get(&self) -> Option> { unsafe { let message = ffi::gst_debug_message_get(self.0.as_ptr()); if message.is_null() { None } else { Some(CStr::from_ptr(message).to_string_lossy()) } } } } #[derive(PartialEq, Eq, Clone, Copy)] pub struct DebugCategory(Option>); impl DebugCategory { pub fn new( name: &str, color: crate::DebugColorFlags, description: Option<&str>, ) -> DebugCategory { skip_assert_initialized!(); extern "C" { fn _gst_debug_category_new( name: *const c_char, color: ffi::GstDebugColorFlags, description: *const c_char, ) -> *mut ffi::GstDebugCategory; } // Gets the category if it exists already unsafe { let ptr = _gst_debug_category_new( name.to_glib_none().0, color.into_glib(), description.to_glib_none().0, ); // Can be NULL if the debug system is compiled out DebugCategory(ptr::NonNull::new(ptr)) } } pub fn get(name: &str) -> Option { skip_assert_initialized!(); unsafe { extern "C" { fn _gst_debug_get_category(name: *const c_char) -> *mut ffi::GstDebugCategory; } let cat = _gst_debug_get_category(name.to_glib_none().0); if cat.is_null() { None } else { Some(DebugCategory(Some(ptr::NonNull::new_unchecked(cat)))) } } } pub fn threshold(self) -> crate::DebugLevel { match self.0 { Some(cat) => unsafe { from_glib(ffi::gst_debug_category_get_threshold(cat.as_ptr())) }, None => crate::DebugLevel::None, } } pub fn set_threshold(self, threshold: crate::DebugLevel) { if let Some(cat) = self.0 { unsafe { ffi::gst_debug_category_set_threshold(cat.as_ptr(), threshold.into_glib()) } } } pub fn reset_threshold(self) { if let Some(cat) = self.0 { unsafe { ffi::gst_debug_category_reset_threshold(cat.as_ptr()) } } } pub fn color(self) -> crate::DebugColorFlags { match self.0 { Some(cat) => unsafe { from_glib(ffi::gst_debug_category_get_color(cat.as_ptr())) }, None => crate::DebugColorFlags::empty(), } } pub fn name<'a>(self) -> &'a str { match self.0 { Some(cat) => unsafe { CStr::from_ptr(ffi::gst_debug_category_get_name(cat.as_ptr())) .to_str() .unwrap() }, None => "", } } pub fn description<'a>(self) -> Option<&'a str> { match self.0 { Some(cat) => unsafe { let ptr = ffi::gst_debug_category_get_description(cat.as_ptr()); if ptr.is_null() { None } else { Some(CStr::from_ptr(ptr).to_str().unwrap()) } }, None => None, } } #[inline] pub fn log>( self, obj: Option<&O>, level: crate::DebugLevel, file: &str, module: &str, line: u32, args: fmt::Arguments, ) { let cat = match self.0 { Some(cat) => cat, None => return, }; unsafe { if level.into_glib() as i32 > cat.as_ref().threshold { return; } } let obj_ptr = match obj { Some(obj) => obj.to_glib_none().0 as *mut glib::gobject_ffi::GObject, None => ptr::null_mut(), }; unsafe { ffi::gst_debug_log( cat.as_ptr(), level.into_glib(), file.to_glib_none().0, module.to_glib_none().0, line as i32, obj_ptr, fmt::format(args).replace("%", "%%").to_glib_none().0, ); } } } unsafe impl Sync for DebugCategory {} unsafe impl Send for DebugCategory {} impl fmt::Debug for DebugCategory { fn fmt(&self, f: &mut fmt::Formatter) -> fmt::Result { f.debug_tuple("DebugCategory").field(&self.name()).finish() } } pub static CAT_RUST: Lazy = Lazy::new(|| { DebugCategory::new( "GST_RUST", crate::DebugColorFlags::UNDERLINE, Some("GStreamer's Rust binding core"), ) }); macro_rules! declare_debug_category_from_name( ($cat:ident, $cat_name:expr) => ( pub static $cat: Lazy = Lazy::new(|| DebugCategory::get($cat_name) .expect(&format!("Unable to find `DebugCategory` with name {}", $cat_name))); ); ); declare_debug_category_from_name!(CAT_DEFAULT, "default"); declare_debug_category_from_name!(CAT_GST_INIT, "GST_INIT"); declare_debug_category_from_name!(CAT_MEMORY, "GST_MEMORY"); declare_debug_category_from_name!(CAT_PARENTAGE, "GST_PARENTAGE"); declare_debug_category_from_name!(CAT_STATES, "GST_STATES"); declare_debug_category_from_name!(CAT_SCHEDULING, "GST_SCHEDULING"); declare_debug_category_from_name!(CAT_BUFFER, "GST_BUFFER"); declare_debug_category_from_name!(CAT_BUFFER_LIST, "GST_BUFFER_LIST"); declare_debug_category_from_name!(CAT_BUS, "GST_BUS"); declare_debug_category_from_name!(CAT_CAPS, "GST_CAPS"); declare_debug_category_from_name!(CAT_CLOCK, "GST_CLOCK"); declare_debug_category_from_name!(CAT_ELEMENT_PADS, "GST_ELEMENT_PADS"); declare_debug_category_from_name!(CAT_PADS, "GST_PADS"); declare_debug_category_from_name!(CAT_PERFORMANCE, "GST_PERFORMANCE"); declare_debug_category_from_name!(CAT_PIPELINE, "GST_PIPELINE"); declare_debug_category_from_name!(CAT_PLUGIN_LOADING, "GST_PLUGIN_LOADING"); declare_debug_category_from_name!(CAT_PLUGIN_INFO, "GST_PLUGIN_INFO"); declare_debug_category_from_name!(CAT_PROPERTIES, "GST_PROPERTIES"); declare_debug_category_from_name!(CAT_NEGOTIATION, "GST_NEGOTIATION"); declare_debug_category_from_name!(CAT_REFCOUNTING, "GST_REFCOUNTING"); declare_debug_category_from_name!(CAT_ERROR_SYSTEM, "GST_ERROR_SYSTEM"); declare_debug_category_from_name!(CAT_EVENT, "GST_EVENT"); declare_debug_category_from_name!(CAT_MESSAGE, "GST_MESSAGE"); declare_debug_category_from_name!(CAT_PARAMS, "GST_PARAMS"); declare_debug_category_from_name!(CAT_CALL_TRACE, "GST_CALL_TRACE"); declare_debug_category_from_name!(CAT_SIGNAL, "GST_SIGNAL"); declare_debug_category_from_name!(CAT_PROBE, "GST_PROBE"); declare_debug_category_from_name!(CAT_REGISTRY, "GST_REGISTRY"); declare_debug_category_from_name!(CAT_QOS, "GST_QOS"); declare_debug_category_from_name!(CAT_META, "GST_META"); declare_debug_category_from_name!(CAT_LOCKING, "GST_LOCKING"); declare_debug_category_from_name!(CAT_CONTEXT, "GST_CONTEXT"); #[macro_export] macro_rules! gst_error( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Error, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Error, $($args)*) }}; ); #[macro_export] macro_rules! gst_warning( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Warning, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Warning, $($args)*) }}; ); #[macro_export] macro_rules! gst_fixme( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Fixme, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Fixme, $($args)*) }}; ); #[macro_export] macro_rules! gst_info( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Info, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Info, $($args)*) }}; ); #[macro_export] macro_rules! gst_debug( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Debug, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Debug, $($args)*) }}; ); #[macro_export] macro_rules! gst_log( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Log, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Log, $($args)*) }}; ); #[macro_export] macro_rules! gst_trace( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Trace, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Trace, $($args)*) }}; ); #[macro_export] macro_rules! gst_memdump( ($cat:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Memdump, obj: $obj, $($args)*) }}; ($cat:expr, $($args:tt)*) => { { $crate::gst_log_with_level!($cat.clone(), level: $crate::DebugLevel::Memdump, $($args)*) }}; ); #[macro_export] macro_rules! gst_log_with_level( ($cat:expr, level: $level:expr, obj: $obj:expr, $($args:tt)*) => { { $crate::DebugCategory::log($cat.clone(), Some($obj), $level, file!(), module_path!(), line!(), format_args!($($args)*)) }}; ($cat:expr, level: $level:expr, $($args:tt)*) => { { $crate::DebugCategory::log($cat.clone(), None as Option<&$crate::glib::Object>, $level, file!(), module_path!(), line!(), format_args!($($args)*)) }}; ); unsafe extern "C" fn log_handler( category: *mut ffi::GstDebugCategory, level: ffi::GstDebugLevel, file: *const c_char, function: *const c_char, line: i32, object: *mut glib::gobject_ffi::GObject, message: *mut ffi::GstDebugMessage, user_data: gpointer, ) where T: Fn(DebugCategory, DebugLevel, &str, &str, u32, Option<&LoggedObject>, &DebugMessage) + Send + Sync + 'static, { if category.is_null() { return; } let category = DebugCategory(Some(ptr::NonNull::new_unchecked(category))); let level = from_glib(level); let file = CStr::from_ptr(file).to_string_lossy(); let function = CStr::from_ptr(function).to_string_lossy(); let line = line as u32; let object = ptr::NonNull::new(object).map(LoggedObject); let message = DebugMessage(ptr::NonNull::new_unchecked(message)); let handler = &*(user_data as *mut T); (handler)( category, level, &file, &function, line, object.as_ref(), &message, ); } unsafe extern "C" fn log_handler_data_free(data: gpointer) { let data = Box::from_raw(data as *mut T); drop(data); } #[derive(Debug)] pub struct DebugLogFunction(ptr::NonNull); // The contained pointer is never dereferenced and has no thread affinity. // It may be convenient to send it or share it between threads to allow cleaning // up log functions from other threads than the one that created it. unsafe impl Send for DebugLogFunction {} unsafe impl Sync for DebugLogFunction {} #[derive(Debug)] pub struct LoggedObject(ptr::NonNull); impl LoggedObject { pub fn as_ptr(&self) -> *mut glib::gobject_ffi::GObject { self.0.as_ptr() } } impl fmt::Display for LoggedObject { fn fmt(&self, f: &mut fmt::Formatter<'_>) -> fmt::Result { unsafe { let ptr = self.0.as_ptr(); let g_type_instance = &mut (*ptr).g_type_instance; if glib::gobject_ffi::g_type_check_instance_is_fundamentally_a( g_type_instance, glib::gobject_ffi::g_object_get_type(), ) != glib::ffi::GFALSE { let type_ = (*g_type_instance.g_class).g_type; if glib::gobject_ffi::g_type_is_a(type_, ffi::gst_pad_get_type()) != glib::ffi::GFALSE { let name_ptr = (*(ptr as *mut ffi::GstObject)).name; let name = if name_ptr.is_null() { "" } else { CStr::from_ptr(name_ptr) .to_str() .unwrap_or("") }; let parent_ptr = (*(ptr as *mut ffi::GstObject)).parent; let parent_name = if parent_ptr.is_null() { "" } else { let name_ptr = (*(parent_ptr as *mut ffi::GstObject)).name; if name_ptr.is_null() { "" } else { CStr::from_ptr(name_ptr) .to_str() .unwrap_or("") } }; write!(f, "{}:{}", parent_name, name) } else if glib::gobject_ffi::g_type_is_a(type_, ffi::gst_object_get_type()) != glib::ffi::GFALSE { let name_ptr = (*(ptr as *mut ffi::GstObject)).name; let name = if name_ptr.is_null() { "" } else { CStr::from_ptr(name_ptr) .to_str() .unwrap_or("") }; write!(f, "{}", name) } else { let type_name = CStr::from_ptr(glib::gobject_ffi::g_type_name(type_)); write!( f, "{}:{:?}", type_name.to_str().unwrap_or(""), ptr ) } } else { write!(f, "{:?}", ptr) } } } } pub fn debug_add_log_function(function: T) -> DebugLogFunction where T: Fn(DebugCategory, DebugLevel, &str, &str, u32, Option<&LoggedObject>, &DebugMessage) + Send + Sync + 'static, { skip_assert_initialized!(); unsafe { let user_data = Box::new(function); let user_data_ptr = Box::into_raw(user_data) as gpointer; ffi::gst_debug_add_log_function( Some(log_handler::), user_data_ptr, Some(log_handler_data_free::), ); DebugLogFunction(ptr::NonNull::new_unchecked(user_data_ptr)) } } pub fn debug_remove_default_log_function() { skip_assert_initialized!(); unsafe { ffi::gst_debug_remove_log_function(None); } } pub fn debug_remove_log_function(log_fn: DebugLogFunction) { skip_assert_initialized!(); unsafe { ffi::gst_debug_remove_log_function_by_data(log_fn.0.as_ptr()); } } #[cfg(test)] mod tests { use super::*; use std::sync::mpsc; use std::sync::{Arc, Mutex}; #[test] fn existing() { crate::init().unwrap(); let perf_cat = DebugCategory::get("GST_PERFORMANCE") .expect("Unable to find `DebugCategory` with name \"GST_PERFORMANCE\""); assert_eq!(perf_cat.name(), CAT_PERFORMANCE.name()); } #[test] fn new_and_log() { crate::init().unwrap(); let cat = DebugCategory::new( "test-cat", crate::DebugColorFlags::empty(), Some("some debug category"), ); gst_error!(cat, "meh"); gst_warning!(cat, "meh"); gst_fixme!(cat, "meh"); gst_info!(cat, "meh"); gst_debug!(cat, "meh"); gst_log!(cat, "meh"); gst_trace!(cat, "meh"); gst_memdump!(cat, "meh"); let obj = crate::Bin::new(Some("meh")); gst_error!(cat, obj: &obj, "meh"); gst_warning!(cat, obj: &obj, "meh"); gst_fixme!(cat, obj: &obj, "meh"); gst_info!(cat, obj: &obj, "meh"); gst_debug!(cat, obj: &obj, "meh"); gst_log!(cat, obj: &obj, "meh"); gst_trace!(cat, obj: &obj, "meh"); gst_memdump!(cat, obj: &obj, "meh"); } #[test] fn log_handler() { crate::init().unwrap(); let cat = DebugCategory::new( "test-cat-log", crate::DebugColorFlags::empty(), Some("some debug category"), ); cat.set_threshold(DebugLevel::Info); let obj = crate::Bin::new(Some("meh")); let (sender, receiver) = mpsc::channel(); let sender = Arc::new(Mutex::new(sender)); let handler = move |category: DebugCategory, level: DebugLevel, _file: &str, _function: &str, _line: u32, _object: Option<&LoggedObject>, message: &DebugMessage| { let cat = DebugCategory::get("test-cat-log").unwrap(); if category != cat { // This test can run in parallel with other tests, including new_and_log above. // We cannot be certain we only see our own messages. return; } assert_eq!(level, DebugLevel::Info); assert_eq!(&message.get().unwrap(), "meh"); let _ = sender.lock().unwrap().send(()); }; debug_remove_default_log_function(); let log_fn = debug_add_log_function(handler); gst_info!(cat, obj: &obj, "meh"); receiver.recv().unwrap(); debug_remove_log_function(log_fn); gst_info!(cat, obj: &obj, "meh2"); assert!(receiver.recv().is_err()); } }