ACI ·

Parent Log: http://ci.aztec-labs.com/ad41d2c01b79593b Command: 21081b81c02e2d2a: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/c06f30929f18b85bcea93c0926a8d640a3819f00 Env: REF_NAME=gh-readonly-queue/master/pr-15074-2707ec99de02004f3e30e7af0810e0d741ab9794 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Mon Jun 16 16:19:51 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15074_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_f9aac7f8d569bb18_master 16:19:51 +++ id -u 16:19:51 +++ id -g 16:19:51 ++ docker run -d --name e2e_private_voting_contract --net=none --cpuset-cpus=0-127 --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'\''' 16:19:51 + cid=a5864c2230b49bba4d801fea67dfe66460f7d34ef1083fa1039a782630f0c0e8 16:19:51 + set +x 16:19:52 {"level":25,"time":1750090792207,"pid":12,"hostname":"a5864c2230b4","module":"logger","msg":"Logger initialized with level verbose"} 16:19:57 [16:19:57.854] INFO: e2e:e2e_private_voting_contract Logging metrics to log/unknown.jsonl 16:19:58 [16:19:58.071] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-WGCNJk/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 16:19:58 [16:19:58.105] INFO: e2e:e2e_private_voting_contract Calling anvil_setBlockTimestampInterval with params: [12] 16:19:58 [16:19:58.127] WARN: e2e:e2e_private_voting_contract Set block interval to 12 16:19:58 [16:19:58.128] VERBOSE: e2e:e2e_private_voting_contract Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:19:58 [16:19:58.171] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 16:19:58 [16:19:58.181] VERBOSE: e2e:e2e_private_voting_contract Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 16:19:58 [16:19:58.200] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 16:19:58 [16:19:58.205] VERBOSE: e2e:e2e_private_voting_contract Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 16:19:58 [16:19:58.221] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 16:19:58 [16:19:58.226] VERBOSE: e2e:e2e_private_voting_contract Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 16:19:58 [16:19:58.251] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 16:19:58 [16:19:58.257] VERBOSE: e2e:e2e_private_voting_contract Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 16:19:58 [16:19:58.273] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 16:19:58 [16:19:58.277] VERBOSE: e2e:e2e_private_voting_contract Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 16:19:58 [16:19:58.289] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 16:19:58 [16:19:58.293] VERBOSE: e2e:e2e_private_voting_contract Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 16:19:58 [16:19:58.294] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 16:19:58 [16:19:58.295] INFO: e2e:e2e_private_voting_contract Waiting for 6 transactions to be mined... 16:19:58 [16:19:58.312] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 16:19:58 [16:19:58.329] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 16:19:58 [16:19:58.329] VERBOSE: e2e:e2e_private_voting_contract Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 16:19:58 [16:19:58.339] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 16:19:58 [16:19:58.350] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 16:19:58 [16:19:58.359] VERBOSE: e2e:e2e_private_voting_contract Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 16:19:58 [16:19:58.372] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 16:19:58 [16:19:58.373] VERBOSE: e2e:e2e_private_voting_contract Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 16:19:58 [16:19:58.391] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 16:19:58 [16:19:58.396] VERBOSE: e2e:e2e_private_voting_contract Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 16:19:58 [16:19:58.409] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 16:19:58 [16:19:58.410] VERBOSE: e2e:e2e_private_voting_contract Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 16:19:58 [16:19:58.410] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 16:19:58 [16:19:58.410] INFO: e2e:e2e_private_voting_contract Waiting for 8 transactions to be mined... 16:19:58 [16:19:58.431] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 16:19:58 [16:19:58.439] VERBOSE: e2e:e2e_private_voting_contract Deployed shared contracts 16:19:58 [16:19:58.454] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 16:19:58 [16:19:58.454] VERBOSE: e2e:e2e_private_voting_contract Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 16:19:58 [16:19:58.457] 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} 16:19:58 [16:19:58.472] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 16:19:58 [16:19:58.496] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 16:19:58 [16:19:58.502] VERBOSE: e2e:e2e_private_voting_contract Awaiting for linked libraries to be deployed 16:19:58 [16:19:58.542] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xd22211d2605598c124707072dd9dbce64b116d3a76ec8437ca5b807deeef9f81 {"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 16:19:58 [16:19:58.547] 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} 16:19:58 [16:19:58.547] INFO: e2e:e2e_private_voting_contract Waiting for 9 transactions to be mined... 16:19:58 [16:19:58.566] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 16:19:58 [16:19:58.566] VERBOSE: e2e:e2e_private_voting_contract All core contracts have been deployed 16:19:58 [16:19:58.583] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 16:19:58 [16:19:58.583] VERBOSE: e2e:e2e_private_voting_contract Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 16:19:58 [16:19:58.597] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a {"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"} 16:19:58 [16:19:58.602] VERBOSE: e2e:e2e_private_voting_contract Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 16:19:58 [16:19:58.629] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 {"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"} 16:19:58 [16:19:58.630] VERBOSE: e2e:e2e_private_voting_contract Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 16:19:58 [16:19:58.630] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 16:19:58 [16:19:58.654] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 16:19:58 [16:19:58.661] VERBOSE: e2e:e2e_private_voting_contract Rollup deployed 16:19:58 [16:19:58.662] VERBOSE: e2e:e2e_private_voting_contract Waiting for rollup and slash factory to be deployed 16:19:58 [16:19:58.662] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 16:19:58 [16:19:58.695] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 16:19:58 [16:19:58.695] VERBOSE: e2e:e2e_private_voting_contract All transactions for L1 deployment have been mined 16:19:58 [16:19:58.710] 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"} 16:19:58 [16:19:58.713] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 16:19:58 [16:19:58.715] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:58 [16:19:58.717] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 16:19:58 [16:19:58.719] INFO: telemetry:client Using NoopTelemetryClient 16:19:58 [16:19:58.727] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 16:19:58 [16:19:58.727] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 16:19:58 [16:19:58.729] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/730881cfea302c29/blob-sink with map size 134217728 KB (LMDB v2) 16:19:58 [16:19:58.732] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:58 [16:19:58.736] INFO: aztecjs:utils:watcher New L1 time: 1750091037 16:19:58 [16:19:58.737] WARN: foundation:test-date-provider Time set to 2025-06-16T16:23:57.000Z {"offset":238264,"timeMs":1750091037000} 16:19:58 [16:19:58.739] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 16:19:58 [16:19:58.748] INFO: blob-sink:server Server is running on http://localhost:43767 16:19:58 [16:19:58.748] VERBOSE: e2e:e2e_private_voting_contract Creating and synching an aztec node... 16:19:58 [16:19:58.749] VERBOSE: e2e:e2e_private_voting_contract Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/8c6b444b/acvm 16:19:58 [16:19:58.750] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:43767"} 16:19:58 [16:19:58.764] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 16:19:58 [16:19:58.765] INFO: archiver:lmdb Creating archiver data store at directory /tmp/730881cfea302c29/archiver with map size 134217728 KB (LMDB v2) 16:19:58 [16:19:58.766] INFO: archiver:lmdb Starting data store with maxReaders 16 16:19:58 [16:19:58.997] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.115] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:43767"} 16:19:59 [16:19:59.138] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:43767"} 16:19:59 [16:19:59.138] WARN: node:blob-sink:client No L1 consensus host urls configured 16:19:59 [16:19:59.138] WARN: node:blob-sink:client No archive client configured 16:19:59 [16:19:59.142] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xf76f02362083573b334436c094360784d0872eab9d53b1bdc1be721e2c313a50 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x35a1f6f017733cb300432b961e024af6860281d164845a3735e4d31849667fad","l1BlockNumber":16}} 16:19:59 [16:19:59.159] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xf76f02362083573b334436c094360784d0872eab9d53b1bdc1be721e2c313a50","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 16:19:59 [16:19:59.167] INFO: world-state:database Creating world state data store at directory /tmp/730881cfea302c29/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 16:19:59 [16:19:59.196] INFO: world_state Created world state synchroniser with block history of 64 16:19:59 [16:19:59.197] WARN: node Aztec node is accepting fake proofs 16:19:59 [16:19:59.205] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.213] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/730881cfea302c29/p2p with map size 134217728 KB (LMDB v2) 16:19:59 [16:19:59.215] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 16:19:59 [16:19:59.217] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/730881cfea302c29/p2p-archive with map size 134217728 KB (LMDB v2) 16:19:59 [16:19:59.218] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 16:19:59 [16:19:59.220] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/730881cfea302c29/p2p-peers with map size 134217728 KB (LMDB v2) 16:19:59 [16:19:59.221] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 16:19:59 [16:19:59.223] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 16:19:59 [16:19:59.224] VERBOSE: p2p P2P is disabled. Using dummy P2P service 16:19:59 [16:19:59.228] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 16:19:59 [16:19:59.229] INFO: world_state Started world state synchronizer from block 1 16:19:59 [16:19:59.232] VERBOSE: world-state:block_stream Starting sync from block number 0 16:19:59 [16:19:59.238] INFO: p2p Starting p2p client from block 0 with empty mempools 16:19:59 [16:19:59.238] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 16:19:59 [16:19:59.239] INFO: slasher Slasher client initialized 16:19:59 [16:19:59.239] INFO: slasher Starting Slasher client... 16:19:59 [16:19:59.283] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:19:59 [16:19:59.285] VERBOSE: node All Aztec Node subsystems synced 16:19:59 [16:19:59.309] INFO: sequencer-client Deploying forwarder contract 16:19:59 [16:19:59.316] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 16:19:59 [16:19:59.330] VERBOSE: sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968 {"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"} 16:19:59 [16:19:59.331] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968. 16:19:59 [16:19:59.337] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:19:59 [16:19:59.356] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:19:59 [16:19:59.357] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 16:19:59 [16:19:59.357] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/8c6b444b/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 16:19:59 [16:19:59.574] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 16:19:59 [16:19:59.576] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:19:59 [16:19:59.577] INFO: node Aztec Node version: 0.87.8 16:19:59 [16:19:59.578] 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"} 16:19:59 [16:19:59.579] VERBOSE: e2e:e2e_private_voting_contract Creating a pxe... 16:19:59 [16:19:59.585] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.593] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/40af7b8cc99a55e1/pxe_data with map size 134217728 KB (LMDB v2) 16:19:59 [16:19:59.602] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:19:59 [16:19:59.605] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0068d58d42a1f9f99ccfe02d0122f285ae50f2fd207bc70b92473f2c219f8829","blockNumber":1,"slot":2} 16:19:59 [16:19:59.801] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.867] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 16:19:59 [16:19:59.868] INFO: pxe:service Started PXE connected to chain 31337 version 426324814 16:19:59 [16:19:59.919] INFO: pxe:service Registered account 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf 16:19:59 [16:19:59.979] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 16:19:59 [16:19:59.980] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf 16:20:00 [16:20:00.006] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:00 [16:20:00.102] INFO: pxe:service Added contract SchnorrAccount at 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:20:00 [16:20:00.163] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0068d58d42a1f9f99ccfe02d0122f285ae50f2fd207bc70b92473f2c219f8829","blockNumber":1,"slot":2} 16:20:00 [16:20:00.164] VERBOSE: pxe:block_stream Starting sync from block number 0 16:20:00 [16:20:00.194] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 16:20:00 [16:20:00.252] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:00 [16:20:00.310] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:20:01 [16:20:01.049] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 16:20:01 [16:20:01.154] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:20:01 [16:20:01.225] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:01 [16:20:01.250] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0068d58d42a1f9f99ccfe02d0122f285ae50f2fd207bc70b92473f2c219f8829","blockNumber":1,"slot":2} 16:20:01 [16:20:01.327] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:01 [16:20:01.369] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:20:01 [16:20:01.370] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:01 [16:20:01.429] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:01 [16:20:01.431] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:01 [16:20:01.434] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:20:01 [16:20:01.602] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:01 [16:20:01.645] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:20:01 [16:20:01.646] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:01 [16:20:01.647] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:01 [16:20:01.684] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:01 [16:20:01.699] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:20:01 [16:20:01.717] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf as fee payer 16:20:01 [16:20:01.791] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0068d58d42a1f9f99ccfe02d0122f285ae50f2fd207bc70b92473f2c219f8829","blockNumber":1,"slot":2} 16:20:01 [16:20:01.923] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:02 [16:20:02.159] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:02 [16:20:02.402] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:02 [16:20:02.517] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0068d58d42a1f9f99ccfe02d0122f285ae50f2fd207bc70b92473f2c219f8829","blockNumber":1,"slot":2} 16:20:02 [16:20:02.866] INFO: pxe:service Proving completed in 2714.9942539999993ms {"timings":{"total":2714.9942539999993,"sync":13.711208000000624,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":164.73814900000252,"oracles":{"callPrivateFunction":{"times":[967.4401269999998,307.38964599999963,203.91605900000104]}}},{"functionName":"private_kernel_init","time":116.4697240000005},{"functionName":"ContractClassRegisterer:register","time":948.348919,"oracles":{"loadCapsule":{"times":[55.067517999999836]},"notifyCreatedNullifier":{"times":[0.807795000000624]},"debugLog":{"times":[0.8286559999996825]},"notifyCreatedContractClassLog":{"times":[9.937411999999313]}}},{"functionName":"private_kernel_inner","time":126.33784399999968},{"functionName":"SchnorrAccount:constructor","time":279.18089099999816,"oracles":{"getContractInstance":{"times":[3.052325999999084]},"debugLog":{"times":[0.8213360000008834,0.3695420000003651]},"fetchTaggedLogs":{"times":[61.503280000000814]},"loadCapsule":{"times":[1.4174249999996391,0.8735880000003817,1.0045420000005834]},"notifyCreatedNullifier":{"times":[0.1836459999994986,0.2363679999998567]},"notifyCreatedNote":{"times":[0.42249400000036985]},"getRandomField":{"times":[0.3688609999990149,0.22128700000030221,0.14359399999921152,0.05776200000036624,0.06474200000047858,0.047311999998782994,0.043551999999181135,0.058342000000266125,0.056510999998863554,0.07673299999987648,0.05704200000036508]},"getIndexedTaggingSecretAsSender":{"times":[36.47177399999964]},"incrementAppTaggingSecretIndexAsSender":{"times":[23.508458000000246]}}},{"functionName":"private_kernel_inner","time":151.9666789999992},{"functionName":"SchnorrAccount:entrypoint","time":171.598704,"oracles":{"debugLog":{"times":[0.7729140000010375,1.6453919999985374,0.8594470000007277]},"fetchTaggedLogs":{"times":[40.29127400000107]},"loadCapsule":{"times":[0.23913700000048266,2.1886690000010276,0.4834449999998469]},"getNotes":{"times":[2.969483000000764]},"getAuthWitness":{"times":[0.4414440000000468]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.834498000000167]}}},{"functionName":"private_kernel_inner","time":118.1069660000012},{"functionName":"private_kernel_reset","time":160.03316200000154},{"functionName":"private_kernel_tail","time":62.259313000000475}],"unaccounted":402.24269499999536}} 16:20:02 [16:20:02.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:02 [16:20:02.996] VERBOSE: p2p:tx_pool Adding tx 0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267 to pool {"eventName":"tx-added-to-pool","txHash":"0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 16:20:03 [16:20:03.014] INFO: node Received tx 0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267 {"txHash":"0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267"} 16:20:03 [16:20:03.015] INFO: pxe:service Sent transaction 0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267 16:20:03 [16:20:03.036] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 16:20:03 [16:20:03.050] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-16T16:24:21.000Z","now":"2025-06-16T16:24:01.314Z"} 16:20:03 [16:20:03.110] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:03 [16:20:03.288] VERBOSE: simulator:public-processor Processed tx 0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267 with no public calls in 166.0336700000007ms {"txHash":"0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267","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":166.0336700000007} 16:20:03 [16:20:03.291] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2381378020000011s {"duration":0.2381378020000011,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 16:20:03 [16:20:03.314] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:03 [16:20:03.443] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1a3369d7086b2e4580f0d3176580418b0df0d7e7d98a75a5cd5ba3b6637638ab","globalVariables":{"chainId":31337,"version":426324814,"blockNumber":1,"slotNumber":2,"timestamp":1750091061,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x099c1f9791ea422cdca0c25b14c455352470dbee9f7b60b4e5c92b1c615c4267"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":407.90656000000126,"publicProcessDuration":239.09221199999956,"rollupCircuitsDuration":394.42109699999855,"txCount":1,"blockNumber":1,"blockTimestamp":1750091061,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:20:03 [16:20:03.446] VERBOSE: sequencer Attesting committee is empty 16:20:03 [16:20:03.559] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:03 [16:20:03.797] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:03 [16:20:03.803] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xe1dc0b61594b813ef7a3e4881dd3225e052637889ae7d4af6ac2cd23e33ca75f 16:20:03 [16:20:03.803] VERBOSE: sequencer-client Sent L1 transaction 0xe1dc0b61594b813ef7a3e4881dd3225e052637889ae7d4af6ac2cd23e33ca75f {"gasLimit":514509,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 16:20:03 [16:20:03.820] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:20:03 [16:20:03.821] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xe1dc0b61594b813ef7a3e4881dd3225e052637889ae7d4af6ac2cd23e33ca75f","calldataSize":1444,"calldataGas":12244,"txCount":1,"blockNumber":1,"blockTimestamp":1750091061,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:20:03 [16:20:03.821] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:20:03 [16:20:03.838] INFO: blob-sink:server Received blob sidecar for block 0x3e88776a4eff2f288c41a42e8ac5adee1866727765c47c33e22c13e26563340b 16:20:03 [16:20:03.844] INFO: blob-sink:server Blob sidecar stored successfully for block 0x3e88776a4eff2f288c41a42e8ac5adee1866727765c47c33e22c13e26563340b 16:20:03 [16:20:03.858] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750091097] on http://127.0.0.1:8545 16:20:03 [16:20:03.861] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:20:03 [16:20:03.862] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750091097 16:20:03 [16:20:03.863] WARN: foundation:test-date-provider Time set to 2025-06-16T16:24:57.000Z {"offset":293137,"timeMs":1750091097000} 16:20:03 [16:20:03.863] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 16:20:03 [16:20:03.999] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:04 [16:20:04.007] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 16:20:04 [16:20:04.009] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 16:20:04 [16:20:04.010] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 16:20:04 [16:20:04.217] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:04 [16:20:04.237] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:20:04 [16:20:04.248] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1a3369d7086b2e4580f0d3176580418b0df0d7e7d98a75a5cd5ba3b6637638ab","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":426324814,"blockNumber":1,"slotNumber":2,"timestamp":1750091061,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x24ca53c098e6eefbb510101c3fd1fea9af8b339a0890ae81a5508f0c683c6031","archiveNextLeafIndex":2} 16:20:04 [16:20:04.256] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 16:20:04 [16:20:04.374] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":40.59756300000117,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750091061,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:20:04 [16:20:04.376] WARN: pxe:service No artifact found for contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 when looking for its metadata 16:20:04 [16:20:04.376] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 as part of deployment for 0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72 16:20:04 [16:20:04.469] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:04 [16:20:04.478] VERBOSE: p2p Synched to latest block 1 16:20:04 [16:20:04.539] INFO: pxe:service Added contract EasyPrivateVoting at 0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72 with class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 16:20:04 [16:20:04.565] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x24ca53c098e6eefbb510101c3fd1fea9af8b339a0890ae81a5508f0c683c6031","header":{"contentCommitment":{"blobsHash":"0x0054cef2f14d0cb130319892b4b5e80027ddcee35cb1e63242b60848a9014c3c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750091061,"version":426324814},"lastArchive":"0x0068d58d42a1f9f99ccfe02d0122f285ae50f2fd207bc70b92473f2c219f8829","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1adeaf42e31f6f36a264a86f379b71f7d65e6fbb0f754784b4c84977faa1f4d5","nullifierTree":"0x204ed3a778c45121edc322b60d06db9b2c3dbc7f284f24db51804d986f7d054c","publicDataTree":"0x00ee72e0f0f933995fa44c47ad33986965fd475dfe1b00e88f16447fb1e66312"},"totalFees":6794052480,"totalManaUsed":20448}} 16:20:04 [16:20:04.660] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:04 [16:20:04.709] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:20:04 [16:20:04.710] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:04 [16:20:04.710] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:04 [16:20:04.775] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:04 [16:20:04.784] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x12132380402a409bfdbd21273e7a0754abb71ddf143d4fef7854b063663928fb 16:20:04 [16:20:04.798] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:20:04 [16:20:04.798] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:20:04 [16:20:04.805] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:20:04 [16:20:04.806] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:20:04 [16:20:04.811] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e877e506b7e6700a7d036b3cb62573ec2336cac2813a0de548c93a7301f1139","nullifier":"0x1b71a886820718a3065d2521a1e1113b83b4a121c05624baf73dbbcd6d6b3fd9"} 16:20:04 [16:20:04.813] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:20:04 [16:20:04.832] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf as fee payer 16:20:04 [16:20:04.885] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:20:05 [16:20:05.318] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x07c93431ee7228896e85ee48c35d1e5b5d747283021244321f1e2360b29dc702,0x0eb6620c85cc03233af00abd8ad2f32e9528f320b09af98beb73808818ac20da,0x13d6566bc501e38ffb391e30ee7b29055b9227558ad14198c97fbf4c5f80e599 16:20:05 [16:20:05.428] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:20:05 [16:20:05.492] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:05 [16:20:05.501] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24ca53c098e6eefbb510101c3fd1fea9af8b339a0890ae81a5508f0c683c6031","blockNumber":2,"slot":3} 16:20:05 [16:20:05.546] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:20:05 [16:20:05.588] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:20:05 [16:20:05.598] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72,0x0000000000000000000000000000000000000000000000000000000000000001,0x1440bdeca17a502fb499b90b15afc47cd066cbda1f5bea3aa9d733b5bb9241e1,0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x2e07c1b34531d19a453db3e249e9ce92e93705fd9cfb33db642ad6e2ca81952b,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf 16:20:05 [16:20:05.767] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:06 [16:20:06.021] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:06 [16:20:06.143] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24ca53c098e6eefbb510101c3fd1fea9af8b339a0890ae81a5508f0c683c6031","blockNumber":2,"slot":3} 16:20:06 [16:20:06.291] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:06 [16:20:06.735] INFO: pxe:service Proving completed in 2180.9440560000003ms {"timings":{"total":2180.9440560000003,"sync":13.247164999998859,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":263.371806000001,"oracles":{"debugLog":{"times":[0.6962320000002364,0.4805149999992864,0.49175600000125996,0.4360739999992802,0.4714850000000297,0.2981290000006993,0.40442299999995157,0.6915420000004815]},"fetchTaggedLogs":{"times":[72.12744300000122]},"loadCapsule":{"times":[0.35413100000005215,0.35758200000054785,0.442403999999442,0.3021000000007916,0.23723700000118697,0.24380700000074285]},"getSharedSecret":{"times":[5.944735999999466]},"aes128Decrypt":{"times":[1.0348720000001776,0.7879140000004554]},"getPublicKeysAndPartialAddress":{"times":[1.7680860000000393]},"getKeyValidationRequest":{"times":[2.2987319999992906]},"deliverNote":{"times":[4.885922999999821]},"deleteCapsule":{"times":[0.4900660000002972]},"storeCapsule":{"times":[0.4064929999985907]},"getNotes":{"times":[3.8867620000000898]},"getAuthWitness":{"times":[0.31160000000090804]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0752119999997376]},"callPrivateFunction":{"times":[655.6055830000005,111.15378799999962]},"notifyEnqueuedPublicFunctionCall":{"times":[0.23183799999969779]}}},{"functionName":"private_kernel_init","time":80.33980100000008},{"functionName":"ContractClassRegisterer:register","time":644.0160889999988,"oracles":{"loadCapsule":{"times":[3.1193380000004254]},"notifyCreatedNullifier":{"times":[0.6895220000005793]},"debugLog":{"times":[0.9003979999997682]},"notifyCreatedContractClassLog":{"times":[14.510454999999638]}}},{"functionName":"private_kernel_inner","time":170.4256379999988},{"functionName":"ContractInstanceDeployer:deploy","time":69.00341500000104,"oracles":{"storeInExecutionCache":{"times":[0.21507700000074692]},"callPrivateFunction":{"times":[43.664270999999644]},"notifyCreatedNullifier":{"times":[0.23309700000027078]},"debugLog":{"times":[0.4428139999999985]}}},{"functionName":"private_kernel_inner","time":143.5791160000008},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":32.231330999999045,"oracles":{}},{"functionName":"private_kernel_inner","time":102.84257799999978},{"functionName":"private_kernel_reset","time":162.68805500000053},{"functionName":"private_kernel_tail","time":98.91109399999914}],"unaccounted":400.28796800000237}} 16:20:06 [16:20:06.767] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:06 [16:20:06.979] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:06 [16:20:06.985] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24ca53c098e6eefbb510101c3fd1fea9af8b339a0890ae81a5508f0c683c6031","blockNumber":2,"slot":3} 16:20:07 [16:20:07.016] VERBOSE: p2p:tx_pool Adding tx 0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9 to pool {"eventName":"tx-added-to-pool","txHash":"0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":151,"proofSize":172052,"size":322921,"feePaymentMethod":"fee_juice"} 16:20:07 [16:20:07.065] INFO: node Received tx 0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9 {"txHash":"0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9"} 16:20:07 [16:20:07.066] INFO: pxe:service Sent transaction 0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9 16:20:07 [16:20:07.209] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:07 [16:20:07.412] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:07 [16:20:07.514] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 16:20:07 [16:20:07.528] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-16T16:24:57.000Z","now":"2025-06-16T16:25:00.665Z"} 16:20:07 [16:20:07.667] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:07 [16:20:07.886] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:07 [16:20:07.951] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x35393df3 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x35393df3","duration":102.63446099999965} 16:20:08 [16:20:08.162] VERBOSE: simulator:public-processor Processed tx 0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9 with 1 public calls in 479.4475040000016ms {"txHash":"0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9","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":479.4475040000016} 16:20:08 [16:20:08.164] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:08 [16:20:08.167] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.6388608470000018s {"duration":0.6388608470000018,"rate":96734.68062756369,"totalPublicGas":{"daGas":3072,"l2Gas":61800},"totalBlockGas":{"daGas":91648,"l2Gas":98344},"totalSizeInBytes":6144} 16:20:08 [16:20:08.332] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 75536.96856673155 mana/s {"blockHash":"0x25ef326eec188f5f284245f7ecb615ac26377ab31759beea3085f88c58866c28","globalVariables":{"chainId":31337,"version":426324814,"blockNumber":2,"slotNumber":3,"timestamp":1750091097,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0be5f29a90c6dcfe37bd9b73b535a90555410ec2c3027b6e06bc2f14d49f8fb9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":817.365937999999,"publicProcessDuration":639.3118820000018,"rollupCircuitsDuration":804.6978610000006,"txCount":1,"blockNumber":2,"blockTimestamp":1750091097,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 16:20:08 [16:20:08.335] VERBOSE: sequencer Attesting committee is empty 16:20:08 [16:20:08.416] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:08 [16:20:08.607] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xaea28277901f43325285ed1c4f7368578dd2b705ea7e01de7844a492120aa75b 16:20:08 [16:20:08.608] VERBOSE: sequencer-client Sent L1 transaction 0xaea28277901f43325285ed1c4f7368578dd2b705ea7e01de7844a492120aa75b {"gasLimit":470265,"maxFeePerGas":"1.303611152","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:20:08 [16:20:08.619] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:20:08 [16:20:08.619] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xaea28277901f43325285ed1c4f7368578dd2b705ea7e01de7844a492120aa75b","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1750091097,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 16:20:08 [16:20:08.620] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:20:08 [16:20:08.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:08 [16:20:08.629] INFO: blob-sink:server Received blob sidecar for block 0xc0791c95037015093ff9610e9d252779524820474f93df559aef863568cbfb1c 16:20:08 [16:20:08.634] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 16:20:08 [16:20:08.638] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 16:20:08 [16:20:08.640] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc0791c95037015093ff9610e9d252779524820474f93df559aef863568cbfb1c 16:20:08 [16:20:08.641] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 16:20:08 [16:20:08.644] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750091133] on http://127.0.0.1:8545 16:20:08 [16:20:08.646] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:20:08 [16:20:08.647] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750091133 16:20:08 [16:20:08.647] WARN: foundation:test-date-provider Time set to 2025-06-16T16:25:33.000Z {"offset":324353,"timeMs":1750091133000} 16:20:08 [16:20:08.647] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 16:20:08 [16:20:08.834] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:09 [16:20:09.079] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:09 [16:20:09.100] VERBOSE: archiver:block-helper Store contract instance at 0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72 16:20:09 [16:20:09.108] VERBOSE: archiver:block-helper Store contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 16:20:09 [16:20:09.133] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x25ef326eec188f5f284245f7ecb615ac26377ab31759beea3085f88c58866c28","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":426324814,"blockNumber":2,"slotNumber":3,"timestamp":1750091097,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0630a1c01d875a5d6784b7ee2d681bea9d008c7f9cef09a3f88fdde5cf39b665","archiveNextLeafIndex":3} 16:20:09 [16:20:09.157] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 16:20:09 [16:20:09.195] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.3704690000013215,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750091097,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 16:20:09 [16:20:09.207] INFO: aztecjs:deploy_sent_tx Contract 0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72 successfully deployed. 16:20:09 [16:20:09.207] INFO: e2e:e2e_private_voting_contract Counter contract deployed at 0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72 16:20:09 [16:20:09.209] INFO: e2e:e2e_private_voting_contract Running test: e2e_voting_contract votes votes, then tries to vote again 16:20:09 [16:20:09.227] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x0630a1c01d875a5d6784b7ee2d681bea9d008c7f9cef09a3f88fdde5cf39b665","header":{"contentCommitment":{"blobsHash":"0x0083592cfa2ace98c5ec747ca6ab965fd8827f4f6fa72fe58b0b29c496b878c5","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750091097,"version":426324814},"lastArchive":"0x24ca53c098e6eefbb510101c3fd1fea9af8b339a0890ae81a5508f0c683c6031","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1adeaf42e31f6f36a264a86f379b71f7d65e6fbb0f754784b4c84977faa1f4d5","nullifierTree":"0x0346d7b7f4ca0234a0a6d07b9de2189baaa896cd461d5c9975a5cee57e435bc0","publicDataTree":"0x2137e3fdc92d2375cf71e63c64d1bcff471a20270cfffeb948d09a2ae7f43c6e"},"totalFees":32675777440,"totalManaUsed":98344}} 16:20:09 [16:20:09.288] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:09 [16:20:09.325] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:20:09 [16:20:09.326] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:09 [16:20:09.326] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:09 [16:20:09.385] VERBOSE: p2p Synched to latest block 2 16:20:09 [16:20:09.398] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:09 [16:20:09.404] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x12132380402a409bfdbd21273e7a0754abb71ddf143d4fef7854b063663928fb 16:20:09 [16:20:09.415] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:20:09 [16:20:09.415] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:20:09 [16:20:09.422] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:20:09 [16:20:09.422] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:20:09 [16:20:09.425] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e877e506b7e6700a7d036b3cb62573ec2336cac2813a0de548c93a7301f1139","nullifier":"0x1b71a886820718a3065d2521a1e1113b83b4a121c05624baf73dbbcd6d6b3fd9"} 16:20:09 [16:20:09.427] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:20:09 [16:20:09.445] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf as fee payer 16:20:09 [16:20:09.475] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72"} 16:20:09 [16:20:09.537] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:09 [16:20:09.760] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:09 [16:20:09.782] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0630a1c01d875a5d6784b7ee2d681bea9d008c7f9cef09a3f88fdde5cf39b665","blockNumber":3,"slot":4} 16:20:09 [16:20:09.970] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:10 [16:20:10.331] INFO: pxe:service Proving completed in 1110.4188839999988ms {"timings":{"total":1110.4188839999988,"sync":8.670751999998174,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":226.29374100000132,"oracles":{"debugLog":{"times":[0.5129460000025574,0.5832289999998466,0.3985529999990831,0.3917220000002999,0.4008219999996072,0.2787290000014764,0.3478010000035283,0.6943520000022545]},"fetchTaggedLogs":{"times":[76.02572599999985]},"loadCapsule":{"times":[0.2449079999969399,0.2658479999990959,0.47167500000068685,0.25174799999876996,0.24605800000063027,0.17225499999767635]},"getSharedSecret":{"times":[3.797118999998929]},"aes128Decrypt":{"times":[0.21058599999742,0.8148460000011255]},"getPublicKeysAndPartialAddress":{"times":[1.7107539999997243]},"getKeyValidationRequest":{"times":[1.675441999999748]},"deliverNote":{"times":[3.118188000000373]},"deleteCapsule":{"times":[0.27254899999752524]},"storeCapsule":{"times":[0.3189700000002631]},"getNotes":{"times":[1.8359380000001693]},"getAuthWitness":{"times":[0.2934990000030666]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05277199999909499]},"callPrivateFunction":{"times":[54.272282999998424]}}},{"functionName":"private_kernel_init","time":86.60021700000289},{"functionName":"EasyPrivateVoting:cast_vote","time":41.66354599999613,"oracles":{"getPublicKeysAndPartialAddress":{"times":[1.7727459999987332]},"getKeyValidationRequest":{"times":[4.160630000002129]},"notifyCreatedNullifier":{"times":[0.3216199999988021]},"storeInExecutionCache":{"times":[0.05654099999810569]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0664920000017446]}}},{"functionName":"private_kernel_inner","time":161.85867900000085},{"functionName":"private_kernel_reset","time":262.9157200000009},{"functionName":"private_kernel_tail","time":109.93163999999888}],"unaccounted":212.4845889999997}} 16:20:10 [16:20:10.364] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:10 [16:20:10.400] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0630a1c01d875a5d6784b7ee2d681bea9d008c7f9cef09a3f88fdde5cf39b665","blockNumber":3,"slot":4} 16:20:10 [16:20:10.406] VERBOSE: p2p:tx_pool Adding tx 0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e to pool {"eventName":"tx-added-to-pool","txHash":"0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226313,"feePaymentMethod":"fee_juice"} 16:20:10 [16:20:10.415] INFO: node Received tx 0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e {"txHash":"0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e"} 16:20:10 [16:20:10.416] INFO: pxe:service Sent transaction 0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e 16:20:10 [16:20:10.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:10 [16:20:10.773] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:10 [16:20:10.922] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 16:20:10 [16:20:10.939] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-16T16:25:33.000Z","now":"2025-06-16T16:25:35.292Z"} 16:20:10 [16:20:10.976] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:11 [16:20:11.019] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5f06617e completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5f06617e","duration":57.51826499999879} 16:20:11 [16:20:11.044] VERBOSE: simulator:public-processor Processed tx 0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e with 1 public calls in 91.06838699999935ms {"txHash":"0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e","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":91.06838699999935} 16:20:11 [16:20:11.046] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10581494999999995s {"duration":0.10581494999999995,"rate":224467.3366098081,"totalPublicGas":{"daGas":512,"l2Gas":23752},"totalBlockGas":{"daGas":2048,"l2Gas":54952},"totalSizeInBytes":352} 16:20:11 [16:20:11.179] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 92208.89462324268 mana/s {"blockHash":"0x0b9070cc3b9e416da7b3131953b47d1f9783bf08a72a756d862704e2271994c1","globalVariables":{"chainId":31337,"version":426324814,"blockNumber":3,"slotNumber":4,"timestamp":1750091133,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1ad1a637819f19f66068529569eb1405b0892b51b926af0a334482d8461cfd7e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":256.896510999999,"publicProcessDuration":106.24614499999734,"rollupCircuitsDuration":241.29746199999863,"txCount":1,"blockNumber":3,"blockTimestamp":1750091133,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:20:11 [16:20:11.181] VERBOSE: sequencer Attesting committee is empty 16:20:11 [16:20:11.258] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:11 [16:20:11.475] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:11 [16:20:11.481] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xea2ca82bd85934f3fee5accfae6bae688cdf6ada13cb0e918e17ae76c71556a7 16:20:11 [16:20:11.481] VERBOSE: sequencer-client Sent L1 transaction 0xea2ca82bd85934f3fee5accfae6bae688cdf6ada13cb0e918e17ae76c71556a7 {"gasLimit":470205,"maxFeePerGas":"1.279583366","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:20:11 [16:20:11.504] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750091169] on http://127.0.0.1:8545 16:20:11 [16:20:11.508] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:20:11 [16:20:11.508] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xea2ca82bd85934f3fee5accfae6bae688cdf6ada13cb0e918e17ae76c71556a7","calldataSize":1444,"calldataGas":12256,"txCount":1,"blockNumber":3,"blockTimestamp":1750091133,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:20:11 [16:20:11.509] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:20:11 [16:20:11.512] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:20:11 [16:20:11.515] INFO: blob-sink:server Received blob sidecar for block 0x5aa6646b459e1949bb72deec8b991586453e226f9d788f75c8c4d9b234009ca3 16:20:11 [16:20:11.519] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750091169 16:20:11 [16:20:11.519] WARN: foundation:test-date-provider Time set to 2025-06-16T16:26:09.000Z {"offset":357481,"timeMs":1750091169000} 16:20:11 [16:20:11.519] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 16:20:11 [16:20:11.521] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5aa6646b459e1949bb72deec8b991586453e226f9d788f75c8c4d9b234009ca3 16:20:11 [16:20:11.659] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x0b9070cc3b9e416da7b3131953b47d1f9783bf08a72a756d862704e2271994c1","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":426324814,"blockNumber":3,"slotNumber":4,"timestamp":1750091133,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","archiveNextLeafIndex":4} 16:20:11 [16:20:11.679] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:11 [16:20:11.684] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 16:20:11 [16:20:11.686] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 16:20:11 [16:20:11.688] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 16:20:11 [16:20:11.767] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.35547200000292,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750091133,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:20:11 [16:20:11.783] VERBOSE: p2p Synched to latest block 3 16:20:11 [16:20:11.882] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:12 [16:20:12.032] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","blockNumber":4,"slot":5} 16:20:12 [16:20:12.085] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:12 [16:20:12.173] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 16:20:12 [16:20:12.288] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:12 [16:20:12.490] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:12 [16:20:12.498] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","header":{"contentCommitment":{"blobsHash":"0x00818ae7d1077362e18e617c9762628afc3708121997c82c00ce12cb87d81993","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750091133,"version":426324814},"lastArchive":"0x0630a1c01d875a5d6784b7ee2d681bea9d008c7f9cef09a3f88fdde5cf39b665","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1adeaf42e31f6f36a264a86f379b71f7d65e6fbb0f754784b4c84977faa1f4d5","nullifierTree":"0x1f56b64600ac26842fe2f8fe9851542e7da6f6ed2cf911dd44ce183b4b73478f","publicDataTree":"0x253eb40aef821885cb166f3e4a7f046d1ab1a44286b0730d8b1c1c12129d5740"},"totalFees":18258351520,"totalManaUsed":54952}} 16:20:12 [16:20:12.521] VERBOSE: simulator Executing utility function get_vote {"contract":"0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72","selector":"0x50ac913f"} 16:20:12 [16:20:12.530] VERBOSE: simulator Utility simulation for 0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72.0x50ac913f completed 16:20:12 [16:20:12.551] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf {"origin":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000001969334e","authWitnesses":["0x16782c52af8334cd3e6854f0b862b9627c7a54b487e980162ce396001ec419af"]} 16:20:12 [16:20:12.562] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","blockNumber":4,"slot":5} 16:20:12 [16:20:12.635] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:12 [16:20:12.686] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:20:12 [16:20:12.686] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:12 [16:20:12.693] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:12 [16:20:12.786] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:12 [16:20:12.792] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x12132380402a409bfdbd21273e7a0754abb71ddf143d4fef7854b063663928fb 16:20:12 [16:20:12.802] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:20:12 [16:20:12.803] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:20:12 [16:20:12.810] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:20:12 [16:20:12.811] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:20:12 [16:20:12.814] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e877e506b7e6700a7d036b3cb62573ec2336cac2813a0de548c93a7301f1139","nullifier":"0x1b71a886820718a3065d2521a1e1113b83b4a121c05624baf73dbbcd6d6b3fd9"} 16:20:12 [16:20:12.816] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:20:12 [16:20:12.835] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf as fee payer 16:20:12 [16:20:12.872] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72"} 16:20:12 [16:20:12.920] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:13 [16:20:13.174] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:13 [16:20:13.194] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","blockNumber":4,"slot":5} 16:20:13 [16:20:13.636] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:13 [16:20:13.657] VERBOSE: node Simulating public calls for tx 0x20bb0ff13c25bf9c74b3fcbdb104912087a2161726045ff8c4b19925e5404c93 {"globalVariables":{"chainId":31337,"version":426324814,"blockNumber":4,"slotNumber":5,"timestamp":1750091169,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHash":"0x20bb0ff13c25bf9c74b3fcbdb104912087a2161726045ff8c4b19925e5404c93","blockNumber":4} 16:20:13 [16:20:13.674] VERBOSE: simulator:state_manager Siloed nullifier 0x20891a86d21deae386eb9a93e19c8173148f24743a65f7425f2d694cf0a0d923 already present in tree! 16:20:13 [16:20:13.679] WARN: simulator:public_tx_context APP_LOGIC phase reverted! insertRevertiblesFromPrivate failed with reason: Nullifier collision encountered when inserting revertible nullifiers from private 16:20:13 Details: Siloed nullifier 0x20891a86d21deae386eb9a93e19c8173148f24743a65f7425f2d694cf0a0d923 already exists in parent cache or host. 16:20:13 Error stack: NullifierCollisionError: Siloed nullifier 0x20891a86d21deae386eb9a93e19c8173148f24743a65f7425f2d694cf0a0d923 already exists in parent cache or host. 16:20:13 at PublicPersistableStateManager.writeSiloedNullifier (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/state_manager/state_manager.js:190:23) 16:20:13 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:263:17) 16:20:13 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:33:24) 16:20:13 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:54:29) 16:20:13 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:14:25) 16:20:13 at PublicProcessor.processTxWithPublicCalls (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:321:91) 16:20:13 at PublicProcessor.processTxWithinDeadline (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:268:20) 16:20:13 at elapsed (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/timer/elapsed.js:8:20) 16:20:13 at PublicProcessor.processTx (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:221:53) 16:20:13 at PublicProcessor.process (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:159:53) 16:20:13 at AztecNodeService.simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:718:66) 16:20:13 at PXEService.#simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:241:28) 16:20:13 at /home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:580:36 16:20:13 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 16:20:13 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 16:20:13 [16:20:13.697] VERBOSE: simulator:public-processor Processed tx 0x20bb0ff13c25bf9c74b3fcbdb104912087a2161726045ff8c4b19925e5404c93 with 1 public calls in 29.485015000002022ms {"txHash":"0x20bb0ff13c25bf9c74b3fcbdb104912087a2161726045ff8c4b19925e5404c93","txFee":1581840000,"revertCode":1,"revertReason":{"originalMessage":"Nullifier collision encountered when inserting revertible nullifiers from private\nDetails: Siloed nullifier 0x20891a86d21deae386eb9a93e19c8173148f24743a65f7425f2d694cf0a0d923 already exists in parent cache or host.\nError stack: NullifierCollisionError: Siloed nullifier 0x20891a86d21deae386eb9a93e19c8173148f24743a65f7425f2d694cf0a0d923 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":29.485015000002022} 16:20:13 [16:20:13.699] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03710702400000082s {"duration":0.03710702400000082,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":31200},"totalSizeInBytes":256} 16:20:13 [16:20:13.702] ERROR: pxe:service Failed to enrich public simulation error: TypeError: Cannot read properties of undefined (reading 'contractAddress') 16:20:13 [16:20:13.731] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","blockNumber":4,"slot":5} 16:20:13 [16:20:13.833] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:13 [16:20:13.883] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:20:13 [16:20:13.883] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:13 [16:20:13.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:13 [16:20:13.942] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf"} 16:20:13 [16:20:13.948] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x12132380402a409bfdbd21273e7a0754abb71ddf143d4fef7854b063663928fb 16:20:13 [16:20:13.962] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:20:13 [16:20:13.963] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:20:13 [16:20:13.973] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:20:13 [16:20:13.974] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:20:13 [16:20:13.979] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e877e506b7e6700a7d036b3cb62573ec2336cac2813a0de548c93a7301f1139","nullifier":"0x1b71a886820718a3065d2521a1e1113b83b4a121c05624baf73dbbcd6d6b3fd9"} 16:20:13 [16:20:13.981] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:20:14 [16:20:14.000] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1bae2b34a32614493d4bdfeb95bce13d23b6fa61351853aa27f6c7fcc7df71cf as fee payer 16:20:14 [16:20:14.041] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x20ce69e97235e35ff00adbd085d53766d9060a7675160863df3bc44e9c3a4b72"} 16:20:14 [16:20:14.092] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:14 [16:20:14.350] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:14 [16:20:14.411] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","blockNumber":4,"slot":5} 16:20:14 [16:20:14.572] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:14 [16:20:14.932] INFO: pxe:service Proving completed in 1206.6623150000014ms {"timings":{"total":1206.6623150000014,"sync":7.642120000000432,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":266.910565999995,"oracles":{"debugLog":{"times":[0.6760810000014317,0.4904660000029253,0.6930819999979576,0.7136019999998098,0.9386500000000524,0.6241090000003169,0.4443440000031842,0.7562839999991411]},"fetchTaggedLogs":{"times":[62.93784599999708]},"loadCapsule":{"times":[0.17511600000216276,0.19148599999971339,0.42301299999962794,0.20358600000326987,0.2112970000016503,0.21083599999838043]},"getSharedSecret":{"times":[4.09295800000109]},"aes128Decrypt":{"times":[0.3771210000013525,1.2486690000005183]},"getPublicKeysAndPartialAddress":{"times":[3.174128999999084]},"getKeyValidationRequest":{"times":[2.43769699999757]},"deliverNote":{"times":[4.53272300000026]},"deleteCapsule":{"times":[0.27768899999864516]},"storeCapsule":{"times":[0.33071100000233855]},"getNotes":{"times":[1.6790629999995872]},"getAuthWitness":{"times":[0.2822189999969851]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1335049999979674]},"callPrivateFunction":{"times":[70.4285400000008]}}},{"functionName":"private_kernel_init","time":90.25754299999971},{"functionName":"EasyPrivateVoting:cast_vote","time":52.37798300000577,"oracles":{"getPublicKeysAndPartialAddress":{"times":[4.513792000001558]},"getKeyValidationRequest":{"times":[2.599082000000635]},"notifyCreatedNullifier":{"times":[0.3704309999993711]},"storeInExecutionCache":{"times":[0.05053099999713595]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0762219999996887]}}},{"functionName":"private_kernel_inner","time":153.94971100000112},{"functionName":"private_kernel_reset","time":246.0583719999995},{"functionName":"private_kernel_tail","time":112.8379709999972}],"unaccounted":276.62804900000265}} 16:20:14 [16:20:14.972] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:20:15 [16:20:15.004] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x0f267a9a5ba9179f890565b13bd5bb0e23c2f104507f650d9826801037a8278c for repeating a nullifier 16:20:15 [16:20:15.008] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2c6e3de00360e02d7d59fef53696715bb7bb25342c8942672db7c40936b6682f","blockNumber":4,"slot":5} 16:20:15 [16:20:15.010] WARN: node Received invalid tx 0x0f267a9a5ba9179f890565b13bd5bb0e23c2f104507f650d9826801037a8278c: Existing nullifier {"txHash":"0x0f267a9a5ba9179f890565b13bd5bb0e23c2f104507f650d9826801037a8278c"} 16:20:15 [16:20:15.014] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 16:20:15 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 16:20:15 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 16:20:15 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 16:20:15 [16:20:15.022] INFO: node Stopping 16:20:15 [16:20:15.023] INFO: slasher Slasher client stopped. 16:20:15 [16:20:15.023] INFO: sequencer Stopped sequencer 16:20:15 [16:20:15.024] INFO: p2p P2P client stopped. 16:20:15 [16:20:15.027] INFO: world_state Stopped world state synchronizer 16:20:15 [16:20:15.027] INFO: archiver Stopped. 16:20:15 [16:20:15.027] INFO: node Stopped 16:20:15 [16:20:15.027] VERBOSE: e2e:e2e_private_voting_contract Cleaning up ACVM state 16:20:15 [16:20:15.028] INFO: e2e:e2e_private_voting_contract Cleaning up ACVM temp directory /tmp/8c6b444b 16:20:15 [16:20:15.029] VERBOSE: e2e:e2e_private_voting_contract Cleaning up BB state 16:20:15 [16:20:15.040] INFO: blob-sink:server Stopping blob sink 16:20:15 [16:20:15.041] INFO: blob-sink:server Blob sink stopped 16:20:15 [16:20:15.041] VERBOSE: e2e:e2e_private_voting_contract Cleaning up data directory at /tmp/730881cfea302c29 16:20:15 PASS src/e2e_private_voting_contract.test.ts 16:20:15 e2e_voting_contract 16:20:15 votes 16:20:15 ✓ votes, then tries to vote again (5807 ms) 16:20:15 16:20:15 Test Suites: 1 passed, 1 total 16:20:15 Tests: 1 passed, 1 total 16:20:15 Snapshots: 0 total 16:20:15 Time: 23.016 s 16:20:15 Ran all test suites matching /src\/e2e_private_voting_contract.test.ts/i. 16:20:15 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?