I run the
lightningd,
debug.log stucks at the "gossipd: REPLY WIRE_GOSSIPD_INIT_REPLY" message again. Specifically:
2022-07-23T12:23:33.265Z DEBUG lightningd: Opened log file /home/bitcoin/.lightningmobile/debug.log
2022-07-23T12:23:33.265Z DEBUG lightningd: Opened log file /home/bitcoin/.lightningmobile/debug.log
2022-07-23T12:23:33.273Z DEBUG plugin-manager: started(31731) /usr/local/bin/../libexec/c-lightning/plugins/autoclean
2022-07-23T12:23:33.283Z DEBUG plugin-manager: started(31732) /usr/local/bin/../libexec/c-lightning/plugins/bcli
2022-07-23T12:23:33.291Z DEBUG plugin-manager: started(31733) /usr/local/bin/../libexec/c-lightning/plugins/fetchinvoice
2022-07-23T12:23:33.300Z DEBUG plugin-manager: started(31734) /usr/local/bin/../libexec/c-lightning/plugins/funder
2022-07-23T12:23:33.322Z DEBUG plugin-manager: started(31735) /usr/local/bin/../libexec/c-lightning/plugins/topology
2022-07-23T12:23:33.351Z DEBUG plugin-manager: started(31736) /usr/local/bin/../libexec/c-lightning/plugins/keysend
2022-07-23T12:23:33.372Z DEBUG plugin-manager: started(31737) /usr/local/bin/../libexec/c-lightning/plugins/offers
2022-07-23T12:23:33.392Z DEBUG plugin-manager: started(31738) /usr/local/bin/../libexec/c-lightning/plugins/pay
2022-07-23T12:23:33.417Z DEBUG plugin-manager: started(31739) /usr/local/bin/../libexec/c-lightning/plugins/txprepare
2022-07-23T12:23:33.442Z DEBUG plugin-manager: started(31740) /usr/local/bin/../libexec/c-lightning/plugins/spenderp
2022-07-23T12:23:33.580Z DEBUG lightningd: testing /usr/local/libexec/c-lightning/lightning_channeld
2022-07-23T12:23:33.600Z DEBUG lightningd: testing /usr/local/libexec/c-lightning/lightning_closingd
2022-07-23T12:23:33.622Z DEBUG lightningd: testing /usr/local/libexec/c-lightning/lightning_connectd
2022-07-23T12:23:33.642Z DEBUG lightningd: testing /usr/local/libexec/c-lightning/lightning_gossipd
2022-07-23T12:23:33.663Z DEBUG lightningd: testing /usr/local/libexec/c-lightning/lightning_hsmd
2022-07-23T12:23:33.684Z DEBUG lightningd: testing /usr/local/libexec/c-lightning/lightning_onchaind
2022-07-23T12:23:33.705Z DEBUG lightningd: testing /usr/local/libexec/c-lightning/lightning_openingd
2022-07-23T12:23:33.726Z DEBUG hsmd: pid 31748, msgfd 39
2022-07-23T12:23:34.010Z DEBUG connectd: pid 31749, msgfd 43
2022-07-23T12:23:34.011Z DEBUG hsmd: new_client: 0
2022-07-23T12:23:34.104Z DEBUG connectd: Proxy address: 127.0.0.1:9050
2022-07-23T12:23:34.104Z DEBUG connectd: Created IPv4 listener on port 9835
2022-07-23T12:23:34.104Z DEBUG connectd: REPLY WIRE_CONNECTD_INIT_REPLY with 0 fds
2022-07-23T12:23:34.109Z DEBUG gossipd: pid 31750, msgfd 42
2022-07-23T12:23:34.110Z DEBUG hsmd: new_client: 0
2022-07-23T12:23:34.203Z DEBUG gossipd: gossip_store_compact_offline: 0 deleted, 0 copied
2022-07-23T12:23:34.203Z DEBUG gossipd: total store load time: 0 msec
2022-07-23T12:23:34.204Z DEBUG gossipd: gossip_store: Read 0/0/0/0 cannounce/cupdate/nannounce/cdelete from store (0 deleted) in 1 bytes
2022-07-23T12:23:34.204Z DEBUG gossipd: seeker: state = STARTING_UP New seeker
2022-07-23T12:23:34.204Z DEBUG gossipd: REPLY WIRE_GOSSIPD_INIT_REPLY with 0 fds
Alright, I just compared with my node's startup sequence and there are a few notable differences.
Three dots stand for a bunch of lines which I truncated, empty on one side means that that's something only the other user has in his log file.
What stands out at first is that your node somehow creates an
IPv4 listener, but still tries to use Tor somehow. It's possible that this is the normal behaviour if you followed Core Lightning's Tor setup guide, though. I'm not sure since I have
my own way of doing that. That could be something you may want to try. Basically manually creating a Tor service and tunneling the Lightning traffic through it.
Next up, I notice your
connectd_init_done isn't executed, as well as much later in the process, the 'Server started with public key' message is missing. Though that's an INFO message, of which you have none. I'm not sure how that's possible, since
debug should be a higher log level than
info.
BlackHatCoiner n0nce
DEBUG connectd: Proxy address: 127.0.0.1:9050 DEBUG connectd: Proxy address: 127.0.0.1:9050
DEBUG connectd: Created IPv4 listener on port 9835 DEBUG connectd: Created listener on 127.0.0.1:9735
DEBUG connectd: REPLY WIRE_CONNECTD_INIT_REPLY with 0 fds DEBUG connectd: REPLY WIRE_CONNECTD_INIT_REPLY with 0 fds
DEBUG connectd: connectd_init_done
INFO plugin-bcli: bitcoin-cli initialized and connected to bitcoind.
DEBUG lightningd: All Bitcoin plugin commands registered
...
DEBUG gossipd: pid 31750, msgfd 43 DEBUG gossipd: pid 18646, msgfd 46
...
DEBUG hsmd: new_client: 0 DEBUG hsmd: new_client: 0
...
DEBUG gossipd: gossip_store_compact_offline: 0 deleted, 0 copied DEBUG gossipd: gossip_store_compact_offline: 350 deleted, 329864 copied
...
DEBUG gossipd: total store load time: 0 msec
DEBUG gossipd: gossip_store: Read 0/0/0/0 cannounce/cupdate/nannounce/cdelete from store (0 deleted) in 1 bytes
DEBUG gossipd: seeker: state = STARTING_UP New seeker
DEBUG connectd: REPLY WIRE_CONNECTD_ACTIVATE_REPLY with 0 fds
INFO lightningd: --------------------------------------------------
INFO lightningd: Server started with public key [redacted]
DEBUG gossipd: REPLY WIRE_GOSSIPD_INIT_REPLY with 0 fds DEBUG gossipd: REPLY WIRE_GOSSIPD_GET_ADDRS_REPLY with 0 fds