2022-06-09 22:26:08.572 [WRN] LTND: open /tmp/lndtest-node2712183908/lnd.conf: no such file or directory 2022-06-09 22:26:08.572 [INF] LTND: Version: 0.15.0-beta.rc5 commit=v0.15.0-beta.rc5-4-gb6750ef, build=development, logging=default, debuglevel=debug 2022-06-09 22:26:08.572 [INF] LTND: Active chain: Bitcoin (network=regtest) 2022-06-09 22:26:08.572 [INF] LTND: Pprof listening on 127.0.0.1:6225 2022-06-09 22:26:08.572 [INF] RPCS: Generating TLS certificates... 2022-06-09 22:26:08.577 [INF] RPCS: Done generating TLS certificates 2022-06-09 22:26:08.578 [DBG] RRPC: Router RPC server successfully register with root gRPC server 2022-06-09 22:26:08.578 [DBG] ARPC: Autopilot RPC server successfully register with root gRPC server 2022-06-09 22:26:08.578 [DBG] IRPC: Invoices RPC server successfully registered with root gRPC server 2022-06-09 22:26:08.578 [DBG] VRPC: Versioner RPC server successfully registered with root gRPC server 2022-06-09 22:26:08.578 [DBG] SGNR: Signer RPC server successfully register with root gRPC server 2022-06-09 22:26:08.579 [DBG] PRPC: Peers RPC server successfully register with root gRPC server 2022-06-09 22:26:08.579 [DBG] NTFR: ChainNotifier RPC server successfully register with root gRPC server 2022-06-09 22:26:08.579 [DBG] DRPC: DEV RPC server successfully register with root the gRPC server 2022-06-09 22:26:08.579 [DBG] NRPC: Neutrino RPC server successfully register with root gRPC server 2022-06-09 22:26:08.579 [DBG] WLKT: WalletKit RPC server successfully registered with root gRPC server 2022-06-09 22:26:08.579 [INF] RPCS: RPC server listening on 127.0.0.1:6223 2022-06-09 22:26:08.579 [DBG] RRPC: Router REST server successfully registered with root REST server 2022-06-09 22:26:08.579 [DBG] ARPC: Autopilot REST server successfully registered with root REST server 2022-06-09 22:26:08.579 [DBG] IRPC: Invoices REST server successfully registered with root REST server 2022-06-09 22:26:08.580 [DBG] VRPC: Versioner REST server successfully registered with root REST server 2022-06-09 22:26:08.580 [DBG] SGNR: Signer REST server successfully registered with root REST server 2022-06-09 22:26:08.580 [DBG] PRPC: Peers REST server successfully registered with root REST server 2022-06-09 22:26:08.580 [DBG] NTFR: ChainNotifier REST server successfully registered with root REST server 2022-06-09 22:26:08.580 [DBG] DRPC: DEV REST server successfully registered with the root REST server 2022-06-09 22:26:08.580 [DBG] NRPC: Neutrino REST server successfully registered with root REST server 2022-06-09 22:26:08.581 [DBG] WLKT: WalletKit REST server successfully registered with root REST server 2022-06-09 22:26:08.585 [INF] RPCS: gRPC proxy started at 127.0.0.1:6224 2022-06-09 22:26:08.585 [INF] LTND: Opening the main database, this might take a few minutes... 2022-06-09 22:26:08.585 [INF] LTND: Opening bbolt database, sync_freelist=false, auto_compact=false 2022-06-09 22:26:08.586 [INF] LTND: Creating local graph and channel state DB instances 2022-06-09 22:26:08.593 [DBG] CHDB: Populating in-memory channel graph, this might take a while... 2022-06-09 22:26:08.593 [DBG] CHDB: Finished populating in-memory channel graph (took 214.76µs, num_node_features=0, num_nodes=0, num_channels=0) 2022-06-09 22:26:08.593 [INF] CHDB: Checking for schema update: latest_version=27, db_version=27 2022-06-09 22:26:08.593 [INF] LTND: Database(s) now open (time_to_open=8.122168ms)! 2022-06-09 22:26:08.598 [INF] CHRE: Primary chain is set to: bitcoin 2022-06-09 22:26:08.612 [INF] LNWL: Started listening for bitcoind block notifications via ZMQ on 127.0.0.1:5558 2022-06-09 22:26:08.612 [INF] LNWL: Started listening for bitcoind transaction notifications via ZMQ on 127.0.0.1:5559 2022-06-09 22:26:08.615 [INF] CHRE: Using external fee estimator http://localhost:6213/fee-estimates.json: cached=false 2022-06-09 22:26:08.644 [INF] LNWL: Opened wallet 2022-06-09 22:26:08.647 [INF] LNWL: The wallet has been unlocked without a time limit 2022-06-09 22:26:08.727 [INF] CHRE: LightningWallet opened 2022-06-09 22:26:08.728 [DBG] LNWL: Locating suitable block for birthday 2022-06-07 22:26:08 +0000 UTC between blocks 0-3938 2022-06-09 22:26:08.729 [DBG] LNWL: Checking candidate block: height=1969, hash=67dde7add48248477d898d2417752057d58d16327757e7933aaa7ea3334fdbd4, timestamp=2022-06-09 21:59:31 +0000 UTC 2022-06-09 22:26:08.729 [INF] HSWC: Cleaning circuits from disk for closed channels 2022-06-09 22:26:08.729 [DBG] HSWC: Found 0 closed channels 2022-06-09 22:26:08.730 [INF] HSWC: Finished cleaning: no closed channels found, no actions taken. 2022-06-09 22:26:08.730 [INF] HSWC: Restoring in-memory circuit state from disk 2022-06-09 22:26:08.730 [INF] HSWC: Payment circuits loaded: num_pending=0, num_open=0 2022-06-09 22:26:08.730 [DBG] LNWL: Checking candidate block: height=984, hash=05cf9d4893ff038a6e4a550e8105548116a1c55fb4d4d62d880a60cdbaa9f9c3, timestamp=2022-06-09 21:48:26 +0000 UTC 2022-06-09 22:26:08.731 [DBG] CRTR: Instantiating mission control with config: Penalty Half Life: 1h0m0s, Apriori Hop Probablity: 0.6, Maximum History: 1000, Apriori Weight: 0.5, Minimum Failure Relax Interval: 1m0s 2022-06-09 22:26:08.731 [DBG] CRTR: Mission control state reconstruction started 2022-06-09 22:26:08.731 [DBG] CRTR: Mission control state reconstruction finished: n=0, time=7.76µs 2022-06-09 22:26:08.731 [DBG] SRVR: Instantiating payment session source with config: AttemptCost=100 + 0.1%, MinRouteProbability=0.01 2022-06-09 22:26:08.731 [DBG] LNWL: Checking candidate block: height=492, hash=3b84f6d74da69b62fe43f10363a1dec3312a085eff7be6f6737d255a59621df8, timestamp=2022-06-09 21:45:08 +0000 UTC 2022-06-09 22:26:08.731 [INF] SWPR: Migrating UTXO nursery finalized TXIDs 2022-06-09 22:26:08.731 [INF] LTND: Channel backup proxy channel notifier starting 2022-06-09 22:26:08.731 [INF] ATPL: Instantiating autopilot with active=false, max_channels=5, allocation=0.600000, min_chan_size=20000, max_chan_size=16777215, private=false, min_confs=1, conf_target=3 2022-06-09 22:26:08.731 [DBG] LTND: Populating dependencies for sub RPC server: SignRPC 2022-06-09 22:26:08.731 [DBG] LTND: Populating dependencies for sub RPC server: WalletKitRPC 2022-06-09 22:26:08.731 [DBG] LTND: Populating dependencies for sub RPC server: AutopilotRPC 2022-06-09 22:26:08.731 [DBG] LTND: Populating dependencies for sub RPC server: ChainRPC 2022-06-09 22:26:08.732 [DBG] LTND: Populating dependencies for sub RPC server: InvoicesRPC 2022-06-09 22:26:08.732 [DBG] LTND: Populating dependencies for sub RPC server: PeersRPC 2022-06-09 22:26:08.732 [DBG] LTND: Populating dependencies for sub RPC server: NeutrinoKitRPC 2022-06-09 22:26:08.732 [DBG] LTND: Populating dependencies for sub RPC server: RouterRPC 2022-06-09 22:26:08.732 [DBG] LTND: Populating dependencies for sub RPC server: WatchtowerRPC 2022-06-09 22:26:08.732 [DBG] LTND: Populating dependencies for sub RPC server: WatchtowerClientRPC 2022-06-09 22:26:08.732 [DBG] LTND: Populating dependencies for sub RPC server: DevRPC 2022-06-09 22:26:08.732 [INF] RRPC: Making macaroons for Router RPC Server at: /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/router.macaroon 2022-06-09 22:26:08.732 [DBG] LNWL: Checking candidate block: height=246, hash=51da78f172c51e02e09eb0efd3baf1bd94fd1e74e8022e0b8b421466e7981db2, timestamp=2022-06-09 21:44:27 +0000 UTC 2022-06-09 22:26:08.732 [INF] IRPC: Baking macaroons for invoices RPC Server at: /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/invoices.macaroon 2022-06-09 22:26:08.732 [INF] SGNR: Making macaroons for Signer RPC Server at: /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/signer.macaroon 2022-06-09 22:26:08.733 [INF] NTFR: Baking macaroons for ChainNotifier RPC Server at: /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/chainnotifier.macaroon 2022-06-09 22:26:08.733 [DBG] LNWL: Checking candidate block: height=123, hash=44a8a7f679eb6cff35b99465d9ff8da1bf435ea9994b505d2c37fd20d22f7536, timestamp=2022-06-09 21:44:07 +0000 UTC 2022-06-09 22:26:08.733 [INF] WLKT: Baking macaroons for WalletKit RPC Server at: /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/walletkit.macaroon 2022-06-09 22:26:08.733 [DBG] RPCS: Starting sub RPC server: RouterRPC 2022-06-09 22:26:08.733 [DBG] RPCS: Starting sub RPC server: AutopilotRPC 2022-06-09 22:26:08.733 [DBG] RPCS: Starting sub RPC server: InvoicesRPC 2022-06-09 22:26:08.733 [DBG] RPCS: Starting sub RPC server: VersionRPC 2022-06-09 22:26:08.733 [DBG] RPCS: Starting sub RPC server: WatchtowerClientRPC 2022-06-09 22:26:08.734 [DBG] RPCS: Starting sub RPC server: SignRPC 2022-06-09 22:26:08.734 [DBG] RPCS: Starting sub RPC server: PeersRPC 2022-06-09 22:26:08.734 [DBG] RPCS: Starting sub RPC server: ChainRPC 2022-06-09 22:26:08.734 [DBG] RPCS: Starting sub RPC server: DevRPC 2022-06-09 22:26:08.734 [DBG] RPCS: Starting sub RPC server: NeutrinoKitRPC 2022-06-09 22:26:08.734 [DBG] RPCS: Starting sub RPC server: WatchtowerRPC 2022-06-09 22:26:08.734 [DBG] RPCS: Starting sub RPC server: WalletKitRPC 2022-06-09 22:26:08.734 [DBG] LNWL: Checking candidate block: height=61, hash=47c459174aa0253c4d495b1b9ab64ac51366d4bf17056e36504e61937cf400ec, timestamp=2022-06-09 21:43:56 +0000 UTC 2022-06-09 22:26:08.734 [INF] LTND: We're not running within systemd or the service type is not 'notify' 2022-06-09 22:26:08.735 [INF] LTND: Waiting for chain backend to finish sync, start_height=3938 2022-06-09 22:26:08.735 [DBG] LNWL: Checking candidate block: height=30, hash=6e823a1d2a3f4b1cea82d4ef6768564eb65eb679528ba9f71613de240a60dc93, timestamp=2022-06-09 21:43:51 +0000 UTC 2022-06-09 22:26:08.737 [DBG] LNWL: Checking candidate block: height=15, hash=022cacd501539ac70a6ba2d03ac104a6c800315092a9c130497c22a87b2957be, timestamp=2022-06-09 21:43:49 +0000 UTC 2022-06-09 22:26:08.738 [DBG] LNWL: Checking candidate block: height=7, hash=1c5b40dc9e5682055db577b78bc7e6d8ba5533b7112deebb4544346787c47024, timestamp=2022-06-09 21:43:47 +0000 UTC 2022-06-09 22:26:08.738 [DBG] LNWL: Checking candidate block: height=3, hash=6daf23f2cc8c2c886d77c4d0ea257e1c1924fa674ae58efb8ddd761a3190f4fa, timestamp=2022-06-09 21:43:46 +0000 UTC 2022-06-09 22:26:08.739 [DBG] LNWL: Checking candidate block: height=1, hash=7e0101d63d7701508b6cea5e1846bf0d0342bcc2c61c408f9e43ca1b5088df62, timestamp=2022-06-09 21:43:45 +0000 UTC 2022-06-09 22:26:08.740 [DBG] LNWL: Checking candidate block: height=0, hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, timestamp=2011-02-02 23:16:42 +0000 UTC 2022-06-09 22:26:08.740 [DBG] LNWL: Found birthday block: height=0, hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, timestamp=2011-02-02 23:16:42 +0000 UTC 2022-06-09 22:26:08.743 [INF] LNWL: Started rescan from block 0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 (height 0) for 0 addresses 2022-06-09 22:26:08.746 [INF] LNWL: Catching up block hashes to height 1, this might take a while 2022-06-09 22:26:08.747 [INF] LNWL: Done catching up block hashes 2022-06-09 22:26:08.748 [INF] LNWL: Rescanned through block 0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 (height 1) 2022-06-09 22:26:12.672 [INF] LNWL: Catching up block hashes to height 3938, this might take a while 2022-06-09 22:26:12.672 [INF] LNWL: Done catching up block hashes 2022-06-09 22:26:12.672 [INF] LNWL: Finished rescan for 0 addresses (synced to block 384892bbd6419156bf5a19a001b44cdae9992897d15b524488ec089e7921d999, height 3938) 2022-06-09 22:26:12.745 [INF] LTND: Chain backend is fully synced (end_height=3938)! 2022-06-09 22:26:12.745 [WRN] HLCK: check: disk space configured with 0 attempts, skipping it 2022-06-09 22:26:12.745 [WRN] HLCK: check: tls configured with 0 attempts, skipping it 2022-06-09 22:26:12.745 [INF] LNWL: SigPool starting 2022-06-09 22:26:12.745 [DBG] HLCK: Monitoring: chain backend 2022-06-09 22:26:12.749 [INF] CHNF: ChannelNotifier starting 2022-06-09 22:26:12.749 [INF] PRNF: PeerNotifier starting 2022-06-09 22:26:12.749 [INF] HSWC: HtlcNotifier starting 2022-06-09 22:26:12.749 [INF] SWPR: Sweeper starting 2022-06-09 22:26:12.749 [INF] UTXN: UTXO nursery starting 2022-06-09 22:26:12.749 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.750 [INF] BRAR: Breach arbiter starting 2022-06-09 22:26:12.750 [DBG] BRAR: Found 0 closing channels, 0 retribution records 2022-06-09 22:26:12.750 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.750 [INF] FNDG: Funding manager starting 2022-06-09 22:26:12.750 [INF] HSWC: HTLC Switch starting 2022-06-09 22:26:12.750 [INF] BRAR: Starting contract observer, watching for breaches. 2022-06-09 22:26:12.751 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.751 [INF] CNCT: ChainArbitrator starting 2022-06-09 22:26:12.751 [INF] DISC: Authenticated Gossiper starting 2022-06-09 22:26:12.751 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.751 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.752 [INF] CRTR: Channel Router starting 2022-06-09 22:26:12.752 [DBG] DISC: New block: height=3938, hash=384892bbd6419156bf5a19a001b44cdae9992897d15b524488ec089e7921d999 2022-06-09 22:26:12.753 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:12.753 [INF] CRTR: FilteredChainView starting 2022-06-09 22:26:12.756 [INF] CRTR: Filtering chain using 0 channels active 2022-06-09 22:26:12.757 [INF] CRTR: Prune tip for Channel Graph: height=3938, hash=384892bbd6419156bf5a19a001b44cdae9992897d15b524488ec089e7921d999 2022-06-09 22:26:12.758 [DBG] CRTR: Cleaning network result store. 2022-06-09 22:26:12.758 [INF] INVC: InvoiceRegistry starting 2022-06-09 22:26:12.758 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.758 [DBG] INVC: Adding 0 pending invoices to the expiry watcher 2022-06-09 22:26:12.758 [INF] HSWC: Onion processor starting 2022-06-09 22:26:12.759 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.759 [INF] NANN: Channel Status Manager starting 2022-06-09 22:26:12.759 [INF] CHFT: ChannelEventStore starting 2022-06-09 22:26:12.759 [INF] CHFT: Adding 0 channels to event store 2022-06-09 22:26:12.759 [INF] CHBU: chanbackup.SubSwapper starting 2022-06-09 22:26:12.760 [INF] CHBU: Updating backup file at /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:12.760 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:12.760 [DBG] CHBU: SubSwapper's backupUpdater is active! 2022-06-09 22:26:12.760 [INF] BTCN: Server listening on 127.0.0.1:6222 2022-06-09 22:26:12.761 [DBG] CRTR: New graph topology client subscription, client 1 2022-06-09 22:26:12.761 [DBG] SRVR: Establishing 0 persistent connections on start 2022-06-09 22:26:12.761 [INF] SRVR: Auto peer bootstrapping is disabled 2022-06-09 22:26:12.765 [DBG] CRTR: New graph topology client subscription, client 2 2022-06-09 22:26:12.768 [DBG] RPCS: [connectpeer] requested connection to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.768 [DBG] SRVR: Connecting to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.771 [INF] SRVR: Established connection to: 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.771 [INF] SRVR: Finalizing connection to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, inbound=false 2022-06-09 22:26:12.771 [DBG] PRNF: PeerNotifier notifying peer: 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 online 2022-06-09 22:26:12.771 [DBG] RPCS: Connected to peer: 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.772 [DBG] PEER: Sending Init to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.772 [DBG] PEER: Received Init from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.772 [DBG] PEER: Loaded 0 active channels from database with NodeKey(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37) 2022-06-09 22:26:12.772 [DBG] SRVR: Notifying that peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 is online 2022-06-09 22:26:12.772 [INF] PEER: Negotiated chan series queries with 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:12.772 [INF] NTFN: New block epoch subscription 2022-06-09 22:26:12.772 [INF] DISC: Creating new GossipSyncer for peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:12.773 [DBG] DISC: Created new GossipSyncer[state=chansSynced type=PassiveSync] for peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.773 [DBG] DISC: Starting GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37) 2022-06-09 22:26:12.773 [DBG] DISC: Attempting initial historical sync with GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37) 2022-06-09 22:26:12.773 [DBG] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): state=chansSynced, type=PassiveSync 2022-06-09 22:26:12.773 [DBG] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): state=syncingChans, type=PassiveSync 2022-06-09 22:26:12.773 [INF] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): requesting new chans from height=0 and 3938 blocks after 2022-06-09 22:26:12.773 [DBG] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): state=waitingQueryRangeReply, type=PassiveSync 2022-06-09 22:26:12.773 [DBG] PEER: Sending QueryChannelRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, start_height=0, end_height=3937) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.773 [DBG] PEER: Received GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2022-06-09 22:26:12 +0000 UTC, stamp_range=4294967295) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.773 [DBG] CHDB: ChanUpdatesInHorizon hit percentage: NaN (0/0) 2022-06-09 22:26:12.773 [INF] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): applying new update horizon: start=2022-06-09 22:26:12 +0000 UTC, end=2158-07-17 04:54:27 +0000 UTC, backlog_size=0 2022-06-09 22:26:12.774 [DBG] PEER: Received ReplyChannelRange(start_height=0, end_height=3937, num_chans=0, encoding=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.774 [INF] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): buffering chan range reply of size=0 2022-06-09 22:26:12.774 [INF] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): filtering through 0 chans 2022-06-09 22:26:12.774 [INF] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): remote peer has no new chans 2022-06-09 22:26:12.774 [DBG] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): state=chansSynced, type=PassiveSync 2022-06-09 22:26:12.774 [DBG] DISC: Initial historical sync completed 2022-06-09 22:26:12.774 [DBG] DISC: Attempting to transition 1 passive GossipSyncers to active 2022-06-09 22:26:12.774 [DBG] DISC: Transitioning passive GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37) to active 2022-06-09 22:26:12.774 [DBG] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): transitioning from PassiveSync to ActiveSync 2022-06-09 22:26:12.774 [INF] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): applying gossipFilter(start=2022-06-09 22:26:12.774443775 +0000 UTC m=+4.212581530, end=2158-07-17 04:54:27.774443775 +0000 UTC) 2022-06-09 22:26:12.774 [DBG] DISC: GossipSyncer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37): state=chansSynced, type=ActiveSync 2022-06-09 22:26:12.774 [DBG] PEER: Sending GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2022-06-09 22:26:12 +0000 UTC, stamp_range=4294967295) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:12.972 [DBG] RPCS: [listpeers] yielded [03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214] peers 2022-06-09 22:26:13.158 [DBG] RPCS: [walletbalance] Total balance=0 BTC (confirmed=0 BTC, unconfirmed=0 BTC) 2022-06-09 22:26:13.159 [DBG] RPCS: [newaddress] account=default type=WITNESS_PUBKEY_HASH addr=bcrt1qrck99zxfkardcq0sls86nqyjeeech8lutdz67k 2022-06-09 22:26:13.234 [INF] LNWL: Inserting unconfirmed transaction 523760e1f4257dca0467833af00f1337f35c6814fc12d3dffdf840b6b5d4a41a 2022-06-09 22:26:13.234 [DBG] LNWL: Marked address bcrt1qrck99zxfkardcq0sls86nqyjeeech8lutdz67k used 2022-06-09 22:26:13.367 [DBG] RPCS: [listunspent] min=0 max=0, generated utxos: [523760e1f4257dca0467833af00f1337f35c6814fc12d3dffdf840b6b5d4a41a:0] 2022-06-09 22:26:13.390 [DBG] LNWL: Filtering block 3939 (2e41966a6aaafb4efbe0d49fc4967c6e59efee9cbc3f39ba4290fcf12ef09bfc) with 2 transactions 2022-06-09 22:26:13.390 [INF] CRTR: Pruning channel graph using block 2e41966a6aaafb4efbe0d49fc4967c6e59efee9cbc3f39ba4290fcf12ef09bfc (height=3939) 2022-06-09 22:26:13.391 [INF] LNWL: Marking unconfirmed transaction 523760e1f4257dca0467833af00f1337f35c6814fc12d3dffdf840b6b5d4a41a mined in block 3939 2022-06-09 22:26:13.391 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:13.391 [INF] CRTR: Block 2e41966a6aaafb4efbe0d49fc4967c6e59efee9cbc3f39ba4290fcf12ef09bfc (height=3939) closed 0 channels 2022-06-09 22:26:13.391 [DBG] LNWL: Marked address bcrt1qrck99zxfkardcq0sls86nqyjeeech8lutdz67k used 2022-06-09 22:26:13.398 [DBG] NTFN: Filtering 2 txns for 0 spend requests at height 3939 2022-06-09 22:26:13.399 [INF] NTFN: New block: height=3939, sha=2e41966a6aaafb4efbe0d49fc4967c6e59efee9cbc3f39ba4290fcf12ef09bfc 2022-06-09 22:26:13.399 [DBG] SWPR: New block: height=3939, sha=2e41966a6aaafb4efbe0d49fc4967c6e59efee9cbc3f39ba4290fcf12ef09bfc 2022-06-09 22:26:13.399 [DBG] DISC: New block: height=3939, hash=2e41966a6aaafb4efbe0d49fc4967c6e59efee9cbc3f39ba4290fcf12ef09bfc 2022-06-09 22:26:13.399 [INF] UTXN: Attempting to graduate height=3939: num_kids=0, num_babies=0 2022-06-09 22:26:13.405 [DBG] LNWL: Filtering block 3940 (5d7adbf1c7f7556580d944b6cc2f8372ef267e2ab6b773890a8bb3188d43834d) with 1 transactions 2022-06-09 22:26:13.405 [INF] CRTR: Pruning channel graph using block 5d7adbf1c7f7556580d944b6cc2f8372ef267e2ab6b773890a8bb3188d43834d (height=3940) 2022-06-09 22:26:13.405 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:13.405 [INF] CRTR: Block 5d7adbf1c7f7556580d944b6cc2f8372ef267e2ab6b773890a8bb3188d43834d (height=3940) closed 0 channels 2022-06-09 22:26:13.411 [DBG] LNWL: Filtering block 3941 (0143fa6340894a911329f1b51ac75a879568f5cb6fbff0d73e2fb6416b1ae144) with 1 transactions 2022-06-09 22:26:13.411 [INF] CRTR: Pruning channel graph using block 0143fa6340894a911329f1b51ac75a879568f5cb6fbff0d73e2fb6416b1ae144 (height=3941) 2022-06-09 22:26:13.411 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:13.411 [INF] CRTR: Block 0143fa6340894a911329f1b51ac75a879568f5cb6fbff0d73e2fb6416b1ae144 (height=3941) closed 0 channels 2022-06-09 22:26:13.417 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3940 2022-06-09 22:26:13.418 [INF] NTFN: New block: height=3940, sha=5d7adbf1c7f7556580d944b6cc2f8372ef267e2ab6b773890a8bb3188d43834d 2022-06-09 22:26:13.418 [DBG] LNWL: Filtering block 3942 (68a5467136285984e28a09e598e17a9fa2947c469a249ac128fb2e7955f12fd0) with 1 transactions 2022-06-09 22:26:13.418 [DBG] DISC: New block: height=3940, hash=5d7adbf1c7f7556580d944b6cc2f8372ef267e2ab6b773890a8bb3188d43834d 2022-06-09 22:26:13.418 [DBG] SWPR: New block: height=3940, sha=5d7adbf1c7f7556580d944b6cc2f8372ef267e2ab6b773890a8bb3188d43834d 2022-06-09 22:26:13.418 [INF] UTXN: Attempting to graduate height=3940: num_kids=0, num_babies=0 2022-06-09 22:26:13.418 [INF] CRTR: Pruning channel graph using block 68a5467136285984e28a09e598e17a9fa2947c469a249ac128fb2e7955f12fd0 (height=3942) 2022-06-09 22:26:13.418 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:13.418 [INF] CRTR: Block 68a5467136285984e28a09e598e17a9fa2947c469a249ac128fb2e7955f12fd0 (height=3942) closed 0 channels 2022-06-09 22:26:13.424 [DBG] LNWL: Filtering block 3943 (4bd0397e2c72ec5dd59f380fdaaa2c1979d115613f3d4bd040f1ac61b4c5ab82) with 1 transactions 2022-06-09 22:26:13.424 [INF] CRTR: Pruning channel graph using block 4bd0397e2c72ec5dd59f380fdaaa2c1979d115613f3d4bd040f1ac61b4c5ab82 (height=3943) 2022-06-09 22:26:13.424 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:13.424 [INF] CRTR: Block 4bd0397e2c72ec5dd59f380fdaaa2c1979d115613f3d4bd040f1ac61b4c5ab82 (height=3943) closed 0 channels 2022-06-09 22:26:13.425 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3941 2022-06-09 22:26:13.425 [INF] NTFN: New block: height=3941, sha=0143fa6340894a911329f1b51ac75a879568f5cb6fbff0d73e2fb6416b1ae144 2022-06-09 22:26:13.425 [DBG] LNWL: Filtering block 3944 (4155da9fd7c4f8a09c318f72e083f5eff6bbc58baab6839aaf93aaebe0aa0bd1) with 1 transactions 2022-06-09 22:26:13.425 [DBG] SWPR: New block: height=3941, sha=0143fa6340894a911329f1b51ac75a879568f5cb6fbff0d73e2fb6416b1ae144 2022-06-09 22:26:13.425 [INF] CRTR: Pruning channel graph using block 4155da9fd7c4f8a09c318f72e083f5eff6bbc58baab6839aaf93aaebe0aa0bd1 (height=3944) 2022-06-09 22:26:13.425 [DBG] DISC: New block: height=3941, hash=0143fa6340894a911329f1b51ac75a879568f5cb6fbff0d73e2fb6416b1ae144 2022-06-09 22:26:13.425 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:13.425 [INF] CRTR: Block 4155da9fd7c4f8a09c318f72e083f5eff6bbc58baab6839aaf93aaebe0aa0bd1 (height=3944) closed 0 channels 2022-06-09 22:26:13.425 [INF] UTXN: Attempting to graduate height=3941: num_kids=0, num_babies=0 2022-06-09 22:26:13.426 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3942 2022-06-09 22:26:13.426 [INF] NTFN: New block: height=3942, sha=68a5467136285984e28a09e598e17a9fa2947c469a249ac128fb2e7955f12fd0 2022-06-09 22:26:13.426 [DBG] DISC: New block: height=3942, hash=68a5467136285984e28a09e598e17a9fa2947c469a249ac128fb2e7955f12fd0 2022-06-09 22:26:13.426 [DBG] SWPR: New block: height=3942, sha=68a5467136285984e28a09e598e17a9fa2947c469a249ac128fb2e7955f12fd0 2022-06-09 22:26:13.426 [INF] UTXN: Attempting to graduate height=3942: num_kids=0, num_babies=0 2022-06-09 22:26:13.428 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3943 2022-06-09 22:26:13.428 [INF] NTFN: New block: height=3943, sha=4bd0397e2c72ec5dd59f380fdaaa2c1979d115613f3d4bd040f1ac61b4c5ab82 2022-06-09 22:26:13.428 [DBG] DISC: New block: height=3943, hash=4bd0397e2c72ec5dd59f380fdaaa2c1979d115613f3d4bd040f1ac61b4c5ab82 2022-06-09 22:26:13.428 [INF] UTXN: Attempting to graduate height=3943: num_kids=0, num_babies=0 2022-06-09 22:26:13.428 [DBG] SWPR: New block: height=3943, sha=4bd0397e2c72ec5dd59f380fdaaa2c1979d115613f3d4bd040f1ac61b4c5ab82 2022-06-09 22:26:13.429 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 3944 2022-06-09 22:26:13.429 [INF] NTFN: New block: height=3944, sha=4155da9fd7c4f8a09c318f72e083f5eff6bbc58baab6839aaf93aaebe0aa0bd1 2022-06-09 22:26:13.429 [DBG] DISC: New block: height=3944, hash=4155da9fd7c4f8a09c318f72e083f5eff6bbc58baab6839aaf93aaebe0aa0bd1 2022-06-09 22:26:13.429 [DBG] SWPR: New block: height=3944, sha=4155da9fd7c4f8a09c318f72e083f5eff6bbc58baab6839aaf93aaebe0aa0bd1 2022-06-09 22:26:13.429 [INF] UTXN: Attempting to graduate height=3944: num_kids=0, num_babies=0 2022-06-09 22:26:13.576 [DBG] RPCS: [walletbalance] Total balance=1 BTC (confirmed=1 BTC, unconfirmed=0 BTC) 2022-06-09 22:26:13.783 [DBG] RPCS: [openchannel] request to NodeKey(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37) allocation(us=100000, them=0) 2022-06-09 22:26:13.784 [WRN] LNWL: Web API does not have a fee rate for target=6, using the fee rate for target=1 instead 2022-06-09 22:26:13.784 [DBG] LNWL: Web API returning 12500 sat/kw for conf target of 6 2022-06-09 22:26:13.784 [DBG] RPCS: [openchannel]: using fee of 12500 sat/kw for funding tx 2022-06-09 22:26:13.784 [INF] FNDG: Initiating fundingRequest(local_amt=0.001 BTC (subtract_fees=false), push_amt=0 mSAT, chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, min_confs=1) 2022-06-09 22:26:13.785 [WRN] LNWL: Web API does not have a fee rate for target=3, using the fee rate for target=1 instead 2022-06-09 22:26:13.785 [DBG] LNWL: Web API returning 12500 sat/kw for conf target of 3 2022-06-09 22:26:13.785 [INF] CHFD: Performing funding tx coin selection using 12500 sat/kw as fee rate 2022-06-09 22:26:13.786 [WRN] CHFD: Unable to find funding output for shim intent: unable to create witness script, no funding keys 2022-06-09 22:26:13.790 [INF] FNDG: Target commit tx sat/kw for pendingID(651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c): 12500 2022-06-09 22:26:13.790 [INF] FNDG: Dust limit for pendingID(651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c): 0.00000354 BTC 2022-06-09 22:26:13.790 [INF] FNDG: Starting funding workflow with 127.0.0.1:6214 for pending_id(651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c), committype=tweakless 2022-06-09 22:26:13.790 [DBG] PEER: Sending MsgOpenChannel(temp_chan_id=651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c, chain=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, csv=4, amt=0.001 BTC, push_amt=0 mSAT, reserve=0.00001 BTC, flags=1) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:13.797 [DBG] PEER: Received MsgAcceptChannel(temp_chan_id=651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c, reserve=0.00001 BTC, csv=4, num_confs=1) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:13.797 [INF] FNDG: Recv'd fundingResponse for pending_id(651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c) 2022-06-09 22:26:13.803 [INF] FNDG: pendingChan(651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c): remote party proposes num_confs=1, csv_delay=4 2022-06-09 22:26:13.803 [DBG] FNDG: Remote party accepted commitment constraints: (channeldb.ChannelConstraints) { DustLimit: (btcutil.Amount) 0.00000354 BTC, ChanReserve: (btcutil.Amount) 0.00001 BTC, MaxPendingAmount: (lnwire.MilliSatoshi) 99000000 mSAT, MinHTLC: (lnwire.MilliSatoshi) 1 mSAT, MaxAcceptedHtlcs: (uint16) 483, CsvDelay: (uint16) 4 } 2022-06-09 22:26:13.803 [DBG] FNDG: Creating chan barrier for ChanID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) 2022-06-09 22:26:13.803 [INF] FNDG: Generated ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) for pending_id(651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c) 2022-06-09 22:26:13.804 [DBG] PEER: Sending MsgFundingCreated(temp_chan_id=651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c, chan_point=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:13.809 [DBG] PEER: Received MsgFundingSigned(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:13.811 [INF] FNDG: Broadcasting funding tx for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): 020000000001011aa4d4b5b640f8fddfd312fc14685cf337130ff03a836704ca7d25f4e160375200000000000000000002a08601000000000022002064cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe898b3cf405000000001600148deaa65973f83ed7e98e5e368cfe7b6b5f115dd0024730440220600664c32186fb5cd2f9ee254fde9e83ce770510555c331f519b1a5dd1930fcf022023315fe1a62bdea996236c0474f99cec2380ad5ebde7420e862eabfc6a5a95fd0121024bc710fbb6811ca09eeb5c2519ad3f1505ab2f108c90b1a19891b8b40eefc58100000000 2022-06-09 22:26:13.811 [INF] LNWL: Inserting unconfirmed transaction bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 2022-06-09 22:26:13.811 [DBG] LNWL: Marked address bcrt1q3h42vktnlqld06vwtcmgelnmdd03zhwspvmlm9 used 2022-06-09 22:26:13.814 [INF] CNCT: Creating new ChannelArbitrator for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) 2022-06-09 22:26:13.814 [DBG] CNCT: New ChainEventSubscription(id=0) for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) 2022-06-09 22:26:13.814 [DBG] CNCT: Starting ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0), htlc_set=(map[contractcourt.HtlcSetKey]contractcourt.htlcSet) (len=2) { (contractcourt.HtlcSetKey) LocalHtlcSet: (contractcourt.htlcSet) { incomingHTLCs: (map[uint64]channeldb.HTLC) { }, outgoingHTLCs: (map[uint64]channeldb.HTLC) { } }, (contractcourt.HtlcSetKey) RemoteHtlcSet: (contractcourt.htlcSet) { incomingHTLCs: (map[uint64]channeldb.HTLC) { }, outgoingHTLCs: (map[uint64]channeldb.HTLC) { } } } , state=StateDefault 2022-06-09 22:26:13.815 [INF] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): starting state=StateDefault, trigger=chainTrigger, triggerHeight=3944 2022-06-09 22:26:13.815 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:13.815 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3944) examining active HTLC's 2022-06-09 22:26:13.815 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3944, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:13.815 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:13.815 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:13.815 [DBG] CNCT: Starting chain watcher for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) 2022-06-09 22:26:13.815 [INF] NTFN: New spend subscription: spend_id=1, outpoint=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, script=0 64cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe89, height_hint=3944 2022-06-09 22:26:13.815 [INF] NTFN: Dispatching historical spend rescan for outpoint=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, script=0 64cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe89, start=3944, end=3944 2022-06-09 22:26:13.826 [DBG] NTFN: Updated spend hint to height=3944 for unconfirmed spend request outpoint=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, script=0 64cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe89 2022-06-09 22:26:13.826 [INF] FNDG: Finalizing pending_id(651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c) over ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0), waiting for channel open on-chain 2022-06-09 22:26:13.826 [INF] CNCT: Close observer for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) active 2022-06-09 22:26:13.826 [INF] NTFN: New confirmation subscription: conf_id=1, txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9, num_confs=1 height_hint=3944 2022-06-09 22:26:13.826 [DBG] NTFN: Dispatching historical confirmation rescan for txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 2022-06-09 22:26:13.826 [DBG] CHBU: Adding channel bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0 to backup state 2022-06-09 22:26:13.827 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=0, num_new_chans=1 2022-06-09 22:26:13.827 [INF] FNDG: Waiting for funding tx (bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9) to reach 1 confirmations 2022-06-09 22:26:13.827 [INF] CHBU: Updating backup file at /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:13.827 [DBG] NTFN: Confirmation details for txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 not found during historical dispatch, waiting to dispatch at tip 2022-06-09 22:26:13.828 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:24.689 [DBG] LNWL: Filtering block 3945 (1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1) with 2 transactions 2022-06-09 22:26:24.689 [DBG] LNWL: Filtering block 3945 (1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1) with 2 transactions 2022-06-09 22:26:24.689 [INF] CRTR: Pruning channel graph using block 1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1 (height=3945) 2022-06-09 22:26:24.689 [INF] LNWL: Marking unconfirmed transaction bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 mined in block 3945 2022-06-09 22:26:24.689 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:24.689 [INF] CRTR: Block 1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1 (height=3945) closed 0 channels 2022-06-09 22:26:24.690 [DBG] LNWL: Marked address bcrt1q3h42vktnlqld06vwtcmgelnmdd03zhwspvmlm9 used 2022-06-09 22:26:24.691 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 3945 2022-06-09 22:26:24.691 [DBG] NTFN: Found initial confirmation of txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9: height=3945, hash=1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1 2022-06-09 22:26:24.710 [DBG] LNWL: Filtering block 3946 (3557ed385985fe8ea7623dd7d2226454b75adf624b26d83278a73950bdabcfab) with 1 transactions 2022-06-09 22:26:24.710 [DBG] LNWL: Filtering block 3946 (3557ed385985fe8ea7623dd7d2226454b75adf624b26d83278a73950bdabcfab) with 1 transactions 2022-06-09 22:26:24.710 [INF] CRTR: Pruning channel graph using block 3557ed385985fe8ea7623dd7d2226454b75adf624b26d83278a73950bdabcfab (height=3946) 2022-06-09 22:26:24.711 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=0, num_channels=0 2022-06-09 22:26:24.711 [INF] CRTR: Block 3557ed385985fe8ea7623dd7d2226454b75adf624b26d83278a73950bdabcfab (height=3946) closed 0 channels 2022-06-09 22:26:24.714 [INF] NTFN: New block: height=3945, sha=1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1 2022-06-09 22:26:24.714 [INF] NTFN: Dispatching 1 confirmation notification for txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 2022-06-09 22:26:24.714 [DBG] SWPR: New block: height=3945, sha=1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1 2022-06-09 22:26:24.714 [INF] FNDG: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) is now active: ChannelID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) 2022-06-09 22:26:24.714 [INF] UTXN: Attempting to graduate height=3945: num_kids=0, num_babies=0 2022-06-09 22:26:24.714 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:24.714 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3945) examining active HTLC's 2022-06-09 22:26:24.714 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3945, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:24.714 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:24.714 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:24.714 [DBG] DISC: New block: height=3945, hash=1b9c91a87d8105e13293f0e678d1919b3485fb86a9ea106d7e8801b41c9540a1 2022-06-09 22:26:24.714 [DBG] FNDG: ChannelID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) is now fully confirmed! (shortChanID=3945:1:0) 2022-06-09 22:26:24.715 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3946 2022-06-09 22:26:24.719 [DBG] LNWL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): Restoring 0 dangling remote updates 2022-06-09 22:26:24.719 [DBG] LNWL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): Restoring 0 local updates that the peer should sign 2022-06-09 22:26:24.722 [ERR] FNDG: unable to report short chan id: link a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb not found 2022-06-09 22:26:24.722 [DBG] CHBU: Adding channel bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0 to backup state 2022-06-09 22:26:24.722 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=1, num_new_chans=1 2022-06-09 22:26:24.722 [WRN] CHBU: Replacing disk backup for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) w/ newer version 2022-06-09 22:26:24.723 [INF] CHBU: Updating backup file at /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:24.723 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:24.725 [INF] NTFN: New block: height=3946, sha=3557ed385985fe8ea7623dd7d2226454b75adf624b26d83278a73950bdabcfab 2022-06-09 22:26:24.725 [DBG] DISC: New block: height=3946, hash=3557ed385985fe8ea7623dd7d2226454b75adf624b26d83278a73950bdabcfab 2022-06-09 22:26:24.725 [DBG] SWPR: New block: height=3946, sha=3557ed385985fe8ea7623dd7d2226454b75adf624b26d83278a73950bdabcfab 2022-06-09 22:26:24.725 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:24.726 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3946) examining active HTLC's 2022-06-09 22:26:24.726 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3946, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:24.726 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:24.726 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:24.725 [INF] UTXN: Attempting to graduate height=3946: num_kids=0, num_babies=0 2022-06-09 22:26:24.726 [DBG] LNWL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): Restoring 0 dangling remote updates 2022-06-09 22:26:24.727 [DBG] LNWL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): Restoring 0 local updates that the peer should sign 2022-06-09 22:26:24.727 [DBG] FNDG: Channel(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) with ShortChanID 3945:1:0 has opening state markedOpen 2022-06-09 22:26:24.727 [DBG] SRVR: Notifying that peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 is online 2022-06-09 22:26:24.727 [INF] FNDG: Peer(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37) is online, sending FundingLocked for ChannelID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) 2022-06-09 22:26:24.727 [DBG] PEER: Sending FundingLocked(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, next_point=02285bf96c3158efbfc875382f480671dd388bb218424dabad821ee4a4e1e4f7cf) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.727 [DBG] FNDG: Channel(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) with ShortChanID 3945:1:0: successfully sent FundingLocked 2022-06-09 22:26:24.727 [DBG] FNDG: Channel(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) with ShortChanID 3945:1:0 has opening state fundingLocked 2022-06-09 22:26:24.728 [DBG] DISC: Processing network message: peer=, source=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658, msg=ChannelAnnouncement, is_remote=false 2022-06-09 22:26:24.728 [DBG] PEER: Received FundingLocked(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, next_point=034c1df59a99d9e8b409c6b9b2de11f0805e5cf83e187ff92595f98ee9731922ba) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.728 [DBG] FNDG: Received FundingLocked for ChannelID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) from peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:24.732 [DBG] DISC: Processing network message: peer=, source=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658, msg=ChannelUpdate, is_remote=false 2022-06-09 22:26:24.732 [DBG] LNWL: Filtering block 3947 (54ab39fc3f328077bbed29c074ffcae78c30d72e02f9fe3c68c9e4a03c969b5b) with 1 transactions 2022-06-09 22:26:24.733 [DBG] LNWL: Filtering block 3947 (54ab39fc3f328077bbed29c074ffcae78c30d72e02f9fe3c68c9e4a03c969b5b) with 1 transactions 2022-06-09 22:26:24.733 [INF] CRTR: Pruning channel graph using block 54ab39fc3f328077bbed29c074ffcae78c30d72e02f9fe3c68c9e4a03c969b5b (height=3947) 2022-06-09 22:26:24.733 [DBG] DISC: The message ChannelUpdate has no AuthProof, sending the update to remote peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:24.733 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=2, num_channels=2 2022-06-09 22:26:24.733 [INF] CRTR: Block 54ab39fc3f328077bbed29c074ffcae78c30d72e02f9fe3c68c9e4a03c969b5b (height=3947) closed 0 channels 2022-06-09 22:26:24.734 [DBG] DISC: Requesting online notification for peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:24.734 [DBG] SRVR: Notifying that peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 is online 2022-06-09 22:26:24.734 [DBG] DISC: Peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 is now online, proceeding to send pending messages 2022-06-09 22:26:24.734 [DBG] DISC: Requesting offline notification for peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:24.734 [DBG] FNDG: Channel(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) with ShortChanID 3945:1:0: successfully added to router graph 2022-06-09 22:26:24.734 [DBG] DISC: Successfully sent ChannelUpdate message for channel=3945:1:0 with peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 upon reconnection 2022-06-09 22:26:24.734 [DBG] LNWL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): Restoring 0 dangling remote updates 2022-06-09 22:26:24.734 [DBG] LNWL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): Restoring 0 local updates that the peer should sign 2022-06-09 22:26:24.734 [INF] PEER: New channel active ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) with NodeKey(03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37) 2022-06-09 22:26:24.734 [DBG] CNCT: New ChainEventSubscription(id=1) for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) 2022-06-09 22:26:24.734 [INF] HSWC: Removing channel link with ChannelID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) 2022-06-09 22:26:24.734 [INF] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): starting 2022-06-09 22:26:24.734 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4337573371641856, mflags=00000001, cflags=00000000, update_time=2022-06-09 22:26:24 +0000 UTC) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.734 [DBG] FNDG: Channel(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) with ShortChanID 3945:1:0 has opening state addedToRouterGraph 2022-06-09 22:26:24.734 [DBG] FNDG: Will announce channel 4337573371641856 after ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) has gotten 6 confirmations 2022-06-09 22:26:24.734 [DBG] NTFN: Using height hint 3945 retrieved from cache for txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 instead of 3944 for conf subscription 2022-06-09 22:26:24.734 [INF] NTFN: New confirmation subscription: conf_id=2, txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9, num_confs=6 height_hint=3945 2022-06-09 22:26:24.734 [INF] HSWC: Trimming open circuits for chan_id=3945:1:0, start_htlc_id=0 2022-06-09 22:26:24.735 [INF] HSWC: Adding live link chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, short_chan_id=3945:1:0 2022-06-09 22:26:24.734 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3947 2022-06-09 22:26:24.735 [INF] CNCT: Attempting to update ContractSignals for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) 2022-06-09 22:26:24.735 [INF] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): HTLC manager started, bandwidth=87800000 mSAT 2022-06-09 22:26:24.735 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): loaded 0 fwd pks 2022-06-09 22:26:24.736 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4337573371641856, mflags=00000001, cflags=00000001, update_time=2022-06-09 22:26:24 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.736 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:24.745 [INF] NTFN: New block: height=3947, sha=54ab39fc3f328077bbed29c074ffcae78c30d72e02f9fe3c68c9e4a03c969b5b 2022-06-09 22:26:24.745 [DBG] NTFN: Attempting to dispatch confirmation for txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 on registration since rescan has finished 2022-06-09 22:26:24.746 [DBG] NTFN: Queueing 6 confirmation notification for txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 at tip 2022-06-09 22:26:24.745 [INF] UTXN: Attempting to graduate height=3947: num_kids=0, num_babies=0 2022-06-09 22:26:24.745 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:24.746 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3947) examining active HTLC's 2022-06-09 22:26:24.746 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3947, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:24.746 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:24.746 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:24.746 [DBG] DISC: New block: height=3947, hash=54ab39fc3f328077bbed29c074ffcae78c30d72e02f9fe3c68c9e4a03c969b5b 2022-06-09 22:26:24.746 [DBG] SWPR: New block: height=3947, sha=54ab39fc3f328077bbed29c074ffcae78c30d72e02f9fe3c68c9e4a03c969b5b 2022-06-09 22:26:24.754 [DBG] LNWL: Filtering block 3948 (4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91) with 1 transactions 2022-06-09 22:26:24.754 [DBG] LNWL: Filtering block 3948 (4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91) with 1 transactions 2022-06-09 22:26:24.754 [DBG] LNWL: Filtering block 3948 (4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91) with 1 transactions 2022-06-09 22:26:24.754 [INF] CRTR: Pruning channel graph using block 4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91 (height=3948) 2022-06-09 22:26:24.754 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=2, num_channels=2 2022-06-09 22:26:24.754 [INF] CRTR: Block 4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91 (height=3948) closed 0 channels 2022-06-09 22:26:24.756 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3948 2022-06-09 22:26:24.766 [INF] NTFN: New block: height=3948, sha=4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91 2022-06-09 22:26:24.766 [DBG] SWPR: New block: height=3948, sha=4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91 2022-06-09 22:26:24.766 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:24.766 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3948) examining active HTLC's 2022-06-09 22:26:24.766 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3948, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:24.766 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:24.766 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:24.766 [DBG] DISC: New block: height=3948, hash=4d02b516944848d1919c2ffd8e273f2c4be0ee4410f52c96301a2cddaf1c8e91 2022-06-09 22:26:24.766 [INF] UTXN: Attempting to graduate height=3948: num_kids=0, num_babies=0 2022-06-09 22:26:24.778 [DBG] LNWL: Filtering block 3949 (2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7) with 1 transactions 2022-06-09 22:26:24.778 [DBG] LNWL: Filtering block 3949 (2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7) with 1 transactions 2022-06-09 22:26:24.778 [DBG] LNWL: Filtering block 3949 (2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7) with 1 transactions 2022-06-09 22:26:24.778 [INF] CRTR: Pruning channel graph using block 2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7 (height=3949) 2022-06-09 22:26:24.778 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=2, num_channels=2 2022-06-09 22:26:24.778 [INF] CRTR: Block 2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7 (height=3949) closed 0 channels 2022-06-09 22:26:24.780 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3949 2022-06-09 22:26:24.790 [INF] NTFN: New block: height=3949, sha=2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7 2022-06-09 22:26:24.790 [DBG] SWPR: New block: height=3949, sha=2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7 2022-06-09 22:26:24.790 [DBG] DISC: New block: height=3949, hash=2d82a03491257c759df8f3bd1d0cfbd18aca782f3a1924f2ee0b2bdbd162a3a7 2022-06-09 22:26:24.790 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:24.790 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3949) examining active HTLC's 2022-06-09 22:26:24.790 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3949, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:24.790 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:24.790 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:24.790 [INF] UTXN: Attempting to graduate height=3949: num_kids=0, num_babies=0 2022-06-09 22:26:24.799 [DBG] LNWL: Filtering block 3950 (788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682) with 1 transactions 2022-06-09 22:26:24.799 [DBG] LNWL: Filtering block 3950 (788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682) with 1 transactions 2022-06-09 22:26:24.799 [DBG] LNWL: Filtering block 3950 (788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682) with 1 transactions 2022-06-09 22:26:24.799 [INF] CRTR: Pruning channel graph using block 788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682 (height=3950) 2022-06-09 22:26:24.800 [DBG] CHDB: Pruned graph, cache now has num_node_features=0, num_nodes=2, num_channels=2 2022-06-09 22:26:24.800 [INF] CRTR: Block 788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682 (height=3950) closed 0 channels 2022-06-09 22:26:24.801 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3950 2022-06-09 22:26:24.804 [DBG] PEER: Received AnnounceSignatures(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, short_chan_id=4337573371641856) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.804 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=AnnounceSignatures, is_remote=true 2022-06-09 22:26:24.804 [INF] DISC: Received new remote channel announcement for 3945:1:0 2022-06-09 22:26:24.805 [INF] DISC: 1/2 of channel ann proof received for short_chan_id=4337573371641856, waiting for other half 2022-06-09 22:26:24.805 [DBG] DISC: Processed network message AnnounceSignatures, returned len(announcements)=0 2022-06-09 22:26:24.811 [INF] NTFN: New block: height=3950, sha=788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682 2022-06-09 22:26:24.812 [INF] UTXN: Attempting to graduate height=3950: num_kids=0, num_babies=0 2022-06-09 22:26:24.812 [INF] NTFN: Dispatching 6 confirmation notification for txid=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9 2022-06-09 22:26:24.812 [DBG] SWPR: New block: height=3950, sha=788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682 2022-06-09 22:26:24.812 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:24.812 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3950) examining active HTLC's 2022-06-09 22:26:24.812 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3950, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:24.812 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:24.812 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:24.812 [DBG] DISC: New block: height=3950, hash=788e11b2c7f9743958e6619edd622dcb8a15f084234911f9eb18fde8c0e6f682 2022-06-09 22:26:24.812 [INF] FNDG: Announcing ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0), short_chan_id=3945:1:0 2022-06-09 22:26:24.812 [DBG] DISC: Processing network message: peer=, source=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658, msg=AnnounceSignatures, is_remote=false 2022-06-09 22:26:24.812 [INF] DISC: Received new local channel announcement for 3945:1:0 2022-06-09 22:26:24.813 [DBG] DISC: Successfully sent AnnounceSignatures message for channel=3945:1:0 with peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:24.813 [DBG] PEER: Sending AnnounceSignatures(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, short_chan_id=4337573371641856) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.814 [INF] DISC: Fully valid channel proof for short_chan_id=4337573371641856 constructed, adding to next ann batch 2022-06-09 22:26:24.815 [DBG] DISC: Unable to fetch node announcement for 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37: node does not have node announcement 2022-06-09 22:26:24.815 [DBG] DISC: Processed network message AnnounceSignatures, returned len(announcements)=4 2022-06-09 22:26:24.815 [DBG] DISC: Processing network message: peer=, source=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658, msg=NodeAnnouncement, is_remote=false 2022-06-09 22:26:24.816 [DBG] FNDG: Channel with ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0), short_chan_id=3945:1:0 sent to gossiper 2022-06-09 22:26:24.816 [DBG] FNDG: Channel(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) with ShortChanID 3945:1:0: successfully announced 2022-06-09 22:26:24.816 [DBG] FNDG: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) with chan_id=651a65e7e2d9b92f6155ff45ebde9ea6fe1251bee450d07f9398c0a3d05f701c not found in opening database, assuming already announced to the network 2022-06-09 22:26:24.836 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4337573371641856, mflags=00000001, cflags=00000001, update_time=2022-06-09 22:26:24 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.836 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:24.836 [DBG] PEER: Received NodeAnnouncement(node=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, update_time=2022-06-09 22:26:24 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.836 [DBG] DISC: Ignored stale edge policy: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:24.836 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=NodeAnnouncement, is_remote=true 2022-06-09 22:26:24.853 [INF] DISC: Broadcasting 5 new announcements in 1 sub batches 2022-06-09 22:26:24.853 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:24.853 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:24.853 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:24.853 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:24.853 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:24.853 [DBG] PEER: Sending ChannelAnnouncement(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4337573371641856) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.853 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4337573371641856, mflags=00000001, cflags=00000000, update_time=2022-06-09 22:26:24 +0000 UTC) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:24.854 [DBG] PEER: Sending NodeAnnouncement(node=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658, update_time=2022-06-09 22:26:24 +0000 UTC) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:25.015 [DBG] RPCS: [listchannels] fetched 1 channels from DB 2022-06-09 22:26:29.863 [DBG] LNWL: Filtering block 3951 (7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695) with 2 transactions 2022-06-09 22:26:29.863 [DBG] LNWL: Filtering block 3951 (7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695) with 2 transactions 2022-06-09 22:26:29.863 [DBG] LNWL: Filtering block 3951 (7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695) with 2 transactions 2022-06-09 22:26:29.863 [INF] CRTR: Pruning channel graph using block 7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695 (height=3951) 2022-06-09 22:26:29.864 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:29.864 [INF] CRTR: Block 7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695 (height=3951) closed 0 channels 2022-06-09 22:26:29.870 [DBG] LNWL: Filtering block 3952 (2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49) with 1 transactions 2022-06-09 22:26:29.870 [DBG] LNWL: Filtering block 3952 (2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49) with 1 transactions 2022-06-09 22:26:29.870 [DBG] LNWL: Filtering block 3952 (2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49) with 1 transactions 2022-06-09 22:26:29.870 [INF] CRTR: Pruning channel graph using block 2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49 (height=3952) 2022-06-09 22:26:29.870 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:29.870 [INF] CRTR: Block 2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49 (height=3952) closed 0 channels 2022-06-09 22:26:29.877 [DBG] LNWL: Filtering block 3953 (3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae) with 1 transactions 2022-06-09 22:26:29.877 [DBG] LNWL: Filtering block 3953 (3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae) with 1 transactions 2022-06-09 22:26:29.877 [DBG] LNWL: Filtering block 3953 (3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae) with 1 transactions 2022-06-09 22:26:29.877 [INF] CRTR: Pruning channel graph using block 3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae (height=3953) 2022-06-09 22:26:29.877 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 3951 2022-06-09 22:26:29.877 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:29.877 [INF] CRTR: Block 3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae (height=3953) closed 0 channels 2022-06-09 22:26:29.882 [DBG] LNWL: Filtering block 3954 (3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3) with 1 transactions 2022-06-09 22:26:29.882 [DBG] LNWL: Filtering block 3954 (3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3) with 1 transactions 2022-06-09 22:26:29.882 [DBG] LNWL: Filtering block 3954 (3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3) with 1 transactions 2022-06-09 22:26:29.882 [INF] CRTR: Pruning channel graph using block 3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3 (height=3954) 2022-06-09 22:26:29.882 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:29.882 [INF] CRTR: Block 3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3 (height=3954) closed 0 channels 2022-06-09 22:26:29.888 [INF] NTFN: New block: height=3951, sha=7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695 2022-06-09 22:26:29.888 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:29.888 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3951) examining active HTLC's 2022-06-09 22:26:29.888 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3951, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:29.888 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:29.888 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:29.888 [DBG] DISC: New block: height=3951, hash=7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695 2022-06-09 22:26:29.888 [INF] UTXN: Attempting to graduate height=3951: num_kids=0, num_babies=0 2022-06-09 22:26:29.888 [DBG] SWPR: New block: height=3951, sha=7a11514b8d6aa6c66001893664af936ca19032588bf5dc5eab505a15dfc06695 2022-06-09 22:26:29.891 [DBG] LNWL: Filtering block 3955 (68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051) with 1 transactions 2022-06-09 22:26:29.891 [DBG] LNWL: Filtering block 3955 (68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051) with 1 transactions 2022-06-09 22:26:29.891 [DBG] LNWL: Filtering block 3955 (68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051) with 1 transactions 2022-06-09 22:26:29.891 [DBG] LNWL: Filtering block 3956 (6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435) with 1 transactions 2022-06-09 22:26:29.891 [DBG] LNWL: Filtering block 3956 (6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435) with 1 transactions 2022-06-09 22:26:29.891 [DBG] LNWL: Filtering block 3956 (6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435) with 1 transactions 2022-06-09 22:26:29.891 [INF] CRTR: Pruning channel graph using block 68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051 (height=3955) 2022-06-09 22:26:29.892 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3952 2022-06-09 22:26:29.892 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:29.892 [INF] CRTR: Block 68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051 (height=3955) closed 0 channels 2022-06-09 22:26:29.893 [INF] CRTR: Pruning channel graph using block 6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435 (height=3956) 2022-06-09 22:26:29.893 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:29.893 [INF] CRTR: Block 6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435 (height=3956) closed 0 channels 2022-06-09 22:26:29.903 [INF] NTFN: New block: height=3952, sha=2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49 2022-06-09 22:26:29.903 [DBG] SWPR: New block: height=3952, sha=2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49 2022-06-09 22:26:29.903 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:29.903 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3952) examining active HTLC's 2022-06-09 22:26:29.903 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3952, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:29.904 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:29.904 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:29.903 [DBG] DISC: New block: height=3952, hash=2a2adcf490ac138309d108cde592fcdc207a07372667a2199570e4f93d589a49 2022-06-09 22:26:29.903 [INF] UTXN: Attempting to graduate height=3952: num_kids=0, num_babies=0 2022-06-09 22:26:29.904 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3953 2022-06-09 22:26:29.915 [INF] NTFN: New block: height=3953, sha=3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae 2022-06-09 22:26:29.915 [DBG] DISC: New block: height=3953, hash=3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae 2022-06-09 22:26:29.915 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:29.915 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3953) examining active HTLC's 2022-06-09 22:26:29.915 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3953, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:29.915 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:29.915 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:29.915 [DBG] SWPR: New block: height=3953, sha=3227c5e8052ae1746bb49962319b0a27999e9735c134adedc92c2c01c7f034ae 2022-06-09 22:26:29.915 [INF] UTXN: Attempting to graduate height=3953: num_kids=0, num_babies=0 2022-06-09 22:26:29.916 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3954 2022-06-09 22:26:29.927 [INF] NTFN: New block: height=3954, sha=3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3 2022-06-09 22:26:29.927 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:29.927 [INF] UTXN: Attempting to graduate height=3954: num_kids=0, num_babies=0 2022-06-09 22:26:29.927 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3954) examining active HTLC's 2022-06-09 22:26:29.927 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3954, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:29.927 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:29.927 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:29.927 [DBG] SWPR: New block: height=3954, sha=3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3 2022-06-09 22:26:29.927 [DBG] DISC: New block: height=3954, hash=3838ed18a6f17c2359b180f39134aaf7a3844bb2cbf27f5bf6ec08e82d2a55e3 2022-06-09 22:26:29.928 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3955 2022-06-09 22:26:29.938 [INF] NTFN: New block: height=3955, sha=68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051 2022-06-09 22:26:29.938 [INF] UTXN: Attempting to graduate height=3955: num_kids=0, num_babies=0 2022-06-09 22:26:29.938 [DBG] SWPR: New block: height=3955, sha=68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051 2022-06-09 22:26:29.938 [DBG] DISC: New block: height=3955, hash=68517927ba3bc45a525cf57de28535186298d36412bba8d9d474cf9edb005051 2022-06-09 22:26:29.938 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:29.938 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3955) examining active HTLC's 2022-06-09 22:26:29.939 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3955, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:29.939 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:29.939 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:29.940 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3956 2022-06-09 22:26:29.950 [INF] NTFN: New block: height=3956, sha=6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435 2022-06-09 22:26:29.950 [DBG] DISC: New block: height=3956, hash=6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435 2022-06-09 22:26:29.950 [DBG] SWPR: New block: height=3956, sha=6db97c0587a64ace8593d95b56ab9b63d375b3ff7e90714807b6637357bc2435 2022-06-09 22:26:29.950 [INF] UTXN: Attempting to graduate height=3956: num_kids=0, num_babies=0 2022-06-09 22:26:29.950 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:29.950 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3956) examining active HTLC's 2022-06-09 22:26:29.950 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3956, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:29.950 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:29.950 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:34.113 [DBG] LNWL: Filtering block 3957 (46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785) with 2 transactions 2022-06-09 22:26:34.113 [DBG] LNWL: Filtering block 3957 (46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785) with 2 transactions 2022-06-09 22:26:34.113 [DBG] LNWL: Filtering block 3957 (46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785) with 2 transactions 2022-06-09 22:26:34.113 [INF] CRTR: Pruning channel graph using block 46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785 (height=3957) 2022-06-09 22:26:34.114 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:34.114 [INF] CRTR: Block 46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785 (height=3957) closed 0 channels 2022-06-09 22:26:34.115 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 3957 2022-06-09 22:26:34.125 [INF] NTFN: New block: height=3957, sha=46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785 2022-06-09 22:26:34.125 [DBG] SWPR: New block: height=3957, sha=46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785 2022-06-09 22:26:34.125 [DBG] DISC: New block: height=3957, hash=46c5a74a9b7e91292f03ece22d3e61051cf30c149ab8e51ce68149d6954f9785 2022-06-09 22:26:34.125 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:34.125 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3957) examining active HTLC's 2022-06-09 22:26:34.125 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3957, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:34.125 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:34.125 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:34.125 [INF] UTXN: Attempting to graduate height=3957: num_kids=0, num_babies=0 2022-06-09 22:26:34.134 [DBG] LNWL: Filtering block 3958 (79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39) with 1 transactions 2022-06-09 22:26:34.134 [DBG] LNWL: Filtering block 3958 (79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39) with 1 transactions 2022-06-09 22:26:34.134 [DBG] LNWL: Filtering block 3958 (79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39) with 1 transactions 2022-06-09 22:26:34.134 [INF] CRTR: Pruning channel graph using block 79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39 (height=3958) 2022-06-09 22:26:34.135 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:34.135 [INF] CRTR: Block 79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39 (height=3958) closed 0 channels 2022-06-09 22:26:34.136 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3958 2022-06-09 22:26:34.146 [INF] NTFN: New block: height=3958, sha=79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39 2022-06-09 22:26:34.146 [DBG] SWPR: New block: height=3958, sha=79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39 2022-06-09 22:26:34.146 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:34.147 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3958) examining active HTLC's 2022-06-09 22:26:34.147 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3958, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:34.147 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:34.147 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:34.146 [DBG] DISC: New block: height=3958, hash=79c1e902d3a86cc62e72ff549047c5f611c7c097e0ddbc4d5146aeaa4417af39 2022-06-09 22:26:34.147 [INF] UTXN: Attempting to graduate height=3958: num_kids=0, num_babies=0 2022-06-09 22:26:34.156 [DBG] LNWL: Filtering block 3959 (2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e) with 1 transactions 2022-06-09 22:26:34.156 [DBG] LNWL: Filtering block 3959 (2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e) with 1 transactions 2022-06-09 22:26:34.156 [DBG] LNWL: Filtering block 3959 (2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e) with 1 transactions 2022-06-09 22:26:34.157 [INF] CRTR: Pruning channel graph using block 2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e (height=3959) 2022-06-09 22:26:34.157 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:34.157 [INF] CRTR: Block 2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e (height=3959) closed 0 channels 2022-06-09 22:26:34.158 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3959 2022-06-09 22:26:34.168 [INF] NTFN: New block: height=3959, sha=2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e 2022-06-09 22:26:34.168 [INF] UTXN: Attempting to graduate height=3959: num_kids=0, num_babies=0 2022-06-09 22:26:34.168 [DBG] SWPR: New block: height=3959, sha=2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e 2022-06-09 22:26:34.168 [DBG] DISC: New block: height=3959, hash=2f7bcf9817ae5d6b0815cb5697b010713cf85d62a58ba3935ba0f78e7d97087e 2022-06-09 22:26:34.168 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:34.169 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3959) examining active HTLC's 2022-06-09 22:26:34.169 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3959, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:34.169 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:34.169 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:34.178 [DBG] LNWL: Filtering block 3960 (71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803) with 1 transactions 2022-06-09 22:26:34.178 [DBG] LNWL: Filtering block 3960 (71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803) with 1 transactions 2022-06-09 22:26:34.178 [DBG] LNWL: Filtering block 3960 (71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803) with 1 transactions 2022-06-09 22:26:34.179 [INF] CRTR: Pruning channel graph using block 71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803 (height=3960) 2022-06-09 22:26:34.179 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:34.179 [INF] CRTR: Block 71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803 (height=3960) closed 0 channels 2022-06-09 22:26:34.180 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3960 2022-06-09 22:26:34.190 [INF] NTFN: New block: height=3960, sha=71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803 2022-06-09 22:26:34.191 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:34.191 [INF] UTXN: Attempting to graduate height=3960: num_kids=0, num_babies=0 2022-06-09 22:26:34.191 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3960) examining active HTLC's 2022-06-09 22:26:34.191 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3960, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:34.191 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:34.191 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:34.191 [DBG] SWPR: New block: height=3960, sha=71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803 2022-06-09 22:26:34.191 [DBG] DISC: New block: height=3960, hash=71cf5f224312dd833330509624b211d5d43e6a56969506a86d491d0e09fa2803 2022-06-09 22:26:34.200 [DBG] LNWL: Filtering block 3961 (5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006) with 1 transactions 2022-06-09 22:26:34.200 [DBG] LNWL: Filtering block 3961 (5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006) with 1 transactions 2022-06-09 22:26:34.200 [DBG] LNWL: Filtering block 3961 (5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006) with 1 transactions 2022-06-09 22:26:34.200 [INF] CRTR: Pruning channel graph using block 5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006 (height=3961) 2022-06-09 22:26:34.201 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:34.201 [INF] CRTR: Block 5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006 (height=3961) closed 0 channels 2022-06-09 22:26:34.202 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3961 2022-06-09 22:26:34.212 [INF] NTFN: New block: height=3961, sha=5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006 2022-06-09 22:26:34.212 [DBG] DISC: New block: height=3961, hash=5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006 2022-06-09 22:26:34.212 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:34.212 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3961) examining active HTLC's 2022-06-09 22:26:34.212 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3961, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:34.212 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:34.212 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:34.212 [DBG] SWPR: New block: height=3961, sha=5fb54ffba0df10bd413ac2621edef35449174c2eb6382faa3491a9fa7aff7006 2022-06-09 22:26:34.212 [INF] UTXN: Attempting to graduate height=3961: num_kids=0, num_babies=0 2022-06-09 22:26:34.222 [DBG] LNWL: Filtering block 3962 (3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26) with 1 transactions 2022-06-09 22:26:34.222 [DBG] LNWL: Filtering block 3962 (3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26) with 1 transactions 2022-06-09 22:26:34.222 [DBG] LNWL: Filtering block 3962 (3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26) with 1 transactions 2022-06-09 22:26:34.222 [INF] CRTR: Pruning channel graph using block 3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26 (height=3962) 2022-06-09 22:26:34.223 [DBG] CHDB: Pruned graph, cache now has num_node_features=2, num_nodes=2, num_channels=2 2022-06-09 22:26:34.223 [INF] CRTR: Block 3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26 (height=3962) closed 0 channels 2022-06-09 22:26:34.224 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 3962 2022-06-09 22:26:34.234 [INF] NTFN: New block: height=3962, sha=3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26 2022-06-09 22:26:34.234 [DBG] SWPR: New block: height=3962, sha=3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26 2022-06-09 22:26:34.234 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:34.234 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3962) examining active HTLC's 2022-06-09 22:26:34.234 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3962, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:34.234 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:34.234 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:34.234 [INF] UTXN: Attempting to graduate height=3962: num_kids=0, num_babies=0 2022-06-09 22:26:34.234 [DBG] DISC: New block: height=3962, hash=3a1d55f4a6e220c3e93b39191d51ff4ed72e9aeaf8eb3cc1c82f2db063cf6f26 2022-06-09 22:26:34.269 [DBG] PEER: Received ChannelAnnouncement(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4350767511175168) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.269 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelAnnouncement, is_remote=true 2022-06-09 22:26:34.269 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4350767511175168, mflags=00000001, cflags=00000000, update_time=2022-06-09 22:26:34 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.269 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4350767511175168, mflags=00000001, cflags=00000001, update_time=2022-06-09 22:26:34 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.269 [DBG] PEER: Received NodeAnnouncement(node=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, update_time=2022-06-09 22:26:34 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.282 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:34.282 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:34.282 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=NodeAnnouncement, is_remote=true 2022-06-09 22:26:34.303 [INF] DISC: Broadcasting 3 new announcements in 1 sub batches 2022-06-09 22:26:34.303 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:34.303 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:34.303 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:34.319 [DBG] PEER: Received NodeAnnouncement(node=0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179, update_time=2022-06-09 22:26:34 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.319 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=NodeAnnouncement, is_remote=true 2022-06-09 22:26:34.352 [INF] DISC: Broadcasting 2 new announcements in 1 sub batches 2022-06-09 22:26:34.352 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:34.353 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:34.643 [DBG] CRTR: Searching for path to 0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179, sending 1000000 mSAT 2022-06-09 22:26:34.645 [DBG] CRTR: Pathfinding absolute attempt cost: 101 sats 2022-06-09 22:26:34.645 [DBG] CRTR: Found route: probability=1, hops=2, fee=1001 mSAT 2022-06-09 22:26:34.645 [DBG] CRTR: Pathfinding perf metrics: nodes=2, edges=2, time=441.04µs 2022-06-09 22:26:34.719 [DBG] CRTR: Payment 4025e53d1434e62de3d423d68fc17667c8b27f3d66538e04853d73683cf710d3 (pid=1) successfully sent to switch, route: 4337573371641856 (1001001 mSAT) -> 4350767511175168 (1000000 mSAT), cltv 4042 2022-06-09 22:26:34.719 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): queueing keystone of ADD open circuit: (Chan ID=0:0:0, HTLC ID=1)->(Chan ID=3945:1:0, HTLC ID=0) 2022-06-09 22:26:34.719 [DBG] PEER: Sending UpdateAddHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=0, amt=1001001 mSAT, expiry=4042, hash=4025e53d1434e62de3d423d68fc17667c8b27f3d66538e04853d73683cf710d3) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.720 [DBG] HSWC: Subscribing to result for paymentID=1 2022-06-09 22:26:34.772 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): removing Add packet (Chan ID=0:0:0, HTLC ID=1) from mailbox 2022-06-09 22:26:34.773 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.776 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=b84390dac6a51666da5f7a72da7c1f3d1a2e576b23dd80624d774e8ce7310338, next_point=03048ff1751d084f5334e4a4040bb1413e3c37167845a3737cf71f7cea0c82fe07) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.778 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.791 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=25d80e09aba69df58b3a51e3de770bc141b4536540158945b7658a7677fbdcda, next_point=024abebbc7ca20b045a7cdbadbdb9c589bf2d3621ecc82b2347a94a32f317a8f61) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.896 [DBG] PEER: Received UpdateFulfillHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=0, pre_image=bbbe31ae6105ca902c8aff1e0efa8b1e2fe1cc5eb95e1de0af8efd53694a563f) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.896 [DBG] HSWC: Closed completed SETTLE circuit for 4025e53d1434e62de3d423d68fc17667c8b27f3d66538e04853d73683cf710d3: (0:0:0, 1) <-> (3945:1:0, 0) 2022-06-09 22:26:34.896 [DBG] HSWC: Storing result for paymentID=1 2022-06-09 22:26:34.896 [DBG] HSWC: Tearing down open circuit with SETTLE pkt, removing circuit=(Chan ID=0:0:0, HTLC ID=1) with keystone=(Chan ID=3945:1:0, HTLC ID=0) 2022-06-09 22:26:34.896 [DBG] HSWC: Received network result *lnwire.UpdateFulfillHTLC for attemptID=1 2022-06-09 22:26:34.897 [DBG] CRTR: Payment 4025e53d1434e62de3d423d68fc17667c8b27f3d66538e04853d73683cf710d3 succeeded with pid=1 2022-06-09 22:26:34.897 [DBG] CRTR: Reporting pair success to Mission Control: pair=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658 -> 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, amt=1001001 mSAT 2022-06-09 22:26:34.897 [DBG] CRTR: Setting 032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658->03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 range to [1001001 mSAT-0 mSAT] 2022-06-09 22:26:34.897 [DBG] CRTR: Reporting pair success to Mission Control: pair=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 -> 0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179, amt=1000000 mSAT 2022-06-09 22:26:34.897 [DBG] CRTR: Setting 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37->0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179 range to [1000000 mSAT-0 mSAT] 2022-06-09 22:26:34.897 [DBG] HSWC: Closed completed SETTLE circuit for 4025e53d1434e62de3d423d68fc17667c8b27f3d66538e04853d73683cf710d3: (0:0:0, 1) <-> (3945:1:0, 0) 2022-06-09 22:26:34.899 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.899 [INF] SRVR: Adding preimage=bbbe31ae6105ca902c8aff1e0efa8b1e2fe1cc5eb95e1de0af8efd53694a563f to witness cache 2022-06-09 22:26:34.910 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=b49bc0a68695968f682ee99ec8c00e4406cae9365bba2d66c5730122b86f3cb6, next_point=02655c43b83c6a6beb2df887be63c0544dcbe6d89a505d27c9a0a3eb15d063fd84) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.913 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.927 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=db3a319d49211b5d691e21f8dfbbb1d223d1feb8e86ec4ff2f39b196cd507138, next_point=0270f29ae2fa54f1c73a57302cc1c7ff3795b3533fbf4303549faa52ee2542ba73) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.929 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): settle-fail-filter &{1 [0]} 2022-06-09 22:26:34.930 [DBG] CRTR: Payment ed6998ed0481ea4ac48ccb057257cea691faba7d3a2bfcf84975b8443ad69a37 (pid=2) successfully sent to switch, route: 4337573371641856 (1001001 mSAT) -> 4350767511175168 (1000000 mSAT), cltv 4042 2022-06-09 22:26:34.931 [DBG] HSWC: Subscribing to result for paymentID=2 2022-06-09 22:26:34.940 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): queueing keystone of ADD open circuit: (Chan ID=0:0:0, HTLC ID=2)->(Chan ID=3945:1:0, HTLC ID=1) 2022-06-09 22:26:34.941 [DBG] PEER: Sending UpdateAddHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=1, amt=1001001 mSAT, expiry=4042, hash=ed6998ed0481ea4ac48ccb057257cea691faba7d3a2bfcf84975b8443ad69a37) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.994 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): removing Add packet (Chan ID=0:0:0, HTLC ID=2) from mailbox 2022-06-09 22:26:34.994 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.997 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=05fd5aafd7d74a5fad5f1eab0ca997ef3ca68ee81ba9477095298c226a4c1159, next_point=02e8afbf77e53c94954d4b6857d6df756eb980ae942f1328e9b4347ee8d520fcdf) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:34.999 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.013 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=53f1c5410e62f6040d173fc3347fcf8ce6549ba13d5ae22e977afab037b92f29, next_point=03e7aaff868b56ac9162fcac04e78e67d17049944456c0204196ae3be40b8545e2) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.117 [DBG] PEER: Received UpdateFulfillHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=1, pre_image=50b30c972cf2ede81169b3f93e683cb86dd9b293e2196992146ae480e25b5007) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.118 [DBG] HSWC: Closed completed SETTLE circuit for ed6998ed0481ea4ac48ccb057257cea691faba7d3a2bfcf84975b8443ad69a37: (0:0:0, 2) <-> (3945:1:0, 1) 2022-06-09 22:26:35.118 [DBG] HSWC: Storing result for paymentID=2 2022-06-09 22:26:35.118 [DBG] HSWC: Tearing down open circuit with SETTLE pkt, removing circuit=(Chan ID=0:0:0, HTLC ID=2) with keystone=(Chan ID=3945:1:0, HTLC ID=1) 2022-06-09 22:26:35.118 [DBG] HSWC: Received network result *lnwire.UpdateFulfillHTLC for attemptID=2 2022-06-09 22:26:35.118 [DBG] HSWC: Closed completed SETTLE circuit for ed6998ed0481ea4ac48ccb057257cea691faba7d3a2bfcf84975b8443ad69a37: (0:0:0, 2) <-> (3945:1:0, 1) 2022-06-09 22:26:35.118 [DBG] CRTR: Payment ed6998ed0481ea4ac48ccb057257cea691faba7d3a2bfcf84975b8443ad69a37 succeeded with pid=2 2022-06-09 22:26:35.118 [DBG] CRTR: Reporting pair success to Mission Control: pair=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658 -> 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, amt=1001001 mSAT 2022-06-09 22:26:35.118 [DBG] CRTR: Setting 032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658->03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 range to [1001001 mSAT-0 mSAT] 2022-06-09 22:26:35.118 [DBG] CRTR: Reporting pair success to Mission Control: pair=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 -> 0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179, amt=1000000 mSAT 2022-06-09 22:26:35.118 [DBG] CRTR: Setting 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37->0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179 range to [1000000 mSAT-0 mSAT] 2022-06-09 22:26:35.120 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.120 [INF] SRVR: Adding preimage=50b30c972cf2ede81169b3f93e683cb86dd9b293e2196992146ae480e25b5007 to witness cache 2022-06-09 22:26:35.132 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=88d23a71abf8a28b694cac3aa0ead93e370160247705499566bf0587079ac029, next_point=0372d95f2a6f57c418dbfaa9126005ae82a5be2799028d83379d091dd29bb9fe00) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.134 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.148 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=4db7456035002bbb6f1f96cdfac6268a54401438574dc128660798bcb4b60abc, next_point=03fd287041961dc9fc577f7761b280aca588a80873b48a58e1051f2c23d46baac0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.151 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): settle-fail-filter &{1 [0]} 2022-06-09 22:26:35.153 [DBG] CRTR: Payment 0638539b217a05dcc30882b4c5bfe431f3197d46b2d0f8362150547916a64023 (pid=3) successfully sent to switch, route: 4337573371641856 (1001001 mSAT) -> 4350767511175168 (1000000 mSAT), cltv 4042 2022-06-09 22:26:35.154 [DBG] HSWC: Subscribing to result for paymentID=3 2022-06-09 22:26:35.162 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): queueing keystone of ADD open circuit: (Chan ID=0:0:0, HTLC ID=3)->(Chan ID=3945:1:0, HTLC ID=2) 2022-06-09 22:26:35.162 [DBG] PEER: Sending UpdateAddHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=2, amt=1001001 mSAT, expiry=4042, hash=0638539b217a05dcc30882b4c5bfe431f3197d46b2d0f8362150547916a64023) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.214 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): removing Add packet (Chan ID=0:0:0, HTLC ID=3) from mailbox 2022-06-09 22:26:35.214 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.217 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=1cf3d142ba59770d20f097cf49b9db505075203f3842e94d2bd35d42f86abe2f, next_point=030425d6d883504723894170b2be10ce5cea5bf542c0f39fe2eb8d0bc999231b8c) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.219 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.233 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=ed5df2447a8d1466ff2ad7769bfa7e9a2bfe63b6900cd85195fceea34c979da7, next_point=034f3b4afcf65f7ca7fc1695c76ad7b1b0e510679dc74133f858f78e79c9f47543) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.338 [DBG] PEER: Received UpdateFulfillHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=2, pre_image=c8b3b72d7dc3bbe36a7b99502d5ea566afd1f73269d7b301d978b3881f30d688) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.338 [DBG] HSWC: Closed completed SETTLE circuit for 0638539b217a05dcc30882b4c5bfe431f3197d46b2d0f8362150547916a64023: (0:0:0, 3) <-> (3945:1:0, 2) 2022-06-09 22:26:35.338 [DBG] HSWC: Storing result for paymentID=3 2022-06-09 22:26:35.338 [DBG] HSWC: Tearing down open circuit with SETTLE pkt, removing circuit=(Chan ID=0:0:0, HTLC ID=3) with keystone=(Chan ID=3945:1:0, HTLC ID=2) 2022-06-09 22:26:35.338 [DBG] HSWC: Received network result *lnwire.UpdateFulfillHTLC for attemptID=3 2022-06-09 22:26:35.338 [DBG] HSWC: Closed completed SETTLE circuit for 0638539b217a05dcc30882b4c5bfe431f3197d46b2d0f8362150547916a64023: (0:0:0, 3) <-> (3945:1:0, 2) 2022-06-09 22:26:35.338 [DBG] CRTR: Payment 0638539b217a05dcc30882b4c5bfe431f3197d46b2d0f8362150547916a64023 succeeded with pid=3 2022-06-09 22:26:35.339 [DBG] CRTR: Reporting pair success to Mission Control: pair=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658 -> 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, amt=1001001 mSAT 2022-06-09 22:26:35.339 [DBG] CRTR: Setting 032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658->03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 range to [1001001 mSAT-0 mSAT] 2022-06-09 22:26:35.339 [DBG] CRTR: Reporting pair success to Mission Control: pair=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 -> 0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179, amt=1000000 mSAT 2022-06-09 22:26:35.339 [DBG] CRTR: Setting 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37->0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179 range to [1000000 mSAT-0 mSAT] 2022-06-09 22:26:35.340 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.340 [INF] SRVR: Adding preimage=c8b3b72d7dc3bbe36a7b99502d5ea566afd1f73269d7b301d978b3881f30d688 to witness cache 2022-06-09 22:26:35.352 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=1072b52a7a03453f15be8b409fbddba8de1cdbbaa74ec49fde458b0c5834e96e, next_point=03ceb5fe8d7e9cdd548ea8f32b1de9b3fcf076dfdb188faa2a615dd5764263342a) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.354 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.371 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=97c5a0e61d87ec607187072ba16df6edac9e3ab0c4d1ac645e4f3bac126ebdfc, next_point=037c1b4e88d6ffc0f476089cabbcdbd8047effc5c0e11025b805c364efb5457cd6) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.373 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): settle-fail-filter &{1 [0]} 2022-06-09 22:26:35.373 [DBG] CRTR: Payment d09829225438c8a48d16dbfafcc52e00a4be4091b146a0a8282147d930857a2a (pid=4) successfully sent to switch, route: 4337573371641856 (1001001 mSAT) -> 4350767511175168 (1000000 mSAT), cltv 4042 2022-06-09 22:26:35.375 [DBG] HSWC: Subscribing to result for paymentID=4 2022-06-09 22:26:35.384 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): queueing keystone of ADD open circuit: (Chan ID=0:0:0, HTLC ID=4)->(Chan ID=3945:1:0, HTLC ID=3) 2022-06-09 22:26:35.384 [DBG] PEER: Sending UpdateAddHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=3, amt=1001001 mSAT, expiry=4042, hash=d09829225438c8a48d16dbfafcc52e00a4be4091b146a0a8282147d930857a2a) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.437 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): removing Add packet (Chan ID=0:0:0, HTLC ID=4) from mailbox 2022-06-09 22:26:35.437 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.440 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=504edbfb5f4d3d906f35468467f0a5277effff880aa3c87eeb5021dc9b6fd3ee, next_point=0229aeca756a789d0452dc3446edca94eab7020f7e6995ff8104819878d96eba36) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.442 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.455 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=47acd1efd9ca3f5a2a6cd7d8b91379e574503a7cbd2d3f92bcc8e222a20e5121, next_point=02fafc6247a07b5f1022f2549df4657453cc0b10cfae18c8726256ea130dd7ade5) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.561 [DBG] PEER: Received UpdateFulfillHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=3, pre_image=eef41e38d216bdd6837bfbc187eed6eafcc86bd9b1a97211eb3d6b9f1f6603c1) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.561 [DBG] HSWC: Closed completed SETTLE circuit for d09829225438c8a48d16dbfafcc52e00a4be4091b146a0a8282147d930857a2a: (0:0:0, 4) <-> (3945:1:0, 3) 2022-06-09 22:26:35.561 [DBG] HSWC: Storing result for paymentID=4 2022-06-09 22:26:35.561 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.561 [INF] SRVR: Adding preimage=eef41e38d216bdd6837bfbc187eed6eafcc86bd9b1a97211eb3d6b9f1f6603c1 to witness cache 2022-06-09 22:26:35.561 [DBG] HSWC: Tearing down open circuit with SETTLE pkt, removing circuit=(Chan ID=0:0:0, HTLC ID=4) with keystone=(Chan ID=3945:1:0, HTLC ID=3) 2022-06-09 22:26:35.561 [DBG] HSWC: Received network result *lnwire.UpdateFulfillHTLC for attemptID=4 2022-06-09 22:26:35.561 [DBG] HSWC: Closed completed SETTLE circuit for d09829225438c8a48d16dbfafcc52e00a4be4091b146a0a8282147d930857a2a: (0:0:0, 4) <-> (3945:1:0, 3) 2022-06-09 22:26:35.561 [DBG] CRTR: Payment d09829225438c8a48d16dbfafcc52e00a4be4091b146a0a8282147d930857a2a succeeded with pid=4 2022-06-09 22:26:35.561 [DBG] CRTR: Reporting pair success to Mission Control: pair=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 -> 0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179, amt=1000000 mSAT 2022-06-09 22:26:35.561 [DBG] CRTR: Setting 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37->0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179 range to [1000000 mSAT-0 mSAT] 2022-06-09 22:26:35.561 [DBG] CRTR: Reporting pair success to Mission Control: pair=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658 -> 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, amt=1001001 mSAT 2022-06-09 22:26:35.562 [DBG] CRTR: Setting 032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658->03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 range to [1001001 mSAT-0 mSAT] 2022-06-09 22:26:35.575 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=724413080f9101873906022ecf6f1b50f1435b700bc3d235388e36ddcf756391, next_point=02e3c88a69db0ff6fe0a7a01eafd48fe9d7dda8979583a0a33826b22f0e6ed80f9) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.577 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.591 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=8d672e6df78a49ce0d4e87ef32e31a46b352273bdf9ad8a9bae64e2986960207, next_point=02de9f2e7604277f68b128a93e92a3ef4d46853c67e7a5af64839f988bb9659d23) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.593 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): settle-fail-filter &{1 [0]} 2022-06-09 22:26:35.596 [DBG] CRTR: Payment 8369da61d59a15b78ca09b48a63e84b840b9af7f284e25d64cb3e527d0d7d496 (pid=5) successfully sent to switch, route: 4337573371641856 (1001001 mSAT) -> 4350767511175168 (1000000 mSAT), cltv 4042 2022-06-09 22:26:35.597 [DBG] HSWC: Subscribing to result for paymentID=5 2022-06-09 22:26:35.604 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): queueing keystone of ADD open circuit: (Chan ID=0:0:0, HTLC ID=5)->(Chan ID=3945:1:0, HTLC ID=4) 2022-06-09 22:26:35.604 [DBG] PEER: Sending UpdateAddHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=4, amt=1001001 mSAT, expiry=4042, hash=8369da61d59a15b78ca09b48a63e84b840b9af7f284e25d64cb3e527d0d7d496) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.657 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): removing Add packet (Chan ID=0:0:0, HTLC ID=5) from mailbox 2022-06-09 22:26:35.657 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.660 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=456f26497ccca8b3a2fef8a2bfafe3d44ea17d6e641a934e9a945219c7a030dd, next_point=0323f48f738e63acb927f18855c8c614b787cbede0b270ef163c4ae9fa7b43797b) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.662 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.676 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=fd8afcabcd64596677e1437e8c67edbd954f1508b345169af720cf2bd61ad698, next_point=02eb47a28c5e17f0c7648eb43417ef11af4778c282b3455b2d86d8fd850f31bf13) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.779 [DBG] PEER: Received UpdateFulfillHTLC(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, id=4, pre_image=8700ba3fb510aa9678e4cc79e0b49e71a884764c29bdd75a6819073032b03e5f) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.779 [DBG] HSWC: Closed completed SETTLE circuit for 8369da61d59a15b78ca09b48a63e84b840b9af7f284e25d64cb3e527d0d7d496: (0:0:0, 5) <-> (3945:1:0, 4) 2022-06-09 22:26:35.779 [DBG] HSWC: Storing result for paymentID=5 2022-06-09 22:26:35.779 [DBG] HSWC: Tearing down open circuit with SETTLE pkt, removing circuit=(Chan ID=0:0:0, HTLC ID=5) with keystone=(Chan ID=3945:1:0, HTLC ID=4) 2022-06-09 22:26:35.779 [DBG] HSWC: Received network result *lnwire.UpdateFulfillHTLC for attemptID=5 2022-06-09 22:26:35.779 [DBG] CRTR: Payment 8369da61d59a15b78ca09b48a63e84b840b9af7f284e25d64cb3e527d0d7d496 succeeded with pid=5 2022-06-09 22:26:35.779 [DBG] CRTR: Reporting pair success to Mission Control: pair=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658 -> 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, amt=1001001 mSAT 2022-06-09 22:26:35.780 [DBG] CRTR: Setting 032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658->03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 range to [1001001 mSAT-0 mSAT] 2022-06-09 22:26:35.780 [DBG] CRTR: Reporting pair success to Mission Control: pair=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 -> 0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179, amt=1000000 mSAT 2022-06-09 22:26:35.780 [DBG] CRTR: Setting 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37->0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179 range to [1000000 mSAT-0 mSAT] 2022-06-09 22:26:35.779 [DBG] HSWC: Closed completed SETTLE circuit for 8369da61d59a15b78ca09b48a63e84b840b9af7f284e25d64cb3e527d0d7d496: (0:0:0, 5) <-> (3945:1:0, 4) 2022-06-09 22:26:35.781 [DBG] PEER: Received CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.781 [INF] SRVR: Adding preimage=8700ba3fb510aa9678e4cc79e0b49e71a884764c29bdd75a6819073032b03e5f to witness cache 2022-06-09 22:26:35.793 [DBG] PEER: Sending RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=7dd62a1ea503f2d1e75e8358210c553f3153e6255e4d496c3e5305b81354f258, next_point=027dc7c69324536c2fe0f3751a012c840e6e8e0165d2ad22d4c79800228a4d29f7) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.795 [DBG] PEER: Sending CommitSig(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, num_htlcs=0) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.809 [DBG] PEER: Received RevokeAndAck(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, rev=8157283d0f0212d9adb6fb4f893489206aa76f136a7ce1edb952de295fd3d112, next_point=0354dd5cf1b75cbf3e1ba818405eac345fb09eb47daae45e59d793d5a09b58268c) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:35.811 [DBG] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): settle-fail-filter &{1 [0]} 2022-06-09 22:26:35.816 [DBG] RPCS: [listchannels] fetched 1 channels from DB 2022-06-09 22:26:36.018 [DBG] RPCS: [listchannels] fetched 1 channels from DB 2022-06-09 22:26:36.220 [DBG] RPCS: [listchannels] fetched 1 channels from DB 2022-06-09 22:26:36.625 [WRN] LNWL: Web API does not have a fee rate for target=6, using the fee rate for target=1 instead 2022-06-09 22:26:36.625 [DBG] LNWL: Web API returning 12500 sat/kw for conf target of 6 2022-06-09 22:26:36.625 [DBG] RPCS: Target sat/kw for closing transaction: 12500 2022-06-09 22:26:36.625 [DBG] HSWC: Requesting local channel close: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb 2022-06-09 22:26:36.625 [INF] PEER: Local close channel request delivered to peer: 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 2022-06-09 22:26:36.626 [INF] PEER: Delivery addr for channel close: bcrt1q8zmhu8pwpgsx9t63qtm5d7krz0x5dkeyzxfy3z 2022-06-09 22:26:36.626 [INF] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): exited 2022-06-09 22:26:36.626 [INF] HSWC: Removing channel link with ChannelID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) 2022-06-09 22:26:36.626 [INF] HSWC: ChannelLink(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): stopping 2022-06-09 22:26:36.627 [INF] CHCL: Ideal fee for closure of ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) is: 9050 sat 2022-06-09 22:26:36.627 [INF] CHCL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): initiating shutdown 2022-06-09 22:26:36.627 [INF] NANN: Announcing channel(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) disabled [requested] 2022-06-09 22:26:36.627 [DBG] DISC: Processing network message: peer=, source=032fb94c44184a9f92c33d794fca5507af163181a087d1d6e03b2e710923c6b658, msg=ChannelUpdate, is_remote=false 2022-06-09 22:26:36.629 [INF] CHCL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): sending shutdown message 2022-06-09 22:26:36.629 [DBG] PEER: Sending Shutdown(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, script=001438b77e1c2e0a2062af5102f746fac313cd46db24) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:36.634 [DBG] PEER: Received Shutdown(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, script=0014041294d2c90054ea937a3a3266408bc61088fca8) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:36.634 [INF] CHCL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): shutdown response received, entering fee negotiation 2022-06-09 22:26:36.634 [INF] CHCL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): proposing fee of 9050 sat to close chan 2022-06-09 22:26:36.634 [DBG] PEER: Sending ClosingSigned(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, fee_sat=0.0000905 BTC) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:36.640 [INF] LNWL: Inserting unconfirmed transaction 593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595 2022-06-09 22:26:36.640 [DBG] LNWL: Marked address bcrt1q8zmhu8pwpgsx9t63qtm5d7krz0x5dkeyzxfy3z used 2022-06-09 22:26:36.641 [DBG] PEER: Received ClosingSigned(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, fee_sat=0.0000905 BTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:36.641 [INF] CHCL: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) fee of 0.0000905 BTC accepted, ending negotiation 2022-06-09 22:26:36.642 [INF] CHCL: Broadcasting cooperative close tx: (*wire.MsgTx)(0x3755440)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0x5e28900)({ PreviousOutPoint: (wire.OutPoint) bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) (len=4 cap=4) { ([]uint8) , ([]uint8) (len=71 cap=144) { 00000000 30 44 02 20 68 c0 ce bf 64 08 97 5b 22 18 3d b4 |0D. h...d..[".=.| 00000010 2f 99 45 c6 e0 26 b3 2c 3c 84 ee 22 d7 ce 2f 01 |/.E..&.,<.."../.| 00000020 b2 9f 83 e7 02 20 37 f3 74 c3 11 2b b9 9e 46 43 |..... 7.t..+..FC| 00000030 9a 2a 1a ed 11 7f a4 15 4f 8c 31 b8 6a 01 7f 92 |.*......O.1.j...| 00000040 e6 eb 5b 54 d5 c1 01 |..[T...| }, ([]uint8) (len=72 cap=144) { 00000000 30 45 02 21 00 d5 7c cb f3 79 1b 3b cd 90 43 60 |0E.!..|..y.;..C`| 00000010 df 52 ec 76 e7 8a 9b 00 06 02 00 12 82 6e d4 d5 |.R.v.........n..| 00000020 c1 07 10 67 ae 02 20 7a c8 b7 ba ed 86 fe 76 11 |...g.. z......v.| 00000030 a3 ce fd f4 4a 89 ad c4 80 21 b9 b4 73 8f 42 f7 |....J....!..s.B.| 00000040 eb cf 09 8c 3b 7a 50 01 |....;zP.| }, ([]uint8) (len=71 cap=500) { 00000000 52 21 03 1c c3 a9 ad 60 c1 f8 2b 6c 0e c2 c1 59 |R!.....`..+l...Y| 00000010 b0 69 ef fd d1 93 f4 72 55 6b 03 ea 63 29 74 5b |.i.....rUk..c)t[| 00000020 f8 f7 c5 21 03 74 cb c6 45 7b 88 e5 1f 82 ae a3 |...!.t..E{......| 00000030 8f a0 94 76 19 79 43 13 72 ff 25 f9 f8 46 27 92 |...v.yC.r.%..F'.| 00000040 bf 69 cc ba 83 52 ae |.i...R.| } }, Sequence: (uint32) 4294967295 }) }, TxOut: ([]*wire.TxOut) (len=2 cap=15) { (*wire.TxOut)(0x340acc0)({ Value: (int64) 5005, PkScript: ([]uint8) (len=22 cap=34) { 00000000 00 14 04 12 94 d2 c9 00 54 ea 93 7a 3a 32 66 40 |........T..z:2f@| 00000010 8b c6 10 88 fc a8 |......| } }), (*wire.TxOut)(0x340aca8)({ Value: (int64) 85944, PkScript: ([]uint8) (len=22 cap=500) { 00000000 00 14 38 b7 7e 1c 2e 0a 20 62 af 51 02 f7 46 fa |..8.~... b.Q..F.| 00000010 c3 13 cd 46 db 24 |...F.$| } }) }, LockTime: (uint32) 0 }) 2022-06-09 22:26:36.644 [INF] HSWC: Removing channel link with ChannelID(a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb) 2022-06-09 22:26:36.644 [INF] PEER: Waiting for confirmation of cooperative close of ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) with txid: 593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595 2022-06-09 22:26:36.644 [INF] NTFN: New confirmation subscription: conf_id=3, txid=593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595, num_confs=1 height_hint=3962 2022-06-09 22:26:36.644 [DBG] NTFN: Dispatching historical confirmation rescan for txid=593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595 2022-06-09 22:26:36.644 [DBG] PEER: Sending ClosingSigned(chan_id=a91207bc97ff3f4584814e07efc52ad144998e05c587093ae2ff475a981caabb, fee_sat=0.0000905 BTC) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:36.645 [DBG] NTFN: Confirmation details for txid=593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595 not found during historical dispatch, waiting to dispatch at tip 2022-06-09 22:26:36.653 [INF] DISC: Broadcasting 1 new announcements in 1 sub batches 2022-06-09 22:26:36.653 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:36.653 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4337573371641856, mflags=00000001, cflags=00000010, update_time=2022-06-09 22:26:36 +0000 UTC) to 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:36.669 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4337573371641856, mflags=00000001, cflags=00000011, update_time=2022-06-09 22:26:36 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:36.669 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:36.703 [INF] DISC: Broadcasting 1 new announcements in 1 sub batches 2022-06-09 22:26:36.703 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:39.646 [DBG] RPCS: [listchannels] fetched 0 channels from DB 2022-06-09 22:26:39.647 [DBG] RPCS: [pendingchannels] 2022-06-09 22:26:39.714 [DBG] LNWL: Filtering block 3963 (683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953) with 2 transactions 2022-06-09 22:26:39.714 [DBG] LNWL: Filtering block 3963 (683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953) with 2 transactions 2022-06-09 22:26:39.714 [DBG] LNWL: Filtering block 3963 (683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953) with 2 transactions 2022-06-09 22:26:39.714 [DBG] NTFN: Found spend of outpoint=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, script=0 64cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe89: spend_tx=593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595, block_height=3963 2022-06-09 22:26:39.714 [INF] CRTR: Pruning channel graph using block 683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953 (height=3963) 2022-06-09 22:26:39.714 [INF] LNWL: Marking unconfirmed transaction 593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595 mined in block 3963 2022-06-09 22:26:39.715 [DBG] LNWL: Marked address bcrt1q8zmhu8pwpgsx9t63qtm5d7krz0x5dkeyzxfy3z used 2022-06-09 22:26:39.715 [DBG] CHDB: Pruned graph, cache now has num_node_features=3, num_nodes=3, num_channels=2 2022-06-09 22:26:39.715 [INF] CRTR: Block 683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953 (height=3963) closed 1 channels 2022-06-09 22:26:39.716 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 3963 2022-06-09 22:26:39.716 [DBG] NTFN: Found spend of outpoint=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, script=0 64cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe89: spend_tx=593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595, block_height=3963 2022-06-09 22:26:39.716 [DBG] NTFN: Spend request outpoint=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, script=0 64cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe89 spent at tip=3963 2022-06-09 22:26:39.716 [DBG] NTFN: Found initial confirmation of txid=593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595: height=3963, hash=683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953 2022-06-09 22:26:39.737 [INF] NTFN: New block: height=3963, sha=683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953 2022-06-09 22:26:39.737 [DBG] SWPR: New block: height=3963, sha=683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953 2022-06-09 22:26:39.737 [INF] UTXN: Attempting to graduate height=3963: num_kids=0, num_babies=0 2022-06-09 22:26:39.737 [INF] NTFN: Dispatching 1 confirmation notification for txid=593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595 2022-06-09 22:26:39.737 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=chainTrigger from state=StateDefault 2022-06-09 22:26:39.737 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3963) examining active HTLC's 2022-06-09 22:26:39.737 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3963, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:39.737 [DBG] DISC: New block: height=3963, hash=683992536a3d6c288f1dc226674fa16389d32319b9a777a4a71465b579347953 2022-06-09 22:26:39.737 [INF] NTFN: Dispatching confirmed spend notification for outpoint=bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, script=0 64cc0e5b28682447fe583313790af461bd3ca9695e2a92c080e3de8de2bbfe89 at current height=3963: 593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595[0] spending bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0 at height=3963 2022-06-09 22:26:39.737 [INF] PEER: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) is now closed at height 3963 2022-06-09 22:26:39.737 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): no actions for chain trigger, terminating 2022-06-09 22:26:39.737 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): terminating at state=StateDefault 2022-06-09 22:26:39.737 [INF] RPCS: [closechannel] close completed: txid(593cde8dae42b7d9268948f2f606f970f156c5a163fac04ce7db8a7f7bb8f595) 2022-06-09 22:26:39.737 [DBG] CNCT: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): local_commit_type=2, local_commit=(*channeldb.ChannelCommitment)(0x58a014c)({ CommitHeight: (uint64) 10, LocalLogIndex: (uint64) 5, LocalHtlcIndex: (uint64) 5, RemoteLogIndex: (uint64) 5, RemoteHtlcIndex: (uint64) 0, LocalBalance: (lnwire.MilliSatoshi) 85944995 mSAT, RemoteBalance: (lnwire.MilliSatoshi) 5005005 mSAT, CommitFee: (btcutil.Amount) 0.0000905 BTC, FeePerKw: (btcutil.Amount) 0.000125 BTC, CommitTx: (*wire.MsgTx)(0x39a4240)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0x48f3200)({ PreviousOutPoint: (wire.OutPoint) bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) , Sequence: (uint32) 2147851902 }) }, TxOut: ([]*wire.TxOut) (len=2 cap=2) { (*wire.TxOut)(0x5c94ed0)({ Value: (int64) 5005, PkScript: ([]uint8) (len=22 cap=22) { 00000000 00 14 37 3a 20 10 2e 3c 27 e3 35 00 35 38 36 51 |..7: ..<'.5.586Q| 00000010 71 b1 ca 62 df 5d |q..b.]| } }), (*wire.TxOut)(0x5c94ee4)({ Value: (int64) 85944, PkScript: ([]uint8) (len=34 cap=34) { 00000000 00 20 91 13 cf 8d aa eb e7 21 8e b9 63 c4 14 a6 |. .......!..c...| 00000010 1a 73 92 0d 4c b6 d8 41 b8 35 4c 82 0c e6 03 0c |.s..L..A.5L.....| 00000020 d4 30 |.0| } }) }, LockTime: (uint32) 547205187 }), CommitSig: ([]uint8) (len=70 cap=70) { 00000000 30 44 02 20 60 08 58 b8 f2 ac 64 58 e1 05 0f c6 |0D. `.X...dX....| 00000010 89 9f 6d a1 5c 67 91 3b ef 37 ca db ec b8 e6 ef |..m.\g.;.7......| 00000020 f0 62 e9 06 02 20 29 36 0d 6b 5b 7a 68 7d 43 02 |.b... )6.k[zh}C.| 00000030 40 dd cc 0c 49 1f bc 4e 7e dc e4 41 ac a5 fc df |@...I..N~..A....| 00000040 7a d6 1a f5 66 36 |z...f6| }, Htlcs: ([]channeldb.HTLC) }) 2022-06-09 22:26:39.737 [DBG] CNCT: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): remote_commit_type=2, remote_commit=(*channeldb.ChannelCommitment)(0x58a01b0)({ CommitHeight: (uint64) 10, LocalLogIndex: (uint64) 5, LocalHtlcIndex: (uint64) 5, RemoteLogIndex: (uint64) 5, RemoteHtlcIndex: (uint64) 0, LocalBalance: (lnwire.MilliSatoshi) 85944995 mSAT, RemoteBalance: (lnwire.MilliSatoshi) 5005005 mSAT, CommitFee: (btcutil.Amount) 0.0000905 BTC, FeePerKw: (btcutil.Amount) 0.000125 BTC, CommitTx: (*wire.MsgTx)(0x39a4260)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0x48f32c0)({ PreviousOutPoint: (wire.OutPoint) bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) , Sequence: (uint32) 2147851902 }) }, TxOut: ([]*wire.TxOut) (len=2 cap=2) { (*wire.TxOut)(0x5c94f00)({ Value: (int64) 5005, PkScript: ([]uint8) (len=34 cap=34) { 00000000 00 20 30 1a d9 a6 e9 1d 58 cb a4 de 09 6e 06 9a |. 0.....X....n..| 00000010 a1 9f c5 13 9f c6 6a 02 37 96 72 81 5b 26 61 f8 |......j.7.r.[&a.| 00000020 5e 81 |^.| } }), (*wire.TxOut)(0x5c94f14)({ Value: (int64) 85944, PkScript: ([]uint8) (len=22 cap=22) { 00000000 00 14 5b 12 27 ab e7 22 80 a4 2a b8 4d 86 55 8f |..[.'.."..*.M.U.| 00000010 bc fc e8 4c a1 41 |...L.A| } }) }, LockTime: (uint32) 547205187 }), CommitSig: ([]uint8) { }, Htlcs: ([]channeldb.HTLC) }) 2022-06-09 22:26:39.738 [INF] CNCT: Cooperative closure for ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): (*wire.MsgTx)(0x391ee20)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0x5d983c0)({ PreviousOutPoint: (wire.OutPoint) bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) (len=4 cap=4) { ([]uint8) { }, ([]uint8) (len=71 cap=71) { 00000000 30 44 02 20 68 c0 ce bf 64 08 97 5b 22 18 3d b4 |0D. h...d..[".=.| 00000010 2f 99 45 c6 e0 26 b3 2c 3c 84 ee 22 d7 ce 2f 01 |/.E..&.,<.."../.| 00000020 b2 9f 83 e7 02 20 37 f3 74 c3 11 2b b9 9e 46 43 |..... 7.t..+..FC| 00000030 9a 2a 1a ed 11 7f a4 15 4f 8c 31 b8 6a 01 7f 92 |.*......O.1.j...| 00000040 e6 eb 5b 54 d5 c1 01 |..[T...| }, ([]uint8) (len=72 cap=72) { 00000000 30 45 02 21 00 d5 7c cb f3 79 1b 3b cd 90 43 60 |0E.!..|..y.;..C`| 00000010 df 52 ec 76 e7 8a 9b 00 06 02 00 12 82 6e d4 d5 |.R.v.........n..| 00000020 c1 07 10 67 ae 02 20 7a c8 b7 ba ed 86 fe 76 11 |...g.. z......v.| 00000030 a3 ce fd f4 4a 89 ad c4 80 21 b9 b4 73 8f 42 f7 |....J....!..s.B.| 00000040 eb cf 09 8c 3b 7a 50 01 |....;zP.| }, ([]uint8) (len=71 cap=71) { 00000000 52 21 03 1c c3 a9 ad 60 c1 f8 2b 6c 0e c2 c1 59 |R!.....`..+l...Y| 00000010 b0 69 ef fd d1 93 f4 72 55 6b 03 ea 63 29 74 5b |.i.....rUk..c)t[| 00000020 f8 f7 c5 21 03 74 cb c6 45 7b 88 e5 1f 82 ae a3 |...!.t..E{......| 00000030 8f a0 94 76 19 79 43 13 72 ff 25 f9 f8 46 27 92 |...v.yC.r.%..F'.| 00000040 bf 69 cc ba 83 52 ae |.i...R.| } }, Sequence: (uint32) 4294967295 }) }, TxOut: ([]*wire.TxOut) (len=2 cap=2) { (*wire.TxOut)(0x4954d80)({ Value: (int64) 5005, PkScript: ([]uint8) (len=22 cap=22) { 00000000 00 14 04 12 94 d2 c9 00 54 ea 93 7a 3a 32 66 40 |........T..z:2f@| 00000010 8b c6 10 88 fc a8 |......| } }), (*wire.TxOut)(0x4954d94)({ Value: (int64) 85944, PkScript: ([]uint8) (len=22 cap=22) { 00000000 00 14 38 b7 7e 1c 2e 0a 20 62 af 51 02 f7 46 fa |..8.~... b.Q..F.| 00000010 c3 13 cd 46 db 24 |...F.$| } }) }, LockTime: (uint32) 0 }) 2022-06-09 22:26:39.739 [INF] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) marking channel cooperatively closed 2022-06-09 22:26:39.741 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=coopCloseTrigger from state=StateDefault 2022-06-09 22:26:39.741 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): new block (height=3963) examining active HTLC's 2022-06-09 22:26:39.741 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): checking commit chain actions at height=3963, in_htlc_count=0, out_htlc_count=0 2022-06-09 22:26:39.741 [DBG] CHBU: Removing channel bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0 from backup state 2022-06-09 22:26:39.741 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=1, num_new_chans=0 2022-06-09 22:26:39.742 [INF] CHBU: Updating backup file at /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:39.743 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:39.752 [DBG] CNCT: ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0): attempting state step with trigger=coopCloseTrigger from state=StateFullyResolved 2022-06-09 22:26:39.752 [INF] CNCT: ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) has been fully resolved on-chain at height=3963 2022-06-09 22:26:39.752 [INF] CNCT: Marking ChannelPoint(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) fully resolved 2022-06-09 22:26:39.752 [DBG] CHBU: Removing channel bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0 from backup state 2022-06-09 22:26:39.752 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=0, num_new_chans=0 2022-06-09 22:26:39.752 [INF] CHDB: Pruning link node 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 with zero open channels from database 2022-06-09 22:26:39.753 [DBG] CNCT: Stopping ChannelArbitrator(bbaa1c985a47ffe23a0987c5058e9944d12ac5ef074e8184453fff97bc0712a9:0) 2022-06-09 22:26:39.753 [INF] CHBU: Updating backup file at /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:39.753 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node2712183908/data/chain/bitcoin/regtest/channel.backup 2022-06-09 22:26:39.938 [DBG] RPCS: [pendingchannels] 2022-06-09 22:26:40.769 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4350767511175168, mflags=00000001, cflags=00000011, update_time=2022-06-09 22:26:40 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:40.769 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:40.769 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=4350767511175168, mflags=00000001, cflags=00000010, update_time=2022-06-09 22:26:40 +0000 UTC) from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:40.769 [DBG] DISC: Processing network message: peer=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, source=03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37, msg=ChannelUpdate, is_remote=true 2022-06-09 22:26:40.803 [INF] DISC: Broadcasting 2 new announcements in 1 sub batches 2022-06-09 22:26:40.803 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:40.803 [DBG] SRVR: Broadcasting 1 messages 2022-06-09 22:26:44.341 [DBG] LNWL: Filtering block 3964 (09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743) with 2 transactions 2022-06-09 22:26:44.341 [DBG] LNWL: Filtering block 3964 (09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743) with 2 transactions 2022-06-09 22:26:44.341 [DBG] LNWL: Filtering block 3964 (09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743) with 2 transactions 2022-06-09 22:26:44.342 [INF] CRTR: Pruning channel graph using block 09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743 (height=3964) 2022-06-09 22:26:44.342 [INF] CHDB: Pruned unconnected node 0294a6b0e231b368bb2292566c3000829fbbb25cadc58b2a7da88e70217159a179 from channel graph 2022-06-09 22:26:44.342 [INF] CHDB: Pruned unconnected node 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37 from channel graph 2022-06-09 22:26:44.342 [INF] CHDB: Pruned 2 unconnected nodes from the channel graph 2022-06-09 22:26:44.342 [DBG] CHDB: Pruned graph, cache now has num_node_features=1, num_nodes=1, num_channels=0 2022-06-09 22:26:44.342 [INF] CRTR: Block 09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743 (height=3964) closed 1 channels 2022-06-09 22:26:44.343 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 3964 2022-06-09 22:26:44.343 [INF] NTFN: New block: height=3964, sha=09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743 2022-06-09 22:26:44.343 [DBG] SWPR: New block: height=3964, sha=09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743 2022-06-09 22:26:44.343 [DBG] DISC: New block: height=3964, hash=09ab92dce1c7180f9b984757fc67d443dbb8a2e51149932548f782dc8f86c743 2022-06-09 22:26:44.343 [INF] UTXN: Attempting to graduate height=3964: num_kids=0, num_babies=0 2022-06-09 22:26:45.774 [INF] LTND: Received shutdown request. 2022-06-09 22:26:45.774 [INF] LTND: Shutting down... 2022-06-09 22:26:45.774 [INF] LTND: Gracefully shutting down. 2022-06-09 22:26:45.774 [INF] NANN: Channel Status Manager shutting down 2022-06-09 22:26:45.774 [INF] HSWC: HTLC Switch shutting down 2022-06-09 22:26:45.774 [INF] NTFN: Cancelling epoch notification, epoch_id=3 2022-06-09 22:26:45.776 [INF] HSWC: Onion processor shutting down 2022-06-09 22:26:45.776 [INF] HSWC: Decaying hash log received shutdown request 2022-06-09 22:26:45.777 [INF] NTFN: Cancelling epoch notification, epoch_id=7 2022-06-09 22:26:45.777 [INF] INVC: InvoiceRegistry shutting down 2022-06-09 22:26:45.777 [INF] NTFN: Cancelling epoch notification, epoch_id=6 2022-06-09 22:26:45.777 [INF] CRTR: Channel Router shutting down 2022-06-09 22:26:45.777 [INF] CRTR: FilteredChainView stopping 2022-06-09 22:26:45.777 [INF] CNCT: ChainArbitrator shutting down 2022-06-09 22:26:45.777 [INF] NTFN: Cancelling epoch notification, epoch_id=4 2022-06-09 22:26:45.777 [INF] FNDG: Funding manager shutting down 2022-06-09 22:26:45.777 [INF] BRAR: Breach arbiter shutting down 2022-06-09 22:26:45.777 [INF] UTXN: UTXO nursery shutting down 2022-06-09 22:26:45.777 [INF] NTFN: Cancelling epoch notification, epoch_id=2 2022-06-09 22:26:45.777 [INF] DISC: Authenticated gossiper shutting down 2022-06-09 22:26:45.777 [INF] DISC: Authenticated Gossiper is stopping 2022-06-09 22:26:45.777 [INF] NTFN: Cancelling epoch notification, epoch_id=5 2022-06-09 22:26:45.777 [INF] SWPR: Sweeper shutting down 2022-06-09 22:26:45.777 [DBG] SWPR: Sweeper shut down 2022-06-09 22:26:45.777 [INF] CHNF: ChannelNotifier shutting down 2022-06-09 22:26:45.777 [INF] NTFN: Cancelling epoch notification, epoch_id=1 2022-06-09 22:26:45.777 [INF] PRNF: PeerNotifier shutting down 2022-06-09 22:26:45.777 [INF] HSWC: HtlcNotifier shutting down 2022-06-09 22:26:45.778 [INF] CHBU: Stopping chanbackup.SubSwapper 2022-06-09 22:26:45.778 [INF] NTFN: bitcoind notifier shutting down 2022-06-09 22:26:45.778 [INF] CHFT: Stopping event store 2022-06-09 22:26:45.778 [DBG] PEER: block notifications canceled 2022-06-09 22:26:45.778 [DBG] CHFT: recording flap count for: 1 peers 2022-06-09 22:26:45.778 [INF] SRVR: Disconnecting from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:45.778 [DBG] SRVR: removing peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:45.778 [INF] PEER: disconnecting 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214, reason: server: disconnecting peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 2022-06-09 22:26:45.778 [INF] PEER: unable to read message from 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214: read tcp 127.0.0.1:45154->127.0.0.1:6214: use of closed network connection 2022-06-09 22:26:45.778 [INF] HLCK: Health monitor shutting down 2022-06-09 22:26:45.778 [DBG] HLCK: Health check: monitor quit 2022-06-09 22:26:45.979 [DBG] SRVR: Peer 03f4577f23801d4a87e99e48c49268b3607b232016309654096dd14e1511c04d37@127.0.0.1:6214 has been disconnected 2022-06-09 22:26:45.979 [INF] RPCS: Stopping RPC Server 2022-06-09 22:26:45.979 [INF] RPCS: Stopping RouterRPC Sub-RPC Server 2022-06-09 22:26:45.979 [INF] RPCS: Stopping AutopilotRPC Sub-RPC Server 2022-06-09 22:26:45.979 [INF] RPCS: Stopping InvoicesRPC Sub-RPC Server 2022-06-09 22:26:45.979 [INF] RPCS: Stopping VersionRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping WatchtowerClientRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping SignRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping PeersRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping ChainRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping DevRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping NeutrinoKitRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping WatchtowerRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] RPCS: Stopping WalletKitRPC Sub-RPC Server 2022-06-09 22:26:45.980 [INF] LTND: Shutdown complete