Parent Log: http://ci.aztec-labs.com/5b033f030d6cee54 Command: 53e9b8d3e8ba3411:ISOLATE=1:NAME=e2e_private_voting_contract yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_private_voting_contract.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/f4ac84d7ac4041d505399edd8819840bb14d6c9d Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 17:08:47 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15005_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_f9aac7f8d569bb18_master 17:08:47 +++ id -u 17:08:47 +++ id -g 17:08:47 ++ 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'\''' 17:08:47 + cid=3763ee382f81a0587be22f3bd342221141474d881fc79dc38fd3ee658bed150e 17:08:47 + set +x 17:08:48 {"level":25,"time":1749834528610,"pid":12,"hostname":"3763ee382f81","module":"logger","msg":"Logger initialized with level verbose"} 17:08:54 [17:08:54.943] INFO: e2e:e2e_private_voting_contract Logging metrics to log/unknown.jsonl 17:08:55 [17:08:55.208] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-nhibNH/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:08:55 [17:08:55.244] INFO: e2e:e2e_private_voting_contract Calling anvil_setBlockTimestampInterval with params: [12] 17:08:55 [17:08:55.270] WARN: e2e:e2e_private_voting_contract Set block interval to 12 17:08:55 [17:08:55.271] VERBOSE: e2e:e2e_private_voting_contract Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:55 [17:08:55.319] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:08:55 [17:08:55.329] VERBOSE: e2e:e2e_private_voting_contract Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:08:55 [17:08:55.346] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:08:55 [17:08:55.351] VERBOSE: e2e:e2e_private_voting_contract Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:08:55 [17:08:55.367] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:08:55 [17:08:55.372] VERBOSE: e2e:e2e_private_voting_contract Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:08:55 [17:08:55.393] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:08:55 [17:08:55.398] VERBOSE: e2e:e2e_private_voting_contract Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:08:55 [17:08:55.415] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:08:55 [17:08:55.421] VERBOSE: e2e:e2e_private_voting_contract Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:08:55 [17:08:55.431] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:08:55 [17:08:55.436] VERBOSE: e2e:e2e_private_voting_contract Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:08:55 [17:08:55.436] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 17:08:55 [17:08:55.437] INFO: e2e:e2e_private_voting_contract Waiting for 6 transactions to be mined... 17:08:55 [17:08:55.456] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:08:55 [17:08:55.471] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:08:55 [17:08:55.471] VERBOSE: e2e:e2e_private_voting_contract Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:08:55 [17:08:55.482] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:08:55 [17:08:55.500] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:08:55 [17:08:55.507] VERBOSE: e2e:e2e_private_voting_contract Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:08:55 [17:08:55.519] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:08:55 [17:08:55.519] VERBOSE: e2e:e2e_private_voting_contract Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:08:55 [17:08:55.540] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:08:55 [17:08:55.547] VERBOSE: e2e:e2e_private_voting_contract Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:08:55 [17:08:55.562] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:08:55 [17:08:55.563] VERBOSE: e2e:e2e_private_voting_contract Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:08:55 [17:08:55.563] VERBOSE: e2e:e2e_private_voting_contract Waiting for deployments to complete 17:08:55 [17:08:55.563] INFO: e2e:e2e_private_voting_contract Waiting for 8 transactions to be mined... 17:08:55 [17:08:55.584] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:08:55 [17:08:55.593] VERBOSE: e2e:e2e_private_voting_contract Deployed shared contracts 17:08:55 [17:08:55.609] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:08:55 [17:08:55.610] VERBOSE: e2e:e2e_private_voting_contract Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:08:55 [17:08:55.613] VERBOSE: e2e:e2e_private_voting_contract Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:55 [17:08:55.631] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:08:55 [17:08:55.651] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:08:55 [17:08:55.656] VERBOSE: e2e:e2e_private_voting_contract Awaiting for linked libraries to be deployed 17:08:55 [17:08:55.698] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x26f844c131f980771793a16257df19e39a8b7f3f0cbf2181aaafa2e21ee268ef {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:08:55 [17:08:55.704] VERBOSE: e2e:e2e_private_voting_contract Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:55 [17:08:55.704] INFO: e2e:e2e_private_voting_contract Waiting for 9 transactions to be mined... 17:08:55 [17:08:55.725] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:08:55 [17:08:55.726] VERBOSE: e2e:e2e_private_voting_contract All core contracts have been deployed 17:08:55 [17:08:55.741] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:08:55 [17:08:55.742] VERBOSE: e2e:e2e_private_voting_contract Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 17:08:55 [17:08:55.753] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 17:08:55 [17:08:55.759] VERBOSE: e2e:e2e_private_voting_contract Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:08:55 [17:08:55.780] VERBOSE: e2e:e2e_private_voting_contract Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 17:08:55 [17:08:55.780] VERBOSE: e2e:e2e_private_voting_contract Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 17:08:55 [17:08:55.780] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 17:08:55 [17:08:55.797] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:08:55 [17:08:55.803] VERBOSE: e2e:e2e_private_voting_contract Rollup deployed 17:08:55 [17:08:55.804] VERBOSE: e2e:e2e_private_voting_contract Waiting for rollup and slash factory to be deployed 17:08:55 [17:08:55.804] INFO: e2e:e2e_private_voting_contract Waiting for 10 transactions to be mined... 17:08:55 [17:08:55.823] INFO: e2e:e2e_private_voting_contract All transactions mined successfully 17:08:55 [17:08:55.823] VERBOSE: e2e:e2e_private_voting_contract All transactions for L1 deployment have been mined 17:08:55 [17:08:55.843] INFO: e2e:e2e_private_voting_contract Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 17:08:55 [17:08:55.846] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:08:55 [17:08:55.848] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:55 [17:08:55.848] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:08:55 [17:08:55.849] INFO: telemetry:client Using NoopTelemetryClient 17:08:55 [17:08:55.854] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/98c215ad284b01d6/blob-sink with map size 134217728 KB (LMDB v2) 17:08:55 [17:08:55.855] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:08:55 [17:08:55.855] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:08:55 [17:08:55.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:55 [17:08:55.861] INFO: aztecjs:utils:watcher New L1 time: 1749834774 17:08:55 [17:08:55.861] WARN: foundation:test-date-provider Time set to 2025-06-13T17:12:54.000Z {"offset":238139,"timeMs":1749834774000} 17:08:55 [17:08:55.863] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:08:55 [17:08:55.871] INFO: blob-sink:server Server is running on http://localhost:44339 17:08:55 [17:08:55.872] VERBOSE: e2e:e2e_private_voting_contract Creating and synching an aztec node... 17:08:55 [17:08:55.872] VERBOSE: e2e:e2e_private_voting_contract Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/b20f8785/acvm 17:08:55 [17:08:55.873] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:44339"} 17:08:55 [17:08:55.892] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:08:55 [17:08:55.893] INFO: archiver:lmdb Creating archiver data store at directory /tmp/98c215ad284b01d6/archiver with map size 134217728 KB (LMDB v2) 17:08:55 [17:08:55.894] INFO: archiver:lmdb Starting data store with maxReaders 16 17:08:56 [17:08:56.093] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.196] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:44339"} 17:08:56 [17:08:56.212] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:44339"} 17:08:56 [17:08:56.213] WARN: node:blob-sink:client No L1 consensus host urls configured 17:08:56 [17:08:56.213] WARN: node:blob-sink:client No archive client configured 17:08:56 [17:08:56.217] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xdbeee7c97e431057ab8f664c5d00c492e812de47b200987a2d47f491d75810f8 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x4994d854c6de57194cc7415b7f1ac60f1f54ad7ee4f318f717a20421ab525fe5","l1BlockNumber":16}} 17:08:56 [17:08:56.229] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xdbeee7c97e431057ab8f664c5d00c492e812de47b200987a2d47f491d75810f8","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:08:56 [17:08:56.236] INFO: world-state:database Creating world state data store at directory /tmp/98c215ad284b01d6/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:08:56 [17:08:56.258] INFO: world_state Created world state synchroniser with block history of 64 17:08:56 [17:08:56.258] WARN: node Aztec node is accepting fake proofs 17:08:56 [17:08:56.267] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/98c215ad284b01d6/p2p with map size 134217728 KB (LMDB v2) 17:08:56 [17:08:56.269] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:08:56 [17:08:56.270] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/98c215ad284b01d6/p2p-archive with map size 134217728 KB (LMDB v2) 17:08:56 [17:08:56.271] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:08:56 [17:08:56.271] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/98c215ad284b01d6/p2p-peers with map size 134217728 KB (LMDB v2) 17:08:56 [17:08:56.272] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:08:56 [17:08:56.273] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:08:56 [17:08:56.274] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:08:56 [17:08:56.277] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:08:56 [17:08:56.278] INFO: world_state Started world state synchronizer from block 1 17:08:56 [17:08:56.279] VERBOSE: world-state:block_stream Starting sync from block number 0 17:08:56 [17:08:56.281] INFO: p2p Starting p2p client from block 0 with empty mempools 17:08:56 [17:08:56.281] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:08:56 [17:08:56.283] INFO: slasher Slasher client initialized 17:08:56 [17:08:56.283] INFO: slasher Starting Slasher client... 17:08:56 [17:08:56.310] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:56 [17:08:56.310] VERBOSE: node All Aztec Node subsystems synced 17:08:56 [17:08:56.318] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.321] INFO: sequencer-client Deploying forwarder contract 17:08:56 [17:08:56.328] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:08:56 [17:08:56.340] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 17:08:56 [17:08:56.341] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 17:08:56 [17:08:56.345] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:56 [17:08:56.357] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:56 [17:08:56.357] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:08:56 [17:08:56.358] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/b20f8785/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:08:56 [17:08:56.549] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:08:56 [17:08:56.551] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:56 [17:08:56.552] INFO: node Aztec Node version: 0.87.8 17:08:56 [17:08:56.552] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 17:08:56 [17:08:56.553] VERBOSE: e2e:e2e_private_voting_contract Creating a pxe... 17:08:56 [17:08:56.557] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.566] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/efefd8c3ad710ac8/pxe_data with map size 134217728 KB (LMDB v2) 17:08:56 [17:08:56.579] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0386d35a73fd2f3baa3cb7844279b8649ae189243d946725e99c58a70d1dec4c","blockNumber":1,"slot":2} 17:08:56 [17:08:56.581] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:08:56 [17:08:56.780] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:56 [17:08:56.887] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:08:56 [17:08:56.888] INFO: pxe:service Started PXE connected to chain 31337 version 341756598 17:08:56 [17:08:56.953] INFO: pxe:service Registered account 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb 17:08:57 [17:08:57.026] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:57 [17:08:57.028] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:08:57 [17:08:57.031] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb 17:08:57 [17:08:57.180] INFO: pxe:service Added contract SchnorrAccount at 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:57 [17:08:57.190] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0386d35a73fd2f3baa3cb7844279b8649ae189243d946725e99c58a70d1dec4c","blockNumber":1,"slot":2} 17:08:57 [17:08:57.216] VERBOSE: pxe:block_stream Starting sync from block number 0 17:08:57 [17:08:57.237] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:57 [17:08:57.279] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:57 [17:08:57.321] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:58 [17:08:58.065] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:08:58 [17:08:58.193] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:58 [17:08:58.291] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:58 [17:08:58.438] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:08:58 [17:08:58.490] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0386d35a73fd2f3baa3cb7844279b8649ae189243d946725e99c58a70d1dec4c","blockNumber":1,"slot":2} 17:08:58 [17:08:58.503] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:58 [17:08:58.504] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:08:58 [17:08:58.507] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:58 [17:08:58.560] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:08:58 [17:08:58.565] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:58 [17:08:58.723] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:58 [17:08:58.757] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:08:58 [17:08:58.807] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:58 [17:08:58.808] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:08:58 [17:08:58.858] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:08:58 [17:08:58.861] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:58 [17:08:58.873] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb as fee payer 17:08:59 [17:08:59.045] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:59 [17:08:59.262] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0386d35a73fd2f3baa3cb7844279b8649ae189243d946725e99c58a70d1dec4c","blockNumber":1,"slot":2} 17:08:59 [17:08:59.267] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:59 [17:08:59.485] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:59 [17:08:59.760] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:59 [17:08:59.910] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0386d35a73fd2f3baa3cb7844279b8649ae189243d946725e99c58a70d1dec4c","blockNumber":1,"slot":2} 17:09:00 [17:09:00.320] INFO: pxe:service Proving completed in 3105.2676229999997ms {"timings":{"total":3105.2676229999997,"sync":2.806273999998666,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":158.8472380000003,"oracles":{"callPrivateFunction":{"times":[1002.3842380000006,370.04492199999913,232.28281400000014]}}},{"functionName":"private_kernel_init","time":110.60565200000019},{"functionName":"ContractClassRegisterer:register","time":984.3556879999978,"oracles":{"loadCapsule":{"times":[32.243961999998646]},"notifyCreatedNullifier":{"times":[1.062184000000343]},"debugLog":{"times":[1.128525999998601]},"notifyCreatedContractClassLog":{"times":[11.450730000000476]}}},{"functionName":"private_kernel_inner","time":203.36976700000014},{"functionName":"SchnorrAccount:constructor","time":331.24640999999974,"oracles":{"getContractInstance":{"times":[6.793523999998797]},"debugLog":{"times":[0.8865200000000186,0.6822859999992943]},"fetchTaggedLogs":{"times":[59.93473999999878]},"loadCapsule":{"times":[0.4204200000003766,0.28064699999958975,0.2807760000014241]},"notifyCreatedNullifier":{"times":[0.2636549999988347,0.32470699999976205]},"notifyCreatedNote":{"times":[0.424909999999727]},"getRandomField":{"times":[0.46310100000118837,0.2877970000008645,0.08693099999982223,0.045080999998390325,0.038419999998950516,0.0814219999992929,0.03837099999873317,0.042760999998790794,0.12106200000016543,0.07461100000000442,0.03476000000046042]},"getIndexedTaggingSecretAsSender":{"times":[31.39765200000147]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.66525299999921]}}},{"functionName":"private_kernel_inner","time":156.29207799999858},{"functionName":"SchnorrAccount:entrypoint","time":192.19880400000147,"oracles":{"debugLog":{"times":[0.6590550000000803,0.28777699999955075,0.5715229999987059]},"fetchTaggedLogs":{"times":[51.89354800000001]},"loadCapsule":{"times":[0.22720500000104948,0.19517500000074506,0.19293500000094355]},"getNotes":{"times":[1.5458749999997963]},"getAuthWitness":{"times":[0.2721660000006523]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8795099999988452]}}},{"functionName":"private_kernel_inner","time":129.749726},{"functionName":"private_kernel_reset","time":185.02174100000047},{"functionName":"private_kernel_tail","time":85.22538499999973}],"unaccounted":565.5488600000026}} 17:09:00 [17:09:00.335] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.513] VERBOSE: p2p:tx_pool Adding tx 0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67 to pool {"eventName":"tx-added-to-pool","txHash":"0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:09:00 [17:09:00.539] INFO: node Received tx 0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67 {"txHash":"0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67"} 17:09:00 [17:09:00.539] INFO: pxe:service Sent transaction 0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67 17:09:00 [17:09:00.543] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.558] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:09:00 [17:09:00.575] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:13:18.000Z","now":"2025-06-13T17:12:58.714Z"} 17:09:00 [17:09:00.753] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.828] VERBOSE: simulator:public-processor Processed tx 0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67 with no public calls in 183.6893799999998ms {"txHash":"0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67","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":183.6893799999998} 17:09:00 [17:09:00.836] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.259213205s {"duration":0.259213205,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:09:00 [17:09:00.963] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:00 [17:09:00.974] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x24d8f28d9468cc46f146202adf1d35d599333f6112103bb09ca5920a1435522b","globalVariables":{"chainId":31337,"version":341756598,"blockNumber":1,"slotNumber":2,"timestamp":1749834798,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2b5b079d7b41b1cdd63ddf899822157f30fb047f8af1a5b2941f4d9d2d4c6c67"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":417.38990600000034,"publicProcessDuration":260.4939549999999,"rollupCircuitsDuration":400.38624100000015,"txCount":1,"blockNumber":1,"blockTimestamp":1749834798,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:09:00 [17:09:00.977] VERBOSE: sequencer Attesting committee is empty 17:09:01 [17:09:01.170] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.374] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.381] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4346fd4f13d60132d978d2bbe79802dfcdb73c14ece168f8f873492eb1d233b8 17:09:01 [17:09:01.381] VERBOSE: sequencer-client Sent L1 transaction 0x4346fd4f13d60132d978d2bbe79802dfcdb73c14ece168f8f873492eb1d233b8 {"gasLimit":514567,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:09:01 [17:09:01.395] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:01 [17:09:01.396] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4346fd4f13d60132d978d2bbe79802dfcdb73c14ece168f8f873492eb1d233b8","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1749834798,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:09:01 [17:09:01.396] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:01 [17:09:01.420] INFO: blob-sink:server Received blob sidecar for block 0x6867a04dfa2b159a84ea1d0d0c773ccb72c03a91a7fc281be7420c14e3188024 17:09:01 [17:09:01.429] INFO: blob-sink:server Blob sidecar stored successfully for block 0x6867a04dfa2b159a84ea1d0d0c773ccb72c03a91a7fc281be7420c14e3188024 17:09:01 [17:09:01.553] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:09:01 [17:09:01.559] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x24d8f28d9468cc46f146202adf1d35d599333f6112103bb09ca5920a1435522b","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":341756598,"blockNumber":1,"slotNumber":2,"timestamp":1749834798,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2718c25fcce905ffa18086a80fce6e2dea2f794a4307bd30194fa94811e735b2","archiveNextLeafIndex":2} 17:09:01 [17:09:01.581] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.586] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:09:01 [17:09:01.588] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:09:01 [17:09:01.590] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:09:01 [17:09:01.594] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834834] on http://127.0.0.1:8545 17:09:01 [17:09:01.596] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:01 [17:09:01.597] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834834 17:09:01 [17:09:01.598] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:54.000Z {"offset":292402,"timeMs":1749834834000} 17:09:01 [17:09:01.598] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:09:01 [17:09:01.679] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":34.80312000000049,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834798,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:09:01 [17:09:01.680] WARN: pxe:service No artifact found for contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 when looking for its metadata 17:09:01 [17:09:01.681] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 as part of deployment for 0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815 17:09:01 [17:09:01.760] VERBOSE: p2p Synched to latest block 1 17:09:01 [17:09:01.794] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:01 [17:09:01.819] INFO: pxe:service Added contract EasyPrivateVoting at 0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815 with class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 17:09:01 [17:09:01.846] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2718c25fcce905ffa18086a80fce6e2dea2f794a4307bd30194fa94811e735b2","header":{"contentCommitment":{"blobsHash":"0x0002a49310a12cb55219da118c3933e542b357487e7226ac197ddffcf88a74e3","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834798,"version":341756598},"lastArchive":"0x0386d35a73fd2f3baa3cb7844279b8649ae189243d946725e99c58a70d1dec4c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x07156371e4fa61fb9a7d2f7ca1a4c8bc9b67bea8decf86728a35c088408284b8","nullifierTree":"0x27914dd75ca859920639c89de37b55ef0f286136449508eabc1676b4a2e02454","publicDataTree":"0x17703da27b0b2b246e87d5e8a92a02648f3e589ac56b4cb88186d8dcf636b4e2"},"totalFees":6794052480,"totalManaUsed":20448}} 17:09:01 [17:09:01.930] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:01 [17:09:01.970] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:01 [17:09:01.970] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:01 [17:09:01.982] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2718c25fcce905ffa18086a80fce6e2dea2f794a4307bd30194fa94811e735b2","blockNumber":2,"slot":3} 17:09:02 [17:09:02.015] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.032] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:02 [17:09:02.039] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a7a53c18c28e895ba52a34cfb5d0b516ddd53ceedd80e371b8edff01877f72d 17:09:02 [17:09:02.049] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:02 [17:09:02.050] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:02 [17:09:02.063] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:02 [17:09:02.064] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:02 [17:09:02.074] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x06bdba2a19334b65e82d76f366e014408beba5b8a3cef567d9fc730a812d43c0","nullifier":"0x077b93ca906f542114514233ce3b97f69579a03c34197ed865fd2fb50ac11352"} 17:09:02 [17:09:02.083] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:02 [17:09:02.088] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:09:02 [17:09:02.102] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb as fee payer 17:09:02 [17:09:02.141] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:09:02 [17:09:02.679] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x07c93431ee7228896e85ee48c35d1e5b5d747283021244321f1e2360b29dc702,0x0eb6620c85cc03233af00abd8ad2f32e9528f320b09af98beb73808818ac20da,0x13d6566bc501e38ffb391e30ee7b29055b9227558ad14198c97fbf4c5f80e599 17:09:02 [17:09:02.805] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:09:02 [17:09:02.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:02 [17:09:02.919] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:09:02 [17:09:02.953] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2718c25fcce905ffa18086a80fce6e2dea2f794a4307bd30194fa94811e735b2","blockNumber":2,"slot":3} 17:09:02 [17:09:02.990] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:09:03 [17:09:03.064] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815,0x0000000000000000000000000000000000000000000000000000000000000001,0x153a9f25344bcb4661bf1dd0d91e3c9b37265cc4cae2e397eaeaaed77f5d6abc,0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82,0x1c5d0a88bc50d4c32213c35fda0cbadf6702309da0d90f2a93483e42f514966e,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb 17:09:03 [17:09:03.088] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.739] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:03 [17:09:03.755] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2718c25fcce905ffa18086a80fce6e2dea2f794a4307bd30194fa94811e735b2","blockNumber":2,"slot":3} 17:09:03 [17:09:03.986] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.436] INFO: pxe:service Proving completed in 2600.6961979999996ms {"timings":{"total":2600.6961979999996,"sync":12.724279000000024,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":263.5169729999998,"oracles":{"debugLog":{"times":[0.6374940000005154,0.41438899999957357,0.4268499999998312,0.4356900000002497,0.7396870000011404,0.4751909999995405,0.4526399999995192,0.6909450000002835]},"fetchTaggedLogs":{"times":[66.42081800000051]},"loadCapsule":{"times":[0.23758599999928265,0.2575349999988248,0.5421430000005785,0.9864319999996951,1.5864160000000993,2.4699860000000626]},"getSharedSecret":{"times":[3.572350999998889]},"aes128Decrypt":{"times":[1.0333940000000439,0.9189009999990958]},"getPublicKeysAndPartialAddress":{"times":[5.512475999999879]},"getKeyValidationRequest":{"times":[3.3509870000016235]},"deliverNote":{"times":[10.563710000000356]},"deleteCapsule":{"times":[3.157712000000174]},"storeCapsule":{"times":[1.594626000000062]},"getNotes":{"times":[2.797523999999612]},"getAuthWitness":{"times":[0.21169499999996333]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1045220000014524]},"callPrivateFunction":{"times":[746.4558280000001,223.22182799999973]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4193990000003396]}}},{"functionName":"private_kernel_init","time":81.20495400000073},{"functionName":"ContractClassRegisterer:register","time":733.8898430000008,"oracles":{"loadCapsule":{"times":[10.782655000000887]},"notifyCreatedNullifier":{"times":[0.6962050000001909]},"debugLog":{"times":[0.8897399999987101]},"notifyCreatedContractClassLog":{"times":[9.256310000000667]}}},{"functionName":"private_kernel_inner","time":125.74264199999925},{"functionName":"ContractInstanceDeployer:deploy","time":145.14107700000204,"oracles":{"storeInExecutionCache":{"times":[0.2542759999996633]},"callPrivateFunction":{"times":[134.35389000000032]},"notifyCreatedNullifier":{"times":[0.4382399999994959]},"debugLog":{"times":[0.6142140000010841]}}},{"functionName":"private_kernel_inner","time":110.23419699999977},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":59.589631999999256,"oracles":{}},{"functionName":"private_kernel_inner","time":121.4053729999996},{"functionName":"private_kernel_reset","time":186.0483089999998},{"functionName":"private_kernel_tail","time":123.54200200000014}],"unaccounted":637.6569169999984}} 17:09:04 [17:09:04.470] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.672] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2718c25fcce905ffa18086a80fce6e2dea2f794a4307bd30194fa94811e735b2","blockNumber":2,"slot":3} 17:09:04 [17:09:04.683] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:04 [17:09:04.687] VERBOSE: p2p:tx_pool Adding tx 0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce to pool {"eventName":"tx-added-to-pool","txHash":"0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":151,"proofSize":172052,"size":322921,"feePaymentMethod":"fee_juice"} 17:09:04 [17:09:04.723] INFO: node Received tx 0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce {"txHash":"0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce"} 17:09:04 [17:09:04.724] INFO: pxe:service Sent transaction 0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce 17:09:04 [17:09:04.888] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.091] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.213] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:09:05 [17:09:05.230] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:13:54.000Z","now":"2025-06-13T17:13:57.632Z"} 17:09:05 [17:09:05.354] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.557] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.595] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x35393df3 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x35393df3","duration":112.72185400000308} 17:09:05 [17:09:05.753] VERBOSE: simulator:public-processor Processed tx 0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce with 1 public calls in 387.8983189999999ms {"txHash":"0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce","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":387.8983189999999} 17:09:05 [17:09:05.756] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.5248849779999982s {"duration":0.5248849779999982,"rate":117740.08133263857,"totalPublicGas":{"daGas":3072,"l2Gas":61800},"totalBlockGas":{"daGas":91648,"l2Gas":98344},"totalSizeInBytes":6144} 17:09:05 [17:09:05.762] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:05 [17:09:05.919] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 86807.64193068106 mana/s {"blockHash":"0x063a05c2d1d796b142be4d81082f9eed910aeb3a963a78550ef7829afe4a98e5","globalVariables":{"chainId":31337,"version":341756598,"blockNumber":2,"slotNumber":3,"timestamp":1749834834,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x291b8bd26bcbaf3c0356643cee109ce15e00c8093490b0ef9cd41fa1ce4120ce"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":710.0021549999983,"publicProcessDuration":525.2434060000014,"rollupCircuitsDuration":688.5116749999979,"txCount":1,"blockNumber":2,"blockTimestamp":1749834834,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 17:09:05 [17:09:05.923] VERBOSE: sequencer Attesting committee is empty 17:09:06 [17:09:06.007] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.234] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.246] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x7ab5aeda78766a7b957327a9cd4dc5045a2e49379963af81da0eddc1ccb360c1 17:09:06 [17:09:06.246] VERBOSE: sequencer-client Sent L1 transaction 0x7ab5aeda78766a7b957327a9cd4dc5045a2e49379963af81da0eddc1ccb360c1 {"gasLimit":470298,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:09:06 [17:09:06.253] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834870] on http://127.0.0.1:8545 17:09:06 [17:09:06.255] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:06 [17:09:06.258] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:06 [17:09:06.258] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x7ab5aeda78766a7b957327a9cd4dc5045a2e49379963af81da0eddc1ccb360c1","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":2,"blockTimestamp":1749834834,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 17:09:06 [17:09:06.258] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:06 [17:09:06.261] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834870 17:09:06 [17:09:06.261] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:30.000Z {"offset":323739,"timeMs":1749834870000} 17:09:06 [17:09:06.262] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:09:06 [17:09:06.267] INFO: blob-sink:server Received blob sidecar for block 0x0fa7327e0f160ef5703c5d0107ceb5fdd066a9187a215abc31e5b75fab33bdca 17:09:06 [17:09:06.274] INFO: blob-sink:server Blob sidecar stored successfully for block 0x0fa7327e0f160ef5703c5d0107ceb5fdd066a9187a215abc31e5b75fab33bdca 17:09:06 [17:09:06.423] VERBOSE: archiver:block-helper Store contract instance at 0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815 17:09:06 [17:09:06.428] VERBOSE: archiver:block-helper Store contract class 0x0fbfc518e8ee4971622de3f275570a7a200e07a53c8d4dd82acd6d50f2c32d82 17:09:06 [17:09:06.439] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.442] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x063a05c2d1d796b142be4d81082f9eed910aeb3a963a78550ef7829afe4a98e5","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":341756598,"blockNumber":2,"slotNumber":3,"timestamp":1749834834,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x22fd54ed5ea903cb70e998156093324b8c933b6aa04f7c147a498985e1757522","archiveNextLeafIndex":3} 17:09:06 [17:09:06.447] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:09:06 [17:09:06.449] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:09:06 [17:09:06.451] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:09:06 [17:09:06.531] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.960446999997657,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834834,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":151} 17:09:06 [17:09:06.568] VERBOSE: p2p Synched to latest block 2 17:09:06 [17:09:06.643] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.800] INFO: aztecjs:deploy_sent_tx Contract 0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815 successfully deployed. 17:09:06 [17:09:06.801] INFO: e2e:e2e_private_voting_contract Counter contract deployed at 0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815 17:09:06 [17:09:06.804] INFO: e2e:e2e_private_voting_contract Running test: e2e_voting_contract votes votes, then tries to vote again 17:09:06 [17:09:06.812] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x22fd54ed5ea903cb70e998156093324b8c933b6aa04f7c147a498985e1757522","blockNumber":3,"slot":4} 17:09:06 [17:09:06.831] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x22fd54ed5ea903cb70e998156093324b8c933b6aa04f7c147a498985e1757522","header":{"contentCommitment":{"blobsHash":"0x004557c8bae7ddf2be4fd633645f97d9158e642d53f9eb73c96a2752cc21eafc","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834834,"version":341756598},"lastArchive":"0x2718c25fcce905ffa18086a80fce6e2dea2f794a4307bd30194fa94811e735b2","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x07156371e4fa61fb9a7d2f7ca1a4c8bc9b67bea8decf86728a35c088408284b8","nullifierTree":"0x097869b343ac5df262edc658f853092b6d9bb3eaf8dae2453b7a159d785f309d","publicDataTree":"0x20efde582474bcf7fd26386db69ffab304bc507d9c03594821b7e34ce0ba2c3c"},"totalFees":32675777440,"totalManaUsed":98344}} 17:09:06 [17:09:06.870] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:06 [17:09:06.931] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:06 [17:09:06.991] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:06 [17:09:06.992] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:07 [17:09:07.046] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:09:07 [17:09:07.073] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:07 [17:09:07.074] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.085] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a7a53c18c28e895ba52a34cfb5d0b516ddd53ceedd80e371b8edff01877f72d 17:09:07 [17:09:07.099] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:07 [17:09:07.100] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:07 [17:09:07.110] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:07 [17:09:07.111] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:07 [17:09:07.114] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x06bdba2a19334b65e82d76f366e014408beba5b8a3cef567d9fc730a812d43c0","nullifier":"0x077b93ca906f542114514233ce3b97f69579a03c34197ed865fd2fb50ac11352"} 17:09:07 [17:09:07.116] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:07 [17:09:07.134] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb as fee payer 17:09:07 [17:09:07.168] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815"} 17:09:07 [17:09:07.316] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.399] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x22fd54ed5ea903cb70e998156093324b8c933b6aa04f7c147a498985e1757522","blockNumber":3,"slot":4} 17:09:07 [17:09:07.565] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.908] INFO: pxe:service Proving completed in 1086.069714000001ms {"timings":{"total":1086.069714000001,"sync":10.706225000001723,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":297.7896099999998,"oracles":{"debugLog":{"times":[0.8864300000022922,0.6436039999971399,0.5284520000022894,0.5619230000011157,0.49471099999936996,0.33439699999871664,0.29943700000148965,0.6702550000009069]},"fetchTaggedLogs":{"times":[89.63258700000006]},"loadCapsule":{"times":[0.6266849999992701,0.42955000000074506,0.5440629999975499,0.23796500000025844,0.2993960000021616,0.19332399999984773]},"getSharedSecret":{"times":[4.71458800000255]},"aes128Decrypt":{"times":[0.34577700000227196,1.0608850000025996]},"getPublicKeysAndPartialAddress":{"times":[4.01328199999989]},"getKeyValidationRequest":{"times":[2.0919880000001285]},"deliverNote":{"times":[3.33137600000191]},"deleteCapsule":{"times":[0.2721959999980754]},"storeCapsule":{"times":[0.24786500000118394]},"getNotes":{"times":[1.7928909999973257]},"getAuthWitness":{"times":[0.23297599999932572]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.061961999999766704]},"callPrivateFunction":{"times":[59.87595699999656]}}},{"functionName":"private_kernel_init","time":63.376077000000805},{"functionName":"EasyPrivateVoting:cast_vote","time":47.357051999999385,"oracles":{"getPublicKeysAndPartialAddress":{"times":[2.1219980000023497]},"getKeyValidationRequest":{"times":[1.8784930000001623]},"notifyCreatedNullifier":{"times":[0.23870499999975436]},"storeInExecutionCache":{"times":[0.03020000000105938]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05405199999950128]}}},{"functionName":"private_kernel_inner","time":114.02071299999807},{"functionName":"private_kernel_reset","time":253.78280599999925},{"functionName":"private_kernel_tail","time":93.27469000000201}],"unaccounted":205.76254100000006}} 17:09:07 [17:09:07.936] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:07 [17:09:07.971] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x22fd54ed5ea903cb70e998156093324b8c933b6aa04f7c147a498985e1757522","blockNumber":3,"slot":4} 17:09:07 [17:09:07.977] VERBOSE: p2p:tx_pool Adding tx 0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1 to pool {"eventName":"tx-added-to-pool","txHash":"0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226313,"feePaymentMethod":"fee_juice"} 17:09:07 [17:09:07.999] INFO: node Received tx 0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1 {"txHash":"0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1"} 17:09:08 [17:09:08.000] INFO: pxe:service Sent transaction 0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1 17:09:08 [17:09:08.158] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:08 [17:09:08.377] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:08 [17:09:08.496] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:09:08 [17:09:08.512] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:14:30.000Z","now":"2025-06-13T17:14:32.251Z"} 17:09:08 [17:09:08.584] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:08 [17:09:08.635] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5f06617e completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5f06617e","duration":84.73521500000061} 17:09:08 [17:09:08.654] VERBOSE: simulator:public-processor Processed tx 0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1 with 1 public calls in 127.06517200000235ms {"txHash":"0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1","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":127.06517200000235} 17:09:08 [17:09:08.656] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1435104070000016s {"duration":0.1435104070000016,"rate":165507.1607454903,"totalPublicGas":{"daGas":512,"l2Gas":23752},"totalBlockGas":{"daGas":2048,"l2Gas":54952},"totalSizeInBytes":352} 17:09:08 [17:09:08.773] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 85618.4579668748 mana/s {"blockHash":"0x190323ae818f634351c44961c015fb513a1f8142b6c60b371ce5809982069a61","globalVariables":{"chainId":31337,"version":341756598,"blockNumber":3,"slotNumber":4,"timestamp":1749834870,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2b570930ecc30a5dd45e6be913c9a582a2220561b423f6b9717c736336aa72f1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":276.781590999999,"publicProcessDuration":143.8119740000002,"rollupCircuitsDuration":261.53638299999875,"txCount":1,"blockNumber":3,"blockTimestamp":1749834870,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:08 [17:09:08.775] VERBOSE: sequencer Attesting committee is empty 17:09:08 [17:09:08.849] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.028] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8ba062bda46414fc8c929fc8f6781654cfc94587350078548e649e3132812968 17:09:09 [17:09:09.028] VERBOSE: sequencer-client Sent L1 transaction 0x8ba062bda46414fc8c929fc8f6781654cfc94587350078548e649e3132812968 {"gasLimit":470312,"maxFeePerGas":"1.279583418","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:09:09 [17:09:09.043] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:09:09 [17:09:09.043] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8ba062bda46414fc8c929fc8f6781654cfc94587350078548e649e3132812968","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":3,"blockTimestamp":1749834870,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:09 [17:09:09.043] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:09:09 [17:09:09.048] INFO: blob-sink:server Received blob sidecar for block 0x491fcc26c7e30bfcdf55ed9b87be9b7d360487a0f653cddfdcf7d6d9127652f9 17:09:09 [17:09:09.053] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.059] INFO: blob-sink:server Blob sidecar stored successfully for block 0x491fcc26c7e30bfcdf55ed9b87be9b7d360487a0f653cddfdcf7d6d9127652f9 17:09:09 [17:09:09.069] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:09:09 [17:09:09.072] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:09:09 [17:09:09.074] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:09:09 [17:09:09.075] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834906] on http://127.0.0.1:8545 17:09:09 [17:09:09.076] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:09:09 [17:09:09.077] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834906 17:09:09 [17:09:09.077] WARN: foundation:test-date-provider Time set to 2025-06-13T17:15:06.000Z {"offset":356923,"timeMs":1749834906000} 17:09:09 [17:09:09.077] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:09:09 [17:09:09.264] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.467] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.714] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:09 [17:09:09.733] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x190323ae818f634351c44961c015fb513a1f8142b6c60b371ce5809982069a61","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":341756598,"blockNumber":3,"slotNumber":4,"timestamp":1749834870,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x220759392b21825998da6d7b07fad811626c5b6210ab23c0f5075eee5dcf8f98","archiveNextLeafIndex":4} 17:09:09 [17:09:09.737] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:09:09 [17:09:09.839] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":7.179073999999673,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834870,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:09:09 [17:09:09.847] VERBOSE: p2p Synched to latest block 3 17:09:09 [17:09:09.922] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.037] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x220759392b21825998da6d7b07fad811626c5b6210ab23c0f5075eee5dcf8f98","header":{"contentCommitment":{"blobsHash":"0x002a7a0319e0ec6a1aebc9f5ffa15fb179206119aad966e29cda0b028a395f27","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834870,"version":341756598},"lastArchive":"0x22fd54ed5ea903cb70e998156093324b8c933b6aa04f7c147a498985e1757522","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x07156371e4fa61fb9a7d2f7ca1a4c8bc9b67bea8decf86728a35c088408284b8","nullifierTree":"0x11fdfc96de08231e634e14b99dd91c5e8f02355e690ebadad54e476864993942","publicDataTree":"0x17eeafe07e2effd4e2db34265f2f21a7ceecee716083317a4478356acea4a063"},"totalFees":18258351520,"totalManaUsed":54952}} 17:09:10 [17:09:10.078] VERBOSE: simulator Executing utility function get_vote {"contract":"0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815","selector":"0x50ac913f"} 17:09:10 [17:09:10.094] VERBOSE: simulator Utility simulation for 0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815.0x50ac913f completed 17:09:10 [17:09:10.111] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb {"origin":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000145ecab6","authWitnesses":["0x2f3bde8fb3f2780e1a42baf7f8e8a64e950ff7bf4db0f5746ab4eb3bead436ef"]} 17:09:10 [17:09:10.112] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x220759392b21825998da6d7b07fad811626c5b6210ab23c0f5075eee5dcf8f98","blockNumber":4,"slot":5} 17:09:10 [17:09:10.144] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.201] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:10 [17:09:10.241] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:10 [17:09:10.242] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:10 [17:09:10.293] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:10 [17:09:10.298] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a7a53c18c28e895ba52a34cfb5d0b516ddd53ceedd80e371b8edff01877f72d 17:09:10 [17:09:10.307] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:10 [17:09:10.308] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:10 [17:09:10.313] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:10 [17:09:10.314] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:10 [17:09:10.318] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x06bdba2a19334b65e82d76f366e014408beba5b8a3cef567d9fc730a812d43c0","nullifier":"0x077b93ca906f542114514233ce3b97f69579a03c34197ed865fd2fb50ac11352"} 17:09:10 [17:09:10.321] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:10 [17:09:10.336] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb as fee payer 17:09:10 [17:09:10.369] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815"} 17:09:10 [17:09:10.377] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.590] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:10 [17:09:10.767] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x220759392b21825998da6d7b07fad811626c5b6210ab23c0f5075eee5dcf8f98","blockNumber":4,"slot":5} 17:09:11 [17:09:11.087] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:11 [17:09:11.110] VERBOSE: node Simulating public calls for tx 0x2a111a21930367a504ec6e5f290d82ad7b5c51349ab904ce82be4004270b3510 {"globalVariables":{"chainId":31337,"version":341756598,"blockNumber":4,"slotNumber":5,"timestamp":1749834906,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHash":"0x2a111a21930367a504ec6e5f290d82ad7b5c51349ab904ce82be4004270b3510","blockNumber":4} 17:09:11 [17:09:11.133] VERBOSE: simulator:state_manager Siloed nullifier 0x1f0707dc946b148ad6879a3488b7b1ad6673d4451079ae0ce047d4268574a399 already present in tree! 17:09:11 [17:09:11.137] WARN: simulator:public_tx_context APP_LOGIC phase reverted! insertRevertiblesFromPrivate failed with reason: Nullifier collision encountered when inserting revertible nullifiers from private 17:09:11 Details: Siloed nullifier 0x1f0707dc946b148ad6879a3488b7b1ad6673d4451079ae0ce047d4268574a399 already exists in parent cache or host. 17:09:11 Error stack: NullifierCollisionError: Siloed nullifier 0x1f0707dc946b148ad6879a3488b7b1ad6673d4451079ae0ce047d4268574a399 already exists in parent cache or host. 17:09:11 at PublicPersistableStateManager.writeSiloedNullifier (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/state_manager/state_manager.js:190:23) 17:09:11 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:263:17) 17:09:11 at TelemetryPublicTxSimulator.insertRevertiblesFromPrivate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:33:24) 17:09:11 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/public_tx_simulator.js:54:29) 17:09:11 at TelemetryPublicTxSimulator.simulate (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_tx_simulator/measured_public_tx_simulator.js:14:25) 17:09:11 at PublicProcessor.processTxWithPublicCalls (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:321:91) 17:09:11 at PublicProcessor.processTxWithinDeadline (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:268:20) 17:09:11 at elapsed (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/timer/elapsed.js:8:20) 17:09:11 at PublicProcessor.processTx (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:221:53) 17:09:11 at PublicProcessor.process (/home/aztec-dev/aztec-packages/yarn-project/simulator/dest/public/public_processor/public_processor.js:159:53) 17:09:11 at AztecNodeService.simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:718:66) 17:09:11 at PXEService.#simulatePublicCalls (/home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:241:28) 17:09:11 at /home/aztec-dev/aztec-packages/yarn-project/pxe/dest/pxe_service/pxe_service.js:580:36 17:09:11 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 17:09:11 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 17:09:11 [17:09:11.157] VERBOSE: simulator:public-processor Processed tx 0x2a111a21930367a504ec6e5f290d82ad7b5c51349ab904ce82be4004270b3510 with 1 public calls in 35.6682550000005ms {"txHash":"0x2a111a21930367a504ec6e5f290d82ad7b5c51349ab904ce82be4004270b3510","txFee":1581840000,"revertCode":1,"revertReason":{"originalMessage":"Nullifier collision encountered when inserting revertible nullifiers from private\nDetails: Siloed nullifier 0x1f0707dc946b148ad6879a3488b7b1ad6673d4451079ae0ce047d4268574a399 already exists in parent cache or host.\nError stack: NullifierCollisionError: Siloed nullifier 0x1f0707dc946b148ad6879a3488b7b1ad6673d4451079ae0ce047d4268574a399 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":35.6682550000005} 17:09:11 [17:09:11.159] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.043696467999998274s {"duration":0.043696467999998274,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":31200},"totalSizeInBytes":256} 17:09:11 [17:09:11.159] ERROR: pxe:service Failed to enrich public simulation error: TypeError: Cannot read properties of undefined (reading 'contractAddress') 17:09:11 [17:09:11.252] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:11 [17:09:11.305] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:09:11 [17:09:11.305] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:11 [17:09:11.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:11 [17:09:11.352] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x220759392b21825998da6d7b07fad811626c5b6210ab23c0f5075eee5dcf8f98","blockNumber":4,"slot":5} 17:09:11 [17:09:11.369] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb"} 17:09:11 [17:09:11.374] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a7a53c18c28e895ba52a34cfb5d0b516ddd53ceedd80e371b8edff01877f72d 17:09:11 [17:09:11.385] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:09:11 [17:09:11.385] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:09:11 [17:09:11.392] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:09:11 [17:09:11.393] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:09:11 [17:09:11.397] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x06bdba2a19334b65e82d76f366e014408beba5b8a3cef567d9fc730a812d43c0","nullifier":"0x077b93ca906f542114514233ce3b97f69579a03c34197ed865fd2fb50ac11352"} 17:09:11 [17:09:11.399] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:09:11 [17:09:11.416] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f517d91bd6e712461b017beb2bc54d30b1f4422aaa72822b8ccea62fb820dcb as fee payer 17:09:11 [17:09:11.440] VERBOSE: simulator:private_execution Executing private function EasyPrivateVoting:cast_vote {"contract":"0x079f0649213fc5ba6ff77a1940a2e1a7793328ec2aca3e439f0dffc4b73e1815"} 17:09:11 [17:09:11.539] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:11 [17:09:11.909] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:12 [17:09:12.349] INFO: pxe:service Proving completed in 1177.0564520000007ms {"timings":{"total":1177.0564520000007,"sync":2.4387860000024375,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":227.31976199999917,"oracles":{"debugLog":{"times":[0.8115089999992051,0.3893690000004426,0.5277419999983977,0.4464410000000498,0.41811000000234344,0.4471300000004703,0.3596080000024813,0.893900000002759]},"fetchTaggedLogs":{"times":[66.91365799999767]},"loadCapsule":{"times":[0.21667499999966822,0.17116399999940768,0.28875699999844073,0.27108600000065053,0.23695600000064587,0.17121399999814457]},"getSharedSecret":{"times":[3.328506000001653]},"aes128Decrypt":{"times":[0.37697900000057416,1.0800449999987904]},"getPublicKeysAndPartialAddress":{"times":[1.6537280000011378]},"getKeyValidationRequest":{"times":[1.8021709999993618]},"deliverNote":{"times":[4.139124000001175]},"deleteCapsule":{"times":[0.31347699999969336]},"storeCapsule":{"times":[0.3131969999994908]},"getNotes":{"times":[1.632777000002534]},"getAuthWitness":{"times":[0.2654359999978624]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0869620000012219]},"callPrivateFunction":{"times":[41.375465000000986]}}},{"functionName":"private_kernel_init","time":100.45936399999846},{"functionName":"EasyPrivateVoting:cast_vote","time":33.334742000002734,"oracles":{"getPublicKeysAndPartialAddress":{"times":[2.8332440000012866]},"getKeyValidationRequest":{"times":[2.6410500000019965]},"notifyCreatedNullifier":{"times":[0.15156299999944167]},"storeInExecutionCache":{"times":[0.03760099999999511]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05095100000107777]}}},{"functionName":"private_kernel_inner","time":164.24874099999943},{"functionName":"private_kernel_reset","time":302.22412299999996},{"functionName":"private_kernel_tail","time":136.1926999999996}],"unaccounted":210.83823399999892}} 17:09:12 [17:09:12.393] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:09:12 [17:09:12.406] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x220759392b21825998da6d7b07fad811626c5b6210ab23c0f5075eee5dcf8f98","blockNumber":4,"slot":5} 17:09:12 [17:09:12.413] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x2bfd4e549f28adf7b67f6b3adcf2e9e3dfbc87390ba997c6c676b26165247d9c for repeating a nullifier 17:09:12 [17:09:12.419] WARN: node Received invalid tx 0x2bfd4e549f28adf7b67f6b3adcf2e9e3dfbc87390ba997c6c676b26165247d9c: Existing nullifier {"txHash":"0x2bfd4e549f28adf7b67f6b3adcf2e9e3dfbc87390ba997c6c676b26165247d9c"} 17:09:12 [17:09:12.424] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 17:09:12 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 17:09:12 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 17:09:12 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 17:09:12 [17:09:12.433] INFO: node Stopping 17:09:12 [17:09:12.434] INFO: slasher Slasher client stopped. 17:09:12 [17:09:12.434] INFO: sequencer Stopped sequencer 17:09:12 [17:09:12.434] INFO: p2p P2P client stopped. 17:09:12 [17:09:12.438] INFO: world_state Stopped world state synchronizer 17:09:12 [17:09:12.438] INFO: archiver Stopped. 17:09:12 [17:09:12.438] INFO: node Stopped 17:09:12 [17:09:12.439] VERBOSE: e2e:e2e_private_voting_contract Cleaning up ACVM state 17:09:12 [17:09:12.439] INFO: e2e:e2e_private_voting_contract Cleaning up ACVM temp directory /tmp/b20f8785 17:09:12 [17:09:12.440] VERBOSE: e2e:e2e_private_voting_contract Cleaning up BB state 17:09:12 [17:09:12.451] INFO: blob-sink:server Stopping blob sink 17:09:12 [17:09:12.452] INFO: blob-sink:server Blob sink stopped 17:09:12 [17:09:12.452] VERBOSE: e2e:e2e_private_voting_contract Cleaning up data directory at /tmp/98c215ad284b01d6 17:09:12 PASS src/e2e_private_voting_contract.test.ts 17:09:12 e2e_voting_contract 17:09:12 votes 17:09:12 ✓ votes, then tries to vote again (5624 ms) 17:09:12 17:09:12 Test Suites: 1 passed, 1 total 17:09:12 Tests: 1 passed, 1 total 17:09:12 Snapshots: 0 total 17:09:12 Time: 24.044 s 17:09:12 Ran all test suites matching /src\/e2e_private_voting_contract.test.ts/i. 17:09:12 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?