helium/blockchain-core

new, not_on_controlling_process when loading snapshot

ci-work opened this issue · 1 comments

after upgrading core to latest master, on start up and trying to get a blessed_snapshot encounter the error:

log file:

>@blockchain_worker:do_snap_source_download:1195 snap written to scratch file "data/snap/snap-1156321.scratch"
2021-12-29 21:36:31.245 [info] <0.1241.0>@blockchain_worker:start_snapshot_sync:1074 Successfully saved snap to disk in "data/snap/snap-1156321"
2021-12-29 21:36:31.246 [info] <0.1241.0>@blockchain_worker:attempt_load_snapshot_from_disk:1219 Stored snap 1156270 - attempting install
2021-12-29 21:36:31.246 [info] <0.1182.0>@blockchain_worker:handle_call:428 installing snapshot <<71,246,182,92,7,238,69,189,96,238,247,29,125,127,40,211,110,45,249,199,35,227,113,162,226,11,44,252,143,49,135,208>>
2021-12-29 21:36:31.248 [info] <0.1182.0>@blockchain_ledger_snapshot_v1:print_memory:617 memory {total_heap_size,2586} 806848
2021-12-29 21:36:31.574 [info] <0.1182.0>@blockchain_ledger_snapshot_v1:load_into_ledger:544 loading snapshot into delayed ledger
2021-12-29 21:36:31.574 [info] <0.1182.0>@blockchain_ledger_snapshot_v1:print_memory:617 memory {total_heap_size,4185} 809776
2021-12-29 21:36:31.575 [error] <0.1182.0> gen_server blockchain_worker terminated with reason: not_on_controlling_process in prim_file:get_fd_data/1
2021-12-29 21:36:31.575 [error] <0.1182.0> CRASH REPORT Process blockchain_worker with 0 neighbours crashed with reason: not_on_controlling_process in prim_file:get_fd_data/1
2021-12-29 21:36:31.575 [warning] <0.1180.0>@blockchain_event:terminate:108 terminating remove_handler
2021-12-29 21:36:31.575 [error] <0.1126.0> Supervisor blockchain_sup had child blockchain_worker started with blockchain_worker:start_link([{port,0},{base_dir,"data"},{update_dir,"update"}]) at <0.1182.0> exit with reason not_on_controlling_process in prim_file:get_fd_data/1 in context child_terminated
2021-12-29 21:36:31.575 [error] <0.1241.0>@blockchain_worker:start_snapshot_sync:1085 snapshot download or loading failed because {{not_on_controlling_process,[{prim_file,get_fd_data,1,[]},{prim_file,position_1,3,[]},{prim_file,position,2,[]},{blockchain_ledger_snapshot_v1,deserialize_field,2,[{file,"/var/sites/blockchain-node/_build/default/lib/blockchain/src/ledger/v1/blockchain_ledger_snapshot_v1.erl"},{line,1516}]},{blockchain_ledger_snapshot_v1,load_into_ledger_,3,[{file,"/var/sites/blockchain-node/_build/default/lib/blockchain/src/ledger/v1/blockchain_ledger_snapshot_v1.erl"},{line,610}]},{blockchain_ledger_snapshot_v1,load_into_ledger,3,[{file,"/var/sites/blockchain-node/_build/default/lib/blockchain/src/ledger/v1/blockchain_ledger_snapshot_v1.erl"},{line,556}]},{blockchain_ledger_snapshot_v1,'-import/5-lc$^0/1-0-',3,[{file,"/var/sites/blockchain-node/_build/default/lib/blockchain/src/ledger/v1/blockchain_ledger_snapshot_v1.erl"},{line,505}]},{blockchain_ledger_snapshot_v1,import,5,[{file,"/var/sites/blockchain-node/_build/default/lib/blockchain/src/ledger/v1/blockchain_ledger_snapshot_v1.erl"},{line,506}]}]},{gen_server,call,[blockchain_worker,{install_snapshot,1156270,<<71,246,182,92,7,238,69,189,96,238,247,29,125,127,40,211,110,45,249,199,35,227,113,162,226,11,44,252,143,49,135,208>>,#{state_channels => {{file_descriptor,prim_file,#{handle => #Ref<0.968084152.1237188637.44243>,owner => <0.1241.0>,r_ahead_size => 0,r_buffer => #Ref<0.968084152.1237188619.46685>}},293730397,7849},htlcs => {{file_descriptor,prim_file,#{handle => #Ref<0.968084152.1237188637.44243>,owner => <0.1241.0>,r_ahead_size => 0,r_buffer => #Ref<0.968084152.1237188619.46685>}},220359441,2235},validators => {{file_descriptor,prim_file,#{handle => #Ref<0.968084152.1237188637.44243>,owner => <0.1241.0>,r_ahead_size => 0,r_buffer => #Ref<0.968084152.1237188619.46685>}},293738805,1143689},vars_nonce => {{file_descriptor,prim_file,#{handle => #Ref<0.968084152.1237188637.44243>,owner => <0.1241.0>,r_ahead_size => 0,r_buffer => #Ref<0.968084152.1237188619.46685>}},298218779,3},multi_keys => {{file_descriptor,prim_file,...},...},...},...},...]}}: [{gen_server,call,3,[{file,"gen_server.erl"},{line,223}]},{blockchain_worker,'-start_snapshot_sync/4-fun-0-',6,[{file,"/var/sites/blockchain-node/_build/default/lib/blockchain/src/blockchain_worker.erl"},{line,1078}]}]
2021-12-29 21:36:31.575 [info] <0.1241.0>@blockchain_worker:attempt_fetch_p2p_snapshot:1098 attempting snapshot sync with "/p2p/1188FwNE5Wwe3AKAMFwGcjiJRNnK9f8duBP69vmvfKTKSKVuN38"
2021-12-29 21:36:31.576 [warning] <0.1180.0>@blockchain_event:terminate:108 terminating remove_handler
2021-12-29 21:36:31.576 [info] <0.1471.0>@blockchain_worker:init:344 blockchain_worker init with [{port,0},{base_dir,"data"},{update_dir,"update"}]
2021-12-29 21:36:31.576 [error] <0.1471.0>@blockchain_worker:init:380 CRASH REPORT Process <0.1471.0> with 0 neighbours crashed with reason: no match of right hand value false in blockchain_worker:init/1 line 380
2021-12-29 21:36:31.576 [error] <0.1126.0>@blockchain_worker:init:380 Supervisor blockchain_sup had child blockchain_worker started with blockchain_worker:start_link([{port,0},{base_dir,"data"},{update_dir,"update"}]) at undefined exit with reason no match of right hand value false in blockchain_worker:init/1 line 380 in context start_error

notes: encountered using blockchain-node, and tried with multiple blessed_snapshots, same error on all, fresh install. After rolling back to previous commit the error is not ecountered.

relevant commit:
2b8231f

pull request:
#1175

tested, and confirmed fixed