X-Git-Url: http://git.bitcoin.ninja/index.cgi?a=blobdiff_plain;f=lightning%2Fsrc%2Futil%2Fmacro_logger.rs;h=8c2aba0c1c1cf87ac15ec95076a3a5cc05ea1330;hb=71739dbe0495b3aed4ce907fea88c122df9ac6a1;hp=3ac294fbff9097686d4d28df669bcab76c402f5e;hpb=f4729075cbfef9f99e8316335dd1e8d15671674d;p=rust-lightning diff --git a/lightning/src/util/macro_logger.rs b/lightning/src/util/macro_logger.rs index 3ac294fb..8c2aba0c 100644 --- a/lightning/src/util/macro_logger.rs +++ b/lightning/src/util/macro_logger.rs @@ -7,43 +7,29 @@ // You may not use this file except in accordance with one or both of these // licenses. -use chain::transaction::OutPoint; -use chain::keysinterface::SpendableOutputDescriptor; +use crate::chain::transaction::OutPoint; +use crate::chain::keysinterface::SpendableOutputDescriptor; use bitcoin::hash_types::Txid; use bitcoin::blockdata::transaction::Transaction; -use bitcoin::secp256k1::key::PublicKey; -use routing::router::Route; -use ln::chan_utils::HTLCType; +use crate::routing::router::Route; +use crate::ln::chan_utils::HTLCClaim; +use crate::util::logger::DebugBytes; -pub(crate) struct DebugPubKey<'a>(pub &'a PublicKey); -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)?; - } - Ok(()) - } -} +/// Logs a pubkey in hex format. +#[macro_export] macro_rules! log_pubkey { ($obj: expr) => { - ::util::macro_logger::DebugPubKey(&$obj) + $crate::util::logger::DebugPubKey(&$obj) } } -pub(crate) struct DebugBytes<'a>(pub &'a [u8]); -impl<'a> core::fmt::Display for DebugBytes<'a> { - fn fmt(&self, f: &mut core::fmt::Formatter) -> Result<(), core::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) } } @@ -58,7 +44,7 @@ impl<'a> core::fmt::Display for DebugFundingChannelId<'a> { } macro_rules! log_funding_channel_id { ($funding_txid: expr, $funding_txo: expr) => { - ::util::macro_logger::DebugFundingChannelId(&$funding_txid, $funding_txo) + $crate::util::macro_logger::DebugFundingChannelId(&$funding_txid, $funding_txo) } } @@ -70,7 +56,7 @@ impl<'a, T> core::fmt::Display for DebugFundingInfo<'a, T> { } macro_rules! log_funding_info { ($key_storage: expr) => { - ::util::macro_logger::DebugFundingInfo(&$key_storage.get_funding_txo()) + $crate::util::macro_logger::DebugFundingInfo(&$key_storage.get_funding_txo()) } } @@ -88,7 +74,7 @@ impl<'a> core::fmt::Display for DebugRoute<'a> { } macro_rules! log_route { ($obj: expr) => { - ::util::macro_logger::DebugRoute(&$obj) + $crate::util::macro_logger::DebugRoute(&$obj) } } @@ -96,25 +82,34 @@ pub(crate) struct DebugTx<'a>(pub &'a Transaction); 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 { + let first_input = &self.0.input[0]; + let witness_script_len = first_input.witness.last().unwrap_or(&[]).len(); + if self.0.input.len() == 1 && witness_script_len == 71 && + (first_input.sequence.0 >> 8*3) as u8 == 0x80 { write!(f, "commitment tx ")?; - } else if self.0.input.len() == 1 && self.0.input[0].witness.last().unwrap().len() == 71 { + } else if self.0.input.len() == 1 && witness_script_len == 71 { 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 { + } else if self.0.input.len() == 1 && HTLCClaim::from_witness(&first_input.witness) == Some(HTLCClaim::OfferedTimeout) { 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 { + } else if self.0.input.len() == 1 && HTLCClaim::from_witness(&first_input.witness) == Some(HTLCClaim::AcceptedPreimage) { write!(f, "HTLC-success tx ")?; } else { + let mut num_preimage = 0; + let mut num_timeout = 0; + let mut num_revoked = 0; for inp in &self.0.input { - if !inp.witness.is_empty() { - if HTLCType::scriptlen_to_htlctype(inp.witness.last().unwrap().len()) == Some(HTLCType::OfferedHTLC) { write!(f, "preimage-")?; break } - else if HTLCType::scriptlen_to_htlctype(inp.witness.last().unwrap().len()) == Some(HTLCType::AcceptedHTLC) { write!(f, "timeout-")?; break } + let htlc_claim = HTLCClaim::from_witness(&inp.witness); + match htlc_claim { + Some(HTLCClaim::AcceptedPreimage)|Some(HTLCClaim::OfferedPreimage) => num_preimage += 1, + Some(HTLCClaim::AcceptedTimeout)|Some(HTLCClaim::OfferedTimeout) => num_timeout += 1, + Some(HTLCClaim::Revocation) => num_revoked += 1, + None => continue, } } - write!(f, "tx ")?; + if num_preimage > 0 || num_timeout > 0 || num_revoked > 0 { + write!(f, "HTLC claim tx ({} preimage, {} timeout, {} revoked)", + num_preimage, num_timeout, num_revoked)?; + } } } else { debug_assert!(false, "We should never generate unknown transaction types"); @@ -127,7 +122,7 @@ impl<'a> core::fmt::Display for DebugTx<'a> { macro_rules! log_tx { ($obj: expr) => { - ::util::macro_logger::DebugTx(&$obj) + $crate::util::macro_logger::DebugTx(&$obj) } } @@ -142,7 +137,7 @@ impl<'a> core::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(()) @@ -151,20 +146,22 @@ impl<'a> core::fmt::Display for DebugSpendable<'a> { macro_rules! log_spendable { ($obj: expr) => { - ::util::macro_logger::DebugSpendable(&$obj) + $crate::util::macro_logger::DebugSpendable(&$obj) } } /// 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. +#[doc(hidden)] #[macro_export] macro_rules! log_given_level { ($logger: expr, $lvl:expr, $($arg:tt)+) => ( @@ -179,8 +176,10 @@ macro_rules! log_given_level { $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"))] + #[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 }, @@ -188,7 +187,7 @@ macro_rules! log_given_level { ); } -/// Log an error. +/// Log at the `ERROR` level. #[macro_export] macro_rules! log_error { ($logger: expr, $($arg:tt)*) => ( @@ -196,28 +195,42 @@ macro_rules! log_error { ) } +/// Log at the `WARN` level. +#[macro_export] macro_rules! log_warn { ($logger: expr, $($arg:tt)*) => ( log_given_level!($logger, $crate::util::logger::Level::Warn, $($arg)*); ) } +/// Log at the `INFO` level. +#[macro_export] macro_rules! log_info { ($logger: expr, $($arg:tt)*) => ( log_given_level!($logger, $crate::util::logger::Level::Info, $($arg)*); ) } +/// Log at the `DEBUG` level. +#[macro_export] macro_rules! log_debug { ($logger: expr, $($arg:tt)*) => ( log_given_level!($logger, $crate::util::logger::Level::Debug, $($arg)*); ) } -/// Log a trace log. +/// Log at the `TRACE` level. #[macro_export] macro_rules! log_trace { ($logger: expr, $($arg:tt)*) => ( - log_given_level!($logger, $crate::util::logger::Level::Trace, $($arg)*); + log_given_level!($logger, $crate::util::logger::Level::Trace, $($arg)*) + ) +} + +/// Log at the `GOSSIP` level. +#[macro_export] +macro_rules! log_gossip { + ($logger: expr, $($arg:tt)*) => ( + log_given_level!($logger, $crate::util::logger::Level::Gossip, $($arg)*); ) }