Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

fix: debug logging for node-to-node clients #740

Merged
merged 1 commit into from
Oct 5, 2024
Merged

Conversation

wolf31o2
Copy link
Member

@wolf31o2 wolf31o2 commented Oct 4, 2024

This helps with troubleshooting node-to-node connections from the client side. Log messages are prefixed with the appropriate subsystem.

{"time":"2024-10-04T17:04:12.703339621-04:00","level":"INFO","msg":"maxprocs: Leaving GOMAXPROCS=8: CPU quota undefined"}
{"time":"2024-10-04T17:04:12.703378997-04:00","level":"INFO","msg":"running: node version devel (commit 070c28f)"}
{"time":"2024-10-04T17:04:12.703505903-04:00","level":"DEBUG","msg":"config: &{BindAddr:0.0.0.0 CardanoConfig:./configs/cardano/preview/config.json Network:mainnet MetricsPort:12798 Port:3001 Topology:./custom-p2p-topology.json}"}
{"time":"2024-10-04T17:04:12.703520138-04:00","level":"DEBUG","msg":"topology: &{Producers:[] LocalRoots:[{AccessPoints:[] Advertise:false Trustable:false Valency:1}] PublicRoots:[{AccessPoints:[] Advertise:false Valency:0}] BootstrapPeers:[{Address:backbone.cardano.iog.io Port:3001}] UseLedgerAfterSlot:128908821}"}
{"time":"2024-10-04T17:04:12.703855119-04:00","level":"DEBUG","msg":"node: cardano node config: &{path:configs/cardano/preview AlonzoGenesisFile:alonzo-genesis.json AlonzoGenesisHash:7e94a15f55d1e82d10f09203fa1d40f8eede58fd8066542cf6566008068ed874 ByronGenesisFile:byron-genesis.json ByronGenesisHash:83de1d7302569ad56cf9139a41e2e11346d4cb4a31c00142557b6ab3fa550761 ConwayGenesisFile:conway-genesis.json ConwayGenesisHash:9cc5084f02e27210eacba47af0872e3dba8946ad9460b6072d793e1d2f3987ef ShelleyGenesisFile:shelley-genesis.json ShelleyGenesisHash:363498d1024f84bb39d3fa9593ce391483cb40d479b87233f868d6e57c3a400d}"}
{"time":"2024-10-04T17:04:12.703864097-04:00","level":"INFO","msg":"listener: ouroboros node-to-node connections on 0.0.0.0:3001"}
{"time":"2024-10-04T17:04:12.703921926-04:00","level":"INFO","msg":"metrics: prometheus metrics on 0.0.0.0:12798"}
{"time":"2024-10-04T17:04:12.708269756-04:00","level":"DEBUG","msg":"connmanager: adding host: {Address:backbone.cardano.iog.io Port:3001 Tags:map[HostBootstrapPeer:true]}"}
{"time":"2024-10-04T17:04:12.708287868-04:00","level":"DEBUG","msg":"outbound: starting connections"}
{"time":"2024-10-04T17:04:12.70829328-04:00","level":"DEBUG","msg":"outbound: adding bootstrap peer topology host: backbone.cardano.iog.io:3001"}
{"time":"2024-10-04T17:04:12.708304804-04:00","level":"DEBUG","msg":"outbound: establishing TCP connection to: backbone.cardano.iog.io:3001"}
{"time":"2024-10-04T17:04:12.793281321-04:00","level":"DEBUG","msg":"outbound: establishing ouroboros protocol to backbone.cardano.iog.io:3001"}
{"time":"2024-10-04T17:04:12.79347029-04:00","level":"DEBUG","msg":"handshake: starting protocol for connection [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.872546705-04:00","level":"DEBUG","msg":"handshake: client accept version for [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.87272316-04:00","level":"DEBUG","msg":"block-fetch: starting protocol for connection [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.872772868-04:00","level":"DEBUG","msg":"chain-sync: starting protocol for connection [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.872826402-04:00","level":"DEBUG","msg":"keep-alive: starting protocol for connection [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.873001885-04:00","level":"INFO","msg":"outbound: connected ouroboros to backbone.cardano.iog.io:3001"}
{"time":"2024-10-04T17:04:12.873564844-04:00","level":"DEBUG","msg":"chain-sync: client [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001 called GetCurrentTip()"}
{"time":"2024-10-04T17:04:12.977060834-04:00","level":"DEBUG","msg":"chain-sync: client intersect not found for [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.977087362-04:00","level":"DEBUG","msg":"keep-alive: client keepalive response for [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.977120275-04:00","level":"DEBUG","msg":"chain-sync: returning tip results {Slot: 136509507, Hash: 379042d77ac0d9af5e1f0bbd5d6e84ef63a3275b6bb0ef8d637becdf7f7d2c9a, BlockNumber: 10920487} to [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:12.977179248-04:00","level":"DEBUG","msg":"chain-sync: client [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001 called Sync(intersectPoints: []{Slot: 136509507, Hash: 379042d77ac0d9af5e1f0bbd5d6e84ef63a3275b6bb0ef8d637becdf7f7d2c9a})"}
{"time":"2024-10-04T17:04:13.055604131-04:00","level":"DEBUG","msg":"chain-sync: client intersect found for [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:13.140122531-04:00","level":"DEBUG","msg":"chain-sync: client roll backward for [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}
{"time":"2024-10-04T17:04:13.141171154-04:00","level":"INFO","msg":"chain rolled back, new tip: 379042d77ac0d9af5e1f0bbd5d6e84ef63a3275b6bb0ef8d637becdf7f7d2c9a at slot 136509507"}
{"time":"2024-10-04T17:04:13.217705584-04:00","level":"DEBUG","msg":"chain-sync: client await reply for [2600:1f13:117:4302:63f4:6cdb:f69c:3f58]:3001"}

@wolf31o2 wolf31o2 requested a review from a team as a code owner October 4, 2024 21:07
@wolf31o2 wolf31o2 merged commit 59c7df4 into main Oct 5, 2024
8 checks passed
@wolf31o2 wolf31o2 deleted the fix/debug-logging branch October 5, 2024 10:46
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

2 participants