oasisprotocol / oasis-core

Performant and Confidentiality-Preserving Smart Contracts + Blockchains
https://oasisprotocol.org
Apache License 2.0
334 stars 110 forks source link

Make End-to-End tests' default console output less verbose #2737

Open tjanez opened 4 years ago

tjanez commented 4 years ago
SUMMARY

At the moment, running make test-e2e produces quite verbose output similar to the following:

End-to-End default console output ``` *** Running E2E tests... + WORKDIR=/home/tadej/Oasis/oasis-core + runtime_target=default + [[ '' == \i\n\t\e\l\-\s\g\x ]] + [[ '' != '' ]] + node_binary=/home/tadej/Oasis/oasis-core/go/oasis-node/oasis-node + [[ '' != '' ]] + /home/tadej/Oasis/oasis-core/go/oasis-test-runner/oasis-test-runner --basedir.no_cleanup --e2e.node.binary /home/tadej/Oasis/oasis-core/go/oasis-node/oasis-node --e2e.client.binary_dir /home/tadej/Oasis/oasis-core/target/default/debug --e2e.runtime.binary_dir /home/tadej/Oasis/oasis-core/target/default/debug --e2e.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --e2e.tee_hardware '' --log.level info level=info module=test-runner caller=root.go:196 ts=2020-02-27T15:59:33.674210828Z msg="running test case" test=basic level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:33.674428006Z msg="launching node" args="registry entity init --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:33.779448256Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/basic/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.kind keymanager --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:33.826930496Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/basic/network/runtime-8000000000000000000000000000000000000000000000000000000000000000 --runtime.id 8000000000000000000000000000000000000000000000000000000000000000 --runtime.kind compute --runtime.executor.group_size 2 --runtime.executor.group_backup_size 1 --runtime.executor.allowed_stragglers 0 --runtime.executor.round_timeout 10s --runtime.merge.group_size 2 --runtime.merge.group_backup_size 1 --runtime.merge.allowed_stragglers 0 --runtime.merge.round_timeout 10s --runtime.txn_scheduler.group_size 1 --runtime.txn_scheduler.batching.max_batch_size 1 --runtime.txn_scheduler.batching.max_batch_size_bytes 1000 --runtime.txn_scheduler.algorithm batching --runtime.txn_scheduler.flush_timeout 1s --runtime.storage.group_size 2 --runtime.storage.max_apply_write_log_entries 100000 --runtime.storage.max_apply_ops 2 --runtime.storage.max_merge_roots 8 --runtime.storage.max_merge_ops 2 --runtime.storage.checkpoint_interval 0 --runtime.storage.checkpoint_num_kept 0 --runtime.storage.checkpoint_chunk_size 0 --runtime.keymanager c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:33.875103118Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:33.915064606Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/basic/network/validator-0 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20000 --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:33.956191771Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.003869501Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/basic/network/validator-1 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20001 --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.044978654Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc= --entity.node.id w8nei5BMEaML7KirBgbJMMAI+nlxjYlfHIE7NK+G5Xg=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.101317104Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/basic/network/validator-2 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20002 --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.152325761Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc= --entity.node.id w8nei5BMEaML7KirBgbJMMAI+nlxjYlfHIE7NK+G5Xg= --entity.node.id 4Cr1NkKo9hvJAWRP6qhgT/g13ARonZXSvaVtkwc5n6g=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.202182507Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc= --entity.node.id w8nei5BMEaML7KirBgbJMMAI+nlxjYlfHIE7NK+G5Xg= --entity.node.id 4Cr1NkKo9hvJAWRP6qhgT/g13ARonZXSvaVtkwc5n6g= --entity.node.id yupB+MH9HytqbRkvJKNOReMvO+GiIQdA+h+6PcvNsYo=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.245641456Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc= --entity.node.id w8nei5BMEaML7KirBgbJMMAI+nlxjYlfHIE7NK+G5Xg= --entity.node.id 4Cr1NkKo9hvJAWRP6qhgT/g13ARonZXSvaVtkwc5n6g= --entity.node.id yupB+MH9HytqbRkvJKNOReMvO+GiIQdA+h+6PcvNsYo= --entity.node.id X9XvEXvjoTqUciuKYPIHSf0NeJmbgFrKUrrdUQ7/s3M=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.280335923Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc= --entity.node.id w8nei5BMEaML7KirBgbJMMAI+nlxjYlfHIE7NK+G5Xg= --entity.node.id 4Cr1NkKo9hvJAWRP6qhgT/g13ARonZXSvaVtkwc5n6g= --entity.node.id yupB+MH9HytqbRkvJKNOReMvO+GiIQdA+h+6PcvNsYo= --entity.node.id X9XvEXvjoTqUciuKYPIHSf0NeJmbgFrKUrrdUQ7/s3M= --entity.node.id oF0PmOM0RlQz2P8ejuJAiGx6+NH9CBg7JKaN5oc3lII=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.316715082Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc= --entity.node.id w8nei5BMEaML7KirBgbJMMAI+nlxjYlfHIE7NK+G5Xg= --entity.node.id 4Cr1NkKo9hvJAWRP6qhgT/g13ARonZXSvaVtkwc5n6g= --entity.node.id yupB+MH9HytqbRkvJKNOReMvO+GiIQdA+h+6PcvNsYo= --entity.node.id X9XvEXvjoTqUciuKYPIHSf0NeJmbgFrKUrrdUQ7/s3M= --entity.node.id oF0PmOM0RlQz2P8ejuJAiGx6+NH9CBg7JKaN5oc3lII= --entity.node.id oKZx1p1Q6sR95bL00xyz1pwfTgbvrl6oauZ+B0RD1zs=" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.366865888Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic/network/entity-1 --entity.node.id YvSL/WTWNkpTlcDMsfaDJWxPVxmODFDM4etqilz4jCE= --entity.node.id TMc4kS0L7LHRUMoG/hST6cCCmKnO6Gz8Mw26F7o6TGc= --entity.node.id w8nei5BMEaML7KirBgbJMMAI+nlxjYlfHIE7NK+G5Xg= --entity.node.id 4Cr1NkKo9hvJAWRP6qhgT/g13ARonZXSvaVtkwc5n6g= --entity.node.id yupB+MH9HytqbRkvJKNOReMvO+GiIQdA+h+6PcvNsYo= --entity.node.id X9XvEXvjoTqUciuKYPIHSf0NeJmbgFrKUrrdUQ7/s3M= --entity.node.id oF0PmOM0RlQz2P8ejuJAiGx6+NH9CBg7JKaN5oc3lII= --entity.node.id oKZx1p1Q6sR95bL00xyz1pwfTgbvrl6oauZ+B0RD1zs= --entity.node.id AU7+J06+jYm7x03bolXuyuY0jbDLZOvWgv/RrnRcG+c=" level=info module=oasis/basic caller=oasis.go:375 ts=2020-02-27T15:59:34.410189357Z msg="starting network" level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.41025051Z msg="launching node" args="keymanager init_status --debug.dont_blame_oasis --debug.allow_test_keys --keymanager.status.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --keymanager.status.file /tmp/oasis-test-runner973079579/basic/network/keymanager/keymanager_status.json --keymanager.policy.file " level=info module=oasis/basic caller=oasis.go:570 ts=2020-02-27T15:59:34.444436192Z msg="launching node" args="genesis init --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --chain.id test: oasis-core tests --halt.epoch 18446744073709551615 --consensus.backend tendermint --epochtime.tendermint.interval 30 --consensus.tendermint.timeout_commit 250ms --registry.debug.allow_unroutable_addresses true --registry.debug.allow_test_runtimes true --scheduler.max_validators_per_entity 3 --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys --entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity_genesis.json --node /tmp/oasis-test-runner973079579/basic/network/validator-0/node_genesis.json --node /tmp/oasis-test-runner973079579/basic/network/validator-1/node_genesis.json --node /tmp/oasis-test-runner973079579/basic/network/validator-2/node_genesis.json --runtime /tmp/oasis-test-runner973079579/basic/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff/runtime_genesis.json --runtime /tmp/oasis-test-runner973079579/basic/network/runtime-8000000000000000000000000000000000000000000000000000000000000000/runtime_genesis.json --keymanager /tmp/oasis-test-runner973079579/basic/network/keymanager/keymanager_status.json" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:34.502457501Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/seed --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/seed/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20021 --tendermint.p2p.seed_mode --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:34.502658296Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/validator-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/validator-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20000 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --supplementarysanity.enabled --supplementarysanity.interval 1 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:37.502899453Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/validator-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/validator-1/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20001 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:40.503232792Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/validator-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/validator-2/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20002 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:43.503639505Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/keymanager --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/keymanager/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20003 --consensus.tendermint.submission.gas_price 0 --worker.client.port 20004 --worker.keymanager.enabled --worker.keymanager.runtime.binary /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-keymanager-runtime --worker.keymanager.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.keymanager.runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --worker.keymanager.may_generate --grpc.log.debug --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:43.50402878Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/storage-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/storage-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20005 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20006 --worker.p2p.port 20007 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:43.504292957Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/storage-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/storage-1/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20008 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20009 --worker.p2p.port 20010 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:43.504581875Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/compute-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/compute-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20011 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20012 --worker.p2p.port 20013 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:43.504880639Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/compute-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/compute-1/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20014 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20015 --worker.p2p.port 20016 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:43.5055194Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/compute-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/compute-2/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20017 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20018 --worker.p2p.port 20019 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:633 ts=2020-02-27T15:59:43.515082902Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic/network/client-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic/network/client-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20020 --storage.backend client --grpc.log.debug --tendermint.p2p.seed 50EEE0D304AAD53BD6C9907C3E33B264D5AFABDD@127.0.0.1:20021 --runtime.history.tag_indexer.backend bleve --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic caller=oasis.go:551 ts=2020-02-27T15:59:43.518825442Z msg="network started" ts=2020-02-27T15:59:43.518928702Z level=info module=e2e/common caller=common.go:94 msg="launching client" binary=/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue-client args="--node-address unix:/tmp/oasis-test-runner973079579/basic/network/client-0/internal.sock --runtime-id 8000000000000000000000000000000000000000000000000000000000000000" level=info module=test-runner caller=root.go:231 ts=2020-02-27T16:00:46.65018722Z msg="passed test case" test=basic level=info module=test-runner caller=root.go:196 ts=2020-02-27T16:00:46.650214321Z msg="running test case" test=basic-encryption level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.650308103Z msg="launching node" args="registry entity init --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.698301982Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/basic-encryption/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.kind keymanager --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.747135138Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/basic-encryption/network/runtime-8000000000000000000000000000000000000000000000000000000000000000 --runtime.id 8000000000000000000000000000000000000000000000000000000000000000 --runtime.kind compute --runtime.executor.group_size 2 --runtime.executor.group_backup_size 1 --runtime.executor.allowed_stragglers 0 --runtime.executor.round_timeout 10s --runtime.merge.group_size 2 --runtime.merge.group_backup_size 1 --runtime.merge.allowed_stragglers 0 --runtime.merge.round_timeout 10s --runtime.txn_scheduler.group_size 1 --runtime.txn_scheduler.batching.max_batch_size 1 --runtime.txn_scheduler.batching.max_batch_size_bytes 1000 --runtime.txn_scheduler.algorithm batching --runtime.txn_scheduler.flush_timeout 1s --runtime.storage.group_size 2 --runtime.storage.max_apply_write_log_entries 100000 --runtime.storage.max_apply_ops 2 --runtime.storage.max_merge_roots 8 --runtime.storage.max_merge_ops 2 --runtime.storage.checkpoint_interval 0 --runtime.storage.checkpoint_num_kept 0 --runtime.storage.checkpoint_chunk_size 0 --runtime.keymanager c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.792151418Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.836449146Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/basic-encryption/network/validator-0 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20000 --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.878131606Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.919372414Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/basic-encryption/network/validator-1 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20001 --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:46.965801247Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw= --entity.node.id mUR7+5Ozv7TDj0USow+mmCmW9nR0ZAfZRrlRvVaSGYs=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.008058116Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/basic-encryption/network/validator-2 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20002 --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.047485659Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw= --entity.node.id mUR7+5Ozv7TDj0USow+mmCmW9nR0ZAfZRrlRvVaSGYs= --entity.node.id 6nC+4qjnUtUaBczh+8Q8LRyV2vB1+yHKd8BOUvUqjVU=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.093745194Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw= --entity.node.id mUR7+5Ozv7TDj0USow+mmCmW9nR0ZAfZRrlRvVaSGYs= --entity.node.id 6nC+4qjnUtUaBczh+8Q8LRyV2vB1+yHKd8BOUvUqjVU= --entity.node.id qLpu1VYgWKdQuDylw0tYNFRAiAN9szKV/erco0yt3lM=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.144268813Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw= --entity.node.id mUR7+5Ozv7TDj0USow+mmCmW9nR0ZAfZRrlRvVaSGYs= --entity.node.id 6nC+4qjnUtUaBczh+8Q8LRyV2vB1+yHKd8BOUvUqjVU= --entity.node.id qLpu1VYgWKdQuDylw0tYNFRAiAN9szKV/erco0yt3lM= --entity.node.id nl+FXBCiEaEuxaWlMABhHIXjiJZM8OjbWVboSPh58CA=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.178800165Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw= --entity.node.id mUR7+5Ozv7TDj0USow+mmCmW9nR0ZAfZRrlRvVaSGYs= --entity.node.id 6nC+4qjnUtUaBczh+8Q8LRyV2vB1+yHKd8BOUvUqjVU= --entity.node.id qLpu1VYgWKdQuDylw0tYNFRAiAN9szKV/erco0yt3lM= --entity.node.id nl+FXBCiEaEuxaWlMABhHIXjiJZM8OjbWVboSPh58CA= --entity.node.id hnIY79ewsY6kyG/wMgdTjzVUOQi6aV87miA8rFyk2zM=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.234132311Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw= --entity.node.id mUR7+5Ozv7TDj0USow+mmCmW9nR0ZAfZRrlRvVaSGYs= --entity.node.id 6nC+4qjnUtUaBczh+8Q8LRyV2vB1+yHKd8BOUvUqjVU= --entity.node.id qLpu1VYgWKdQuDylw0tYNFRAiAN9szKV/erco0yt3lM= --entity.node.id nl+FXBCiEaEuxaWlMABhHIXjiJZM8OjbWVboSPh58CA= --entity.node.id hnIY79ewsY6kyG/wMgdTjzVUOQi6aV87miA8rFyk2zM= --entity.node.id AZUfZf5c4Qw9ahqxmTTbxckvySLSa70+x/lHlUbn39Y=" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.280196185Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1 --entity.node.id PSegh+2mK5T3MbIcTeN44i/Zgmi7KWW6U8PW6wH8eH8= --entity.node.id sIIo+MoRMVnZRNdsY/4co+zz8qk2CROD7t14vgylLYw= --entity.node.id mUR7+5Ozv7TDj0USow+mmCmW9nR0ZAfZRrlRvVaSGYs= --entity.node.id 6nC+4qjnUtUaBczh+8Q8LRyV2vB1+yHKd8BOUvUqjVU= --entity.node.id qLpu1VYgWKdQuDylw0tYNFRAiAN9szKV/erco0yt3lM= --entity.node.id nl+FXBCiEaEuxaWlMABhHIXjiJZM8OjbWVboSPh58CA= --entity.node.id hnIY79ewsY6kyG/wMgdTjzVUOQi6aV87miA8rFyk2zM= --entity.node.id AZUfZf5c4Qw9ahqxmTTbxckvySLSa70+x/lHlUbn39Y= --entity.node.id 7N8KMuIZPVs1GpLZz+6hGKEbyTAPxMCdGKnXIahWVEc=" level=info module=oasis/basic-encryption caller=oasis.go:375 ts=2020-02-27T16:00:47.315782113Z msg="starting network" level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.315858242Z msg="launching node" args="keymanager init_status --debug.dont_blame_oasis --debug.allow_test_keys --keymanager.status.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --keymanager.status.file /tmp/oasis-test-runner973079579/basic-encryption/network/keymanager/keymanager_status.json --keymanager.policy.file " level=info module=oasis/basic-encryption caller=oasis.go:570 ts=2020-02-27T16:00:47.365053093Z msg="launching node" args="genesis init --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --chain.id test: oasis-core tests --halt.epoch 18446744073709551615 --consensus.backend tendermint --epochtime.tendermint.interval 30 --consensus.tendermint.timeout_commit 250ms --registry.debug.allow_unroutable_addresses true --registry.debug.allow_test_runtimes true --scheduler.max_validators_per_entity 3 --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys --entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity_genesis.json --node /tmp/oasis-test-runner973079579/basic-encryption/network/validator-0/node_genesis.json --node /tmp/oasis-test-runner973079579/basic-encryption/network/validator-1/node_genesis.json --node /tmp/oasis-test-runner973079579/basic-encryption/network/validator-2/node_genesis.json --runtime /tmp/oasis-test-runner973079579/basic-encryption/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff/runtime_genesis.json --runtime /tmp/oasis-test-runner973079579/basic-encryption/network/runtime-8000000000000000000000000000000000000000000000000000000000000000/runtime_genesis.json --keymanager /tmp/oasis-test-runner973079579/basic-encryption/network/keymanager/keymanager_status.json" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:47.42071752Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/seed --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/seed/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20021 --tendermint.p2p.seed_mode --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:47.421438627Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/validator-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/validator-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20000 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --supplementarysanity.enabled --supplementarysanity.interval 1 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:50.421988493Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/validator-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/validator-1/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20001 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:53.422563254Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/validator-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/validator-2/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20002 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:56.423101759Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/keymanager --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/keymanager/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20003 --consensus.tendermint.submission.gas_price 0 --worker.client.port 20004 --worker.keymanager.enabled --worker.keymanager.runtime.binary /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-keymanager-runtime --worker.keymanager.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.keymanager.runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --worker.keymanager.may_generate --grpc.log.debug --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:56.423471564Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/storage-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/storage-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20005 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20006 --worker.p2p.port 20007 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:56.42373562Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/storage-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/storage-1/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20008 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20009 --worker.p2p.port 20010 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:56.424071024Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/compute-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/compute-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20011 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20012 --worker.p2p.port 20013 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:56.424501103Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/compute-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/compute-1/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20014 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20015 --worker.p2p.port 20016 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:56.426125527Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/compute-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/compute-2/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20017 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20018 --worker.p2p.port 20019 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --worker.registration.entity /tmp/oasis-test-runner973079579/basic-encryption/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:633 ts=2020-02-27T16:00:56.428666309Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/basic-encryption/network/client-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/basic-encryption/network/client-0/node.log --genesis.file /tmp/oasis-test-runner973079579/basic-encryption/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20020 --storage.backend client --grpc.log.debug --tendermint.p2p.seed D4D486159A35250158C32BBF07468FB2A15DC8AA@127.0.0.1:20021 --runtime.history.tag_indexer.backend bleve --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/basic-encryption caller=oasis.go:551 ts=2020-02-27T16:00:56.429390377Z msg="network started" ts=2020-02-27T16:00:56.429527952Z level=info module=e2e/common caller=common.go:94 msg="launching client" binary=/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue-enc-client args="--node-address unix:/tmp/oasis-test-runner973079579/basic-encryption/network/client-0/internal.sock --runtime-id 8000000000000000000000000000000000000000000000000000000000000000" level=info module=test-runner caller=root.go:231 ts=2020-02-27T16:01:56.997729413Z msg="passed test case" test=basic-encryption level=info module=test-runner caller=root.go:196 ts=2020-02-27T16:01:56.997761192Z msg="running test case" test=byzantine/executor-honest level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:56.99786898Z msg="launching node" args="registry entity init --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.039529445Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.kind keymanager --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.084727954Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/runtime-8000000000000000000000000000000000000000000000000000000000000000 --runtime.id 8000000000000000000000000000000000000000000000000000000000000000 --runtime.kind compute --runtime.executor.group_size 2 --runtime.executor.group_backup_size 1 --runtime.executor.allowed_stragglers 0 --runtime.executor.round_timeout 10s --runtime.merge.group_size 2 --runtime.merge.group_backup_size 1 --runtime.merge.allowed_stragglers 0 --runtime.merge.round_timeout 10s --runtime.txn_scheduler.group_size 1 --runtime.txn_scheduler.batching.max_batch_size 1 --runtime.txn_scheduler.batching.max_batch_size_bytes 1000 --runtime.txn_scheduler.algorithm batching --runtime.txn_scheduler.flush_timeout 1s --runtime.storage.group_size 2 --runtime.storage.max_apply_write_log_entries 100000 --runtime.storage.max_apply_ops 2 --runtime.storage.max_merge_roots 8 --runtime.storage.max_merge_ops 2 --runtime.storage.checkpoint_interval 0 --runtime.storage.checkpoint_num_kept 0 --runtime.storage.checkpoint_chunk_size 0 --runtime.keymanager c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.14938941Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.189287458Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-0 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20000 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.247926931Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.290898233Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-1 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20001 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.352997992Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.415898281Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-2 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20002 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.476417509Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.542705661Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.602273522Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.65047563Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.698279584Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.749460577Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg= --entity.node.id hcWVUucu/MwOyEDmj5T4TACwpgre5e2cJLczBggxxm0=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.796527503Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg= --entity.node.id hcWVUucu/MwOyEDmj5T4TACwpgre5e2cJLczBggxxm0= --entity.node.id 5p6VdeWKYQipb16TTapxkygWiO0xjl5i/e+nGLERBwE=" level=info module=oasis/byzantine/executor-honest caller=oasis.go:375 ts=2020-02-27T16:01:57.843349241Z msg="starting network" level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.843411223Z msg="launching node" args="keymanager init_status --debug.dont_blame_oasis --debug.allow_test_keys --keymanager.status.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --keymanager.status.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/keymanager/keymanager_status.json --keymanager.policy.file " level=info module=oasis/byzantine/executor-honest caller=oasis.go:570 ts=2020-02-27T16:01:57.890376945Z msg="launching node" args="genesis init --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --chain.id test: oasis-core tests --halt.epoch 18446744073709551615 --consensus.backend tendermint --epochtime.tendermint.interval 30 --consensus.tendermint.timeout_commit 250ms --registry.debug.allow_unroutable_addresses true --registry.debug.allow_test_runtimes true --scheduler.max_validators_per_entity 3 --epochtime.debug.mock_backend --beacon.debug.deterministic --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys --entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-0/node_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-1/node_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-2/node_genesis.json --runtime /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff/runtime_genesis.json --runtime /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/runtime-8000000000000000000000000000000000000000000000000000000000000000/runtime_genesis.json --keymanager /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/keymanager/keymanager_status.json --registry.max_node_expiration 0" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:01:57.956975205Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/seed --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/seed/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20023 --tendermint.p2p.seed_mode --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:01:57.957477662Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20000 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --supplementarysanity.enabled --supplementarysanity.interval 1 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:00.957956324Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20001 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:03.958285838Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/validator-2/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20002 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.958668458Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/keymanager --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/keymanager/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20003 --consensus.tendermint.submission.gas_price 0 --worker.client.port 20004 --worker.keymanager.enabled --worker.keymanager.runtime.binary /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-keymanager-runtime --worker.keymanager.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.keymanager.runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --worker.keymanager.may_generate --grpc.log.debug --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.959051309Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/storage-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/storage-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20005 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20006 --worker.p2p.port 20007 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.959347956Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/storage-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/storage-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20008 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20009 --worker.p2p.port 20010 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.959594688Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/compute-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/compute-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20011 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20012 --worker.p2p.port 20013 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.959852643Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/compute-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/compute-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20014 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20015 --worker.p2p.port 20016 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.9603057Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/compute-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/compute-2/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20017 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20018 --worker.p2p.port 20019 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.960681012Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/client-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/client-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20020 --storage.backend client --grpc.log.debug --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --runtime.history.tag_indexer.backend bleve --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-honest caller=oasis.go:633 ts=2020-02-27T16:02:06.966057807Z msg="launching Oasis node" args="debug byzantine executor-honest --datadir /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/byzantine-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/byzantine-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20021 --tendermint.debug.addr_book_lenient --consensus.tendermint.submission.gas_price 0 --worker.p2p.port 20022 --tendermint.p2p.seed 1E87514C2BBB749BB8E7F9B2F0322BA7E1B79EEB@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-honest/network/entity-1/entity.json --activation_epoch 1" level=info module=oasis/byzantine/executor-honest caller=oasis.go:551 ts=2020-02-27T16:02:06.980886743Z msg="network started" ts=2020-02-27T16:02:06.98105859Z level=info module=e2e/common caller=common.go:94 msg="launching client" binary=/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue-ops-client args="--node-address unix:/tmp/oasis-test-runner973079579/byzantine/executor-honest/network/client-0/internal.sock --runtime-id 8000000000000000000000000000000000000000000000000000000000000000 set hello_key hello_value" ts=2020-02-27T16:02:07.02009329Z level=info module=scenario/e2e/byzantine/executor-honest caller=basic.go:363 msg="waiting for (some) nodes to register" num_nodes=4 ts=2020-02-27T16:02:39.780128142Z level=info module=scenario/e2e/byzantine/executor-honest caller=basic.go:371 msg="triggering epoch transition" ts=2020-02-27T16:02:40.923330833Z level=info module=scenario/e2e/byzantine/executor-honest caller=basic.go:375 msg="epoch transition done" ts=2020-02-27T16:02:40.923359198Z level=info module=scenario/e2e/byzantine/executor-honest caller=basic.go:379 msg="waiting for (all) nodes to register" num_nodes=10 ts=2020-02-27T16:02:42.236970605Z level=info module=scenario/e2e/byzantine/executor-honest caller=basic.go:388 msg="triggering epoch transition" ts=2020-02-27T16:02:43.456780366Z level=info module=scenario/e2e/byzantine/executor-honest caller=basic.go:392 msg="epoch transition done" level=info module=test-runner caller=root.go:231 ts=2020-02-27T16:02:45.346798699Z msg="passed test case" test=byzantine/executor-honest level=info module=test-runner caller=root.go:196 ts=2020-02-27T16:02:45.346837313Z msg="running test case" test=byzantine/executor-wrong level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.347068675Z msg="launching node" args="registry entity init --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.389487081Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.kind keymanager --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.447099184Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/runtime-8000000000000000000000000000000000000000000000000000000000000000 --runtime.id 8000000000000000000000000000000000000000000000000000000000000000 --runtime.kind compute --runtime.executor.group_size 2 --runtime.executor.group_backup_size 1 --runtime.executor.allowed_stragglers 0 --runtime.executor.round_timeout 10s --runtime.merge.group_size 2 --runtime.merge.group_backup_size 1 --runtime.merge.allowed_stragglers 0 --runtime.merge.round_timeout 10s --runtime.txn_scheduler.group_size 1 --runtime.txn_scheduler.batching.max_batch_size 1 --runtime.txn_scheduler.batching.max_batch_size_bytes 1000 --runtime.txn_scheduler.algorithm batching --runtime.txn_scheduler.flush_timeout 1s --runtime.storage.group_size 2 --runtime.storage.max_apply_write_log_entries 100000 --runtime.storage.max_apply_ops 2 --runtime.storage.max_merge_roots 8 --runtime.storage.max_merge_ops 2 --runtime.storage.checkpoint_interval 0 --runtime.storage.checkpoint_num_kept 0 --runtime.storage.checkpoint_chunk_size 0 --runtime.keymanager c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.489306857Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.532982044Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-0 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20000 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.577040822Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.62268128Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-1 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20001 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.667846593Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.716345959Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-2 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20002 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.757210371Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.804709907Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.853425174Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.891932134Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.938779596Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:45.988555531Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg= --entity.node.id hcWVUucu/MwOyEDmj5T4TACwpgre5e2cJLczBggxxm0=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:46.02711949Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg= --entity.node.id hcWVUucu/MwOyEDmj5T4TACwpgre5e2cJLczBggxxm0= --entity.node.id 5p6VdeWKYQipb16TTapxkygWiO0xjl5i/e+nGLERBwE=" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:375 ts=2020-02-27T16:02:46.071852872Z msg="starting network" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:46.071939757Z msg="launching node" args="keymanager init_status --debug.dont_blame_oasis --debug.allow_test_keys --keymanager.status.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --keymanager.status.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/keymanager/keymanager_status.json --keymanager.policy.file " level=info module=oasis/byzantine/executor-wrong caller=oasis.go:570 ts=2020-02-27T16:02:46.112817496Z msg="launching node" args="genesis init --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --chain.id test: oasis-core tests --halt.epoch 18446744073709551615 --consensus.backend tendermint --epochtime.tendermint.interval 30 --consensus.tendermint.timeout_commit 250ms --registry.debug.allow_unroutable_addresses true --registry.debug.allow_test_runtimes true --scheduler.max_validators_per_entity 3 --epochtime.debug.mock_backend --beacon.debug.deterministic --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys --entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-0/node_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-1/node_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-2/node_genesis.json --runtime /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff/runtime_genesis.json --runtime /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/runtime-8000000000000000000000000000000000000000000000000000000000000000/runtime_genesis.json --keymanager /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/keymanager/keymanager_status.json --registry.max_node_expiration 0" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:46.179606853Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/seed --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/seed/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20023 --tendermint.p2p.seed_mode --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:46.179798499Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20000 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --supplementarysanity.enabled --supplementarysanity.interval 1 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:49.180108474Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20001 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:52.180567957Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/validator-2/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20002 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.180912565Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/keymanager --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/keymanager/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20003 --consensus.tendermint.submission.gas_price 0 --worker.client.port 20004 --worker.keymanager.enabled --worker.keymanager.runtime.binary /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-keymanager-runtime --worker.keymanager.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.keymanager.runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --worker.keymanager.may_generate --grpc.log.debug --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.181130625Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/storage-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/storage-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20005 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20006 --worker.p2p.port 20007 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.18139563Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/storage-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/storage-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20008 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20009 --worker.p2p.port 20010 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.181567619Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/compute-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/compute-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20011 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20012 --worker.p2p.port 20013 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.181732532Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/compute-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/compute-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20014 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20015 --worker.p2p.port 20016 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.181996293Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/compute-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/compute-2/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20017 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20018 --worker.p2p.port 20019 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.182676275Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/client-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/client-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20020 --storage.backend client --grpc.log.debug --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --runtime.history.tag_indexer.backend bleve --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:633 ts=2020-02-27T16:02:55.183525161Z msg="launching Oasis node" args="debug byzantine executor-wrong --datadir /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/byzantine-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/byzantine-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20021 --tendermint.debug.addr_book_lenient --consensus.tendermint.submission.gas_price 0 --worker.p2p.port 20022 --tendermint.p2p.seed FC008D8D7E37A809B6E1EB2D83DB317C3B43EF49@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/entity-1/entity.json --activation_epoch 1" level=info module=oasis/byzantine/executor-wrong caller=oasis.go:551 ts=2020-02-27T16:02:55.184383246Z msg="network started" ts=2020-02-27T16:02:55.184468241Z level=info module=e2e/common caller=common.go:94 msg="launching client" binary=/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue-ops-client args="--node-address unix:/tmp/oasis-test-runner973079579/byzantine/executor-wrong/network/client-0/internal.sock --runtime-id 8000000000000000000000000000000000000000000000000000000000000000 set hello_key hello_value" ts=2020-02-27T16:02:55.200144979Z level=info module=scenario/e2e/byzantine/executor-wrong caller=basic.go:363 msg="waiting for (some) nodes to register" num_nodes=4 ts=2020-02-27T16:03:27.898063029Z level=info module=scenario/e2e/byzantine/executor-wrong caller=basic.go:371 msg="triggering epoch transition" ts=2020-02-27T16:03:29.019257615Z level=info module=scenario/e2e/byzantine/executor-wrong caller=basic.go:375 msg="epoch transition done" ts=2020-02-27T16:03:29.019383451Z level=info module=scenario/e2e/byzantine/executor-wrong caller=basic.go:379 msg="waiting for (all) nodes to register" num_nodes=10 ts=2020-02-27T16:03:30.293183201Z level=info module=scenario/e2e/byzantine/executor-wrong caller=basic.go:388 msg="triggering epoch transition" ts=2020-02-27T16:03:31.283288997Z level=info module=scenario/e2e/byzantine/executor-wrong caller=basic.go:392 msg="epoch transition done" level=info module=test-runner caller=root.go:231 ts=2020-02-27T16:03:33.038403456Z msg="passed test case" test=byzantine/executor-wrong level=info module=test-runner caller=root.go:196 ts=2020-02-27T16:03:33.038431644Z msg="running test case" test=byzantine/executor-straggler level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.038529888Z msg="launching node" args="registry entity init --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.07509761Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.kind keymanager --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.124348269Z msg="launching node" args="registry runtime init_genesis --datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/runtime-8000000000000000000000000000000000000000000000000000000000000000 --runtime.id 8000000000000000000000000000000000000000000000000000000000000000 --runtime.kind compute --runtime.executor.group_size 2 --runtime.executor.group_backup_size 1 --runtime.executor.allowed_stragglers 0 --runtime.executor.round_timeout 10s --runtime.merge.group_size 2 --runtime.merge.group_backup_size 1 --runtime.merge.allowed_stragglers 0 --runtime.merge.round_timeout 10s --runtime.txn_scheduler.group_size 1 --runtime.txn_scheduler.batching.max_batch_size 1 --runtime.txn_scheduler.batching.max_batch_size_bytes 1000 --runtime.txn_scheduler.algorithm batching --runtime.txn_scheduler.flush_timeout 1s --runtime.storage.group_size 2 --runtime.storage.max_apply_write_log_entries 100000 --runtime.storage.max_apply_ops 2 --runtime.storage.max_merge_roots 8 --runtime.storage.max_merge_ops 2 --runtime.storage.checkpoint_interval 0 --runtime.storage.checkpoint_num_kept 0 --runtime.storage.checkpoint_chunk_size 0 --runtime.keymanager c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --runtime.admission_policy any-node --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.170055936Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.206680112Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-0 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20000 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.253882009Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.294383171Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-1 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20001 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.336126244Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.372796674Z msg="launching node" args="registry node init --datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-2 --node.expiration 1 --node.role validator --node.consensus_address 127.0.0.1:20002 --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.415109462Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.464010168Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.506558811Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.547909068Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.592330394Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.640406488Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg= --entity.node.id hcWVUucu/MwOyEDmj5T4TACwpgre5e2cJLczBggxxm0=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.678022015Z msg="launching node" args="registry entity update --signer file --signer.dir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1 --entity.node.id LQu4ZtFg8OJ0MC4M4QMeUR7Is6Xt4A/CW+PK/7TPiH0= --entity.node.id IluobMWMoZvxeW5ceAEiQj+TJUXZZJu6ZCWgtZxsHds= --entity.node.id toAWSrxsxSFbGXQIhu4p2fOL0z/fnirrGT/MuzRgcW8= --entity.node.id mh+b9hN+2oLAflZACgBgVHA0EjeZK3ew6kml75s2wN4= --entity.node.id B14NG+Joea3j09rVt0SEPQ4Z6Ned1EEi6rzZoa2YrYw= --entity.node.id iPYyR3I45FRGK568PTJIZUmELgcFYPhIb80e2GxrIf0= --entity.node.id DbeoxcRwDO4Wh8bwq5rAR7wzhiB+LeYn+y7lFSGAZ7I= --entity.node.id oWk0qdNhp7XNQDX4YFJY2KeFM+9u4fo16DeSdW1gChg= --entity.node.id hcWVUucu/MwOyEDmj5T4TACwpgre5e2cJLczBggxxm0= --entity.node.id 5p6VdeWKYQipb16TTapxkygWiO0xjl5i/e+nGLERBwE=" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:375 ts=2020-02-27T16:03:33.714806023Z msg="starting network" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.714879437Z msg="launching node" args="keymanager init_status --debug.dont_blame_oasis --debug.allow_test_keys --keymanager.status.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --keymanager.status.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/keymanager/keymanager_status.json --keymanager.policy.file " level=info module=oasis/byzantine/executor-straggler caller=oasis.go:570 ts=2020-02-27T16:03:33.757879245Z msg="launching node" args="genesis init --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --chain.id test: oasis-core tests --halt.epoch 18446744073709551615 --consensus.backend tendermint --epochtime.tendermint.interval 30 --consensus.tendermint.timeout_commit 250ms --registry.debug.allow_unroutable_addresses true --registry.debug.allow_test_runtimes true --scheduler.max_validators_per_entity 3 --epochtime.debug.mock_backend --beacon.debug.deterministic --debug.dont_blame_oasis --debug.test_entity --debug.allow_test_keys --entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-0/node_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-1/node_genesis.json --node /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-2/node_genesis.json --runtime /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/runtime-c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff/runtime_genesis.json --runtime /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/runtime-8000000000000000000000000000000000000000000000000000000000000000/runtime_genesis.json --keymanager /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/keymanager/keymanager_status.json --registry.max_node_expiration 0" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:33.818672286Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/seed --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/seed/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20023 --tendermint.p2p.seed_mode --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:33.818882123Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20000 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --supplementarysanity.enabled --supplementarysanity.interval 1 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:36.819332718Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20001 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:39.819947528Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/validator-2/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --consensus.validator --tendermint.core.listen_address tcp://0.0.0.0:20002 --consensus.tendermint.min_gas_price 0 --consensus.tendermint.submission.gas_price 0 --storage.backend client --grpc.log.debug --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.82045207Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/keymanager --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/keymanager/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20003 --consensus.tendermint.submission.gas_price 0 --worker.client.port 20004 --worker.keymanager.enabled --worker.keymanager.runtime.binary /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-keymanager-runtime --worker.keymanager.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.keymanager.runtime.id c000000000000000ffffffffffffffffffffffffffffffffffffffffffffffff --worker.keymanager.may_generate --grpc.log.debug --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.820757088Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/storage-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/storage-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20005 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20006 --worker.p2p.port 20007 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.820934306Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/storage-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/storage-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20008 --consensus.tendermint.submission.gas_price 0 --storage.backend badger --worker.client.port 20009 --worker.p2p.port 20010 --worker.storage.enabled --grpc.log.debug --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.821100366Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/compute-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/compute-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20011 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20012 --worker.p2p.port 20013 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.821266618Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/compute-1 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/compute-1/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20014 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20015 --worker.p2p.port 20016 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.821495748Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/compute-2 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/compute-2/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20017 --consensus.tendermint.submission.gas_price 0 --storage.backend client --worker.client.port 20018 --worker.p2p.port 20019 --worker.compute.enabled --worker.runtime.backend sandboxed --worker.runtime.loader /home/tadej/Oasis/oasis-core/target/default/debug/oasis-core-runtime-loader --worker.txn_scheduler.check_tx.enabled --grpc.log.debug --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --worker.runtime.binary 8000000000000000000000000000000000000000000000000000000000000000:/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.822847085Z msg="launching Oasis node" args="--datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/client-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/client-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20020 --storage.backend client --grpc.log.debug --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --runtime.history.tag_indexer.backend bleve --runtime.supported 8000000000000000000000000000000000000000000000000000000000000000 --tendermint.debug.addr_book_lenient --tendermint.debug.allow_duplicate_ip" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:633 ts=2020-02-27T16:03:42.826589393Z msg="launching Oasis node" args="debug byzantine executor-straggler --datadir /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/byzantine-0 --log.level debug --log.format json --log.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/byzantine-0/node.log --genesis.file /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/genesis.json --debug.dont_blame_oasis --debug.allow_test_keys --tendermint.core.listen_address tcp://0.0.0.0:20021 --tendermint.debug.addr_book_lenient --consensus.tendermint.submission.gas_price 0 --worker.p2p.port 20022 --tendermint.p2p.seed 860ED162D9166B8103D0218D2EA25E928D6D891B@127.0.0.1:20023 --worker.registration.entity /tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/entity-1/entity.json --activation_epoch 1" level=info module=oasis/byzantine/executor-straggler caller=oasis.go:551 ts=2020-02-27T16:03:42.84726581Z msg="network started" ts=2020-02-27T16:03:42.84741589Z level=info module=e2e/common caller=common.go:94 msg="launching client" binary=/home/tadej/Oasis/oasis-core/target/default/debug/simple-keyvalue-ops-client args="--node-address unix:/tmp/oasis-test-runner973079579/byzantine/executor-straggler/network/client-0/internal.sock --runtime-id 8000000000000000000000000000000000000000000000000000000000000000 set hello_key hello_value" ts=2020-02-27T16:03:42.867659588Z level=info module=scenario/e2e/byzantine/executor-straggler caller=basic.go:363 msg="waiting for (some) nodes to register" num_nodes=4 ts=2020-02-27T16:04:14.9474876Z level=info module=scenario/e2e/byzantine/executor-straggler caller=basic.go:371 msg="triggering epoch transition" ts=2020-02-27T16:04:15.99087637Z level=info module=scenario/e2e/byzantine/executor-straggler caller=basic.go:375 msg="epoch transition done" ts=2020-02-27T16:04:15.990916019Z level=info module=scenario/e2e/byzantine/executor-straggler caller=basic.go:379 msg="waiting for (all) nodes to register" num_nodes=10 ts=2020-02-27T16:04:18.490978293Z level=info module=scenario/e2e/byzantine/executor-straggler caller=basic.go:388 msg="triggering epoch transition" ts=2020-02-27T16:04:19.663173391Z level=info module=scenario/e2e/byzantine/executor-straggler caller=basic.go:392 msg="epoch transition done" level=info module=test-runner caller=root.go:231 ts=2020-02-27T16:04:44.153860535Z msg="passed test case" test=byzantine/executor-straggler ... output trimmed ... ```

NOTE: On an average developer's terminal, it actually looks worse since these very long lines are wrapped.


I think a better default would be to output something along the following lines:

*** Running E2E tests...
  - Running basic test case... PASS
  - Running basic-encryption test case... PASS
  - Running byzantine/executor-honest test case... PASS
  ... more test cases that pass ...
  - Running stake-cli test case... FAIL

Error: root: failed to run test case: root: failed to run test case: scenario/e2e/stake: error while running ReclaimEscrow test: genReclaimEscrowTx: failed to generate reclaim escrow tx: error: exit status 1 output: Error: unknown flag: --stake.amount
Usage:
  oasis-node stake account gen_reclaim_escrow [flags]

Flags:
  -g, --genesis.file string            path to genesis file (default "genesis.json")
  -h, --help                           help for gen_reclaim_escrow
  -s, --signer string                  signer backend [file, ledger] (default "file")
      --signer.dir string              path to directory containing the entity files. If file signer backend is being used, the directory must also contain the private key. If blank, defaults to the working directory.
      --signer.ledger.address string   Ledger signer: select Ledger device based on this specified address. If blank, any available Ledger device will be connected to.
      --signer.ledger.index uint32     Ledger signer: address index used to derive address on Ledger device
      --stake.escrow.account string    ID of the escrow account
      --stake.shares string            amount of shares for the transaction (default "0")
      --transaction.fee.amount uint    transaction fee in tokens
      --transaction.fee.gas string     maximum transaction gas limit (default "0")
      --transaction.file string        path to the transaction
      --transaction.nonce uint         nonce of the signing account

Global Flags:
      --config string                       config file
      --datadir string                      data directory
      --log.file string                     log file
      --log.format [logfmt,JSON]            log format (default logfmt)
      --log.level [DEBUG,INFO,WARN,ERROR]   log level (default WARN)

unknown flag: --stake.amount

For more detailed test case logs, see: /tmp/oasis-test-runner973079579/stake-cli/.

make: *** [Makefile:106: test-e2e] Error 1
ISSUE TYPE
Yawning commented 4 years ago

level=info

--log.level [DEBUG,INFO,WARN,ERROR] log level (default WARN)