ACI ·

Parent Log: http://ci.aztec-labs.com/29998ce2b6f652f0 Command: 0208e45f5d528351:ISOLATE=1:NAME=e2e_multi_validator_node yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_multi_validator_node.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/16656695f6f0daa012fec8020350b4e65ecb6085 Env: REF_NAME=gh-readonly-queue/next/pr-14726-acc4cc9352097c0c3532e1d7eb47fff1d0794551 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Wed Jun 4 19:00:02 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14726_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/0d13f39a62f4c76d 19:00:02 +++ id -u 19:00:02 +++ id -g 19:00:02 ++ docker run -d --name e2e_multi_validator_node --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_multi_validator_node.test.ts'\''' 19:00:02 + cid=5b582efc471eae9b75e11a82f039c04ad1c6dca90df870bcbea80c28201190dc 19:00:02 + set +x 19:00:03 {"level":25,"time":1749063603536,"pid":12,"hostname":"5b582efc471e","module":"logger","msg":"Logger initialized with level verbose"} 19:00:09 [19:00:09.832] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should build blocks & attest with multiple validator keys 19:00:10 [19:00:10.274] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 19:00:10 [19:00:10.835] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-Wbi6Wg/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:00:10 [19:00:10.878] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 19:00:10 [19:00:10.906] WARN: e2e:e2e_multi_validator_node Set block interval to 12 19:00:10 [19:00:10.907] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:00:10 [19:00:10.963] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:00:10 [19:00:10.977] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:00:10 [19:00:10.996] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:00:11 [19:00:11.002] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:00:11 [19:00:11.030] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:00:11 [19:00:11.038] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:00:11 [19:00:11.064] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:00:11 [19:00:11.072] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:00:11 [19:00:11.090] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 19:00:11 [19:00:11.095] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:00:11 [19:00:11.124] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 19:00:11 [19:00:11.129] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:00:11 [19:00:11.156] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 19:00:11 [19:00:11.156] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 19:00:11 [19:00:11.170] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 19:00:11 [19:00:11.175] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 19:00:11 [19:00:11.176] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:00:11 [19:00:11.176] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 19:00:11 [19:00:11.206] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:11 [19:00:11.223] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 19:00:11 [19:00:11.224] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 19:00:11 [19:00:11.237] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 19:00:11 [19:00:11.253] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 19:00:11 [19:00:11.262] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:00:11 [19:00:11.286] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 19:00:11 [19:00:11.286] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 19:00:11 [19:00:11.301] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 19:00:11 [19:00:11.306] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 19:00:11 [19:00:11.326] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 19:00:11 [19:00:11.326] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 19:00:11 [19:00:11.326] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:00:11 [19:00:11.326] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 19:00:11 [19:00:11.354] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:11 [19:00:11.370] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 19:00:11 [19:00:11.391] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 19:00:11 [19:00:11.392] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 19:00:11 [19:00:11.395] VERBOSE: e2e:e2e_multi_validator_node Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:00:11 [19:00:11.411] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 19:00:11 [19:00:11.451] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 19:00:11 [19:00:11.458] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 19:00:11 [19:00:11.513] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xba5bc64d0d3e15d304fc9236ceef48a75a2cad4744277bcc3898e0c275e7b52d {"gasLimit":10716795,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 19:00:11 [19:00:11.521] VERBOSE: e2e:e2e_multi_validator_node Deployed Rollup at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:00:11 [19:00:11.521] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 19:00:11 [19:00:11.562] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:11 [19:00:11.562] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 19:00:11 [19:00:11.592] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 19:00:11 [19:00:11.593] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 19:00:11 [19:00:11.613] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xd413488be28de232ee67a932daca30e5e7bc4e1ad751dedc3910bbbe185aafe4 {"gasLimit":1040116,"maxFeePerGas":"38.520398451","maxPriorityFeePerGas":"38.337599913"} 19:00:11 [19:00:11.617] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 19:00:11 [19:00:11.652] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec {"gasLimit":116846,"maxFeePerGas":"46.165150264","maxPriorityFeePerGas":"46.005119895"} 19:00:11 [19:00:11.653] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec 19:00:11 [19:00:11.671] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 {"gasLimit":109478,"maxFeePerGas":"55.34732635","maxPriorityFeePerGas":"55.206143874"} 19:00:11 [19:00:11.671] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 19:00:11 [19:00:11.674] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 19:00:11 [19:00:11.705] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:11 [19:00:11.713] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 19:00:11 [19:00:11.713] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 19:00:11 [19:00:11.713] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 19:00:11 [19:00:11.749] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:11 [19:00:11.750] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 19:00:11 [19:00:11.775] INFO: e2e:e2e_multi_validator_node Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 19:00:11 [19:00:11.776] INFO: e2e:e2e_multi_validator_node Handing over to governance 19:00:11 [19:00:11.782] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:00:11 [19:00:11.784] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:11 [19:00:11.785] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 19:00:11 [19:00:11.787] INFO: telemetry:client Using NoopTelemetryClient 19:00:11 [19:00:11.794] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:00:11 [19:00:11.794] WARN: foundation:test-date-provider Time set to 2025-06-04T19:04:34.000Z {"offset":262206,"timeMs":1749063874000} 19:00:11 [19:00:11.795] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/3eb719925a36c609/blob-sink with map size 134217728 KB (LMDB v2) 19:00:11 [19:00:11.801] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:00:11 [19:00:11.807] INFO: blob-sink:server Server is running on http://localhost:40857 19:00:11 [19:00:11.808] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 19:00:11 [19:00:11.808] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/e275d080/acvm 19:00:11 [19:00:11.810] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:40857"} 19:00:11 [19:00:11.843] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:00:11 [19:00:11.845] INFO: archiver:lmdb Creating archiver data store at directory /tmp/3eb719925a36c609/archiver with map size 134217728 KB (LMDB v2) 19:00:11 [19:00:11.847] INFO: archiver:lmdb Starting data store with maxReaders 16 19:00:12 [19:00:11.997] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:12 [19:00:12.329] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:40857"} 19:00:12 [19:00:12.338] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:12 [19:00:12.355] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:40857"} 19:00:12 [19:00:12.355] WARN: node:blob-sink:client No L1 consensus host urls configured 19:00:12 [19:00:12.355] WARN: node:blob-sink:client No archive client configured 19:00:12 [19:00:12.362] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 22 with hash 0x78a4e82cd8ef0aa7beeafa1e1daae73c593eb1cf8a2e48036753521316640f17 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xacbf62ceffe9265fc8eaa0f6dbbe9e5b1996ff699b37aa86e6dd6836634d1572","l1BlockNumber":18}} 19:00:12 [19:00:12.405] INFO: archiver Initial archiver sync to L1 block 22 complete. {"l1BlockNumber":22,"syncPoint":{"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0x78a4e82cd8ef0aa7beeafa1e1daae73c593eb1cf8a2e48036753521316640f17","l1BlockNumber":22}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:00:12 [19:00:12.420] INFO: world-state:database Creating world state data store at directory /tmp/3eb719925a36c609/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:00:12 [19:00:12.459] INFO: world_state Created world state synchroniser with block history of 64 19:00:12 [19:00:12.460] WARN: node Aztec node is accepting fake proofs 19:00:12 [19:00:12.475] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/3eb719925a36c609/p2p with map size 134217728 KB (LMDB v2) 19:00:12 [19:00:12.481] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:00:12 [19:00:12.484] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/3eb719925a36c609/p2p-archive with map size 134217728 KB (LMDB v2) 19:00:12 [19:00:12.491] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:00:12 [19:00:12.497] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/3eb719925a36c609/p2p-peers with map size 134217728 KB (LMDB v2) 19:00:12 [19:00:12.501] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:00:12 [19:00:12.503] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:00:12 [19:00:12.504] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:00:12 [19:00:12.512] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:00:12 [19:00:12.513] INFO: world_state Started world state synchronizer from block 1 19:00:12 [19:00:12.516] VERBOSE: world-state:block_stream Starting sync from block number 0 19:00:12 [19:00:12.527] INFO: p2p Starting p2p client from block 0 with empty mempools 19:00:12 [19:00:12.528] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 19:00:12 [19:00:12.529] INFO: epoch-prune-watcher EpochPruneWatcher initialized 19:00:12 [19:00:12.533] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:00:12 [19:00:12.544] INFO: slasher Starting Slasher client... 19:00:12 [19:00:12.611] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:00:12 [19:00:12.611] VERBOSE: node All Aztec Node subsystems synced 19:00:12 [19:00:12.618] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:12 [19:00:12.625] INFO: sequencer-client Deploying forwarder contract 19:00:12 [19:00:12.650] VERBOSE: sequencer-client Sent L1 transaction 0x602f411c9ae84deb9da90dad04b3e6b54d91158c82d01934d2b760f3de926311 {"gasLimit":323704,"maxFeePerGas":"66.371021876","maxPriorityFeePerGas":"66.247372648"} 19:00:12 [19:00:12.650] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x602f411c9ae84deb9da90dad04b3e6b54d91158c82d01934d2b760f3de926311. 19:00:12 [19:00:12.656] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 19:00:12 [19:00:12.664] INFO: validator Started validator with addresses: 19:00:12 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:00:12 [19:00:12.665] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 19:00:12 [19:00:12.665] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/e275d080/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:00:13 [19:00:13.003] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:00:13 [19:00:13.006] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:00:13 [19:00:13.008] INFO: node Aztec Node version: 0.87.6 19:00:13 [19:00:13.008] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0"} 19:00:13 [19:00:13.010] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 19:00:13 [19:00:13.052] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:40857"} 19:00:13 [19:00:13.058] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:13 [19:00:13.074] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:00:13 [19:00:13.074] WARN: foundation:test-date-provider Time set to 2025-06-04T19:04:46.000Z {"offset":272926,"timeMs":1749063886000} 19:00:13 [19:00:13.083] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/3eb719925a36c609/a255637cef0a9f8d/archiver with map size 134217728 KB (LMDB v2) 19:00:13 [19:00:13.104] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:13 [19:00:13.112] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 19:00:13 [19:00:13.370] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:13 [19:00:13.421] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:13 [19:00:13.527] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:40857"} 19:00:13 [19:00:13.532] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:40857"} 19:00:13 [19:00:13.532] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 19:00:13 [19:00:13.533] WARN: blob-sink:client:prover-node No archive client configured 19:00:13 [19:00:13.536] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 23 with hash 0x188c2929180079d75afff584d0be513a8f1a9ff90d2856f4ed108cf62d202c4e {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xacbf62ceffe9265fc8eaa0f6dbbe9e5b1996ff699b37aa86e6dd6836634d1572","l1BlockNumber":18}} 19:00:13 [19:00:13.553] INFO: archiver:prover-node Initial archiver sync to L1 block 23 complete. {"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x188c2929180079d75afff584d0be513a8f1a9ff90d2856f4ed108cf62d202c4e","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:00:13 [19:00:13.559] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:40857"} 19:00:13 [19:00:13.559] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 19:00:13 [19:00:13.562] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 19:00:13 [19:00:13.572] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/3eb719925a36c609/a255637cef0a9f8d/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:00:13 [19:00:13.600] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:13 [19:00:13.610] INFO: world_state:prover-node Created world state synchroniser with block history of 64 19:00:13 [19:00:13.612] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:00:13 [19:00:13.612] INFO: world_state:prover-node Started world state synchronizer from block 1 19:00:13 [19:00:13.614] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 19:00:13 [19:00:13.615] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/3eb719925a36c609/a255637cef0a9f8d/archiver when loading epoch databases, ignoring 19:00:13 [19:00:13.615] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/3eb719925a36c609/a255637cef0a9f8d/world_state when loading epoch databases, ignoring 19:00:13 [19:00:13.617] INFO: prover-client:proving-broker:prover-node Proving Broker started 19:00:13 [19:00:13.641] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 19:00:13 [19:00:13.643] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 19:00:13 [19:00:13.645] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 19:00:13 [19:00:13.657] INFO: prover-node:prover-node Started Prover Node with prover id 0x0000000000000000000000003c44cdddb6a900fa2b585dd299e03d12fa4293bc {"proverNodePollingIntervalMs":200,"proverNodeMaxPendingJobs":10,"proverNodeMaxParallelBlocksPerEpoch":32,"txGatheringIntervalMs":1000,"txGatheringBatchSize":10,"txGatheringMaxParallelRequestsPerNode":100,"dataDirectory":"/tmp/3eb719925a36c609/a255637cef0a9f8d","l1ChainId":31337,"rollupVersion":3942340346} 19:00:13 [19:00:13.657] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 19:00:13 [19:00:13.665] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:13 [19:00:13.666] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/ad499ceb464e5f3e/pxe_data with map size 134217728 KB (LMDB v2) 19:00:13 [19:00:13.669] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:00:13 [19:00:13.889] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:13 [19:00:13.970] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:14 [19:00:14.005] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:00:14 [19:00:14.006] INFO: pxe:service Started PXE connected to chain 31337 version 3942340346 19:00:14 [19:00:14.064] INFO: pxe:service Registered account 0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60 19:00:14 [19:00:14.131] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:14 [19:00:14.134] WARN: pxe:service No artifact found for contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 when looking for its metadata 19:00:14 [19:00:14.139] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 as part of deployment for 0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60 19:00:14 [19:00:14.187] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:14 [19:00:14.312] INFO: pxe:service Added contract SchnorrAccount at 0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60 with class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:00:14 [19:00:14.365] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:14 [19:00:14.372] VERBOSE: pxe:block_stream Starting sync from block number 0 19:00:14 [19:00:14.415] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:00:14 [19:00:14.485] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:14 [19:00:14.562] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:00:15 [19:00:15.672] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0,0x0240bf0e016845a25c6a69d15d5ca1bb78fd38b72dc894232e020c2b188ad937,0x0d7e7b1c04f61ee57629d3be4dc7b937efb93329c57da17d8b5151dd750d818b,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:00:15 [19:00:15.889] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:00:16 [19:00:16.024] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:16 [19:00:16.063] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:16 [19:00:16.247] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:16 [19:00:16.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:16 [19:00:16.318] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:16 [19:00:16.319] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:16 [19:00:16.381] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:16 [19:00:16.427] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:16 [19:00:16.435] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:16 [19:00:16.543] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:16 [19:00:16.650] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:16 [19:00:16.684] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:16 [19:00:16.724] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:16 [19:00:16.724] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:16 [19:00:16.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:16 [19:00:16.799] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:16 [19:00:16.802] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:16 [19:00:16.829] VERBOSE: simulator:client_execution_context:debug_log Setting 0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60 as fee payer 19:00:16 [19:00:16.910] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:17 [19:00:17.055] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:17 [19:00:17.184] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:17 [19:00:17.382] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:17 [19:00:17.552] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:17 [19:00:17.742] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:17 [19:00:17.846] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:18 [19:00:18.348] INFO: pxe:service Proving completed in 3985.339436ms {"timings":{"total":3985.339436,"sync":10.95085300000028,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":224.81726100000014,"oracles":{"callPrivateFunction":{"times":[1520.2305730000007,570.7587649999987,287.8928589999996]}}},{"functionName":"private_kernel_init","time":132.3650030000008},{"functionName":"ContractClassRegisterer:register","time":1489.4005340000003,"oracles":{"loadCapsule":{"times":[25.077562999998918]},"notifyCreatedNullifier":{"times":[18.927551000000676]},"debugLog":{"times":[1.4925419999999576]},"notifyCreatedContractClassLog":{"times":[28.298962000000756]}}},{"functionName":"private_kernel_inner","time":186.99590700000044},{"functionName":"SchnorrAccount:constructor","time":521.5203799999999,"oracles":{"getContractInstance":{"times":[7.4955210000007355]},"debugLog":{"times":[0.7775810000002821,0.8287319999999454]},"fetchTaggedLogs":{"times":[113.23218700000143]},"loadCapsule":{"times":[0.8749829999997019,0.47303699999974924,0.4726670000000013]},"validateEnqueuedNotes":{"times":[2.436206000000311]},"notifyCreatedNullifier":{"times":[0.38072599999941303,0.5247280000003229]},"notifyCreatedNote":{"times":[0.6202599999996892]},"getRandomField":{"times":[0.6652600000015809,0.22798399999919639,0.12460199999986799,0.11657100000047649,0.09009100000002945,0.06579100000089966,0.0870520000007673,0.13000199999987672,0.10584100000050967,0.15036200000031386,0.07329099999878963]},"getIndexedTaggingSecretAsSender":{"times":[46.08633700000064]},"incrementAppTaggingSecretIndexAsSender":{"times":[42.23072899999897]}}},{"functionName":"private_kernel_inner","time":168.38564899999983},{"functionName":"SchnorrAccount:entrypoint","time":245.71568200000002,"oracles":{"debugLog":{"times":[0.7932920000002923,0.3269540000001143,2.3039539999990666]},"fetchTaggedLogs":{"times":[76.5275700000002]},"loadCapsule":{"times":[0.2590039999995497,0.2034830000011425,0.18259299999954237]},"validateEnqueuedNotes":{"times":[0.8242620000000898]},"getNotes":{"times":[2.5396980000004987]},"getAuthWitness":{"times":[0.377835999999661]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.8447880000003352]}}},{"functionName":"private_kernel_inner","time":158.72615499999847},{"functionName":"private_kernel_reset","time":224.87844100000075},{"functionName":"private_kernel_tail","time":104.06573099999878}],"unaccounted":517.5178400000004}} 19:00:18 [19:00:18.375] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:18 [19:00:18.502] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","blockNumber":1,"slot":2} 19:00:18 [19:00:18.533] VERBOSE: p2p:tx_pool Adding tx 0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1 to pool {"eventName":"tx-added-to-pool","txHash":"0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:00:18 [19:00:18.561] INFO: node Received tx 0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1 {"txHash":"0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1"} 19:00:18 [19:00:18.562] INFO: pxe:service Sent transaction 0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1 19:00:18 [19:00:18.604] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:18 [19:00:18.761] VERBOSE: sequencer:block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-04T19:04:58.000Z","now":"2025-06-04T19:04:51.687Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:00:18 [19:00:18.811] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:18 [19:00:18.856] VERBOSE: simulator:public-processor Processed tx 0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1 with no public calls in 49.68886100000054ms {"txHash":"0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1","txFee":2101212240,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":6324},"billedGas":{"daGas":16896,"l2Gas":6324},"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":49.68886100000054} 19:00:18 [19:00:18.867] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.09913213700000051s {"duration":0.09913213700000051,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 19:00:19 [19:00:19.027] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:19 [19:00:19.054] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x27d058e080ff51310dc30ecc2e702c820ed0d7097bca0221a067434d0ceabb7b","globalVariables":{"chainId":31337,"version":3942340346,"blockNumber":1,"slotNumber":2,"timestamp":1749063898,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2331f88a9954bec9ec57aafd96c1c2d348d7735bd0eb7b6c3ba0905e8770b7b1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":314.83659100000114,"publicProcessDuration":101.587313,"rollupCircuitsDuration":294.1100829999996,"txCount":1,"blockNumber":1,"blockTimestamp":1749063898,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:19 [19:00:19.061] VERBOSE: sequencer Attesting committee is empty 19:00:19 [19:00:19.242] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:19 [19:00:19.591] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:19 [19:00:19.605] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x3fa9b657593967475583bd1c6d36ad48d271294edade8885f3718d40f56ecc41 19:00:19 [19:00:19.606] VERBOSE: node Sent L1 transaction 0x3fa9b657593967475583bd1c6d36ad48d271294edade8885f3718d40f56ecc41 {"gasLimit":555058,"maxFeePerGas":"79.605134257","maxPriorityFeePerGas":"79.496847177","maxFeePerBlobGas":"0.000000001"} 19:00:19 [19:00:19.634] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:00:19 [19:00:19.636] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x3fa9b657593967475583bd1c6d36ad48d271294edade8885f3718d40f56ecc41","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1749063898,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:19 [19:00:19.637] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:00:19 [19:00:19.642] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749063934] on http://127.0.0.1:8545 19:00:19 [19:00:19.648] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:00:19 [19:00:19.653] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749063934 19:00:19 [19:00:19.653] WARN: foundation:test-date-provider Time set to 2025-06-04T19:05:34.000Z {"offset":314347,"timeMs":1749063934000} 19:00:19 [19:00:19.654] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 19:00:19 [19:00:19.674] INFO: blob-sink:server Received blob sidecar for block 0xd79b69377623810eae766593580672b9b1e75e21d180748084756a02d12662db 19:00:19 [19:00:19.683] INFO: blob-sink:server Blob sidecar stored successfully for block 0xd79b69377623810eae766593580672b9b1e75e21d180748084756a02d12662db 19:00:19 [19:00:19.802] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:19 [19:00:19.815] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:00:19 [19:00:19.828] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:00:19 [19:00:19.839] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:00:19 [19:00:19.932] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e, 0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e) 19:00:20 [19:00:20.132] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:20 [19:00:20.221] VERBOSE: archiver:block-helper:prover-node Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:00:20 [19:00:20.360] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:20 [19:00:20.364] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x27d058e080ff51310dc30ecc2e702c820ed0d7097bca0221a067434d0ceabb7b","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3942340346,"blockNumber":1,"slotNumber":2,"timestamp":1749063898,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","archiveNextLeafIndex":2} 19:00:20 [19:00:20.379] VERBOSE: archiver:block-helper Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:00:20 [19:00:20.407] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x27d058e080ff51310dc30ecc2e702c820ed0d7097bca0221a067434d0ceabb7b","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3942340346,"blockNumber":1,"slotNumber":2,"timestamp":1749063898,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","archiveNextLeafIndex":2} 19:00:20 [19:00:20.416] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e, 0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e) 19:00:20 [19:00:20.420] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 19:00:20 [19:00:20.426] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 19:00:20 [19:00:20.427] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 19:00:20 [19:00:20.430] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":12.794775000002119,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749063898,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:20 [19:00:20.434] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 19:00:20 [19:00:20.435] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 19:00:20 [19:00:20.436] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:00:20 [19:00:20.509] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749066238] on http://127.0.0.1:8545 19:00:20 [19:00:20.513] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:00:20 [19:00:20.519] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749066238 19:00:20 [19:00:20.520] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60 19:00:20 [19:00:20.966] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:20 [19:00:20.987] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:00:20 [19:00:20.987] WARN: foundation:test-date-provider Time set to 2025-06-04T19:43:58.000Z {"offset":2617013,"timeMs":1749066238000} 19:00:20 [19:00:20.997] INFO: pxe:service Added contract StatefulTest at 0x1ab93db53caeb3c43015b1738d5eb4569ff0466a201a2a5b105d0a7279d113df with class 0x0e75e50f67127bddbbf0c6e812b093c4e20dc26681235d9c77c3d57f93ab52a0 19:00:21 [19:00:21.031] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.40290499999901,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749063898,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:21 [19:00:21.095] VERBOSE: p2p Synched to latest block 1 19:00:21 [19:00:21.116] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","header":{"contentCommitment":{"blobsHash":"0x00cd44a0b0825e1ced413e097952bd9c5a39bf9d7d1776bfb543810373804316","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749063898,"version":3942340346},"lastArchive":"0x0c6597fb20515326f4f3b94aece236f0ab820c1fe8fce427f7136ca452aacd1e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x12d4159f6032b3be30a89277735d3497aa9d512ad51e95413c4a940deedd4c21","nullifierTree":"0x2bd697e7c0e98fb1f74aa5878afbab68abfdf8b9004897be47c388b61ef00ae6","publicDataTree":"0x124931efcf11cec0cec9b4a5054d4296b840ce43164b7f76688d0baac05e935a"},"totalFees":2101212240,"totalManaUsed":6324}} 19:00:21 [19:00:21.217] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:21 [19:00:21.269] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:21 [19:00:21.329] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:21 [19:00:21.330] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:21 [19:00:21.432] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:21 [19:00:21.434] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 2 19:00:21 [19:00:21.482] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60"} 19:00:21 [19:00:21.488] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x14169ebd7ae999d84bae9e2bd5228d7d74ea8c639f77cc04f6e4211e5d81a91e 19:00:21 [19:00:21.503] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:00:21 [19:00:21.504] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:00:21 [19:00:21.512] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:00:21 [19:00:21.513] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:00:21 [19:00:21.519] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:21 [19:00:21.532] VERBOSE: pxe:service Added note {"index":0,"contract":"0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x095180e2c4f8d1a3860ee0919e71e189f81056eb5d3f23eb7df8decf04857e2c","nullifier":"0x005215c6503faf51ea3b9e338394b3fce4ea68b9ff35b1f411698174235e575e"} 19:00:21 [19:00:21.542] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:21 [19:00:21.562] VERBOSE: simulator:client_execution_context:debug_log Setting 0x18377375e61f0606146fc547385eb06fc78815140bede86e01781ca7144cfa60 as fee payer 19:00:21 [19:00:21.783] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x1ab93db53caeb3c43015b1738d5eb4569ff0466a201a2a5b105d0a7279d113df"} 19:00:21 [19:00:21.804] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:21 [19:00:21.813] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:21 [19:00:21.813] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1ab93db53caeb3c43015b1738d5eb4569ff0466a201a2a5b105d0a7279d113df"} 19:00:21 [19:00:21.888] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:21 [19:00:21.926] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1ab93db53caeb3c43015b1738d5eb4569ff0466a201a2a5b105d0a7279d113df"} 19:00:21 [19:00:21.932] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:22 [19:00:22.016] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:22 [19:00:22.157] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x1ab93db53caeb3c43015b1738d5eb4569ff0466a201a2a5b105d0a7279d113df"} 19:00:22 [19:00:22.212] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:22 [19:00:22.213] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1ab93db53caeb3c43015b1738d5eb4569ff0466a201a2a5b105d0a7279d113df"} 19:00:22 [19:00:22.319] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:22 [19:00:22.357] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1ab93db53caeb3c43015b1738d5eb4569ff0466a201a2a5b105d0a7279d113df"} 19:00:22 [19:00:22.361] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:22 [19:00:22.628] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:22 [19:00:22.844] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:22 [19:00:22.920] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:23 [19:00:23.103] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:23 [19:00:23.322] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:23 [19:00:23.371] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:23 [19:00:23.662] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:23 [19:00:23.707] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:23 [19:00:23.900] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:24 [19:00:24.227] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:24 [19:00:24.295] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:24 [19:00:24.472] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:24 [19:00:24.791] INFO: pxe:service Proving completed in 3719.9820800000016ms {"timings":{"total":3719.9820800000016,"sync":56.08104299999832,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":476.8595989999958,"oracles":{"debugLog":{"times":[1.2411389999979292,0.46845699999903445,0.618439000001672,0.5217980000015814,0.615098999998736,0.3877950000023702,0.7621309999994992,1.1263770000005024]},"fetchTaggedLogs":{"times":[155.16582199999903]},"loadCapsule":{"times":[0.42738699999972596,0.8575330000021495,0.5424679999996442,0.3529960000014398,0.6479600000020582,0.3901160000023083,1.034135999998398]},"getSharedSecret":{"times":[5.290370999999141]},"aes128Decrypt":{"times":[1.2825190000003204,1.1716180000003078]},"getPublicKeysAndPartialAddress":{"times":[1.7955279999987397]},"getKeyValidationRequest":{"times":[2.922203999998601]},"storeCapsule":{"times":[1.3373700000011013,0.848533000000316,0.5707390000025043]},"deleteCapsule":{"times":[0.7053710000000137]},"validateEnqueuedNotes":{"times":[13.019988999996713]},"getNotes":{"times":[8.733264000002237]},"getAuthWitness":{"times":[0.39789500000188127]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.15782299999773386]},"callPrivateFunction":{"times":[1389.189985000001]}}},{"functionName":"private_kernel_init","time":81.15726500000164},{"functionName":"StatefulTest:constructor","time":386.40647000000536,"oracles":{"getContractInstance":{"times":[6.249534999999014]},"debugLog":{"times":[0.49736699999994016,0.6732410000004165]},"fetchTaggedLogs":{"times":[117.27457499999946]},"loadCapsule":{"times":[0.2644040000013774,0.20285300000250572,0.5206780000007711]},"validateEnqueuedNotes":{"times":[1.7629769999985]},"storeInExecutionCache":{"times":[0.2092529999972612]},"callPrivateFunction":{"times":[1007.6610870000004]},"notifyCreatedNullifier":{"times":[0.48036799999681534]}}},{"functionName":"private_kernel_inner","time":182.88278400000127},{"functionName":"StatefulTest:create_note_no_init_check","time":929.6691909999972,"oracles":{"debugLog":{"times":[0.7336109999996552,0.5392180000017106]},"fetchTaggedLogs":{"times":[146.70140200000242]},"loadCapsule":{"times":[0.20640300000013667,0.22018300000127056,0.20621299999766052]},"validateEnqueuedNotes":{"times":[0.999934999999823]},"getRandomField":{"times":[0.16380299999946146,0.23413399999844842,0.23507299999982934,0.1147610000007262,0.05993099999977858,0.05142100000011851,0.047850999999354826,0.03671099999701255,0.06783099999665865,0.04090100000030361,0.07455100000152015,0.036880999999993946]},"notifyCreatedNote":{"times":[0.19119300000238582]},"getIndexedTaggingSecretAsSender":{"times":[362.2923640000008]},"incrementAppTaggingSecretIndexAsSender":{"times":[183.64440500000273]}}},{"functionName":"private_kernel_inner","time":165.5005689999998},{"functionName":"private_kernel_reset","time":228.47296799999822},{"functionName":"private_kernel_tail","time":88.04424999999901}],"unaccounted":1124.907941000005}} 19:00:24 [19:00:24.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:24 [19:00:24.903] VERBOSE: p2p:tx_pool Adding tx 0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b to pool {"eventName":"tx-added-to-pool","txHash":"0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:00:24 [19:00:24.905] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e","blockNumber":2,"slot":67} 19:00:24 [19:00:24.914] INFO: node Received tx 0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b {"txHash":"0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b"} 19:00:24 [19:00:24.914] INFO: pxe:service Sent transaction 0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b 19:00:25 [19:00:25.033] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:25 [19:00:25.182] VERBOSE: sequencer:block-builder Building block 2 for slot 67 {"slot":67,"slotStart":"2025-06-04T19:43:58.000Z","now":"2025-06-04T19:44:02.195Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:00:25 [19:00:25.239] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:25 [19:00:25.252] VERBOSE: simulator:public-processor Processed tx 0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b with no public calls in 23.98698499999955ms {"txHash":"0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b","txFee":196507480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":4814},"billedGas":{"daGas":11776,"l2Gas":4814},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":23.98698499999955} 19:00:25 [19:00:25.258] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.07289817000000039s {"duration":0.07289817000000039,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 19:00:25 [19:00:25.408] INFO: sequencer Built block 2 for slot 67 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x088855fa6016c6fff8785d72babaab3f7b1330750646ec3f65fce06873f2e3a9","globalVariables":{"chainId":31337,"version":3942340346,"blockNumber":2,"slotNumber":67,"timestamp":1749066238,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x00fa045dab9c82e62eb18b1506c744d6ea01b0db265bcab03d47dcea2988f08b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":240.93692700000247,"publicProcessDuration":73.5369389999978,"rollupCircuitsDuration":226.74176200000147,"txCount":1,"blockNumber":2,"blockTimestamp":1749066238,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:25 [19:00:25.411] VERBOSE: sequencer Attesting committee is empty 19:00:25 [19:00:25.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:25 [19:00:25.720] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:25 [19:00:25.851] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x5c8f63bfe6d5a1420de6bc7defc0b5c08ebbf2c0d83bc2f41852f7e3e3b20d80 19:00:25 [19:00:25.852] VERBOSE: node Sent L1 transaction 0x5c8f63bfe6d5a1420de6bc7defc0b5c08ebbf2c0d83bc2f41852f7e3e3b20d80 {"gasLimit":565394,"maxFeePerGas":"1.273011826","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:00:25 [19:00:25.874] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749066274] on http://127.0.0.1:8545 19:00:25 [19:00:25.878] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:00:25 [19:00:25.880] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:00:25 [19:00:25.881] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x5c8f63bfe6d5a1420de6bc7defc0b5c08ebbf2c0d83bc2f41852f7e3e3b20d80","calldataSize":1444,"calldataGas":12244,"txCount":1,"blockNumber":2,"blockTimestamp":1749066238,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:25 [19:00:25.881] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:00:25 [19:00:25.886] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749066274 19:00:25 [19:00:25.886] WARN: foundation:test-date-provider Time set to 2025-06-04T19:44:34.000Z {"offset":2648114,"timeMs":1749066274000} 19:00:25 [19:00:25.887] INFO: aztecjs:utils:watcher Slot 67 was filled, jumped to next slot 19:00:25 [19:00:25.899] INFO: blob-sink:server Received blob sidecar for block 0xc75eb9495a001f9781004c70c8d4219437af32dd2d2df360d354270c1fe0e5f6 19:00:25 [19:00:25.910] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc75eb9495a001f9781004c70c8d4219437af32dd2d2df360d354270c1fe0e5f6 19:00:25 [19:00:25.930] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:26 [19:00:26.122] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:00:26 [19:00:26.128] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:00:26 [19:00:26.137] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x088855fa6016c6fff8785d72babaab3f7b1330750646ec3f65fce06873f2e3a9","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3942340346,"blockNumber":2,"slotNumber":67,"timestamp":1749066238,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0ce92466a09c25e55691411a63b81108f477768c5fc286fdf6d5b5a514414017","archiveNextLeafIndex":3} 19:00:26 [19:00:26.145] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:00:26 [19:00:26.145] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:26 [19:00:26.316] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x088855fa6016c6fff8785d72babaab3f7b1330750646ec3f65fce06873f2e3a9","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3942340346,"blockNumber":2,"slotNumber":67,"timestamp":1749066238,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0ce92466a09c25e55691411a63b81108f477768c5fc286fdf6d5b5a514414017","archiveNextLeafIndex":3} 19:00:26 [19:00:26.343] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x0ce92466a09c25e55691411a63b81108f477768c5fc286fdf6d5b5a514414017, 0x05fac406a57c309483920f8e164b8908e63eea1fa942459df31872322aba379e) 19:00:26 [19:00:26.364] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.096687999997812,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749066238,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:26 [19:00:26.366] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.140069000000949,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749066238,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:26 [19:00:26.497] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:26 [19:00:26.529] VERBOSE: p2p Synched to latest block 2 19:00:26 [19:00:26.537] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 19:00:26 [19:00:26.576] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0ce92466a09c25e55691411a63b81108f477768c5fc286fdf6d5b5a514414017","blockNumber":3,"slot":68} 19:00:26 [19:00:26.585] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:00:26 [19:00:26.701] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:26 [19:00:26.789] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0ce92466a09c25e55691411a63b81108f477768c5fc286fdf6d5b5a514414017","blockNumber":3,"slot":68} 19:00:26 [19:00:26.849] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 19:00:26 [19:00:26.850] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 19:00:26 [19:00:26.853] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 19:00:26 [19:00:26.853] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 19:00:26 [19:00:26.903] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:27 [19:00:27.109] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:27 [19:00:27.125] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0ce92466a09c25e55691411a63b81108f477768c5fc286fdf6d5b5a514414017","blockNumber":3,"slot":68} 19:00:27 [19:00:27.131] INFO: node Stopping 19:00:27 [19:00:27.133] INFO: slasher Slasher client stopped. 19:00:27 [19:00:27.133] INFO: sequencer Stopped sequencer 19:00:27 [19:00:27.134] INFO: p2p P2P client stopped. 19:00:27 [19:00:27.137] INFO: world_state Stopped world state synchronizer 19:00:27 [19:00:27.137] INFO: archiver Stopped. 19:00:27 [19:00:27.137] INFO: node Stopped 19:00:27 [19:00:27.137] INFO: prover-node:prover-node Stopping ProverNode 19:00:27 [19:00:27.138] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 19:00:27 [19:00:27.138] INFO: archiver:prover-node Stopped. 19:00:27 [19:00:27.140] INFO: world_state:prover-node Stopped world state synchronizer 19:00:27 [19:00:27.141] INFO: prover-node:prover-node Stopped ProverNode 19:00:27 [19:00:27.141] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 19:00:27 [19:00:27.141] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/e275d080 19:00:27 [19:00:27.145] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 19:00:27 [19:00:27.157] INFO: blob-sink:server Stopping blob sink 19:00:27 [19:00:27.157] INFO: blob-sink:server Blob sink stopped 19:00:27 [19:00:27.158] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/3eb719925a36c609 19:00:27 [19:00:27.171] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should attest ONLY with the correct validator keys 19:00:27 [19:00:27.387] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 19:00:27 [19:00:27.447] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-Ia87xg/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:00:27 [19:00:27.492] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 19:00:27 [19:00:27.499] WARN: e2e:e2e_multi_validator_node Set block interval to 12 19:00:27 [19:00:27.500] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:00:27 [19:00:27.531] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:00:27 [19:00:27.538] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:00:27 [19:00:27.557] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:00:27 [19:00:27.565] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:00:27 [19:00:27.589] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:00:27 [19:00:27.595] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:00:27 [19:00:27.611] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:00:27 [19:00:27.617] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:00:27 [19:00:27.639] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 19:00:27 [19:00:27.651] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:00:27 [19:00:27.673] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 19:00:27 [19:00:27.679] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:00:27 [19:00:27.694] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 19:00:27 [19:00:27.694] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 19:00:27 [19:00:27.707] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 19:00:27 [19:00:27.711] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 19:00:27 [19:00:27.711] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:00:27 [19:00:27.711] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 19:00:27 [19:00:27.740] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:27 [19:00:27.765] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 19:00:27 [19:00:27.765] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 19:00:27 [19:00:27.793] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 19:00:27 [19:00:27.809] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 19:00:27 [19:00:27.830] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:00:27 [19:00:27.870] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 19:00:27 [19:00:27.870] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 19:00:27 [19:00:27.893] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 19:00:27 [19:00:27.900] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 19:00:27 [19:00:27.929] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 19:00:27 [19:00:27.929] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 19:00:27 [19:00:27.929] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:00:27 [19:00:27.929] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 19:00:27 [19:00:27.958] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:28 [19:00:28.000] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 19:00:28 [19:00:28.029] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 19:00:28 [19:00:28.030] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 19:00:28 [19:00:28.033] VERBOSE: e2e:e2e_multi_validator_node Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:00:28 [19:00:28.053] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 19:00:28 [19:00:28.078] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 19:00:28 [19:00:28.085] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 19:00:28 [19:00:28.164] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf7fe7b980d959ca0885923b361489221de1504c7df33b5c091b282fa13e1b2da {"gasLimit":10716795,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 19:00:28 [19:00:28.175] VERBOSE: e2e:e2e_multi_validator_node Deployed Rollup at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:00:28 [19:00:28.176] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 19:00:28 [19:00:28.208] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:28 [19:00:28.208] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 19:00:28 [19:00:28.225] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 19:00:28 [19:00:28.226] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 19:00:28 [19:00:28.247] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xd413488be28de232ee67a932daca30e5e7bc4e1ad751dedc3910bbbe185aafe4 {"gasLimit":1040116,"maxFeePerGas":"38.520398451","maxPriorityFeePerGas":"38.337599913"} 19:00:28 [19:00:28.252] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 19:00:28 [19:00:28.272] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec {"gasLimit":116846,"maxFeePerGas":"46.165150264","maxPriorityFeePerGas":"46.005119895"} 19:00:28 [19:00:28.272] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec 19:00:28 [19:00:28.287] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 {"gasLimit":109478,"maxFeePerGas":"55.34732635","maxPriorityFeePerGas":"55.206143874"} 19:00:28 [19:00:28.288] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 19:00:28 [19:00:28.321] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2baf4763aa17682af85263faf72b939a3b0de80fabfa567cc2614de37cb716e2 {"gasLimit":362859,"maxFeePerGas":"66.371021876","maxPriorityFeePerGas":"66.247372648"} 19:00:28 [19:00:28.340] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xa623e13db3bc03c6828b186ab37039f59d8527e19526127bc6b78030c6e5fea9 {"gasLimit":84823,"maxFeePerGas":"79.605134257","maxPriorityFeePerGas":"79.496847177"} 19:00:28 [19:00:28.390] INFO: e2e:e2e_multi_validator_node Initialized validator set {"validators":[{"attester":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","withdrawer":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","privateKey":"0xac0974bec39a17e36ba4a6b4d238ff944bacb478cbed5efcae784d7bf4f2ff80"},{"attester":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","withdrawer":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","privateKey":"0x59c6995e998f97a5a0044966f0945389dc9e86dae88c7a8412f4603b6b78690d"},{"attester":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","withdrawer":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","privateKey":"0x5de4111afa1a4b94908f83103eb1f1706367c2e68ca870fc3fb9a804cdab365a"},{"attester":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","withdrawer":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","privateKey":"0x7c852118294e51e653712a81e05800f419141751be58f605c371e15141b007a6"},{"attester":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","withdrawer":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","privateKey":"0x47e179ec197488593b187f80a00eb0da91f1b9d0b13f8733639f19c30a34926a"}],"txHash":"0xc005a872652e5180c06511d7b2c65be32bd9db61f5c8a251e60d728456eb4cb3"} 19:00:28 [19:00:28.391] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 19:00:28 [19:00:28.435] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:28 [19:00:28.449] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 19:00:28 [19:00:28.449] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 19:00:28 [19:00:28.450] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 19:00:28 [19:00:28.468] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:00:28 [19:00:28.469] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 19:00:28 [19:00:28.486] INFO: e2e:e2e_multi_validator_node Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 19:00:28 [19:00:28.486] INFO: e2e:e2e_multi_validator_node Handing over to governance 19:00:28 [19:00:28.491] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:00:28 [19:00:28.493] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:28 [19:00:28.494] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 19:00:28 [19:00:28.500] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/6904c27650d468c4/blob-sink with map size 134217728 KB (LMDB v2) 19:00:28 [19:00:28.502] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:00:28 [19:00:28.502] WARN: foundation:test-date-provider Time set to 2025-06-04T19:05:27.000Z {"offset":298498,"timeMs":1749063927000} 19:00:28 [19:00:28.512] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:00:28 [19:00:28.517] INFO: blob-sink:server Server is running on http://localhost:41727 19:00:28 [19:00:28.517] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 19:00:28 [19:00:28.518] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/d0775bca/acvm 19:00:28 [19:00:28.519] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:41727"} 19:00:28 [19:00:28.546] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:00:28 [19:00:28.546] INFO: archiver:lmdb Creating archiver data store at directory /tmp/6904c27650d468c4/archiver with map size 134217728 KB (LMDB v2) 19:00:28 [19:00:28.548] INFO: archiver:lmdb Starting data store with maxReaders 16 19:00:28 [19:00:28.752] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:28 [19:00:28.889] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:41727"} 19:00:28 [19:00:28.896] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:41727"} 19:00:28 [19:00:28.896] WARN: node:blob-sink:client No L1 consensus host urls configured 19:00:28 [19:00:28.896] WARN: node:blob-sink:client No archive client configured 19:00:28 [19:00:28.899] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 25 with hash 0xf85659009a066b94b6cbb1d8ab353b9757bba21823bc0008e6cf88452c86257e {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xbe01698140a8dbf39973d905a1813a91aba8ee3f1b4d5fedd4904c46aa2bf377","l1BlockNumber":18}} 19:00:28 [19:00:28.912] INFO: archiver Initial archiver sync to L1 block 25 complete. {"l1BlockNumber":25,"syncPoint":{"blocksSynchedTo":25,"messagesSynchedTo":{"l1BlockHash":"0xf85659009a066b94b6cbb1d8ab353b9757bba21823bc0008e6cf88452c86257e","l1BlockNumber":25}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:00:28 [19:00:28.919] INFO: world-state:database Creating world state data store at directory /tmp/6904c27650d468c4/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:00:28 [19:00:28.949] INFO: world_state Created world state synchroniser with block history of 64 19:00:28 [19:00:28.950] WARN: node Aztec node is accepting fake proofs 19:00:28 [19:00:28.959] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:28 [19:00:28.961] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/6904c27650d468c4/p2p with map size 134217728 KB (LMDB v2) 19:00:28 [19:00:28.963] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:00:28 [19:00:28.965] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/6904c27650d468c4/p2p-archive with map size 134217728 KB (LMDB v2) 19:00:28 [19:00:28.966] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:00:28 [19:00:28.969] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/6904c27650d468c4/p2p-peers with map size 134217728 KB (LMDB v2) 19:00:28 [19:00:28.970] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:00:28 [19:00:28.972] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:00:28 [19:00:28.972] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:00:28 [19:00:28.974] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:00:28 [19:00:28.974] INFO: world_state Started world state synchronizer from block 1 19:00:28 [19:00:28.975] VERBOSE: world-state:block_stream Starting sync from block number 0 19:00:28 [19:00:28.976] INFO: p2p Starting p2p client from block 0 with empty mempools 19:00:28 [19:00:28.976] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 19:00:28 [19:00:28.977] INFO: epoch-prune-watcher EpochPruneWatcher initialized 19:00:28 [19:00:28.982] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:00:28 [19:00:28.983] INFO: slasher Starting Slasher client... 19:00:29 [19:00:28.991] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:00:29 [19:00:28.991] VERBOSE: node All Aztec Node subsystems synced 19:00:29 [19:00:29.000] INFO: sequencer-client Deploying forwarder contract 19:00:29 [19:00:29.020] VERBOSE: sequencer-client Sent L1 transaction 0x5f35c2d0e4f65c467262e74571eec910db06feaae6991ac544d9a02dbb6f34dd {"gasLimit":323704,"maxFeePerGas":"95.479418643","maxPriorityFeePerGas":"95.396216612"} 19:00:29 [19:00:29.020] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x5f35c2d0e4f65c467262e74571eec910db06feaae6991ac544d9a02dbb6f34dd. 19:00:29 [19:00:29.024] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 19:00:29 [19:00:29.029] INFO: validator Started validator with addresses: 19:00:29 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:00:29 [19:00:29.029] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 19:00:29 [19:00:29.029] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/d0775bca/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:00:29 [19:00:29.030] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:00:29 [19:00:29.030] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:00:29 [19:00:29.031] INFO: node Aztec Node version: 0.87.6 19:00:29 [19:00:29.031] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0"} 19:00:29 [19:00:29.032] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 19:00:29 [19:00:29.059] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:41727"} 19:00:29 [19:00:29.063] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/6904c27650d468c4/4b75e54c95ca33c9/archiver with map size 134217728 KB (LMDB v2) 19:00:29 [19:00:29.067] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":2} 19:00:29 [19:00:29.068] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 19:00:29 [19:00:29.185] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:29 [19:00:29.191] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:00:29 [19:00:29.192] WARN: foundation:test-date-provider Time set to 2025-06-04T19:05:39.000Z {"offset":309808,"timeMs":1749063939000} 19:00:29 [19:00:29.326] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:29 [19:00:29.407] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:29 [19:00:29.420] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:41727"} 19:00:29 [19:00:29.424] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:41727"} 19:00:29 [19:00:29.424] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 19:00:29 [19:00:29.429] WARN: blob-sink:client:prover-node No archive client configured 19:00:29 [19:00:29.438] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 26 with hash 0xfac595ed22a20745db98b00018682111ab20bc274411baf45d329a59b9c3be8c {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xbe01698140a8dbf39973d905a1813a91aba8ee3f1b4d5fedd4904c46aa2bf377","l1BlockNumber":18}} 19:00:29 [19:00:29.458] INFO: archiver:prover-node Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26,"messagesSynchedTo":{"l1BlockHash":"0xfac595ed22a20745db98b00018682111ab20bc274411baf45d329a59b9c3be8c","l1BlockNumber":26}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:00:29 [19:00:29.462] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:41727"} 19:00:29 [19:00:29.463] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 19:00:29 [19:00:29.466] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 19:00:29 [19:00:29.491] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/6904c27650d468c4/4b75e54c95ca33c9/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:00:29 [19:00:29.556] INFO: world_state:prover-node Created world state synchroniser with block history of 64 19:00:29 [19:00:29.559] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:00:29 [19:00:29.559] INFO: world_state:prover-node Started world state synchronizer from block 1 19:00:29 [19:00:29.561] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 19:00:29 [19:00:29.562] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/6904c27650d468c4/4b75e54c95ca33c9/archiver when loading epoch databases, ignoring 19:00:29 [19:00:29.562] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/6904c27650d468c4/4b75e54c95ca33c9/world_state when loading epoch databases, ignoring 19:00:29 [19:00:29.562] INFO: prover-client:proving-broker:prover-node Proving Broker started 19:00:29 [19:00:29.567] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:29 [19:00:29.585] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 19:00:29 [19:00:29.587] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 19:00:29 [19:00:29.588] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 19:00:29 [19:00:29.591] INFO: prover-node:prover-node Started Prover Node with prover id 0x0000000000000000000000003c44cdddb6a900fa2b585dd299e03d12fa4293bc {"proverNodePollingIntervalMs":200,"proverNodeMaxPendingJobs":10,"proverNodeMaxParallelBlocksPerEpoch":32,"txGatheringIntervalMs":1000,"txGatheringBatchSize":10,"txGatheringMaxParallelRequestsPerNode":100,"dataDirectory":"/tmp/6904c27650d468c4/4b75e54c95ca33c9","l1ChainId":31337,"rollupVersion":3883739672} 19:00:29 [19:00:29.592] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 19:00:29 [19:00:29.596] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/00c31988f9aa00b9/pxe_data with map size 134217728 KB (LMDB v2) 19:00:29 [19:00:29.601] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:00:29 [19:00:29.660] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:29 [19:00:29.883] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:29 [19:00:29.919] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:29 [19:00:29.924] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:00:29 [19:00:29.925] INFO: pxe:service Started PXE connected to chain 31337 version 3883739672 19:00:29 [19:00:29.998] INFO: pxe:service Registered account 0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3 19:00:30 [19:00:30.066] WARN: pxe:service No artifact found for contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 when looking for its metadata 19:00:30 [19:00:30.069] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 as part of deployment for 0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3 19:00:30 [19:00:30.138] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:30 [19:00:30.203] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:30 [19:00:30.262] INFO: pxe:service Added contract SchnorrAccount at 0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3 with class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:00:30 [19:00:30.289] VERBOSE: pxe:block_stream Starting sync from block number 0 19:00:30 [19:00:30.324] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:00:30 [19:00:30.365] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:30 [19:00:30.395] WARN: sequencer:block-builder Error closing forks for block processing {"generatedMessage":false,"code":"ERR_ASSERTION","actual":false,"expected":true,"operator":"=="} 19:00:30 [19:00:30.439] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:00:31 [19:00:31.074] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0,0x0240bf0e016845a25c6a69d15d5ca1bb78fd38b72dc894232e020c2b188ad937,0x0d7e7b1c04f61ee57629d3be4dc7b937efb93329c57da17d8b5151dd750d818b,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:00:31 [19:00:31.218] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:00:31 [19:00:31.268] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:31 [19:00:31.299] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:31 [19:00:31.417] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:31 [19:00:31.469] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:31 [19:00:31.470] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:31 [19:00:31.494] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:31 [19:00:31.533] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:31 [19:00:31.543] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:31 [19:00:31.550] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:31 [19:00:31.726] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:31 [19:00:31.816] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:31 [19:00:31.859] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:31 [19:00:31.860] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:31 [19:00:31.867] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:31 [19:00:31.905] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:31 [19:00:31.913] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:31 [19:00:31.926] VERBOSE: simulator:client_execution_context:debug_log Setting 0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3 as fee payer 19:00:31 [19:00:31.999] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:32 [19:00:32.208] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:32 [19:00:32.211] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:32 [19:00:32.489] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:32 [19:00:32.517] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:32 [19:00:32.746] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:32 [19:00:32.837] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:33 [19:00:33.234] INFO: pxe:service Proving completed in 2946.865322999998ms {"timings":{"total":2946.865322999998,"sync":2.736950999998953,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":163.48454600000332,"oracles":{"callPrivateFunction":{"times":[921.4569950000005,415.3492320000005,255.4225179999994]}}},{"functionName":"private_kernel_init","time":77.984166000002},{"functionName":"ContractClassRegisterer:register","time":899.6754340000007,"oracles":{"loadCapsule":{"times":[5.55679500000042]},"notifyCreatedNullifier":{"times":[0.8266619999994873]},"debugLog":{"times":[0.8512819999996282]},"notifyCreatedContractClassLog":{"times":[10.538919999999052]}}},{"functionName":"private_kernel_inner","time":113.74776199999906},{"functionName":"SchnorrAccount:constructor","time":369.353153,"oracles":{"getContractInstance":{"times":[0.8885140000020328]},"debugLog":{"times":[0.7554510000009032,0.687380999999732]},"fetchTaggedLogs":{"times":[78.42439399999785]},"loadCapsule":{"times":[0.5115979999973206,0.8062820000013744,0.509728000000905]},"validateEnqueuedNotes":{"times":[1.3623210000005201]},"notifyCreatedNullifier":{"times":[0.3766460000006191,0.3939060000011523]},"notifyCreatedNote":{"times":[0.22805300000254647]},"getRandomField":{"times":[0.20482300000003306,0.25396399999954156,0.08737100000143982,0.05577099999936763,0.04400100000202656,0.07212200000140001,0.0821620000024268,0.04922000000078697,0.06081099999937578,0.04965099999753875,0.04433000000062748]},"getIndexedTaggingSecretAsSender":{"times":[61.76423000000068]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.660071999998763]}}},{"functionName":"private_kernel_inner","time":164.62712499999907},{"functionName":"SchnorrAccount:entrypoint","time":209.32478699999774,"oracles":{"debugLog":{"times":[0.6402599999964877,0.6804599999995844,0.6475100000025122]},"fetchTaggedLogs":{"times":[51.68624699999782]},"loadCapsule":{"times":[0.29599400000006426,0.5691189999997732,0.252823000002536]},"validateEnqueuedNotes":{"times":[1.0364360000021406]},"getNotes":{"times":[1.0155049999993935]},"getAuthWitness":{"times":[0.22902299999987008]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.49112800000148127]}}},{"functionName":"private_kernel_inner","time":120.76997800000026},{"functionName":"private_kernel_reset","time":195.3364330000004},{"functionName":"private_kernel_tail","time":71.62145000000237}],"unaccounted":558.2035379999943}} 19:00:33 [19:00:33.250] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:33 [19:00:33.325] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","blockNumber":1,"slot":3} 19:00:33 [19:00:33.335] VERBOSE: p2p:tx_pool Adding tx 0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc to pool {"eventName":"tx-added-to-pool","txHash":"0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:00:33 [19:00:33.351] INFO: node Received tx 0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc {"txHash":"0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc"} 19:00:33 [19:00:33.352] INFO: pxe:service Sent transaction 0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc 19:00:33 [19:00:33.461] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:33 [19:00:33.555] VERBOSE: sequencer:block-builder Building block 1 for slot 3 {"slot":3,"slotStart":"2025-06-04T19:05:51.000Z","now":"2025-06-04T19:05:43.363Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:00:33 [19:00:33.611] VERBOSE: simulator:public-processor Processed tx 0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc with no public calls in 30.169299000001047ms {"txHash":"0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc","txFee":2101212240,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":6324},"billedGas":{"daGas":16896,"l2Gas":6324},"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":30.169299000001047} 19:00:33 [19:00:33.615] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05699950700000045s {"duration":0.05699950700000045,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 19:00:33 [19:00:33.709] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:33 [19:00:33.725] INFO: sequencer Built block 1 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x064beb6d6327b4648f3aa8d61067416f0068cd79e270a70eb5537f987f8a9946","globalVariables":{"chainId":31337,"version":3883739672,"blockNumber":1,"slotNumber":3,"timestamp":1749063951,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x00b34ad217f11edad134faa7bcb9ace65fd2ee8fda38fa0cde124218b8b2a4bc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":181.44763199999943,"publicProcessDuration":57.832970999999816,"rollupCircuitsDuration":170.7361380000002,"txCount":1,"blockNumber":1,"blockTimestamp":1749063951,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:33 [19:00:33.729] VERBOSE: sequencer Attesting committee is empty 19:00:33 [19:00:33.917] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:34 [19:00:34.150] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:34 [19:00:34.158] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8d53d9cb7f887f3d4be957b44550a00ad6c8a256fc7ecd698b778045c304f8d9 19:00:34 [19:00:34.158] VERBOSE: node Sent L1 transaction 0x8d53d9cb7f887f3d4be957b44550a00ad6c8a256fc7ecd698b778045c304f8d9 {"gasLimit":555026,"maxFeePerGas":"114.549196547","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 19:00:34 [19:00:34.166] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:00:34 [19:00:34.173] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:00:34 [19:00:34.179] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:00:34 [19:00:34.180] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749063987] on http://127.0.0.1:8545 19:00:34 [19:00:34.184] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:00:34 [19:00:34.187] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749063987 19:00:34 [19:00:34.188] WARN: foundation:test-date-provider Time set to 2025-06-04T19:06:27.000Z {"offset":352812,"timeMs":1749063987000} 19:00:34 [19:00:34.188] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 19:00:34 [19:00:34.190] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:00:34 [19:00:34.191] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8d53d9cb7f887f3d4be957b44550a00ad6c8a256fc7ecd698b778045c304f8d9","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1749063951,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:34 [19:00:34.192] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:00:34 [19:00:34.202] INFO: blob-sink:server Received blob sidecar for block 0x910dcb1db95ad6c232e8051391e35c797d593893514f394087e79ba0a4192c0c 19:00:34 [19:00:34.216] INFO: blob-sink:server Blob sidecar stored successfully for block 0x910dcb1db95ad6c232e8051391e35c797d593893514f394087e79ba0a4192c0c 19:00:34 [19:00:34.351] VERBOSE: archiver:block-helper:prover-node Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:00:34 [19:00:34.360] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x064beb6d6327b4648f3aa8d61067416f0068cd79e270a70eb5537f987f8a9946","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3883739672,"blockNumber":1,"slotNumber":3,"timestamp":1749063951,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","archiveNextLeafIndex":2} 19:00:34 [19:00:34.361] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:34 [19:00:34.375] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 19:00:34 [19:00:34.532] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538, 0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25) 19:00:34 [19:00:34.539] VERBOSE: archiver:block-helper Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:00:34 [19:00:34.543] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x064beb6d6327b4648f3aa8d61067416f0068cd79e270a70eb5537f987f8a9946","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3883739672,"blockNumber":1,"slotNumber":3,"timestamp":1749063951,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","archiveNextLeafIndex":2} 19:00:34 [19:00:34.547] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:00:34 [19:00:34.564] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:34 [19:00:34.584] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.426783000002615,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749063951,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:34 [19:00:34.589] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":11.486824999999953,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749063951,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:00:34 [19:00:34.611] VERBOSE: p2p Synched to latest block 1 19:00:34 [19:00:34.650] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749066291] on http://127.0.0.1:8545 19:00:34 [19:00:34.652] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:00:34 [19:00:34.654] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749066291 19:00:34 [19:00:34.698] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749068595] on http://127.0.0.1:8545 19:00:34 [19:00:34.700] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:00:34 [19:00:34.703] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749068595 19:00:34 [19:00:34.706] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3 19:00:35 [19:00:35.073] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:35 [19:00:35.078] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:00:35 [19:00:35.078] WARN: foundation:test-date-provider Time set to 2025-06-04T20:23:15.000Z {"offset":4959922,"timeMs":1749068595000} 19:00:35 [19:00:35.094] INFO: pxe:service Added contract StatefulTest at 0x0585886b364860d1c361252b0d19de32bcca5f2eac8158feca17eb72bc301ceb with class 0x0e75e50f67127bddbbf0c6e812b093c4e20dc26681235d9c77c3d57f93ab52a0 19:00:35 [19:00:35.118] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:35 [19:00:35.170] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","header":{"contentCommitment":{"blobsHash":"0x0094f5e35ab76bbab80f713134b5d497fdb89ca3eb0fdac22f25d2fa84958db8","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749063951,"version":3883739672},"lastArchive":"0x0a3564dd37c597f984d5f7affe29cde75116be28a0159cb96d2494dc5f0cff25","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21a97c4aafc812287bf6cbb2e147bf53f5b68eafc110eceb42225b403731c68a","nullifierTree":"0x1b6f20acdf98c4a402ee56725216666942413d142c09c43ab1ecc52bd4ce919a","publicDataTree":"0x0860b4168fee9b6a5e16bbbba64efae398d8293fc185e40764964503f4473b0f"},"totalFees":2101212240,"totalManaUsed":6324}} 19:00:35 [19:00:35.317] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:35 [19:00:35.374] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:35 [19:00:35.374] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:35 [19:00:35.378] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:35 [19:00:35.382] INFO: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 is on the validator committee for epoch 4 19:00:35 [19:00:35.382] INFO: validator Validator 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 is on the validator committee for epoch 4 19:00:35 [19:00:35.382] INFO: validator Validator 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc is on the validator committee for epoch 4 19:00:35 [19:00:35.399] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 19:00:35 [19:00:35.400] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 19:00:35 [19:00:35.410] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 19:00:35 [19:00:35.410] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 19:00:35 [19:00:35.458] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:35 [19:00:35.503] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3"} 19:00:35 [19:00:35.507] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x06deea0f96717eee3e4d03a6113d911c0f165a6de14a68ac824c4489e9d7f49c 19:00:35 [19:00:35.520] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:00:35 [19:00:35.521] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:00:35 [19:00:35.530] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:00:35 [19:00:35.530] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:00:35 [19:00:35.539] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:35 [19:00:35.544] VERBOSE: pxe:service Added note {"index":0,"contract":"0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2b7589077ee34021b9abcd38fb2e898ed54a5c8ad3df1388d8303ddea2c32384","nullifier":"0x03dc208cb42cc2b6c74585f73e104711065ce1bf693c21a769442e2f2cde4be5"} 19:00:35 [19:00:35.561] VERBOSE: simulator:client_execution_context:debug_log Setting 0x059ae779df9b1236c82dfd211f293d56b67819f04212a6b3ab315d850306f8f3 as fee payer 19:00:35 [19:00:35.640] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:35 [19:00:35.770] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x0585886b364860d1c361252b0d19de32bcca5f2eac8158feca17eb72bc301ceb"} 19:00:35 [19:00:35.794] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:35 [19:00:35.794] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0585886b364860d1c361252b0d19de32bcca5f2eac8158feca17eb72bc301ceb"} 19:00:35 [19:00:35.882] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:35 [19:00:35.912] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:35 [19:00:35.931] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0585886b364860d1c361252b0d19de32bcca5f2eac8158feca17eb72bc301ceb"} 19:00:35 [19:00:35.935] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:36 [19:00:36.143] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:36 [19:00:36.462] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x0585886b364860d1c361252b0d19de32bcca5f2eac8158feca17eb72bc301ceb"} 19:00:36 [19:00:36.516] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:00:36 [19:00:36.516] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0585886b364860d1c361252b0d19de32bcca5f2eac8158feca17eb72bc301ceb"} 19:00:36 [19:00:36.561] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:36 [19:00:36.635] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:36 [19:00:36.678] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0585886b364860d1c361252b0d19de32bcca5f2eac8158feca17eb72bc301ceb"} 19:00:36 [19:00:36.682] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:00:36 [19:00:36.840] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:36 [19:00:36.846] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:37 [19:00:37.119] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:37 [19:00:37.177] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:37 [19:00:37.334] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:37 [19:00:37.585] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:37 [19:00:37.635] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:37 [19:00:37.818] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:38 [19:00:38.116] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:38 [19:00:38.146] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:38 [19:00:38.332] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:38 [19:00:38.639] INFO: pxe:service Proving completed in 3504.803135000002ms {"timings":{"total":3504.803135000002,"sync":39.23832699999912,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":411.92007000001104,"oracles":{"debugLog":{"times":[0.5788990000000922,0.47993700000006356,0.4471269999994547,0.6105590000006487,0.546517999999196,0.4613869999993767,0.5780389999999898,0.861652999999933]},"fetchTaggedLogs":{"times":[130.28866299999936]},"loadCapsule":{"times":[0.2043229999981122,0.19172299999991083,0.4321170000002894,0.22053299999970477,0.4813880000001518,0.33676500000001397,0.26082400000086636]},"getSharedSecret":{"times":[3.800907000000734]},"aes128Decrypt":{"times":[0.29103399999803514,1.1475680000003194]},"getPublicKeysAndPartialAddress":{"times":[1.6520550000022922]},"getKeyValidationRequest":{"times":[2.90131399999882]},"storeCapsule":{"times":[0.4697870000018156,4.351926999999705,0.563428000001295]},"deleteCapsule":{"times":[0.5033980000007432]},"validateEnqueuedNotes":{"times":[5.570325000000594]},"getNotes":{"times":[1.6153640000011364]},"getAuthWitness":{"times":[0.23220299999957206]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08138200000394136]},"callPrivateFunction":{"times":[1375.9491629999975]}}},{"functionName":"private_kernel_init","time":79.99063699999533},{"functionName":"StatefulTest:constructor","time":413.03266599999915,"oracles":{"getContractInstance":{"times":[4.649680999995326]},"debugLog":{"times":[0.4890970000051311,0.49762699999701]},"fetchTaggedLogs":{"times":[139.41352199999528]},"loadCapsule":{"times":[0.22762400000647176,0.2971949999991921,0.21795299999939743]},"validateEnqueuedNotes":{"times":[0.9501949999976205]},"storeInExecutionCache":{"times":[0.06782100000418723]},"callPrivateFunction":{"times":[993.848917000003]},"notifyCreatedNullifier":{"times":[0.3293940000003204]}}},{"functionName":"private_kernel_inner","time":151.0050080000001},{"functionName":"StatefulTest:create_note_no_init_check","time":895.8704959999959,"oracles":{"debugLog":{"times":[0.5386079999952926,0.39170600000215927]},"fetchTaggedLogs":{"times":[164.36438199999975]},"loadCapsule":{"times":[0.2194930000041495,0.21221299999888288,0.18190299999696435]},"validateEnqueuedNotes":{"times":[0.8875530000004801]},"getRandomField":{"times":[0.1337920000005397,0.17948299999989104,0.2429539999939152,0.07470099999773083,0.05789100000401959,0.056050999999570195,0.05230100000335369,0.06140099999902304,0.06308100000023842,0.052141000000119675,0.06960099999560043,0.06397000000288244]},"notifyCreatedNote":{"times":[0.16234300000360236]},"getIndexedTaggingSecretAsSender":{"times":[123.97252599999774]},"incrementAppTaggingSecretIndexAsSender":{"times":[84.37031400000706]}}},{"functionName":"private_kernel_inner","time":167.3538469999985},{"functionName":"private_kernel_reset","time":224.76798099999723},{"functionName":"private_kernel_tail","time":83.30583800000022}],"unaccounted":1038.3182650000053}} 19:00:38 [19:00:38.692] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538","blockNumber":2,"slot":132} 19:00:38 [19:00:38.695] VERBOSE: p2p:tx_pool Adding tx 0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82 to pool {"eventName":"tx-added-to-pool","txHash":"0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:00:38 [19:00:38.699] INFO: node Received tx 0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82 {"txHash":"0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82"} 19:00:38 [19:00:38.699] INFO: pxe:service Sent transaction 0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82 19:00:38 [19:00:38.865] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:38 [19:00:38.930] VERBOSE: sequencer:block-builder Building block 2 for slot 132 {"slot":132,"slotStart":"2025-06-04T20:23:15.000Z","now":"2025-06-04T20:23:18.852Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:00:38 [19:00:38.956] VERBOSE: simulator:public-processor Processed tx 0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82 with no public calls in 15.317723000000115ms {"txHash":"0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82","txFee":196507480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":4814},"billedGas":{"daGas":11776,"l2Gas":4814},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":15.317723000000115} 19:00:38 [19:00:38.957] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.025374116999999387s {"duration":0.025374116999999387,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 19:00:39 [19:00:39.040] INFO: sequencer Built block 2 for slot 132 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0bd9a4eb5354774a810540edbcb7e35a9604c4268941287de3177e48b5edc2c9","globalVariables":{"chainId":31337,"version":3883739672,"blockNumber":2,"slotNumber":132,"timestamp":1749068595,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x27907b6bcb7a8b75ffbe805cc573b1c2de41319e48cf516b63a78210999d7c82"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":115.37047599999642,"publicProcessDuration":25.832303000002867,"rollupCircuitsDuration":110.538112000002,"txCount":1,"blockNumber":2,"blockTimestamp":1749068595,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:39 [19:00:39.049] VERBOSE: p2p Broadcasting proposal for slot 132 to peers 19:00:39 [19:00:39.059] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 {"signature":"0x0ee938395d234cc60b68726a81f12897860cc5f65df6639e2f4a2f4541bdd620009f8a1c83ada7b43ecd022631cf3b95a1ad2c6a08c51667e975be3b114cb1411c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","proposalId":"0x042efb913d07a72554781f14af9c6f4fe3d3cd85073333c39b401386650192f9"} 19:00:39 [19:00:39.062] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 {"signature":"0xc41c2c1a394c8fd36d7299b45bc7fff28231676b13ab10f154d29dfb3a963ee9456e72310fd0108c6920efe5aa751e2fb2c452fb0ce28ad63249aca4a72424ff1b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","proposalId":"0x042efb913d07a72554781f14af9c6f4fe3d3cd85073333c39b401386650192f9"} 19:00:39 [19:00:39.067] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc {"signature":"0x0b057c299ccf372a24fdda51c7a65a5c5969ac3cebd116c325821cc2321b514a07cd434b3aeb167937c703d62ff131b4a7ef32a5a4eb3aaf1d36319e3cb2d8e21c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","proposalId":"0x042efb913d07a72554781f14af9c6f4fe3d3cd85073333c39b401386650192f9"} 19:00:39 [19:00:39.068] VERBOSE: validator Collected all 3 attestations for slot 132 19:00:39 [19:00:39.068] VERBOSE: sequencer Collected 3 attestations {"blockHash":"0x0bd9a4eb5354774a810540edbcb7e35a9604c4268941287de3177e48b5edc2c9","blockNumber":2} 19:00:39 [19:00:39.144] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:39 [19:00:39.351] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:39 [19:00:39.354] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x13a032f440cb11d0b6a5770eb6b788ad2106d1105c03bd3f998b99f054a29d06 19:00:39 [19:00:39.355] VERBOSE: node Sent L1 transaction 0x13a032f440cb11d0b6a5770eb6b788ad2106d1105c03bd3f998b99f054a29d06 {"gasLimit":633229,"maxFeePerGas":"1.233593069","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:00:39 [19:00:39.369] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:00:39 [19:00:39.373] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:00:39 [19:00:39.374] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x13a032f440cb11d0b6a5770eb6b788ad2106d1105c03bd3f998b99f054a29d06","calldataSize":1828,"calldataGas":16864,"txCount":1,"blockNumber":2,"blockTimestamp":1749068595,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:39 [19:00:39.374] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:00:39 [19:00:39.376] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:00:39 [19:00:39.378] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:00:39 [19:00:39.380] INFO: blob-sink:server Received blob sidecar for block 0xdbb22000c6df004ff1f122cf5531fcf5b8b8efc706b73c0b483552754a058b37 19:00:39 [19:00:39.386] INFO: blob-sink:server Blob sidecar stored successfully for block 0xdbb22000c6df004ff1f122cf5531fcf5b8b8efc706b73c0b483552754a058b37 19:00:39 [19:00:39.391] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749068631] on http://127.0.0.1:8545 19:00:39 [19:00:39.392] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:00:39 [19:00:39.393] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749068631 19:00:39 [19:00:39.393] WARN: foundation:test-date-provider Time set to 2025-06-04T20:23:51.000Z {"offset":4991607,"timeMs":1749068631000} 19:00:39 [19:00:39.394] INFO: aztecjs:utils:watcher Slot 132 was filled, jumped to next slot 19:00:39 [19:00:39.552] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x0bd9a4eb5354774a810540edbcb7e35a9604c4268941287de3177e48b5edc2c9","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3883739672,"blockNumber":2,"slotNumber":132,"timestamp":1749068595,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x042efb913d07a72554781f14af9c6f4fe3d3cd85073333c39b401386650192f9","archiveNextLeafIndex":3} 19:00:39 [19:00:39.553] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:39 [19:00:39.659] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 19:00:39 [19:00:39.691] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0bd9a4eb5354774a810540edbcb7e35a9604c4268941287de3177e48b5edc2c9","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3883739672,"blockNumber":2,"slotNumber":132,"timestamp":1749068595,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x042efb913d07a72554781f14af9c6f4fe3d3cd85073333c39b401386650192f9","archiveNextLeafIndex":3} 19:00:39 [19:00:39.697] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 19:00:39 [19:00:39.697] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 19:00:39 [19:00:39.702] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 19:00:39 [19:00:39.706] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 19:00:39 [19:00:39.709] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":11.849620000000868,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749068595,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:39 [19:00:39.714] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:00:39 [19:00:39.721] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x042efb913d07a72554781f14af9c6f4fe3d3cd85073333c39b401386650192f9, 0x2fc7320f09e327a83af0a795ba5256b5eed05cfd69853bf5cc4033c46db3d538) 19:00:39 [19:00:39.735] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.4709490000022925,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749068595,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:00:39 [19:00:39.836] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:00:39 [19:00:39.857] INFO: node Stopping 19:00:39 [19:00:39.859] INFO: slasher Slasher client stopped. 19:00:39 [19:00:39.860] INFO: sequencer Stopped sequencer 19:00:39 [19:00:39.861] INFO: p2p P2P client stopped. 19:00:39 [19:00:39.862] INFO: world_state Stopped world state synchronizer 19:00:39 [19:00:39.862] INFO: archiver Stopped. 19:00:39 [19:00:39.863] INFO: node Stopped 19:00:39 [19:00:39.863] INFO: prover-node:prover-node Stopping ProverNode 19:00:39 [19:00:39.863] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 19:00:39 [19:00:39.863] INFO: archiver:prover-node Stopped. 19:00:39 [19:00:39.865] INFO: world_state:prover-node Stopped world state synchronizer 19:00:39 [19:00:39.866] INFO: prover-node:prover-node Stopped ProverNode 19:00:39 [19:00:39.866] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 19:00:39 [19:00:39.866] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/d0775bca 19:00:39 [19:00:39.867] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 19:00:39 [19:00:39.871] INFO: blob-sink:server Stopping blob sink 19:00:39 [19:00:39.871] INFO: blob-sink:server Blob sink stopped 19:00:39 [19:00:39.872] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/6904c27650d468c4 19:00:39 FAIL src/e2e_multi_validator_node.test.ts 19:00:39 e2e_multi_validator_node 19:00:39 ✕ should build blocks & attest with multiple validator keys (17332 ms) 19:00:39 ✓ should attest ONLY with the correct validator keys (12714 ms) 19:00:39 19:00:39 ● e2e_multi_validator_node › should build blocks & attest with multiple validator keys 19:00:39 19:00:39 expect(received).toBeGreaterThanOrEqual(expected) 19:00:39 19:00:39 Expected: >= 4 19:00:39 Received: 0 19:00:39 19:00:39 130 | .map(a => new BlockAttestation(new Fr(block.block.number), payload, a.signature)); 19:00:39 131 | 19:00:39 > 132 | expect(attestations.length).toBeGreaterThanOrEqual(4); // Math.floor((5 * 2) / 3) + 1 19:00:39 | ^ 19:00:39 133 | 19:00:39 134 | const signers = attestations.map(att => att.getSender().toString()); 19:00:39 135 | 19:00:39 19:00:39 at Object.toBeGreaterThanOrEqual (e2e_multi_validator_node.test.ts:132:33) 19:00:39 19:00:39 Test Suites: 1 failed, 1 total 19:00:39 Tests: 1 failed, 1 passed, 2 total 19:00:39 Snapshots: 0 total 19:00:39 Time: 36.598 s 19:00:39 Ran all test suites matching /src\/e2e_multi_validator_node.test.ts/i. 19:00:39 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?