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.

Sign up for GitHub

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

Jump to bottom

empty payload msg spam in the logs #6856

Closed
1 task done
krakovia-evm opened this issue Feb 28, 2024 · 3 comments · Fixed by #6863
Closed
1 task done

empty payload msg spam in the logs #6856

krakovia-evm opened this issue Feb 28, 2024 · 3 comments · Fixed by #6863
Assignees
@emhane
Labels
A-observability Related to tracing, metrics, logs and other observability tools

Comments

@krakovia-evm
Copy link

Describe the bug

this log seems a little bit too verbose

DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }

2024-02-28T19:47:32.419383Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:32.989804Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:32.996205Z DEBUG storage::db::mdbx: Commit total_duration=5.452µs commit_latency=Some(CommitLatency(MDBX_commit_latency { preparation: 0, gc_wallclock: 0, audit: 0, write: 0, sync: 0, ending: 0, whole: 1, gc_cputime: 0, gc_prof: MDBX_commit_latency__bindgen_ty_1 { wloops: 0, coalescences: 0, wipes: 0, flushes: 0, kicks: 0, work_counter: 0, work_rtime_monotonic: 0, work_xtime_cpu: 0, work_rsteps: 0, work_xpages: 0, work_majflt: 0, self_counter: 0, self_rtime_monotonic: 0, self_xtime_cpu: 0, self_rsteps: 0, self_xpages: 0, self_majflt: 0 } }))
2024-02-28T19:47:34.084685Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:34.183434Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:34.564485Z  INFO blockchain_tree: Block is already canonical, ignoring. block_hash=0x7f7d01eeaa468cd9952cc09cd612c1f2737c598ecba3bc85929b157946294a8a
2024-02-28T19:47:34.564528Z DEBUG consensus::engine: Ignoring beacon update to old head fcu_head_num=19328205 current_head_num=19328205
2024-02-28T19:47:34.566628Z  INFO reth_node_core::events::node: Forkchoice updated head_block_hash=0x7f7d01eeaa468cd9952cc09cd612c1f2737c598ecba3bc85929b157946294a8a safe_block_hash=0x8162a03013f4c4b264a15f6f93bb75e957b7c8c9638b74e342fd27bf14931155 finalized_block_hash=0x1808923ddf14cb46f168dcaf3af5df5ee9ac1b63ae47393c9079c3164735dc7e status=Valid
2024-02-28T19:47:37.995988Z DEBUG storage::db::mdbx: Commit total_duration=2.169µs commit_latency=Some(CommitLatency(MDBX_commit_latency { preparation: 0, gc_wallclock: 0, audit: 0, write: 0, sync: 0, ending: 0, whole: 1, gc_cputime: 0, gc_prof: MDBX_commit_latency__bindgen_ty_1 { wloops: 0, coalescences: 0, wipes: 0, flushes: 0, kicks: 0, work_counter: 0, work_rtime_monotonic: 0, work_xtime_cpu: 0, work_rsteps: 0, work_xpages: 0, work_majflt: 0, self_counter: 0, self_rtime_monotonic: 0, self_xtime_cpu: 0, self_rsteps: 0, self_xpages: 0, self_majflt: 0 } }))
2024-02-28T19:47:38.199112Z DEBUG blockchain_tree: Appending block to canonical chain head=0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5 parent=(19328205, 0x7f7d01eeaa468cd9952cc09cd612c1f2737c598ecba3bc85929b157946294a8a)
2024-02-28T19:47:38.241876Z DEBUG evm: Execution time evm_transact=40.925994ms apply_state=351.08µs apply_post_state=4.704µs merge_transitions=215.918µs receipt_root=1.154471ms
2024-02-28T19:47:38.442175Z DEBUG blockchain_tree::chain: Validated state root number=19328206 hash=0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5 elapsed=200.286752ms
2024-02-28T19:47:38.442398Z  INFO reth_node_core::events::node: Block added to canonical chain number=19328206 hash=0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5 peers=121 txs=195 mgas=15.599 full=52.0% base_fee=53.93gwei blobs=0 excess_blobs=0 elapsed=245.364039ms
2024-02-28T19:47:38.457545Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.619036Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.643743Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.653112Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.684321Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.706219Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.775562Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.784438Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.792334Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.816972Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:38.906290Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.103974Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.144090Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.205795Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.309555Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.420021Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.451239Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.452215Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.452638Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.486890Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.496465Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.503092Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.511946Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.519438Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.522386Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.535973Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.566169Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.633692Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.643033Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.648626Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.663912Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.673924Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.706597Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.733928Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.782786Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.793487Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.817595Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.844601Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.926680Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.949324Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:39.982644Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.021391Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.126399Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.138455Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.151224Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.238123Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.243006Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.257308Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.372161Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.384089Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.396931Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.416156Z DEBUG blockchain_tree: Committing new canonical chain: [(19328206, 0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5)]
2024-02-28T19:47:40.418373Z DEBUG blockchain_tree: Using cached trie updates blocks=[(19328206, 0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5)]
2024-02-28T19:47:40.421256Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.445312Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.449473Z DEBUG providers::db: Inserted block block_number=19328206 actions=[(InsertCanonicalHeaders, 35.18µs), (InsertHeaders, 23.806µs), (InsertHeaderNumbers, 14.827µs), (GetParentTD, 1.4µs), (InsertHeaderTD, 15.359µs), (GetNextTxNum, 5.846µs), (InsertTxSenders, 0ns), (InsertTransactions, 10.371419ms), (InsertTxHashNumbers, 20.452845ms), (InsertBlockWithdrawals, 17.923µs), (InsertBlockBodyIndices, 13.982µs), (InsertTransactionBlock, 11.695µs)]
2024-02-28T19:47:40.455154Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.525457Z DEBUG providers::db: Appended blocks range=19328206..=19328206 actions=[(InsertBlock, 31.04215ms), (InsertState, 8.928453ms), (InsertHashes, 40.490272ms), (InsertHistoryIndices, 26.503726ms), (UpdatePipelineStages, 22.646µs)]
2024-02-28T19:47:40.570201Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.591677Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.606319Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.609719Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.672412Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.729634Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.816859Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:40.914338Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.074289Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.125831Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.177570Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.187775Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.215401Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.245353Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.269175Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.270602Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.286146Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.293903Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.295862Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.309930Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.321219Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.355850Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.489332Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.490676Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.543912Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.679625Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:41.944653Z DEBUG storage::db::mdbx: Commit total_duration=1.419179057s commit_latency=Some(CommitLatency(MDBX_commit_latency { preparation: 0, gc_wallclock: 75, audit: 0, write: 0, sync: 92928, ending: 0, whole: 93003, gc_cputime: 0, gc_prof: MDBX_commit_latency__bindgen_ty_1 { wloops: 0, coalescences: 0, wipes: 0, flushes: 0, kicks: 0, work_counter: 0, work_rtime_monotonic: 0, work_xtime_cpu: 0, work_rsteps: 0, work_xpages: 0, work_majflt: 0, self_counter: 0, self_rtime_monotonic: 0, self_xtime_cpu: 0, self_rsteps: 0, self_xpages: 0, self_majflt: 0 } }))
2024-02-28T19:47:41.944740Z DEBUG blockchain_tree: Canonicalization finished actions=[(CloneOldBlocks, 48.303µs), (FindCanonicalHeader, 13.713µs), (SplitChain, 1.695µs), (SplitChainForks, 1.333µs), (MergeAllChains, 989ns), (UpdateCanonicalIndex, 4.377µs), (RetrieveStateTrieUpdates, 2.229346ms), (CommitCanonicalChainToDatabase, 1.526333084s)]
2024-02-28T19:47:41.944815Z DEBUG consensus::engine: Canonicalized new head hash=0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5 number=19328206
2024-02-28T19:47:41.944904Z  INFO reth_node_core::events::node: Canonical chain committed number=19328206 hash=0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5 elapsed=1.528715411s
2024-02-28T19:47:41.949997Z DEBUG txpool: cleaning up blob store finalized_block=19328143
2024-02-28T19:47:41.950009Z DEBUG txpool::blob: Removing blobs from disk num_blobs=0
2024-02-28T19:47:41.954307Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.135553Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.209676Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.236389Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.361412Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.381540Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.390354Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.400438Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.419329Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.463009Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.576125Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.577444Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.601190Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.751835Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.771090Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.813926Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.832862Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.859004Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.871683Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.932923Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.944250Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:42.995673Z DEBUG storage::db::mdbx: Commit total_duration=1.43µs commit_latency=Some(CommitLatency(MDBX_commit_latency { preparation: 0, gc_wallclock: 0, audit: 0, write: 0, sync: 0, ending: 0, whole: 1, gc_cputime: 0, gc_prof: MDBX_commit_latency__bindgen_ty_1 { wloops: 0, coalescences: 0, wipes: 0, flushes: 0, kicks: 0, work_counter: 0, work_rtime_monotonic: 0, work_xtime_cpu: 0, work_rsteps: 0, work_xpages: 0, work_majflt: 0, self_counter: 0, self_rtime_monotonic: 0, self_xtime_cpu: 0, self_rsteps: 0, self_xpages: 0, self_majflt: 0 } }))
2024-02-28T19:47:43.153169Z DEBUG net::session: failed to receive message err=disconnected remote_peer_id=0x5f67525442216f39d7371826fe1158b8458686958a0a3e58daf8198fa4b5dd45fcb03141e05dfdec6e36da61af62eb6b065ca825a56c9217e531d1b36447fef4
2024-02-28T19:47:43.306207Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:43.554216Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:43.627006Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:43.749564Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:43.836242Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:43.840740Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:43.960228Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.016372Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.024186Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.059385Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.087333Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.213648Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.287728Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.302522Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.335502Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.387976Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.419074Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.453979Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.657169Z DEBUG discv4: evicting nodes due to failed pong num=0
2024-02-28T19:47:44.657200Z DEBUG discv4: evicting nodes due to failed lookup num=0
2024-02-28T19:47:44.657206Z DEBUG discv4: processing failed neighbours num=0
2024-02-28T19:47:44.657401Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.751779Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.823258Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.864551Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.894932Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:44.978353Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.068544Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.210088Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.329308Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.429920Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.456815Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.472515Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.497156Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.584062Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.766971Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:45.985205Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.004028Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.268147Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.270671Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.369824Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.542105Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.548313Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.563314Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.672285Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.695426Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.717036Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.724074Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.724309Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.771148Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:46.946578Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.032872Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.065480Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.163692Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.389918Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.567700Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.633505Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.724664Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.735715Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:47.996126Z DEBUG storage::db::mdbx: Commit total_duration=1.672µs commit_latency=Some(CommitLatency(MDBX_commit_latency { preparation: 0, gc_wallclock: 0, audit: 0, write: 0, sync: 0, ending: 0, whole: 1, gc_cputime: 0, gc_prof: MDBX_commit_latency__bindgen_ty_1 { wloops: 0, coalescences: 0, wipes: 0, flushes: 0, kicks: 0, work_counter: 0, work_rtime_monotonic: 0, work_xtime_cpu: 0, work_rsteps: 0, work_xpages: 0, work_majflt: 0, self_counter: 0, self_rtime_monotonic: 0, self_xtime_cpu: 0, self_rsteps: 0, self_xpages: 0, self_majflt: 0 } }))
2024-02-28T19:47:48.275345Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:48.314947Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:48.478529Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:48.496799Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:48.522724Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:48.541508Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:48.683562Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:48.969446Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.010556Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.038375Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.063649Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.085375Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.095656Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.195196Z DEBUG blockchain_tree: Appending block to canonical chain head=0x61e8cfbf493bfca63e22df99fe81fa55744656fad1f3c44fbc3eca35957bc402 parent=(19328206, 0xc1e96efac2963e3340708786582ef9298f9f2fbfdb064a3200350ac9b1dde0b5)
2024-02-28T19:47:49.230061Z DEBUG evm: Execution time evm_transact=33.782394ms apply_state=242.64µs apply_post_state=4.88µs merge_transitions=141.06µs receipt_root=541.074µs
2024-02-28T19:47:49.359494Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.359684Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.384905Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.410642Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.435414Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.460280Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.464747Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.466048Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.508262Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.522923Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.579590Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.605747Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.640963Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.647248Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.665681Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.680801Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.687902Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.697324Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.704787Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.729397Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.747251Z DEBUG net::tx: empty payload msg=VerifiedPooledTransactions { txns: PooledTransactions([]) }
2024-02-28T19:47:49.757048Z DEBUG blockchain_tree::chain: Validated state root number=19328207 hash=0x61e8cfbf493bfca63e22df99fe81fa55744656fad1f3c44fbc3eca35957bc402 elapsed=526.973589ms
2024-02-28T19:47:49.757332Z  INFO reth_node_core::events::node: Block added to canonical chain number=19328207 hash=0x61e8cfbf493bfca63e22df99fe81fa55744656fad1f3c44fbc3eca35957bc402 peers=121 txs=113 mgas=6.502 full=21.7% base_fee=54.19gwei blobs=0 excess_blobs=0 elapsed=563.372661ms

Steps to reproduce

normal execution

Node logs

No response

Platform(s)

Linux (x86)

What version/commit are you on?

reth 0.1.0-alpha.21 (d36180d)

What database version are you on?

1

What type of node are you running?

Full via --full flag

What prune config do you use, if any?

No response

If you've built Reth from source, provide the full command you used

docker build .

Code of Conduct

  • I agree to follow the Code of Conduct
@krakovia-evm krakovia-evm added C-bug An unexpected or incorrect behavior S-needs-triage This issue needs to be labelled labels Feb 28, 2024
@mattsse
Copy link
Collaborator

mattsse commented Feb 28, 2024 •
edited
Loading

@emhane did we downgrade this already?
But also looks weird that there are so many? Is this just spam?

@shekhirin
Copy link
Collaborator

it's on main

reth/crates/net/network/src/transactions/validation.rs

Lines 78 to 84 in 790bc62

if msg.is_empty() {
debug!(target: "net::tx",
msg=?msg,
"empty payload"
);
return (FilterOutcome::ReportPeer, PartiallyValidData::empty_eth66())
}

@mattsse mattsse added A-observability Related to tracing, metrics, logs and other observability tools and removed C-bug An unexpected or incorrect behavior S-needs-triage This issue needs to be labelled labels Feb 28, 2024
@emhane
Copy link
Member

emhane commented Feb 28, 2024

nice, attack attempt caught in logs that wasn't caught before :) peer sending us txns we didn't request, hence why message is empty at this point. issue exists to report these peers I think otherwise will make one. will downgrade to trace.

@emhane emhane mentioned this issue Feb 28, 2024
Merged
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@emhane emhane

Labels
A-observability Related to tracing, metrics, logs and other observability tools
Projects
Reth Tracker
Archived in project
Milestone
No milestone
Development

Successfully merging a pull request may close this issue.

Downgrade all logs in validation to trace paradigmxyz/reth
4 participants
@shekhirin @mattsse @emhane @krakovia-evm