2021-01-18 08:30:48.106 [WRN] LTND: open /tmp/lndtest-node720792410/data: no such file or directory 2021-01-18 08:30:48.108 [INF] LTND: Version: 0.12.0-beta.rc5 commit=v0.12.0-beta.rc5-24-g009f7527, build=development, logging=default, debuglevel=debug 2021-01-18 08:30:48.109 [INF] LTND: Active chain: Bitcoin (network=regtest) 2021-01-18 08:30:48.109 [INF] LTND: Opening the main database, this might take a few minutes... 2021-01-18 08:30:48.109 [INF] LTND: Opening bbolt database, sync_freelist=false, auto_compact=false 2021-01-18 08:30:48.120 [INF] CHDB: Checking for schema update: latest_version=20, db_version=20 2021-01-18 08:30:48.120 [INF] LTND: Database now open (time_to_open=10.824946ms)! 2021-01-18 08:30:48.120 [INF] RPCS: Generating TLS certificates... 2021-01-18 08:30:48.132 [INF] RPCS: Done generating TLS certificates 2021-01-18 08:30:48.139 [INF] CHRE: Primary chain is set to: bitcoin 2021-01-18 08:30:48.150 [INF] CHRE: Using external fee estimator http://localhost:6560/fee-estimates.json: cached=false 2021-01-18 08:30:48.163 [INF] LNWL: Opened wallet 2021-01-18 08:30:48.164 [INF] LNWL: The wallet has been unlocked without a time limit 2021-01-18 08:30:48.245 [INF] CHRE: LightningWallet opened 2021-01-18 08:30:48.246 [DBG] LNWL: Locating suitable block for birthday 2021-01-16 08:30:48 +0000 UTC between blocks 0-943 2021-01-18 08:30:48.246 [DBG] LNWL: Checking candidate block: height=471, hash=525377b6e88a3b416cfa0414dbda3c74c4dfbb16b13a3ac7d805587c17251db9, timestamp=2021-01-18 08:28:11 +0000 UTC 2021-01-18 08:30:48.247 [DBG] LNWL: Checking candidate block: height=235, hash=263cbf1971e5f20db0f29dd2655167c0cc8ca02b6131cbdc23793b2f2878e28c, timestamp=2021-01-18 08:27:31 +0000 UTC 2021-01-18 08:30:48.248 [DBG] LNWL: Checking candidate block: height=117, hash=761b49584ca26728be277a8215fb1369fe9d3b9d1c4bcb3a9cbfa4e4541fe899, timestamp=2021-01-18 08:27:12 +0000 UTC 2021-01-18 08:30:48.248 [DBG] LNWL: Checking candidate block: height=58, hash=2d4a4af4c48ac0d474f692ecdff0ec3dedf599bf7ec06f062e4374ed10686381, timestamp=2021-01-18 08:27:02 +0000 UTC 2021-01-18 08:30:48.249 [DBG] LNWL: Checking candidate block: height=29, hash=609b9fe2923dc20cde74d262fb5b2866b2d2852dd84f01c9bc26eb081f5bbb03, timestamp=2021-01-18 08:26:57 +0000 UTC 2021-01-18 08:30:48.250 [DBG] LNWL: Checking candidate block: height=14, hash=4dc3e3da00840ce1343715ed0b7fb61b90144f2e26ec43b966b7a9999fabdd63, timestamp=2021-01-18 08:26:55 +0000 UTC 2021-01-18 08:30:48.251 [DBG] LNWL: Checking candidate block: height=7, hash=6564aae66f86436ce385a2b6d0d1696d26231a309bcf24611df9214d7010a38b, timestamp=2021-01-18 08:26:53 +0000 UTC 2021-01-18 08:30:48.251 [DBG] LNWL: Checking candidate block: height=3, hash=04a958b657525331b84ed4e3caf6a67856e63a69c0356d8401ea417d51e94e30, timestamp=2021-01-18 08:26:52 +0000 UTC 2021-01-18 08:30:48.252 [INF] HSWC: Restoring in-memory circuit state from disk 2021-01-18 08:30:48.252 [DBG] LNWL: Checking candidate block: height=1, hash=162996935eb0b8d95952df8b2ca3ec369b38d7b3c70591825d7c46b5669fe51a, timestamp=2021-01-18 08:26:51 +0000 UTC 2021-01-18 08:30:48.252 [INF] HSWC: Payment circuits loaded: num_pending=0, num_open=0 2021-01-18 08:30:48.252 [DBG] LNWL: Checking candidate block: height=0, hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, timestamp=2011-02-02 23:16:42 +0000 UTC 2021-01-18 08:30:48.252 [DBG] LNWL: Found birthday block: height=0, hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, timestamp=2011-02-02 23:16:42 +0000 UTC 2021-01-18 08:30:48.255 [DBG] CRTR: Instantiating mission control with config: PenaltyHalfLife=1h0m0s, AprioriHopProbability=0.6, AprioriWeight=0.5 2021-01-18 08:30:48.256 [DBG] CRTR: Mission control state reconstruction started 2021-01-18 08:30:48.256 [DBG] CRTR: Mission control state reconstruction finished: n=0, time=6.389µs 2021-01-18 08:30:48.256 [DBG] SRVR: Instantiating payment session source with config: AttemptCost=100 + 0.1%, MinRouteProbability=0.01 2021-01-18 08:30:48.257 [INF] LNWL: Started rescan from block 0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 (height 0) for 0 addresses 2021-01-18 08:30:48.258 [INF] LNWL: Catching up block hashes to height 943, this might take a while 2021-01-18 08:30:48.267 [INF] SWPR: Migrating UTXO nursery finalized TXIDs 2021-01-18 08:30:48.268 [INF] LTND: Channel backup proxy channel notifier starting 2021-01-18 08:30:48.268 [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 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: SignRPC 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: WalletKitRPC 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: AutopilotRPC 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: ChainRPC 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: InvoicesRPC 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: RouterRPC 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: WatchtowerRPC 2021-01-18 08:30:48.268 [DBG] LTND: Populating dependencies for sub RPC server: WatchtowerClientRPC 2021-01-18 08:30:48.268 [INF] SGNR: Making macaroons for Signer RPC Server at: /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/signer.macaroon 2021-01-18 08:30:48.269 [INF] RRPC: Making macaroons for Router RPC Server at: /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/router.macaroon 2021-01-18 08:30:48.269 [INF] NTFR: Baking macaroons for ChainNotifier RPC Server at: /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/chainnotifier.macaroon 2021-01-18 08:30:48.270 [INF] IRPC: Baking macaroons for invoices RPC Server at: /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/invoices.macaroon 2021-01-18 08:30:48.271 [INF] WLKT: Baking macaroons for WalletKit RPC Server at: /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/walletkit.macaroon 2021-01-18 08:30:48.271 [DBG] SGNR: Signer RPC server successfully register with root gRPC server 2021-01-18 08:30:48.271 [DBG] VRPC: Versioner RPC server successfully registered with root gRPC server 2021-01-18 08:30:48.271 [DBG] RPCS: WatchtowerClient RPC server successfully registered with root gRPC server 2021-01-18 08:30:48.271 [DBG] RRPC: Router RPC server successfully register with root gRPC server 2021-01-18 08:30:48.272 [DBG] ARPC: Autopilot RPC server successfully register with root gRPC server 2021-01-18 08:30:48.272 [DBG] NTFR: ChainNotifier RPC server successfully register with root gRPC server 2021-01-18 08:30:48.272 [DBG] IRPC: Invoices RPC server successfully registered with root gRPC server 2021-01-18 08:30:48.272 [DBG] WLKT: WalletKit RPC server successfully registered with root gRPC server 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: SignRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: VersionRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: WatchtowerClientRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: RouterRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: AutopilotRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: ChainRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: InvoicesRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: WalletKitRPC 2021-01-18 08:30:48.272 [DBG] RPCS: Starting sub RPC server: WatchtowerRPC 2021-01-18 08:30:48.272 [DBG] SGNR: Signer REST server successfully registered with root REST server 2021-01-18 08:30:48.272 [DBG] VRPC: Versioner REST server successfully registered with root REST server 2021-01-18 08:30:48.272 [DBG] RRPC: Router REST server successfully registered with root REST server 2021-01-18 08:30:48.272 [DBG] ARPC: Autopilot REST server successfully registered with root REST server 2021-01-18 08:30:48.272 [DBG] NTFR: ChainNotifier REST server successfully registered with root REST server 2021-01-18 08:30:48.272 [DBG] IRPC: Invoices REST server successfully registered with root REST server 2021-01-18 08:30:48.272 [DBG] WLKT: WalletKit REST server successfully registered with root REST server 2021-01-18 08:30:48.272 [WRN] HLCK: check: disk space configured with 0 attempts, skipping it 2021-01-18 08:30:48.272 [WRN] HLCK: check: tls configured with 0 attempts, skipping it 2021-01-18 08:30:48.272 [INF] RPCS: RPC server listening on 127.0.0.1:6782 2021-01-18 08:30:48.273 [INF] RPCS: gRPC proxy started at 127.0.0.1:6784 2021-01-18 08:30:48.273 [DBG] HLCK: Monitoring: chain backend 2021-01-18 08:30:48.390 [INF] PRNF: PeerNotifier starting 2021-01-18 08:30:48.398 [INF] HSWC: Starting HTLC Switch 2021-01-18 08:30:48.398 [INF] NTFN: New block epoch subscription 2021-01-18 08:30:48.398 [INF] NTFN: New block epoch subscription 2021-01-18 08:30:48.398 [INF] NTFN: New block epoch subscription 2021-01-18 08:30:48.399 [INF] NTFN: New block epoch subscription 2021-01-18 08:30:48.399 [INF] NTFN: New block epoch subscription 2021-01-18 08:30:48.400 [INF] DISC: Authenticated Gossiper is starting 2021-01-18 08:30:48.400 [INF] BRAR: Starting contract observer, watching for breaches. 2021-01-18 08:30:48.400 [INF] NTFN: New block epoch subscription 2021-01-18 08:30:48.400 [DBG] DISC: New block: height=943, hash=54ccf928411dfc4a3d60ef2487c8b5bd32cde344640e210bd77f196058be41ae 2021-01-18 08:30:48.402 [INF] CRTR: FilteredChainView starting 2021-01-18 08:30:48.469 [INF] CRTR: Filtering chain using 0 channels active 2021-01-18 08:30:48.469 [INF] CRTR: Prune tip for Channel Graph: height=943, hash=54ccf928411dfc4a3d60ef2487c8b5bd32cde344640e210bd77f196058be41ae 2021-01-18 08:30:48.470 [DBG] CRTR: Cleaning network result store. 2021-01-18 08:30:48.471 [DBG] INVC: Adding 0 pending invoices to the expiry watcher 2021-01-18 08:30:48.471 [WRN] INVC: Deleting old invoices failed: there are no existing invoices 2021-01-18 08:30:48.471 [INF] CHFT: Adding 0 channels to event store 2021-01-18 08:30:48.471 [INF] CHBU: Starting chanbackup.SubSwapper 2021-01-18 08:30:48.660 [DBG] CRTR: New graph topology client subscription, client 1 2021-01-18 08:30:48.822 [INF] LNWL: Done catching up block hashes 2021-01-18 08:30:48.822 [INF] LNWL: Finished rescan for 0 addresses (synced to block 54ccf928411dfc4a3d60ef2487c8b5bd32cde344640e210bd77f196058be41ae, height 943) 2021-01-18 08:30:48.825 [INF] CHBU: Updating backup file at /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:48.826 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:48.827 [INF] BTCN: Server listening on 127.0.0.1:6781 2021-01-18 08:30:48.827 [DBG] CHBU: SubSwapper's backupUpdater is active! 2021-01-18 08:30:48.827 [INF] SRVR: Auto peer bootstrapping is disabled 2021-01-18 08:30:49.660 [DBG] CRTR: New graph topology client subscription, client 2 2021-01-18 08:30:49.702 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qftq9rnrqfxmf7ec69d2wrc26p94n07sp6xuevu 2021-01-18 08:30:49.706 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qdsa8lycjavtnps7767ulmx0t3jwkqfrhgcemcp 2021-01-18 08:30:49.709 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qsyg5jy6fen40vpw27564vzhk6d79kr87r54fhx 2021-01-18 08:30:49.712 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qysckv7g6u8rpapw47xzlywm2ks22z7eep62acy 2021-01-18 08:30:49.717 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1q3gffak8x7u08e8wmgf3njeyxd5667etvtp693m 2021-01-18 08:30:49.720 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1q3ps96qmgvwp9zvxa7grlp532cdlx0qxwccj2hz 2021-01-18 08:30:49.723 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qtssuqulwt562t06t829270mtt99ew2gd7l4lsa 2021-01-18 08:30:49.726 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qujqf39407wc2g9v4j9e9wzdyqrpsv94p9deydu 2021-01-18 08:30:49.730 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1qzjrxyrtxp3mnsgcfcyrrk5xw4pvxv0stlqg4kd 2021-01-18 08:30:49.733 [DBG] RPCS: [newaddress] type=WITNESS_PUBKEY_HASH addr=bcrt1q7faj7fv5p52yzrshr0y636y7lxlarqzhgca3m4 2021-01-18 08:30:49.751 [INF] LNWL: Inserting unconfirmed transaction 8daeb7dc06ce692827998de912dc298a836f8f0e520d6f2978eb21ddfab7b690 2021-01-18 08:30:49.751 [DBG] LNWL: Marked address bcrt1qftq9rnrqfxmf7ec69d2wrc26p94n07sp6xuevu used 2021-01-18 08:30:49.753 [INF] LNWL: Inserting unconfirmed transaction 553c28709e446501ad2373fecafae5e0397416c2c87fa596e59f088d8e460a12 2021-01-18 08:30:49.753 [DBG] LNWL: Marked address bcrt1qdsa8lycjavtnps7767ulmx0t3jwkqfrhgcemcp used 2021-01-18 08:30:49.754 [INF] LNWL: Inserting unconfirmed transaction 57393c4b3d1f1f614f4ffc128ef164123379228a8624bf8117512a1173534c29 2021-01-18 08:30:49.754 [DBG] LNWL: Marked address bcrt1qsyg5jy6fen40vpw27564vzhk6d79kr87r54fhx used 2021-01-18 08:30:49.755 [INF] LNWL: Inserting unconfirmed transaction 6eff18d0e1507f88eb149d619401227adba09699b56cba356f29ae994ebf7d11 2021-01-18 08:30:49.755 [DBG] LNWL: Marked address bcrt1qysckv7g6u8rpapw47xzlywm2ks22z7eep62acy used 2021-01-18 08:30:49.757 [INF] LNWL: Inserting unconfirmed transaction 6f36660369c209c1215d02b85ee761263564b77da959f9066f71ad483f4ca4b8 2021-01-18 08:30:49.757 [DBG] LNWL: Marked address bcrt1q3gffak8x7u08e8wmgf3njeyxd5667etvtp693m used 2021-01-18 08:30:49.759 [INF] LNWL: Inserting unconfirmed transaction 4dc6a84843d8ad9457edf6f6e25f1b1fe2d8d7e8a8f34fcd5b85108247dd5ca8 2021-01-18 08:30:49.759 [DBG] LNWL: Marked address bcrt1q3ps96qmgvwp9zvxa7grlp532cdlx0qxwccj2hz used 2021-01-18 08:30:49.761 [INF] LNWL: Inserting unconfirmed transaction 471fbcb422abe5044dfb9b22ae88139f6450ae65166dba06ec442ff1cdbbb7e7 2021-01-18 08:30:49.761 [DBG] LNWL: Marked address bcrt1qtssuqulwt562t06t829270mtt99ew2gd7l4lsa used 2021-01-18 08:30:49.762 [INF] LNWL: Inserting unconfirmed transaction d3a51dc225599849cf6899cd76c076284c8624cbcf952847b41a4c41f0475023 2021-01-18 08:30:49.762 [DBG] LNWL: Marked address bcrt1qujqf39407wc2g9v4j9e9wzdyqrpsv94p9deydu used 2021-01-18 08:30:49.763 [INF] LNWL: Inserting unconfirmed transaction 7edc31b3ad7c064601709964506a80e79c17f6497b6c9ccfce67de46635c84e5 2021-01-18 08:30:49.763 [DBG] LNWL: Marked address bcrt1qzjrxyrtxp3mnsgcfcyrrk5xw4pvxv0stlqg4kd used 2021-01-18 08:30:49.767 [INF] LNWL: Inserting unconfirmed transaction 1844338ea59e26e46e42ccaef7909106f437647eadbec939b91dd1890f9cec00 2021-01-18 08:30:49.767 [DBG] LNWL: Marked address bcrt1q7faj7fv5p52yzrshr0y636y7lxlarqzhgca3m4 used 2021-01-18 08:30:49.782 [INF] LNWL: Marking unconfirmed transaction 7edc31b3ad7c064601709964506a80e79c17f6497b6c9ccfce67de46635c84e5 mined in block 944 2021-01-18 08:30:49.782 [DBG] LNWL: Marked address bcrt1qzjrxyrtxp3mnsgcfcyrrk5xw4pvxv0stlqg4kd used 2021-01-18 08:30:49.783 [INF] LNWL: Marking unconfirmed transaction 471fbcb422abe5044dfb9b22ae88139f6450ae65166dba06ec442ff1cdbbb7e7 mined in block 944 2021-01-18 08:30:49.784 [DBG] LNWL: Marked address bcrt1qtssuqulwt562t06t829270mtt99ew2gd7l4lsa used 2021-01-18 08:30:49.785 [INF] LNWL: Marking unconfirmed transaction 6f36660369c209c1215d02b85ee761263564b77da959f9066f71ad483f4ca4b8 mined in block 944 2021-01-18 08:30:49.785 [DBG] LNWL: Marked address bcrt1q3gffak8x7u08e8wmgf3njeyxd5667etvtp693m used 2021-01-18 08:30:49.786 [INF] LNWL: Marking unconfirmed transaction d3a51dc225599849cf6899cd76c076284c8624cbcf952847b41a4c41f0475023 mined in block 944 2021-01-18 08:30:49.786 [INF] CRTR: Pruning channel graph using block 272256767c847bf1a253ffc935cf0829812d1cf2f7c290f17f8611d9416a4d86 (height=944) 2021-01-18 08:30:49.786 [DBG] LNWL: Marked address bcrt1qujqf39407wc2g9v4j9e9wzdyqrpsv94p9deydu used 2021-01-18 08:30:49.788 [INF] LNWL: Marking unconfirmed transaction 57393c4b3d1f1f614f4ffc128ef164123379228a8624bf8117512a1173534c29 mined in block 944 2021-01-18 08:30:49.788 [INF] CRTR: Block 272256767c847bf1a253ffc935cf0829812d1cf2f7c290f17f8611d9416a4d86 (height=944) closed 0 channels 2021-01-18 08:30:49.788 [DBG] LNWL: Marked address bcrt1qsyg5jy6fen40vpw27564vzhk6d79kr87r54fhx used 2021-01-18 08:30:49.791 [INF] LNWL: Marking unconfirmed transaction 553c28709e446501ad2373fecafae5e0397416c2c87fa596e59f088d8e460a12 mined in block 944 2021-01-18 08:30:49.791 [INF] CRTR: Pruning channel graph using block 74bc6d7c977f921a6bc9fd24bc43608e69a3ce554ce24a41a5bfd281b5d15926 (height=945) 2021-01-18 08:30:49.791 [DBG] LNWL: Marked address bcrt1qdsa8lycjavtnps7767ulmx0t3jwkqfrhgcemcp used 2021-01-18 08:30:49.792 [DBG] NTFN: Filtering 21 txns for 0 spend requests at height 944 2021-01-18 08:30:49.792 [INF] NTFN: New block: height=944, sha=272256767c847bf1a253ffc935cf0829812d1cf2f7c290f17f8611d9416a4d86 2021-01-18 08:30:49.792 [DBG] DISC: New block: height=944, hash=272256767c847bf1a253ffc935cf0829812d1cf2f7c290f17f8611d9416a4d86 2021-01-18 08:30:49.792 [DBG] SWPR: New block: height=944, sha=272256767c847bf1a253ffc935cf0829812d1cf2f7c290f17f8611d9416a4d86 2021-01-18 08:30:49.792 [INF] UTXN: Attempting to graduate height=944: num_kids=0, num_babies=0 2021-01-18 08:30:49.792 [INF] LNWL: Marking unconfirmed transaction 8daeb7dc06ce692827998de912dc298a836f8f0e520d6f2978eb21ddfab7b690 mined in block 944 2021-01-18 08:30:49.793 [INF] CRTR: Block 74bc6d7c977f921a6bc9fd24bc43608e69a3ce554ce24a41a5bfd281b5d15926 (height=945) closed 0 channels 2021-01-18 08:30:49.793 [INF] CRTR: Pruning channel graph using block 681912f84215bcd48639fb4ac05a67f3021a83e7286f81b57e84f8a4279c100d (height=946) 2021-01-18 08:30:49.793 [DBG] LNWL: Marked address bcrt1qftq9rnrqfxmf7ec69d2wrc26p94n07sp6xuevu used 2021-01-18 08:30:49.794 [INF] CRTR: Block 681912f84215bcd48639fb4ac05a67f3021a83e7286f81b57e84f8a4279c100d (height=946) closed 0 channels 2021-01-18 08:30:49.794 [INF] LNWL: Marking unconfirmed transaction 4dc6a84843d8ad9457edf6f6e25f1b1fe2d8d7e8a8f34fcd5b85108247dd5ca8 mined in block 944 2021-01-18 08:30:49.794 [DBG] LNWL: Marked address bcrt1q3ps96qmgvwp9zvxa7grlp532cdlx0qxwccj2hz used 2021-01-18 08:30:49.795 [INF] CRTR: Pruning channel graph using block 02f2457294b917e878473285f0abf675c01a47be76ff2c91bf8aa4c487dfaafc (height=947) 2021-01-18 08:30:49.796 [INF] LNWL: Marking unconfirmed transaction 6eff18d0e1507f88eb149d619401227adba09699b56cba356f29ae994ebf7d11 mined in block 944 2021-01-18 08:30:49.796 [DBG] LNWL: Marked address bcrt1qysckv7g6u8rpapw47xzlywm2ks22z7eep62acy used 2021-01-18 08:30:49.797 [INF] LNWL: Marking unconfirmed transaction 1844338ea59e26e46e42ccaef7909106f437647eadbec939b91dd1890f9cec00 mined in block 944 2021-01-18 08:30:49.797 [DBG] LNWL: Marked address bcrt1q7faj7fv5p52yzrshr0y636y7lxlarqzhgca3m4 used 2021-01-18 08:30:49.798 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 945 2021-01-18 08:30:49.798 [INF] NTFN: New block: height=945, sha=74bc6d7c977f921a6bc9fd24bc43608e69a3ce554ce24a41a5bfd281b5d15926 2021-01-18 08:30:49.798 [DBG] SWPR: New block: height=945, sha=74bc6d7c977f921a6bc9fd24bc43608e69a3ce554ce24a41a5bfd281b5d15926 2021-01-18 08:30:49.798 [INF] UTXN: Attempting to graduate height=945: num_kids=0, num_babies=0 2021-01-18 08:30:49.798 [DBG] DISC: New block: height=945, hash=74bc6d7c977f921a6bc9fd24bc43608e69a3ce554ce24a41a5bfd281b5d15926 2021-01-18 08:30:49.798 [INF] SRVR: New inbound connection from 127.0.0.1:53336 2021-01-18 08:30:49.798 [INF] SRVR: Finalizing connection to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336, inbound=true 2021-01-18 08:30:49.798 [DBG] PRNF: PeerNotifier notifying peer: 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76 online 2021-01-18 08:30:49.798 [DBG] PEER: Sending Init to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.799 [INF] CRTR: Block 02f2457294b917e878473285f0abf675c01a47be76ff2c91bf8aa4c487dfaafc (height=947) closed 0 channels 2021-01-18 08:30:49.799 [INF] CRTR: Pruning channel graph using block 4ac0e234621c438dd40496c3ffb449efe1c61cd254834802719186b74c5bb8e5 (height=948) 2021-01-18 08:30:49.800 [DBG] PEER: Received Init from 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.800 [DBG] PEER: Loaded 0 active channels from database with NodeKey(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76) 2021-01-18 08:30:49.800 [DBG] SRVR: Notifying that peer 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 is online 2021-01-18 08:30:49.800 [INF] PEER: Negotiated chan series queries with 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76 2021-01-18 08:30:49.800 [INF] DISC: Creating new GossipSyncer for peer=03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76 2021-01-18 08:30:49.800 [DBG] DISC: Starting GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76) 2021-01-18 08:30:49.800 [DBG] DISC: Attempting initial historical sync with GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76) 2021-01-18 08:30:49.800 [DBG] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): state=chansSynced, type=PassiveSync 2021-01-18 08:30:49.801 [DBG] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): state=syncingChans, type=PassiveSync 2021-01-18 08:30:49.801 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): requesting new chans from height=0 and 945 blocks after 2021-01-18 08:30:49.801 [DBG] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): state=waitingQueryRangeReply, type=PassiveSync 2021-01-18 08:30:49.802 [DBG] PEER: Received QueryChannelRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, start_height=0, end_height=944) from 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.802 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): filtering chan range: start_height=0, num_blocks=945 2021-01-18 08:30:49.802 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): sending final chan range chunk, size=0 2021-01-18 08:30:49.802 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 946 2021-01-18 08:30:49.802 [INF] NTFN: New block: height=946, sha=681912f84215bcd48639fb4ac05a67f3021a83e7286f81b57e84f8a4279c100d 2021-01-18 08:30:49.802 [DBG] SWPR: New block: height=946, sha=681912f84215bcd48639fb4ac05a67f3021a83e7286f81b57e84f8a4279c100d 2021-01-18 08:30:49.802 [INF] UTXN: Attempting to graduate height=946: num_kids=0, num_babies=0 2021-01-18 08:30:49.802 [DBG] DISC: New block: height=946, hash=681912f84215bcd48639fb4ac05a67f3021a83e7286f81b57e84f8a4279c100d 2021-01-18 08:30:49.802 [DBG] PEER: Sending QueryChannelRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, start_height=0, end_height=944) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.802 [DBG] PEER: Sending ReplyChannelRange(start_height=0, end_height=944, num_chans=0, encoding=0) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.804 [INF] CRTR: Block 4ac0e234621c438dd40496c3ffb449efe1c61cd254834802719186b74c5bb8e5 (height=948) closed 0 channels 2021-01-18 08:30:49.804 [INF] CRTR: Pruning channel graph using block 0bb1ccd2da8a29ab3b3d5a11ce7d0d1b4fe22703d9e8d603c8401555994deb13 (height=949) 2021-01-18 08:30:49.804 [DBG] PEER: Received ReplyChannelRange(start_height=0, end_height=944, num_chans=0, encoding=0) from 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.804 [DBG] PEER: Received GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2021-01-18 08:30:49 +0000 UTC, stamp_range=4294967295) from 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.804 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): buffering chan range reply of size=0 2021-01-18 08:30:49.804 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): filtering through 0 chans 2021-01-18 08:30:49.805 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): remote peer has no new chans 2021-01-18 08:30:49.805 [DBG] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): state=chansSynced, type=PassiveSync 2021-01-18 08:30:49.805 [DBG] DISC: Initial historical sync completed 2021-01-18 08:30:49.805 [DBG] DISC: Attempting to transition 3 passive GossipSyncers to active 2021-01-18 08:30:49.805 [DBG] DISC: Transitioning passive GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76) to active 2021-01-18 08:30:49.805 [DBG] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): transitioning from PassiveSync to ActiveSync 2021-01-18 08:30:49.805 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): applying gossipFilter(start=2021-01-18 08:30:49.805074942 +0000 UTC m=+1.748049928, end=2157-02-24 14:59:04.805074942 +0000 UTC m=+4294967296.748049928) 2021-01-18 08:30:49.805 [DBG] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): state=chansSynced, type=ActiveSync 2021-01-18 08:30:49.805 [DBG] PEER: Sending GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2021-01-18 08:30:49 +0000 UTC, stamp_range=4294967295) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:49.805 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 947 2021-01-18 08:30:49.805 [INF] NTFN: New block: height=947, sha=02f2457294b917e878473285f0abf675c01a47be76ff2c91bf8aa4c487dfaafc 2021-01-18 08:30:49.805 [DBG] DISC: New block: height=947, hash=02f2457294b917e878473285f0abf675c01a47be76ff2c91bf8aa4c487dfaafc 2021-01-18 08:30:49.805 [DBG] SWPR: New block: height=947, sha=02f2457294b917e878473285f0abf675c01a47be76ff2c91bf8aa4c487dfaafc 2021-01-18 08:30:49.805 [INF] UTXN: Attempting to graduate height=947: num_kids=0, num_babies=0 2021-01-18 08:30:49.806 [INF] CRTR: Block 0bb1ccd2da8a29ab3b3d5a11ce7d0d1b4fe22703d9e8d603c8401555994deb13 (height=949) closed 0 channels 2021-01-18 08:30:49.806 [INF] CRTR: Pruning channel graph using block 5b23535940c7d214d890a897363a983ad7f2a2594a792b9c9816adad2982b601 (height=950) 2021-01-18 08:30:49.806 [DBG] CHDB: ChanUpdatesInHorizon hit percentage: NaN (0/0) 2021-01-18 08:30:49.806 [INF] DISC: GossipSyncer(03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76): applying new update horizon: start=2021-01-18 08:30:49 +0000 UTC, end=2157-02-24 14:59:04 +0000 UTC, backlog_size=0 2021-01-18 08:30:49.807 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 948 2021-01-18 08:30:49.807 [INF] NTFN: New block: height=948, sha=4ac0e234621c438dd40496c3ffb449efe1c61cd254834802719186b74c5bb8e5 2021-01-18 08:30:49.807 [DBG] SWPR: New block: height=948, sha=4ac0e234621c438dd40496c3ffb449efe1c61cd254834802719186b74c5bb8e5 2021-01-18 08:30:49.807 [DBG] DISC: New block: height=948, hash=4ac0e234621c438dd40496c3ffb449efe1c61cd254834802719186b74c5bb8e5 2021-01-18 08:30:49.807 [INF] UTXN: Attempting to graduate height=948: num_kids=0, num_babies=0 2021-01-18 08:30:49.808 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 949 2021-01-18 08:30:49.808 [INF] NTFN: New block: height=949, sha=0bb1ccd2da8a29ab3b3d5a11ce7d0d1b4fe22703d9e8d603c8401555994deb13 2021-01-18 08:30:49.808 [DBG] SWPR: New block: height=949, sha=0bb1ccd2da8a29ab3b3d5a11ce7d0d1b4fe22703d9e8d603c8401555994deb13 2021-01-18 08:30:49.808 [INF] UTXN: Attempting to graduate height=949: num_kids=0, num_babies=0 2021-01-18 08:30:49.808 [DBG] DISC: New block: height=949, hash=0bb1ccd2da8a29ab3b3d5a11ce7d0d1b4fe22703d9e8d603c8401555994deb13 2021-01-18 08:30:49.809 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 950 2021-01-18 08:30:49.809 [INF] NTFN: New block: height=950, sha=5b23535940c7d214d890a897363a983ad7f2a2594a792b9c9816adad2982b601 2021-01-18 08:30:49.809 [DBG] DISC: New block: height=950, hash=5b23535940c7d214d890a897363a983ad7f2a2594a792b9c9816adad2982b601 2021-01-18 08:30:49.809 [DBG] SWPR: New block: height=950, sha=5b23535940c7d214d890a897363a983ad7f2a2594a792b9c9816adad2982b601 2021-01-18 08:30:49.809 [INF] UTXN: Attempting to graduate height=950: num_kids=0, num_babies=0 2021-01-18 08:30:49.809 [INF] CRTR: Block 5b23535940c7d214d890a897363a983ad7f2a2594a792b9c9816adad2982b601 (height=950) closed 0 channels 2021-01-18 08:30:49.809 [INF] CRTR: Pruning channel graph using block 1a66dd9ddfc920b06f2669bfcc619048528ec7c7403895678d6f0e9f8f61e5f7 (height=951) 2021-01-18 08:30:49.810 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 951 2021-01-18 08:30:49.810 [INF] NTFN: New block: height=951, sha=1a66dd9ddfc920b06f2669bfcc619048528ec7c7403895678d6f0e9f8f61e5f7 2021-01-18 08:30:49.810 [DBG] SWPR: New block: height=951, sha=1a66dd9ddfc920b06f2669bfcc619048528ec7c7403895678d6f0e9f8f61e5f7 2021-01-18 08:30:49.810 [INF] UTXN: Attempting to graduate height=951: num_kids=0, num_babies=0 2021-01-18 08:30:49.810 [DBG] DISC: New block: height=951, hash=1a66dd9ddfc920b06f2669bfcc619048528ec7c7403895678d6f0e9f8f61e5f7 2021-01-18 08:30:49.810 [INF] CRTR: Block 1a66dd9ddfc920b06f2669bfcc619048528ec7c7403895678d6f0e9f8f61e5f7 (height=951) closed 0 channels 2021-01-18 08:30:49.810 [INF] CRTR: Pruning channel graph using block 6bcd5ae5cdc3f43f24fbff0fed2d6912536b2fb580823942d7ff2b1a0ff2b3e6 (height=952) 2021-01-18 08:30:49.810 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 952 2021-01-18 08:30:49.810 [INF] NTFN: New block: height=952, sha=6bcd5ae5cdc3f43f24fbff0fed2d6912536b2fb580823942d7ff2b1a0ff2b3e6 2021-01-18 08:30:49.810 [DBG] SWPR: New block: height=952, sha=6bcd5ae5cdc3f43f24fbff0fed2d6912536b2fb580823942d7ff2b1a0ff2b3e6 2021-01-18 08:30:49.810 [INF] UTXN: Attempting to graduate height=952: num_kids=0, num_babies=0 2021-01-18 08:30:49.810 [DBG] DISC: New block: height=952, hash=6bcd5ae5cdc3f43f24fbff0fed2d6912536b2fb580823942d7ff2b1a0ff2b3e6 2021-01-18 08:30:49.811 [DBG] NTFN: Filtering 1 txns for 0 spend requests at height 953 2021-01-18 08:30:49.811 [INF] NTFN: New block: height=953, sha=52a248fca190db4d7793cf0127d9513bc59fa487d3ea1ed8e07afa9dde5ca7c4 2021-01-18 08:30:49.811 [DBG] SWPR: New block: height=953, sha=52a248fca190db4d7793cf0127d9513bc59fa487d3ea1ed8e07afa9dde5ca7c4 2021-01-18 08:30:49.811 [INF] UTXN: Attempting to graduate height=953: num_kids=0, num_babies=0 2021-01-18 08:30:49.811 [DBG] DISC: New block: height=953, hash=52a248fca190db4d7793cf0127d9513bc59fa487d3ea1ed8e07afa9dde5ca7c4 2021-01-18 08:30:49.811 [INF] CRTR: Block 6bcd5ae5cdc3f43f24fbff0fed2d6912536b2fb580823942d7ff2b1a0ff2b3e6 (height=952) closed 0 channels 2021-01-18 08:30:49.811 [INF] CRTR: Pruning channel graph using block 52a248fca190db4d7793cf0127d9513bc59fa487d3ea1ed8e07afa9dde5ca7c4 (height=953) 2021-01-18 08:30:49.813 [INF] CRTR: Block 52a248fca190db4d7793cf0127d9513bc59fa487d3ea1ed8e07afa9dde5ca7c4 (height=953) closed 0 channels 2021-01-18 08:30:50.202 [DBG] RPCS: [walletbalance] Total balance=10 BTC (confirmed=10 BTC, unconfirmed=0 BTC) 2021-01-18 08:30:50.605 [DBG] RPCS: [connectpeer] requested connection to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:6783 2021-01-18 08:30:50.605 [ERR] RPCS: [connectpeer]: error connecting to peer: already connected to peer: 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:50.605 [ERR] RPCS: [/lnrpc.Lightning/ConnectPeer]: already connected to peer: 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 STARTING ============ node announcement ============ 2021-01-18 08:30:52.212 [DBG] RPCS: [connectpeer] requested connection to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.212 [DBG] SRVR: Connecting to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.216 [INF] SRVR: Established connection to: 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.216 [INF] SRVR: Finalizing connection to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789, inbound=false 2021-01-18 08:30:52.216 [DBG] PRNF: PeerNotifier notifying peer: 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef online 2021-01-18 08:30:52.216 [DBG] RPCS: Connected to peer: 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.217 [DBG] PEER: Sending Init to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.217 [DBG] PEER: Received Init from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.217 [DBG] PEER: Loaded 0 active channels from database with NodeKey(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef) 2021-01-18 08:30:52.217 [DBG] SRVR: Notifying that peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 is online 2021-01-18 08:30:52.217 [INF] PEER: Negotiated chan series queries with 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:52.217 [INF] DISC: Creating new GossipSyncer for peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:52.217 [DBG] DISC: Starting GossipSyncer(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef) 2021-01-18 08:30:52.217 [DBG] DISC: GossipSyncer(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef): state=chansSynced, type=ActiveSync 2021-01-18 08:30:52.217 [INF] DISC: GossipSyncer(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef): applying gossipFilter(start=2021-01-18 08:30:52.217802178 +0000 UTC m=+4.160777164, end=2157-02-24 14:59:07.217802178 +0000 UTC m=+4294967299.160777164) 2021-01-18 08:30:52.217 [DBG] PEER: Sending GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2021-01-18 08:30:52 +0000 UTC, stamp_range=4294967295) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.218 [DBG] PEER: Received QueryChannelRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, start_height=0, end_height=952) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.218 [INF] DISC: GossipSyncer(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef): filtering chan range: start_height=0, num_blocks=953 2021-01-18 08:30:52.218 [INF] DISC: GossipSyncer(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef): sending final chan range chunk, size=0 2021-01-18 08:30:52.218 [DBG] PEER: Sending ReplyChannelRange(start_height=0, end_height=952, num_chans=0, encoding=0) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.218 [DBG] PEER: Received GossipTimestampRange(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, first_stamp=2021-01-18 08:30:52 +0000 UTC, stamp_range=4294967295) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:52.218 [DBG] CHDB: ChanUpdatesInHorizon hit percentage: NaN (0/0) 2021-01-18 08:30:52.218 [INF] DISC: GossipSyncer(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef): applying new update horizon: start=2021-01-18 08:30:52 +0000 UTC, end=2157-02-24 14:59:07 +0000 UTC, backlog_size=0 2021-01-18 08:30:52.417 [DBG] RPCS: [listpeers] yielded [030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336] peers 2021-01-18 08:30:53.621 [DBG] RPCS: [openchannel] request to NodeKey(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef) allocation(us=1000000, them=0) 2021-01-18 08:30:53.621 [DBG] LNWL: Web API returning 12500 sat/kw for conf target of 6 2021-01-18 08:30:53.621 [DBG] RPCS: [openchannel]: using fee of 12500 sat/kw for funding tx 2021-01-18 08:30:53.622 [INF] FNDG: Initiating fundingRequest(local_amt=0.01 BTC (subtract_fees=false), push_amt=0 mSAT, chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef, dust_limit=0.00000573 BTC, min_confs=1) 2021-01-18 08:30:53.622 [DBG] LNWL: Web API returning 12500 sat/kw for conf target of 3 2021-01-18 08:30:53.622 [INF] CHFD: Performing funding tx coin selection using 12500 sat/kw as fee rate 2021-01-18 08:30:53.624 [WRN] CHFD: Unable to find funding output for shim intent: unable to create witness script, no funding keys 2021-01-18 08:30:53.638 [INF] FNDG: Target commit tx sat/kw for pendingID(a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa): 12500 2021-01-18 08:30:53.638 [INF] FNDG: Starting funding workflow with 127.0.0.1:6789 for pending_id(a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa), committype=tweakless 2021-01-18 08:30:53.638 [DBG] PEER: Sending MsgOpenChannel(temp_chan_id=a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa, chain=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, csv=4, amt=0.01 BTC, push_amt=0 mSAT, reserve=0.0001 BTC, flags=1) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.651 [DBG] PEER: Received MsgAcceptChannel(temp_chan_id=a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa, reserve=0.0001 BTC, csv=4, num_confs=1) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.651 [INF] FNDG: Recv'd fundingResponse for pending_id(a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa) 2021-01-18 08:30:53.651 [DBG] LNWL: Funding tx for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) generated: (*wire.MsgTx)(0xc000be2fc0)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc00093ede0)({ PreviousOutPoint: (wire.OutPoint) 1844338ea59e26e46e42ccaef7909106f437647eadbec939b91dd1890f9cec00:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) (len=2 cap=2) { ([]uint8) (len=72 cap=144) { 00000000 30 45 02 21 00 a1 f6 20 30 d2 75 e8 70 87 da e4 |0E.!... 0.u.p...| 00000010 db 02 43 22 37 03 c1 a7 0a 08 1a 81 7b 9a 50 41 |..C"7.......{.PA| 00000020 ff df 37 86 75 02 20 52 00 6e 6c e3 04 d5 b1 36 |..7.u. R.nl....6| 00000030 3f cd 36 51 67 11 0d 50 ca e8 e8 69 fb 32 12 55 |?.6Qg..P...i.2.U| 00000040 77 ec 05 95 2b f1 32 01 |w...+.2.| }, ([]uint8) (len=33 cap=33) { 00000000 02 1f c8 99 6d b3 73 40 2b 27 a3 e8 67 60 5f 49 |....m.s@+'..g`_I| 00000010 59 f8 bf 49 00 70 9b 38 5a c7 c7 39 50 7f f9 cc |Y..I.p.8Z..9P...| 00000020 42 |B| } }, Sequence: (uint32) 0 }) }, TxOut: ([]*wire.TxOut) (len=2 cap=15) { (*wire.TxOut)(0xc0011bffa0)({ Value: (int64) 1000000, PkScript: ([]uint8) (len=34 cap=500) { 00000000 00 20 e2 0f 1d c0 7b a0 c7 0c 97 ca e3 f4 80 89 |. ....{.........| 00000010 db 0b dc 58 7c e0 93 b9 47 2a 09 b0 f4 66 8c f9 |...X|...G*...f..| 00000020 65 6d |em| } }), (*wire.TxOut)(0xc000c24b60)({ Value: (int64) 98992363, PkScript: ([]uint8) (len=22 cap=500) { 00000000 00 14 e0 7f 42 e7 0d f0 16 52 1f 01 ba 0d 32 13 |....B....R....2.| 00000010 8a 3b 18 00 cc f7 |.;....| } }) }, LockTime: (uint32) 0 }) 2021-01-18 08:30:53.653 [DBG] LNWL: Local commit tx for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): (*wire.MsgTx)(0xc000be33c0)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc00093f200)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=15) { (*wire.TxOut)(0xc000c948e0)({ Value: (int64) 990950, PkScript: ([]uint8) (len=34 cap=500) { 00000000 00 20 2c 50 cb 38 a4 f3 95 ec 80 c9 e1 34 f5 ac |. ,P.8.......4..| 00000010 89 df f9 d0 e8 9a ef 28 05 83 bd c9 87 d1 7f b7 |.......(........| 00000020 2c ae |,.| } }) }, LockTime: (uint32) 550156200 }) 2021-01-18 08:30:53.653 [DBG] LNWL: Remote commit tx for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): (*wire.MsgTx)(0xc000be3400)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc00093f260)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=15) { (*wire.TxOut)(0xc000c94900)({ Value: (int64) 990950, PkScript: ([]uint8) (len=22 cap=500) { 00000000 00 14 16 0d 57 30 e3 12 8a 9e 32 94 0d 31 2e df |....W0....2..1..| 00000010 ca 91 15 8b 5f 84 |...._.| } }) }, LockTime: (uint32) 550156200 }) 2021-01-18 08:30:53.653 [INF] FNDG: pendingChan(a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa): remote party proposes num_confs=1, csv_delay=4 2021-01-18 08:30:53.653 [DBG] FNDG: Remote party accepted commitment constraints: (channeldb.ChannelConstraints) { DustLimit: (btcutil.Amount) 0.00000573 BTC, ChanReserve: (btcutil.Amount) 0.0001 BTC, MaxPendingAmount: (lnwire.MilliSatoshi) 990000000 mSAT, MinHTLC: (lnwire.MilliSatoshi) 1 mSAT, MaxAcceptedHtlcs: (uint16) 483, CsvDelay: (uint16) 4 } 2021-01-18 08:30:53.653 [DBG] FNDG: Creating chan barrier for ChanID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) 2021-01-18 08:30:53.653 [INF] FNDG: Generated ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) for pending_id(a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa) 2021-01-18 08:30:53.653 [DBG] PEER: Sending MsgFundingCreated(temp_chan_id=a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa, chan_point=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.657 [DBG] PEER: Received MsgFundingSigned(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.660 [INF] FNDG: Broadcasting funding tx for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): 0200000000010100ec9c0f89d11db939c9bead7e6437f4069190f7aecc426ee4269ea58e3344180000000000000000000240420f0000000000220020e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656deb80e60500000000160014e07f42e70df016521f01ba0d32138a3b1800ccf702483045022100a1f62030d275e87087dae4db0243223703c1a70a081a817b9a5041ffdf378675022052006e6ce304d5b1363fcd365167110d50cae8e869fb32125577ec05952bf1320121021fc8996db373402b27a3e867605f4959f8bf4900709b385ac7c739507ff9cc4200000000 2021-01-18 08:30:53.660 [INF] LNWL: Inserting unconfirmed transaction b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 2021-01-18 08:30:53.660 [DBG] LNWL: Marked address bcrt1qupl59ecd7qt9y8cphgxnyyu28vvqpn8hg3pu0n used 2021-01-18 08:30:53.663 [INF] CNCT: Creating new ChannelArbitrator for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) 2021-01-18 08:30:53.663 [DBG] CNCT: New ChainEventSubscription(id=0) for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) 2021-01-18 08:30:53.663 [DBG] CNCT: Starting ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3: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) { } } } 2021-01-18 08:30:53.663 [DBG] LNWL: Marked address bcrt1qupl59ecd7qt9y8cphgxnyyu28vvqpn8hg3pu0n used 2021-01-18 08:30:53.664 [INF] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): starting state=StateDefault, trigger=chainTrigger, triggerHeight=953 2021-01-18 08:30:53.664 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=953) examining active HTLC's 2021-01-18 08:30:53.664 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=953, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:53.664 [DBG] CNCT: Starting chain watcher for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) 2021-01-18 08:30:53.664 [INF] NTFN: New spend subscription: spend_id=1, outpoint=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, script=0 e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656d, height_hint=953 2021-01-18 08:30:53.664 [INF] NTFN: Dispatching historical spend rescan for outpoint=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, script=0 e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656d, start=953, end=953 2021-01-18 08:30:53.665 [DBG] LNWL: Marked address bcrt1qupl59ecd7qt9y8cphgxnyyu28vvqpn8hg3pu0n used 2021-01-18 08:30:53.675 [DBG] NTFN: Updated spend hint to height=953 for unconfirmed spend request outpoint=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, script=0 e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656d 2021-01-18 08:30:53.675 [INF] FNDG: Finalizing pending_id(a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa) over ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0), waiting for channel open on-chain 2021-01-18 08:30:53.675 [INF] NTFN: New confirmation subscription: conf_id=1, txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3, num_confs=1 height_hint=953 2021-01-18 08:30:53.675 [DBG] NTFN: Dispatching historical confirmation rescan for txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 2021-01-18 08:30:53.675 [INF] FNDG: Waiting for funding tx (b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3) to reach 1 confirmations 2021-01-18 08:30:53.675 [INF] CNCT: Close observer for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) active 2021-01-18 08:30:53.675 [DBG] CHBU: Adding channel b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0 to backup state 2021-01-18 08:30:53.676 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=0, num_new_chans=1 2021-01-18 08:30:53.676 [DBG] NTFN: Confirmation details for txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 not found during historical dispatch, waiting to dispatch at tip 2021-01-18 08:30:53.678 [INF] CHBU: Updating backup file at /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:53.679 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:53.782 [INF] CRTR: Pruning channel graph using block 2e250f468935e65e2c4efd92be958cf262b1009915c17bea506ebaf1954eaac5 (height=954) 2021-01-18 08:30:53.787 [INF] LNWL: Marking unconfirmed transaction b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 mined in block 954 2021-01-18 08:30:53.788 [INF] CRTR: Block 2e250f468935e65e2c4efd92be958cf262b1009915c17bea506ebaf1954eaac5 (height=954) closed 0 channels 2021-01-18 08:30:53.790 [INF] CRTR: Pruning channel graph using block 3bbb4c50d84af2ac086034a98e82a4a458e9d08a0e25924556b374809813b486 (height=955) 2021-01-18 08:30:53.789 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 954 2021-01-18 08:30:53.791 [DBG] NTFN: Found initial confirmation of txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3: height=954, hash=2e250f468935e65e2c4efd92be958cf262b1009915c17bea506ebaf1954eaac5 2021-01-18 08:30:53.791 [DBG] LNWL: Marked address bcrt1qupl59ecd7qt9y8cphgxnyyu28vvqpn8hg3pu0n used 2021-01-18 08:30:53.792 [INF] CRTR: Block 3bbb4c50d84af2ac086034a98e82a4a458e9d08a0e25924556b374809813b486 (height=955) closed 0 channels 2021-01-18 08:30:53.792 [INF] CRTR: Pruning channel graph using block 35a171e14c2de68d40de6e514f56c86b05fa6b0b7039e8782d98753c79745acf (height=956) 2021-01-18 08:30:53.793 [DBG] LNWL: Marked address bcrt1qupl59ecd7qt9y8cphgxnyyu28vvqpn8hg3pu0n used 2021-01-18 08:30:53.793 [INF] CRTR: Block 35a171e14c2de68d40de6e514f56c86b05fa6b0b7039e8782d98753c79745acf (height=956) closed 0 channels 2021-01-18 08:30:53.793 [INF] CRTR: Pruning channel graph using block 11542e95f27e6d6557d50ac04051395c91ad18797bf8dc99f6f5876481bd2ae9 (height=957) 2021-01-18 08:30:53.794 [INF] CRTR: Block 11542e95f27e6d6557d50ac04051395c91ad18797bf8dc99f6f5876481bd2ae9 (height=957) closed 0 channels 2021-01-18 08:30:53.794 [INF] CRTR: Pruning channel graph using block 6153ea5587c75f470886745e463f8d2db462e92e05c964b6f915e859a3d146f3 (height=958) 2021-01-18 08:30:53.795 [INF] CRTR: Block 6153ea5587c75f470886745e463f8d2db462e92e05c964b6f915e859a3d146f3 (height=958) closed 0 channels 2021-01-18 08:30:53.795 [INF] CRTR: Pruning channel graph using block 24d7526baa30543cbfe5724e5bdc5cae0588035a7e299cee5adccfce726d32bb (height=959) 2021-01-18 08:30:53.796 [INF] CRTR: Block 24d7526baa30543cbfe5724e5bdc5cae0588035a7e299cee5adccfce726d32bb (height=959) closed 0 channels 2021-01-18 08:30:53.815 [INF] NTFN: New block: height=954, sha=2e250f468935e65e2c4efd92be958cf262b1009915c17bea506ebaf1954eaac5 2021-01-18 08:30:53.815 [INF] NTFN: Dispatching 1 confirmation notification for txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 2021-01-18 08:30:53.815 [DBG] DISC: New block: height=954, hash=2e250f468935e65e2c4efd92be958cf262b1009915c17bea506ebaf1954eaac5 2021-01-18 08:30:53.815 [DBG] SWPR: New block: height=954, sha=2e250f468935e65e2c4efd92be958cf262b1009915c17bea506ebaf1954eaac5 2021-01-18 08:30:53.815 [INF] FNDG: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) is now active: ChannelID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) 2021-01-18 08:30:53.815 [INF] UTXN: Attempting to graduate height=954: num_kids=0, num_babies=0 2021-01-18 08:30:53.815 [DBG] FNDG: ChannelID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) is now fully confirmed! (shortChanID=954:1:0) 2021-01-18 08:30:53.815 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=954) examining active HTLC's 2021-01-18 08:30:53.815 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=954, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:53.817 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): starting local commitment: (*lnwallet.commitment)(0xc000441980)({ height: (uint64) 0, isOurs: (bool) true, ourMessageIndex: (uint64) 0, theirMessageIndex: (uint64) 0, ourHtlcIndex: (uint64) 0, theirHtlcIndex: (uint64) 0, txn: (*wire.MsgTx)(0xc000be33c0)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc00093f200)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=15) { (*wire.TxOut)(0xc000c948e0)({ Value: (int64) 990950, PkScript: ([]uint8) (len=34 cap=500) { 00000000 00 20 2c 50 cb 38 a4 f3 95 ec 80 c9 e1 34 f5 ac |. ,P.8.......4..| 00000010 89 df f9 d0 e8 9a ef 28 05 83 bd c9 87 d1 7f b7 |.......(........| 00000020 2c ae |,.| } }) }, LockTime: (uint32) 550156200 }), sig: ([]uint8) (len=71 cap=71) { 00000000 30 45 02 21 00 a2 27 d7 c9 56 93 3b f0 e6 44 36 |0E.!..'..V.;..D6| 00000010 9a 98 9c 11 b2 1f 9b 8d 22 b0 15 84 69 d2 3d 78 |........"...i.=x| 00000020 9b 62 a2 f7 c9 02 20 7f 62 f0 4f b7 6b f8 62 03 |.b.... .b.O.k.b.| 00000030 8f 36 10 30 57 3e d2 15 60 76 6e a2 2d 34 8b cd |.6.0W>..`vn.-4..| 00000040 88 44 20 a9 5c b4 60 |.D .\.`| }, ourBalance: (lnwire.MilliSatoshi) 990950000 mSAT, theirBalance: (lnwire.MilliSatoshi) 0 mSAT, fee: (btcutil.Amount) 0.0000905 BTC, feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw, dustLimit: (btcutil.Amount) 0.00000573 BTC, outgoingHTLCs: ([]lnwallet.PaymentDescriptor) , incomingHTLCs: ([]lnwallet.PaymentDescriptor) , outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) , incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) }) 2021-01-18 08:30:53.818 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): starting remote commitment: (*lnwallet.commitment)(0xc00045f140)({ height: (uint64) 0, isOurs: (bool) false, ourMessageIndex: (uint64) 0, theirMessageIndex: (uint64) 0, ourHtlcIndex: (uint64) 0, theirHtlcIndex: (uint64) 0, txn: (*wire.MsgTx)(0xc000be3400)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc00093f260)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=15) { (*wire.TxOut)(0xc000c94900)({ Value: (int64) 990950, PkScript: ([]uint8) (len=22 cap=500) { 00000000 00 14 16 0d 57 30 e3 12 8a 9e 32 94 0d 31 2e df |....W0....2..1..| 00000010 ca 91 15 8b 5f 84 |...._.| } }) }, LockTime: (uint32) 550156200 }), sig: ([]uint8) , ourBalance: (lnwire.MilliSatoshi) 990950000 mSAT, theirBalance: (lnwire.MilliSatoshi) 0 mSAT, fee: (btcutil.Amount) 0.0000905 BTC, feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw, dustLimit: (btcutil.Amount) 0.00000573 BTC, outgoingHTLCs: ([]lnwallet.PaymentDescriptor) , incomingHTLCs: ([]lnwallet.PaymentDescriptor) , outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) , incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) }) 2021-01-18 08:30:53.818 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): Restoring 0 dangling remote updates 2021-01-18 08:30:53.819 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): Restoring 0 local updates that the peer should sign 2021-01-18 08:30:53.820 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 955 2021-01-18 08:30:53.820 [DBG] PEER: Received FundingLocked(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, next_point=03bee691d1917b97789726e84af488714766a459387f44926dbdf77b806f078b15) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.820 [DBG] FNDG: Received FundingLocked for ChannelID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) from peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:53.824 [ERR] FNDG: unable to report short chan id: link b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1 not found 2021-01-18 08:30:53.824 [DBG] CHBU: Adding channel b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0 to backup state 2021-01-18 08:30:53.825 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=1, num_new_chans=1 2021-01-18 08:30:53.827 [WRN] CHBU: Replacing disk backup for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) w/ newer version 2021-01-18 08:30:53.829 [INF] CHBU: Updating backup file at /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:53.830 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): starting local commitment: (*lnwallet.commitment)(0xc00045f2c0)({ height: (uint64) 0, isOurs: (bool) true, ourMessageIndex: (uint64) 0, theirMessageIndex: (uint64) 0, ourHtlcIndex: (uint64) 0, theirHtlcIndex: (uint64) 0, txn: (*wire.MsgTx)(0xc000be33c0)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc00093f200)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=15) { (*wire.TxOut)(0xc000c948e0)({ Value: (int64) 990950, PkScript: ([]uint8) (len=34 cap=500) { 00000000 00 20 2c 50 cb 38 a4 f3 95 ec 80 c9 e1 34 f5 ac |. ,P.8.......4..| 00000010 89 df f9 d0 e8 9a ef 28 05 83 bd c9 87 d1 7f b7 |.......(........| 00000020 2c ae |,.| } }) }, LockTime: (uint32) 550156200 }), sig: ([]uint8) (len=71 cap=71) { 00000000 30 45 02 21 00 a2 27 d7 c9 56 93 3b f0 e6 44 36 |0E.!..'..V.;..D6| 00000010 9a 98 9c 11 b2 1f 9b 8d 22 b0 15 84 69 d2 3d 78 |........"...i.=x| 00000020 9b 62 a2 f7 c9 02 20 7f 62 f0 4f b7 6b f8 62 03 |.b.... .b.O.k.b.| 00000030 8f 36 10 30 57 3e d2 15 60 76 6e a2 2d 34 8b cd |.6.0W>..`vn.-4..| 00000040 88 44 20 a9 5c b4 60 |.D .\.`| }, ourBalance: (lnwire.MilliSatoshi) 990950000 mSAT, theirBalance: (lnwire.MilliSatoshi) 0 mSAT, fee: (btcutil.Amount) 0.0000905 BTC, feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw, dustLimit: (btcutil.Amount) 0.00000573 BTC, outgoingHTLCs: ([]lnwallet.PaymentDescriptor) , incomingHTLCs: ([]lnwallet.PaymentDescriptor) , outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) , incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) }) 2021-01-18 08:30:53.831 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): starting local commitment: (*lnwallet.commitment)(0xc000441b00)({ height: (uint64) 0, isOurs: (bool) true, ourMessageIndex: (uint64) 0, theirMessageIndex: (uint64) 0, ourHtlcIndex: (uint64) 0, theirHtlcIndex: (uint64) 0, txn: (*wire.MsgTx)(0xc000cd5b80)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0xc000a9ade0)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=1) { (*wire.TxOut)(0xc000cf99a0)({ Value: (int64) 990950, PkScript: ([]uint8) (len=34 cap=34) { 00000000 00 20 2c 50 cb 38 a4 f3 95 ec 80 c9 e1 34 f5 ac |. ,P.8.......4..| 00000010 89 df f9 d0 e8 9a ef 28 05 83 bd c9 87 d1 7f b7 |.......(........| 00000020 2c ae |,.| } }) }, LockTime: (uint32) 550156200 }), sig: ([]uint8) (len=71 cap=71) { 00000000 30 45 02 21 00 a2 27 d7 c9 56 93 3b f0 e6 44 36 |0E.!..'..V.;..D6| 00000010 9a 98 9c 11 b2 1f 9b 8d 22 b0 15 84 69 d2 3d 78 |........"...i.=x| 00000020 9b 62 a2 f7 c9 02 20 7f 62 f0 4f b7 6b f8 62 03 |.b.... .b.O.k.b.| 00000030 8f 36 10 30 57 3e d2 15 60 76 6e a2 2d 34 8b cd |.6.0W>..`vn.-4..| 00000040 88 44 20 a9 5c b4 60 |.D .\.`| }, ourBalance: (lnwire.MilliSatoshi) 990950000 mSAT, theirBalance: (lnwire.MilliSatoshi) 0 mSAT, fee: (btcutil.Amount) 0.0000905 BTC, feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw, dustLimit: (btcutil.Amount) 0.00000573 BTC, outgoingHTLCs: ([]lnwallet.PaymentDescriptor) , incomingHTLCs: ([]lnwallet.PaymentDescriptor) , outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) , incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) }) 2021-01-18 08:30:53.833 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): starting remote commitment: (*lnwallet.commitment)(0xc000441bc0)({ height: (uint64) 0, isOurs: (bool) false, ourMessageIndex: (uint64) 0, theirMessageIndex: (uint64) 0, ourHtlcIndex: (uint64) 0, theirHtlcIndex: (uint64) 0, txn: (*wire.MsgTx)(0xc000cd5bc0)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0xc000a9aea0)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=1) { (*wire.TxOut)(0xc000cf99e0)({ Value: (int64) 990950, PkScript: ([]uint8) (len=22 cap=22) { 00000000 00 14 16 0d 57 30 e3 12 8a 9e 32 94 0d 31 2e df |....W0....2..1..| 00000010 ca 91 15 8b 5f 84 |...._.| } }) }, LockTime: (uint32) 550156200 }), sig: ([]uint8) { }, ourBalance: (lnwire.MilliSatoshi) 990950000 mSAT, theirBalance: (lnwire.MilliSatoshi) 0 mSAT, fee: (btcutil.Amount) 0.0000905 BTC, feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw, dustLimit: (btcutil.Amount) 0.00000573 BTC, outgoingHTLCs: ([]lnwallet.PaymentDescriptor) , incomingHTLCs: ([]lnwallet.PaymentDescriptor) , outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) , incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) }) 2021-01-18 08:30:53.834 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): Restoring 0 dangling remote updates 2021-01-18 08:30:53.834 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): Restoring 0 local updates that the peer should sign 2021-01-18 08:30:53.834 [INF] PEER: New channel active ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) with NodeKey(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef) 2021-01-18 08:30:53.834 [DBG] CNCT: New ChainEventSubscription(id=1) for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) 2021-01-18 08:30:53.834 [INF] HSWC: Removing channel link with ChannelID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) 2021-01-18 08:30:53.834 [INF] HSWC: ChannelLink(954:1:0): starting 2021-01-18 08:30:53.834 [INF] NTFN: New block: height=955, sha=3bbb4c50d84af2ac086034a98e82a4a458e9d08a0e25924556b374809813b486 2021-01-18 08:30:53.834 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:53.834 [DBG] DISC: New block: height=955, hash=3bbb4c50d84af2ac086034a98e82a4a458e9d08a0e25924556b374809813b486 2021-01-18 08:30:53.834 [DBG] SWPR: New block: height=955, sha=3bbb4c50d84af2ac086034a98e82a4a458e9d08a0e25924556b374809813b486 2021-01-18 08:30:53.834 [INF] UTXN: Attempting to graduate height=955: num_kids=0, num_babies=0 2021-01-18 08:30:53.834 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=955) examining active HTLC's 2021-01-18 08:30:53.834 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=955, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:53.834 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 956 2021-01-18 08:30:53.835 [INF] HSWC: Trimming open circuits for chan_id=954:1:0, start_htlc_id=0 2021-01-18 08:30:53.835 [INF] HSWC: Adding live link chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, short_chan_id=954:1:0 2021-01-18 08:30:53.835 [INF] CNCT: Attempting to update ContractSignals for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) 2021-01-18 08:30:53.835 [INF] HSWC: ChannelLink(954:1:0): HTLC manager started, bandwidth=978800000 mSAT 2021-01-18 08:30:53.835 [DBG] HSWC: ChannelLink(954:1:0): loaded 0 fwd pks 2021-01-18 08:30:53.837 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): starting remote commitment: (*lnwallet.commitment)(0xc00045f380)({ height: (uint64) 0, isOurs: (bool) false, ourMessageIndex: (uint64) 0, theirMessageIndex: (uint64) 0, ourHtlcIndex: (uint64) 0, theirHtlcIndex: (uint64) 0, txn: (*wire.MsgTx)(0xc000be3400)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc00093f260)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=15) { (*wire.TxOut)(0xc000c94900)({ Value: (int64) 990950, PkScript: ([]uint8) (len=22 cap=500) { 00000000 00 14 16 0d 57 30 e3 12 8a 9e 32 94 0d 31 2e df |....W0....2..1..| 00000010 ca 91 15 8b 5f 84 |...._.| } }) }, LockTime: (uint32) 550156200 }), sig: ([]uint8) , ourBalance: (lnwire.MilliSatoshi) 990950000 mSAT, theirBalance: (lnwire.MilliSatoshi) 0 mSAT, fee: (btcutil.Amount) 0.0000905 BTC, feePerKw: (chainfee.SatPerKWeight) 12500 sat/kw, dustLimit: (btcutil.Amount) 0.00000573 BTC, outgoingHTLCs: ([]lnwallet.PaymentDescriptor) , incomingHTLCs: ([]lnwallet.PaymentDescriptor) , outgoingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) , incomingHTLCIndex: (map[int32]*lnwallet.PaymentDescriptor) }) 2021-01-18 08:30:53.837 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): Restoring 0 dangling remote updates 2021-01-18 08:30:53.837 [DBG] LNWL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): Restoring 0 local updates that the peer should sign 2021-01-18 08:30:53.837 [DBG] FNDG: Channel(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) with ShortChanID 954:1:0 has opening state 0 2021-01-18 08:30:53.837 [DBG] SRVR: Notifying that peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef is online 2021-01-18 08:30:53.837 [INF] FNDG: Peer(030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef) is online, sending FundingLocked for ChannelID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) 2021-01-18 08:30:53.837 [DBG] PEER: Sending FundingLocked(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, next_point=0383929e0735dfd1db23002958ae733e1dc6e6f7a1b3a60bfab5eaf27e98a0d4b8) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.838 [DBG] FNDG: Channel(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) with ShortChanID 954:1:0: successfully sent FundingLocked 2021-01-18 08:30:53.838 [DBG] FNDG: Channel(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) with ShortChanID 954:1:0 has opening state 1 2021-01-18 08:30:53.845 [INF] NTFN: New block: height=956, sha=35a171e14c2de68d40de6e514f56c86b05fa6b0b7039e8782d98753c79745acf 2021-01-18 08:30:53.845 [DBG] SWPR: New block: height=956, sha=35a171e14c2de68d40de6e514f56c86b05fa6b0b7039e8782d98753c79745acf 2021-01-18 08:30:53.845 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=956) examining active HTLC's 2021-01-18 08:30:53.845 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=956, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:53.845 [DBG] DISC: New block: height=956, hash=35a171e14c2de68d40de6e514f56c86b05fa6b0b7039e8782d98753c79745acf 2021-01-18 08:30:53.845 [INF] UTXN: Attempting to graduate height=956: num_kids=0, num_babies=0 2021-01-18 08:30:53.846 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 957 2021-01-18 08:30:53.856 [INF] NTFN: New block: height=957, sha=11542e95f27e6d6557d50ac04051395c91ad18797bf8dc99f6f5876481bd2ae9 2021-01-18 08:30:53.856 [DBG] SWPR: New block: height=957, sha=11542e95f27e6d6557d50ac04051395c91ad18797bf8dc99f6f5876481bd2ae9 2021-01-18 08:30:53.857 [INF] UTXN: Attempting to graduate height=957: num_kids=0, num_babies=0 2021-01-18 08:30:53.857 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=957) examining active HTLC's 2021-01-18 08:30:53.857 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=957, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:53.857 [DBG] DISC: New block: height=957, hash=11542e95f27e6d6557d50ac04051395c91ad18797bf8dc99f6f5876481bd2ae9 2021-01-18 08:30:53.857 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 958 2021-01-18 08:30:53.861 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000000, update_time=2021-01-18 08:30:53 +0000 UTC) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.864 [ERR] RPCS: [/lnrpc.Lightning/SubscribeChannelGraph]: rpc error: code = Internal desc = transport: transport: the stream is done or WriteHeader was already called 2021-01-18 08:30:53.868 [INF] NTFN: New block: height=958, sha=6153ea5587c75f470886745e463f8d2db462e92e05c964b6f915e859a3d146f3 2021-01-18 08:30:53.868 [DBG] DISC: Requesting online notification for peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:53.868 [DBG] SRVR: Notifying that peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef is online 2021-01-18 08:30:53.868 [DBG] DISC: Peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef is now online, proceeding to send pending messages 2021-01-18 08:30:53.868 [DBG] DISC: Requesting offline notification for peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:53.868 [DBG] DISC: Successfully sent ChannelUpdate message for channel=954:1:0 with peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef upon reconnection 2021-01-18 08:30:53.869 [INF] UTXN: Attempting to graduate height=958: num_kids=0, num_babies=0 2021-01-18 08:30:53.869 [DBG] SWPR: New block: height=958, sha=6153ea5587c75f470886745e463f8d2db462e92e05c964b6f915e859a3d146f3 2021-01-18 08:30:53.869 [DBG] DISC: New block: height=958, hash=6153ea5587c75f470886745e463f8d2db462e92e05c964b6f915e859a3d146f3 2021-01-18 08:30:53.869 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=958) examining active HTLC's 2021-01-18 08:30:53.869 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=958, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:53.869 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000001, update_time=2021-01-18 08:30:53 +0000 UTC) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.869 [DBG] NTFN: Filtering 1 txns for 1 spend requests at height 959 2021-01-18 08:30:53.869 [DBG] FNDG: Channel(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) with ShortChanID 954:1:0: successfully added to router graph 2021-01-18 08:30:53.869 [DBG] FNDG: Channel(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) with ShortChanID 954:1:0 has opening state 2 2021-01-18 08:30:53.869 [DBG] FNDG: Will announce channel 1048934092963840 after ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) has gotten 6 confirmations 2021-01-18 08:30:53.869 [DBG] NTFN: Using height hint 954 retrieved from cache for txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 instead of 953 2021-01-18 08:30:53.869 [INF] NTFN: New confirmation subscription: conf_id=2, txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3, num_confs=6 height_hint=954 2021-01-18 08:30:53.876 [DBG] PEER: Received AnnounceSignatures(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, short_chan_id=1048934092963840) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.876 [INF] DISC: Received new remote channel announcement for 954:1:0 2021-01-18 08:30:53.880 [INF] NTFN: New block: height=959, sha=24d7526baa30543cbfe5724e5bdc5cae0588035a7e299cee5adccfce726d32bb 2021-01-18 08:30:53.880 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=959) examining active HTLC's 2021-01-18 08:30:53.880 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=959, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:53.880 [DBG] NTFN: Attempting to dispatch confirmation for txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 on registration since rescan has finished 2021-01-18 08:30:53.880 [INF] NTFN: Dispatching 6 confirmation notification for txid=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3 2021-01-18 08:30:53.880 [INF] FNDG: Announcing ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0), short_chan_id=954:1:0 2021-01-18 08:30:53.881 [DBG] SWPR: New block: height=959, sha=24d7526baa30543cbfe5724e5bdc5cae0588035a7e299cee5adccfce726d32bb 2021-01-18 08:30:53.881 [INF] UTXN: Attempting to graduate height=959: num_kids=0, num_babies=0 2021-01-18 08:30:53.881 [INF] DISC: 1/2 of channel ann proof received for short_chan_id=1048934092963840, waiting for other half 2021-01-18 08:30:53.881 [DBG] DISC: New block: height=959, hash=24d7526baa30543cbfe5724e5bdc5cae0588035a7e299cee5adccfce726d32bb 2021-01-18 08:30:53.883 [INF] DISC: Received new local channel announcement for 954:1:0 2021-01-18 08:30:53.894 [DBG] DISC: Successfully sent AnnounceSignatures message for channel=954:1:0 with peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:53.894 [DBG] PEER: Sending AnnounceSignatures(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, short_chan_id=1048934092963840) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.899 [INF] DISC: Fully valid channel proof for short_chan_id=1048934092963840 constructed, adding to next ann batch 2021-01-18 08:30:53.899 [DBG] DISC: Unable to fetch node announcement for 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef: node does not have node announcement 2021-01-18 08:30:53.901 [INF] DISC: Broadcasting 4 new announcements in 1 sub batches 2021-01-18 08:30:53.901 [DBG] PEER: Sending ChannelAnnouncement(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.901 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000001, update_time=2021-01-18 08:30:53 +0000 UTC) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.901 [DBG] PEER: Sending ChannelAnnouncement(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:53.901 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000000, update_time=2021-01-18 08:30:53 +0000 UTC) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:53.901 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000001, update_time=2021-01-18 08:30:53 +0000 UTC) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:53.901 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:53.901 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:53.901 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:53.901 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:53.912 [DBG] FNDG: Channel with ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0), short_chan_id=954:1:0 announced 2021-01-18 08:30:53.913 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000000, update_time=2021-01-18 08:30:53 +0000 UTC) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.913 [DBG] PEER: Received NodeAnnouncement(node=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef, update_time=2021-01-18 08:30:53 +0000 UTC) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:53.913 [DBG] FNDG: Channel(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) with ShortChanID 954:1:0: successfully announced 2021-01-18 08:30:53.913 [DBG] FNDG: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) with chan_id=a6434e2af467ac66589986df5a75e7baf44b95b93510333152139eaf10016afa not found in opening database, assuming already announced to the network 2021-01-18 08:30:53.950 [INF] DISC: Broadcasting 2 new announcements in 1 sub batches 2021-01-18 08:30:53.950 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:53.950 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:53.950 [DBG] PEER: Sending NodeAnnouncement(node=03764c7eea899648466e6b3b528d39de0ee9c066f1bee11d73bfa86aa23e71db93, update_time=2021-01-18 08:30:53 +0000 UTC) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:53.950 [DBG] PEER: Sending NodeAnnouncement(node=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef, update_time=2021-01-18 08:30:53 +0000 UTC) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:53.950 [DBG] PEER: Sending NodeAnnouncement(node=03764c7eea899648466e6b3b528d39de0ee9c066f1bee11d73bfa86aa23e71db93, update_time=2021-01-18 08:30:53 +0000 UTC) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.071 [DBG] RPCS: [listchannels] fetched 1 channels from DB 2021-01-18 08:30:54.473 [DBG] CRTR: New graph topology client subscription, client 3 2021-01-18 08:30:54.474 [DBG] RPCS: [listchannels] fetched 1 channels from DB 2021-01-18 08:30:54.675 [DBG] RPCS: [listchannels] fetched 1 channels from DB 2021-01-18 08:30:54.878 [DBG] LNWL: Web API returning 12500 sat/kw for conf target of 6 2021-01-18 08:30:54.878 [DBG] RPCS: Target sat/kw for closing transaction: 12500 2021-01-18 08:30:54.878 [DBG] HSWC: Requesting local channel close: peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789, chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1 2021-01-18 08:30:54.878 [INF] PEER: Local close channel request delivered to peer: 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:54.880 [INF] PEER: Delivery addr for channel close: bcrt1qmewsfuq4p7e4ausxzyd4f3dzfk26tv6al5ygua 2021-01-18 08:30:54.880 [INF] CHCL: Ideal fee for closure of ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) is: 9050 sat 2021-01-18 08:30:54.880 [INF] CHCL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): initiating shutdown 2021-01-18 08:30:54.881 [INF] NANN: Announcing channel(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) disabled [requested] 2021-01-18 08:30:54.894 [INF] HSWC: Removing channel link with ChannelID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) 2021-01-18 08:30:54.894 [INF] HSWC: ChannelLink(954:1:0): stopping 2021-01-18 08:30:54.894 [INF] HSWC: ChannelLink(954:1:0): exited 2021-01-18 08:30:54.895 [INF] CHCL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): sending shutdown message 2021-01-18 08:30:54.895 [DBG] PEER: Sending Shutdown(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, script=0014de5d04f0150fb35ef206111b54c5a24d95a5b35d) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.900 [INF] DISC: Broadcasting 1 new announcements in 1 sub batches 2021-01-18 08:30:54.900 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:54.900 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000011, update_time=2021-01-18 08:30:54 +0000 UTC) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.900 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000011, update_time=2021-01-18 08:30:54 +0000 UTC) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:54.913 [DBG] PEER: Received ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000010, update_time=2021-01-18 08:30:54 +0000 UTC) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.914 [DBG] PEER: Received Shutdown(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, script=00141550bf4bb76a424955735561d8eca15216224b03) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.914 [INF] CHCL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): shutdown response received, entering fee negotiation 2021-01-18 08:30:54.914 [INF] CHCL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): proposing fee of 9050 sat to close chan 2021-01-18 08:30:54.914 [DBG] PEER: Sending ClosingSigned(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, fee_sat=0.0000905 BTC) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.920 [DBG] PEER: Received ClosingSigned(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, fee_sat=0.0000905 BTC) from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.920 [INF] CHCL: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) fee of 0.0000905 BTC accepted, ending negotiation 2021-01-18 08:30:54.920 [INF] LNWL: Inserting unconfirmed transaction 717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf 2021-01-18 08:30:54.921 [DBG] LNWL: Marked address bcrt1qmewsfuq4p7e4ausxzyd4f3dzfk26tv6al5ygua used 2021-01-18 08:30:54.923 [INF] CHCL: Broadcasting cooperative close tx: (*wire.MsgTx)(0xc000f0d400)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=15) { (*wire.TxIn)(0xc000f42f00)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) , Witness: (wire.TxWitness) (len=4 cap=4) { ([]uint8) , ([]uint8) (len=72 cap=144) { 00000000 30 45 02 21 00 8e 55 54 b9 6a c8 bf ce 0b b2 92 |0E.!..UT.j......| 00000010 95 fb b2 21 5c 42 a5 22 b5 0d 1c bc 7b 97 35 2c |...!\B."....{.5,| 00000020 eb f4 50 a4 41 02 20 52 c0 ed d4 56 85 ee 87 e3 |..P.A. R...V....| 00000030 a0 05 e7 fe b8 22 08 fa 92 a6 98 52 07 3c 55 75 |.....".....R......| 00000040 19 2f fd 3f 3c 4e 01 |./.?.G..| 00000010 be 0d 25 b3 fe 8e 6b c0 79 7e 48 d5 eb 11 9a e4 |..%...k.y~H.....| 00000020 25 a9 48 21 03 c0 be 31 b7 58 07 45 d2 77 3f 65 |%.H!...1.X.E.w?e| 00000030 4c 46 9f e7 9c 8d 5f e5 f9 77 68 3d 66 ab e4 66 |LF...._..wh=f..f| 00000040 1a f0 50 34 e8 52 ae |..P4.R.| } }, Sequence: (uint32) 4294967295 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=15) { (*wire.TxOut)(0xc000f45b80)({ Value: (int64) 990950, PkScript: ([]uint8) (len=22 cap=500) { 00000000 00 14 de 5d 04 f0 15 0f b3 5e f2 06 11 1b 54 c5 |...].....^....T.| 00000010 a2 4d 95 a5 b3 5d |.M...]| } }) }, LockTime: (uint32) 0 }) 2021-01-18 08:30:54.924 [DBG] LNWL: Marked address bcrt1qmewsfuq4p7e4ausxzyd4f3dzfk26tv6al5ygua used 2021-01-18 08:30:54.927 [INF] HSWC: Removing channel link with ChannelID(b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1) 2021-01-18 08:30:54.927 [INF] PEER: Waiting for confirmation of cooperative close of ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) with txid: 717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf 2021-01-18 08:30:54.927 [INF] NTFN: New confirmation subscription: conf_id=3, txid=717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf, num_confs=1 height_hint=959 2021-01-18 08:30:54.927 [DBG] NTFN: Dispatching historical confirmation rescan for txid=717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf 2021-01-18 08:30:54.927 [DBG] PEER: Sending ClosingSigned(chan_id=b3876031d148daf2e596fa11c3bc7f4ec83a0dee11f8fd6e2dc0a36e6b05f4b1, fee_sat=0.0000905 BTC) to 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:54.927 [DBG] NTFN: Confirmation details for txid=717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf not found during historical dispatch, waiting to dispatch at tip 2021-01-18 08:30:54.950 [INF] DISC: Broadcasting 1 new announcements in 1 sub batches 2021-01-18 08:30:54.950 [DBG] SRVR: Broadcasting 1 messages 2021-01-18 08:30:54.950 [DBG] PEER: Sending ChannelUpdate(chain_hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206, short_chan_id=1048934092963840, mflags=00000001, cflags=00000010, update_time=2021-01-18 08:30:54 +0000 UTC) to 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:54.978 [DBG] RPCS: [listchannels] fetched 0 channels from DB 2021-01-18 08:30:54.979 [DBG] RPCS: [pendingchannels] 2021-01-18 08:30:55.036 [INF] CRTR: Pruning channel graph using block 32d992a58a22546d1d2689637c24b1260c28513e28914b2dcf9dd242fc10644a (height=960) 2021-01-18 08:30:55.037 [INF] LNWL: Marking unconfirmed transaction 717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf mined in block 960 2021-01-18 08:30:55.037 [DBG] LNWL: Marked address bcrt1qmewsfuq4p7e4ausxzyd4f3dzfk26tv6al5ygua used 2021-01-18 08:30:55.039 [DBG] NTFN: Filtering 2 txns for 1 spend requests at height 960 2021-01-18 08:30:55.037 [INF] CHDB: Pruned unconnected node 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef from channel graph 2021-01-18 08:30:55.040 [INF] CHDB: Pruned 1 unconnected nodes from the channel graph 2021-01-18 08:30:55.040 [DBG] NTFN: Found spend of outpoint=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, script=0 e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656d: spend_tx=717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf, block_height=960 2021-01-18 08:30:55.040 [DBG] NTFN: Spend request outpoint=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, script=0 e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656d spent at tip=960 2021-01-18 08:30:55.040 [DBG] NTFN: Found initial confirmation of txid=717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf: height=960, hash=32d992a58a22546d1d2689637c24b1260c28513e28914b2dcf9dd242fc10644a 2021-01-18 08:30:55.041 [INF] CRTR: Block 32d992a58a22546d1d2689637c24b1260c28513e28914b2dcf9dd242fc10644a (height=960) closed 1 channels 2021-01-18 08:30:55.062 [INF] NTFN: New block: height=960, sha=32d992a58a22546d1d2689637c24b1260c28513e28914b2dcf9dd242fc10644a 2021-01-18 08:30:55.062 [INF] NTFN: Dispatching 1 confirmation notification for txid=717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf 2021-01-18 08:30:55.063 [INF] NTFN: Dispatching confirmed spend notification for outpoint=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, script=0 e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656d at current height=960: 717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf[0] spending b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0 at height=960 2021-01-18 08:30:55.063 [DBG] NTFN: Found spend of outpoint=b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, script=0 e20f1dc07ba0c70c97cae3f48089db0bdc587ce093b9472a09b0f4668cf9656d: spend_tx=717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf, block_height=960 2021-01-18 08:30:55.063 [DBG] DISC: New block: height=960, hash=32d992a58a22546d1d2689637c24b1260c28513e28914b2dcf9dd242fc10644a 2021-01-18 08:30:55.063 [DBG] CNCT: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): local_commit_type=2, local_commit=(*channeldb.ChannelCommitment)(0xc000870bf0)({ CommitHeight: (uint64) 0, LocalLogIndex: (uint64) 0, LocalHtlcIndex: (uint64) 0, RemoteLogIndex: (uint64) 0, RemoteHtlcIndex: (uint64) 0, LocalBalance: (lnwire.MilliSatoshi) 990950000 mSAT, RemoteBalance: (lnwire.MilliSatoshi) 0 mSAT, CommitFee: (btcutil.Amount) 0.0000905 BTC, FeePerKw: (btcutil.Amount) 0.000125 BTC, CommitTx: (*wire.MsgTx)(0xc000f0cc00)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0xc000f42960)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=1) { (*wire.TxOut)(0xc001016020)({ Value: (int64) 990950, PkScript: ([]uint8) (len=34 cap=34) { 00000000 00 20 2c 50 cb 38 a4 f3 95 ec 80 c9 e1 34 f5 ac |. ,P.8.......4..| 00000010 89 df f9 d0 e8 9a ef 28 05 83 bd c9 87 d1 7f b7 |.......(........| 00000020 2c ae |,.| } }) }, LockTime: (uint32) 550156200 }), CommitSig: ([]uint8) (len=71 cap=71) { 00000000 30 45 02 21 00 a2 27 d7 c9 56 93 3b f0 e6 44 36 |0E.!..'..V.;..D6| 00000010 9a 98 9c 11 b2 1f 9b 8d 22 b0 15 84 69 d2 3d 78 |........"...i.=x| 00000020 9b 62 a2 f7 c9 02 20 7f 62 f0 4f b7 6b f8 62 03 |.b.... .b.O.k.b.| 00000030 8f 36 10 30 57 3e d2 15 60 76 6e a2 2d 34 8b cd |.6.0W>..`vn.-4..| 00000040 88 44 20 a9 5c b4 60 |.D .\.`| }, Htlcs: ([]channeldb.HTLC) }) 2021-01-18 08:30:55.063 [DBG] CNCT: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): remote_commit_type=2, remote_commit=(*channeldb.ChannelCommitment)(0xc000870c70)({ CommitHeight: (uint64) 0, LocalLogIndex: (uint64) 0, LocalHtlcIndex: (uint64) 0, RemoteLogIndex: (uint64) 0, RemoteHtlcIndex: (uint64) 0, LocalBalance: (lnwire.MilliSatoshi) 990950000 mSAT, RemoteBalance: (lnwire.MilliSatoshi) 0 mSAT, CommitFee: (btcutil.Amount) 0.0000905 BTC, FeePerKw: (btcutil.Amount) 0.000125 BTC, CommitTx: (*wire.MsgTx)(0xc000f0cc40)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0xc000f429c0)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) , Sequence: (uint32) 2157680769 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=1) { (*wire.TxOut)(0xc001016060)({ Value: (int64) 990950, PkScript: ([]uint8) (len=22 cap=22) { 00000000 00 14 16 0d 57 30 e3 12 8a 9e 32 94 0d 31 2e df |....W0....2..1..| 00000010 ca 91 15 8b 5f 84 |...._.| } }) }, LockTime: (uint32) 550156200 }), CommitSig: ([]uint8) { }, Htlcs: ([]channeldb.HTLC) }) 2021-01-18 08:30:55.063 [INF] CNCT: Cooperative closure for ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): (*wire.MsgTx)(0xc0000b43c0)({ Version: (int32) 2, TxIn: ([]*wire.TxIn) (len=1 cap=1) { (*wire.TxIn)(0xc000865380)({ PreviousOutPoint: (wire.OutPoint) b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0, SignatureScript: ([]uint8) { }, Witness: (wire.TxWitness) (len=4 cap=4) { ([]uint8) { }, ([]uint8) (len=72 cap=72) { 00000000 30 45 02 21 00 8e 55 54 b9 6a c8 bf ce 0b b2 92 |0E.!..UT.j......| 00000010 95 fb b2 21 5c 42 a5 22 b5 0d 1c bc 7b 97 35 2c |...!\B."....{.5,| 00000020 eb f4 50 a4 41 02 20 52 c0 ed d4 56 85 ee 87 e3 |..P.A. R...V....| 00000030 a0 05 e7 fe b8 22 08 fa 92 a6 98 52 07 3c 55 75 |.....".....R......| 00000040 19 2f fd 3f 3c 4e 01 |./.?.G..| 00000010 be 0d 25 b3 fe 8e 6b c0 79 7e 48 d5 eb 11 9a e4 |..%...k.y~H.....| 00000020 25 a9 48 21 03 c0 be 31 b7 58 07 45 d2 77 3f 65 |%.H!...1.X.E.w?e| 00000030 4c 46 9f e7 9c 8d 5f e5 f9 77 68 3d 66 ab e4 66 |LF...._..wh=f..f| 00000040 1a f0 50 34 e8 52 ae |..P4.R.| } }, Sequence: (uint32) 4294967295 }) }, TxOut: ([]*wire.TxOut) (len=1 cap=1) { (*wire.TxOut)(0xc000f48000)({ Value: (int64) 990950, PkScript: ([]uint8) (len=22 cap=22) { 00000000 00 14 de 5d 04 f0 15 0f b3 5e f2 06 11 1b 54 c5 |...].....^....T.| 00000010 a2 4d 95 a5 b3 5d |.M...]| } }) }, LockTime: (uint32) 0 }) 2021-01-18 08:30:55.063 [INF] UTXN: Attempting to graduate height=960: num_kids=0, num_babies=0 2021-01-18 08:30:55.063 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=960) examining active HTLC's 2021-01-18 08:30:55.064 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=960, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:55.063 [DBG] SWPR: New block: height=960, sha=32d992a58a22546d1d2689637c24b1260c28513e28914b2dcf9dd242fc10644a 2021-01-18 08:30:55.063 [INF] PEER: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) is now closed at height 960 2021-01-18 08:30:55.064 [INF] RPCS: [closechannel] close completed: txid(717010251ee367c0b3cb2d7438fff2156fc794969c47a6df5034b37228dc2dcf) 2021-01-18 08:30:55.064 [INF] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) marking channel cooperatively closed 2021-01-18 08:30:55.066 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): new block (height=960) examining active HTLC's 2021-01-18 08:30:55.066 [DBG] CNCT: ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0): checking commit chain actions at height=960, in_htlc_count=0, out_htlc_count=0 2021-01-18 08:30:55.066 [DBG] CHBU: Removing channel b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0 from backup state 2021-01-18 08:30:55.066 [INF] CHBU: Updating on-disk multi SCB backup: num_old_chans=1, num_new_chans=0 2021-01-18 08:30:55.068 [INF] CHBU: Updating backup file at /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:55.070 [INF] CHBU: Swapping old multi backup file from /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/temp-dont-use.backup to /tmp/lndtest-node720792410/data/chain/bitcoin/regtest/channel.backup 2021-01-18 08:30:55.077 [INF] CNCT: ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) has been fully resolved on-chain at height=960 2021-01-18 08:30:55.077 [INF] CNCT: Marking ChannelPoint(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) fully resolved 2021-01-18 08:30:55.077 [INF] CHDB: Pruning link node 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef with zero open channels from database 2021-01-18 08:30:55.078 [DBG] CNCT: Stopping ChannelArbitrator(b1f4056b6ea3c02d6efdf811ee0d3ac84e7fbcc311fa96e5f2da48d1316087b3:0) 2021-01-18 08:30:55.264 [DBG] RPCS: [pendingchannels] 2021-01-18 08:30:55.270 [INF] PEER: unable to read message from 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789: EOF 2021-01-18 08:30:55.270 [INF] PEER: disconnecting 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789, reason: read handler closed 2021-01-18 08:30:55.370 [DBG] SRVR: Peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 has been disconnected 2021-01-18 08:30:55.370 [DBG] FNDG: Cancelling all reservations for peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:55.370 [DBG] FNDG: No active reservations for node: 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:55.370 [INF] DISC: Removing GossipSyncer for peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:55.370 [DBG] SRVR: Notifying that peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 is offline 2021-01-18 08:30:55.370 [DBG] SRVR: removing peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 2021-01-18 08:30:55.370 [DBG] PRNF: PeerNotifier notifying peer: 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef offline 2021-01-18 08:30:55.370 [DBG] DISC: Requesting online notification for peer=030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef 2021-01-18 08:30:55.370 [DBG] SRVR: Scheduling connection re-establishment to persistent peer 030815cdb1dfe6d187934675bc0042753ccde7e70291664c6bf2b652772dc2aeef@127.0.0.1:6789 in 1s 2021-01-18 08:30:55.373 [INF] LTND: Received shutdown request. 2021-01-18 08:30:55.373 [INF] LTND: Shutting down... 2021-01-18 08:30:55.373 [INF] LTND: Gracefully shutting down. 2021-01-18 08:30:55.373 [INF] CRTR: FilteredChainView stopping 2021-01-18 08:30:55.373 [INF] HSWC: HTLC Switch shutting down 2021-01-18 08:30:55.373 [INF] HSWC: Block epoch canceled, decaying hash log shutting down 2021-01-18 08:30:55.375 [INF] UTXN: UTXO nursery shutting down 2021-01-18 08:30:55.375 [INF] BRAR: Breach arbiter shutting down 2021-01-18 08:30:55.375 [INF] DISC: Authenticated Gossiper is stopping 2021-01-18 08:30:55.375 [INF] CNCT: Stopping ChainArbitrator 2021-01-18 08:30:55.375 [DBG] SWPR: Sweeper shutting down 2021-01-18 08:30:55.375 [DBG] SWPR: Sweeper shut down 2021-01-18 08:30:55.375 [INF] PRNF: Stopping PeerNotifier 2021-01-18 08:30:55.375 [INF] FNDG: Funding manager shutting down 2021-01-18 08:30:55.375 [INF] CHBU: Stopping chanbackup.SubSwapper 2021-01-18 08:30:55.376 [INF] CHFT: Stopping event store 2021-01-18 08:30:55.376 [DBG] CHFT: recording flap count for: 2 peers 2021-01-18 08:30:55.377 [INF] SRVR: Disconnecting from 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:55.377 [DBG] SRVR: removing peer 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:55.377 [INF] PEER: disconnecting 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336, reason: server: disconnecting peer 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 2021-01-18 08:30:55.377 [INF] PEER: unable to read message from 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336: read tcp 127.0.0.1:6781->127.0.0.1:53336: use of closed network connection 2021-01-18 08:30:55.477 [DBG] SRVR: Peer 03262eaad867894e6de387aaa5b7816d3a703e973852f83ae9c01c1f7529b1ff76@127.0.0.1:53336 has been disconnected 2021-01-18 08:30:55.477 [INF] RPCS: Stopping RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping SignRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping VersionRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping WatchtowerClientRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping RouterRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping AutopilotRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping ChainRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping InvoicesRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping WalletKitRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] RPCS: Stopping WatchtowerRPC Sub-RPC Server 2021-01-18 08:30:55.477 [INF] LTND: Shutdown complete