search

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
85 stars 16 forks source link

Reveal key transaction gets stuck forever #1064

Open p4u opened 1 year ago

p4u commented 1 year ago 
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=
altergui commented 6 months ago

i believe this might have been fixed by #1264