iroha icon indicating copy to clipboard operation
iroha copied to clipboard

[BUG] "Failed to create a snapshot of state" inside docker compose

Open dima74 opened this issue 1 year ago • 1 comments

OS and Environment

Linux

GIT commit hash

4779723cddfe64eccaec375f0cb60b9a6277e994

Minimum working example / Steps to reproduce

docker compose -f configs/swarm/docker-compose.single.yml up

Update: also can be reproduced using tests can_read_snapshot_after_writing and creates_all_dirs_while_writing_snapshots.

Actual result

Observe errors in the log:

ERROR iroha_core::snapshot: Failed to create a snapshot of state error=Error (de)serializing World State View snapshot

(Actual JSON deserialization error is Error("EOF while parsing a value", line: 1, column: 0))

Expected result

Not sure whether it is a bug, or I did something wrong

Logs

Log contents
% docker compose -f configs/swarm/docker-compose.single.yml up
WARN[0000] /home/dima/soramitsu/iroha/configs/swarm/docker-compose.single.yml: `version` is obsolete 
[+] Running 1/0
✔ Container swarm-irohad0-1  Created                                                                                                                                 0.0s 
Attaching to irohad0-1
irohad0-1  | 2024-05-30T10:17:54.056850Z  INFO irohad: Hyperledgerいろは2にようこそ!(translation) Welcome to Hyperledger Iroha! version="2.0.0-pre-rc.21" git_commit_sha="4779723c"
irohad0-1  | 2024-05-30T10:17:54.056927Z  INFO init:start{listen_addr=WithOrigin { value: 0.0.0.0:1337, origin: Env { id: ParameterId(network.address), var: "P2P_ADDRESS" } } idle_timeout=60s}: iroha_p2p::network: Network bound to listener
irohad0-1  | 2024-05-30T10:17:54.057706Z  INFO init:kura_init: iroha_core::kura: Kura init complete mode=Strict block_count=0
irohad0-1  | 2024-05-30T10:17:54.057758Z  INFO init: irohad: Didn't find a state snapshot; creating an empty state
irohad0-1  | 2024-05-30T10:17:54.058445Z  INFO init: irohad: Telemetry not started due to absent configuration
irohad0-1  | 2024-05-30T10:17:54.058566Z  INFO iroha_core::sumeragi: Sumeragi has finished loading blocks and setting up the state
irohad0-1  | 2024-05-30T10:17:54.058682Z  INFO irohad: Starting Iroha
irohad0-1  | 2024-05-30T10:17:54.651617Z  INFO consensus: iroha_core::sumeragi::main_loop: Genesis block created role=Leader block_hash=3d3d358818971d0087e3435750af1c863f359925e90cad1f6b64016c27eb4459
irohad0-1  | 2024-05-30T10:17:54.652298Z  INFO consensus: iroha_core::sumeragi::main_loop: Committing block addr=0.0.0.0:1337 role=Leader block_height=1 block_hash=3d3d358818971d0087e3435750af1c863f359925e90cad1f6b64016c27eb4459
irohad0-1  | 2024-05-30T10:17:54.654943Z  INFO consensus: iroha_core::sumeragi::main_loop: Sumeragi initialized addr=0.0.0.0:1337 role_in_next_round=Leader
irohad0-1  | 2024-05-30T10:17:56.096497Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49904}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:17:56.096549Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49904}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:17:58.146109Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49912}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:17:58.146144Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49912}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:00.186096Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49924}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:00.186129Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49924}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:02.220453Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49930}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:02.220489Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49930}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:04.257849Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49934}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:04.257888Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:49934}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:06.296155Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53258}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:06.296196Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53258}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:08.333482Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53260}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:08.333518Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53260}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:10.368766Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53264}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:10.368799Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53264}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:12.405990Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53268}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:12.406026Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53268}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:14.439918Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53272}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:14.439951Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:53272}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:16.477117Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50694}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:16.477150Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50694}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:18.521004Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50704}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:18.521043Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50704}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:20.563972Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50716}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:20.564005Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50716}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:22.600737Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50724}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:22.600772Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50724}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:24.633796Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50736}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:24.633829Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:50736}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:26.665159Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46728}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:26.665192Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46728}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:28.702917Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46738}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:28.702954Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46738}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:30.735991Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46740}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:30.736026Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46740}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:32.777135Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46752}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:32.777167Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46752}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:34.814094Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46760}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:34.814126Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:46760}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:36.846670Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:56994}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:36.846704Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:56994}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:38.886773Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57006}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:38.886808Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57006}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:40.924832Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57022}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:40.924867Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57022}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:42.964177Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57032}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:42.964210Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57032}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:45.005753Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57036}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:45.005786Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:57036}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:47.050802Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44208}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:47.050836Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44208}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:49.084843Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44210}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:49.084878Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44210}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:51.121038Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44212}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:51.121073Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44212}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:53.153087Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44226}: warp::filters::trace: processing request
irohad0-1  | 2024-05-30T10:18:53.153120Z  INFO request{method=GET path=/status/blocks version=HTTP/1.1 remote.addr=127.0.0.1:44226}: warp::filters::trace: finished processing with success status=200
irohad0-1  | 2024-05-30T10:18:54.061181Z ERROR iroha_core::snapshot: Failed to create a snapshot of state error=Error (de)serializing World State View snapshot

Who can help to reproduce?

No response

Notes

No response

dima74 avatar May 30 '24 10:05 dima74

Should be solved by #4692.

Erigara avatar Jun 05 '24 12:06 Erigara