X-Git-Url: http://git.bitcoin.ninja/index.cgi?a=blobdiff_plain;f=lightning%2Fsrc%2Futil%2Fmacro_logger.rs;h=2dd73d8279cff447576817450601c85112adce74;hb=refs%2Fheads%2F2021-12-0.0.104-bindings;hp=ab2b6ceea797235e149d7a8b6a2e50103f45494a;hpb=ee68ffa5fdfcfa8ee7fe70512d9e079d621083bc;p=rust-lightning diff --git a/lightning/src/util/macro_logger.rs b/lightning/src/util/macro_logger.rs index ab2b6cee..2dd73d82 100644 --- a/lightning/src/util/macro_logger.rs +++ b/lightning/src/util/macro_logger.rs @@ -16,12 +16,11 @@ use bitcoin::secp256k1::key::PublicKey; use routing::router::Route; use ln::chan_utils::HTLCType; - -use std; +use util::logger::DebugBytes; pub(crate) struct DebugPubKey<'a>(pub &'a PublicKey); -impl<'a> std::fmt::Display for DebugPubKey<'a> { - fn fmt(&self, f: &mut std::fmt::Formatter) -> Result<(), std::fmt::Error> { +impl<'a> core::fmt::Display for DebugPubKey<'a> { + fn fmt(&self, f: &mut core::fmt::Formatter) -> Result<(), core::fmt::Error> { for i in self.0.serialize().iter() { write!(f, "{:02x}", i)?; } @@ -34,24 +33,17 @@ macro_rules! log_pubkey { } } -pub(crate) struct DebugBytes<'a>(pub &'a [u8]); -impl<'a> std::fmt::Display for DebugBytes<'a> { - fn fmt(&self, f: &mut std::fmt::Formatter) -> Result<(), std::fmt::Error> { - for i in self.0 { - write!(f, "{:02x}", i)?; - } - Ok(()) - } -} +/// Logs a byte slice in hex format. +#[macro_export] macro_rules! log_bytes { ($obj: expr) => { - ::util::macro_logger::DebugBytes(&$obj) + $crate::util::logger::DebugBytes(&$obj) } } pub(crate) struct DebugFundingChannelId<'a>(pub &'a Txid, pub u16); -impl<'a> std::fmt::Display for DebugFundingChannelId<'a> { - fn fmt(&self, f: &mut std::fmt::Formatter) -> Result<(), std::fmt::Error> { +impl<'a> core::fmt::Display for DebugFundingChannelId<'a> { + fn fmt(&self, f: &mut core::fmt::Formatter) -> Result<(), core::fmt::Error> { for i in (OutPoint { txid: self.0.clone(), index: self.1 }).to_channel_id().iter() { write!(f, "{:02x}", i)?; } @@ -65,20 +57,20 @@ macro_rules! log_funding_channel_id { } pub(crate) struct DebugFundingInfo<'a, T: 'a>(pub &'a (OutPoint, T)); -impl<'a, T> std::fmt::Display for DebugFundingInfo<'a, T> { - fn fmt(&self, f: &mut std::fmt::Formatter) -> Result<(), std::fmt::Error> { +impl<'a, T> core::fmt::Display for DebugFundingInfo<'a, T> { + fn fmt(&self, f: &mut core::fmt::Formatter) -> Result<(), core::fmt::Error> { DebugBytes(&(self.0).0.to_channel_id()[..]).fmt(f) } } macro_rules! log_funding_info { ($key_storage: expr) => { - ::util::macro_logger::DebugFundingInfo($key_storage.get_funding_txo()) + ::util::macro_logger::DebugFundingInfo(&$key_storage.get_funding_txo()) } } pub(crate) struct DebugRoute<'a>(pub &'a Route); -impl<'a> std::fmt::Display for DebugRoute<'a> { - fn fmt(&self, f: &mut std::fmt::Formatter) -> Result<(), std::fmt::Error> { +impl<'a> core::fmt::Display for DebugRoute<'a> { + fn fmt(&self, f: &mut core::fmt::Formatter) -> Result<(), core::fmt::Error> { for (idx, p) in self.0.paths.iter().enumerate() { writeln!(f, "path {}:", idx)?; for h in p.iter() { @@ -95,20 +87,20 @@ macro_rules! log_route { } pub(crate) struct DebugTx<'a>(pub &'a Transaction); -impl<'a> std::fmt::Display for DebugTx<'a> { - fn fmt(&self, f: &mut std::fmt::Formatter) -> Result<(), std::fmt::Error> { +impl<'a> core::fmt::Display for DebugTx<'a> { + fn fmt(&self, f: &mut core::fmt::Formatter) -> Result<(), core::fmt::Error> { if self.0.input.len() >= 1 && self.0.input.iter().any(|i| !i.witness.is_empty()) { if self.0.input.len() == 1 && self.0.input[0].witness.last().unwrap().len() == 71 && (self.0.input[0].sequence >> 8*3) as u8 == 0x80 { - write!(f, "commitment tx")?; + write!(f, "commitment tx ")?; } else if self.0.input.len() == 1 && self.0.input[0].witness.last().unwrap().len() == 71 { - write!(f, "closing tx")?; + write!(f, "closing tx ")?; } else if self.0.input.len() == 1 && HTLCType::scriptlen_to_htlctype(self.0.input[0].witness.last().unwrap().len()) == Some(HTLCType::OfferedHTLC) && self.0.input[0].witness.len() == 5 { - write!(f, "HTLC-timeout tx")?; + write!(f, "HTLC-timeout tx ")?; } else if self.0.input.len() == 1 && HTLCType::scriptlen_to_htlctype(self.0.input[0].witness.last().unwrap().len()) == Some(HTLCType::AcceptedHTLC) && self.0.input[0].witness.len() == 5 { - write!(f, "HTLC-success tx")?; + write!(f, "HTLC-success tx ")?; } else { for inp in &self.0.input { if !inp.witness.is_empty() { @@ -116,11 +108,13 @@ impl<'a> std::fmt::Display for DebugTx<'a> { else if HTLCType::scriptlen_to_htlctype(inp.witness.last().unwrap().len()) == Some(HTLCType::AcceptedHTLC) { write!(f, "timeout-")?; break } } } - write!(f, "tx")?; + write!(f, "tx ")?; } } else { - write!(f, "INVALID TRANSACTION")?; + debug_assert!(false, "We should never generate unknown transaction types"); + write!(f, "unknown tx type ").unwrap(); } + write!(f, "with txid {}", self.0.txid())?; Ok(()) } } @@ -132,8 +126,8 @@ macro_rules! log_tx { } pub(crate) struct DebugSpendable<'a>(pub &'a SpendableOutputDescriptor); -impl<'a> std::fmt::Display for DebugSpendable<'a> { - fn fmt(&self, f: &mut std::fmt::Formatter) -> Result<(), std::fmt::Error> { +impl<'a> core::fmt::Display for DebugSpendable<'a> { + fn fmt(&self, f: &mut core::fmt::Formatter) -> Result<(), core::fmt::Error> { match self.0 { &SpendableOutputDescriptor::StaticOutput { ref outpoint, .. } => { write!(f, "StaticOutput {}:{} marked for spending", outpoint.txid, outpoint.index)?; @@ -142,7 +136,7 @@ impl<'a> std::fmt::Display for DebugSpendable<'a> { write!(f, "DelayedPaymentOutput {}:{} marked for spending", descriptor.outpoint.txid, descriptor.outpoint.index)?; } &SpendableOutputDescriptor::StaticPaymentOutput(ref descriptor) => { - write!(f, "DynamicOutputP2WPKH {}:{} marked for spending", descriptor.outpoint.txid, descriptor.outpoint.index)?; + write!(f, "StaticPaymentOutput {}:{} marked for spending", descriptor.outpoint.txid, descriptor.outpoint.index)?; } } Ok(()) @@ -157,10 +151,37 @@ macro_rules! log_spendable { /// Create a new Record and log it. You probably don't want to use this macro directly, /// but it needs to be exported so `log_trace` etc can use it in external crates. +#[doc(hidden)] #[macro_export] macro_rules! log_internal { ($logger: expr, $lvl:expr, $($arg:tt)+) => ( - $logger.log(&$crate::util::logger::Record::new($lvl, format_args!($($arg)+), module_path!(), file!(), line!())); + $logger.log(&$crate::util::logger::Record::new($lvl, format_args!($($arg)+), module_path!(), file!(), line!())) + ); +} + +/// Logs an entry at the given level. +#[macro_export] +macro_rules! log_given_level { + ($logger: expr, $lvl:expr, $($arg:tt)+) => ( + match $lvl { + #[cfg(not(any(feature = "max_level_off")))] + $crate::util::logger::Level::Error => log_internal!($logger, $lvl, $($arg)*), + #[cfg(not(any(feature = "max_level_off", feature = "max_level_error")))] + $crate::util::logger::Level::Warn => log_internal!($logger, $lvl, $($arg)*), + #[cfg(not(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn")))] + $crate::util::logger::Level::Info => log_internal!($logger, $lvl, $($arg)*), + #[cfg(not(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn", feature = "max_level_info")))] + $crate::util::logger::Level::Debug => log_internal!($logger, $lvl, $($arg)*), + #[cfg(not(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn", feature = "max_level_info", feature = "max_level_debug")))] + $crate::util::logger::Level::Trace => log_internal!($logger, $lvl, $($arg)*), + #[cfg(not(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn", feature = "max_level_info", feature = "max_level_debug", feature = "max_level_trace")))] + $crate::util::logger::Level::Gossip => log_internal!($logger, $lvl, $($arg)*), + + #[cfg(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn", feature = "max_level_info", feature = "max_level_debug", feature = "max_level_trace"))] + _ => { + // The level is disabled at compile-time + }, + } ); } @@ -168,29 +189,25 @@ macro_rules! log_internal { #[macro_export] macro_rules! log_error { ($logger: expr, $($arg:tt)*) => ( - #[cfg(not(any(feature = "max_level_off")))] - log_internal!($logger, $crate::util::logger::Level::Error, $($arg)*); + log_given_level!($logger, $crate::util::logger::Level::Error, $($arg)*); ) } macro_rules! log_warn { ($logger: expr, $($arg:tt)*) => ( - #[cfg(not(any(feature = "max_level_off", feature = "max_level_error")))] - log_internal!($logger, $crate::util::logger::Level::Warn, $($arg)*); + log_given_level!($logger, $crate::util::logger::Level::Warn, $($arg)*); ) } macro_rules! log_info { ($logger: expr, $($arg:tt)*) => ( - #[cfg(not(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn")))] - log_internal!($logger, $crate::util::logger::Level::Info, $($arg)*); + log_given_level!($logger, $crate::util::logger::Level::Info, $($arg)*); ) } macro_rules! log_debug { ($logger: expr, $($arg:tt)*) => ( - #[cfg(not(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn", feature = "max_level_info")))] - log_internal!($logger, $crate::util::logger::Level::Debug, $($arg)*); + log_given_level!($logger, $crate::util::logger::Level::Debug, $($arg)*); ) } @@ -198,7 +215,13 @@ macro_rules! log_debug { #[macro_export] macro_rules! log_trace { ($logger: expr, $($arg:tt)*) => ( - #[cfg(not(any(feature = "max_level_off", feature = "max_level_error", feature = "max_level_warn", feature = "max_level_info", feature = "max_level_debug")))] - log_internal!($logger, $crate::util::logger::Level::Trace, $($arg)*); + log_given_level!($logger, $crate::util::logger::Level::Trace, $($arg)*) + ) +} + +/// Log a gossip log. +macro_rules! log_gossip { + ($logger: expr, $($arg:tt)*) => ( + log_given_level!($logger, $crate::util::logger::Level::Gossip, $($arg)*); ) }