Parent Log: http://ci.aztec-labs.com/b77d7025149214cb Command: a173e32263f6bc73: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/71fe6b444df8fafa5531226cf458dbd22d2f3ab7 Env: REF_NAME=gh-readonly-queue/master/pr-15117-c06f30929f18b85bcea93c0926a8d640a3819f00 CURRENT_VERSION=0.87.8 CI_FULL=0 Date: Tue Jun 17 19:31:52 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15117_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_f9aac7f8d569bb18_master 19:31:52 +++ id -u 19:31:52 +++ id -g 19:31:52 ++ docker run -d --name e2e_private_voting_contract --net=none --cpuset-cpus=0-63 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_private_voting_contract.test.ts'\''' 19:31:52 + cid=59429c3881abdd1c038fd9ab89e76a7dcbbbdf2c9a26e2ab1577c3321e1c9f34 19:31:52 + set +x 19:31:53 {"level":25,"time":1750188713471,"pid":12,"hostname":"59429c3881ab","module":"logger","msg":"Logger initialized with level verbose"} 19:31:57 [19:31:57.649] INFO: e2e:e2e_private_voting_contract Logging metrics to log/unknown.jsonl 19:31:57 [19:31:57.846] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-x7hgwh/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:31:57 [19:31:57.876] INFO: e2e:e2e_private_voting_contract Calling anvil_setBlockTimestampInterval with params: [12] 19:31:57 [19:31:57.898] WARN: e2e:e2e_private_voting_contract Set block interval to 12 19:31:57 [19:31:57.899] VERBOSE: e2e:e2e_private_voting_contract Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:31:57 [19:31:57.943] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:31:57 [19:31:57.950] VERBOSE: e2e:e2e_private_voting_contract Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:31:57 [19:31:57.965] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:31:57 [19:31:57.969] VERBOSE: e2e:e2e_private_voting_contract Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:31:57 [19:31:57.984] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:31:57 [19:31:57.988] VERBOSE: e2e:e2e_private_voting_contract Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:31:58 [19:31:58.003] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:31:58 [19:31:58.007] VERBOSE: e2e:e2e_private_voting_contract Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:31:58 [19:31:58.022] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 19:31:58 [19:31:58.026] VERBOSE: e2e:e2e_private_voting_contract Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:31:58 [19:31:58.037] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 19:31:58 [19:31:58.041] VERBOSE: e2e:e2e_private_voting_contract Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:31:58 [19:31:58.042] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 19:31:58 [19:31:58.042] INFO: e2e:e2e_private_voting_contract Waiting for 6 transactions to be mined... 19:31:58 [19:31:58.061] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 19:31:58 [19:31:58.075] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 19:31:58 [19:31:58.075] VERBOSE: e2e:e2e_private_voting_contract Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 19:31:58 [19:31:58.085] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 19:31:58 [19:31:58.097] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 19:31:58 [19:31:58.103] VERBOSE: e2e:e2e_private_voting_contract Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 19:31:58 [19:31:58.113] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 19:31:58 [19:31:58.114] VERBOSE: e2e:e2e_private_voting_contract Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 19:31:58 [19:31:58.127] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 19:31:58 [19:31:58.131] VERBOSE: e2e:e2e_private_voting_contract Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:31:58 [19:31:58.141] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 19:31:58 [19:31:58.141] VERBOSE: e2e:e2e_private_voting_contract Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 19:31:58 [19:31:58.141] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 19:31:58 [19:31:58.141] INFO: e2e:e2e_private_voting_contract Waiting for 8 transactions to be mined... 19:31:58 [19:31:58.158] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 19:31:58 [19:31:58.167] VERBOSE: e2e:e2e_private_voting_contract Deployed shared contracts 19:31:58 [19:31:58.182] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 19:31:58 [19:31:58.182] VERBOSE: e2e:e2e_private_voting_contract Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 19:31:58 [19:31:58.184] 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} 19:31:58 [19:31:58.198] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 19:31:58 [19:31:58.219] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 19:31:58 [19:31:58.223] VERBOSE: e2e:e2e_private_voting_contract Awaiting for linked libraries to be deployed 19:31:58 [19:31:58.256] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xba5eec8cec859dbd6393a44aeb2779276603aad5aad33d78371727576f73a2d4 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 19:31:58 [19:31:58.261] 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} 19:31:58 [19:31:58.261] INFO: e2e:e2e_private_voting_contract Waiting for 9 transactions to be mined... 19:31:58 [19:31:58.281] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 19:31:58 [19:31:58.282] VERBOSE: e2e:e2e_private_voting_contract All core contracts have been deployed 19:31:58 [19:31:58.294] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 19:31:58 [19:31:58.294] VERBOSE: e2e:e2e_private_voting_contract Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 19:31:58 [19:31:58.305] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 19:31:58 [19:31:58.309] VERBOSE: e2e:e2e_private_voting_contract Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 19:31:58 [19:31:58.327] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 19:31:58 [19:31:58.327] VERBOSE: e2e:e2e_private_voting_contract Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 19:31:58 [19:31:58.327] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 19:31:58 [19:31:58.344] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 19:31:58 [19:31:58.350] VERBOSE: e2e:e2e_private_voting_contract Rollup deployed 19:31:58 [19:31:58.350] VERBOSE: e2e:e2e_private_voting_contract Waiting for rollup and slash factory to be deployed 19:31:58 [19:31:58.350] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 19:31:58 [19:31:58.369] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 19:31:58 [19:31:58.370] VERBOSE: e2e:e2e_private_voting_contract All transactions for L1 deployment have been mined 19:31:58 [19:31:58.385] 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"} 19:31:58 [19:31:58.387] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:31:58 [19:31:58.389] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.390] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 19:31:58 [19:31:58.391] INFO: telemetry:client Using NoopTelemetryClient 19:31:58 [19:31:58.395] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 19:31:58 [19:31:58.395] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 19:31:58 [19:31:58.396] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/29f5c7462a84b340/blob-sink with map size 134217728 KB (LMDB v2) 19:31:58 [19:31:58.398] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.400] INFO: aztecjs:utils:watcher New L1 time: 1750188957 19:31:58 [19:31:58.401] WARN: foundation:test-date-provider Time set to 2025-06-17T19:35:57.000Z {"offset":238599,"timeMs":1750188957000} 19:31:58 [19:31:58.402] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:31:58 [19:31:58.407] INFO: blob-sink:server Server is running on http://localhost:43901 19:31:58 [19:31:58.408] VERBOSE: e2e:e2e_private_voting_contract Creating and synching an aztec node... 19:31:58 [19:31:58.408] VERBOSE: e2e:e2e_private_voting_contract Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/4da00107/acvm 19:31:58 [19:31:58.409] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:43901"} 19:31:58 [19:31:58.422] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:31:58 [19:31:58.422] INFO: archiver:lmdb Creating archiver data store at directory /tmp/29f5c7462a84b340/archiver with map size 134217728 KB (LMDB v2) 19:31:58 [19:31:58.423] INFO: archiver:lmdb Starting data store with maxReaders 16 19:31:58 [19:31:58.605] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.679] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:43901"} 19:31:58 [19:31:58.693] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:43901"} 19:31:58 [19:31:58.693] WARN: node:blob-sink:client No L1 consensus host urls configured 19:31:58 [19:31:58.693] WARN: node:blob-sink:client No archive client configured 19:31:58 [19:31:58.696] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xd286a451b2cbd71c6a6aa4b206bf2d9039a723b7d76deefa9b84e8e586b57885 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x66904367411dc8d025c65bd398b08200bf1846bea611512f6d6990b61902997a","l1BlockNumber":16}} 19:31:58 [19:31:58.708] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:31:58 [19:31:58.714] INFO: world-state:database Creating world state data store at directory /tmp/29f5c7462a84b340/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:31:58 [19:31:58.736] INFO: world_state Created world state synchroniser with block history of 64 19:31:58 [19:31:58.737] WARN: node Aztec node is accepting fake proofs 19:31:58 [19:31:58.746] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/29f5c7462a84b340/p2p with map size 134217728 KB (LMDB v2) 19:31:58 [19:31:58.747] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:31:58 [19:31:58.748] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/29f5c7462a84b340/p2p-archive with map size 134217728 KB (LMDB v2) 19:31:58 [19:31:58.748] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:31:58 [19:31:58.749] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/29f5c7462a84b340/p2p-peers with map size 134217728 KB (LMDB v2) 19:31:58 [19:31:58.750] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:31:58 [19:31:58.751] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:31:58 [19:31:58.751] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:31:58 [19:31:58.753] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 19:31:58 [19:31:58.754] INFO: world_state Started world state synchronizer from block 1 19:31:58 [19:31:58.756] VERBOSE: world-state:block_stream Starting sync from block number 0 19:31:58 [19:31:58.758] INFO: p2p Starting p2p client from block 0 with empty mempools 19:31:58 [19:31:58.758] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 19:31:58 [19:31:58.759] INFO: slasher Slasher client initialized 19:31:58 [19:31:58.759] INFO: slasher Starting Slasher client... 19:31:58 [19:31:58.787] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:31:58 [19:31:58.787] VERBOSE: node All Aztec Node subsystems synced 19:31:58 [19:31:58.793] INFO: sequencer-client Deploying forwarder contract 19:31:58 [19:31:58.798] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:31:58 [19:31:58.810] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.812] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 19:31:58 [19:31:58.812] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 19:31:58 [19:31:58.817] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:31:58 [19:31:58.830] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:31:58 [19:31:58.830] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 19:31:58 [19:31:58.831] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/4da00107/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:31:59 [19:31:59.012] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:31:59 [19:31:59.013] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:31:59 [19:31:59.014] INFO: node Aztec Node version: 0.87.8 19:31:59 [19:31:59.014] 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"} 19:31:59 [19:31:59.015] VERBOSE: e2e:e2e_private_voting_contract Creating a pxe... 19:31:59 [19:31:59.018] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:59 [19:31:59.026] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/f900fd030540a70f/pxe_data with map size 134217728 KB (LMDB v2) 19:31:59 [19:31:59.036] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1c6b7fde555824dbb39379631517338723709b497b8c855ba1e1838322fa2b22","blockNumber":1,"slot":2} 19:31:59 [19:31:59.037] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:31:59 [19:31:59.228] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:59 [19:31:59.256] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:31:59 [19:31:59.256] INFO: pxe:service Started PXE connected to chain 31337 version 2643230180 19:31:59 [19:31:59.305] INFO: pxe:service Registered account 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 19:31:59 [19:31:59.358] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 19:31:59 [19:31:59.359] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 19:31:59 [19:31:59.469] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:59 [19:31:59.472] INFO: pxe:service Added contract SchnorrAccount at 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:31:59 [19:31:59.510] VERBOSE: pxe:block_stream Starting sync from block number 0 19:31:59 [19:31:59.527] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:31:59 [19:31:59.612] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:32:00 [19:32:00.022] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:32:00 [19:32:00.096] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:32:00 [19:32:00.151] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1c6b7fde555824dbb39379631517338723709b497b8c855ba1e1838322fa2b22","blockNumber":1,"slot":2} 19:32:00 [19:32:00.155] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.243] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:00 [19:32:00.282] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:00 [19:32:00.283] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:00 [19:32:00.316] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:00 [19:32:00.319] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:00 [19:32:00.367] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.472] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:00 [19:32:00.507] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:00 [19:32:00.508] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:00 [19:32:00.538] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:00 [19:32:00.541] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:00 [19:32:00.554] VERBOSE: simulator:client_execution_context:debug_log Setting 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 as fee payer 19:32:00 [19:32:00.576] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.859] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.868] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1c6b7fde555824dbb39379631517338723709b497b8c855ba1e1838322fa2b22","blockNumber":1,"slot":2} 19:32:01 [19:32:01.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:01 [19:32:01.624] INFO: pxe:service Proving completed in 2121.928083ms {"timings":{"total":2121.928083,"sync":8.146169000000555,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":120.01277000000118,"oracles":{"callPrivateFunction":{"times":[581.7860019999998,256.4242439999998,158.20864999999958]}}},{"functionName":"private_kernel_init","time":92.35666599999968},{"functionName":"ContractClassRegisterer:register","time":568.2722790000007,"oracles":{"loadCapsule":{"times":[4.404814999999871]},"notifyCreatedNullifier":{"times":[0.5691370000004099]},"debugLog":{"times":[0.7128710000006322]},"notifyCreatedContractClassLog":{"times":[7.792451999999685]}}},{"functionName":"private_kernel_inner","time":118.87055099999998},{"functionName":"SchnorrAccount:constructor","time":231.8120199999994,"oracles":{"getContractInstance":{"times":[3.5536739999997735]},"debugLog":{"times":[0.4923109999999724,0.456742999999733]},"fetchTaggedLogs":{"times":[34.98464300000069]},"loadCapsule":{"times":[0.3689509999994698,0.23538800000005722,0.24655999999959022]},"notifyCreatedNullifier":{"times":[0.2237990000003265,0.24401400000078866]},"notifyCreatedNote":{"times":[0.41089199999987613]},"getRandomField":{"times":[0.22390900000027614,0.1638600000005681,0.2240780000001905,0.08490899999924295,0.06987600000047678,0.08069299999988289,0.06269199999951525,0.0786789999992834,0.06832200000008015,0.10849399999915477,0.05957200000011653]},"getIndexedTaggingSecretAsSender":{"times":[30.749735000000328]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.16483700000026]}}},{"functionName":"private_kernel_inner","time":114.12752699999965},{"functionName":"SchnorrAccount:entrypoint","time":135.6728639999992,"oracles":{"debugLog":{"times":[0.48203600000033475,0.40404099999977916,0.5491499999998268]},"fetchTaggedLogs":{"times":[32.1820459999999]},"loadCapsule":{"times":[0.21489500000006956,0.19904200000019046,0.22981999999956315]},"getNotes":{"times":[1.3437659999999596]},"getAuthWitness":{"times":[0.336779000000206]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7740519999997559]}}},{"functionName":"private_kernel_inner","time":107.79464700000062},{"functionName":"private_kernel_reset","time":163.95631200000025},{"functionName":"private_kernel_tail","time":72.31369500000073}],"unaccounted":388.59258299999783}} 19:32:01 [19:32:01.639] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:01 [19:32:01.707] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1c6b7fde555824dbb39379631517338723709b497b8c855ba1e1838322fa2b22","blockNumber":1,"slot":2} 19:32:01 [19:32:01.769] VERBOSE: p2p:tx_pool Adding tx 0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94 to pool {"eventName":"tx-added-to-pool","txHash":"0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:32:01 [19:32:01.786] INFO: node Received tx 0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94 {"txHash":"0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94"} 19:32:01 [19:32:01.786] INFO: pxe:service Sent transaction 0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94 19:32:01 [19:32:01.847] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.050] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.220] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 19:32:02 [19:32:02.232] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-17T19:36:21.000Z","now":"2025-06-17T19:36:00.831Z"} 19:32:02 [19:32:02.295] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.461] VERBOSE: simulator:public-processor Processed tx 0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94 with no public calls in 156.07156600000053ms {"txHash":"0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94","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":156.07156600000053} 19:32:02 [19:32:02.464] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23194007500000044s {"duration":0.23194007500000044,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 19:32:02 [19:32:02.576] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.590] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2c939bbd3c2c0301f8ccf8585fe591805d918b5d23a8dc2925b9ee94eee28521","globalVariables":{"chainId":31337,"version":2643230180,"blockNumber":1,"slotNumber":2,"timestamp":1750188981,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2f3a1743bbc7fdcea77e9ba81c17278b81448c848c134231a995df2dd5916d94"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":370.2881499999985,"publicProcessDuration":232.68534900000122,"rollupCircuitsDuration":359.00266100000044,"txCount":1,"blockNumber":1,"blockTimestamp":1750188981,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:32:02 [19:32:02.593] VERBOSE: sequencer Attesting committee is empty 19:32:02 [19:32:02.781] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.950] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf9e8519bab5025f2999ae35ba8a51690e8616d9e149460053d9151fed9a57df7 19:32:02 [19:32:02.950] VERBOSE: sequencer-client Sent L1 transaction 0xf9e8519bab5025f2999ae35ba8a51690e8616d9e149460053d9151fed9a57df7 {"gasLimit":514585,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 19:32:02 [19:32:02.960] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:32:02 [19:32:02.961] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf9e8519bab5025f2999ae35ba8a51690e8616d9e149460053d9151fed9a57df7","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750188981,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:32:02 [19:32:02.961] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:32:02 [19:32:02.975] INFO: blob-sink:server Received blob sidecar for block 0xdf161ee10840f9079b0d85d3f860caf0e5bcf2de3ed5a2a8ee86e3069a7e35b5 19:32:02 [19:32:02.980] INFO: blob-sink:server Blob sidecar stored successfully for block 0xdf161ee10840f9079b0d85d3f860caf0e5bcf2de3ed5a2a8ee86e3069a7e35b5 19:32:02 [19:32:02.984] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.988] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:32:02 [19:32:02.990] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:32:02 [19:32:02.991] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:32:03 [19:32:03.005] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750189017] on http://127.0.0.1:8545 19:32:03 [19:32:03.007] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:32:03 [19:32:03.008] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750189017 19:32:03 [19:32:03.008] WARN: foundation:test-date-provider Time set to 2025-06-17T19:36:57.000Z {"offset":293992,"timeMs":1750189017000} 19:32:03 [19:32:03.008] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 19:32:03 [19:32:03.188] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.341] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:32:03 [19:32:03.346] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2c939bbd3c2c0301f8ccf8585fe591805d918b5d23a8dc2925b9ee94eee28521","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2643230180,"blockNumber":1,"slotNumber":2,"timestamp":1750188981,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x16a01f5a109db648888938671f460a061023cfa5bb25fbb674ec376c44748248","archiveNextLeafIndex":2} 19:32:03 [19:32:03.351] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:32:03 [19:32:03.390] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.475] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":32.98408699999891,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750188981,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:32:03 [19:32:03.476] WARN: pxe:service No artifact found for contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 when looking for its metadata 19:32:03 [19:32:03.478] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 as part of deployment for 0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32 19:32:03 [19:32:03.544] VERBOSE: p2p Synched to latest block 1 19:32:03 [19:32:03.586] INFO: pxe:service Added contract EasyPrivateVoting at 0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32 with class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 19:32:03 [19:32:03.592] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.609] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x16a01f5a109db648888938671f460a061023cfa5bb25fbb674ec376c44748248","header":{"contentCommitment":{"blobsHash":"0x00ceee0a72105fa45223d8eaf19f35d29807bf96d3d01cc233f05e16376348b2","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750188981,"version":2643230180},"lastArchive":"0x1c6b7fde555824dbb39379631517338723709b497b8c855ba1e1838322fa2b22","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x03788fe79abc2dbc3cd0d4d7e6345dca093eb377935706d65236be0b1b601594","nullifierTree":"0x0953ab8b50ddb089cc9c44b760405d6b7c183276a583d44d5813a998757449ec","publicDataTree":"0x0bb8049061004785a912d9f9028c26e5814e1bfabfc813ad9588b80da8ae56fa"},"totalFees":6794052480,"totalManaUsed":20448}} 19:32:03 [19:32:03.678] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:03 [19:32:03.712] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:03 [19:32:03.712] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:03 [19:32:03.759] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:03 [19:32:03.763] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20a8688a418fddf6d62fa71f74de335a3595df40d6f40316b58d38932ecb60c9 19:32:03 [19:32:03.773] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:32:03 [19:32:03.774] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:32:03 [19:32:03.779] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:32:03 [19:32:03.780] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:32:03 [19:32:03.783] VERBOSE: pxe:service Added note {"index":0,"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1ec58d3bc757afcf95e8da9dd3fd63a4c004779d14829d962c9278618460374c","nullifier":"0x04546239428b0c0440c718a4e1606893a63d6e2acc0c9283b5ec3960a6ae406a"} 19:32:03 [19:32:03.785] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:03 [19:32:03.797] VERBOSE: simulator:client_execution_context:debug_log Setting 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 as fee payer 19:32:03 [19:32:03.800] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.827] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:32:04 [19:32:04.146] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x07c93431ee7228896e85ee48c35d1e5b5d747283021244321f1e2360b29dc702,0x0eb6620c85cc03233af00abd8ad2f32e9528f320b09af98beb73808818ac20da,0x13d6566bc501e38ffb391e30ee7b29055b9227558ad14198c97fbf4c5f80e599 19:32:04 [19:32:04.218] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:32:04 [19:32:04.270] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:04 [19:32:04.329] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 19:32:04 [19:32:04.340] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x16a01f5a109db648888938671f460a061023cfa5bb25fbb674ec376c44748248","blockNumber":2,"slot":3} 19:32:04 [19:32:04.368] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:32:04 [19:32:04.378] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32,0x0000000000000000000000000000000000000000000000000000000000000001,0x06762be4bcdbba7d3710c79d46ca0de160fa6b271888ec7edc6575a5382f8b2b,0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x0125cfb597f7e3e7637b6edc84d8ec192ed2ba9520f6b6123953dfc976be7e2e,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 19:32:04 [19:32:04.525] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:04 [19:32:04.758] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:05 [19:32:05.068] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:05 [19:32:05.070] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x16a01f5a109db648888938671f460a061023cfa5bb25fbb674ec376c44748248","blockNumber":2,"slot":3} 19:32:05 [19:32:05.321] INFO: pxe:service Proving completed in 1719.4832889999998ms {"timings":{"total":1719.4832889999998,"sync":9.373461999999563,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":195.15883899999608,"oracles":{"debugLog":{"times":[0.47423499999968044,0.3897020000003977,0.41049199999906705,0.5079599999990023,0.41830099999970116,0.344571999999971,0.35882800000035786,0.47725400000126683]},"fetchTaggedLogs":{"times":[48.093267000000196]},"loadCapsule":{"times":[0.20566899999903399,0.4113199999992503,0.5385829999995622,0.23477900000034424,0.1992019999997865,0.2127619999992021]},"getSharedSecret":{"times":[3.1630370000002586]},"aes128Decrypt":{"times":[0.9076079999995272,0.9204239999999118]},"getPublicKeysAndPartialAddress":{"times":[1.33621999999923]},"getKeyValidationRequest":{"times":[1.6488270000008924]},"deliverNote":{"times":[3.786984999998822]},"deleteCapsule":{"times":[0.3628870000011375]},"storeCapsule":{"times":[0.35017400000106136]},"getNotes":{"times":[1.5200459999996383]},"getAuthWitness":{"times":[0.2299700000003213]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0557570000000851]},"callPrivateFunction":{"times":[468.3565370000015,115.15917500000069]},"notifyEnqueuedPublicFunctionCall":{"times":[0.259079000001293]}}},{"functionName":"private_kernel_init","time":59.92095900000095},{"functionName":"ContractClassRegisterer:register","time":458.70821400000204,"oracles":{"loadCapsule":{"times":[3.5879120000008697]},"notifyCreatedNullifier":{"times":[0.2832299999990937]},"debugLog":{"times":[0.5038169999988895]},"notifyCreatedContractClassLog":{"times":[8.616922999999588]}}},{"functionName":"private_kernel_inner","time":106.94277899999906},{"functionName":"ContractInstanceDeployer:deploy","time":71.68867300000238,"oracles":{"storeInExecutionCache":{"times":[0.19313399999919056]},"callPrivateFunction":{"times":[39.78738599999997]},"notifyCreatedNullifier":{"times":[0.2860439999985829]},"debugLog":{"times":[0.4798510000000533]}}},{"functionName":"private_kernel_inner","time":107.15156000000025},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":31.162319999999454,"oracles":{}},{"functionName":"private_kernel_inner","time":111.96573299999909},{"functionName":"private_kernel_reset","time":167.015668},{"functionName":"private_kernel_tail","time":85.21993799999836}],"unaccounted":315.17514400000255}} 19:32:05 [19:32:05.353] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:05 [19:32:05.521] VERBOSE: p2p:tx_pool Adding tx 0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d to pool {"eventName":"tx-added-to-pool","txHash":"0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":151,"proofSize":172052,"size":322921,"feePaymentMethod":"fee_juice"} 19:32:05 [19:32:05.540] INFO: node Received tx 0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d {"txHash":"0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d"} 19:32:05 [19:32:05.540] INFO: pxe:service Sent transaction 0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d 19:32:05 [19:32:05.560] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:05 [19:32:05.590] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 19:32:05 [19:32:05.604] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-17T19:36:57.000Z","now":"2025-06-17T19:36:59.596Z"} 19:32:05 [19:32:05.766] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:05 [19:32:05.911] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x35393df3 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x35393df3","duration":82.98373199999878} 19:32:06 [19:32:06.062] VERBOSE: simulator:public-processor Processed tx 0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d with 1 public calls in 344.8857200000002ms {"txHash":"0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d","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":344.8857200000002} 19:32:06 [19:32:06.065] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.068] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.46322468599999955s {"duration":0.46322468599999955,"rate":133412.5789660529,"totalPublicGas":{"daGas":3072,"l2Gas":61800},"totalBlockGas":{"daGas":91648,"l2Gas":98344},"totalSizeInBytes":6144} 19:32:06 [19:32:06.205] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 100493.13607976871 mana/s {"blockHash":"0x15ef40d6d1f05b2e4db3c306384dfdff40f8220f6ff5c405e98e8d16e946d58e","globalVariables":{"chainId":31337,"version":2643230180,"blockNumber":2,"slotNumber":3,"timestamp":1750189017,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0723c26b6416837a785fca868d113b00b5f97ef0052d643b49e2cc2756697b1d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":614.3739519999999,"publicProcessDuration":463.5657220000012,"rollupCircuitsDuration":601.6244910000005,"txCount":1,"blockNumber":2,"blockTimestamp":1750189017,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 19:32:06 [19:32:06.207] VERBOSE: sequencer Attesting committee is empty 19:32:06 [19:32:06.303] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.490] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xd6eb28a3bf189ce038a1d9d0d5983cda1698ca426f870fe9f8bfdf3561f98e1a 19:32:06 [19:32:06.490] VERBOSE: sequencer-client Sent L1 transaction 0xd6eb28a3bf189ce038a1d9d0d5983cda1698ca426f870fe9f8bfdf3561f98e1a {"gasLimit":470251,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:32:06 [19:32:06.505] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:32:06 [19:32:06.505] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xd6eb28a3bf189ce038a1d9d0d5983cda1698ca426f870fe9f8bfdf3561f98e1a","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1750189017,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 19:32:06 [19:32:06.505] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:32:06 [19:32:06.507] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.515] INFO: blob-sink:server Received blob sidecar for block 0x61520d8cd2dfe524f2b2939b0cb4ab79d3d9f3c8de57b1fec4d0c11f391afe9d 19:32:06 [19:32:06.518] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:32:06 [19:32:06.521] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:32:06 [19:32:06.522] INFO: blob-sink:server Blob sidecar stored successfully for block 0x61520d8cd2dfe524f2b2939b0cb4ab79d3d9f3c8de57b1fec4d0c11f391afe9d 19:32:06 [19:32:06.524] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:32:06 [19:32:06.528] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750189053] on http://127.0.0.1:8545 19:32:06 [19:32:06.529] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:32:06 [19:32:06.530] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750189053 19:32:06 [19:32:06.531] WARN: foundation:test-date-provider Time set to 2025-06-17T19:37:33.000Z {"offset":326469,"timeMs":1750189053000} 19:32:06 [19:32:06.531] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 19:32:06 [19:32:06.712] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.914] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.154] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.171] VERBOSE: archiver:block-helper Store contract instance at 0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32 19:32:07 [19:32:07.177] VERBOSE: archiver:block-helper Store contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 19:32:07 [19:32:07.194] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x15ef40d6d1f05b2e4db3c306384dfdff40f8220f6ff5c405e98e8d16e946d58e","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2643230180,"blockNumber":2,"slotNumber":3,"timestamp":1750189017,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x28e3a59dec9e932e19502a5fe18ba3177ff9786b729266ee5c3973842ce5bbae","archiveNextLeafIndex":3} 19:32:07 [19:32:07.199] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:32:07 [19:32:07.274] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.438459999999395,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750189017,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 19:32:07 [19:32:07.312] VERBOSE: p2p Synched to latest block 2 19:32:07 [19:32:07.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.550] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x28e3a59dec9e932e19502a5fe18ba3177ff9786b729266ee5c3973842ce5bbae","blockNumber":3,"slot":4} 19:32:07 [19:32:07.562] INFO: aztecjs:deploy_sent_tx Contract 0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32 successfully deployed. 19:32:07 [19:32:07.562] INFO: e2e:e2e_private_voting_contract Counter contract deployed at 0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32 19:32:07 [19:32:07.564] INFO: e2e:e2e_private_voting_contract Running test: e2e_voting_contract votes votes, then tries to vote again 19:32:07 [19:32:07.567] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.588] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x28e3a59dec9e932e19502a5fe18ba3177ff9786b729266ee5c3973842ce5bbae","header":{"contentCommitment":{"blobsHash":"0x00e21d679d6157a9413f13b7d195d8d30ff4beb95b13847c494fc5de46d56ed3","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750189017,"version":2643230180},"lastArchive":"0x16a01f5a109db648888938671f460a061023cfa5bb25fbb674ec376c44748248","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x03788fe79abc2dbc3cd0d4d7e6345dca093eb377935706d65236be0b1b601594","nullifierTree":"0x0a4556fd32a69daf59c77246d1e688a294787518a42f0ff5e01b5da7b7a8885b","publicDataTree":"0x2cd797bfca0eebb49d5e527cf14286348096a01a2913ca4c1edad8ad007fa282"},"totalFees":32675777440,"totalManaUsed":98344}} 19:32:07 [19:32:07.655] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:07 [19:32:07.689] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:07 [19:32:07.689] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:07 [19:32:07.742] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:07 [19:32:07.748] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20a8688a418fddf6d62fa71f74de335a3595df40d6f40316b58d38932ecb60c9 19:32:07 [19:32:07.757] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:32:07 [19:32:07.758] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:32:07 [19:32:07.763] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:32:07 [19:32:07.764] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:32:07 [19:32:07.766] VERBOSE: pxe:service Added note {"index":0,"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1ec58d3bc757afcf95e8da9dd3fd63a4c004779d14829d962c9278618460374c","nullifier":"0x04546239428b0c0440c718a4e1606893a63d6e2acc0c9283b5ec3960a6ae406a"} 19:32:07 [19:32:07.768] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:07 [19:32:07.770] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.782] VERBOSE: simulator:client_execution_context:debug_log Setting 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 as fee payer 19:32:07 [19:32:07.804] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32"} 19:32:07 [19:32:07.977] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.397] INFO: pxe:service Proving completed in 819.1574339999988ms {"timings":{"total":819.1574339999988,"sync":11.423349000000599,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":187.7732219999998,"oracles":{"debugLog":{"times":[0.43471599999975297,0.38293999999950756,0.40006999999968684,0.5449630000002799,0.41507199999978184,0.36524699999972654,0.3190660000000207,0.46839399999953457]},"fetchTaggedLogs":{"times":[56.877418000000034]},"loadCapsule":{"times":[0.22491200000149547,0.16371799999978975,0.33312000000114494,0.1948630000006233,0.16148900000007416,0.18521999999938998]},"getSharedSecret":{"times":[2.8164230000002135]},"aes128Decrypt":{"times":[0.2391879999995581,0.8465999999989435]},"getPublicKeysAndPartialAddress":{"times":[1.4721150000004855]},"getKeyValidationRequest":{"times":[1.588445999999749]},"deliverNote":{"times":[2.4537010000003647]},"deleteCapsule":{"times":[0.2348729999994248]},"storeCapsule":{"times":[0.21459200000026613]},"getNotes":{"times":[4.283368000000337]},"getAuthWitness":{"times":[0.20201999999881082]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06467999999949825]},"callPrivateFunction":{"times":[40.850554999999076]}}},{"functionName":"private_kernel_init","time":55.214436000000205},{"functionName":"EasyPrivateVoting:cast_vote","time":32.01206700000148,"oracles":{"getPublicKeysAndPartialAddress":{"times":[4.3724290000009205]},"getKeyValidationRequest":{"times":[1.5774939999992057]},"notifyCreatedNullifier":{"times":[0.2268019999992248]},"storeInExecutionCache":{"times":[0.049187000000529224]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06518700000015087]}}},{"functionName":"private_kernel_inner","time":108.4255319999993},{"functionName":"private_kernel_reset","time":185.07070899999962},{"functionName":"private_kernel_tail","time":84.65559500000018}],"unaccounted":154.58252399999765}} 19:32:08 [19:32:08.424] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.436] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x28e3a59dec9e932e19502a5fe18ba3177ff9786b729266ee5c3973842ce5bbae","blockNumber":3,"slot":4} 19:32:08 [19:32:08.457] VERBOSE: p2p:tx_pool Adding tx 0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4 to pool {"eventName":"tx-added-to-pool","txHash":"0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226313,"feePaymentMethod":"fee_juice"} 19:32:08 [19:32:08.466] INFO: node Received tx 0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4 {"txHash":"0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4"} 19:32:08 [19:32:08.467] INFO: pxe:service Sent transaction 0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4 19:32:08 [19:32:08.627] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.832] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.957] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 19:32:08 [19:32:08.971] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-17T19:37:33.000Z","now":"2025-06-17T19:37:35.440Z"} 19:32:09 [19:32:09.023] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5f06617e completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5f06617e","duration":22.654324999999517} 19:32:09 [19:32:09.033] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.041] VERBOSE: simulator:public-processor Processed tx 0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4 with 1 public calls in 57.084406999998464ms {"txHash":"0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4","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":57.084406999998464} 19:32:09 [19:32:09.043] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0717112419999994s {"duration":0.0717112419999994,"rate":331217.244849841,"totalPublicGas":{"daGas":512,"l2Gas":23752},"totalBlockGas":{"daGas":2048,"l2Gas":54952},"totalSizeInBytes":352} 19:32:09 [19:32:09.162] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 115642.99513663088 mana/s {"blockHash":"0x115bd702c2269455d20153046b54d0173fac3dede311609c4e362aab5faa1b0a","globalVariables":{"chainId":31337,"version":2643230180,"blockNumber":3,"slotNumber":4,"timestamp":1750189053,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x102b136711cc8199f84d99613e2db91a9ea086740d131aa7ebd2e4595efacca4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":204.8797109999996,"publicProcessDuration":72.02623500000118,"rollupCircuitsDuration":192.06424199999856,"txCount":1,"blockNumber":3,"blockTimestamp":1750189053,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:09 [19:32:09.164] VERBOSE: sequencer Attesting committee is empty 19:32:09 [19:32:09.250] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.425] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x38ac85191de8ac3fdbbe15df5733eef15772c928187edece4e5bd23f6e811181 19:32:09 [19:32:09.425] VERBOSE: sequencer-client Sent L1 transaction 0x38ac85191de8ac3fdbbe15df5733eef15772c928187edece4e5bd23f6e811181 {"gasLimit":470298,"maxFeePerGas":"1.279583398","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:32:09 [19:32:09.435] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:32:09 [19:32:09.435] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x38ac85191de8ac3fdbbe15df5733eef15772c928187edece4e5bd23f6e811181","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750189053,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:09 [19:32:09.436] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:32:09 [19:32:09.438] INFO: blob-sink:server Received blob sidecar for block 0x5c6e8c15021e4625c2a259e99944876e178103220ad426b3cd18afeed74b5d4f 19:32:09 [19:32:09.441] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5c6e8c15021e4625c2a259e99944876e178103220ad426b3cd18afeed74b5d4f 19:32:09 [19:32:09.453] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.459] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 19:32:09 [19:32:09.461] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 19:32:09 [19:32:09.462] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 19:32:09 [19:32:09.471] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750189089] on http://127.0.0.1:8545 19:32:09 [19:32:09.472] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:32:09 [19:32:09.474] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750189089 19:32:09 [19:32:09.474] WARN: foundation:test-date-provider Time set to 2025-06-17T19:38:09.000Z {"offset":359526,"timeMs":1750189089000} 19:32:09 [19:32:09.474] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 19:32:09 [19:32:09.621] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x115bd702c2269455d20153046b54d0173fac3dede311609c4e362aab5faa1b0a","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2643230180,"blockNumber":3,"slotNumber":4,"timestamp":1750189053,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x26f851b1ec731069fa67f663a6acbcbc4357b1093e5b30f335e95e507a1ceadb","archiveNextLeafIndex":4} 19:32:09 [19:32:09.623] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 19:32:09 [19:32:09.657] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.729] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.628693000002386,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750189053,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:09 [19:32:09.734] VERBOSE: p2p Synched to latest block 3 19:32:09 [19:32:09.859] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.953] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x26f851b1ec731069fa67f663a6acbcbc4357b1093e5b30f335e95e507a1ceadb","blockNumber":4,"slot":5} 19:32:10 [19:32:10.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:10 [19:32:10.263] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:10 [19:32:10.463] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x26f851b1ec731069fa67f663a6acbcbc4357b1093e5b30f335e95e507a1ceadb","blockNumber":4,"slot":5} 19:32:10 [19:32:10.465] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:10 [19:32:10.477] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x26f851b1ec731069fa67f663a6acbcbc4357b1093e5b30f335e95e507a1ceadb","header":{"contentCommitment":{"blobsHash":"0x006c695c8c537716e9f28c6526cf84cdaf2b53255fa90529ccc16698f1158324","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750189053,"version":2643230180},"lastArchive":"0x28e3a59dec9e932e19502a5fe18ba3177ff9786b729266ee5c3973842ce5bbae","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x03788fe79abc2dbc3cd0d4d7e6345dca093eb377935706d65236be0b1b601594","nullifierTree":"0x2f04312075c4525be254f7db99bf892cf616e5671cb89e0ab3642e4001dc2ebc","publicDataTree":"0x1e6904dcbdb4b0bb7a3a7247b5f61d0039e527f70c529ad73dfad1b83a90f9d8"},"totalFees":18258351520,"totalManaUsed":54952}} 19:32:10 [19:32:10.501] VERBOSE: simulator Executing utility function get_vote {"contract":"0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32","selector":"0x50ac913f"} 19:32:10 [19:32:10.509] VERBOSE: simulator Utility simulation for 0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32.0x50ac913f completed 19:32:10 [19:32:10.521] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 {"origin":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000009d8c7de4","authWitnesses":["0x18d5e0b86c35b7810fae3c65430d5622d3f504d0cf62425f129f585185b26195"]} 19:32:10 [19:32:10.584] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:10 [19:32:10.618] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:10 [19:32:10.619] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:10 [19:32:10.660] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:10 [19:32:10.664] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20a8688a418fddf6d62fa71f74de335a3595df40d6f40316b58d38932ecb60c9 19:32:10 [19:32:10.666] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:10 [19:32:10.677] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:32:10 [19:32:10.677] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:32:10 [19:32:10.683] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:32:10 [19:32:10.683] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:32:10 [19:32:10.686] VERBOSE: pxe:service Added note {"index":0,"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1ec58d3bc757afcf95e8da9dd3fd63a4c004779d14829d962c9278618460374c","nullifier":"0x04546239428b0c0440c718a4e1606893a63d6e2acc0c9283b5ec3960a6ae406a"} 19:32:10 [19:32:10.688] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:10 [19:32:10.700] VERBOSE: simulator:client_execution_context:debug_log Setting 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 as fee payer 19:32:10 [19:32:10.723] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32"} 19:32:10 [19:32:10.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:11 [19:32:11.324] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:11 [19:32:11.342] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x26f851b1ec731069fa67f663a6acbcbc4357b1093e5b30f335e95e507a1ceadb","blockNumber":4,"slot":5} 19:32:11 [19:32:11.347] VERBOSE: node Simulating public calls for tx 0x0557fcf14e9ac77c67dcf39c8e671c90ab7dc352a242a8bc21ce151186b09db8 {"globalVariables":{"chainId":31337,"version":2643230180,"blockNumber":4,"slotNumber":5,"timestamp":1750189089,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHash":"0x0557fcf14e9ac77c67dcf39c8e671c90ab7dc352a242a8bc21ce151186b09db8","blockNumber":4} 19:32:11 [19:32:11.365] VERBOSE: simulator:state_manager Siloed nullifier 0x100ad2c6704ccb738bc20519003b93314743a23123e030890ea71b65f8690136 already present in tree! 19:32:11 [19:32:11.369] WARN: simulator:public_tx_context APP_LOGIC phase reverted! insertRevertiblesFromPrivate failed with reason: Nullifier collision encountered when inserting revertible nullifiers from private 19:32:11 Details: Siloed nullifier 0x100ad2c6704ccb738bc20519003b93314743a23123e030890ea71b65f8690136 already exists in parent cache or host. 19:32:11 Error stack: NullifierCollisionError: Siloed nullifier 0x100ad2c6704ccb738bc20519003b93314743a23123e030890ea71b65f8690136 already exists in parent cache or host. 19:32:11 at PublicPersistableStateManager.writeSiloedNullifier (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/state_manager/state_manager.js:190:23) 19:32:11 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:263:17) 19:32:11 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:33:24) 19:32:11 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:54:29) 19:32:11 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:14:25) 19:32:11 at PublicProcessor.processTxWithPublicCalls (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:321:91) 19:32:11 at PublicProcessor.processTxWithinDeadline (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:268:20) 19:32:11 at elapsed (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/timer/elapsed.js:8:20) 19:32:11 at PublicProcessor.processTx (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:221:53) 19:32:11 at PublicProcessor.process (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:159:53) 19:32:11 at AztecNodeService.simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:718:66) 19:32:11 at PXEService.#simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:241:28) 19:32:11 at /home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:580:36 19:32:11 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 19:32:11 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 19:32:11 [19:32:11.386] VERBOSE: simulator:public-processor Processed tx 0x0557fcf14e9ac77c67dcf39c8e671c90ab7dc352a242a8bc21ce151186b09db8 with 1 public calls in 27.169268999998167ms {"txHash":"0x0557fcf14e9ac77c67dcf39c8e671c90ab7dc352a242a8bc21ce151186b09db8","txFee":1581840000,"revertCode":1,"revertReason":{"originalMessage":"Nullifier collision encountered when inserting revertible nullifiers from private\nDetails: Siloed nullifier 0x100ad2c6704ccb738bc20519003b93314743a23123e030890ea71b65f8690136 already exists in parent cache or host.\nError stack: NullifierCollisionError: Siloed nullifier 0x100ad2c6704ccb738bc20519003b93314743a23123e030890ea71b65f8690136 already exists in parent cache or host.\n at PublicPersistableStateManager.writeSiloedNullifier (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/state_manager/state_manager.js:190:23)\n at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:263:17)\n at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:33:24)\n at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:54:29)\n at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:14:25)\n at PublicProcessor.processTxWithPublicCalls (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:321:91)\n at PublicProcessor.processTxWithinDeadline (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:268:20)\n at elapsed (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/timer/elapsed.js:8:20)\n at PublicProcessor.processTx (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:221:53)\n at PublicProcessor.process (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:159:53)\n at AztecNodeService.simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:718:66)\n at PXEService.#simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:241:28)\n at /home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:580:36\n at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33\n at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17)","functionErrorStack":[],"revertData":[]},"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":31200},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0},"billedGas":{"daGas":1536,"l2Gas":31200}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":27.169268999998167} 19:32:11 [19:32:11.387] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03428347399999984s {"duration":0.03428347399999984,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":31200},"totalSizeInBytes":256} 19:32:11 [19:32:11.388] ERROR: pxe:service Failed to enrich public simulation error: TypeError: Cannot read properties of undefined (reading 'contractAddress') 19:32:11 [19:32:11.465] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:11 [19:32:11.499] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:11 [19:32:11.499] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:11 [19:32:11.532] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:11 [19:32:11.541] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5"} 19:32:11 [19:32:11.548] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x20a8688a418fddf6d62fa71f74de335a3595df40d6f40316b58d38932ecb60c9 19:32:11 [19:32:11.566] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:32:11 [19:32:11.567] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:32:11 [19:32:11.572] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:32:11 [19:32:11.573] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:32:11 [19:32:11.594] VERBOSE: pxe:service Added note {"index":0,"contract":"0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1ec58d3bc757afcf95e8da9dd3fd63a4c004779d14829d962c9278618460374c","nullifier":"0x04546239428b0c0440c718a4e1606893a63d6e2acc0c9283b5ec3960a6ae406a"} 19:32:11 [19:32:11.596] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:11 [19:32:11.607] VERBOSE: simulator:client_execution_context:debug_log Setting 0x195e3e1ebaeff1be40fc60e082804177db8fbffdbabda7f591b7d458ddf9cfb5 as fee payer 19:32:11 [19:32:11.670] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x26736256f45c9fb311c275fbf0aa9bfa0b4155ead0e7ce2e6a42e7692d8efd32"} 19:32:11 [19:32:11.762] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:12 [19:32:12.001] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:12 [19:32:12.004] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x26f851b1ec731069fa67f663a6acbcbc4357b1093e5b30f335e95e507a1ceadb","blockNumber":4,"slot":5} 19:32:12 [19:32:12.255] INFO: pxe:service Proving completed in 854.4429610000007ms {"timings":{"total":854.4429610000007,"sync":2.632955999997648,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":201.00839800000176,"oracles":{"debugLog":{"times":[0.44546899999841116,0.40659299999970244,0.4272560000026715,0.5186219999995956,0.4538460000003397,0.47140899999794783,0.35595200000170735,0.42220999999699416]},"fetchTaggedLogs":{"times":[46.02446699999928]},"loadCapsule":{"times":[0.2560880000019097,1.2927490000001853,0.43360500000198954,0.22050300000046263,0.1462439999995695,0.18391300000075717]},"getSharedSecret":{"times":[11.50925400000051]},"aes128Decrypt":{"times":[0.26623400000244146,0.8979260000014619]},"getPublicKeysAndPartialAddress":{"times":[2.1374550000000454]},"getKeyValidationRequest":{"times":[1.228530000000319]},"deliverNote":{"times":[21.353158000001713]},"deleteCapsule":{"times":[0.24001599999974133]},"storeCapsule":{"times":[0.19951599999694736]},"getNotes":{"times":[1.2293289999979606]},"getAuthWitness":{"times":[0.18549300000086077]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05975799999941955]},"callPrivateFunction":{"times":[77.3612600000015]}}},{"functionName":"private_kernel_init","time":59.64297699999952},{"functionName":"EasyPrivateVoting:cast_vote","time":68.77778799999942,"oracles":{"getPublicKeysAndPartialAddress":{"times":[1.2290659999998752]},"getKeyValidationRequest":{"times":[1.1591590000025462]},"notifyCreatedNullifier":{"times":[0.17064899999968475]},"storeInExecutionCache":{"times":[0.03559999999924912]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05330099999991944]}}},{"functionName":"private_kernel_inner","time":105.77209999999832},{"functionName":"private_kernel_reset","time":173.11475000000064},{"functionName":"private_kernel_tail","time":81.3433449999975}],"unaccounted":162.15064700000585}} 19:32:12 [19:32:12.282] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:12 [19:32:12.303] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x1fbc1add03e7f04398a838ccad0ccf8a7bc588b1fbfeccb7e706ecbb2108c55b for repeating a nullifier 19:32:12 [19:32:12.306] WARN: node Received invalid tx 0x1fbc1add03e7f04398a838ccad0ccf8a7bc588b1fbfeccb7e706ecbb2108c55b: Existing nullifier {"txHash":"0x1fbc1add03e7f04398a838ccad0ccf8a7bc588b1fbfeccb7e706ecbb2108c55b"} 19:32:12 [19:32:12.310] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 19:32:12 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 19:32:12 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 19:32:12 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 19:32:12 [19:32:12.312] INFO: node Stopping 19:32:12 [19:32:12.313] INFO: slasher Slasher client stopped. 19:32:12 [19:32:12.313] INFO: sequencer Stopped sequencer 19:32:12 [19:32:12.313] INFO: p2p P2P client stopped. 19:32:12 [19:32:12.315] INFO: world_state Stopped world state synchronizer 19:32:12 [19:32:12.315] INFO: archiver Stopped. 19:32:12 [19:32:12.315] INFO: node Stopped 19:32:12 [19:32:12.315] VERBOSE: e2e:e2e_private_voting_contract Cleaning up ACVM state 19:32:12 [19:32:12.315] INFO: e2e:e2e_private_voting_contract Cleaning up ACVM temp directory /tmp/4da00107 19:32:12 [19:32:12.316] VERBOSE: e2e:e2e_private_voting_contract Cleaning up BB state 19:32:12 [19:32:12.325] INFO: blob-sink:server Stopping blob sink 19:32:12 [19:32:12.325] INFO: blob-sink:server Blob sink stopped 19:32:12 [19:32:12.325] VERBOSE: e2e:e2e_private_voting_contract Cleaning up data directory at /tmp/29f5c7462a84b340 19:32:12 PASS src/e2e_private_voting_contract.test.ts 19:32:12 e2e_voting_contract 19:32:12 votes 19:32:12 ✓ votes, then tries to vote again (4747 ms) 19:32:12 19:32:12 Test Suites: 1 passed, 1 total 19:32:12 Tests: 1 passed, 1 total 19:32:12 Snapshots: 0 total 19:32:12 Time: 19.01 s 19:32:12 Ran all test suites matching /src\/e2e_private_voting_contract.test.ts/i. 19:32:12 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?