vocdoni / vocdoni-node

A set of libraries and tools for the Vocdoni decentralized backend infrastructure, the main ground of our universally verifiable, privacy-centric and scalable digital voting protocol
GNU Affero General Public License v3.0
86 stars 16 forks source link

cometBFT crashed with recheck cursor is not nil before resCbFirstTime #1239

Open p4u opened 8 months ago

p4u commented 8 months ago

On vocdoni-node branch dev, using cometbft v1.0.0-alpha.1

2024-01-16T13:11:22.576Z ERR vochain/cometbft.go:216 > checkTx error="voteTx: process 63f57be98f80079bd064d886b7198f4a4c110a17a8f8f8f8c532020000000000 not in READY state - current state: RESULTS"
2024-01-16T13:11:22.59Z INF vochain status blockPeriod="10m:12.614s 1h:10.895s 24h:10.424s" blocksMinute=6.00 elections=85 height=10019 mempool=7990 peers=4 voteCache=15976 votes=64558 votes/min=0
2024-01-16T13:11:24.223Z WRN transaction/vote_tx.go:67 > deprecated block count based vote detected process=63f57be98f805e3c7cfb4535c3a7b612ca4a64892478b9765c14020000000000
2024-01-16T13:11:24.223Z ERR vochain/cometbft.go:216 > checkTx error="voteTx: process 63f57be98f805e3c7cfb4535c3a7b612ca4a64892478b9765c14020000000000 not in READY state - current state: ENDED"
2024-01-16T13:11:24.404Z INF api/censuses.go:306 > adding participants to census census=885afa81627066761c521e1c81f7eae7f871e9802197a0605bae4d107d4da004 count=1
2024-01-16T13:11:24.668Z INF ipfs/ipfs.go:180 > published file cid=bafybeieivpqlwppcwfjezjumnm4s6ozouzvz2grytdbtgr4mrk2uwkpyom protocol=ipfs size=0
2024-01-16T13:11:26.125Z WRN transaction/election_tx.go:63 > deprecated block count based new process detected id=
panic: recheck cursor is not nil before resCbFirstTime

goroutine 984026 [running]:
github.com/cometbft/cometbft/mempool.(*CListMempool).globalCb(0xc001c31ba0, 0xc000600000?, 0xc0119eadd0)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:314 +0x145
github.com/cometbft/cometbft/abci/client.(*localClient).callback(0xc0007c8580?, 0x40?, 0x36e9de0?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:64 +0x27
github.com/cometbft/cometbft/abci/client.(*localClient).CheckTxAsync(0xc004277b00, {0x453add8?, 0x6043ec0?}, 0xc01c33d460)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:57 +0x1e6
github.com/cometbft/cometbft/proxy.(*appConnMempool).CheckTxAsync(0xc002cc2768, {0x453add8, 0x6043ec0}, 0xc01c33d440?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/proxy/app_conn.go:148 +0x16d
github.com/cometbft/cometbft/mempool.(*CListMempool).CheckTx(0xc001c31ba0, {0xc0126143c0, 0x133, 0x135})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:293 +0x426
github.com/cometbft/cometbft/rpc/core.(*Environment).BroadcastTxSync(0xc002336a00, 0xc002ba8b20, {0xc0126143c0, 0x133, 0x135})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/core/mempool.go:43 +0xa8
github.com/cometbft/cometbft/rpc/client/local.(*Local).BroadcastTxSync(...)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/client/local/local.go:98
go.vocdoni.io/dvote/vochain.(*BaseApplication).SetDefaultMethods.func4({0xc0126143c0?, 0x133, 0x3b?})
    go.vocdoni.io/dvote/vochain/appsetup.go:64 +0x4e
go.vocdoni.io/dvote/vochain.(*BaseApplication).SendTx(0x24?, {0xc0126143c0?, 0x24?, 0x1b8?})
    go.vocdoni.io/dvote/vochain/app.go:339 +0x2a
go.vocdoni.io/dvote/api.(*API).sendTx(0xc01dd95ec0?, {0xc0126143c0?, 0xc00dcd28c0?, 0x42?})
    go.vocdoni.io/dvote/api/helpers.go:40 +0x2b
go.vocdoni.io/dvote/api.(*API).electionCreateHandler(0xc00dde2320, 0xc01dd66240, 0x10000c00ffe2f58?)
    go.vocdoni.io/dvote/api/elections.go:496 +0x2c8
go.vocdoni.io/dvote/httprouter/apirest.(*API).RegisterMethod.func1({{0x3619160, 0xc01dd66240}, {0xc161bdff876e01d4, 0xfe4a1c8f2d, 0x600bfa0}, {0xc01dd66280, 0x2, 0x2}, 0xc01c33d380})
    go.vocdoni.io/dvote/httprouter/apirest/apirest.go:231 +0x6b
created by go.vocdoni.io/dvote/httprouter.(*HTTProuter).AddPublicHandler.(*HTTProuter).routerHandler.func1 in goroutine 984037
    go.vocdoni.io/dvote/httprouter/httprouter.go:283 +0x3c5
p4u commented 8 months ago

More... we are trying to identify what's the action that trigers this panic.

2024-01-29T12:16:41.213Z DBG vochain/app.go:206 > commit block height=117570 txs=1
2024-01-29T12:16:41.213Z DBG indexer/vote.go:116 > finalize results endDate="2024-01-29 12:16:30 +0000 UTC" height=117570 processID=63f57be98f8035c7623f6d399ce6ff150699f5da635ea23b82d6020000000000
2024-01-29T12:16:41.213Z DBG indexer/indexer.go:397 > updated process processID=63f57be98f8035c7623f6d399ce6ff150699f5da635ea23b82d6020000000000
2024-01-29T12:16:41.213Z DBG indexer/indexer.go:397 > updated process processID=63f57be98f8090974fda6d57c41da637a1f53c53fae2e040e38e020000000000
2024-01-29T12:16:41.222Z INF indexer/indexer.go:511 > add live votes to results block=117570 newVotes=1 overwritedVotes=0
2024-01-29T12:16:41.224Z ERR vochain/cometbft.go:216 > checkTx error="voteTx: process 63f57be98f80ae5d505a0661393472636bb1b85f6d2668051fb5020000000000 finished at time 2024-01-29 12:12:16 +0000 UTC, current time is 2024-01-29 12:16:30 +0000 UTC"
2024-01-29T12:16:42.032Z DBG httprouter/message.go:65 > response: (200) {"transactionNumber":66759,"transactionHash":"daa0c8c9eb9bb403d7b947aa2d851db51e4d16d3428eba82f663000245e4d84d","blockHeight":117570,"transactionIndex":0,"transactionType":"vote"}
2024-01-29T12:16:42.032Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/chain/transactions/reference/daa0c8c9eb9bb403d7b947aa2d851db51e4d16d3428eba82f663000245e4d84d HTTP/1.1" from 79.155.117.238:57992 - 200 180B in 367.339µs
2024-01-29T12:16:42.416Z INF vochain status blockPeriod="10m:10.454s 1h:10.43s 24h:10.401s" blocksMinute=5.00 elections=451 height=117569 mempool=4 peers=4 voteCache=6 votes=65559 votes/min=0
2024-01-29T12:16:42.833Z DBG httprouter/message.go:65 > response: (404) {"error":"account not found: 0x80Eb8F13bf5ee5Fe054B993dab03081a952c1994","code":4003}
2024-01-29T12:16:42.834Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x80Eb8F13bf5ee5Fe054B993dab03081a952c1994 HTTP/1.1" from 79.155.117.238:58006 - 404 86B in 371.085µs
2024-01-29T12:16:43.011Z DBG httprouter/message.go:65 > response: (404) {"error":"account not found: 0x80Eb8F13bf5ee5Fe054B993dab03081a952c1994","code":4003}
2024-01-29T12:16:43.012Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x80Eb8F13bf5ee5Fe054B993dab03081a952c1994/metadata HTTP/1.1" from 79.155.117.238:58018 - 404 86B in 716.161µs
2024-01-29T12:16:43.742Z DBG apirest/apirest.go:197 > request: {"payload":"eyJ2ZXJzaW9uIjoiMS4wIiwibGFuZ3VhZ2VzIjpbXSwibmFtZSI6eyJkZWZhdWx0IjoiIn0sImRlc2NyaXB0aW9uIjp7ImRlZmF1bHQiOiIifSwibmV3c0ZlZWQiOnsiZGVmYXVsdCI6IiJ9LCJtZWRpYSI6eyJhdmF0YXIiOiIiLCJoZWFkZXIiOiIiLCJsb2dvIjoiIn0sIm1ldGEiOnt9fQ=="}
2024-01-29T12:16:43.742Z DBG httprouter/message.go:65 > response: (200) {"cid":"ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q"}
2024-01-29T12:16:43.742Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/files/cid HTTP/1.1" from 79.155.117.238:58020 - 200 77B in 376.765µs
2024-01-29T12:16:43.953Z DBG apirest/apirest.go:197 > request: {"txPayload":"CukBSuYBCBcQABpCaXBmczovL2JhZnliZWlndjRtZm1uM3R5dXNid21za2ZuNnhob3l2djJpMnN2ZHE3cG5zNmRwaGRpdmVmcjYyazNxIhSA648Tv17l/gVLmT2rAwgalSwZlCpkCh8Impvp6AESFIDrjxO/XuX+BUuZPasDCBqVLBmUGPQDEkHApQ0CCbQP0voxEahKF+JkiMaH9SElNpfsGdKjwsoJgXtYPCmWKv4v+nOd7JY2zA5shmVgUud4ABmz3FhA97EoADogL5SDC3HIjPLA5ppAtUbkBGWaLp0tLIwki7fWH3pXlB0SQdMx++2nwIWJRIqGD7kCL6nH8czMO9jWyIgFQ8L0H2rWMBmgYZHjOhgpKe1PyulWdjymIBAy0rCmM14Jfjbl4o0b","metadata":"eyJ2ZXJzaW9uIjoiMS4wIiwibGFuZ3VhZ2VzIjpbXSwibmFtZSI6eyJkZWZhdWx0IjoiIn0sImRlc2NyaXB0aW9uIjp7ImRlZmF1bHQiOiIifSwibmV3c0ZlZWQiOnsiZGVmYXVsdCI6IiJ9LCJtZWRpYSI6eyJhdmF0YXIiOiIiLCJoZWFkZXIiOiIiLCJsb2dvIjoiIn0sIm1ldGEiOnt9fQ=="}
panic: recheck cursor is not nil before resCbFirstTime

goroutine 868226 [running]:
github.com/cometbft/cometbft/mempool.(*CListMempool).globalCb(0xc001f7be10, 0xc00008a800?, 0xc008a11800)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:314 +0x145
github.com/cometbft/cometbft/abci/client.(*localClient).callback(0xc003240000?, 0x40?, 0x36e9de0?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:64 +0x27
github.com/cometbft/cometbft/abci/client.(*localClient).CheckTxAsync(0xc0040214a0, {0x453aef8?, 0x6043ec0?}, 0xc00ec71620)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:57 +0x1e6
github.com/cometbft/cometbft/proxy.(*appConnMempool).CheckTxAsync(0xc004048b28, {0x453aef8, 0x6043ec0}, 0xc00ec71600?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/proxy/app_conn.go:148 +0x16d
github.com/cometbft/cometbft/mempool.(*CListMempool).CheckTx(0xc001f7be10, {0xc00f3e4b40, 0x12f, 0x12f})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:293 +0x426
github.com/cometbft/cometbft/rpc/core.(*Environment).BroadcastTxSync(0xc001b60a00, 0xc004022ea0, {0xc00f3e4b40, 0x12f, 0x12f})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/core/mempool.go:43 +0xa8
github.com/cometbft/cometbft/rpc/client/local.(*Local).BroadcastTxSync(...)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/client/local/local.go:98
go.vocdoni.io/dvote/vochain.(*BaseApplication).SetDefaultMethods.func4({0xc00f3e4b40?, 0x12f, 0x3b?})
    go.vocdoni.io/dvote/vochain/appsetup.go:64 +0x4e
go.vocdoni.io/dvote/vochain.(*BaseApplication).SendTx(0x24?, {0xc00f3e4b40?, 0x24?, 0xa3?})
    go.vocdoni.io/dvote/vochain/app.go:341 +0x2a
go.vocdoni.io/dvote/api.(*API).sendTx(0xc00f4187c0?, {0xc00f3e4b40?, 0xc012d34960?, 0x42?})
    go.vocdoni.io/dvote/api/helpers.go:40 +0x2b
go.vocdoni.io/dvote/api.(*API).accountSetHandler(0xc00c000b40, 0xc01012bda0, 0x0?)
    go.vocdoni.io/dvote/api/accounts.go:289 +0x2b8
go.vocdoni.io/dvote/httprouter/apirest.(*API).RegisterMethod.func1({{0x3619160, 0xc01012bda0}, {0xc16603aaf8d0e6d4, 0x1427de37ec0, 0x600bfa0}, {0xc01012bde0, 0x2, 0x2}, 0xc00ec71560})
    go.vocdoni.io/dvote/httprouter/apirest/apirest.go:231 +0x6b
created by go.vocdoni.io/dvote/httprouter.(*HTTProuter).AddPublicHandler.(*HTTProuter).routerHandler.func1 in goroutine 868169
    go.vocdoni.io/dvote/httprouter/httprouter.go:283 +0x3c5
p4u commented 8 months ago
2024-01-29T13:29:46.405Z DBG httprouter/message.go:65 > response: (200) {"type":"weighted","weight":"1","censusRoot":"e88d602e10379913b457dab11b5b14d8b309d8947f5192ac4b6a0c1e0460e199","censusProof":"25000100108c0ead929573f582b7d926e292782f540b6392d1960923d74979175a937adc85","value":"0100000000000000000000000000000000000000000000000000000000000000"}
2024-01-29T13:29:46.406Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/censuses/e88d602e10379913b457dab11b5b14d8b309d8947f5192ac4b6a0c1e0460e199/proof/A4547Aa8d230654485279200f2Afc81Db907173e HTTP/1.1" from 79.155.117.238:35920 - 200 279B in 584.646µs
2024-01-29T13:29:46.584Z DBG httprouter/message.go:65 > response: (200) {"chainId":"vocdoni/DEV/31","blockTime":[10296,10393,10413,10407,10402],"electionCount":700,"organizationCount":403,"genesisTime":"2024-01-12T01:00:00Z","height":117990,"syncing":false,"blockTimestamp":1706534971,"transactionCount":66954,"validatorCount":3,"voteCount":65550,"circuitVersion":"v1.0.0","maxCensusSize":100000,"networkCapacity":20000}
2024-01-29T13:29:46.584Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/chain/info HTTP/1.1" from 79.155.117.238:35926 - 200 349B in 2.227978ms
2024-01-29T13:29:46.792Z DBG apirest/apirest.go:197 > request: {"txPayload":"CsIBCr8BCiCM9y44UHtdon/STeBjnGdNienygmlZwf067fDZDJz6oRIgY/V76Y+An8/wxrhNi2RpxNzxeNDjdY0kMvUCAAAAADAaTTJLEiUlAAEAEIwOrZKVc/WCt9km4pJ4L1QLY5LRlgkj10l5F1qTetyFGiABAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAACABIih7Im5vbmNlIjoiMWViZmNhNmNhOTM3YTc5MSIsInZvdGVzIjpbMF19MgASQYxovfmYyXPKHkJYpqataZ18jZNzOJSepOIA5+xplZeSMpRb9k1rXHcrX79SjuSHIecyJE26iBdr8uUarbHRSocb"}
2024-01-29T13:29:46.793Z ERR vochain/cometbft.go:216 > checkTx error="voteTx: process 63f57be98f809fcff0c6b84d8b6469c4dcf178d0e3758d2432f5020000000030 not in READY state - current state: ENDED"
2024-01-29T13:29:46.793Z DBG vochain/appsetup.go:65 > broadcast tx error="check tx async: voteTx: process 63f57be98f809fcff0c6b84d8b6469c4dcf178d0e3758d2432f5020000000030 not in READY state - current state: ENDED" result=-1 size=264
2024-01-29T13:29:46.793Z DBG httprouter/message.go:65 > response: (500) {"error":"vochain SendTx failed: check tx async: voteTx: process 63f57be98f809fcff0c6b84d8b6469c4dcf178d0e3758d2432f5020000000030 not in READY state - current state: ENDED","code":5001}
2024-01-29T13:29:46.793Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/votes HTTP/1.1" from 79.155.117.238:35934 - 500 186B in 1.775891ms
2024-01-29T13:29:47.333Z DBG httprouter/message.go:57 > response: (204)
2024-01-29T13:29:47.333Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/chain/transactions/reference/34af50fc92fe65c590c58fa003f95c366bfc84369e915c74364d7151fa014f8f HTTP/1.1" from 185.153.38.54:62126 - 204 0B in 318.607µs
2024-01-29T13:29:48.226Z DBG httprouter/message.go:65 > response: (200) {"address":"9fcff0c6b84d8b6469c4dcf178d0e3758d2432f5","nonce":98,"balance":157,"electionIndex":49,"infoURL":"ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q","metadata":{"version":"1.0","name":{"default":""},"description":{"default":""},"newsFeed":{"default":""},"media":{},"meta":{}},"sik":"169c0ce463a88e541cd5cc8dfa981d87f7cabc44be5be8081b21edf44c513c03"}
2024-01-29T13:29:48.227Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x9FCff0C6B84D8b6469c4DCf178D0E3758D2432f5 HTTP/1.1" from 79.155.117.238:35948 - 200 378B in 816.331µs
2024-01-29T13:29:48.395Z DBG httprouter/message.go:65 > response: (200) {"censusID":"32a51d2ce27800e9d5708690b53764d0c79dfacc504184ff4dd33526b493db73"}
2024-01-29T13:29:48.395Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/censuses/weighted HTTP/1.1" from 79.155.117.238:35958 - 200 80B in 2.496551ms
2024-01-29T13:29:48.556Z DBG apirest/apirest.go:197 > request: {"participants":[{"key":"0x1BdB87C499883ea4EB74DA87aD28B4F7906e0830","weight":"1"},{"key":"0x564e38eeA5e8cEA041000d984b6d5d8396EB08A3","weight":"1"}]}
2024-01-29T13:29:48.557Z DBG censusdb/censusdb.go:159 > loaded census tree id=32a51d2ce27800e9d5708690b53764d0c79dfacc504184ff4dd33526b493db73 root=0000000000000000000000000000000000000000000000000000000000000000 size=0 type=ARBO_BLAKE2B
2024-01-29T13:29:48.557Z INF api/censuses.go:306 > adding participants to census census=32a51d2ce27800e9d5708690b53764d0c79dfacc504184ff4dd33526b493db73 count=2
2024-01-29T13:29:48.558Z DBG httprouter/message.go:65 > response: (200) 
2024-01-29T13:29:48.558Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/censuses/32a51d2ce27800e9d5708690b53764d0c79dfacc504184ff4dd33526b493db73/participants HTTP/1.1" from 79.155.117.238:35972 - 200 1B in 1.936392ms
2024-01-29T13:29:48.716Z DBG censusdb/censusdb.go:159 > loaded census tree id=32a51d2ce27800e9d5708690b53764d0c79dfacc504184ff4dd33526b493db73 root=a399b116ebe45aaf5961391ca755981b4bd9d3d4795aa2aaf042fbebb73f9838 size=2 type=ARBO_BLAKE2B
2024-01-29T13:29:48.717Z DBG compressor/compression.go:40 > compressed 0.11 KiB to 0.07 KiB in 1.137153ms with zstd, 64.5% of the original size
2024-01-29T13:29:48.726Z INF ipfs/ipfs.go:180 > published file cid=bafybeieikrrnox3s46yjjmuu7zcjyltqrexrqf2gys5s4xp67pkh7wkd3m protocol=ipfs size=0
2024-01-29T13:29:48.73Z DBG httprouter/message.go:65 > response: (200) {"censusID":"a399b116ebe45aaf5961391ca755981b4bd9d3d4795aa2aaf042fbebb73f9838","uri":"ipfs://bafybeieikrrnox3s46yjjmuu7zcjyltqrexrqf2gys5s4xp67pkh7wkd3m"}
2024-01-29T13:29:48.73Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/censuses/32a51d2ce27800e9d5708690b53764d0c79dfacc504184ff4dd33526b493db73/publish HTTP/1.1" from 79.155.117.238:35976 - 200 155B in 14.292814ms
2024-01-29T13:29:48.895Z DBG httprouter/message.go:65 > response: (200) {"address":"9fcff0c6b84d8b6469c4dcf178d0e3758d2432f5","nonce":98,"balance":157,"electionIndex":49,"infoURL":"ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q","metadata":{"version":"1.0","name":{"default":""},"description":{"default":""},"newsFeed":{"default":""},"media":{},"meta":{}},"sik":"169c0ce463a88e541cd5cc8dfa981d87f7cabc44be5be8081b21edf44c513c03"}
2024-01-29T13:29:48.895Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x9FCff0C6B84D8b6469c4DCf178D0E3758D2432f5 HTTP/1.1" from 79.155.117.238:35990 - 200 378B in 678.141µs
2024-01-29T13:29:49.075Z DBG apirest/apirest.go:197 > request: {"payload":"eyJ2ZXJzaW9uIjoiMS4yIiwidGl0bGUiOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gVGl0bGUifSwiZGVzY3JpcHRpb24iOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gRGVzY3JpcHRpb24ifSwibWVkaWEiOnt9LCJtZXRhIjp7InNkayI6eyJ2ZXJzaW9uIjoiMC43LjMifX0sInF1ZXN0aW9ucyI6W3sidGl0bGUiOnsiZGVmYXVsdCI6IlRoaXMgaXMgYSB0aXRsZSJ9LCJkZXNjcmlwdGlvbiI6eyJkZWZhdWx0IjoiVGhpcyBpcyBhIGRlc2NyaXB0aW9uIn0sImNob2ljZXMiOlt7InRpdGxlIjp7ImRlZmF1bHQiOiJPcHRpb24gMSJ9LCJ2YWx1ZSI6MH0seyJ0aXRsZSI6eyJkZWZhdWx0IjoiT3B0aW9uIDIifSwidmFsdWUiOjF9XX1dLCJ0eXBlIjp7Im5hbWUiOiJzaW5nbGUtY2hvaWNlLW11bHRpcXVlc3Rpb24iLCJwcm9wZXJ0aWVzIjp7fX19"}
2024-01-29T13:29:49.075Z DBG httprouter/message.go:65 > response: (200) {"cid":"ipfs://bafybeib4n2bvyymwrnif2tivgj4niz3zulepn7243mduzf47unkwukikou"}
2024-01-29T13:29:49.075Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/files/cid HTTP/1.1" from 79.155.117.238:36002 - 200 77B in 456.276µs
2024-01-29T13:29:49.241Z DBG httprouter/message.go:65 > response: (200) {"height":118950}
2024-01-29T13:29:49.241Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/chain/dateToBlock/1706544988 HTTP/1.1" from 79.155.117.238:36018 - 200 18B in 228.548µs
2024-01-29T13:29:49.451Z DBG apirest/apirest.go:197 > request: {"txPayload":"CusBEugBCAEQYhrhARIUn8/wxrhNi2RpxNzxeNDjdY0kMvUg5QgqIKOZsRbr5FqvWWE5HKdVmBtL2dPUeVqiqvBC++u3P5g4MkJpcGZzOi8vYmFmeWJlaWVpa3Jybm94M3M0Nnlqam11dTd6Y2p5bHRxcmV4cnFmMmd5czVzNHhwNjdwa2g3d2tkM21gAXoAggEECAEQAZoBBggBEAEoAaABAtIBQmlwZnM6Ly9iYWZ5YmVpYjRuMmJ2eXltd3JuaWYydGl2Z2o0bml6M3p1bGVwbjcyNDNtZHV6ZjQ3dW5rd3VraWtvdeABApACABJBlMf9SQRkeKVVFvBDgKlrkteDOr4QUpnc2QTTHX93165hTKpEicZ4HwZGbSJOcXhy9jzv/JTWFSWvQ5KxhuYmJxw=","metadata":"eyJ2ZXJzaW9uIjoiMS4yIiwidGl0bGUiOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gVGl0bGUifSwiZGVzY3JpcHRpb24iOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gRGVzY3JpcHRpb24ifSwibWVkaWEiOnt9LCJtZXRhIjp7InNkayI6eyJ2ZXJzaW9uIjoiMC43LjMifX0sInF1ZXN0aW9ucyI6W3sidGl0bGUiOnsiZGVmYXVsdCI6IlRoaXMgaXMgYSB0aXRsZSJ9LCJkZXNjcmlwdGlvbiI6eyJkZWZhdWx0IjoiVGhpcyBpcyBhIGRlc2NyaXB0aW9uIn0sImNob2ljZXMiOlt7InRpdGxlIjp7ImRlZmF1bHQiOiJPcHRpb24gMSJ9LCJ2YWx1ZSI6MH0seyJ0aXRsZSI6eyJkZWZhdWx0IjoiT3B0aW9uIDIifSwidmFsdWUiOjF9XX1dLCJ0eXBlIjp7Im5hbWUiOiJzaW5nbGUtY2hvaWNlLW11bHRpcXVlc3Rpb24iLCJwcm9wZXJ0aWVzIjp7fX19"}
2024-01-29T13:29:49.451Z WRN transaction/election_tx.go:63 > deprecated block count based new process detected id=
panic: recheck cursor is not nil before resCbFirstTime

goroutine 1821955 [running]:
github.com/cometbft/cometbft/mempool.(*CListMempool).globalCb(0xc00267b520, 0xc000100400?, 0xc018c1cc50)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:314 +0x145
github.com/cometbft/cometbft/abci/client.(*localClient).callback(0xc00036e840?, 0x40?, 0x36e9de0?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:64 +0x27
github.com/cometbft/cometbft/abci/client.(*localClient).CheckTxAsync(0xc004b15d40, {0x453aef8?, 0x6043ec0?}, 0xc0118909e0)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:57 +0x1e6
github.com/cometbft/cometbft/proxy.(*appConnMempool).CheckTxAsync(0xc003ae5d70, {0x453aef8, 0x6043ec0}, 0xc0118909c0?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/proxy/app_conn.go:148 +0x16d
github.com/cometbft/cometbft/mempool.(*CListMempool).CheckTx(0xc00267b520, {0xc012e8ba40, 0x131, 0x132})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:293 +0x426
github.com/cometbft/cometbft/rpc/core.(*Environment).BroadcastTxSync(0xc000b2aa00, 0xc0007ca860, {0xc012e8ba40, 0x131, 0x132})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/core/mempool.go:43 +0xa8
github.com/cometbft/cometbft/rpc/client/local.(*Local).BroadcastTxSync(...)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/client/local/local.go:98
go.vocdoni.io/dvote/vochain.(*BaseApplication).SetDefaultMethods.func4({0xc012e8ba40?, 0x131, 0x3b?})
    go.vocdoni.io/dvote/vochain/appsetup.go:64 +0x4e
go.vocdoni.io/dvote/vochain.(*BaseApplication).SendTx(0x24?, {0xc012e8ba40?, 0x24?, 0x1a7?})
    go.vocdoni.io/dvote/vochain/app.go:341 +0x2a
go.vocdoni.io/dvote/api.(*API).sendTx(0xc00fd46f80?, {0xc012e8ba40?, 0xc004142c30?, 0x42?})
    go.vocdoni.io/dvote/api/helpers.go:40 +0x2b
go.vocdoni.io/dvote/api.(*API).electionCreateHandler(0xc00add5130, 0xc0123030b0, 0xc00093c7e0?)
    go.vocdoni.io/dvote/api/elections.go:496 +0x2c8
go.vocdoni.io/dvote/httprouter/apirest.(*API).RegisterMethod.func1({{0x3619160, 0xc0123030b0}, {0xc16607f35aea631a, 0x2815c110111, 0x600bfa0}, {0xc0123030f0, 0x2, 0x2}, 0xc011890900})
    go.vocdoni.io/dvote/httprouter/apirest/apirest.go:231 +0x6b
created by go.vocdoni.io/dvote/httprouter.(*HTTProuter).AddPublicHandler.(*HTTProuter).routerHandler.func1 in goroutine 1821905
    go.vocdoni.io/dvote/httprouter/httprouter.go:283 +0x3c5
p4u commented 8 months ago
2024-01-29T16:13:04.881Z DBG httprouter/message.go:65 > response: (200) {"type":"weighted","weight":"1","censusRoot":"ba8b111027fd7a83e3c6a88142890fd01af90db7972b5971fb39e05ca4ee9e66","censusProof":"2500010001fa4b12e1d2afb40486882b0e4e3b77cef5cae5cc6c0d5bb883879daf8c2a0533","value":"0100000000000000000000000000000000000000000000000000000000000000"}
2024-01-29T16:13:04.881Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/censuses/ba8b111027fd7a83e3c6a88142890fd01af90db7972b5971fb39e05ca4ee9e66/proof/512684885d89A176b01DfDbAd2563930b272c416 HTTP/1.1" from 79.155.117.238:46122 - 200 279B in 485.611µs
2024-01-29T16:13:05.047Z DBG httprouter/message.go:65 > response: (200) {"chainId":"vocdoni/DEV/31","blockTime":[10373,10395,10405,10414,10404],"electionCount":715,"organizationCount":408,"genesisTime":"2024-01-12T01:00:00Z","height":118931,"syncing":false,"blockTimestamp":1706544771,"transactionCount":67097,"validatorCount":3,"voteCount":65660,"circuitVersion":"v1.0.0","maxCensusSize":100000,"networkCapacity":20000}
2024-01-29T16:13:05.047Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/chain/info HTTP/1.1" from 79.155.117.238:46126 - 200 349B in 2.209914ms
2024-01-29T16:13:05.269Z DBG apirest/apirest.go:197 > request: {"txPayload":"CsIBCr8BCiABDV9GOyNXAMw8qdmksUmRqBoIRiS8uAsAGtHMeq+gTBIgY/V76Y+AUkjiKgAX0k+pCxLMmk/c/eFvCUQCAAAAAAAaTTJLEiUlAAEAAfpLEuHSr7QEhogrDk47d871yuXMbA1buIOHna+MKgUzGiABAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAACABIih7Im5vbmNlIjoiNDgxOTI2YTMzODM0YmExMSIsInZvdGVzIjpbMF19MgASQWiREA8VZJMnj6Sb/4f2jE34khhBhiE9tFC+xbvRBLMBWrXze/O3LgOdY/E/AL3TL+swxyBbp71QM+btzKvFzGcb"}
2024-01-29T16:13:05.27Z ERR vochain/cometbft.go:214 > checkTx error="voteTx: process 63f57be98f805248e22a0017d24fa90b12cc9a4fdcfde16f0944020000000000 not in READY state - current state: ENDED"
2024-01-29T16:13:05.27Z DBG vochain/appsetup.go:65 > broadcast tx error="check tx async: voteTx: process 63f57be98f805248e22a0017d24fa90b12cc9a4fdcfde16f0944020000000000 not in READY state - current state: ENDED" result=-1 size=264
2024-01-29T16:13:05.27Z DBG httprouter/message.go:65 > response: (500) {"error":"vochain SendTx failed: check tx async: voteTx: process 63f57be98f805248e22a0017d24fa90b12cc9a4fdcfde16f0944020000000000 not in READY state - current state: ENDED","code":5001}
2024-01-29T16:13:05.271Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/votes HTTP/1.1" from 79.155.117.238:46128 - 500 186B in 1.115041ms
2024-01-29T16:13:05.636Z WRN ipfs/ipfs.go:326 > invalid path error="invalid path \"\": path does not have enough components" path=
2024-01-29T16:13:05.636Z WRN api/accounts.go:154 > cannot get account metadata from : invalid storage path
2024-01-29T16:13:05.636Z DBG httprouter/message.go:65 > response: (200) {"address":"7c3a4a5f142ed27c07966b7c7c3f085521154b40","nonce":2,"balance":999759020,"electionIndex":0,"metadata":{},"sik":""}
2024-01-29T16:13:05.636Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x7C3a4A5f142ed27C07966b7C7C3F085521154b40 HTTP/2.0" from 79.155.117.238:46130 - 200 126B in 632.617µs
2024-01-29T16:13:06.432Z WRN ipfs/ipfs.go:326 > invalid path error="invalid path \"\": path does not have enough components" path=
2024-01-29T16:13:06.433Z WRN api/accounts.go:154 > cannot get account metadata from : invalid storage path
2024-01-29T16:13:06.433Z DBG httprouter/message.go:65 > response: (200) {"address":"7c3a4a5f142ed27c07966b7c7c3f085521154b40","nonce":2,"balance":999759020,"electionIndex":0,"metadata":{},"sik":""}
2024-01-29T16:13:06.433Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x7C3a4A5f142ed27C07966b7C7C3F085521154b40 HTTP/2.0" from 79.155.117.238:46132 - 200 126B in 756.81µs
2024-01-29T16:13:06.814Z DBG httprouter/message.go:65 > response: (200) {"address":"5248e22a0017d24fa90b12cc9a4fdcfde16f0944","nonce":2,"balance":493,"electionIndex":1,"infoURL":"ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q","metadata":{"version":"1.0","name":{"default":""},"description":{"default":""},"newsFeed":{"default":""},"media":{},"meta":{}},"sik":"781ebb566f4fd19c1a69c92d6f611c63d50d3ecd6a356f8c82f5a97bd6ecb524"}
2024-01-29T16:13:06.814Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x5248E22a0017D24FA90b12cC9a4FdcfDE16F0944 HTTP/1.1" from 79.155.117.238:46140 - 200 376B in 472.536µs
2024-01-29T16:13:06.978Z DBG httprouter/message.go:65 > response: (200) {"censusID":"70aa22fed9811a518777c240e328726d0269fb309f418b253b5db07fb04cac9a"}
2024-01-29T16:13:06.979Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/censuses/weighted HTTP/1.1" from 79.155.117.238:46150 - 200 80B in 3.208789ms
2024-01-29T16:13:07.137Z DBG apirest/apirest.go:197 > request: {"participants":[{"key":"0x54D94eA4853ceD0C5159EB8ebb8e25bAD7c12999","weight":"1"},{"key":"0x1763Faf50350a90EdDa3Ce2252153cB0A825aE6d","weight":"1"}]}
2024-01-29T16:13:07.138Z DBG censusdb/censusdb.go:159 > loaded census tree id=70aa22fed9811a518777c240e328726d0269fb309f418b253b5db07fb04cac9a root=0000000000000000000000000000000000000000000000000000000000000000 size=0 type=ARBO_BLAKE2B
2024-01-29T16:13:07.138Z INF api/censuses.go:306 > adding participants to census census=70aa22fed9811a518777c240e328726d0269fb309f418b253b5db07fb04cac9a count=2
2024-01-29T16:13:07.139Z DBG httprouter/message.go:65 > response: (200) 
2024-01-29T16:13:07.14Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/censuses/70aa22fed9811a518777c240e328726d0269fb309f418b253b5db07fb04cac9a/participants HTTP/1.1" from 79.155.117.238:46166 - 200 1B in 2.210896ms
2024-01-29T16:13:07.313Z DBG censusdb/censusdb.go:159 > loaded census tree id=70aa22fed9811a518777c240e328726d0269fb309f418b253b5db07fb04cac9a root=8061eb71794bbb87cc7f48810ad23f06a0a7922f455f1dda181b96676bc768f1 size=2 type=ARBO_BLAKE2B
2024-01-29T16:13:07.315Z DBG compressor/compression.go:40 > compressed 0.11 KiB to 0.07 KiB in 1.528907ms with zstd, 64.5% of the original size
2024-01-29T16:13:07.326Z INF ipfs/ipfs.go:180 > published file cid=bafybeibgweitmi4lcqaoa2ubkf3vuu35krgyla46hsysxuo2hbx56noknq protocol=ipfs size=0
2024-01-29T16:13:07.331Z DBG httprouter/message.go:65 > response: (200) {"censusID":"8061eb71794bbb87cc7f48810ad23f06a0a7922f455f1dda181b96676bc768f1","uri":"ipfs://bafybeibgweitmi4lcqaoa2ubkf3vuu35krgyla46hsysxuo2hbx56noknq"}
2024-01-29T16:13:07.331Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/censuses/70aa22fed9811a518777c240e328726d0269fb309f418b253b5db07fb04cac9a/publish HTTP/1.1" from 79.155.117.238:46180 - 200 155B in 18.444945ms
2024-01-29T16:13:07.405Z WRN ipfs/ipfs.go:326 > invalid path error="invalid path \"\": path does not have enough components" path=
2024-01-29T16:13:07.405Z WRN api/accounts.go:154 > cannot get account metadata from : invalid storage path
2024-01-29T16:13:07.406Z DBG httprouter/message.go:65 > response: (200) {"address":"7c3a4a5f142ed27c07966b7c7c3f085521154b40","nonce":2,"balance":999759020,"electionIndex":0,"metadata":{},"sik":""}
2024-01-29T16:13:07.406Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x7C3a4A5f142ed27C07966b7C7C3F085521154b40 HTTP/2.0" from 79.155.117.238:46188 - 200 126B in 840.937µs
2024-01-29T16:13:07.512Z DBG httprouter/message.go:65 > response: (200) {"address":"5248e22a0017d24fa90b12cc9a4fdcfde16f0944","nonce":2,"balance":493,"electionIndex":1,"infoURL":"ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q","metadata":{"version":"1.0","name":{"default":""},"description":{"default":""},"newsFeed":{"default":""},"media":{},"meta":{}},"sik":"781ebb566f4fd19c1a69c92d6f611c63d50d3ecd6a356f8c82f5a97bd6ecb524"}
2024-01-29T16:13:07.512Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/accounts/0x5248E22a0017D24FA90b12cC9a4FdcfDE16F0944 HTTP/1.1" from 79.155.117.238:46196 - 200 376B in 469.741µs
2024-01-29T16:13:07.694Z DBG apirest/apirest.go:197 > request: {"payload":"eyJ2ZXJzaW9uIjoiMS4yIiwidGl0bGUiOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gVGl0bGUifSwiZGVzY3JpcHRpb24iOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gRGVzY3JpcHRpb24ifSwibWVkaWEiOnt9LCJtZXRhIjp7InNkayI6eyJ2ZXJzaW9uIjoiMC43LjMifX0sInF1ZXN0aW9ucyI6W3sidGl0bGUiOnsiZGVmYXVsdCI6IlRoaXMgaXMgYSB0aXRsZSJ9LCJkZXNjcmlwdGlvbiI6eyJkZWZhdWx0IjoiVGhpcyBpcyBhIGRlc2NyaXB0aW9uIn0sImNob2ljZXMiOlt7InRpdGxlIjp7ImRlZmF1bHQiOiJPcHRpb24gMSJ9LCJ2YWx1ZSI6MH0seyJ0aXRsZSI6eyJkZWZhdWx0IjoiT3B0aW9uIDIifSwidmFsdWUiOjF9XX1dLCJ0eXBlIjp7Im5hbWUiOiJzaW5nbGUtY2hvaWNlLW11bHRpcXVlc3Rpb24iLCJwcm9wZXJ0aWVzIjp7fX19"}
2024-01-29T16:13:07.695Z DBG httprouter/message.go:65 > response: (200) {"cid":"ipfs://bafybeib4n2bvyymwrnif2tivgj4niz3zulepn7243mduzf47unkwukikou"}
2024-01-29T16:13:07.695Z DBG middleware/logger.go:159 > "POST https://api-dev.vocdoni.net/v2/files/cid HTTP/1.1" from 79.155.117.238:46206 - 200 77B in 561.012µs
2024-01-29T16:13:07.874Z DBG httprouter/message.go:65 > response: (200) {"height":119890}
2024-01-29T16:13:07.874Z DBG middleware/logger.go:159 > "GET https://api-dev.vocdoni.net/v2/chain/dateToBlock/1706554786 HTTP/1.1" from 79.155.117.238:46212 - 200 18B in 323.257µs
2024-01-29T16:13:08.076Z DBG apirest/apirest.go:197 > request: {"txPayload":"CusBEugBCAEQAhrhARIUUkjiKgAX0k+pCxLMmk/c/eFvCUQgwwcqIIBh63F5S7uHzH9IgQrSPwagp5IvRV8d2hgblmdrx2jxMkJpcGZzOi8vYmFmeWJlaWJnd2VpdG1pNGxjcWFvYTJ1YmtmM3Z1dTM1a3JneWxhNDZoc3lzeHVvMmhieDU2bm9rbnFgAXoAggEECAEQAZoBBggBEAEoAaABAtIBQmlwZnM6Ly9iYWZ5YmVpYjRuMmJ2eXltd3JuaWYydGl2Z2o0bml6M3p1bGVwbjcyNDNtZHV6ZjQ3dW5rd3VraWtvdeABApACABJBhWfHQLHCceDb0reG9FHVivBhVnRTKuUSyntZAR0axqMqEYCrpurTLbMd/EvaqAhz9VnhdAwTlpah79xhXKXpMRw=","metadata":"eyJ2ZXJzaW9uIjoiMS4yIiwidGl0bGUiOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gVGl0bGUifSwiZGVzY3JpcHRpb24iOnsiZGVmYXVsdCI6IlNESyBUZXN0aW5nIC0gRGVzY3JpcHRpb24ifSwibWVkaWEiOnt9LCJtZXRhIjp7InNkayI6eyJ2ZXJzaW9uIjoiMC43LjMifX0sInF1ZXN0aW9ucyI6W3sidGl0bGUiOnsiZGVmYXVsdCI6IlRoaXMgaXMgYSB0aXRsZSJ9LCJkZXNjcmlwdGlvbiI6eyJkZWZhdWx0IjoiVGhpcyBpcyBhIGRlc2NyaXB0aW9uIn0sImNob2ljZXMiOlt7InRpdGxlIjp7ImRlZmF1bHQiOiJPcHRpb24gMSJ9LCJ2YWx1ZSI6MH0seyJ0aXRsZSI6eyJkZWZhdWx0IjoiT3B0aW9uIDIifSwidmFsdWUiOjF9XX1dLCJ0eXBlIjp7Im5hbWUiOiJzaW5nbGUtY2hvaWNlLW11bHRpcXVlc3Rpb24iLCJwcm9wZXJ0aWVzIjp7fX19"}
2024-01-29T16:13:08.077Z WRN transaction/election_tx.go:63 > deprecated block count based new process detected id=
panic: recheck cursor is not nil before resCbFirstTime

goroutine 323480 [running]:
github.com/cometbft/cometbft/mempool.(*CListMempool).globalCb(0xc002807930, 0xc00008a800?, 0xc014737380)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:314 +0x145
github.com/cometbft/cometbft/abci/client.(*localClient).callback(0xc000ae8f20?, 0x40?, 0x36e9de0?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:64 +0x27
github.com/cometbft/cometbft/abci/client.(*localClient).CheckTxAsync(0xc002785140, {0x453af38?, 0x6043ec0?}, 0xc014940a40)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/abci/client/local_client.go:57 +0x1e6
github.com/cometbft/cometbft/proxy.(*appConnMempool).CheckTxAsync(0xc001818318, {0x453af38, 0x6043ec0}, 0xc014940a20?)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/proxy/app_conn.go:148 +0x16d
github.com/cometbft/cometbft/mempool.(*CListMempool).CheckTx(0xc002807930, {0xc0125f9540, 0x131, 0x132})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/mempool/clist_mempool.go:293 +0x426
github.com/cometbft/cometbft/rpc/core.(*Environment).BroadcastTxSync(0xc000553800, 0xc00426a880, {0xc0125f9540, 0x131, 0x132})
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/core/mempool.go:43 +0xa8
github.com/cometbft/cometbft/rpc/client/local.(*Local).BroadcastTxSync(...)
    github.com/cometbft/cometbft@v1.0.0-alpha.1/rpc/client/local/local.go:98
go.vocdoni.io/dvote/vochain.(*BaseApplication).SetDefaultMethods.func4({0xc0125f9540?, 0x131, 0x3b?})
    go.vocdoni.io/dvote/vochain/appsetup.go:64 +0x4e
go.vocdoni.io/dvote/vochain.(*BaseApplication).SendTx(0x24?, {0xc0125f9540?, 0x24?, 0x1a7?})
    go.vocdoni.io/dvote/vochain/app.go:338 +0x2a
go.vocdoni.io/dvote/api.(*API).sendTx(0xc012843d80?, {0xc0125f9540?, 0xc00ec770e0?, 0x42?})
    go.vocdoni.io/dvote/api/helpers.go:40 +0x2b
go.vocdoni.io/dvote/api.(*API).electionCreateHandler(0xc00ec660a0, 0xc012766f90, 0xc0037ccf58?)
    go.vocdoni.io/dvote/api/elections.go:496 +0x2c8
go.vocdoni.io/dvote/httprouter/apirest.(*API).RegisterMethod.func1({{0x3619160, 0xc012766f90}, {0xc166118504975d97, 0x69501599bb, 0x600bfa0}, {0xc012766fd0, 0x2, 0x2}, 0xc014940960})
    go.vocdoni.io/dvote/httprouter/apirest/apirest.go:231 +0x6b
created by go.vocdoni.io/dvote/httprouter.(*HTTProuter).AddPublicHandler.(*HTTProuter).routerHandler.func1 in goroutine 323666
    go.vocdoni.io/dvote/httprouter/httprouter.go:283 +0x3c5
vocdoni version "f4222d8"