Fatal error on close

[jsign]

Version: ntwk-calibration-8.8.0

When Ctrl+C got a fatal error:

2020-08-10T10:17:43.619-0300    INFO     pubsub  go-libp2p-pubsub@v0.3.4-0.20200731161531-2b5243c72f0d/comm.go:52        error reading rpc from 12D3KooWRTUDGrXYe1ZV7whKKdhCKbWyjTe67cg7x8JfbPgAjGPR: stream reset
2020-08-10T10:17:43.619-0300    INFO     pubsub  go-libp2p-pubsub@v0.3.4-0.20200731161531-2b5243c72f0d/comm.go:52        error reading rpc from 12D3KooWE56bGwGaQEVbeeCPJimA78EnJ7y7zkWbM8h6pqYYfiaj: stream reset
2020-08-10T10:17:43.619-0300    INFO     pubsub  go-libp2p-pubsub@v0.3.4-0.20200731161531-2b5243c72f0d/comm.go:52        error reading rpc from 12D3KooWCJPoFUvsvKcyqTyZhNXRobSrU2tNqZPwB5HVHCrMkLMk: stream reset
2020-08-10T10:17:43.619-0300    INFO     pubsub  go-libp2p-pubsub@v0.3.4-0.20200731161531-2b5243c72f0d/comm.go:52        error reading rpc from 12D3KooWE2HM4JQbwzy9cx9NYj3TfkDyhEC2Dg3JMMyCEoUTtL1S: stream reset
2020-08-10T10:17:43.619-0300    INFO     pubsub  go-libp2p-pubsub@v0.3.4-0.20200731161531-2b5243c72f0d/comm.go:52        error reading rpc from 12D3KooWMNQCLZBdWdTC57WPQJRvdaNkxix1fjvtFZT1DcJzXycu: stream reset
2020-08-10T10:17:43.628-0300    INFO     badger  v2@v2.0.1-rc1.0.20200716180832-3ab515320794/levels.go:975       Got compaction priority: {level:0 score:1.73 dropPrefixes:[]}
2020-08-10T10:17:43.653-0300    WARN     vm      vm/vm.go:447    Send actor error        {"from": "t3vgy3t6m5ewacbeuschfpgazsqfq4rh7q6c3hxo5fowl3l5usw7kwpq3w76jeh36yiqnqpspaejnehva27nwq", "to": "t3w4hmn557jzxmqnamcneifb4ktktgeomfsgnugmgi5wjznqzfiqzw7wohvv6szpmlg4e7kqudnpsicowvopoq", "nonce": 1, "method": "0", "height": "4047", "error": "failed to transfer funds (RetCode=6):\n    github.com/filecoin-project/lotus/chain/vm.(*VM).send.func2\n        /Users/ignaciohagopian/code/lotus/chain/vm/vm.go:261\n  - transfer failed when deducting funds (9999 FIL): not enough funds (RetCode=6):\n    github.com/filecoin-project/lotus/chain/vm.(*VM).transfer\n        /Users/ignaciohagopian/code/lotus/chain/vm/vm.go:762"}
2020-08-10T10:17:43.681-0300    INFO     badger  v2@v2.0.1-rc1.0.20200716180832-3ab515320794/levels.go:975       Got compaction priority: {level:0 score:1.73 dropPrefixes:[]}
2020-08-10T10:17:43.873-0300    INFO     badger  v2@v2.0.1-rc1.0.20200716180832-3ab515320794/levels.go:975       Got compaction priority: {level:0 score:1.73 dropPrefixes:[]}
2020-08-10T10:17:43.873-0300    INFO     badger  v2@v2.0.1-rc1.0.20200716180832-3ab515320794/levels.go:991       Running for level: 0

2020-08-10T10:17:50.838-0300    INFO     badger  v2@v2.0.1-rc1.0.20200716180832-3ab515320794/levels.go:953       LOG Compact 0->1, del 8 tables, add 7 tables, took 6.964479023s

2020-08-10T10:17:50.838-0300    INFO     badger  v2@v2.0.1-rc1.0.20200716180832-3ab515320794/levels.go:1000      Compaction for level: 0 DONE
2020-08-10T10:17:50.838-0300    INFO     badger  v2@v2.0.1-rc1.0.20200716180832-3ab515320794/db.go:537   Force compaction on level 0 done
2020-08-10T10:17:50.936-0300    WARN     vm      vm/runtime.go:170       VM.Call failure: failed to get cbor object bafy2bzacecchvwp6zdazzg4hau6spafx4rtsmle3esi2kvupiwlkchsgsvfkk: failed to get block from blockstore (FATAL): datastore closed (FATAL):
    github.com/filecoin-project/lotus/chain/vm.(*Runtime).Get
        /Users/ignaciohagopian/code/lotus/chain/vm/runtime.go:148
2020-08-10T10:17:50.936-0300    WARN     main    lotus/rpc.go:80 Graceful shutdown successful
2020-08-10T10:17:50.936-0300    WARN     vm      vm/runtime.go:170       VM.Call failure: failed to get cbor object bafy2bzacecchvwp6zdazzg4hau6spafx4rtsmle3esi2kvupiwlkchsgsvfkk: failed to get block from blockstore (FATAL): datastore closed (FATAL):
    github.com/filecoin-project/lotus/chain/vm.(*Runtime).Get
        /Users/ignaciohagopian/code/lotus/chain/vm/runtime.go:148
2020-08-10T10:17:50.936-0300    WARN     vm      vm/runtime.go:170       VM.Call failure: failed to get cbor object bafy2bzacecchvwp6zdazzg4hau6spafx4rtsmle3esi2kvupiwlkchsgsvfkk: failed to get block from blockstore (FATAL): datastore closed (FATAL):
    github.com/filecoin-project/lotus/chain/vm.(*Runtime).Get
        /Users/ignaciohagopian/code/lotus/chain/vm/runtime.go:148
2020-08-10T10:17:50.937-0300    INFO     chain   chain/sync.go:644       block validation        {"took": 7.372490598, "height": "4048"}
2020-08-10T10:17:50.937-0300    INFO     chain   chain/sync.go:644       block validation        {"took": 7.372423004, "height": "4048"}
2020-08-10T10:17:50.937-0300    INFO     chain   chain/sync.go:644       block validation        {"took": 7.372659328, "height": "4048"}
2020-08-10T10:17:50.937-0300    INFO     chain   chain/sync.go:644       block validation        {"took": 7.372473425, "height": "4048"}
2020-08-10T10:17:50.938-0300    ERROR    chain   chain/sync.go:1384      failed to validate tipset: validating block bafy2bzacecu7p6pyp2fhbb6gtbor24rksolh4j5aulz534wal5rzacu5qebge:
    github.com/filecoin-project/lotus/chain.(*Syncer).ValidateTipSet.func1
        /Users/ignaciohagopian/code/lotus/chain/sync.go:559
  - get tipsetstate(4048, [bafy2bzacedvywd7entjmsflwmxanyix32zyjlkwwwwotkel6agq7qy2y7vtw4]) failed:
    github.com/filecoin-project/lotus/chain.(*Syncer).ValidateBlock
        /Users/ignaciohagopian/code/lotus/chain/sync.go:728
  - failed to get cbor object bafy2bzacecchvwp6zdazzg4hau6spafx4rtsmle3esi2kvupiwlkchsgsvfkk: failed to get block from blockstore (FATAL): datastore closed (FATAL):
    github.com/filecoin-project/lotus/chain/vm.(*Runtime).Get
        /Users/ignaciohagopian/code/lotus/chain/vm/runtime.go:148
2020-08-10T10:17:50.938-0300    ERROR    chain   chain/sync_manager.go:389       sync error: collectChain failed:
    github.com/filecoin-project/lotus/chain.(*Syncer).Sync
        /Users/ignaciohagopian/code/lotus/chain/sync.go:509
  - collectChain syncMessages:
    github.com/filecoin-project/lotus/chain.(*Syncer).collectChain
        /Users/ignaciohagopian/code/lotus/chain/sync.go:1546
  - message processing failed:
    github.com/filecoin-project/lotus/chain.(*Syncer).syncMessagesAndCheckState.func1
        /Users/ignaciohagopian/code/lotus/chain/sync.go:1385
  - validating block bafy2bzacecu7p6pyp2fhbb6gtbor24rksolh4j5aulz534wal5rzacu5qebge:
    github.com/filecoin-project/lotus/chain.(*Syncer).ValidateTipSet.func1
        /Users/ignaciohagopian/code/lotus/chain/sync.go:559
  - get tipsetstate(4048, [bafy2bzacedvywd7entjmsflwmxanyix32zyjlkwwwwotkel6agq7qy2y7vtw4]) failed:
    github.com/filecoin-project/lotus/chain.(*Syncer).ValidateBlock
        /Users/ignaciohagopian/code/lotus/chain/sync.go:728
  - failed to get cbor object bafy2bzacecchvwp6zdazzg4hau6spafx4rtsmle3esi2kvupiwlkchsgsvfkk: failed to get block from blockstore (FATAL): datastore closed (FATAL):
    github.com/filecoin-project/lotus/chain/vm.(*Runtime).Get
        /Users/ignaciohagopian/code/lotus/chain/vm/runtime.go:148

[schomatis]

Related to #2572. Different errors but the potential solution to both could be unified.

[magik6k]

Well, those aren't panics, just aborted VM execution, with very loud logs

[rjan90]

Hi

Thanks for the report. The issue is outdated, so we are closing it for now. If this is a issue in the current release - please open a new ticket.

Thank you !