core-rs-albatross icon indicating copy to clipboard operation
core-rs-albatross copied to clipboard

Could not parse request type ID

Open styppo opened this issue 2 years ago • 5 comments

CI run: #2244 Job: LowViewChangeDelay Node: validator1-validator4, spammer Logs: 2244 LowViewChangeDelay.zip

2022-04-26T20:44:41.120032Z ERROR network              | [Request ID 6527] Could not parse request type ID, swarm task{peer_id=PeerId("12D3KooWMBzxH8EdKT7mGwjftCuW3gN6fvACfx43Mg6J3tRt9iqc")}
2022-04-26T20:44:41.120239Z ERROR network              | [Request ID 6529] Could not parse request type ID, swarm task{peer_id=PeerId("12D3KooWMBzxH8EdKT7mGwjftCuW3gN6fvACfx43Mg6J3tRt9iqc")}
2022-04-26T20:44:41.120442Z ERROR network              | [Request ID 6530] Could not parse request type ID, swarm task{peer_id=PeerId("12D3KooWMBzxH8EdKT7mGwjftCuW3gN6fvACfx43Mg6J3tRt9iqc")}
2022-04-26T20:44:41.120639Z ERROR network              | [Request ID 6531] Could not parse request type ID, swarm task{peer_id=PeerId("12D3KooWMBzxH8EdKT7mGwjftCuW3gN6fvACfx43Mg6J3tRt9iqc")}
2022-04-26T20:44:41.120849Z ERROR network              | [Request ID 6532] Could not parse request type ID, swarm task{peer_id=PeerId("12D3KooWMBzxH8EdKT7mGwjftCuW3gN6fvACfx43Mg6J3tRt9iqc")}
2022-04-26T20:44:41.121042Z ERROR network              | [Request ID 6536] Could not parse request type ID, swarm task{peer_id=PeerId("12D3KooWMBzxH8EdKT7mGwjftCuW3gN6fvACfx43Mg6J3tRt9iqc")}

styppo avatar Apr 28 '22 08:04 styppo

Unfortunately we are not logging the sender peer_id so we have no information on which request was this actually coming from. #809 changes this.

jsdanielh avatar Apr 29 '22 00:04 jsdanielh

Woops, accidental autoclose.

hrxi avatar May 11 '22 10:05 hrxi

Apparently hasn't happened for the last two weeks, hard to debug.

hrxi avatar May 12 '22 13:05 hrxi

Found by @styppo:

CI run #2488 Job: Validators90sDown Nodes: validator1-validator4 Logs: 2488.Validators90sDown.zip

Unfortunately, it doesn't contain raw bytes, so I guess I put the log messages in the wrong place. :(

hrxi avatar May 16 '22 13:05 hrxi

type request_id=3949 peer_id=12D3KooWP1UMMZ7HEYbXxd2MCJuTsghPcdpqaMGZePuyPyDLiWYb , swarm task{peer_id=PeerId("12D3KooWAqmPywkWjxde8U2y9Z2ztp97Gzp52Fpcvv7bH6ysZeRL")}

It does contain the raw bytes, but in a weird place. It's affected by #845, but the message is still included in the logs, it's directly before the comma before swarm task{peer_id=Pe…, i.e. all the messages that failed parsing like this were actually empty.

hrxi avatar May 16 '22 14:05 hrxi