Skip to content

Rare bug where Shisui answers discv5 findnode request 40s after sending a bunch of offer requests #1742

Open
@KolbyML

Description

@KolbyML
2025-04-02T03:47:44.903215Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=a0a45f17adb17863
2025-04-02T03:47:47.868265Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=2b21550640dc470f
2025-04-02T03:47:49.075744Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=73c263ec66b2958f
2025-04-02T03:47:50.125255Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=1cdc06daa5be95c2
2025-04-02T03:47:54.018584Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=59320d243b45754c
2025-04-02T03:47:54.380722Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=878b0bac7d621e5f
2025-04-02T03:47:54.667046Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=fc644b31ce320154
2025-04-02T03:47:58.777791Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=c1825ab4e723fa3f
2025-04-02T03:47:59.189228Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=ead9ecae858a9e53
2025-04-02T03:47:59.699927Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=27ee411ecb58ef73
2025-04-02T03:48:02.821115Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=fff2ed9609b4073d
2025-04-02T03:48:07.585077Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=164431e94bf08987
2025-04-02T03:48:07.791280Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=f2102a5af97d9f13
2025-04-02T03:48:09.125354Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=4e658f5471af6d9b
2025-04-02T03:48:11.675193Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=3a2e8e6a358618fd
2025-04-02T03:48:13.807893Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=1cc3d2313c34bc45
2025-04-02T03:48:15.566157Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=87f7db32db400640
2025-04-02T03:48:15.735279Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=319817c6cae0350c
2025-04-02T03:48:15.950217Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=f15396f568dacb4c
2025-04-02T03:48:16.455129Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=3f90e9368db9a1d7
2025-04-02T03:48:20.664254Z ERROR trin_state::events: Error processing portal state request, responding with empty TALKRESP error=Error while building accept message: handle_offer: unable to find ENR for NodeId: source=0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749 request.discv5.id=b3bf4b3f0df58211
2025-04-02T03:48:24.599697Z ERROR portalnet::discovery: session established enr=Enr { id: Some("v4"), seq: 1743471933652, NodeId: 0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749, signature: "58589965efd506fec9045410919163d1191de6268fe0010886fa5419256f0d5f26f772dfe20e9ab1a38941dbc5c33fbd02936ad2fb4000c9b5240442e85e686e", IpV4 UDP Socket: Some(65.109.69.98:29013), IpV6 UDP Socket: None, IpV4 TCP Socket: None, IpV6 TCP Socket: None, Other Pairs: [("c", "86736869737569"), ("secp256k1", "a1022b7d454bfea1a9121fc118dad923b301e392d27ff4832eb30e1e2a5237661d1a")], .. } addr=65.109.69.98:29013
2025-04-02T03:48:24.599752Z ERROR portalnet::discovery: node address cached addr=(Enr { id: Some("v4"), seq: 1743471933652, NodeId: 0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749, signature: "58589965efd506fec9045410919163d1191de6268fe0010886fa5419256f0d5f26f772dfe20e9ab1a38941dbc5c33fbd02936ad2fb4000c9b5240442e85e686e", IpV4 UDP Socket: Some(65.109.69.98:29013), IpV6 UDP Socket: None, IpV4 TCP Socket: None, IpV6 TCP Socket: None, Other Pairs: [("c", "86736869737569"), ("secp256k1", "a1022b7d454bfea1a9121fc118dad923b301e392d27ff4832eb30e1e2a5237661d1a")], .. }, 65.109.69.98:29013)
2025-04-02T03:49:46.821373Z ERROR portalnet::discovery: session established enr=Enr { id: Some("v4"), seq: 1743471933652, NodeId: 0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749, signature: "58589965efd506fec9045410919163d1191de6268fe0010886fa5419256f0d5f26f772dfe20e9ab1a38941dbc5c33fbd02936ad2fb4000c9b5240442e85e686e", IpV4 UDP Socket: Some(65.109.69.98:29013), IpV6 UDP Socket: None, IpV4 TCP Socket: None, IpV6 TCP Socket: None, Other Pairs: [("c", "86736869737569"), ("secp256k1", "a1022b7d454bfea1a9121fc118dad923b301e392d27ff4832eb30e1e2a5237661d1a")], .. } addr=65.109.69.98:29013
2025-04-02T03:49:46.821430Z ERROR portalnet::discovery: cached node address updated old=(Enr { id: Some("v4"), seq: 1743471933652, NodeId: 0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749, signature: "58589965efd506fec9045410919163d1191de6268fe0010886fa5419256f0d5f26f772dfe20e9ab1a38941dbc5c33fbd02936ad2fb4000c9b5240442e85e686e", IpV4 UDP Socket: Some(65.109.69.98:29013), IpV6 UDP Socket: None, IpV4 TCP Socket: None, IpV6 TCP Socket: None, Other Pairs: [("c", "86736869737569"), ("secp256k1", "a1022b7d454bfea1a9121fc118dad923b301e392d27ff4832eb30e1e2a5237661d1a")], .. }, 65.109.69.98:29013) new=(Enr { id: Some("v4"), seq: 1743471933652, NodeId: 0x9e019b690d7a097894200bb8f2b7dd69d5438cb9c26a3eadb698ba51623d9749, signature: "58589965efd506fec9045410919163d1191de6268fe0010886fa5419256f0d5f26f772dfe20e9ab1a38941dbc5c33fbd02936ad2fb4000c9b5240442e85e686e", IpV4 UDP Socket: Some(65.109.69.98:29013), IpV6 UDP Socket: None, IpV4 TCP Socket: None, IpV6 TCP Socket: None, Other Pairs: [("c", "86736869737569"), ("secp256k1", "a1022b7d454bfea1a9121fc118dad923b301e392d27ff4832eb30e1e2a5237661d1a")], .. }, 65.109.69.98:29013)

Image

Image

I can no longer replicate this issue. This problem would affect rollout of protocol versions as we would require Enr's but currently a lot of our code assumes we have access to a nodes Enr. Hopefully in the future we can figure out what this problem is, but it seems fairly low priority for the time being.

Metadata

Metadata

Assignees

No one assigned

    Labels

    bugSomething isn't working

    Type

    No type

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions