Parent Log: http://ci.aztec-labs.com/b13745b3a815110f Command: f34dabd8fae2f26b:ISOLATE=1:NAME=e2e_private_voting_contract yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_private_voting_contract.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/f4ac84d7ac4041d505399edd8819840bb14d6c9d Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=0 Date: Fri Jun 13 17:08:57 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15005_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_f9aac7f8d569bb18_master 17:08:57 +++ id -u 17:08:57 +++ id -g 17:08:57 ++ docker run -d --name e2e_private_voting_contract --net=none --cpuset-cpus=0-63 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_private_voting_contract.test.ts'\''' 17:08:57 + cid=4ba4122b6dd2bba7c35d90cebafb26167c79a0e4db838c844a3d6c7787b0a3f0 17:08:57 + set +x 17:08:58 {"level":25,"time":1749834538022,"pid":12,"hostname":"4ba4122b6dd2","module":"logger","msg":"Logger initialized with level verbose"} 17:09:02 [17:09:02.243] INFO: e2e:e2e_private_voting_contract Logging metrics to log/unknown.jsonl 17:09:02 [17:09:02.437] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-FqxV3t/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:09:02 [17:09:02.467] INFO: e2e:e2e_private_voting_contract Calling anvil_setBlockTimestampInterval with params: [12] 17:09:02 [17:09:02.489] WARN: e2e:e2e_private_voting_contract Set block interval to 12 17:09:02 [17:09:02.489] VERBOSE: e2e:e2e_private_voting_contract Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:09:02 [17:09:02.535] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:09:02 [17:09:02.541] VERBOSE: e2e:e2e_private_voting_contract Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:09:02 [17:09:02.556] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:09:02 [17:09:02.561] VERBOSE: e2e:e2e_private_voting_contract Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:09:02 [17:09:02.575] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:09:02 [17:09:02.580] VERBOSE: e2e:e2e_private_voting_contract Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:09:02 [17:09:02.595] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:09:02 [17:09:02.599] VERBOSE: e2e:e2e_private_voting_contract Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:09:02 [17:09:02.614] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:09:02 [17:09:02.618] VERBOSE: e2e:e2e_private_voting_contract Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:09:02 [17:09:02.629] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:09:02 [17:09:02.633] VERBOSE: e2e:e2e_private_voting_contract Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:09:02 [17:09:02.633] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 17:09:02 [17:09:02.634] INFO: e2e:e2e_private_voting_contract Waiting for 6 transactions to be mined... 17:09:02 [17:09:02.652] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:09:02 [17:09:02.665] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:09:02 [17:09:02.665] VERBOSE: e2e:e2e_private_voting_contract Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:09:02 [17:09:02.675] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:09:02 [17:09:02.687] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:09:02 [17:09:02.693] VERBOSE: e2e:e2e_private_voting_contract Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:09:02 [17:09:02.705] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:09:02 [17:09:02.705] VERBOSE: e2e:e2e_private_voting_contract Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:09:02 [17:09:02.719] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:09:02 [17:09:02.723] VERBOSE: e2e:e2e_private_voting_contract Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:09:02 [17:09:02.733] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:09:02 [17:09:02.733] VERBOSE: e2e:e2e_private_voting_contract Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:09:02 [17:09:02.733] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 17:09:02 [17:09:02.734] INFO: e2e:e2e_private_voting_contract Waiting for 8 transactions to be mined... 17:09:02 [17:09:02.749] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:09:02 [17:09:02.758] VERBOSE: e2e:e2e_private_voting_contract Deployed shared contracts 17:09:02 [17:09:02.772] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:09:02 [17:09:02.773] VERBOSE: e2e:e2e_private_voting_contract Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:09:02 [17:09:02.775] VERBOSE: e2e:e2e_private_voting_contract Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:09:02 [17:09:02.789] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:09:02 [17:09:02.810] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:09:02 [17:09:02.815] VERBOSE: e2e:e2e_private_voting_contract Awaiting for linked libraries to be deployed 17:09:02 [17:09:02.848] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x6db3b8921da11b9ea1780f6fc3daaa122fd56731ffa8eab8723a2caacfa146cc {"gasLimit":10407380,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:09:02 [17:09:02.853] VERBOSE: e2e:e2e_private_voting_contract Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:09:02 [17:09:02.853] INFO: e2e:e2e_private_voting_contract Waiting for 9 transactions to be mined... 17:09:02 [17:09:02.873] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:09:02 [17:09:02.873] VERBOSE: e2e:e2e_private_voting_contract All core contracts have been deployed 17:09:02 [17:09:02.886] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:09:02 [17:09:02.886] VERBOSE: e2e:e2e_private_voting_contract Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 17:09:02 [17:09:02.898] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x693e487a024b82a8817c92f0cdcf02b768326be68ff794fbe39ca4d8583843ce {"gasLimit":716194,"maxFeePerGas":"26.850966134","maxPriorityFeePerGas":"26.623333274"} 17:09:02 [17:09:02.902] VERBOSE: e2e:e2e_private_voting_contract Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:09:02 [17:09:02.921] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xc908b23fc5759d113a6f954be42268d4cd4f85ace48dea07a62ef9a665e35f76 {"gasLimit":116953,"maxFeePerGas":"32.147280353","maxPriorityFeePerGas":"31.947999928"} 17:09:02 [17:09:02.921] VERBOSE: e2e:e2e_private_voting_contract Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xc908b23fc5759d113a6f954be42268d4cd4f85ace48dea07a62ef9a665e35f76 17:09:02 [17:09:02.921] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 17:09:02 [17:09:02.939] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:09:02 [17:09:02.945] VERBOSE: e2e:e2e_private_voting_contract Rollup deployed 17:09:02 [17:09:02.945] VERBOSE: e2e:e2e_private_voting_contract Waiting for rollup and slash factory to be deployed 17:09:02 [17:09:02.945] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 17:09:02 [17:09:02.964] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:09:02 [17:09:02.965] VERBOSE: e2e:e2e_private_voting_contract All transactions for L1 deployment have been mined 17:09:02 [17:09:02.980] INFO: e2e:e2e_private_voting_contract Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 17:09:02 [17:09:02.983] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:09:02 [17:09:02.985] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.985] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:09:02 [17:09:02.986] INFO: telemetry:client Using NoopTelemetryClient 17:09:02 [17:09:02.991] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:09:02 [17:09:02.992] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:09:02 [17:09:02.992] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/94d58f908ca950bf/blob-sink with map size 134217728 KB (LMDB v2) 17:09:02 [17:09:02.994] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.997] INFO: aztecjs:utils:watcher New L1 time: 1749834782 17:09:02 [17:09:02.997] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:02.000Z {"offset":239003,"timeMs":1749834782000} 17:09:02 [17:09:02.999] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:09:03 [17:09:03.004] INFO: blob-sink:server Server is running on http://localhost:45647 17:09:03 [17:09:03.004] VERBOSE: e2e:e2e_private_voting_contract Creating and synching an aztec node... 17:09:03 [17:09:03.005] VERBOSE: e2e:e2e_private_voting_contract Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/288acf99/acvm 17:09:03 [17:09:03.005] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:45647"} 17:09:03 [17:09:03.018] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:09:03 [17:09:03.019] INFO: archiver:lmdb Creating archiver data store at directory /tmp/94d58f908ca950bf/archiver with map size 134217728 KB (LMDB v2) 17:09:03 [17:09:03.020] INFO: archiver:lmdb Starting data store with maxReaders 16 17:09:03 [17:09:03.202] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.276] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:45647"} 17:09:03 [17:09:03.291] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:45647"} 17:09:03 [17:09:03.291] WARN: node:blob-sink:client No L1 consensus host urls configured 17:09:03 [17:09:03.291] WARN: node:blob-sink:client No archive client configured 17:09:03 [17:09:03.294] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x90868d7c10c93b1026573feb8a8de0411403cce1909eb455d1b154b068acb770 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x63905416074f7ae4252a988aaafc4c54f51ab6ef160a017e1a5fd8984dae5acb","l1BlockNumber":16}} 17:09:03 [17:09:03.307] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x90868d7c10c93b1026573feb8a8de0411403cce1909eb455d1b154b068acb770","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:09:03 [17:09:03.311] INFO: world-state:database Creating world state data store at directory /tmp/94d58f908ca950bf/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:09:03 [17:09:03.333] INFO: world_state Created world state synchroniser with block history of 64 17:09:03 [17:09:03.334] WARN: node Aztec node is accepting fake proofs 17:09:03 [17:09:03.343] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/94d58f908ca950bf/p2p with map size 134217728 KB (LMDB v2) 17:09:03 [17:09:03.344] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:09:03 [17:09:03.345] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/94d58f908ca950bf/p2p-archive with map size 134217728 KB (LMDB v2) 17:09:03 [17:09:03.346] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:09:03 [17:09:03.347] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/94d58f908ca950bf/p2p-peers with map size 134217728 KB (LMDB v2) 17:09:03 [17:09:03.348] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:09:03 [17:09:03.349] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:09:03 [17:09:03.349] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:09:03 [17:09:03.351] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:09:03 [17:09:03.352] INFO: world_state Started world state synchronizer from block 1 17:09:03 [17:09:03.354] VERBOSE: world-state:block_stream Starting sync from block number 0 17:09:03 [17:09:03.355] INFO: p2p Starting p2p client from block 0 with empty mempools 17:09:03 [17:09:03.355] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:09:03 [17:09:03.357] INFO: slasher Slasher client initialized 17:09:03 [17:09:03.357] INFO: slasher Starting Slasher client... 17:09:03 [17:09:03.385] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:09:03 [17:09:03.385] VERBOSE: node All Aztec Node subsystems synced 17:09:03 [17:09:03.392] INFO: sequencer-client Deploying forwarder contract 17:09:03 [17:09:03.397] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:09:03 [17:09:03.409] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.411] VERBOSE: sequencer-client Sent L1 transaction 0xa18031acdd04a2d15b0980e4b0120233443c2137ecf8c9c14cb9271ad95b383f {"gasLimit":436981,"maxFeePerGas":"1.353583745","maxPriorityFeePerGas":"1.2"} 17:09:03 [17:09:03.412] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa18031acdd04a2d15b0980e4b0120233443c2137ecf8c9c14cb9271ad95b383f. 17:09:03 [17:09:03.416] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:09:03 [17:09:03.429] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:09:03 [17:09:03.429] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:09:03 [17:09:03.430] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/288acf99/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:09:03 [17:09:03.612] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:09:03 [17:09:03.614] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:09:03 [17:09:03.615] INFO: node Aztec Node version: 0.87.8 17:09:03 [17:09:03.615] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 17:09:03 [17:09:03.616] VERBOSE: e2e:e2e_private_voting_contract Creating a pxe... 17:09:03 [17:09:03.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.628] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/422226d7cda0e065/pxe_data with map size 134217728 KB (LMDB v2) 17:09:03 [17:09:03.639] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27b83033186b5f9f003c37607c0bdc4cf8a10052220f6c54521c8d2cf7a5b56e","blockNumber":1,"slot":2} 17:09:03 [17:09:03.640] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:09:03 [17:09:03.833] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.861] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:09:03 [17:09:03.862] INFO: pxe:service Started PXE connected to chain 31337 version 655753031 17:09:03 [17:09:03.910] INFO: pxe:service Registered account 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b 17:09:03 [17:09:03.963] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:09:03 [17:09:03.964] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b 17:09:04 [17:09:04.074] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.077] INFO: pxe:service Added contract SchnorrAccount at 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:09:04 [17:09:04.115] VERBOSE: pxe:block_stream Starting sync from block number 0 17:09:04 [17:09:04.131] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:09:04 [17:09:04.210] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27b83033186b5f9f003c37607c0bdc4cf8a10052220f6c54521c8d2cf7a5b56e","blockNumber":1,"slot":2} 17:09:04 [17:09:04.217] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:09:04 [17:09:04.628] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:09:04 [17:09:04.702] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:09:04 [17:09:04.761] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.804] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27b83033186b5f9f003c37607c0bdc4cf8a10052220f6c54521c8d2cf7a5b56e","blockNumber":1,"slot":2} 17:09:04 [17:09:04.850] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:04 [17:09:04.885] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:04 [17:09:04.886] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:04 [17:09:04.924] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:04 [17:09:04.927] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:04 [17:09:04.975] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.081] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:05 [17:09:05.115] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:05 [17:09:05.115] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:05 [17:09:05.143] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:05 [17:09:05.146] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:05 [17:09:05.159] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b as fee payer 17:09:05 [17:09:05.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.391] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.396] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27b83033186b5f9f003c37607c0bdc4cf8a10052220f6c54521c8d2cf7a5b56e","blockNumber":1,"slot":2} 17:09:05 [17:09:05.617] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.223] INFO: pxe:service Proving completed in 2115.8349279999993ms {"timings":{"total":2115.8349279999993,"sync":8.29382700000042,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":119.32788300000084,"oracles":{"callPrivateFunction":{"times":[582.9263300000002,260.4833719999997,153.0444269999998]}}},{"functionName":"private_kernel_init","time":94.19606399999975},{"functionName":"ContractClassRegisterer:register","time":568.728666,"oracles":{"loadCapsule":{"times":[4.398753000000397]},"notifyCreatedNullifier":{"times":[0.5648390000005747]},"debugLog":{"times":[0.7777340000002368]},"notifyCreatedContractClassLog":{"times":[7.987629000000197]}}},{"functionName":"private_kernel_inner","time":117.7145330000003},{"functionName":"SchnorrAccount:constructor","time":236.2355030000008,"oracles":{"getContractInstance":{"times":[1.2081749999997555]},"debugLog":{"times":[0.48407099999985803,0.3995420000001104]},"fetchTaggedLogs":{"times":[40.387722000000394]},"loadCapsule":{"times":[0.3782420000006823,0.21921800000018266,0.23070499999994354]},"notifyCreatedNullifier":{"times":[0.21529399999963061,0.22737400000005437]},"notifyCreatedNote":{"times":[0.3717790000000605]},"getRandomField":{"times":[0.39797600000019884,0.16735800000060408,0.10045999999965716,0.08882999999968888,0.07282800000029965,0.08411999999952968,0.06473400000049878,0.07971900000029564,0.06239499999992404,0.08865400000013324,0.062084999999569845]},"getIndexedTaggingSecretAsSender":{"times":[30.85794900000019]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.476728999999978]}}},{"functionName":"private_kernel_inner","time":113.02514899999915},{"functionName":"SchnorrAccount:entrypoint","time":130.96534599999995,"oracles":{"debugLog":{"times":[0.4627760000003036,0.4000799999994342,0.5653720000000249]},"fetchTaggedLogs":{"times":[29.46223900000041]},"loadCapsule":{"times":[0.20952399999987392,0.20931100000052538,0.22859100000005128]},"getNotes":{"times":[1.4118389999994179]},"getAuthWitness":{"times":[0.34922499999993306]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7548660000002201]}}},{"functionName":"private_kernel_inner","time":106.12779099999898},{"functionName":"private_kernel_reset","time":163.18593200000032},{"functionName":"private_kernel_tail","time":70.67849200000092}],"unaccounted":387.3557419999979}} 17:09:06 [17:09:06.237] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.304] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27b83033186b5f9f003c37607c0bdc4cf8a10052220f6c54521c8d2cf7a5b56e","blockNumber":1,"slot":2} 17:09:06 [17:09:06.364] VERBOSE: p2p:tx_pool Adding tx 0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590 to pool {"eventName":"tx-added-to-pool","txHash":"0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:09:06 [17:09:06.383] INFO: node Received tx 0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590 {"txHash":"0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590"} 17:09:06 [17:09:06.383] INFO: pxe:service Sent transaction 0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590 17:09:06 [17:09:06.444] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.647] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.817] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:09:06 [17:09:06.829] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:13:26.000Z","now":"2025-06-13T17:13:05.832Z"} 17:09:06 [17:09:06.890] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.060] VERBOSE: simulator:public-processor Processed tx 0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590 with no public calls in 157.69708799999898ms {"txHash":"0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590","txFee":6794052480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":20448},"billedGas":{"daGas":16896,"l2Gas":20448},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":157.69708799999898} 17:09:07 [17:09:07.064] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23426569100000053s {"duration":0.23426569100000053,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:09:07 [17:09:07.176] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.189] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x15be5406ce4458d8026045f87d4a4a1a7bfa765d8effb42991db9c02dadfe649","globalVariables":{"chainId":31337,"version":655753031,"blockNumber":1,"slotNumber":2,"timestamp":1749834806,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0e461ec468463f0b1daac938f71c47f6fbf90dec297165a6524e36c05c474590"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":371.88564100000076,"publicProcessDuration":235.01607599999988,"rollupCircuitsDuration":360.6842310000011,"txCount":1,"blockNumber":1,"blockTimestamp":1749834806,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:09:07 [17:09:07.191] VERBOSE: sequencer Attesting committee is empty 17:09:07 [17:09:07.381] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.542] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xc99bb056583fa9522c148a28aaac1c384661fd38d0b0a8a98b6631e80622175c 17:09:07 [17:09:07.542] VERBOSE: sequencer-client Sent L1 transaction 0xc99bb056583fa9522c148a28aaac1c384661fd38d0b0a8a98b6631e80622175c {"gasLimit":514464,"maxFeePerGas":"1.574385777","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:09:07 [17:09:07.552] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:07 [17:09:07.553] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xc99bb056583fa9522c148a28aaac1c384661fd38d0b0a8a98b6631e80622175c","calldataSize":1444,"calldataGas":12220,"txCount":1,"blockNumber":1,"blockTimestamp":1749834806,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:09:07 [17:09:07.553] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:07 [17:09:07.567] INFO: blob-sink:server Received blob sidecar for block 0x9373aef96b341f8436f0cd06fbcd21337f274e9eab4f0af717b5dd44ae7998b9 17:09:07 [17:09:07.572] INFO: blob-sink:server Blob sidecar stored successfully for block 0x9373aef96b341f8436f0cd06fbcd21337f274e9eab4f0af717b5dd44ae7998b9 17:09:07 [17:09:07.584] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.589] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:09:07 [17:09:07.590] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:09:07 [17:09:07.591] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:09:07 [17:09:07.602] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834842] on http://127.0.0.1:8545 17:09:07 [17:09:07.603] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:07 [17:09:07.605] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834842 17:09:07 [17:09:07.605] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:02.000Z {"offset":294395,"timeMs":1749834842000} 17:09:07 [17:09:07.605] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:09:07 [17:09:07.788] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:08 [17:09:08.027] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:08 [17:09:08.044] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:09:08 [17:09:08.053] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x15be5406ce4458d8026045f87d4a4a1a7bfa765d8effb42991db9c02dadfe649","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":655753031,"blockNumber":1,"slotNumber":2,"timestamp":1749834806,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2f5d95f9cb9387ef1d4bd4fb1641f9e2f3aafd67e821c373d91b819d2cf500d2","archiveNextLeafIndex":2} 17:09:08 [17:09:08.061] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:09:08 [17:09:08.171] WARN: pxe:service No artifact found for contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 when looking for its metadata 17:09:08 [17:09:08.171] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 as part of deployment for 0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9 17:09:08 [17:09:08.184] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.189517000000706,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834806,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:09:08 [17:09:08.234] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:08 [17:09:08.241] VERBOSE: p2p Synched to latest block 1 17:09:08 [17:09:08.288] INFO: pxe:service Added contract EasyPrivateVoting at 0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9 with class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 17:09:08 [17:09:08.308] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2f5d95f9cb9387ef1d4bd4fb1641f9e2f3aafd67e821c373d91b819d2cf500d2","header":{"contentCommitment":{"blobsHash":"0x0090b9ba3d329ec71adff69b2bc00aa8c17713003cf0614b5e5400f14752877a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834806,"version":655753031},"lastArchive":"0x27b83033186b5f9f003c37607c0bdc4cf8a10052220f6c54521c8d2cf7a5b56e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x077dcd6c1e84f660ec6acbb1db12aef99978c7bea82a2dd1f9c78f244dedd3f8","nullifierTree":"0x16e2f8a1bc2d253455ada8bbb4d0b53c676da2e1f3f833549abbaad88113fbb8","publicDataTree":"0x07e42e5a361ea2e71aa9dadd6fe75ca61fa924cd94ecd0d10f4dc89c62096b43"},"totalFees":6794052480,"totalManaUsed":20448}} 17:09:08 [17:09:08.375] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:08 [17:09:08.407] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:08 [17:09:08.408] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:08 [17:09:08.439] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:08 [17:09:08.452] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:08 [17:09:08.456] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20af57d96b75647ddce14795ff2a77b45da60424971e9b3e4cdf7ba44ba216b5 17:09:08 [17:09:08.467] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:08 [17:09:08.467] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:08 [17:09:08.473] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:08 [17:09:08.473] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:08 [17:09:08.477] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2333677e8dd28de3e989cddba7883dacd6a9726da478908761b9cf2bdeeca7e8","nullifier":"0x11a75475b9bca80e4001e681a0caa78b0ec210eb8629df984757ab402a0cc41d"} 17:09:08 [17:09:08.479] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:08 [17:09:08.491] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b as fee payer 17:09:08 [17:09:08.524] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:09:08 [17:09:08.831] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x07c93431ee7228896e85ee48c35d1e5b5d747283021244321f1e2360b29dc702,0x0eb6620c85cc03233af00abd8ad2f32e9528f320b09af98beb73808818ac20da,0x13d6566bc501e38ffb391e30ee7b29055b9227558ad14198c97fbf4c5f80e599 17:09:08 [17:09:08.906] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:09:08 [17:09:08.956] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.017] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:09:09 [17:09:09.033] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2f5d95f9cb9387ef1d4bd4fb1641f9e2f3aafd67e821c373d91b819d2cf500d2","blockNumber":2,"slot":3} 17:09:09 [17:09:09.053] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:09:09 [17:09:09.063] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9,0x0000000000000000000000000000000000000000000000000000000000000001,0x30570d40c45ac66a060be4b7a9a79e9d50c64e7583164a9cfb6c589e29fd4446,0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x1c60f76caa56cb97727d3bbd553869cd8d629516ddd9161d11a427f39393e8d2,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b 17:09:09 [17:09:09.210] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.436] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.638] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.751] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2f5d95f9cb9387ef1d4bd4fb1641f9e2f3aafd67e821c373d91b819d2cf500d2","blockNumber":2,"slot":3} 17:09:09 [17:09:09.994] INFO: pxe:service Proving completed in 1693.693765ms {"timings":{"total":1693.693765,"sync":8.717161000000488,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":190.6455690000039,"oracles":{"debugLog":{"times":[0.49232499999925494,0.39382000000114203,0.43368399999963003,0.5340710000000399,0.39373599999998987,0.3560030000007828,0.37150300000030256,0.43502600000101666]},"fetchTaggedLogs":{"times":[46.02407399999902]},"loadCapsule":{"times":[0.19216100000085135,0.5082430000002205,0.40940000000045984,0.2421070000000327,0.21565600000030827,0.21581100000003062]},"getSharedSecret":{"times":[3.285476999999446]},"aes128Decrypt":{"times":[0.9734929999995074,0.9083599999994476]},"getPublicKeysAndPartialAddress":{"times":[1.3920650000000023]},"getKeyValidationRequest":{"times":[1.6880399999990914]},"deliverNote":{"times":[3.802400000000489]},"deleteCapsule":{"times":[0.35871399999996356]},"storeCapsule":{"times":[0.3675010000006296]},"getNotes":{"times":[1.5259129999994911]},"getAuthWitness":{"times":[0.21389099999942118]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05967899999996007]},"callPrivateFunction":{"times":[462.0369780000001,112.80212000000029]},"notifyEnqueuedPublicFunctionCall":{"times":[0.21897699999863107]}}},{"functionName":"private_kernel_init","time":58.99490600000172},{"functionName":"ContractClassRegisterer:register","time":452.26542699999845,"oracles":{"loadCapsule":{"times":[3.538473000000522]},"notifyCreatedNullifier":{"times":[0.28938600000037695]},"debugLog":{"times":[0.5142919999998412]},"notifyCreatedContractClassLog":{"times":[10.625740999999834]}}},{"functionName":"private_kernel_inner","time":104.46452700000009},{"functionName":"ContractInstanceDeployer:deploy","time":72.7908920000009,"oracles":{"storeInExecutionCache":{"times":[0.173452000000907]},"callPrivateFunction":{"times":[37.811869000001025]},"notifyCreatedNullifier":{"times":[0.2622579999988375]},"debugLog":{"times":[0.45375700000113284]}}},{"functionName":"private_kernel_inner","time":107.33521100000144},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":29.078213999999207,"oracles":{}},{"functionName":"private_kernel_inner","time":104.45303500000045},{"functionName":"private_kernel_reset","time":164.03708600000027},{"functionName":"private_kernel_tail","time":83.24973900000077}],"unaccounted":317.6619979999923}} 17:09:10 [17:09:10.025] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.186] VERBOSE: p2p:tx_pool Adding tx 0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468 to pool {"eventName":"tx-added-to-pool","txHash":"0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":151,"proofSize":172052,"size":322921,"feePaymentMethod":"fee_juice"} 17:09:10 [17:09:10.204] INFO: node Received tx 0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468 {"txHash":"0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468"} 17:09:10 [17:09:10.204] INFO: pxe:service Sent transaction 0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468 17:09:10 [17:09:10.228] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.282] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:09:10 [17:09:10.296] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:14:02.000Z","now":"2025-06-13T17:14:04.691Z"} 17:09:10 [17:09:10.457] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.583] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x35393df3 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x35393df3","duration":59.70942500000092} 17:09:10 [17:09:10.733] VERBOSE: simulator:public-processor Processed tx 0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468 with 1 public calls in 323.80247099999906ms {"txHash":"0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468","txFee":32675777440,"revertCode":0,"gasUsed":{"totalGas":{"daGas":91648,"l2Gas":98344},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":3072,"l2Gas":61800},"billedGas":{"daGas":91648,"l2Gas":98344}},"publicDataWriteCount":6,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":323.80247099999906} 17:09:10 [17:09:10.734] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.737] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.44026581199999965s {"duration":0.44026581199999965,"rate":140369.7455390882,"totalPublicGas":{"daGas":3072,"l2Gas":61800},"totalBlockGas":{"daGas":91648,"l2Gas":98344},"totalSizeInBytes":6144} 17:09:10 [17:09:10.878] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 103490.89214336973 mana/s {"blockHash":"0x16feb7c6f1ca113e79065dc4d82c97e2df7c0fc70c5db9d10d524a5b7675bac7","globalVariables":{"chainId":31337,"version":655753031,"blockNumber":2,"slotNumber":3,"timestamp":1749834842,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0809eae5a1ed8f6f24eb1d49126016f543b55265d3ceff23c850b52400c8e468"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":596.6433259999994,"publicProcessDuration":440.61188500000026,"rollupCircuitsDuration":582.5188470000012,"txCount":1,"blockNumber":2,"blockTimestamp":1749834842,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 17:09:10 [17:09:10.882] VERBOSE: sequencer Attesting committee is empty 17:09:10 [17:09:10.978] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:11 [17:09:11.165] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xd6254cd9f1a9e1969663fc34975af09365b281a6beaf56760c9ebb0b3a8ebbd3 17:09:11 [17:09:11.166] VERBOSE: sequencer-client Sent L1 transaction 0xd6254cd9f1a9e1969663fc34975af09365b281a6beaf56760c9ebb0b3a8ebbd3 {"gasLimit":470251,"maxFeePerGas":"1.303611114","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:09:11 [17:09:11.175] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:11 [17:09:11.176] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xd6254cd9f1a9e1969663fc34975af09365b281a6beaf56760c9ebb0b3a8ebbd3","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1749834842,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 17:09:11 [17:09:11.176] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:11 [17:09:11.180] INFO: blob-sink:server Received blob sidecar for block 0x84a94974914a3de1e6a24bdd64f287cdd8395e4632795fe7b66b5c4fcc5137c0 17:09:11 [17:09:11.182] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:11 [17:09:11.188] INFO: blob-sink:server Blob sidecar stored successfully for block 0x84a94974914a3de1e6a24bdd64f287cdd8395e4632795fe7b66b5c4fcc5137c0 17:09:11 [17:09:11.192] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:09:11 [17:09:11.193] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:09:11 [17:09:11.194] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:09:11 [17:09:11.203] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834878] on http://127.0.0.1:8545 17:09:11 [17:09:11.204] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:11 [17:09:11.205] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834878 17:09:11 [17:09:11.205] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:38.000Z {"offset":326795,"timeMs":1749834878000} 17:09:11 [17:09:11.206] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:09:11 [17:09:11.390] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:11 [17:09:11.624] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:11 [17:09:11.641] VERBOSE: archiver:block-helper Store contract instance at 0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9 17:09:11 [17:09:11.647] VERBOSE: archiver:block-helper Store contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 17:09:11 [17:09:11.664] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x16feb7c6f1ca113e79065dc4d82c97e2df7c0fc70c5db9d10d524a5b7675bac7","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":655753031,"blockNumber":2,"slotNumber":3,"timestamp":1749834842,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x23c2d9175bed45adaa9ab137ccdba0127d72ca44a04f55a48dcf577708b22e7e","archiveNextLeafIndex":3} 17:09:11 [17:09:11.668] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:09:11 [17:09:11.743] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.415080999999191,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834842,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 17:09:11 [17:09:11.782] VERBOSE: p2p Synched to latest block 2 17:09:11 [17:09:11.829] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:12 [17:09:12.032] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:12 [17:09:12.201] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x23c2d9175bed45adaa9ab137ccdba0127d72ca44a04f55a48dcf577708b22e7e","blockNumber":3,"slot":4} 17:09:12 [17:09:12.222] INFO: aztecjs:deploy_sent_tx Contract 0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9 successfully deployed. 17:09:12 [17:09:12.222] INFO: e2e:e2e_private_voting_contract Counter contract deployed at 0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9 17:09:12 [17:09:12.224] INFO: e2e:e2e_private_voting_contract Running test: e2e_voting_contract votes votes, then tries to vote again 17:09:12 [17:09:12.234] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:12 [17:09:12.245] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x23c2d9175bed45adaa9ab137ccdba0127d72ca44a04f55a48dcf577708b22e7e","header":{"contentCommitment":{"blobsHash":"0x00246c92810f1612047cf9ee293f6a453c986754ab6d6d15ed72705f606db377","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834842,"version":655753031},"lastArchive":"0x2f5d95f9cb9387ef1d4bd4fb1641f9e2f3aafd67e821c373d91b819d2cf500d2","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x077dcd6c1e84f660ec6acbb1db12aef99978c7bea82a2dd1f9c78f244dedd3f8","nullifierTree":"0x15f7d8c80f5ec2890caeb51c2cb9cdb95a50d26c3f9dd26e44275639faa16777","publicDataTree":"0x2724b6ee9bfffe8b2ccd3b80c5035c79412a88c9f479e0bc1f9a092bb2cc45ae"},"totalFees":32675777440,"totalManaUsed":98344}} 17:09:12 [17:09:12.309] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:12 [17:09:12.342] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:12 [17:09:12.342] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:12 [17:09:12.386] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:12 [17:09:12.390] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20af57d96b75647ddce14795ff2a77b45da60424971e9b3e4cdf7ba44ba216b5 17:09:12 [17:09:12.399] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:12 [17:09:12.400] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:12 [17:09:12.405] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:12 [17:09:12.406] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:12 [17:09:12.408] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2333677e8dd28de3e989cddba7883dacd6a9726da478908761b9cf2bdeeca7e8","nullifier":"0x11a75475b9bca80e4001e681a0caa78b0ec210eb8629df984757ab402a0cc41d"} 17:09:12 [17:09:12.409] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:12 [17:09:12.420] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b as fee payer 17:09:12 [17:09:12.437] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:12 [17:09:12.443] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9"} 17:09:12 [17:09:12.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:13 [17:09:13.028] INFO: pxe:service Proving completed in 793.949138ms {"timings":{"total":793.949138,"sync":12.434557999999015,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":172.45687100000214,"oracles":{"debugLog":{"times":[0.4629000000004453,0.4082040000012057,0.37282500000037544,0.49344899999960035,0.39047000000027765,0.3227199999982986,0.30342799999925774,0.4425810000011552]},"fetchTaggedLogs":{"times":[46.53514299999915]},"loadCapsule":{"times":[0.19008599999870057,0.1700120000004972,0.31789299999945797,0.2046169999994163,0.15146999999888067,0.17665000000124564]},"getSharedSecret":{"times":[2.748037999999724]},"aes128Decrypt":{"times":[0.21097000000008848,0.793375000001106]},"getPublicKeysAndPartialAddress":{"times":[1.2087469999987661]},"getKeyValidationRequest":{"times":[1.469199999999546]},"deliverNote":{"times":[2.3337790000005043]},"deleteCapsule":{"times":[0.2022560000004887]},"storeCapsule":{"times":[0.1953800000010233]},"getNotes":{"times":[1.1741320000000997]},"getAuthWitness":{"times":[0.1788139999989653]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.057463999999527005]},"callPrivateFunction":{"times":[42.23523099999875]}}},{"functionName":"private_kernel_init","time":53.93449700000019},{"functionName":"EasyPrivateVoting:cast_vote","time":30.528738999999405,"oracles":{"getPublicKeysAndPartialAddress":{"times":[5.232540000000881]},"getKeyValidationRequest":{"times":[1.3569959999986168]},"notifyCreatedNullifier":{"times":[0.22040999999990163]},"storeInExecutionCache":{"times":[0.04926300000079209]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05690400000094087]}}},{"functionName":"private_kernel_inner","time":106.83149299999968},{"functionName":"private_kernel_reset","time":182.33658699999978},{"functionName":"private_kernel_tail","time":79.7604680000004}],"unaccounted":155.66592499999933}} 17:09:13 [17:09:13.058] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:13 [17:09:13.079] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x23c2d9175bed45adaa9ab137ccdba0127d72ca44a04f55a48dcf577708b22e7e","blockNumber":3,"slot":4} 17:09:13 [17:09:13.090] VERBOSE: p2p:tx_pool Adding tx 0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780 to pool {"eventName":"tx-added-to-pool","txHash":"0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226313,"feePaymentMethod":"fee_juice"} 17:09:13 [17:09:13.096] INFO: node Received tx 0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780 {"txHash":"0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780"} 17:09:13 [17:09:13.096] INFO: pxe:service Sent transaction 0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780 17:09:13 [17:09:13.263] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:13 [17:09:13.465] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:13 [17:09:13.607] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:09:13 [17:09:13.622] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:14:38.000Z","now":"2025-06-13T17:14:40.417Z"} 17:09:13 [17:09:13.658] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5f06617e completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5f06617e","duration":19.921100999999908} 17:09:13 [17:09:13.667] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:13 [17:09:13.675] VERBOSE: simulator:public-processor Processed tx 0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780 with 1 public calls in 44.09441400000105ms {"txHash":"0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780","txFee":18258351520,"revertCode":0,"gasUsed":{"totalGas":{"daGas":2048,"l2Gas":54952},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":23752},"billedGas":{"daGas":2048,"l2Gas":54952}},"publicDataWriteCount":2,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":44.09441400000105} 17:09:13 [17:09:13.677] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.055168385000000854s {"duration":0.055168385000000854,"rate":430536.4385779941,"totalPublicGas":{"daGas":512,"l2Gas":23752},"totalBlockGas":{"daGas":2048,"l2Gas":54952},"totalSizeInBytes":352} 17:09:13 [17:09:13.798] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 124177.64787804158 mana/s {"blockHash":"0x223dacae390fb691f78393b566a4b44c568dd1c297a398bb8b278ec57cc9165e","globalVariables":{"chainId":31337,"version":655753031,"blockNumber":3,"slotNumber":4,"timestamp":1749834878,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x00ff9f1a14bd78159829bca15c47e66b19e5a6ed53f652d1a1501246174dc780"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":190.72700599999916,"publicProcessDuration":55.498741000001246,"rollupCircuitsDuration":177.70232399999986,"txCount":1,"blockNumber":3,"blockTimestamp":1749834878,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:13 [17:09:13.800] VERBOSE: sequencer Attesting committee is empty 17:09:13 [17:09:13.886] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:14 [17:09:14.059] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x6a24776bc9bd4a0d4bc40b0c363925f317eafcaa8ed4fded08e5057b80bcfa92 17:09:14 [17:09:14.059] VERBOSE: sequencer-client Sent L1 transaction 0x6a24776bc9bd4a0d4bc40b0c363925f317eafcaa8ed4fded08e5057b80bcfa92 {"gasLimit":470265,"maxFeePerGas":"1.27958333","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:09:14 [17:09:14.067] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:14 [17:09:14.067] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x6a24776bc9bd4a0d4bc40b0c363925f317eafcaa8ed4fded08e5057b80bcfa92","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":3,"blockTimestamp":1749834878,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:14 [17:09:14.068] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:14 [17:09:14.070] INFO: blob-sink:server Received blob sidecar for block 0xebaddeb4f8ac6d6aaa57d3bb5ec34820c5210b898f211fff652be65388a2dcd4 17:09:14 [17:09:14.073] INFO: blob-sink:server Blob sidecar stored successfully for block 0xebaddeb4f8ac6d6aaa57d3bb5ec34820c5210b898f211fff652be65388a2dcd4 17:09:14 [17:09:14.089] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:14 [17:09:14.095] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:09:14 [17:09:14.096] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:09:14 [17:09:14.098] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:09:14 [17:09:14.136] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834914] on http://127.0.0.1:8545 17:09:14 [17:09:14.139] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:14 [17:09:14.234] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834914 17:09:14 [17:09:14.234] WARN: foundation:test-date-provider Time set to 2025-06-13T17:15:14.000Z {"offset":359766,"timeMs":1749834914000} 17:09:14 [17:09:14.235] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:09:14 [17:09:14.241] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x223dacae390fb691f78393b566a4b44c568dd1c297a398bb8b278ec57cc9165e","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":655753031,"blockNumber":3,"slotNumber":4,"timestamp":1749834878,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1aab988b840956240c9af7b0ed3cd6fbc2b3ddb0d87826f911a2c830ce860552","archiveNextLeafIndex":4} 17:09:14 [17:09:14.243] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:09:14 [17:09:14.293] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:14 [17:09:14.352] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.75988199999847,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834878,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:14 [17:09:14.357] VERBOSE: p2p Synched to latest block 3 17:09:14 [17:09:14.494] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:14 [17:09:14.583] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1aab988b840956240c9af7b0ed3cd6fbc2b3ddb0d87826f911a2c830ce860552","blockNumber":4,"slot":5} 17:09:14 [17:09:14.696] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:14 [17:09:14.898] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:15 [17:09:15.094] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1aab988b840956240c9af7b0ed3cd6fbc2b3ddb0d87826f911a2c830ce860552","blockNumber":4,"slot":5} 17:09:15 [17:09:15.098] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:15 [17:09:15.108] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x1aab988b840956240c9af7b0ed3cd6fbc2b3ddb0d87826f911a2c830ce860552","header":{"contentCommitment":{"blobsHash":"0x0015f7e5dd8ab3a6480e525740a1c24ef24a845ad157f27edb0b2ca8d4f8a4ce","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834878,"version":655753031},"lastArchive":"0x23c2d9175bed45adaa9ab137ccdba0127d72ca44a04f55a48dcf577708b22e7e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x077dcd6c1e84f660ec6acbb1db12aef99978c7bea82a2dd1f9c78f244dedd3f8","nullifierTree":"0x2d9b7847c694310bd5fc1526b7705891f65dc18a68ca7d6bd735098bbdc95386","publicDataTree":"0x024c454595957de9670ed79f0edffd436491a4f896ef03ec7c7594cb22a90e98"},"totalFees":18258351520,"totalManaUsed":54952}} 17:09:15 [17:09:15.131] VERBOSE: simulator Executing utility function get_vote {"contract":"0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9","selector":"0x50ac913f"} 17:09:15 [17:09:15.135] VERBOSE: simulator Utility simulation for 0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9.0x50ac913f completed 17:09:15 [17:09:15.147] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b {"origin":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000002715ff47","authWitnesses":["0x2f21bd16e62fcff9666264f24d1c5abfe88001fc25ffe4eb4ee8b57aec6af6d3"]} 17:09:15 [17:09:15.212] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:15 [17:09:15.244] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:15 [17:09:15.245] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:15 [17:09:15.291] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:15 [17:09:15.295] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20af57d96b75647ddce14795ff2a77b45da60424971e9b3e4cdf7ba44ba216b5 17:09:15 [17:09:15.304] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:15 [17:09:15.305] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:15 [17:09:15.306] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:15 [17:09:15.313] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:15 [17:09:15.313] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:15 [17:09:15.316] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2333677e8dd28de3e989cddba7883dacd6a9726da478908761b9cf2bdeeca7e8","nullifier":"0x11a75475b9bca80e4001e681a0caa78b0ec210eb8629df984757ab402a0cc41d"} 17:09:15 [17:09:15.317] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:15 [17:09:15.328] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b as fee payer 17:09:15 [17:09:15.350] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9"} 17:09:15 [17:09:15.515] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:15 [17:09:15.943] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:15 [17:09:15.960] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1aab988b840956240c9af7b0ed3cd6fbc2b3ddb0d87826f911a2c830ce860552","blockNumber":4,"slot":5} 17:09:15 [17:09:15.964] VERBOSE: node Simulating public calls for tx 0x132865c001b0c8f72ab15732472535cbc63c8f5f9a38774cd451b14bc0e06a02 {"globalVariables":{"chainId":31337,"version":655753031,"blockNumber":4,"slotNumber":5,"timestamp":1749834914,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHash":"0x132865c001b0c8f72ab15732472535cbc63c8f5f9a38774cd451b14bc0e06a02","blockNumber":4} 17:09:15 [17:09:15.981] VERBOSE: simulator:state_manager Siloed nullifier 0x2c91cfd6a9bc333286aeb8ab3b24dd8bc0f2ba48e6177d321c35f5b2115d524e already present in tree! 17:09:15 [17:09:15.984] WARN: simulator:public_tx_context APP_LOGIC phase reverted! insertRevertiblesFromPrivate failed with reason: Nullifier collision encountered when inserting revertible nullifiers from private 17:09:15 Details: Siloed nullifier 0x2c91cfd6a9bc333286aeb8ab3b24dd8bc0f2ba48e6177d321c35f5b2115d524e already exists in parent cache or host. 17:09:15 Error stack: NullifierCollisionError: Siloed nullifier 0x2c91cfd6a9bc333286aeb8ab3b24dd8bc0f2ba48e6177d321c35f5b2115d524e already exists in parent cache or host. 17:09:15 at PublicPersistableStateManager.writeSiloedNullifier (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/state_manager/state_manager.js:190:23) 17:09:15 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:263:17) 17:09:15 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:33:24) 17:09:15 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:54:29) 17:09:15 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:14:25) 17:09:15 at PublicProcessor.processTxWithPublicCalls (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:321:91) 17:09:15 at PublicProcessor.processTxWithinDeadline (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:268:20) 17:09:15 at elapsed (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/timer/elapsed.js:8:20) 17:09:15 at PublicProcessor.processTx (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:221:53) 17:09:15 at PublicProcessor.process (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:159:53) 17:09:15 at AztecNodeService.simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:718:66) 17:09:15 at PXEService.#simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:241:28) 17:09:15 at /home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:580:36 17:09:15 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 17:09:15 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 17:09:16 [17:09:16.001] VERBOSE: simulator:public-processor Processed tx 0x132865c001b0c8f72ab15732472535cbc63c8f5f9a38774cd451b14bc0e06a02 with 1 public calls in 27.931431999997585ms {"txHash":"0x132865c001b0c8f72ab15732472535cbc63c8f5f9a38774cd451b14bc0e06a02","txFee":1581840000,"revertCode":1,"revertReason":{"originalMessage":"Nullifier collision encountered when inserting revertible nullifiers from private\nDetails: Siloed nullifier 0x2c91cfd6a9bc333286aeb8ab3b24dd8bc0f2ba48e6177d321c35f5b2115d524e already exists in parent cache or host.\nError stack: NullifierCollisionError: Siloed nullifier 0x2c91cfd6a9bc333286aeb8ab3b24dd8bc0f2ba48e6177d321c35f5b2115d524e already exists in parent cache or host.\n at PublicPersistableStateManager.writeSiloedNullifier (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/state_manager/state_manager.js:190:23)\n at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:263:17)\n at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:33:24)\n at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:54:29)\n at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:14:25)\n at PublicProcessor.processTxWithPublicCalls (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:321:91)\n at PublicProcessor.processTxWithinDeadline (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:268:20)\n at elapsed (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/timer/elapsed.js:8:20)\n at PublicProcessor.processTx (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:221:53)\n at PublicProcessor.process (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:159:53)\n at AztecNodeService.simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:718:66)\n at PXEService.#simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:241:28)\n at /home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:580:36\n at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33\n at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17)","functionErrorStack":[],"revertData":[]},"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":31200},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0},"billedGas":{"daGas":1536,"l2Gas":31200}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":27.931431999997585} 17:09:16 [17:09:16.002] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03369291599999997s {"duration":0.03369291599999997,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":31200},"totalSizeInBytes":256} 17:09:16 [17:09:16.003] ERROR: pxe:service Failed to enrich public simulation error: TypeError: Cannot read properties of undefined (reading 'contractAddress') 17:09:16 [17:09:16.077] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:16 [17:09:16.109] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:16 [17:09:16.110] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:16 [17:09:16.144] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b"} 17:09:16 [17:09:16.148] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20af57d96b75647ddce14795ff2a77b45da60424971e9b3e4cdf7ba44ba216b5 17:09:16 [17:09:16.151] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:16 [17:09:16.160] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:16 [17:09:16.161] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:16 [17:09:16.169] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:16 [17:09:16.170] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:16 [17:09:16.174] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2333677e8dd28de3e989cddba7883dacd6a9726da478908761b9cf2bdeeca7e8","nullifier":"0x11a75475b9bca80e4001e681a0caa78b0ec210eb8629df984757ab402a0cc41d"} 17:09:16 [17:09:16.176] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:16 [17:09:16.187] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05ce46b1eb28676f53637ed7909736561ce326b434f8b65da9b76f596ba67a6b as fee payer 17:09:16 [17:09:16.210] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x1983f7d08685a022b36f68a005664360efb26a1fa845debbb154e310d6e455f9"} 17:09:16 [17:09:16.400] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:16 [17:09:16.828] INFO: pxe:service Proving completed in 814.1976940000022ms {"timings":{"total":814.1976940000022,"sync":2.560891000000993,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":170.28536899999744,"oracles":{"debugLog":{"times":[0.4473889999972016,0.39591400000063004,0.4167359999992186,0.47145699999964563,0.38127000000167754,0.3194919999987178,0.3468619999985094,0.4542409999994561]},"fetchTaggedLogs":{"times":[36.82430300000124]},"loadCapsule":{"times":[0.17836800000077346,0.16012299999783863,0.34159400000135065,0.19586799999888171,0.17500299999665003,0.18712100000266219]},"getSharedSecret":{"times":[5.639188999997714]},"aes128Decrypt":{"times":[0.22612300000037067,0.8619639999997162]},"getPublicKeysAndPartialAddress":{"times":[1.193783999999141]},"getKeyValidationRequest":{"times":[4.681478999998944]},"deliverNote":{"times":[4.876156000002084]},"deleteCapsule":{"times":[0.2208710000013525]},"storeCapsule":{"times":[0.2024989999990794]},"getNotes":{"times":[1.1544789999970817]},"getAuthWitness":{"times":[0.20958999999857042]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05290700000114157]},"callPrivateFunction":{"times":[41.104379000000336]}}},{"functionName":"private_kernel_init","time":88.1764529999964},{"functionName":"EasyPrivateVoting:cast_vote","time":30.484026999998605,"oracles":{"getPublicKeysAndPartialAddress":{"times":[4.744445000000269]},"getKeyValidationRequest":{"times":[1.543746999999712]},"notifyCreatedNullifier":{"times":[0.1908499999990454]},"storeInExecutionCache":{"times":[0.04120200000033947]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05365199999869219]}}},{"functionName":"private_kernel_inner","time":116.17736399999922},{"functionName":"private_kernel_reset","time":181.35207699999955},{"functionName":"private_kernel_tail","time":80.3496559999985}],"unaccounted":144.8118570000115}} 17:09:16 [17:09:16.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:16 [17:09:16.871] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1aab988b840956240c9af7b0ed3cd6fbc2b3ddb0d87826f911a2c830ce860552","blockNumber":4,"slot":5} 17:09:16 [17:09:16.877] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x0b23e647b596d57cfa74aaac2ee653cc804d341a566b561a3ff49a3d3276b72d for repeating a nullifier 17:09:16 [17:09:16.880] WARN: node Received invalid tx 0x0b23e647b596d57cfa74aaac2ee653cc804d341a566b561a3ff49a3d3276b72d: Existing nullifier {"txHash":"0x0b23e647b596d57cfa74aaac2ee653cc804d341a566b561a3ff49a3d3276b72d"} 17:09:16 [17:09:16.884] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 17:09:16 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 17:09:16 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 17:09:16 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 17:09:16 [17:09:16.886] INFO: node Stopping 17:09:16 [17:09:16.887] INFO: slasher Slasher client stopped. 17:09:16 [17:09:16.887] INFO: sequencer Stopped sequencer 17:09:16 [17:09:16.887] INFO: p2p P2P client stopped. 17:09:16 [17:09:16.889] INFO: world_state Stopped world state synchronizer 17:09:16 [17:09:16.889] INFO: archiver Stopped. 17:09:16 [17:09:16.889] INFO: node Stopped 17:09:16 [17:09:16.889] VERBOSE: e2e:e2e_private_voting_contract Cleaning up ACVM state 17:09:16 [17:09:16.889] INFO: e2e:e2e_private_voting_contract Cleaning up ACVM temp directory /tmp/288acf99 17:09:16 [17:09:16.890] VERBOSE: e2e:e2e_private_voting_contract Cleaning up BB state 17:09:16 [17:09:16.898] INFO: blob-sink:server Stopping blob sink 17:09:16 [17:09:16.899] INFO: blob-sink:server Blob sink stopped 17:09:16 [17:09:16.899] VERBOSE: e2e:e2e_private_voting_contract Cleaning up data directory at /tmp/94d58f908ca950bf 17:09:16 PASS src/e2e_private_voting_contract.test.ts 17:09:16 e2e_voting_contract 17:09:16 votes 17:09:16 ✓ votes, then tries to vote again (4662 ms) 17:09:16 17:09:16 Test Suites: 1 passed, 1 total 17:09:16 Tests: 1 passed, 1 total 17:09:16 Snapshots: 0 total 17:09:16 Time: 19.034 s 17:09:16 Ran all test suites matching /src\/e2e_private_voting_contract.test.ts/i. 17:09:16 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?