Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Reveal key transaction gets stuck forever #1064

Open
p4u opened this issue Jul 27, 2023 · 1 comment
Open

Reveal key transaction gets stuck forever #1064

p4u opened this issue Jul 27, 2023 · 1 comment
Assignees
@p4u

Comments

@p4u
Copy link
Member

p4u commented Jul 27, 2023 

2023-07-27T12:16:36Z DBG ist/ist.go:223 > commit results action=commit-results height=15082 id=c5d2460186f74d97557fa8de8031ff8f239143887ba936125d28020000000000
2023-07-27T12:16:36.001Z INF ist/results.go:100 > committing results electionID=c5d2460186f74d97557fa8de8031ff8f239143887ba936125d28020000000000
2023-07-27T12:16:41.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:50302 - 200 6535B in 3.008728ms
2023-07-27T12:16:47.227Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15082 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:17:01.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:55154 - 200 6510B in 3.167294ms
2023-07-27T12:17:04.098Z DBG ist/ist.go:247 > end process action=end-process height=15084 id=c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000
2023-07-27T12:17:04.1Z INF keykeeper/keykeeper.go:275 > process ended, scheduling reveal keys for next block
2023-07-27T12:17:04.1Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15085 id=c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000
2023-07-27T12:17:04.104Z INF keykeeper/keykeeper.go:339 > scheduled reveal keys of process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000 for block 15085
2023-07-27T12:17:04.105Z INF keykeeper/keykeeper.go:380 > revealing keys for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000 on block 15084
2023-07-27T12:17:04.106Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x04CC36BE85A0a6e2bfd09295396625e6302d7C60 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"5aT3M/T1l95FS0JAMsVb5w9qIRQKCT44vhYCUqhXNl0=\",\"keyIndex\":1,\"nonce\":352607569}"
2023-07-27T12:17:04.106Z DBG vochain/appsetup.go:67 > broadcast tx error= result=0 size=149
2023-07-27T12:17:04.106Z INF keykeeper/keykeeper.go:458 > revealing encryption key for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000
2023-07-27T12:17:04.168Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xFc095a35338D96503b6fD1010475e45A3545fC25 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"C5MCNk8eD6pTRKiaN12Lh3Sb+9FuFr9RHDkN4BFy0h4=\",\"keyIndex\":2,\"nonce\":13800553}"
2023-07-27T12:17:04.194Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xa9b1008f17654B36f2a9AbD29323C53d344415A0 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"JK9hZMLb5ZR4OMHshOsW+tg91zM4Q+3LiZ6QjuwOui8=\",\"keyIndex\":3,\"nonce\":47781614}"
2023-07-27T12:17:04.218Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"ETK+8lZV5O9xW5syCdJjamI+HNSgXnwYiGgeNEiAqz0=\",\"keyIndex\":4,\"nonce\":244768750}"
2023-07-27T12:17:07.227Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15083 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:17:14.522Z DBG vochain/app.go:358 > deliver tx hash=3bf2f7af07230430c33bda91ccd7d0ae09ca2da3e4a3999721876ee74f730f70 height=15085 tx={"Payload":{"Admin":{"encryptionPrivateKey":"JK9hZMLb5ZR4OMHshOsW+tg91zM4Q+3LiZ6QjuwOui8=","keyIndex":3,"nonce":47781614,"processId":"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:17:14.522Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xa9b1008f17654B36f2a9AbD29323C53d344415A0 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"JK9hZMLb5ZR4OMHshOsW+tg91zM4Q+3LiZ6QjuwOui8=\",\"keyIndex\":3,\"nonce\":47781614}"
2023-07-27T12:17:14.522Z DBG state/state.go:373 > revealed encryption key 3 for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000: 24af6164c2dbe5947838c1ec84eb16fad83dd7333843edcb899e908eec0eba2f
2023-07-27T12:17:14.523Z DBG vochain/app.go:358 > deliver tx hash=b33469fc36ac270d44ed1714f27c57bd358eec6c8ab9d29b879ad86487179f5d height=15085 tx={"Payload":{"Admin":{"encryptionPrivateKey":"C5MCNk8eD6pTRKiaN12Lh3Sb+9FuFr9RHDkN4BFy0h4=","keyIndex":2,"nonce":13800553,"processId":"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:17:14.523Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xFc095a35338D96503b6fD1010475e45A3545fC25 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"C5MCNk8eD6pTRKiaN12Lh3Sb+9FuFr9RHDkN4BFy0h4=\",\"keyIndex\":2,\"nonce\":13800553}"
2023-07-27T12:17:14.523Z DBG state/state.go:373 > revealed encryption key 2 for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000: 0b9302364f1e0faa5344a89a375d8b87749bfbd16e16bf511c390de01172d21e
2023-07-27T12:17:14.524Z DBG vochain/app.go:358 > deliver tx hash=790bb6a3475a589310c6e8168ac5125d82d685632f7fe01bb25149caae13c029 height=15085 tx={"Payload":{"Admin":{"encryptionPrivateKey":"5aT3M/T1l95FS0JAMsVb5w9qIRQKCT44vhYCUqhXNl0=","keyIndex":1,"nonce":352607569,"processId":"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:17:14.524Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x04CC36BE85A0a6e2bfd09295396625e6302d7C60 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"5aT3M/T1l95FS0JAMsVb5w9qIRQKCT44vhYCUqhXNl0=\",\"keyIndex\":1,\"nonce\":352607569}"
2023-07-27T12:17:14.524Z DBG state/state.go:373 > revealed encryption key 1 for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000: e5a4f733f4f597de454b424032c55be70f6a21140a093e38be160252a857365d
2023-07-27T12:17:14.525Z DBG vochain/app.go:358 > deliver tx hash=54d5a994ed0a798940ef6cd5160d95ec43b3ea0b367f1936926f67dcf65382a0 height=15085 tx={"Payload":{"Admin":{"encryptionPrivateKey":"ETK+8lZV5O9xW5syCdJjamI+HNSgXnwYiGgeNEiAqz0=","keyIndex":4,"nonce":244768750,"processId":"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:17:14.525Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"ETK+8lZV5O9xW5syCdJjamI+HNSgXnwYiGgeNEiAqz0=\",\"keyIndex\":4,\"nonce\":244768750}"
2023-07-27T12:17:14.525Z DBG state/state.go:373 > revealed encryption key 4 for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000: 1132bef25655e4ef715b9b3209d2636a623e1cd4a05e7c1888681e344880ab3d
2023-07-27T12:17:14.525Z DBG ist/ist.go:197 > compute results attempt=0 height=15085 id=c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000
2023-07-27T12:17:14.526Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15087 id=c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000
2023-07-27T12:17:14.529Z INF vochain/app.go:343 > commit block height=15085 txs=4
2023-07-27T12:17:14.53Z INF keykeeper/keykeeper.go:380 > revealing keys for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000 on block 15085
2023-07-27T12:17:14.53Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x04CC36BE85A0a6e2bfd09295396625e6302d7C60 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3y1x1m+XR3lbYTMSphUmF3t363BoCBAAAAAA=\",\"encryptionPrivateKey\":\"5aT3M/T1l95FS0JAMsVb5w9qIRQKCT44vhYCUqhXNl0=\",\"keyIndex\":1,\"nonce\":641948895}"
2023-07-27T12:17:14.531Z ERR vochain/app.go:278 > checkTx error="adminTx: keys for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000 already revealed"
2023-07-27T12:17:14.531Z DBG vochain/appsetup.go:67 > broadcast tx error="adminTx: keys for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000 already revealed" result=-1 size=149
2023-07-27T12:17:14.531Z ERR keykeeper/keykeeper.go:382 > cannot reveal process keys for c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000: (adminTx: keys for process c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000 already revealed)
2023-07-27T12:17:14.534Z INF results/compute.go:78 > computed results elapsed=8.017853ms process=c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000 results=[5,5]
2023-07-27T12:17:21.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:41136 - 200 6510B in 2.865548ms
2023-07-27T12:17:27.228Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15085 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:17:35.405Z DBG ist/ist.go:223 > commit results action=commit-results height=15087 id=c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000
2023-07-27T12:17:35.406Z INF ist/results.go:100 > committing results electionID=c5d2460186f7cb5c759be5d1de56d84cc4a9854985deddfadc1a020400000000
2023-07-27T12:17:41.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:59396 - 200 6516B in 2.957421ms
2023-07-27T12:17:47.229Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15087 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:18:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:51374 - 200 6497B in 2.898461ms
2023-07-27T12:18:07.23Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15088 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:18:13.987Z DBG ist/ist.go:247 > end process action=end-process height=15090 id=c5d2460186f75921e5865802b078792c5c0b99c86126e3bfc3ae020000000000
2023-07-27T12:18:13.988Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15091 id=c5d2460186f75921e5865802b078792c5c0b99c86126e3bfc3ae020000000000
2023-07-27T12:18:21.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:55098 - 200 6523B in 3.375575ms
2023-07-27T12:18:24.343Z DBG ist/ist.go:197 > compute results attempt=0 height=15091 id=c5d2460186f75921e5865802b078792c5c0b99c86126e3bfc3ae020000000000
2023-07-27T12:18:24.344Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15093 id=c5d2460186f75921e5865802b078792c5c0b99c86126e3bfc3ae020000000000
2023-07-27T12:18:24.344Z INF results/compute.go:78 > computed results elapsed="315.491µs" process=c5d2460186f75921e5865802b078792c5c0b99c86126e3bfc3ae020000000000 results=[2,2]
2023-07-27T12:18:27.232Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15090 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:18:41.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:45598 - 200 6497B in 3.083548ms
2023-07-27T12:18:47.233Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15091 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:18:52.506Z DBG ist/ist.go:223 > commit results action=commit-results height=15093 id=c5d2460186f75921e5865802b078792c5c0b99c86126e3bfc3ae020000000000
2023-07-27T12:18:52.507Z INF ist/results.go:100 > committing results electionID=c5d2460186f75921e5865802b078792c5c0b99c86126e3bfc3ae020000000000
2023-07-27T12:19:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:57842 - 200 6512B in 2.910432ms
2023-07-27T12:19:07.234Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15093 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:19:21.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:55374 - 200 6507B in 2.795326ms
2023-07-27T12:19:27.235Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15095 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:19:41.867Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:39862 - 200 6510B in 3.114314ms
2023-07-27T12:19:47.236Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15097 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:20:01.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:49744 - 200 6485B in 3.059681ms
2023-07-27T12:20:07.236Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15098 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:20:21.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:51644 - 200 6508B in 2.799484ms
2023-07-27T12:20:27.237Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15100 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:20:40.55Z DBG ist/ist.go:247 > end process action=end-process height=15102 id=c5d2460186f76c1125a6718b04c9bc2dfd7b073dbbc679f6dffa020000000000
2023-07-27T12:20:41.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:57292 - 200 6511B in 3.093094ms
2023-07-27T12:20:47.237Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15102 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:21:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:40586 - 200 6518B in 3.21919ms
2023-07-27T12:21:07.238Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15103 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:21:19.046Z DBG ist/ist.go:247 > end process action=end-process height=15105 id=c5d2460186f74ea5a592acb70576bd083fee505f316f220c8b1e020000000000
2023-07-27T12:21:19.047Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15106 id=c5d2460186f74ea5a592acb70576bd083fee505f316f220c8b1e020000000000
2023-07-27T12:21:21.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:51842 - 200 6536B in 2.930379ms
2023-07-27T12:21:27.238Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15105 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:21:29.462Z DBG ist/ist.go:197 > compute results attempt=0 height=15106 id=c5d2460186f74ea5a592acb70576bd083fee505f316f220c8b1e020000000000
2023-07-27T12:21:29.463Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15108 id=c5d2460186f74ea5a592acb70576bd083fee505f316f220c8b1e020000000000
2023-07-27T12:21:39.846Z DBG ist/ist.go:247 > end process action=end-process height=15107 id=c5d2460186f779ca0a4448dec04a36b82ba3a74d6f6a806fe4a6020000000000
2023-07-27T12:21:41.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:34560 - 200 6532B in 3.081952ms
2023-07-27T12:21:47.239Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15107 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:21:57.584Z DBG ist/ist.go:223 > commit results action=commit-results height=15108 id=c5d2460186f74ea5a592acb70576bd083fee505f316f220c8b1e020000000000
2023-07-27T12:21:57.585Z INF ist/results.go:100 > committing results electionID=c5d2460186f74ea5a592acb70576bd083fee505f316f220c8b1e020000000000
2023-07-27T12:22:01.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:35024 - 200 6508B in 3.023372ms
2023-07-27T12:22:07.239Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15108 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:22:21.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:33714 - 200 6505B in 3.378919ms
2023-07-27T12:22:27.24Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15110 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:22:28.764Z DBG ist/ist.go:247 > end process action=end-process height=15111 id=c5d2460186f70144d8606ba10985dd5206ac923e6a1d263c4e47020000000000
2023-07-27T12:22:28.765Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15112 id=c5d2460186f70144d8606ba10985dd5206ac923e6a1d263c4e47020000000000
2023-07-27T12:22:41.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:56030 - 200 6511B in 2.965223ms
2023-07-27T12:22:46.439Z DBG ist/ist.go:197 > compute results attempt=0 height=15112 id=c5d2460186f70144d8606ba10985dd5206ac923e6a1d263c4e47020000000000
2023-07-27T12:22:46.44Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15114 id=c5d2460186f70144d8606ba10985dd5206ac923e6a1d263c4e47020000000000
2023-07-27T12:22:47.241Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15111 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:23:01.868Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:42936 - 200 6519B in 3.26748ms
2023-07-27T12:23:07.203Z DBG ist/ist.go:247 > end process action=end-process height=15114 id=c5d2460186f7883b4f3fa7e7ce12e03c6d0b38a36d312782603b021000000000
2023-07-27T12:23:07.204Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15115 id=c5d2460186f7883b4f3fa7e7ce12e03c6d0b38a36d312782603b021000000000
2023-07-27T12:23:07.205Z DBG ist/ist.go:223 > commit results action=commit-results height=15114 id=c5d2460186f70144d8606ba10985dd5206ac923e6a1d263c4e47020000000000
2023-07-27T12:23:07.205Z INF ist/results.go:100 > committing results electionID=c5d2460186f70144d8606ba10985dd5206ac923e6a1d263c4e47020000000000
2023-07-27T12:23:07.242Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15113 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:23:17.718Z DBG ist/ist.go:197 > compute results attempt=0 height=15115 id=c5d2460186f7883b4f3fa7e7ce12e03c6d0b38a36d312782603b021000000000
2023-07-27T12:23:17.718Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15117 id=c5d2460186f7883b4f3fa7e7ce12e03c6d0b38a36d312782603b021000000000
2023-07-27T12:23:17.719Z INF results/compute.go:78 > computed results elapsed="375.644µs" process=c5d2460186f7883b4f3fa7e7ce12e03c6d0b38a36d312782603b021000000000 results=[10][0][30][20]
2023-07-27T12:23:21.868Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:43008 - 200 6512B in 3.147986ms
2023-07-27T12:23:27.243Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15115 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:23:41.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:49972 - 200 6526B in 3.119462ms
2023-07-27T12:23:45.831Z DBG ist/ist.go:223 > commit results action=commit-results height=15117 id=c5d2460186f7883b4f3fa7e7ce12e03c6d0b38a36d312782603b021000000000
2023-07-27T12:23:45.832Z INF ist/results.go:100 > committing results electionID=c5d2460186f7883b4f3fa7e7ce12e03c6d0b38a36d312782603b021000000000
2023-07-27T12:23:47.244Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15116 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:24:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:39566 - 200 6519B in 3.336369ms
2023-07-27T12:24:06.578Z DBG ist/ist.go:247 > end process action=end-process height=15119 id=c5d2460186f7c4018daea5cc66a31c835e50ca81eb3683491ce4020000000000
2023-07-27T12:24:06.579Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15120 id=c5d2460186f7c4018daea5cc66a31c835e50ca81eb3683491ce4020000000000
2023-07-27T12:24:07.245Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15118 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:24:21.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:57966 - 200 6509B in 2.746695ms
2023-07-27T12:24:24.352Z DBG ist/ist.go:197 > compute results attempt=0 height=15120 id=c5d2460186f7c4018daea5cc66a31c835e50ca81eb3683491ce4020000000000
2023-07-27T12:24:24.352Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15122 id=c5d2460186f7c4018daea5cc66a31c835e50ca81eb3683491ce4020000000000
2023-07-27T12:24:24.353Z INF results/compute.go:78 > computed results elapsed="595.765µs" process=c5d2460186f7c4018daea5cc66a31c835e50ca81eb3683491ce4020000000000 results=[10,0][0,10][10,0][0,10]
2023-07-27T12:24:27.246Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15119 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:24:41.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:39866 - 200 6513B in 2.834399ms
2023-07-27T12:24:45.098Z DBG ist/ist.go:223 > commit results action=commit-results height=15122 id=c5d2460186f7c4018daea5cc66a31c835e50ca81eb3683491ce4020000000000
2023-07-27T12:24:45.099Z INF ist/results.go:100 > committing results electionID=c5d2460186f7c4018daea5cc66a31c835e50ca81eb3683491ce4020000000000
2023-07-27T12:24:47.247Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15121 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:25:01.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:46656 - 200 6519B in 2.825422ms
2023-07-27T12:25:07.247Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15123 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:25:13.284Z DBG ist/ist.go:247 > end process action=end-process height=15124 id=c5d2460186f74981339d4147504cffc1b2cfb8020843668a5334020800000000
2023-07-27T12:25:13.285Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15125 id=c5d2460186f74981339d4147504cffc1b2cfb8020843668a5334020800000000
2023-07-27T12:25:21.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:44828 - 200 6528B in 3.189765ms
2023-07-27T12:25:23.713Z DBG ist/ist.go:197 > compute results attempt=0 height=15125 id=c5d2460186f74981339d4147504cffc1b2cfb8020843668a5334020800000000
2023-07-27T12:25:23.714Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15127 id=c5d2460186f74981339d4147504cffc1b2cfb8020843668a5334020800000000
2023-07-27T12:25:23.714Z INF results/compute.go:78 > computed results elapsed="330.569µs" process=c5d2460186f74981339d4147504cffc1b2cfb8020843668a5334020800000000 results=[0,0,10,0,0][0,0,0,10,0][10,0,0,0,0][0,10,0,0,0][0,0,0,0,10]
2023-07-27T12:25:27.248Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15124 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:25:41.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:60528 - 200 6512B in 2.855087ms
2023-07-27T12:25:44.498Z DBG ist/ist.go:223 > commit results action=commit-results height=15127 id=c5d2460186f74981339d4147504cffc1b2cfb8020843668a5334020800000000
2023-07-27T12:25:44.499Z INF ist/results.go:100 > committing results electionID=c5d2460186f74981339d4147504cffc1b2cfb8020843668a5334020800000000
2023-07-27T12:25:47.248Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15126 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:26:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:40116 - 200 6501B in 3.918597ms
2023-07-27T12:26:07.25Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15127 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:26:21.869Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:46338 - 200 6506B in 2.875456ms
2023-07-27T12:26:22.996Z DBG ist/ist.go:247 > end process action=end-process height=15130 id=c5d2460186f7c169f7f60295c3ffb9fbb9f06e74188fdbbf97cc020000000000
2023-07-27T12:26:22.997Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15131 id=c5d2460186f7c169f7f60295c3ffb9fbb9f06e74188fdbbf97cc020000000000
2023-07-27T12:26:27.251Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15129 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:26:33.354Z DBG ist/ist.go:197 > compute results attempt=0 height=15131 id=c5d2460186f7c169f7f60295c3ffb9fbb9f06e74188fdbbf97cc020000000000
2023-07-27T12:26:33.354Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15133 id=c5d2460186f7c169f7f60295c3ffb9fbb9f06e74188fdbbf97cc020000000000
2023-07-27T12:26:33.354Z INF results/compute.go:78 > computed results elapsed="201.206µs" process=c5d2460186f7c169f7f60295c3ffb9fbb9f06e74188fdbbf97cc020000000000 results=[1,1]
2023-07-27T12:26:41.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:43708 - 200 6516B in 2.806807ms
2023-07-27T12:26:47.251Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15131 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:27:01.445Z DBG ist/ist.go:223 > commit results action=commit-results height=15133 id=c5d2460186f7c169f7f60295c3ffb9fbb9f06e74188fdbbf97cc020000000000
2023-07-27T12:27:01.446Z INF ist/results.go:100 > committing results electionID=c5d2460186f7c169f7f60295c3ffb9fbb9f06e74188fdbbf97cc020000000000
2023-07-27T12:27:01.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:51414 - 200 6511B in 2.748998ms
2023-07-27T12:27:07.252Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15133 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:27:21.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:42530 - 200 6497B in 3.286665ms
2023-07-27T12:27:27.252Z INF vochain status blockTime="1m:10.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15134 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:27:41.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:56504 - 200 6514B in 2.576134ms
2023-07-27T12:27:47.253Z INF vochain status blockTime="1m:10.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15136 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:28:01.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:50090 - 200 6518B in 2.715265ms
2023-07-27T12:28:07.254Z INF vochain status blockTime="1m:10.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15138 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:28:11.025Z DBG ist/ist.go:247 > end process action=end-process height=15139 id=c5d2460186f700df4d58ea5a1f30a6253fdd9ddb6b5f1012d8c5020200000000
2023-07-27T12:28:11.026Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15140 id=c5d2460186f700df4d58ea5a1f30a6253fdd9ddb6b5f1012d8c5020200000000
2023-07-27T12:28:21.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:53854 - 200 6497B in 2.674067ms
2023-07-27T12:28:27.255Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15139 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:28:28.691Z DBG ist/ist.go:197 > compute results attempt=0 height=15140 id=c5d2460186f700df4d58ea5a1f30a6253fdd9ddb6b5f1012d8c5020200000000
2023-07-27T12:28:28.691Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15142 id=c5d2460186f700df4d58ea5a1f30a6253fdd9ddb6b5f1012d8c5020200000000
2023-07-27T12:28:28.692Z INF results/compute.go:78 > computed results elapsed="183.976µs" process=c5d2460186f700df4d58ea5a1f30a6253fdd9ddb6b5f1012d8c5020200000000 results=[0,195730901639124056921570056589921458726]
2023-07-27T12:28:41.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:49374 - 200 6525B in 2.468681ms
2023-07-27T12:28:47.256Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15141 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:28:49.46Z DBG ist/ist.go:223 > commit results action=commit-results height=15142 id=c5d2460186f700df4d58ea5a1f30a6253fdd9ddb6b5f1012d8c5020200000000
2023-07-27T12:28:49.461Z INF ist/results.go:100 > committing results electionID=c5d2460186f700df4d58ea5a1f30a6253fdd9ddb6b5f1012d8c5020200000000
2023-07-27T12:29:01.872Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:44876 - 200 6510B in 2.645563ms
2023-07-27T12:29:07.257Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15143 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:29:21.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:36288 - 200 6527B in 2.887677ms
2023-07-27T12:29:27.257Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15144 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:29:41.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:46860 - 200 6531B in 2.777681ms
2023-07-27T12:29:47.257Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15146 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:30:01.868Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:33190 - 200 6521B in 3.039711ms
2023-07-27T12:30:07.258Z INF vochain status blockTime="1m:15.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15147 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:30:21.869Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:59728 - 200 6507B in 2.890563ms
2023-07-27T12:30:27.259Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15149 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:30:41.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:56564 - 200 6506B in 2.881986ms
2023-07-27T12:30:47.26Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15151 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:31:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:59964 - 200 6517B in 2.855427ms
2023-07-27T12:31:05.665Z DBG ist/ist.go:247 > end process action=end-process height=15153 id=c5d2460186f7bc5096ad90f7daad3d239dc1c595cdae6e8de13d020000000000
2023-07-27T12:31:05.666Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15154 id=c5d2460186f7bc5096ad90f7daad3d239dc1c595cdae6e8de13d020000000000
2023-07-27T12:31:07.261Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15152 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:31:16.129Z DBG ist/ist.go:197 > compute results attempt=0 height=15154 id=c5d2460186f7bc5096ad90f7daad3d239dc1c595cdae6e8de13d020000000000
2023-07-27T12:31:16.129Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15156 id=c5d2460186f7bc5096ad90f7daad3d239dc1c595cdae6e8de13d020000000000
2023-07-27T12:31:21.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:47820 - 200 6530B in 2.327288ms
2023-07-27T12:31:27.261Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15154 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:31:41.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:58028 - 200 6528B in 2.584317ms
2023-07-27T12:31:44.488Z DBG ist/ist.go:223 > commit results action=commit-results height=15156 id=c5d2460186f7bc5096ad90f7daad3d239dc1c595cdae6e8de13d020000000000
2023-07-27T12:31:44.489Z INF ist/results.go:100 > committing results electionID=c5d2460186f7bc5096ad90f7daad3d239dc1c595cdae6e8de13d020000000000
2023-07-27T12:31:47.262Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15155 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:32:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:37626 - 200 6513B in 2.758476ms
2023-07-27T12:32:07.262Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15157 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:32:21.877Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:60382 - 200 6515B in 2.908206ms
2023-07-27T12:32:27.263Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15159 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0

2023-07-27T12:41:13.244Z DBG ist/ist.go:247 > end process action=end-process height=15203 id=c5d2460186f7bd5b5e1ed5c3c37fc15d34b46177cbbe72c14af0020000000000
2023-07-27T12:41:13.245Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15204 id=c5d2460186f7bd5b5e1ed5c3c37fc15d34b46177cbbe72c14af0020000000000
2023-07-27T12:41:13.245Z DBG ist/ist.go:247 > end process action=end-process height=15203 id=c5d2460186f71370e54dbcb99d03c20b54c10de2a01e4308f368020000000000
2023-07-27T12:41:13.246Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15204 id=c5d2460186f71370e54dbcb99d03c20b54c10de2a01e4308f368020000000000
2023-07-27T12:41:21.868Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:43770 - 200 6518B in 2.995026ms
2023-07-27T12:41:27.282Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15203 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:41:31.014Z DBG ist/ist.go:197 > compute results attempt=0 height=15204 id=c5d2460186f7bd5b5e1ed5c3c37fc15d34b46177cbbe72c14af0020000000000
2023-07-27T12:41:31.014Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15206 id=c5d2460186f7bd5b5e1ed5c3c37fc15d34b46177cbbe72c14af0020000000000
2023-07-27T12:41:31.015Z INF results/compute.go:78 > computed results elapsed="175.709µs" process=c5d2460186f7bd5b5e1ed5c3c37fc15d34b46177cbbe72c14af0020000000000 results=[0,1]
2023-07-27T12:41:31.015Z DBG ist/ist.go:197 > compute results attempt=0 height=15204 id=c5d2460186f71370e54dbcb99d03c20b54c10de2a01e4308f368020000000000
2023-07-27T12:41:31.016Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15206 id=c5d2460186f71370e54dbcb99d03c20b54c10de2a01e4308f368020000000000
2023-07-27T12:41:41.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:42452 - 200 6513B in 3.399925ms
2023-07-27T12:41:47.283Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15205 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:41:51.756Z DBG ist/ist.go:223 > commit results action=commit-results height=15206 id=c5d2460186f7bd5b5e1ed5c3c37fc15d34b46177cbbe72c14af0020000000000
2023-07-27T12:41:51.757Z INF ist/results.go:100 > committing results electionID=c5d2460186f7bd5b5e1ed5c3c37fc15d34b46177cbbe72c14af0020000000000
2023-07-27T12:41:51.757Z DBG ist/ist.go:223 > commit results action=commit-results height=15206 id=c5d2460186f71370e54dbcb99d03c20b54c10de2a01e4308f368020000000000
2023-07-27T12:41:51.758Z INF ist/results.go:100 > committing results electionID=c5d2460186f71370e54dbcb99d03c20b54c10de2a01e4308f368020000000000
2023-07-27T12:42:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:55032 - 200 6511B in 2.418629ms
2023-07-27T12:42:07.284Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15207 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:42:20.102Z DBG vochain/app.go:358 > deliver tx hash=35b35ecd165309f8f213409d364b83892f951c1d5062a9882a970ca0091216c2 height=15208 tx={"Payload":{"SetAccount":{"account":"E1hmyGLrV9i+u1SH5ZCJqkoqOEw=","faucetPackage":{"payload":"CPnBxcy8/JmMCxIUE1hmyGLrV9i+u1SH5ZCJqkoqOEwY6Ac=","signature":"246ZOZ/ferT+l7HIFIirv5Yju6VrjNQbH25XO7LulxQG75G27RuyO2zOjWaShxAtL7DoyAxhmr4mAUkRBg/BLgA="},"infoURI":"ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q","nonce":0,"sik":"Zfg34wwlS+R+QKsRboZ0gTeLs8mc+HA/9vOnnaUjTx4=","txtype":23}}} type=setAccount
2023-07-27T12:42:20.105Z DBG state/account.go:173 > creating account 0x135866c862Eb57D8beBB5487e59089AA4a2a384c with infoURI ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q balance 0 and delegates []
2023-07-27T12:42:20.105Z DBG state/account.go:188 > setAccount: address 0x135866c862Eb57D8beBB5487e59089AA4a2a384c, nonce 0, infoURI ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q, balance: 0, delegates: [], processIndex: 0
2023-07-27T12:42:20.105Z DBG state/sik.go:59 > setSIK (create) address=0x135866c862Eb57D8beBB5487e59089AA4a2a384c sik=65f837e30c254be47e40ab116e867481378bb3c99cf8703ff6f3a79da5234f1e
2023-07-27T12:42:20.106Z DBG state/sik.go:214 > updateSIKRoots (deleted) blockNumber=15008
2023-07-27T12:42:20.106Z DBG state/sik.go:218 > updateSIKRoots (created) blockNumber=15208 newSikRoot=24e1b68320f8fe4090d1cd72c16629f9114dac77fe976601723a3b043432b609
2023-07-27T12:42:20.106Z DBG state/balances.go:243 > transferring balance amount=1 from=c7c6e17059801b6962cc144a374ecc3ba1b8a9e0 to=ffffffffffffffffffffffffffffffffffffffff
2023-07-27T12:42:20.106Z DBG state/account.go:188 > setAccount: address 0xC7C6E17059801b6962cc144a374eCc3ba1b8A9e0, nonce 6, infoURI , balance: 99756756, delegates: [], processIndex: 0
2023-07-27T12:42:20.106Z DBG state/account.go:188 > setAccount: address 0xFFfFfFffFFfffFFfFFfFFFFFffFFFffffFfFFFfF, nonce 0, infoURI , balance: 3329, delegates: [], processIndex: 0
2023-07-27T12:42:20.106Z DBG state/balances.go:213 > consuming faucet payload created by 0xC7C6E17059801b6962cc144a374eCc3ba1b8A9e0 with amount 1000 and identifier 799503161895248121 (keyHash: b70f2024b43679849d5703ad8be75be0dcac59c48c75acdb91738ab42a067565)
2023-07-27T12:42:20.106Z DBG state/balances.go:243 > transferring balance amount=1000 from=c7c6e17059801b6962cc144a374ecc3ba1b8a9e0 to=135866c862eb57d8bebb5487e59089aa4a2a384c
2023-07-27T12:42:20.106Z DBG state/account.go:188 > setAccount: address 0xC7C6E17059801b6962cc144a374eCc3ba1b8A9e0, nonce 6, infoURI , balance: 99755756, delegates: [], processIndex: 0
2023-07-27T12:42:20.106Z DBG state/account.go:188 > setAccount: address 0x135866c862Eb57D8beBB5487e59089AA4a2a384c, nonce 0, infoURI ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q, balance: 1000, delegates: [], processIndex: 0
2023-07-27T12:42:20.109Z INF vochain/app.go:343 > commit block height=15208 txs=1
2023-07-27T12:42:21.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:54286 - 200 6541B in 2.934764ms
2023-07-27T12:42:27.284Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=205 height=15208 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:42:30.357Z DBG vochain/app.go:358 > deliver tx hash=e48648d8c6d5ed44ed66b1e8dff0607a1a8e6e5e70fa631488149256dd6e3638 height=15209 tx={"Payload":{"NewProcess":{"process":{"blockCount":820,"censusOrigin":2,"censusRoot":"CNlf3RMYHKfpBmOwtaA//qobu6DWHMO+/ojyUxbFtBY=","censusURI":"ipfs://bafybeifwuh2g6dkujiywjkrgtgqpqsdc2gxrbatvghlvr255npigt56cum","entityId":"E1hmyGLrV9i+u1SH5ZCJqkoqOEw=","envelopeType":{"anonymous":true},"maxCensusSize":2,"metadata":"ipfs://bafybeid3hyyxp47nj4m6hovybngsfm2z62l3rbnnbtdot62oeb6fbqpnhm","mode":{"autoStart":true,"interruptible":true,"preRegister":true},"status":1,"voteOptions":{"costExponent":10000,"maxCount":1,"maxValue":1}},"txtype":1}}} type=newProcess
2023-07-27T12:42:30.358Z INF state/process.go:73 > new election censusOrigin=OFF_CHAIN_TREE_WEIGHTED censusRoot=08d95fdd13181ca7e90663b0b5a03ffeaa1bbba0d61cc3befe88f25316c5b416 censusURI=ipfs://bafybeifwuh2g6dkujiywjkrgtgqpqsdc2gxrbatvghlvr255npigt56cum endBlock=16030 entityId=135866c862eb57d8bebb5487e59089aa4a2a384c envelopeType={"anonymous":true} height=15209 maxCensusSize=2 mode={"autoStart":true,"interruptible":true,"preRegister":true} processId=c5d2460186f7135866c862eb57d8bebb5487e59089aa4a2a384c020200000000 startBlock=15210 status=1 voteOptions={"costExponent":10000,"maxCount":1,"maxValue":1}
2023-07-27T12:42:30.358Z DBG state/account.go:159 > setting account 0x135866c862Eb57D8beBB5487e59089AA4a2a384c process index to 1
2023-07-27T12:42:30.358Z DBG state/account.go:188 > setAccount: address 0x135866c862Eb57D8beBB5487e59089AA4a2a384c, nonce 0, infoURI ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q, balance: 1000, delegates: [], processIndex: 1
2023-07-27T12:42:30.358Z DBG ist/ist.go:127 > schedule IST action action=end-process height=16030 id=c5d2460186f7135866c862eb57d8bebb5487e59089aa4a2a384c020200000000
2023-07-27T12:42:30.36Z DBG state/account.go:243 > burning fee for tx NEW_PROCESS with cost 23 from account 0x135866c862Eb57D8beBB5487e59089AA4a2a384c
2023-07-27T12:42:30.36Z DBG state/account.go:188 > setAccount: address 0xFFfFfFffFFfffFFfFFfFFFFFffFFFffffFfFFFfF, nonce 0, infoURI , balance: 3352, delegates: [], processIndex: 0
2023-07-27T12:42:30.36Z DBG state/account.go:188 > setAccount: address 0x135866c862Eb57D8beBB5487e59089AA4a2a384c, nonce 1, infoURI ipfs://bafybeigv4mfmn3tyusbwmskfn6xhoyvv2i2svdq7pns6dphdivefr62k3q, balance: 977, delegates: [], processIndex: 1
2023-07-27T12:42:30.362Z INF vochain/app.go:343 > commit block height=15209 txs=1
2023-07-27T12:42:40.691Z DBG ist/ist.go:247 > end process action=end-process height=15210 id=c5d2460186f74525863880d2c5560dbfdc03f022acc298cc7939020000000000
2023-07-27T12:42:40.693Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15211 id=c5d2460186f74525863880d2c5560dbfdc03f022acc298cc7939020000000000
2023-07-27T12:42:41.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:58028 - 200 6530B in 3.296783ms
2023-07-27T12:42:47.284Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15210 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:42:51.046Z DBG ist/ist.go:197 > compute results attempt=0 height=15211 id=c5d2460186f74525863880d2c5560dbfdc03f022acc298cc7939020000000000
2023-07-27T12:42:51.046Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15213 id=c5d2460186f74525863880d2c5560dbfdc03f022acc298cc7939020000000000
2023-07-27T12:42:51.047Z INF results/compute.go:78 > computed results elapsed="222.186µs" process=c5d2460186f74525863880d2c5560dbfdc03f022acc298cc7939020000000000 results=[5,5]
2023-07-27T12:43:01.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:58764 - 200 6521B in 2.805203ms
2023-07-27T12:43:07.285Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15211 mempool=0 peers=7 voteCache=0 votes=550 votes/min=0
2023-07-27T12:43:11.925Z DBG transaction/vote_tx.go:167 > new vote electionID=c5d2460186f7135866c862eb57d8bebb5487e59089aa4a2a384c020200000000 nullifier=148767441453211199851135850129307383597264920658762385541367871936621457489750 type=zkSNARK
2023-07-27T12:43:19.144Z DBG vochain/app.go:358 > deliver tx hash=2e92280c6ea736358ea70bfd8f9477190fb1d5536ca43dbd7ffeea6e844a0691 height=15213 tx={"Payload":{"Vote":{"nonce":"fqS+CAFVLMQwhUYcnEn/nYWShggbd4JaKGBcPsGA21c=","nullifier":"FIdnRBRTIRGZhRE1hQEpMHODWXJkkgZYdiOFVBNnhxk2YhRXSJdQ","processId":"xdJGAYb3E1hmyGLrV9i+u1SH5ZCJqkoqOEwCAgAAAAA=","proof":{"Payload":{"ZkSnark":{"a":["11942813533624036619196686340284647715629959353173452827897072718385786794256","18613879450244566687662747170638615221872320934831437614900134239498646826833","1"],"b":["3444271419186555928475108171039755483455509594089276570742671183829516787940","13262300285930178220232204731319902385751081388767039886387240573013653415871","7671807161389759153876477018473023169930817535199949756455717998259448205475","15736193289259461074971074598960927252216276954414070957354484173575991158914","1","0"],"c":["13924526137312739652462276130752293269039103673904281509927482114423520540220","11069428236232345593067152854443800253687785531066506099013645694018703672345","1"],"publicInputs":["30597866734949521510901314017487266229","14963951817308252790770503696463508443","14876744145321119985113585012930738359726492065876238554136787193662145748975","1","195730901639124056921570056589921458726","129906658586233122414795331685470603782","4392728292719243940291946494194635376201804447664252801422023266744185315620","10270275386481807518761839199628305656357357444241370667966093113572777253128"]}}},"votePackage":"eyJub25jZSI6ImE2ODJkODI0ZTcyMTczZWMiLCJ2b3RlcyI6WzBdfQ=="}}} type=vote
2023-07-27T12:43:19.145Z DBG ist/ist.go:223 > commit results action=commit-results height=15213 id=c5d2460186f74525863880d2c5560dbfdc03f022acc298cc7939020000000000
2023-07-27T12:43:19.146Z INF ist/results.go:100 > committing results electionID=c5d2460186f74525863880d2c5560dbfdc03f022acc298cc7939020000000000
2023-07-27T12:43:19.149Z INF vochain/app.go:343 > commit block height=15213 txs=1
2023-07-27T12:43:21.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:37428 - 200 6520B in 2.459499ms
2023-07-27T12:43:27.286Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15213 mempool=0 peers=7 voteCache=0 votes=551 votes/min=0
2023-07-27T12:43:41.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:44636 - 200 6522B in 2.919301ms
2023-07-27T12:43:47.287Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15215 mempool=0 peers=7 voteCache=0 votes=551 votes/min=0
2023-07-27T12:44:01.864Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:38620 - 200 6531B in 2.747108ms
2023-07-27T12:44:07.287Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15216 mempool=0 peers=7 voteCache=0 votes=551 votes/min=0
2023-07-27T12:44:07.977Z DBG ist/ist.go:247 > end process action=end-process height=15217 id=c5d2460186f7a7b2db2be0d2f147f34aab379d2671fedfb5e734020000000000
2023-07-27T12:44:07.977Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15218 id=c5d2460186f7a7b2db2be0d2f147f34aab379d2671fedfb5e734020000000000
2023-07-27T12:44:18.414Z DBG ist/ist.go:197 > compute results attempt=0 height=15218 id=c5d2460186f7a7b2db2be0d2f147f34aab379d2671fedfb5e734020000000000
2023-07-27T12:44:18.415Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15220 id=c5d2460186f7a7b2db2be0d2f147f34aab379d2671fedfb5e734020000000000
2023-07-27T12:44:18.415Z INF results/compute.go:78 > computed results elapsed="217.867µs" process=c5d2460186f7a7b2db2be0d2f147f34aab379d2671fedfb5e734020000000000 results=[25,30]
2023-07-27T12:44:21.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:43278 - 200 6538B in 2.958083ms
2023-07-27T12:44:27.287Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15218 mempool=0 peers=7 voteCache=0 votes=551 votes/min=1
2023-07-27T12:44:41.868Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:34314 - 200 6528B in 2.875558ms
2023-07-27T12:44:46.592Z DBG ist/ist.go:223 > commit results action=commit-results height=15220 id=c5d2460186f7a7b2db2be0d2f147f34aab379d2671fedfb5e734020000000000
2023-07-27T12:44:46.593Z INF ist/results.go:100 > committing results electionID=c5d2460186f7a7b2db2be0d2f147f34aab379d2671fedfb5e734020000000000
2023-07-27T12:44:47.288Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15219 mempool=0 peers=7 voteCache=0 votes=551 votes/min=1
2023-07-27T12:45:01.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:38156 - 200 6525B in 3.031038ms
2023-07-27T12:45:07.29Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15221 mempool=0 peers=7 voteCache=0 votes=551 votes/min=1
2023-07-27T12:45:17.907Z DBG ist/ist.go:247 > end process action=end-process height=15223 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:45:17.908Z INF keykeeper/keykeeper.go:275 > process ended, scheduling reveal keys for next block
2023-07-27T12:45:17.908Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15224 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:45:17.911Z INF keykeeper/keykeeper.go:339 > scheduled reveal keys of process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 for block 15224
2023-07-27T12:45:17.912Z INF keykeeper/keykeeper.go:380 > revealing keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 on block 15223
2023-07-27T12:45:17.912Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x04CC36BE85A0a6e2bfd09295396625e6302d7C60 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"HiJXX2WxdVbrom1kwFNFwyn70EtOmNBwmjUK/Rj+6pE=\",\"keyIndex\":1,\"nonce\":225143383}"
2023-07-27T12:45:17.913Z DBG vochain/appsetup.go:67 > broadcast tx error= result=0 size=148
2023-07-27T12:45:17.913Z INF keykeeper/keykeeper.go:458 > revealing encryption key for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:45:17.992Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"GUvYouq6DjtTystU+IhulmY2VPgdiDG+AKHYclHAFj8=\",\"keyIndex\":4,\"nonce\":64342652}"
2023-07-27T12:45:17.993Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xa9b1008f17654B36f2a9AbD29323C53d344415A0 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"tuT9amw7EB94tRsgIgKfDd/7NHJMKXy1dI9QqIJVsiY=\",\"keyIndex\":3,\"nonce\":488060828}"
2023-07-27T12:45:18.015Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xFc095a35338D96503b6fD1010475e45A3545fC25 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"IkCeY0CqLEajxmzmYIxEX/CiOYyG1vTGI6ttlqnlGYA=\",\"keyIndex\":2,\"nonce\":488797768}"
2023-07-27T12:45:21.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:56040 - 200 6537B in 2.894373ms
2023-07-27T12:45:27.29Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15223 mempool=4 peers=7 voteCache=0 votes=551 votes/min=0
2023-07-27T12:45:35.653Z DBG vochain/app.go:358 > deliver tx hash=2c346e2e0483c6f00eda4fea038cf8c0f6f05c4b8c70be9b71ba1cf051832080 height=15224 tx={"Payload":{"Admin":{"encryptionPrivateKey":"tuT9amw7EB94tRsgIgKfDd/7NHJMKXy1dI9QqIJVsiY=","keyIndex":3,"nonce":488060828,"processId":"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:45:35.654Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xa9b1008f17654B36f2a9AbD29323C53d344415A0 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"tuT9amw7EB94tRsgIgKfDd/7NHJMKXy1dI9QqIJVsiY=\",\"keyIndex\":3,\"nonce\":488060828}"
2023-07-27T12:45:35.655Z DBG state/state.go:373 > revealed encryption key 3 for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000: b6e4fd6a6c3b101f78b51b2022029f0ddffb34724c297cb5748f50a88255b226
2023-07-27T12:45:35.655Z DBG vochain/app.go:358 > deliver tx hash=f16620fd961c16f06939f9a8dd3c66fe2eb0ca359a35b6d86fbbeb2eb40e7dc8 height=15224 tx={"Payload":{"Admin":{"encryptionPrivateKey":"HiJXX2WxdVbrom1kwFNFwyn70EtOmNBwmjUK/Rj+6pE=","keyIndex":1,"nonce":225143383,"processId":"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:45:35.655Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x04CC36BE85A0a6e2bfd09295396625e6302d7C60 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"HiJXX2WxdVbrom1kwFNFwyn70EtOmNBwmjUK/Rj+6pE=\",\"keyIndex\":1,\"nonce\":225143383}"
2023-07-27T12:45:35.656Z DBG state/state.go:373 > revealed encryption key 1 for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000: 1e22575f65b17556eba26d64c05345c329fbd04b4e98d0709a350afd18feea91
2023-07-27T12:45:35.656Z DBG vochain/app.go:358 > deliver tx hash=974d424de48a12c8c8c517f9cae9671cf7c1eb362c4b17c40f032cb5d8a942a0 height=15224 tx={"Payload":{"Admin":{"encryptionPrivateKey":"IkCeY0CqLEajxmzmYIxEX/CiOYyG1vTGI6ttlqnlGYA=","keyIndex":2,"nonce":488797768,"processId":"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:45:35.657Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0xFc095a35338D96503b6fD1010475e45A3545fC25 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"IkCeY0CqLEajxmzmYIxEX/CiOYyG1vTGI6ttlqnlGYA=\",\"keyIndex\":2,\"nonce\":488797768}"
2023-07-27T12:45:35.657Z DBG state/state.go:373 > revealed encryption key 2 for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000: 22409e6340aa2c46a3c66ce6608c445ff0a2398c86d6f4c623ab6d96a9e51980
2023-07-27T12:45:35.658Z DBG ist/ist.go:197 > compute results attempt=0 height=15224 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:45:35.658Z INF ist/ist.go:202 > missing keys, rescheduling IST action action=compute-results attempt=0 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 newHeight=15225
2023-07-27T12:45:35.658Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15225 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:45:35.666Z INF vochain/app.go:343 > commit block height=15224 txs=3
2023-07-27T12:45:35.666Z INF keykeeper/keykeeper.go:380 > revealing keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 on block 15224
2023-07-27T12:45:35.667Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x04CC36BE85A0a6e2bfd09295396625e6302d7C60 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"HiJXX2WxdVbrom1kwFNFwyn70EtOmNBwmjUK/Rj+6pE=\",\"keyIndex\":1,\"nonce\":130207113}"
2023-07-27T12:45:35.668Z ERR vochain/app.go:278 > checkTx error="adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed"
2023-07-27T12:45:35.668Z DBG vochain/appsetup.go:67 > broadcast tx error="adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed" result=-1 size=148
2023-07-27T12:45:35.668Z ERR keykeeper/keykeeper.go:382 > cannot reveal process keys for c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000: (adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed)
2023-07-27T12:45:35.749Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"GUvYouq6DjtTystU+IhulmY2VPgdiDG+AKHYclHAFj8=\",\"keyIndex\":4,\"nonce\":316566690}"
2023-07-27T12:45:41.866Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:55396 - 200 6524B in 3.157948ms
2023-07-27T12:45:45.987Z DBG vochain/app.go:358 > deliver tx hash=0b7988fbe927dd8da994448a52f4f17164df4a7ea21c35210becda63acba5ed9 height=15225 tx={"Payload":{"Admin":{"encryptionPrivateKey":"GUvYouq6DjtTystU+IhulmY2VPgdiDG+AKHYclHAFj8=","keyIndex":4,"nonce":316566690,"processId":"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=","txtype":6}}} type=admin
2023-07-27T12:45:45.987Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"GUvYouq6DjtTystU+IhulmY2VPgdiDG+AKHYclHAFj8=\",\"keyIndex\":4,\"nonce\":316566690}"
2023-07-27T12:45:45.988Z DBG state/state.go:373 > revealed encryption key 4 for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000: 194bd8a2eaba0e3b53cacb54f8886e96663654f81d8831be00a1d87251c0163f
2023-07-27T12:45:45.988Z DBG ist/ist.go:197 > compute results attempt=1 height=15225 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:45:45.988Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15227 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:45:45.991Z INF vochain/app.go:343 > commit block height=15225 txs=1
2023-07-27T12:45:45.996Z INF results/compute.go:78 > computed results elapsed=7.481988ms process=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 results=[5,5]
2023-07-27T12:45:47.291Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15224 mempool=2 peers=7 voteCache=0 votes=551 votes/min=0
2023-07-27T12:45:55.984Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"GUvYouq6DjtTystU+IhulmY2VPgdiDG+AKHYclHAFj8=\",\"keyIndex\":4,\"nonce\":64342652}"
2023-07-27T12:45:55.985Z ERR vochain/app.go:278 > checkTx error="adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed"
2023-07-27T12:45:55.985Z WRN vochain/app.go:486 > discard invalid tx on prepare proposal code=1 data="checkTx adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed" err="adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed" info= log=
2023-07-27T12:46:01.865Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:47088 - 200 6507B in 2.967509ms
2023-07-27T12:46:06.763Z DBG ist/ist.go:223 > commit results action=commit-results height=15227 id=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:46:06.764Z INF ist/results.go:100 > committing results electionID=c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000
2023-07-27T12:46:07.292Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15226 mempool=1 peers=7 voteCache=0 votes=551 votes/min=0
2023-07-27T12:46:21.868Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:58338 - 200 6531B in 2.39113ms
2023-07-27T12:46:24.547Z DBG ist/ist.go:247 > end process action=end-process height=15228 id=c5d2460186f7a9a3ed92674353a406f8c7737981a650d3cbe34e020000000000
2023-07-27T12:46:24.548Z DBG ist/ist.go:127 > schedule IST action action=compute-results height=15229 id=c5d2460186f7a9a3ed92674353a406f8c7737981a650d3cbe34e020000000000
2023-07-27T12:46:24.552Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"GUvYouq6DjtTystU+IhulmY2VPgdiDG+AKHYclHAFj8=\",\"keyIndex\":4,\"nonce\":64342652}"
2023-07-27T12:46:24.552Z ERR vochain/app.go:278 > checkTx error="adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed"
2023-07-27T12:46:24.553Z ERR comet: recheckTx
2023-07-27T12:46:27.292Z INF vochain status blockTime="1m:12.00 10m:12.24 1h:12.20 6h:12.22 24h:12.21" elections=206 height=15227 mempool=1 peers=7 voteCache=0 votes=551 votes/min=0
2023-07-27T12:46:34.878Z DBG ist/ist.go:197 > compute results attempt=0 height=15229 id=c5d2460186f7a9a3ed92674353a406f8c7737981a650d3cbe34e020000000000
2023-07-27T12:46:34.878Z DBG ist/ist.go:127 > schedule IST action action=commit-results height=15231 id=c5d2460186f7a9a3ed92674353a406f8c7737981a650d3cbe34e020000000000
2023-07-27T12:46:34.879Z INF results/compute.go:78 > computed results elapsed="254.677µs" process=c5d2460186f7a9a3ed92674353a406f8c7737981a650d3cbe34e020000000000 results=[2,2]
2023-07-27T12:46:41.867Z DBG middleware/logger.go:158 > "GET http://miner1.dev.vocdoni.net:9090/metrics HTTP/1.1" from 95.217.216.185:51838 - 200 6524B in 3.420026ms
2023-07-27T12:46:44.875Z DBG transaction/admin_tx.go:31 > checking admin tx addr=0x234120598E3FcFCFAE5d969254d371248B0cF8D1 tx="{\"txtype\":\"REVEAL_PROCESS_KEYS\",\"processId\":\"xdJGAYb3dqes9zdykuU8IVl4ski1TyxwN9gCBAAAAAA=\",\"encryptionPrivateKey\":\"GUvYouq6DjtTystU+IhulmY2VPgdiDG+AKHYclHAFj8=\",\"keyIndex\":4,\"nonce\":64342652}"
2023-07-27T12:46:44.875Z ERR vochain/app.go:278 > checkTx error="adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed"
2023-07-27T12:46:44.875Z WRN vochain/app.go:486 > discard invalid tx on prepare proposal code=1 data="checkTx adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed" err="adminTx: keys for process c5d2460186f776a7acf7377292e53c215978b248b54f2c7037d8020400000000 already revealed" info= log=
@p4u p4u self-assigned this Jul 27, 2023
@altergui
Copy link
Contributor

altergui commented Mar 6, 2024

i believe this might have been fixed by #1264

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@p4u p4u

Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@p4u @altergui