ACI ·

Parent Log: http://ci.aztec-labs.com/a3bb03fa16e317bc Command: 00c2c16648004337: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/015cb0cadef6a41094c3649f32a735392e1b9693 Env: REF_NAME=gh-readonly-queue/master/pr-15027-e9a2301883801edbe36ea8bba05dcca7e714f30a CURRENT_VERSION=0.87.8 CI_FULL=0 Date: Wed Jun 18 14:25:34 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15027_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_f9aac7f8d569bb18_master 14:25:34 +++ id -u 14:25:34 +++ id -g 14:25:34 ++ 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'\''' 14:25:34 + cid=90a31faffdca1cc9d2317597d83905af619f09e31a69f871ec74727d530d41ac 14:25:34 + set +x 14:25:35 {"level":25,"time":1750256735278,"pid":12,"hostname":"90a31faffdca","module":"logger","msg":"Logger initialized with level verbose"} 14:25:39 [14:25:39.484] INFO: e2e:e2e_private_voting_contract Logging metrics to log/unknown.jsonl 14:25:39 [14:25:39.678] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-NuUJQS/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 14:25:39 [14:25:39.708] INFO: e2e:e2e_private_voting_contract Calling anvil_setBlockTimestampInterval with params: [12] 14:25:39 [14:25:39.730] WARN: e2e:e2e_private_voting_contract Set block interval to 12 14:25:39 [14:25:39.731] VERBOSE: e2e:e2e_private_voting_contract Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:25:39 [14:25:39.776] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 14:25:39 [14:25:39.783] VERBOSE: e2e:e2e_private_voting_contract Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 14:25:39 [14:25:39.799] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 14:25:39 [14:25:39.804] VERBOSE: e2e:e2e_private_voting_contract Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 14:25:39 [14:25:39.820] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 14:25:39 [14:25:39.825] VERBOSE: e2e:e2e_private_voting_contract Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 14:25:39 [14:25:39.840] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 14:25:39 [14:25:39.845] VERBOSE: e2e:e2e_private_voting_contract Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 14:25:39 [14:25:39.861] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 14:25:39 [14:25:39.865] VERBOSE: e2e:e2e_private_voting_contract Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 14:25:39 [14:25:39.877] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 14:25:39 [14:25:39.881] VERBOSE: e2e:e2e_private_voting_contract Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 14:25:39 [14:25:39.881] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 14:25:39 [14:25:39.882] INFO: e2e:e2e_private_voting_contract Waiting for 6 transactions to be mined... 14:25:39 [14:25:39.901] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 14:25:39 [14:25:39.914] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 14:25:39 [14:25:39.915] VERBOSE: e2e:e2e_private_voting_contract Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 14:25:39 [14:25:39.926] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 14:25:39 [14:25:39.938] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 14:25:39 [14:25:39.945] VERBOSE: e2e:e2e_private_voting_contract Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 14:25:39 [14:25:39.956] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 14:25:39 [14:25:39.957] VERBOSE: e2e:e2e_private_voting_contract Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 14:25:39 [14:25:39.971] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 14:25:39 [14:25:39.976] VERBOSE: e2e:e2e_private_voting_contract Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 14:25:39 [14:25:39.987] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 14:25:39 [14:25:39.987] VERBOSE: e2e:e2e_private_voting_contract Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 14:25:39 [14:25:39.987] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 14:25:39 [14:25:39.987] INFO: e2e:e2e_private_voting_contract Waiting for 8 transactions to be mined... 14:25:40 [14:25:40.003] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 14:25:40 [14:25:40.012] VERBOSE: e2e:e2e_private_voting_contract Deployed shared contracts 14:25:40 [14:25:40.026] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 14:25:40 [14:25:40.026] VERBOSE: e2e:e2e_private_voting_contract Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 14:25:40 [14:25:40.029] 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} 14:25:40 [14:25:40.043] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 14:25:40 [14:25:40.065] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 14:25:40 [14:25:40.069] VERBOSE: e2e:e2e_private_voting_contract Awaiting for linked libraries to be deployed 14:25:40 [14:25:40.103] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x4bcdca00b76979844761c871ecfc2a08ee71fe63bfeb9187d482d1538eb28012 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 14:25:40 [14:25:40.108] 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} 14:25:40 [14:25:40.108] INFO: e2e:e2e_private_voting_contract Waiting for 9 transactions to be mined... 14:25:40 [14:25:40.129] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 14:25:40 [14:25:40.129] VERBOSE: e2e:e2e_private_voting_contract All core contracts have been deployed 14:25:40 [14:25:40.142] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 14:25:40 [14:25:40.142] VERBOSE: e2e:e2e_private_voting_contract Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 14:25:40 [14:25:40.153] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 14:25:40 [14:25:40.157] VERBOSE: e2e:e2e_private_voting_contract Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 14:25:40 [14:25:40.176] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 14:25:40 [14:25:40.176] VERBOSE: e2e:e2e_private_voting_contract Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 14:25:40 [14:25:40.176] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 14:25:40 [14:25:40.194] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 14:25:40 [14:25:40.200] VERBOSE: e2e:e2e_private_voting_contract Rollup deployed 14:25:40 [14:25:40.200] VERBOSE: e2e:e2e_private_voting_contract Waiting for rollup and slash factory to be deployed 14:25:40 [14:25:40.200] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 14:25:40 [14:25:40.221] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 14:25:40 [14:25:40.221] VERBOSE: e2e:e2e_private_voting_contract All transactions for L1 deployment have been mined 14:25:40 [14:25:40.237] 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"} 14:25:40 [14:25:40.239] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 14:25:40 [14:25:40.241] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:40 [14:25:40.242] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 14:25:40 [14:25:40.243] INFO: telemetry:client Using NoopTelemetryClient 14:25:40 [14:25:40.248] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 14:25:40 [14:25:40.248] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 14:25:40 [14:25:40.249] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/ea972afb7ae08094/blob-sink with map size 134217728 KB (LMDB v2) 14:25:40 [14:25:40.250] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:40 [14:25:40.253] INFO: aztecjs:utils:watcher New L1 time: 1750256979 14:25:40 [14:25:40.253] WARN: foundation:test-date-provider Time set to 2025-06-18T14:29:39.000Z {"offset":238747,"timeMs":1750256979000} 14:25:40 [14:25:40.255] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 14:25:40 [14:25:40.260] INFO: blob-sink:server Server is running on http://localhost:37157 14:25:40 [14:25:40.260] VERBOSE: e2e:e2e_private_voting_contract Creating and synching an aztec node... 14:25:40 [14:25:40.261] VERBOSE: e2e:e2e_private_voting_contract Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/c3c73891/acvm 14:25:40 [14:25:40.261] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:37157"} 14:25:40 [14:25:40.275] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 14:25:40 [14:25:40.275] INFO: archiver:lmdb Creating archiver data store at directory /tmp/ea972afb7ae08094/archiver with map size 134217728 KB (LMDB v2) 14:25:40 [14:25:40.276] INFO: archiver:lmdb Starting data store with maxReaders 16 14:25:40 [14:25:40.457] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:40 [14:25:40.531] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:37157"} 14:25:40 [14:25:40.545] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:37157"} 14:25:40 [14:25:40.545] WARN: node:blob-sink:client No L1 consensus host urls configured 14:25:40 [14:25:40.545] WARN: node:blob-sink:client No archive client configured 14:25:40 [14:25:40.548] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x641e3084d2c97e2042586dc84c5e7d49e07dbc2d70f1b68f9b9c76967e606f77 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x88eed7f555c04bf5aa89ac24cd2b351ca948df13b4bfd3d2c73c9795ee49e1c6","l1BlockNumber":16}} 14:25:40 [14:25:40.559] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 14:25:40 [14:25:40.565] INFO: world-state:database Creating world state data store at directory /tmp/ea972afb7ae08094/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 14:25:40 [14:25:40.587] INFO: world_state Created world state synchroniser with block history of 64 14:25:40 [14:25:40.587] WARN: node Aztec node is accepting fake proofs 14:25:40 [14:25:40.597] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/ea972afb7ae08094/p2p with map size 134217728 KB (LMDB v2) 14:25:40 [14:25:40.598] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 14:25:40 [14:25:40.598] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/ea972afb7ae08094/p2p-archive with map size 134217728 KB (LMDB v2) 14:25:40 [14:25:40.599] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 14:25:40 [14:25:40.600] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/ea972afb7ae08094/p2p-peers with map size 134217728 KB (LMDB v2) 14:25:40 [14:25:40.601] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 14:25:40 [14:25:40.602] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 14:25:40 [14:25:40.602] VERBOSE: p2p P2P is disabled. Using dummy P2P service 14:25:40 [14:25:40.605] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 14:25:40 [14:25:40.605] INFO: world_state Started world state synchronizer from block 1 14:25:40 [14:25:40.607] VERBOSE: world-state:block_stream Starting sync from block number 0 14:25:40 [14:25:40.609] INFO: p2p Starting p2p client from block 0 with empty mempools 14:25:40 [14:25:40.609] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 14:25:40 [14:25:40.610] INFO: slasher Slasher client initialized 14:25:40 [14:25:40.611] INFO: slasher Starting Slasher client... 14:25:40 [14:25:40.639] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:25:40 [14:25:40.639] VERBOSE: node All Aztec Node subsystems synced 14:25:40 [14:25:40.645] INFO: sequencer-client Deploying forwarder contract 14:25:40 [14:25:40.650] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 14:25:40 [14:25:40.662] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:40 [14:25:40.664] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 14:25:40 [14:25:40.664] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 14:25:40 [14:25:40.669] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:25:40 [14:25:40.682] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:25:40 [14:25:40.682] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 14:25:40 [14:25:40.683] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/c3c73891/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 14:25:40 [14:25:40.865] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 14:25:40 [14:25:40.867] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:25:40 [14:25:40.868] INFO: node Aztec Node version: 0.87.8 14:25:40 [14:25:40.868] 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"} 14:25:40 [14:25:40.869] VERBOSE: e2e:e2e_private_voting_contract Creating a pxe... 14:25:40 [14:25:40.872] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:40 [14:25:40.880] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/74c8d053a111a051/pxe_data with map size 134217728 KB (LMDB v2) 14:25:40 [14:25:40.889] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x155afaeca6ad983008591a3b238e896789db95b13dcbac2315aa9083e83e6c34","blockNumber":1,"slot":2} 14:25:40 [14:25:40.890] INFO: pxe:data:lmdb Starting data store with maxReaders 16 14:25:41 [14:25:41.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:41 [14:25:41.111] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 14:25:41 [14:25:41.111] INFO: pxe:service Started PXE connected to chain 31337 version 2713347771 14:25:41 [14:25:41.159] INFO: pxe:service Registered account 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c 14:25:41 [14:25:41.212] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 14:25:41 [14:25:41.213] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c 14:25:41 [14:25:41.324] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:41 [14:25:41.327] INFO: pxe:service Added contract SchnorrAccount at 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:25:41 [14:25:41.365] VERBOSE: pxe:block_stream Starting sync from block number 0 14:25:41 [14:25:41.382] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 14:25:41 [14:25:41.461] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x155afaeca6ad983008591a3b238e896789db95b13dcbac2315aa9083e83e6c34","blockNumber":1,"slot":2} 14:25:41 [14:25:41.468] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:25:41 [14:25:41.873] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 14:25:41 [14:25:41.947] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:25:42 [14:25:42.005] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:42 [14:25:42.054] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x155afaeca6ad983008591a3b238e896789db95b13dcbac2315aa9083e83e6c34","blockNumber":1,"slot":2} 14:25:42 [14:25:42.101] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:42 [14:25:42.136] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:25:42 [14:25:42.137] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:42 [14:25:42.173] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:42 [14:25:42.177] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:25:42 [14:25:42.225] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:42 [14:25:42.330] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:42 [14:25:42.364] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:25:42 [14:25:42.364] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:42 [14:25:42.393] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:42 [14:25:42.396] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:25:42 [14:25:42.409] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c as fee payer 14:25:42 [14:25:42.431] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:42 [14:25:42.641] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:42 [14:25:42.648] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x155afaeca6ad983008591a3b238e896789db95b13dcbac2315aa9083e83e6c34","blockNumber":1,"slot":2} 14:25:42 [14:25:42.866] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:43 [14:25:43.396] INFO: pxe:service Proving completed in 2038.9732790000007ms {"timings":{"total":2038.9732790000007,"sync":8.317036000000371,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":119.30115900000146,"oracles":{"callPrivateFunction":{"times":[577.0657449999999,264.68343600000026,154.2010969999992]}}},{"functionName":"private_kernel_init","time":94.01750400000037},{"functionName":"ContractClassRegisterer:register","time":564.0632029999997,"oracles":{"loadCapsule":{"times":[4.395352999999886]},"notifyCreatedNullifier":{"times":[0.6235870000000432]},"debugLog":{"times":[0.8081320000001142]},"notifyCreatedContractClassLog":{"times":[7.939649000000827]}}},{"functionName":"private_kernel_inner","time":117.0727369999995},{"functionName":"SchnorrAccount:constructor","time":240.02313099999992,"oracles":{"getContractInstance":{"times":[1.244672000000719]},"debugLog":{"times":[0.4681170000003476,0.4245949999994991]},"fetchTaggedLogs":{"times":[39.04684499999985]},"loadCapsule":{"times":[0.3871130000006815,0.2313850000000457,0.2442559999999503]},"notifyCreatedNullifier":{"times":[0.2177190000002156,0.21588900000006106]},"notifyCreatedNote":{"times":[0.4054519999999684]},"getRandomField":{"times":[0.39785400000073423,0.17198399999961111,0.09497599999940576,0.07499000000007072,0.08067599999958475,0.07580000000052678,0.0780510000004142,0.06304499999987456,0.08222299999943061,0.08244999999988067,0.06592599999930826]},"getIndexedTaggingSecretAsSender":{"times":[30.861439999999675]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.35325499999999]}}},{"functionName":"private_kernel_inner","time":107.4694329999993},{"functionName":"SchnorrAccount:entrypoint","time":132.19377899999927,"oracles":{"debugLog":{"times":[0.4585090000000491,0.43346699999983684,0.6152140000003783]},"fetchTaggedLogs":{"times":[30.316671000000497]},"loadCapsule":{"times":[0.2399890000006053,0.20301800000015646,0.24575699999968492]},"getNotes":{"times":[1.5223350000005667]},"getAuthWitness":{"times":[0.359546999999111]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8546799999994619]}}},{"functionName":"private_kernel_inner","time":110.71677699999964},{"functionName":"private_kernel_reset","time":161.54721299999983},{"functionName":"private_kernel_tail","time":67.6247540000004}],"unaccounted":316.62655300000097}} 14:25:43 [14:25:43.412] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:43 [14:25:43.480] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x155afaeca6ad983008591a3b238e896789db95b13dcbac2315aa9083e83e6c34","blockNumber":1,"slot":2} 14:25:43 [14:25:43.541] VERBOSE: p2p:tx_pool Adding tx 0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4 to pool {"eventName":"tx-added-to-pool","txHash":"0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:25:43 [14:25:43.560] INFO: node Received tx 0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4 {"txHash":"0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4"} 14:25:43 [14:25:43.560] INFO: pxe:service Sent transaction 0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4 14:25:43 [14:25:43.620] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:43 [14:25:43.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:43 [14:25:43.992] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 14:25:44 [14:25:44.004] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T14:30:03.000Z","now":"2025-06-18T14:29:42.751Z"} 14:25:44 [14:25:44.067] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:44 [14:25:44.234] VERBOSE: simulator:public-processor Processed tx 0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4 with no public calls in 157.38629600000058ms {"txHash":"0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4","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.38629600000058} 14:25:44 [14:25:44.238] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2321700639999999s {"duration":0.2321700639999999,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 14:25:44 [14:25:44.350] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:44 [14:25:44.364] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0121f7b726aaa6047e3e36585f42b68c7da0133b002407c11877f5ce29510263","globalVariables":{"chainId":31337,"version":2713347771,"blockNumber":1,"slotNumber":2,"timestamp":1750257003,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0c78e932d1b0f72c605e0c3c3dbfc6b3bd95afa49db7ad5198629f1203afcaf4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":371.8415839999998,"publicProcessDuration":232.92897000000085,"rollupCircuitsDuration":360.38867799999935,"txCount":1,"blockNumber":1,"blockTimestamp":1750257003,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:25:44 [14:25:44.366] VERBOSE: sequencer Attesting committee is empty 14:25:44 [14:25:44.555] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:44 [14:25:44.726] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf5c98874c5c7c8b64bba25c5739b71014175a7125baee80bec32c0675242938e 14:25:44 [14:25:44.726] VERBOSE: sequencer-client Sent L1 transaction 0xf5c98874c5c7c8b64bba25c5739b71014175a7125baee80bec32c0675242938e {"gasLimit":514585,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 14:25:44 [14:25:44.739] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:25:44 [14:25:44.740] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf5c98874c5c7c8b64bba25c5739b71014175a7125baee80bec32c0675242938e","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750257003,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:25:44 [14:25:44.740] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:25:44 [14:25:44.754] INFO: blob-sink:server Received blob sidecar for block 0x73fa530bc935bcd96946f482a2f189ea7c395a227480d3e8710354a3af713f4f 14:25:44 [14:25:44.757] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:44 [14:25:44.763] INFO: blob-sink:server Blob sidecar stored successfully for block 0x73fa530bc935bcd96946f482a2f189ea7c395a227480d3e8710354a3af713f4f 14:25:44 [14:25:44.764] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 14:25:44 [14:25:44.767] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 14:25:44 [14:25:44.769] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 14:25:44 [14:25:44.777] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257039] on http://127.0.0.1:8545 14:25:44 [14:25:44.779] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:25:44 [14:25:44.780] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257039 14:25:44 [14:25:44.780] WARN: foundation:test-date-provider Time set to 2025-06-18T14:30:39.000Z {"offset":294220,"timeMs":1750257039000} 14:25:44 [14:25:44.781] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 14:25:44 [14:25:44.966] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:45 [14:25:45.113] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:25:45 [14:25:45.118] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0121f7b726aaa6047e3e36585f42b68c7da0133b002407c11877f5ce29510263","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2713347771,"blockNumber":1,"slotNumber":2,"timestamp":1750257003,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x24a275a3b4794e8239921f4c97f7aefdbf4a37a972826ff2536b0e7d76e5966c","archiveNextLeafIndex":2} 14:25:45 [14:25:45.126] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 14:25:45 [14:25:45.169] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:45 [14:25:45.243] WARN: pxe:service No artifact found for contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 when looking for its metadata 14:25:45 [14:25:45.243] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 as part of deployment for 0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544 14:25:45 [14:25:45.256] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":16.071296000000075,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750257003,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:25:45 [14:25:45.317] VERBOSE: p2p Synched to latest block 1 14:25:45 [14:25:45.354] INFO: pxe:service Added contract EasyPrivateVoting at 0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544 with class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 14:25:45 [14:25:45.373] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:45 [14:25:45.383] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x24a275a3b4794e8239921f4c97f7aefdbf4a37a972826ff2536b0e7d76e5966c","header":{"contentCommitment":{"blobsHash":"0x008e916fdf7bce5273b0cf4d3fc5bcec178ec36821e309ab457b5ddbc2ab47fe","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750257003,"version":2713347771},"lastArchive":"0x155afaeca6ad983008591a3b238e896789db95b13dcbac2315aa9083e83e6c34","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0e11d624cb64f87bbb493641f879158231dd8c5ae3e85a534cd6865baa61d0eb","nullifierTree":"0x0d52290f854f15cf6485334ce2a348d7ed54a5b463dc3897771c04c4541a1feb","publicDataTree":"0x00e768e1f6d972c2155c62b859838b53134dcc8950748ce3d729206936ce7b76"},"totalFees":6794052480,"totalManaUsed":20448}} 14:25:45 [14:25:45.453] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:45 [14:25:45.486] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:25:45 [14:25:45.487] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:45 [14:25:45.535] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:45 [14:25:45.538] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x27b34119766d6ed90eab3a6dba7ae710c363a224e4e9adde752ba183f2414002 14:25:45 [14:25:45.549] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:25:45 [14:25:45.550] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:25:45 [14:25:45.555] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:25:45 [14:25:45.556] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:25:45 [14:25:45.559] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1d96df8ed1a541a4e9ad35d57eb28fb6db0afa7afb1a39d3c92a3e16da4a2164","nullifier":"0x0c5c9d3e15448e9ee35b2712fd4b9572b369683a1a92ac41aa395f6349d2303f"} 14:25:45 [14:25:45.562] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:25:45 [14:25:45.573] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c as fee payer 14:25:45 [14:25:45.576] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:45 [14:25:45.604] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:25:45 [14:25:45.912] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x07c93431ee7228896e85ee48c35d1e5b5d747283021244321f1e2360b29dc702,0x0eb6620c85cc03233af00abd8ad2f32e9528f320b09af98beb73808818ac20da,0x13d6566bc501e38ffb391e30ee7b29055b9227558ad14198c97fbf4c5f80e599 14:25:45 [14:25:45.983] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:25:46 [14:25:46.039] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:46 [14:25:46.098] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:25:46 [14:25:46.110] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24a275a3b4794e8239921f4c97f7aefdbf4a37a972826ff2536b0e7d76e5966c","blockNumber":2,"slot":3} 14:25:46 [14:25:46.137] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:25:46 [14:25:46.147] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544,0x0000000000000000000000000000000000000000000000000000000000000001,0x29056a41fc02f448df9cfd154d4e37833695d230499dc2f0e2f9278c1d9ee49a,0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x16b45589bf54408af95a84f867aa2374ffb8382953807b3cae08dc668c3327f2,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c 14:25:46 [14:25:46.293] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:46 [14:25:46.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:46 [14:25:46.725] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24a275a3b4794e8239921f4c97f7aefdbf4a37a972826ff2536b0e7d76e5966c","blockNumber":2,"slot":3} 14:25:46 [14:25:46.725] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:47 [14:25:47.087] INFO: pxe:service Proving completed in 1718.8689779999986ms {"timings":{"total":1718.8689779999986,"sync":16.52996600000006,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":199.76694400000088,"oracles":{"debugLog":{"times":[0.4913799999994808,0.42613300000084564,0.43680500000118627,0.4990799999995943,0.41934500000024855,0.32789799999954994,0.36913000000095053,0.47263999999995576]},"fetchTaggedLogs":{"times":[49.84118900000067]},"loadCapsule":{"times":[0.20986999999877298,0.4447839999993448,0.42854999999872234,0.23949999999967986,0.2183469999999943,0.2126029999999446]},"getSharedSecret":{"times":[3.221013000000312]},"aes128Decrypt":{"times":[0.9449939999994967,0.9169499999989057]},"getPublicKeysAndPartialAddress":{"times":[1.3503140000011626]},"getKeyValidationRequest":{"times":[1.6389469999994617]},"deliverNote":{"times":[3.731658000000607]},"deleteCapsule":{"times":[0.40649800000028335]},"storeCapsule":{"times":[0.33499399999891466]},"getNotes":{"times":[1.5752799999991112]},"getAuthWitness":{"times":[0.19014400000014575]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0577290000001085]},"callPrivateFunction":{"times":[461.22936200000004,114.73174699999981]},"notifyEnqueuedPublicFunctionCall":{"times":[0.25137399999948684]}}},{"functionName":"private_kernel_init","time":54.269577999999456},{"functionName":"ContractClassRegisterer:register","time":449.4535219999998,"oracles":{"loadCapsule":{"times":[3.4552869999988616]},"notifyCreatedNullifier":{"times":[0.29706699999951525]},"debugLog":{"times":[0.5103820000003907]},"notifyCreatedContractClassLog":{"times":[7.044280000000072]}}},{"functionName":"private_kernel_inner","time":110.95382199999949},{"functionName":"ContractInstanceDeployer:deploy","time":71.18435199999658,"oracles":{"storeInExecutionCache":{"times":[0.1595660000002681]},"callPrivateFunction":{"times":[40.5883900000008]},"notifyCreatedNullifier":{"times":[0.255527000001166]},"debugLog":{"times":[0.4390830000011192]}}},{"functionName":"private_kernel_inner","time":109.30062200000066},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":31.8652510000029,"oracles":{}},{"functionName":"private_kernel_inner","time":105.2827870000001},{"functionName":"private_kernel_reset","time":167.99947299999985},{"functionName":"private_kernel_tail","time":83.6608099999994}],"unaccounted":318.60185099999944}} 14:25:47 [14:25:47.117] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:47 [14:25:47.290] VERBOSE: p2p:tx_pool Adding tx 0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60 to pool {"eventName":"tx-added-to-pool","txHash":"0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":151,"proofSize":172052,"size":322921,"feePaymentMethod":"fee_juice"} 14:25:47 [14:25:47.310] INFO: node Received tx 0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60 {"txHash":"0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60"} 14:25:47 [14:25:47.311] INFO: pxe:service Sent transaction 0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60 14:25:47 [14:25:47.318] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 14:25:47 [14:25:47.321] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:47 [14:25:47.334] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T14:30:39.000Z","now":"2025-06-18T14:30:41.554Z"} 14:25:47 [14:25:47.561] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:47 [14:25:47.621] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x35393df3 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x35393df3","duration":61.454649000001154} 14:25:47 [14:25:47.785] VERBOSE: simulator:public-processor Processed tx 0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60 with 1 public calls in 333.00558400000045ms {"txHash":"0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60","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":333.00558400000045} 14:25:47 [14:25:47.786] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:47 [14:25:47.788] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.4539628339999999s {"duration":0.4539628339999999,"rate":136134.49245494843,"totalPublicGas":{"daGas":3072,"l2Gas":61800},"totalBlockGas":{"daGas":91648,"l2Gas":98344},"totalSizeInBytes":6144} 14:25:47 [14:25:47.927] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 101465.79706932195 mana/s {"blockHash":"0x0c1c59c5c008a19acd8500e6b4c4674685a61e5fb91260a6130e3d627081136a","globalVariables":{"chainId":31337,"version":2713347771,"blockNumber":2,"slotNumber":3,"timestamp":1750257039,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x00aeb4540f5d86b54937603ad3a39495e893b904ede06af139743a0cdedb1a60"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":608.5214410000008,"publicProcessDuration":454.3232649999991,"rollupCircuitsDuration":594.9222600000012,"txCount":1,"blockNumber":2,"blockTimestamp":1750257039,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 14:25:47 [14:25:47.929] VERBOSE: sequencer Attesting committee is empty 14:25:48 [14:25:48.025] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:48 [14:25:48.212] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x343965a39b10dc20a07598df0586e4ac050f0153dc7366b056cbab54901fed09 14:25:48 [14:25:48.212] VERBOSE: sequencer-client Sent L1 transaction 0x343965a39b10dc20a07598df0586e4ac050f0153dc7366b056cbab54901fed09 {"gasLimit":470298,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:25:48 [14:25:48.224] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:25:48 [14:25:48.224] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x343965a39b10dc20a07598df0586e4ac050f0153dc7366b056cbab54901fed09","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":2,"blockTimestamp":1750257039,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 14:25:48 [14:25:48.224] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:25:48 [14:25:48.229] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:48 [14:25:48.235] INFO: blob-sink:server Received blob sidecar for block 0x7c4bb1a529da4ac9c9636108b8ecfdee3c1d2fa70550ae73d7a95be209d7f691 14:25:48 [14:25:48.245] INFO: blob-sink:server Blob sidecar stored successfully for block 0x7c4bb1a529da4ac9c9636108b8ecfdee3c1d2fa70550ae73d7a95be209d7f691 14:25:48 [14:25:48.246] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 14:25:48 [14:25:48.249] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 14:25:48 [14:25:48.252] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 14:25:48 [14:25:48.255] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257075] on http://127.0.0.1:8545 14:25:48 [14:25:48.256] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:25:48 [14:25:48.257] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257075 14:25:48 [14:25:48.258] WARN: foundation:test-date-provider Time set to 2025-06-18T14:31:15.000Z {"offset":326743,"timeMs":1750257075000} 14:25:48 [14:25:48.258] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 14:25:48 [14:25:48.434] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:48 [14:25:48.636] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:48 [14:25:48.880] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:48 [14:25:48.897] VERBOSE: archiver:block-helper Store contract instance at 0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544 14:25:48 [14:25:48.903] VERBOSE: archiver:block-helper Store contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 14:25:48 [14:25:48.918] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0c1c59c5c008a19acd8500e6b4c4674685a61e5fb91260a6130e3d627081136a","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2713347771,"blockNumber":2,"slotNumber":3,"timestamp":1750257039,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x185aefc4f87460850baa9d5b73c32b0d01961d1879de9b0cd4cc0aec9982d3e4","archiveNextLeafIndex":3} 14:25:48 [14:25:48.923] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 14:25:49 [14:25:49.000] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.3958330000004935,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750257039,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 14:25:49 [14:25:49.038] VERBOSE: p2p Synched to latest block 2 14:25:49 [14:25:49.085] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:49 [14:25:49.259] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x185aefc4f87460850baa9d5b73c32b0d01961d1879de9b0cd4cc0aec9982d3e4","blockNumber":3,"slot":4} 14:25:49 [14:25:49.288] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:49 [14:25:49.331] INFO: aztecjs:deploy_sent_tx Contract 0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544 successfully deployed. 14:25:49 [14:25:49.331] INFO: e2e:e2e_private_voting_contract Counter contract deployed at 0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544 14:25:49 [14:25:49.333] INFO: e2e:e2e_private_voting_contract Running test: e2e_voting_contract votes votes, then tries to vote again 14:25:49 [14:25:49.357] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x185aefc4f87460850baa9d5b73c32b0d01961d1879de9b0cd4cc0aec9982d3e4","header":{"contentCommitment":{"blobsHash":"0x001ca2ef765b25ae7dd32da9a2bd6c49b8d782070b8790392ba5bdf4423d59e9","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750257039,"version":2713347771},"lastArchive":"0x24a275a3b4794e8239921f4c97f7aefdbf4a37a972826ff2536b0e7d76e5966c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0e11d624cb64f87bbb493641f879158231dd8c5ae3e85a534cd6865baa61d0eb","nullifierTree":"0x26a0dfcc02372ba9da1f35fe1d8c84c978f62c431bea5017db72f86ca4d7c631","publicDataTree":"0x0dd55fbf76e091b677ad34938fb310997a8829590ba8efa70fbee0c024cf6dd2"},"totalFees":32675777440,"totalManaUsed":98344}} 14:25:49 [14:25:49.420] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:49 [14:25:49.455] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:25:49 [14:25:49.455] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:49 [14:25:49.495] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:49 [14:25:49.507] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:49 [14:25:49.512] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x27b34119766d6ed90eab3a6dba7ae710c363a224e4e9adde752ba183f2414002 14:25:49 [14:25:49.521] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:25:49 [14:25:49.522] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:25:49 [14:25:49.526] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:25:49 [14:25:49.527] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:25:49 [14:25:49.529] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1d96df8ed1a541a4e9ad35d57eb28fb6db0afa7afb1a39d3c92a3e16da4a2164","nullifier":"0x0c5c9d3e15448e9ee35b2712fd4b9572b369683a1a92ac41aa395f6349d2303f"} 14:25:49 [14:25:49.531] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:25:49 [14:25:49.542] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c as fee payer 14:25:49 [14:25:49.568] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544"} 14:25:49 [14:25:49.724] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:49 [14:25:49.908] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x185aefc4f87460850baa9d5b73c32b0d01961d1879de9b0cd4cc0aec9982d3e4","blockNumber":3,"slot":4} 14:25:50 [14:25:50.151] INFO: pxe:service Proving completed in 802.9266290000014ms {"timings":{"total":802.9266290000014,"sync":11.243730000000141,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":183.39451799999733,"oracles":{"debugLog":{"times":[0.44255599999996775,0.43358099999932165,0.3694359999990411,0.4913429999996879,0.4161390000008396,0.3476389999996172,0.3217819999990752,0.4457769999989978]},"fetchTaggedLogs":{"times":[54.462180000000444]},"loadCapsule":{"times":[0.20537399999921035,0.19433200000094075,0.32390599999962433,0.1911260000015318,0.15538999999989755,0.18923999999969965]},"getSharedSecret":{"times":[2.815827000000354]},"aes128Decrypt":{"times":[0.21285999999963678,0.805527999998958]},"getPublicKeysAndPartialAddress":{"times":[1.1988130000008823]},"getKeyValidationRequest":{"times":[1.4380270000001474]},"deliverNote":{"times":[2.496643000000404]},"deleteCapsule":{"times":[0.20596800000021176]},"storeCapsule":{"times":[0.23186100000020815]},"getNotes":{"times":[1.3051200000008976]},"getAuthWitness":{"times":[0.18298300000060408]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05739899999935005]},"callPrivateFunction":{"times":[46.15805999999975]}}},{"functionName":"private_kernel_init","time":54.12883300000067},{"functionName":"EasyPrivateVoting:cast_vote","time":37.554933000001256,"oracles":{"getPublicKeysAndPartialAddress":{"times":[4.902066999999079]},"getKeyValidationRequest":{"times":[2.824510000000373]},"notifyCreatedNullifier":{"times":[0.2138730000006035]},"storeInExecutionCache":{"times":[0.04849800000010873]},"notifyEnqueuedPublicFunctionCall":{"times":[0.060821999999461696]}}},{"functionName":"private_kernel_inner","time":107.11743899999965},{"functionName":"private_kernel_reset","time":167.8239080000003},{"functionName":"private_kernel_tail","time":79.99995599999966}],"unaccounted":161.6633120000024}} 14:25:50 [14:25:50.177] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:50 [14:25:50.219] VERBOSE: p2p:tx_pool Adding tx 0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889 to pool {"eventName":"tx-added-to-pool","txHash":"0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226313,"feePaymentMethod":"fee_juice"} 14:25:50 [14:25:50.226] INFO: node Received tx 0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889 {"txHash":"0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889"} 14:25:50 [14:25:50.226] INFO: pxe:service Sent transaction 0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889 14:25:50 [14:25:50.382] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:50 [14:25:50.424] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 14:25:50 [14:25:50.437] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T14:31:15.000Z","now":"2025-06-18T14:31:17.180Z"} 14:25:50 [14:25:50.477] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5f06617e completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5f06617e","duration":23.205474000000322} 14:25:50 [14:25:50.493] VERBOSE: simulator:public-processor Processed tx 0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889 with 1 public calls in 46.26781300000039ms {"txHash":"0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889","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":46.26781300000039} 14:25:50 [14:25:50.494] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.056222177999999984s {"duration":0.056222177999999984,"rate":422466.73545802524,"totalPublicGas":{"daGas":512,"l2Gas":23752},"totalBlockGas":{"daGas":2048,"l2Gas":54952},"totalSizeInBytes":352} 14:25:50 [14:25:50.600] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:50 [14:25:50.613] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 125399.67251953755 mana/s {"blockHash":"0x04b969e8b0bf01ea684170554800006696ea5a4dfcc74d92be6a6733c414e03b","globalVariables":{"chainId":31337,"version":2713347771,"blockNumber":3,"slotNumber":4,"timestamp":1750257075,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x08607a136c695fbddd6b758440a59cadbd71f4797f00e79fce8600326bb2b889"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":188.85324799999944,"publicProcessDuration":56.50037399999928,"rollupCircuitsDuration":176.1123639999987,"txCount":1,"blockNumber":3,"blockTimestamp":1750257075,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:25:50 [14:25:50.615] VERBOSE: sequencer Attesting committee is empty 14:25:50 [14:25:50.866] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:50 [14:25:50.874] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x7e7e2c0fb4afcae620918b7cb1661ed2dc665c3bb7d833dacba4936a5c638685 14:25:50 [14:25:50.875] VERBOSE: sequencer-client Sent L1 transaction 0x7e7e2c0fb4afcae620918b7cb1661ed2dc665c3bb7d833dacba4936a5c638685 {"gasLimit":470254,"maxFeePerGas":"1.279583418","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:25:50 [14:25:50.882] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257111] on http://127.0.0.1:8545 14:25:50 [14:25:50.885] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:25:50 [14:25:50.887] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:25:50 [14:25:50.888] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x7e7e2c0fb4afcae620918b7cb1661ed2dc665c3bb7d833dacba4936a5c638685","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":3,"blockTimestamp":1750257075,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:25:50 [14:25:50.888] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:25:50 [14:25:50.890] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257111 14:25:50 [14:25:50.890] WARN: foundation:test-date-provider Time set to 2025-06-18T14:31:51.000Z {"offset":360110,"timeMs":1750257111000} 14:25:50 [14:25:50.890] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 14:25:50 [14:25:50.891] INFO: blob-sink:server Received blob sidecar for block 0xf778c9ad9f4cb43200eb59f7bae71cfd7a2d98e86a7bda2da9939c7fd695a936 14:25:50 [14:25:50.895] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf778c9ad9f4cb43200eb59f7bae71cfd7a2d98e86a7bda2da9939c7fd695a936 14:25:51 [14:25:51.070] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:51 [14:25:51.074] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 14:25:51 [14:25:51.075] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 14:25:51 [14:25:51.081] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 14:25:51 [14:25:51.274] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:51 [14:25:51.382] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x04b969e8b0bf01ea684170554800006696ea5a4dfcc74d92be6a6733c414e03b","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2713347771,"blockNumber":3,"slotNumber":4,"timestamp":1750257075,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1ac7121205f8243dabb7ead0e2f8489a00051f433eb28db9a9bec2147314441a","archiveNextLeafIndex":4} 14:25:51 [14:25:51.386] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 14:25:51 [14:25:51.484] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":6.397876999999426,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750257075,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:25:51 [14:25:51.494] VERBOSE: p2p Synched to latest block 3 14:25:51 [14:25:51.571] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:51 [14:25:51.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:51 [14:25:51.911] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1ac7121205f8243dabb7ead0e2f8489a00051f433eb28db9a9bec2147314441a","blockNumber":4,"slot":5} 14:25:51 [14:25:51.973] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:52 [14:25:52.175] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:52 [14:25:52.235] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x1ac7121205f8243dabb7ead0e2f8489a00051f433eb28db9a9bec2147314441a","header":{"contentCommitment":{"blobsHash":"0x0057d3a5ea7ddd0c0997f69db0cc84c319b9fe57eb7395f227a87604a93930c8","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750257075,"version":2713347771},"lastArchive":"0x185aefc4f87460850baa9d5b73c32b0d01961d1879de9b0cd4cc0aec9982d3e4","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0e11d624cb64f87bbb493641f879158231dd8c5ae3e85a534cd6865baa61d0eb","nullifierTree":"0x1ae6687e3c3a71ae4330c2eeda1c0488462f6b98376e838c732e3800577053fc","publicDataTree":"0x026571fbf97dd7d14614deb11a32fb3c70b6a980c7d4ec37bd4608d785fe500a"},"totalFees":18258351520,"totalManaUsed":54952}} 14:25:52 [14:25:52.255] VERBOSE: simulator Executing utility function get_vote {"contract":"0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544","selector":"0x50ac913f"} 14:25:52 [14:25:52.262] VERBOSE: simulator Utility simulation for 0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544.0x50ac913f completed 14:25:52 [14:25:52.275] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c {"origin":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000a1ba66bb","authWitnesses":["0x2a2f5b43de55afb66cd230ff40a34cd5aff03c0cc6cf30aeee1efd92270d42e6"]} 14:25:52 [14:25:52.340] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:52 [14:25:52.372] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:25:52 [14:25:52.372] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:52 [14:25:52.377] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:52 [14:25:52.430] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:52 [14:25:52.441] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1ac7121205f8243dabb7ead0e2f8489a00051f433eb28db9a9bec2147314441a","blockNumber":4,"slot":5} 14:25:52 [14:25:52.443] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x27b34119766d6ed90eab3a6dba7ae710c363a224e4e9adde752ba183f2414002 14:25:52 [14:25:52.452] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:25:52 [14:25:52.453] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:25:52 [14:25:52.458] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:25:52 [14:25:52.458] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:25:52 [14:25:52.461] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1d96df8ed1a541a4e9ad35d57eb28fb6db0afa7afb1a39d3c92a3e16da4a2164","nullifier":"0x0c5c9d3e15448e9ee35b2712fd4b9572b369683a1a92ac41aa395f6349d2303f"} 14:25:52 [14:25:52.463] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:25:52 [14:25:52.474] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c as fee payer 14:25:52 [14:25:52.497] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544"} 14:25:52 [14:25:52.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:53 [14:25:53.081] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:53 [14:25:53.110] VERBOSE: node Simulating public calls for tx 0x2deb1f00f0559584eaa973d8c8ac8c5cc72b2846c08f92d9e7929c32e80e593b {"globalVariables":{"chainId":31337,"version":2713347771,"blockNumber":4,"slotNumber":5,"timestamp":1750257111,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHash":"0x2deb1f00f0559584eaa973d8c8ac8c5cc72b2846c08f92d9e7929c32e80e593b","blockNumber":4} 14:25:53 [14:25:53.115] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1ac7121205f8243dabb7ead0e2f8489a00051f433eb28db9a9bec2147314441a","blockNumber":4,"slot":5} 14:25:53 [14:25:53.127] VERBOSE: simulator:state_manager Siloed nullifier 0x1c80f3b11d7c19af6a77de9724fef9efd8b04a7f17ad50f78702f20998d229d4 already present in tree! 14:25:53 [14:25:53.130] WARN: simulator:public_tx_context APP_LOGIC phase reverted! insertRevertiblesFromPrivate failed with reason: Nullifier collision encountered when inserting revertible nullifiers from private 14:25:53 Details: Siloed nullifier 0x1c80f3b11d7c19af6a77de9724fef9efd8b04a7f17ad50f78702f20998d229d4 already exists in parent cache or host. 14:25:53 Error stack: NullifierCollisionError: Siloed nullifier 0x1c80f3b11d7c19af6a77de9724fef9efd8b04a7f17ad50f78702f20998d229d4 already exists in parent cache or host. 14:25:53 at PublicPersistableStateManager.writeSiloedNullifier (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/state_manager/state_manager.js:190:23) 14:25:53 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:263:17) 14:25:53 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:33:24) 14:25:53 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:54:29) 14:25:53 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:14:25) 14:25:53 at PublicProcessor.processTxWithPublicCalls (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:321:91) 14:25:53 at PublicProcessor.processTxWithinDeadline (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:268:20) 14:25:53 at elapsed (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/timer/elapsed.js:8:20) 14:25:53 at PublicProcessor.processTx (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:221:53) 14:25:53 at PublicProcessor.process (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:159:53) 14:25:53 at AztecNodeService.simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:718:66) 14:25:53 at PXEService.#simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:241:28) 14:25:53 at /home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:580:36 14:25:53 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 14:25:53 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 14:25:53 [14:25:53.147] VERBOSE: simulator:public-processor Processed tx 0x2deb1f00f0559584eaa973d8c8ac8c5cc72b2846c08f92d9e7929c32e80e593b with 1 public calls in 24.708944000001793ms {"txHash":"0x2deb1f00f0559584eaa973d8c8ac8c5cc72b2846c08f92d9e7929c32e80e593b","txFee":1581840000,"revertCode":1,"revertReason":{"originalMessage":"Nullifier collision encountered when inserting revertible nullifiers from private\nDetails: Siloed nullifier 0x1c80f3b11d7c19af6a77de9724fef9efd8b04a7f17ad50f78702f20998d229d4 already exists in parent cache or host.\nError stack: NullifierCollisionError: Siloed nullifier 0x1c80f3b11d7c19af6a77de9724fef9efd8b04a7f17ad50f78702f20998d229d4 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":24.708944000001793} 14:25:53 [14:25:53.148] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03117837899999722s {"duration":0.03117837899999722,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":31200},"totalSizeInBytes":256} 14:25:53 [14:25:53.149] ERROR: pxe:service Failed to enrich public simulation error: TypeError: Cannot read properties of undefined (reading 'contractAddress') 14:25:53 [14:25:53.223] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:53 [14:25:53.256] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:25:53 [14:25:53.256] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:53 [14:25:53.291] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:53 [14:25:53.294] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c"} 14:25:53 [14:25:53.299] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x27b34119766d6ed90eab3a6dba7ae710c363a224e4e9adde752ba183f2414002 14:25:53 [14:25:53.308] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:25:53 [14:25:53.308] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:25:53 [14:25:53.319] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:25:53 [14:25:53.320] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:25:53 [14:25:53.323] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1d96df8ed1a541a4e9ad35d57eb28fb6db0afa7afb1a39d3c92a3e16da4a2164","nullifier":"0x0c5c9d3e15448e9ee35b2712fd4b9572b369683a1a92ac41aa395f6349d2303f"} 14:25:53 [14:25:53.324] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:25:53 [14:25:53.338] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1159aba6f26793577369ed7db9dbf5b15243b2befe80e335fbb36d90bb5c0f8c as fee payer 14:25:53 [14:25:53.357] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x2023163f1168f8e33d99230ae8e7008360d487bb4ff904c1b1f7ab8b73e38544"} 14:25:53 [14:25:53.511] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:53 [14:25:53.923] INFO: pxe:service Proving completed in 762.6099130000002ms {"timings":{"total":762.6099130000002,"sync":2.488578000000416,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":174.6809719999983,"oracles":{"debugLog":{"times":[0.434146999999939,0.38531200000215904,0.3862619999999879,0.462799000000814,0.4352039999976114,0.4447890000010375,0.3345919999992475,0.44123899999976857]},"fetchTaggedLogs":{"times":[41.296589000001404]},"loadCapsule":{"times":[0.1732460000021092,0.14719399999739835,0.33237799999915296,0.179004999998142,0.23854500000015832,0.1930739999988873]},"getSharedSecret":{"times":[2.54122500000085]},"aes128Decrypt":{"times":[0.20350600000165286,0.7900389999995241]},"getPublicKeysAndPartialAddress":{"times":[2.4845900000000256]},"getKeyValidationRequest":{"times":[5.801239000000351]},"deliverNote":{"times":[3.09169699999984]},"deleteCapsule":{"times":[0.21565499999996973]},"storeCapsule":{"times":[0.20102100000076462]},"getNotes":{"times":[2.9515339999998105]},"getAuthWitness":{"times":[0.18949099999736063]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05622600000060629]},"callPrivateFunction":{"times":[35.760301999998774]}}},{"functionName":"private_kernel_init","time":53.680490000002465},{"functionName":"EasyPrivateVoting:cast_vote","time":27.38123099999939,"oracles":{"getPublicKeysAndPartialAddress":{"times":[2.774677999997948]},"getKeyValidationRequest":{"times":[1.2059439999975439]},"notifyCreatedNullifier":{"times":[0.19206900000062888]},"storeInExecutionCache":{"times":[0.04101699999955599]},"notifyEnqueuedPublicFunctionCall":{"times":[0.047625999999581836]}}},{"functionName":"private_kernel_inner","time":106.94742799999949},{"functionName":"private_kernel_reset","time":177.2685760000022},{"functionName":"private_kernel_tail","time":79.91775400000188}],"unaccounted":140.2448839999961}} 14:25:53 [14:25:53.952] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:25:53 [14:25:53.966] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1ac7121205f8243dabb7ead0e2f8489a00051f433eb28db9a9bec2147314441a","blockNumber":4,"slot":5} 14:25:53 [14:25:53.974] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x2b63f2137b92b45d74639faf5296c00ee6adeddd628934b341c22665cbfb76e7 for repeating a nullifier 14:25:53 [14:25:53.977] WARN: node Received invalid tx 0x2b63f2137b92b45d74639faf5296c00ee6adeddd628934b341c22665cbfb76e7: Existing nullifier {"txHash":"0x2b63f2137b92b45d74639faf5296c00ee6adeddd628934b341c22665cbfb76e7"} 14:25:53 [14:25:53.980] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 14:25:53 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 14:25:53 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 14:25:53 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 14:25:53 [14:25:53.982] INFO: node Stopping 14:25:53 [14:25:53.983] INFO: slasher Slasher client stopped. 14:25:53 [14:25:53.983] INFO: sequencer Stopped sequencer 14:25:53 [14:25:53.983] INFO: p2p P2P client stopped. 14:25:53 [14:25:53.984] INFO: world_state Stopped world state synchronizer 14:25:53 [14:25:53.984] INFO: archiver Stopped. 14:25:53 [14:25:53.985] INFO: node Stopped 14:25:53 [14:25:53.985] VERBOSE: e2e:e2e_private_voting_contract Cleaning up ACVM state 14:25:53 [14:25:53.985] INFO: e2e:e2e_private_voting_contract Cleaning up ACVM temp directory /tmp/c3c73891 14:25:53 [14:25:53.985] VERBOSE: e2e:e2e_private_voting_contract Cleaning up BB state 14:25:53 [14:25:53.993] INFO: blob-sink:server Stopping blob sink 14:25:53 [14:25:53.994] INFO: blob-sink:server Blob sink stopped 14:25:53 [14:25:53.994] VERBOSE: e2e:e2e_private_voting_contract Cleaning up data directory at /tmp/ea972afb7ae08094 14:25:53 PASS src/e2e_private_voting_contract.test.ts 14:25:53 e2e_voting_contract 14:25:53 votes 14:25:53 ✓ votes, then tries to vote again (4648 ms) 14:25:53 14:25:54 Test Suites: 1 passed, 1 total 14:25:54 Tests: 1 passed, 1 total 14:25:54 Snapshots: 0 total 14:25:54 Time: 18.868 s 14:25:54 Ran all test suites matching /src\/e2e_private_voting_contract.test.ts/i. 14:25:54 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?