Parent Log: http://ci.aztec-labs.com/ef89dee05ee19866 Command: 664b8957669493e5: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/86188777399fa24dddbced3e11278a65c4c775c0 Env: REF_NAME=gh-readonly-queue/next/pr-14682-ae79e3e0778efb8be2c933c1170eb9502189c9bd CURRENT_VERSION=0.87.4 CI_FULL=1 Date: Mon Jun 2 18:44:02 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14682_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/0d13f39a62f4c76d 18:44:02 +++ id -u 18:44:02 +++ id -g 18:44: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'\''' 18:44:03 + cid=70b13d284d44a1ef5ec33734645993faadaa3caad0529bb60392fc92f8c2f1ff 18:44:03 + set +x 18:44:03 {"level":25,"time":1748889843837,"pid":12,"hostname":"70b13d284d44","module":"logger","msg":"Logger initialized with level verbose"} 18:44:10 [18:44:10.800] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should build blocks & attest with multiple validator keys 18:44:11 [18:44:11.270] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 18:44:11 [18:44:11.876] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-zabzu1/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 18:44:11 [18:44:11.919] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 18:44:11 [18:44:11.948] WARN: e2e:e2e_multi_validator_node Set block interval to 12 18:44:11 [18:44:11.948] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 18:44:12 [18:44:12.033] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 18:44:12 [18:44:12.046] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 18:44:12 [18:44:12.075] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 18:44:12 [18:44:12.084] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 18:44:12 [18:44:12.118] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 18:44:12 [18:44:12.128] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 18:44:12 [18:44:12.146] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 18:44:12 [18:44:12.153] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 18:44:12 [18:44:12.175] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 18:44:12 [18:44:12.181] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 18:44:12 [18:44:12.224] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 18:44:12 [18:44:12.234] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 18:44:12 [18:44:12.264] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 18:44:12 [18:44:12.265] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 18:44:12 [18:44:12.282] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 18:44:12 [18:44:12.292] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 18:44:12 [18:44:12.292] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 18:44:12 [18:44:12.293] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 18:44:12 [18:44:12.322] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:12 [18:44:12.344] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 18:44:12 [18:44:12.345] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 18:44:12 [18:44:12.359] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 18:44:12 [18:44:12.390] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 18:44:12 [18:44:12.395] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 18:44:12 [18:44:12.408] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 18:44:12 [18:44:12.408] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 18:44:12 [18:44:12.432] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 18:44:12 [18:44:12.449] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 18:44:12 [18:44:12.478] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 18:44:12 [18:44:12.479] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 18:44:12 [18:44:12.479] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 18:44:12 [18:44:12.479] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 18:44:12 [18:44:12.502] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:12 [18:44:12.515] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 18:44:12 [18:44:12.534] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 18:44:12 [18:44:12.534] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 18:44:12 [18:44:12.574] 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} 18:44:12 [18:44:12.594] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 18:44:12 [18:44:12.635] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 18:44:12 [18:44:12.644] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 18:44:12 [18:44:12.710] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x37343f55cb1895d754523fe1ae7b2552e12407ba26837f1c43aed13f5a7ba9b7 {"gasLimit":10716781,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 18:44:12 [18:44:12.721] 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} 18:44:12 [18:44:12.722] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 18:44:12 [18:44:12.746] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:12 [18:44:12.746] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 18:44:12 [18:44:12.771] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 18:44:12 [18:44:12.772] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 18:44:12 [18:44:12.790] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xa8897c0adb59c20b46f23cd39fab84926417a78cc6c803792273c45350f8ad09 {"gasLimit":1040116,"maxFeePerGas":"38.520398432","maxPriorityFeePerGas":"38.337599913"} 18:44:12 [18:44:12.796] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 18:44:12 [18:44:12.843] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 {"gasLimit":116846,"maxFeePerGas":"46.165150248","maxPriorityFeePerGas":"46.005119895"} 18:44:12 [18:44:12.844] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 18:44:12 [18:44:12.873] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf {"gasLimit":109478,"maxFeePerGas":"55.347326337","maxPriorityFeePerGas":"55.206143874"} 18:44:12 [18:44:12.874] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf 18:44:12 [18:44:12.913] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf67b1f1a8fadaaa657e2704a0cdb495263f20eedc959e0027719f7c285a36fdb {"gasLimit":362859,"maxFeePerGas":"66.371021863","maxPriorityFeePerGas":"66.247372648"} 18:44:12 [18:44:12.934] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4627582215b058d08ad1d7108f731ce7fa174636ff2ec947460a13f0ae86eb97 {"gasLimit":84823,"maxFeePerGas":"79.605134246","maxPriorityFeePerGas":"79.496847177"} 18:44:12 [18:44:12.987] 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":"0x4e4ec8f9b1f0e9e09d869af02a453d313ad0901dd3dce5bfcb39fd47d053dbc2"} 18:44:12 [18:44:12.988] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 18:44:13 [18:44:13.014] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:13 [18:44:13.021] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 18:44:13 [18:44:13.022] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 18:44:13 [18:44:13.022] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 18:44:13 [18:44:13.057] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:13 [18:44:13.058] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 18:44:13 [18:44:13.078] 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"} 18:44:13 [18:44:13.078] INFO: e2e:e2e_multi_validator_node Handing over to governance 18:44:13 [18:44:13.089] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 18:44:13 [18:44:13.092] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:13 [18:44:13.093] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 18:44:13 [18:44:13.095] INFO: telemetry:client Using NoopTelemetryClient 18:44:13 [18:44:13.101] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:44:13 [18:44:13.102] WARN: foundation:test-date-provider Time set to 2025-06-02T18:49:11.000Z {"offset":297899,"timeMs":1748890151000} 18:44:13 [18:44:13.102] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/41283201a759b0f8/blob-sink with map size 134217728 KB (LMDB v2) 18:44:13 [18:44:13.114] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 18:44:13 [18:44:13.125] INFO: blob-sink:server Server is running on http://localhost:39395 18:44:13 [18:44:13.126] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 18:44:13 [18:44:13.127] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/314cafdd/acvm 18:44:13 [18:44:13.129] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:39395"} 18:44:13 [18:44:13.152] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 18:44:13 [18:44:13.153] INFO: archiver:lmdb Creating archiver data store at directory /tmp/41283201a759b0f8/archiver with map size 134217728 KB (LMDB v2) 18:44:13 [18:44:13.154] INFO: archiver:lmdb Starting data store with maxReaders 16 18:44:13 [18:44:13.343] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:13 [18:44:13.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:13 [18:44:13.631] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:39395"} 18:44:13 [18:44:13.652] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:39395"} 18:44:13 [18:44:13.653] WARN: node:blob-sink:client No L1 consensus host urls configured 18:44:13 [18:44:13.653] WARN: node:blob-sink:client No archive client configured 18:44:13 [18:44:13.656] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 25 with hash 0x87d53bcd9d4e26c524be5785ed4cf301c7109c5b274b99c12f5002e9650a1683 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xb5cb0e13464decff65e4b5e5a505ebe72817a2899ab23593699c609126da472d","l1BlockNumber":18}} 18:44:13 [18:44:13.670] INFO: archiver Initial archiver sync to L1 block 25 complete. {"l1BlockNumber":25,"syncPoint":{"blocksSynchedTo":25,"messagesSynchedTo":{"l1BlockHash":"0x87d53bcd9d4e26c524be5785ed4cf301c7109c5b274b99c12f5002e9650a1683","l1BlockNumber":25}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 18:44:13 [18:44:13.676] INFO: world-state:database Creating world state data store at directory /tmp/41283201a759b0f8/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 18:44:13 [18:44:13.709] INFO: world_state Created world state synchroniser with block history of 64 18:44:13 [18:44:13.709] WARN: node Aztec node is accepting fake proofs 18:44:13 [18:44:13.734] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/41283201a759b0f8/p2p with map size 134217728 KB (LMDB v2) 18:44:13 [18:44:13.738] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 18:44:13 [18:44:13.740] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/41283201a759b0f8/p2p-archive with map size 134217728 KB (LMDB v2) 18:44:13 [18:44:13.743] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 18:44:13 [18:44:13.744] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/41283201a759b0f8/p2p-peers with map size 134217728 KB (LMDB v2) 18:44:13 [18:44:13.746] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 18:44:13 [18:44:13.749] VERBOSE: p2p P2P is disabled. Using dummy P2P service 18:44:13 [18:44:13.752] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 18:44:13 [18:44:13.753] INFO: world_state Started world state synchronizer from block 1 18:44:13 [18:44:13.760] VERBOSE: world-state:block_stream Starting sync from block number 0 18:44:13 [18:44:13.762] INFO: p2p Starting p2p client from block 0 with empty mempools 18:44:13 [18:44:13.763] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 18:44:13 [18:44:13.764] INFO: epoch-prune-watcher EpochPruneWatcher initialized 18:44:13 [18:44:13.773] INFO: slasher Starting Slasher client... 18:44:13 [18:44:13.827] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 18:44:13 [18:44:13.839] VERBOSE: node All Aztec Node subsystems synced 18:44:13 [18:44:13.846] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:13 [18:44:13.850] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 18:44:13 [18:44:13.857] INFO: sequencer-client Deploying forwarder contract 18:44:13 [18:44:13.889] VERBOSE: sequencer-client Sent L1 transaction 0x73b8a88fe86e88bd3176c01e809308cfc403d0da0dad9e2bb353a1e7ea55f50a {"gasLimit":323704,"maxFeePerGas":"95.479418634","maxPriorityFeePerGas":"95.396216612"} 18:44:13 [18:44:13.889] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x73b8a88fe86e88bd3176c01e809308cfc403d0da0dad9e2bb353a1e7ea55f50a. 18:44:13 [18:44:13.903] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 18:44:13 [18:44:13.914] INFO: validator Started validator with addresses: 18:44:13 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 18:44:13 [18:44:13.915] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 18:44:13 [18:44:13.916] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/314cafdd/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 18:44:14 [18:44:14.287] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 18:44:14 [18:44:14.289] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 18:44:14 [18:44:14.301] INFO: node Aztec Node version: 0.87.4 18:44:14 [18:44:14.303] 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"} 18:44:14 [18:44:14.309] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 18:44:14 [18:44:14.385] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:39395"} 18:44:14 [18:44:14.395] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:14 [18:44:14.424] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:44:14 [18:44:14.425] WARN: foundation:test-date-provider Time set to 2025-06-02T18:49:23.000Z {"offset":308576,"timeMs":1748890163000} 18:44:14 [18:44:14.436] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/41283201a759b0f8/d50b18140a28e067/archiver with map size 134217728 KB (LMDB v2) 18:44:14 [18:44:14.454] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":2} 18:44:14 [18:44:14.458] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 18:44:14 [18:44:14.626] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:14 [18:44:14.874] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:15 [18:44:15.006] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:15 [18:44:15.022] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:39395"} 18:44:15 [18:44:15.027] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:39395"} 18:44:15 [18:44:15.028] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 18:44:15 [18:44:15.028] WARN: blob-sink:client:prover-node No archive client configured 18:44:15 [18:44:15.031] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 26 with hash 0x76d7e34eec80bc992fd41a3e706d3ff79ad570c6b94aa0d938c83050294fc6f9 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xb5cb0e13464decff65e4b5e5a505ebe72817a2899ab23593699c609126da472d","l1BlockNumber":18}} 18:44:15 [18:44:15.063] INFO: archiver:prover-node Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26,"messagesSynchedTo":{"l1BlockHash":"0x76d7e34eec80bc992fd41a3e706d3ff79ad570c6b94aa0d938c83050294fc6f9","l1BlockNumber":26}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 18:44:15 [18:44:15.069] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:39395"} 18:44:15 [18:44:15.069] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 18:44:15 [18:44:15.072] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 18:44:15 [18:44:15.088] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/41283201a759b0f8/d50b18140a28e067/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 18:44:15 [18:44:15.116] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:15 [18:44:15.119] INFO: world_state:prover-node Created world state synchroniser with block history of 64 18:44:15 [18:44:15.120] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 18:44:15 [18:44:15.121] INFO: world_state:prover-node Started world state synchronizer from block 1 18:44:15 [18:44:15.123] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 18:44:15 [18:44:15.124] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/41283201a759b0f8/d50b18140a28e067/archiver when loading epoch databases, ignoring 18:44:15 [18:44:15.124] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/41283201a759b0f8/d50b18140a28e067/world_state when loading epoch databases, ignoring 18:44:15 [18:44:15.126] INFO: prover-client:proving-broker:prover-node Proving Broker started 18:44:15 [18:44:15.143] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 18:44:15 [18:44:15.146] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 18:44:15 [18:44:15.147] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 18:44:15 [18:44:15.151] 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/41283201a759b0f8/d50b18140a28e067","l1ChainId":31337,"rollupVersion":2880323404} 18:44:15 [18:44:15.152] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 18:44:15 [18:44:15.160] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/1d3b06b2f52f693a/pxe_data with map size 134217728 KB (LMDB v2) 18:44:15 [18:44:15.163] INFO: pxe:data:lmdb Starting data store with maxReaders 16 18:44:15 [18:44:15.235] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:15 [18:44:15.452] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:15 [18:44:15.526] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:15 [18:44:15.530] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 18:44:15 [18:44:15.530] INFO: pxe:service Started PXE connected to chain 31337 version 2880323404 18:44:15 [18:44:15.585] INFO: pxe:service Registered account 0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762 18:44:15 [18:44:15.649] WARN: pxe:service No artifact found for contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 when looking for its metadata 18:44:15 [18:44:15.654] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 as part of deployment for 0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762 18:44:15 [18:44:15.750] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:15 [18:44:15.800] INFO: pxe:service Added contract SchnorrAccount at 0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762 with class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 18:44:15 [18:44:15.810] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:15 [18:44:15.855] VERBOSE: pxe:block_stream Starting sync from block number 0 18:44:15 [18:44:15.901] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 18:44:16 [18:44:16.027] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:16 [18:44:16.045] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 18:44:16 [18:44:16.840] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09,0x14bef9e6919fcbb4a8f3fa0e00cb393f0d2c2437d1c39371f7ad09355ff0f2fe,0x1d9edc9e571a9e7ab4d2aa454dd024ee819579e3e22ae0fadf28089b29f3f0bc,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 18:44:16 [18:44:16.941] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 18:44:17 [18:44:17.028] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:17 [18:44:17.152] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:17 [18:44:17.241] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:17 [18:44:17.259] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 18:44:17 [18:44:17.261] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:17 [18:44:17.324] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:17 [18:44:17.435] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:17 [18:44:17.442] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 18:44:17 [18:44:17.491] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:17 [18:44:17.605] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:17 [18:44:17.734] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:17 [18:44:17.782] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:17 [18:44:17.850] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 18:44:17 [18:44:17.851] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:17 [18:44:17.866] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:17 [18:44:17.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:17 [18:44:17.980] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:17 [18:44:17.991] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 18:44:18 [18:44:18.041] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762 as fee payer 18:44:18 [18:44:18.173] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:18 [18:44:18.188] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:18 [18:44:18.442] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:18 [18:44:18.583] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:18 [18:44:18.797] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:18 [18:44:18.942] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:19 [18:44:19.107] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:19 [18:44:19.260] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:19 [18:44:19.799] INFO: pxe:service Proving completed in 3947.626769999999ms {"timings":{"total":3947.626769999999,"sync":4.325383999999758,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":200.96491200000128,"oracles":{"callPrivateFunction":{"times":[1035.8116959999988,664.2935079999988,394.78341700000055]}}},{"functionName":"private_kernel_init","time":150.09131800000068},{"functionName":"ContractClassRegisterer:register","time":1005.668470999999,"oracles":{"loadCapsule":{"times":[70.89869399999952]},"notifyCreatedNullifier":{"times":[17.897196999998414]},"debugLog":{"times":[1.1780430000017077]},"notifyCreatedContractClassLog":{"times":[9.01725500000066]}}},{"functionName":"private_kernel_inner","time":195.3249340000002},{"functionName":"SchnorrAccount:constructor","time":627.9149240000006,"oracles":{"getContractInstance":{"times":[11.126236000000063]},"debugLog":{"times":[1.2110539999994216,0.6884030000001076]},"fetchTaggedLogs":{"times":[179.9820469999995]},"loadCapsule":{"times":[0.612092000001212,0.3630269999994198,2.556780000000799]},"validateEnqueuedNotes":{"times":[3.3083740000001853]},"notifyCreatedNullifier":{"times":[0.3471869999993942,0.3871679999992921]},"notifyCreatedNote":{"times":[0.5529999999998836]},"getRandomField":{"times":[0.5564310000008845,0.2940459999990708,0.1633239999991929,0.18389299999944342,0.11012200000004668,0.087561000000278,0.0977920000004815,0.08485099999961676,0.08939199999986158,0.13580200000069453,0.10532199999943259]},"getIndexedTaggingSecretAsSender":{"times":[98.08880999999928]},"incrementAppTaggingSecretIndexAsSender":{"times":[65.56075899999996]}}},{"functionName":"private_kernel_inner","time":149.84812299999976},{"functionName":"SchnorrAccount:entrypoint","time":367.6345020000008,"oracles":{"debugLog":{"times":[0.9381680000005872,0.8622660000000906,1.1753029999999853]},"fetchTaggedLogs":{"times":[138.22037699999964]},"loadCapsule":{"times":[0.30786600000101316,0.29496600000129547,0.3341070000005857]},"validateEnqueuedNotes":{"times":[13.385009999999966]},"getNotes":{"times":[9.480843000001187]},"getAuthWitness":{"times":[0.7473439999994298]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.3632959999995364]}}},{"functionName":"private_kernel_inner","time":166.09775799999989},{"functionName":"private_kernel_reset","time":259.690971},{"functionName":"private_kernel_tail","time":96.89412699999957}],"unaccounted":723.1713459999974}} 18:44:19 [18:44:19.817] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:19 [18:44:19.905] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","blockNumber":1,"slot":3} 18:44:19 [18:44:19.916] VERBOSE: p2p:tx_pool Adding tx 0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b to pool {"eventName":"tx-added-to-pool","txHash":"0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 18:44:19 [18:44:19.943] INFO: node Received tx 0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b {"txHash":"0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b"} 18:44:19 [18:44:19.943] INFO: pxe:service Sent transaction 0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b 18:44:20 [18:44:20.029] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:20 [18:44:20.122] VERBOSE: sequencer Building block 1 for slot 3 {"slot":3,"blockNumber":1,"msgCount":0} 18:44:20 [18:44:20.130] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-02T18:49:35.000Z","now":"2025-06-02T18:49:28.706Z"} 18:44:20 [18:44:20.195] VERBOSE: simulator:public-processor Processed tx 0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b with no public calls in 25.819140999999945ms {"txHash":"0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b","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":25.819140999999945} 18:44:20 [18:44:20.197] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06483408599999893s {"duration":0.06483408599999893,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 18:44:20 [18:44:20.300] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:20 [18:44:20.319] INFO: sequencer Built block 1 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1941397ce15d421d8303c0bf6e89cd90eb0a80742c75721effce19c964382306","globalVariables":{"chainId":31337,"version":2880323404,"blockNumber":1,"slotNumber":3,"timestamp":1748890175,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1b5a5ac7e672f578f012a1379f6de0536e474aca2afe8a94c5b26a3c6307466b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":198.19566900000063,"publicProcessDuration":65.92179699999906,"rollupCircuitsDuration":190.68404400000145,"txCount":1,"blockNumber":1,"blockTimestamp":1748890175,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:20 [18:44:20.323] VERBOSE: sequencer Attesting committee is empty 18:44:20 [18:44:20.508] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:20 [18:44:20.701] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x52fcc025071bae6e84c0bc87e7145a1e4c46628e7720c38f9835440834e1ee3d 18:44:20 [18:44:20.701] VERBOSE: node Sent L1 transaction 0x52fcc025071bae6e84c0bc87e7145a1e4c46628e7720c38f9835440834e1ee3d {"gasLimit":555058,"maxFeePerGas":"114.549196538","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 18:44:20 [18:44:20.714] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:20 [18:44:20.728] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:44:20 [18:44:20.728] WARN: foundation:test-date-provider Time set to 2025-06-02T18:49:35.000Z {"offset":314272,"timeMs":1748890175000} 18:44:20 [18:44:20.732] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:44:20 [18:44:20.733] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x52fcc025071bae6e84c0bc87e7145a1e4c46628e7720c38f9835440834e1ee3d","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1748890175,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:20 [18:44:20.734] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 18:44:20 [18:44:20.739] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 18:44:20 [18:44:20.745] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 18:44:20 [18:44:20.751] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 18:44:20 [18:44:20.769] INFO: blob-sink:server Received blob sidecar for block 0x6e5ebb9ac08082a07cea0250e2e63c08c539c5c892789f38d865383cd94f38de 18:44:20 [18:44:20.781] INFO: blob-sink:server Blob sidecar stored successfully for block 0x6e5ebb9ac08082a07cea0250e2e63c08c539c5c892789f38d865383cd94f38de 18:44:20 [18:44:20.944] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:20 [18:44:20.995] VERBOSE: archiver:block-helper Store contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 18:44:21 [18:44:21.146] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1941397ce15d421d8303c0bf6e89cd90eb0a80742c75721effce19c964382306","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2880323404,"blockNumber":1,"slotNumber":3,"timestamp":1748890175,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","archiveNextLeafIndex":2} 18:44:21 [18:44:21.157] VERBOSE: archiver:block-helper:prover-node Store contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 18:44:21 [18:44:21.166] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1748890211] on http://127.0.0.1:8545 18:44:21 [18:44:21.180] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 18:44:21 [18:44:21.214] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x1941397ce15d421d8303c0bf6e89cd90eb0a80742c75721effce19c964382306","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2880323404,"blockNumber":1,"slotNumber":3,"timestamp":1748890175,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","archiveNextLeafIndex":2} 18:44:21 [18:44:21.215] WARN: ethereum:cheat_codes Warped L1 timestamp to 1748890211 18:44:21 [18:44:21.215] WARN: foundation:test-date-provider Time set to 2025-06-02T18:50:11.000Z {"offset":349785,"timeMs":1748890211000} 18:44:21 [18:44:21.216] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 18:44:21 [18:44:21.216] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:21 [18:44:21.228] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1, 0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4) 18:44:21 [18:44:21.239] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 18:44:21 [18:44:21.260] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 18:44:21 [18:44:21.263] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1748892515] on http://127.0.0.1:8545 18:44:21 [18:44:21.266] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.169513999997434,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1748890175,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:21 [18:44:21.269] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 18:44:21 [18:44:21.274] WARN: ethereum:cheat_codes Warped L1 timestamp to 1748892515 18:44:21 [18:44:21.276] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762 18:44:21 [18:44:21.673] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:21 [18:44:21.690] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:44:21 [18:44:21.690] WARN: foundation:test-date-provider Time set to 2025-06-02T19:28:35.000Z {"offset":2653310,"timeMs":1748892515000} 18:44:21 [18:44:21.695] INFO: pxe:service Added contract StatefulTest at 0x2f3aeddf6314379c5fb71beab76b79e7db64f05e480e8c05f68bbd05e9fb40ab with class 0x0e13c37376e2b54a1e15f6c035d52d5511e7a48e620f090f067dd167dba5b61b 18:44:21 [18:44:21.737] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":16.43055800000002,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1748890175,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:21 [18:44:21.799] VERBOSE: p2p Synched to latest block 1 18:44:21 [18:44:21.817] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","header":{"contentCommitment":{"blobsHash":"0x00df206de2b1b763fc28d5521abe30c3def45ac228f448b5dfe63bc543a35ef0","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1748890175,"version":2880323404},"lastArchive":"0x2618163f90bccf94fa3223af8f6164827415e066db4f628bd20bc98ee6e382e4","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x290838ef3eb8f0bca912cd0a85350c0c243514feceac4d278766dbde2c26a748","nullifierTree":"0x0c6e5ffcd472638d14e975d8a1bc420fc6ca01001edf70073d441071fda7d8bc","publicDataTree":"0x1339746c76b849a6621d122ffa2b3ec06fdb7cc6a4487ad0bdc870a962db36f9"},"totalFees":2101212240,"totalManaUsed":6324}} 18:44:21 [18:44:21.913] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:21 [18:44:21.944] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:21 [18:44:21.990] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 18:44:21 [18:44:21.991] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:22 [18:44:22.106] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:22 [18:44:22.128] INFO: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 is on the validator committee for epoch 2 18:44:22 [18:44:22.129] INFO: validator Validator 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 is on the validator committee for epoch 2 18:44:22 [18:44:22.129] INFO: validator Validator 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc is on the validator committee for epoch 2 18:44:22 [18:44:22.129] INFO: validator Validator 0x90f79bf6eb2c4f870365e785982e1f101e93b906 is on the validator committee for epoch 2 18:44:22 [18:44:22.130] INFO: validator Validator 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 is on the validator committee for epoch 2 18:44:22 [18:44:22.166] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762"} 18:44:22 [18:44:22.172] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d07ed8e09cd31f463f732201ab17a6ceb6944b4874c8d67175b15ffe16daa36 18:44:22 [18:44:22.208] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 18:44:22 [18:44:22.210] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 18:44:22 [18:44:22.217] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:22 [18:44:22.313] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 18:44:22 [18:44:22.314] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 18:44:22 [18:44:22.335] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 18:44:22 [18:44:22.340] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 18:44:22 [18:44:22.382] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 18:44:22 [18:44:22.383] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 18:44:22 [18:44:22.407] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:22 [18:44:22.415] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 18:44:22 [18:44:22.440] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0eda87f9134af673cbd19a7dc1ead044f06aedf5dda01e06dc7bcde7b81eb7c8","nullifier":"0x1b0f5290fbc4f78ac6c30e75345c44148646b430b1e5ff8c7b4983e383ce64b2"} 18:44:22 [18:44:22.462] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2891f4fe886b04b25b8489abeee874327316faf755141da43bb53c5dcd99f762 as fee payer 18:44:22 [18:44:22.466] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:22 [18:44:22.648] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x2f3aeddf6314379c5fb71beab76b79e7db64f05e480e8c05f68bbd05e9fb40ab"} 18:44:22 [18:44:22.676] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 18:44:22 [18:44:22.677] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2f3aeddf6314379c5fb71beab76b79e7db64f05e480e8c05f68bbd05e9fb40ab"} 18:44:22 [18:44:22.685] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:22 [18:44:22.716] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:22 [18:44:22.848] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2f3aeddf6314379c5fb71beab76b79e7db64f05e480e8c05f68bbd05e9fb40ab"} 18:44:22 [18:44:22.853] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 18:44:22 [18:44:22.979] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:23 [18:44:23.114] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x2f3aeddf6314379c5fb71beab76b79e7db64f05e480e8c05f68bbd05e9fb40ab"} 18:44:23 [18:44:23.155] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 18:44:23 [18:44:23.156] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2f3aeddf6314379c5fb71beab76b79e7db64f05e480e8c05f68bbd05e9fb40ab"} 18:44:23 [18:44:23.189] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:23 [18:44:23.274] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:23 [18:44:23.300] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2f3aeddf6314379c5fb71beab76b79e7db64f05e480e8c05f68bbd05e9fb40ab"} 18:44:23 [18:44:23.304] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 18:44:23 [18:44:23.476] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:23 [18:44:23.534] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:23 [18:44:23.743] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:23 [18:44:23.783] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:24 [18:44:24.036] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:24 [18:44:24.292] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:24 [18:44:24.745] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:25 [18:44:25.190] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:25 [18:44:25.227] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:25 [18:44:25.426] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:25 [18:44:25.821] INFO: pxe:service Proving completed in 4031.9756869999983ms {"timings":{"total":4031.9756869999983,"sync":33.95999699999811,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":670.3516379999965,"oracles":{"debugLog":{"times":[0.9821389999997336,0.7214739999981248,0.8704569999972591,1.1393019999995886,0.586870999999519,0.3916270000008808,0.43159799999921233,1.0766910000020289]},"fetchTaggedLogs":{"times":[178.10959100000036]},"loadCapsule":{"times":[0.3908479999990959,0.6363319999982195,0.8445160000010219,5.432525999996869,2.375636000000668,0.771984999999404,0.6083909999979369]},"getSharedSecret":{"times":[10.66581700000097]},"aes128Decrypt":{"times":[8.683019000000058,1.8498560000007274]},"getPublicKeysAndPartialAddress":{"times":[67.71315200000026]},"getKeyValidationRequest":{"times":[95.87516699999833]},"storeCapsule":{"times":[10.014424000000872,3.624981000000844,2.743462999998883]},"deleteCapsule":{"times":[5.588847999999416]},"validateEnqueuedNotes":{"times":[27.91073099999994]},"getNotes":{"times":[2.6944320000002335]},"getAuthWitness":{"times":[0.301354999999603]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09016200000041863]},"callPrivateFunction":{"times":[1111.8886999999995]}}},{"functionName":"private_kernel_init","time":95.44328200000018},{"functionName":"StatefulTest:constructor","time":418.789681000002,"oracles":{"getContractInstance":{"times":[6.442415000001347]},"debugLog":{"times":[0.7245739999998477,0.5423210000008112]},"fetchTaggedLogs":{"times":[174.31560199999876]},"loadCapsule":{"times":[0.21236399999907007,0.6833939999996801,0.31637599999885424]},"validateEnqueuedNotes":{"times":[1.0803309999973862]},"storeInExecutionCache":{"times":[0.30378600000040024]},"callPrivateFunction":{"times":[705.591811000002]},"notifyCreatedNullifier":{"times":[0.36744700000053854]}}},{"functionName":"private_kernel_inner","time":131.9130299999997},{"functionName":"StatefulTest:create_note_no_init_check","time":647.6035059999995,"oracles":{"debugLog":{"times":[0.7071630000027653,0.5329910000000382]},"fetchTaggedLogs":{"times":[147.19017600000006]},"loadCapsule":{"times":[0.24363499999890337,0.3190970000032394,0.23871499999950174]},"validateEnqueuedNotes":{"times":[1.4878280000011728]},"getRandomField":{"times":[0.5780620000005001,0.272305000002234,0.2949160000025586,0.08404199999858974,0.06800099999964004,0.06135100000028615,0.06074099999750615,0.052590999999665655,0.050931000001583016,0.05713099999775295,0.051350000001548324,0.045311000001674984]},"notifyCreatedNote":{"times":[0.36744700000053854]},"getIndexedTaggingSecretAsSender":{"times":[97.64214499999798]},"incrementAppTaggingSecretIndexAsSender":{"times":[106.62837899999795]}}},{"functionName":"private_kernel_inner","time":177.82470000000103},{"functionName":"private_kernel_reset","time":283.5335509999968},{"functionName":"private_kernel_tail","time":111.08366500000193}],"unaccounted":1461.4726370000026}} 18:44:25 [18:44:25.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:25 [18:44:25.929] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1","blockNumber":2,"slot":68} 18:44:25 [18:44:25.940] VERBOSE: p2p:tx_pool Adding tx 0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d to pool {"eventName":"tx-added-to-pool","txHash":"0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 18:44:25 [18:44:25.979] INFO: node Received tx 0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d {"txHash":"0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d"} 18:44:25 [18:44:25.979] INFO: pxe:service Sent transaction 0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d 18:44:26 [18:44:26.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:26 [18:44:26.163] VERBOSE: sequencer Building block 2 for slot 68 {"slot":68,"blockNumber":2,"msgCount":0} 18:44:26 [18:44:26.184] VERBOSE: sequencer Processing pending txs {"slot":68,"slotStart":"2025-06-02T19:28:35.000Z","now":"2025-06-02T19:28:39.494Z"} 18:44:26 [18:44:26.243] VERBOSE: simulator:public-processor Processed tx 0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d with no public calls in 29.24323699999877ms {"txHash":"0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d","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":29.24323699999877} 18:44:26 [18:44:26.245] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05904522599999837s {"duration":0.05904522599999837,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 18:44:26 [18:44:26.369] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:26 [18:44:26.391] INFO: sequencer Built block 2 for slot 68 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x200f16cdd24be351187970c4ac88eb11df66f3488211a10403b7ef9e45c8ad7c","globalVariables":{"chainId":31337,"version":2880323404,"blockNumber":2,"slotNumber":68,"timestamp":1748892515,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x0e96417a1343612b4a820eb8ead6144658bddb95b22ec496fdcfeba57482044d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":228.87566099999822,"publicProcessDuration":59.70148799999879,"rollupCircuitsDuration":212.76050899999973,"txCount":1,"blockNumber":2,"blockTimestamp":1748892515,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:44:26 [18:44:26.403] VERBOSE: p2p Broadcasting proposal for slot 68 to peers 18:44:26 [18:44:26.427] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 {"signature":"0x26cc9e8fd025064dd6c074f6c36e5a360fb7e3e7e54ab0bcb5a58342286136026b6b1cda0ec21254729a6298e6e98f22a3a8704206ceef37d5c32536bfa8b5711c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","proposalId":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f"} 18:44:26 [18:44:26.432] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 {"signature":"0xdb2efccd003266654d029f338a03ebc84813df22ae7c5bec7fa1c30217c76fd022e8b7486e5beeeb9b4f17b91bacf2e121559c8c047322c027149fdfa92ef4e11c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","proposalId":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f"} 18:44:26 [18:44:26.438] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc {"signature":"0x730172f0c6234ac8d9fb45f1594388c83cf899717d264419ae6a939135e616104a0bcc33b085d8dceda3d806e0d33cf3d95a5f5ed0a396700a640a52bb7cee471c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","proposalId":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f"} 18:44:26 [18:44:26.443] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x90f79bf6eb2c4f870365e785982e1f101e93b906 {"signature":"0x7cd9791eac6f3c3a0fd1c3759f79c38871ca4cc5bc0659c870319e28160f8b2441cc2b48e202bb44a8761bd55770ed990a94cafa54619b844c0b08efd23e01a81b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","proposalId":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f"} 18:44:26 [18:44:26.447] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 {"signature":"0xaa97a69b0b69e20846c4bdc8dec220c7dff3b57e934fee47082cb0ab2c65567222da11adcb86ddbacb6216b38910e7ba1ea7ba193a31239c8232be1ab31e32051c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","proposalId":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f"} 18:44:26 [18:44:26.448] VERBOSE: validator Collected all 4 attestations for slot 68 18:44:26 [18:44:26.448] VERBOSE: sequencer Collected 5 attestations {"blockHash":"0x200f16cdd24be351187970c4ac88eb11df66f3488211a10403b7ef9e45c8ad7c","blockNumber":2} 18:44:26 [18:44:26.589] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:26 [18:44:26.820] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:26 [18:44:26.848] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x5c762cffae3108b0a56ce7c62d6cbecce1e9760920425c373554068b282c644a 18:44:26 [18:44:26.849] VERBOSE: node Sent L1 transaction 0x5c762cffae3108b0a56ce7c62d6cbecce1e9760920425c373554068b282c644a {"gasLimit":660414,"maxFeePerGas":"1.249716403","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 18:44:26 [18:44:26.875] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1748892551] on http://127.0.0.1:8545 18:44:26 [18:44:26.881] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 18:44:26 [18:44:26.889] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:44:26 [18:44:26.890] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x5c762cffae3108b0a56ce7c62d6cbecce1e9760920425c373554068b282c644a","calldataSize":2084,"calldataGas":19928,"txCount":1,"blockNumber":2,"blockTimestamp":1748892515,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:44:26 [18:44:26.891] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 18:44:26 [18:44:26.894] WARN: ethereum:cheat_codes Warped L1 timestamp to 1748892551 18:44:26 [18:44:26.894] WARN: foundation:test-date-provider Time set to 2025-06-02T19:29:11.000Z {"offset":2684106,"timeMs":1748892551000} 18:44:26 [18:44:26.895] INFO: aztecjs:utils:watcher Slot 68 was filled, jumped to next slot 18:44:26 [18:44:26.906] INFO: blob-sink:server Received blob sidecar for block 0xf84afbb2df11cf9b13ca21da12586ba074691163bab2770a4c2edf20de59fe15 18:44:26 [18:44:26.915] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf84afbb2df11cf9b13ca21da12586ba074691163bab2770a4c2edf20de59fe15 18:44:27 [18:44:27.078] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:27 [18:44:27.102] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 18:44:27 [18:44:27.250] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 18:44:27 [18:44:27.256] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x200f16cdd24be351187970c4ac88eb11df66f3488211a10403b7ef9e45c8ad7c","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2880323404,"blockNumber":2,"slotNumber":68,"timestamp":1748892515,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f","archiveNextLeafIndex":3} 18:44:27 [18:44:27.260] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 18:44:27 [18:44:27.280] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x200f16cdd24be351187970c4ac88eb11df66f3488211a10403b7ef9e45c8ad7c","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2880323404,"blockNumber":2,"slotNumber":68,"timestamp":1748892515,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f","archiveNextLeafIndex":3} 18:44:27 [18:44:27.290] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:27 [18:44:27.302] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f, 0x1328b2ffd545e7f8a895a79e524987b42ca5de53c21fbb0979075317b17489b1) 18:44:27 [18:44:27.319] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.52043500000218,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1748892515,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:44:27 [18:44:27.320] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.68453800000134,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1748892515,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:44:27 [18:44:27.494] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:27 [18:44:27.546] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 18:44:27 [18:44:27.552] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 18:44:27 [18:44:27.553] VERBOSE: p2p Synched to latest block 2 18:44:27 [18:44:27.702] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:27 [18:44:27.766] VERBOSE: sequencer Not enough txs to build block 3 at slot 69 (got 0 txs, need 1) {"chainTipArchive":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f","blockNumber":3,"slot":69} 18:44:27 [18:44:27.887] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 18:44:27 [18:44:27.888] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 18:44:27 [18:44:27.890] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 18:44:27 [18:44:27.890] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 18:44:27 [18:44:27.916] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:28 [18:44:28.026] VERBOSE: sequencer Not enough txs to build block 3 at slot 69 (got 0 txs, need 1) {"chainTipArchive":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f","blockNumber":3,"slot":69} 18:44:28 [18:44:28.215] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:28 [18:44:28.302] VERBOSE: sequencer Not enough txs to build block 3 at slot 69 (got 0 txs, need 1) {"chainTipArchive":"0x1a0f45301a1b13dce04423d4f2715d2261d097c1b0f0be2bb4ed1d3d1f9ed27f","blockNumber":3,"slot":69} 18:44:28 [18:44:28.304] INFO: node Stopping 18:44:28 [18:44:28.307] INFO: slasher Slasher client stopped. 18:44:28 [18:44:28.308] INFO: sequencer Stopped sequencer 18:44:28 [18:44:28.309] INFO: p2p P2P client stopped. 18:44:28 [18:44:28.315] INFO: world_state Stopped world state synchronizer 18:44:28 [18:44:28.322] INFO: archiver Stopped. 18:44:28 [18:44:28.326] INFO: node Stopped 18:44:28 [18:44:28.327] INFO: prover-node:prover-node Stopping ProverNode 18:44:28 [18:44:28.327] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 18:44:28 [18:44:28.328] INFO: archiver:prover-node Stopped. 18:44:28 [18:44:28.339] INFO: world_state:prover-node Stopped world state synchronizer 18:44:28 [18:44:28.340] INFO: prover-node:prover-node Stopped ProverNode 18:44:28 [18:44:28.340] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 18:44:28 [18:44:28.341] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/314cafdd 18:44:28 [18:44:28.344] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 18:44:28 [18:44:28.361] INFO: blob-sink:server Stopping blob sink 18:44:28 [18:44:28.362] INFO: blob-sink:server Blob sink stopped 18:44:28 [18:44:28.362] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/41283201a759b0f8 18:44:28 [18:44:28.370] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should attest ONLY with the correct validator keys 18:44:28 [18:44:28.656] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 18:44:28 [18:44:28.702] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-blBMUG/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 18:44:28 [18:44:28.743] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 18:44:28 [18:44:28.748] WARN: e2e:e2e_multi_validator_node Set block interval to 12 18:44:28 [18:44:28.749] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 18:44:28 [18:44:28.786] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 18:44:28 [18:44:28.810] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 18:44:28 [18:44:28.840] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 18:44:28 [18:44:28.846] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 18:44:28 [18:44:28.878] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 18:44:28 [18:44:28.889] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 18:44:28 [18:44:28.914] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 18:44:28 [18:44:28.921] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 18:44:28 [18:44:28.940] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 18:44:28 [18:44:28.952] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 18:44:28 [18:44:28.989] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 18:44:28 [18:44:28.995] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 18:44:29 [18:44:29.018] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 18:44:29 [18:44:29.018] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 18:44:29 [18:44:29.036] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 18:44:29 [18:44:29.049] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 18:44:29 [18:44:29.050] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 18:44:29 [18:44:29.050] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 18:44:29 [18:44:29.070] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:29 [18:44:29.085] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 18:44:29 [18:44:29.086] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 18:44:29 [18:44:29.106] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 18:44:29 [18:44:29.129] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 18:44:29 [18:44:29.135] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 18:44:29 [18:44:29.150] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 18:44:29 [18:44:29.150] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 18:44:29 [18:44:29.163] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 18:44:29 [18:44:29.174] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 18:44:29 [18:44:29.195] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 18:44:29 [18:44:29.195] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 18:44:29 [18:44:29.196] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 18:44:29 [18:44:29.196] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 18:44:29 [18:44:29.234] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:29 [18:44:29.251] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 18:44:29 [18:44:29.278] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 18:44:29 [18:44:29.279] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 18:44:29 [18:44:29.281] 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} 18:44:29 [18:44:29.290] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 18:44:29 [18:44:29.331] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 18:44:29 [18:44:29.339] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 18:44:29 [18:44:29.391] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x1392e3727f92d15b8ed0da9c71680377a12578bc64cddf70d88ff215b3952a88 {"gasLimit":10716781,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 18:44:29 [18:44:29.401] 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} 18:44:29 [18:44:29.401] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 18:44:29 [18:44:29.447] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:29 [18:44:29.447] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 18:44:29 [18:44:29.461] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 18:44:29 [18:44:29.462] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 18:44:29 [18:44:29.475] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xa8897c0adb59c20b46f23cd39fab84926417a78cc6c803792273c45350f8ad09 {"gasLimit":1040116,"maxFeePerGas":"38.520398432","maxPriorityFeePerGas":"38.337599913"} 18:44:29 [18:44:29.479] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 18:44:29 [18:44:29.507] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 {"gasLimit":116846,"maxFeePerGas":"46.165150248","maxPriorityFeePerGas":"46.005119895"} 18:44:29 [18:44:29.508] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 18:44:29 [18:44:29.523] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf {"gasLimit":109478,"maxFeePerGas":"55.347326337","maxPriorityFeePerGas":"55.206143874"} 18:44:29 [18:44:29.524] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf 18:44:29 [18:44:29.526] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 18:44:29 [18:44:29.560] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:29 [18:44:29.569] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 18:44:29 [18:44:29.569] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 18:44:29 [18:44:29.570] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 18:44:29 [18:44:29.591] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 18:44:29 [18:44:29.591] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 18:44:29 [18:44:29.614] 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"} 18:44:29 [18:44:29.615] INFO: e2e:e2e_multi_validator_node Handing over to governance 18:44:29 [18:44:29.621] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 18:44:29 [18:44:29.623] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:29 [18:44:29.624] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 18:44:29 [18:44:29.632] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/33f8421fa40de734/blob-sink with map size 134217728 KB (LMDB v2) 18:44:29 [18:44:29.634] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:44:29 [18:44:29.635] WARN: foundation:test-date-provider Time set to 2025-06-02T18:48:52.000Z {"offset":262365,"timeMs":1748890132000} 18:44:29 [18:44:29.644] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 18:44:29 [18:44:29.648] INFO: blob-sink:server Server is running on http://localhost:46373 18:44:29 [18:44:29.648] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 18:44:29 [18:44:29.649] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/b80278c0/acvm 18:44:29 [18:44:29.650] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:46373"} 18:44:29 [18:44:29.668] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 18:44:29 [18:44:29.669] INFO: archiver:lmdb Creating archiver data store at directory /tmp/33f8421fa40de734/archiver with map size 134217728 KB (LMDB v2) 18:44:29 [18:44:29.672] INFO: archiver:lmdb Starting data store with maxReaders 16 18:44:29 [18:44:29.887] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:30 [18:44:30.011] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:46373"} 18:44:30 [18:44:30.023] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:46373"} 18:44:30 [18:44:30.024] WARN: node:blob-sink:client No L1 consensus host urls configured 18:44:30 [18:44:30.024] WARN: node:blob-sink:client No archive client configured 18:44:30 [18:44:30.029] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 22 with hash 0x1e521d71907b7b04294c8484e6cec68463c5a57ad8c979037a47272c4d137c0e {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x84b4ce88f7f05e145110d72346dac0c74e50e01ad7112a6e970f2d8a00e6e4c1","l1BlockNumber":18}} 18:44:30 [18:44:30.043] INFO: archiver Initial archiver sync to L1 block 22 complete. {"l1BlockNumber":22,"syncPoint":{"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0x1e521d71907b7b04294c8484e6cec68463c5a57ad8c979037a47272c4d137c0e","l1BlockNumber":22}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 18:44:30 [18:44:30.050] INFO: world-state:database Creating world state data store at directory /tmp/33f8421fa40de734/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 18:44:30 [18:44:30.079] INFO: world_state Created world state synchroniser with block history of 64 18:44:30 [18:44:30.079] WARN: node Aztec node is accepting fake proofs 18:44:30 [18:44:30.088] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/33f8421fa40de734/p2p with map size 134217728 KB (LMDB v2) 18:44:30 [18:44:30.090] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:30 [18:44:30.092] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 18:44:30 [18:44:30.095] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/33f8421fa40de734/p2p-archive with map size 134217728 KB (LMDB v2) 18:44:30 [18:44:30.096] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 18:44:30 [18:44:30.100] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/33f8421fa40de734/p2p-peers with map size 134217728 KB (LMDB v2) 18:44:30 [18:44:30.101] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 18:44:30 [18:44:30.104] VERBOSE: p2p P2P is disabled. Using dummy P2P service 18:44:30 [18:44:30.106] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 18:44:30 [18:44:30.107] INFO: world_state Started world state synchronizer from block 1 18:44:30 [18:44:30.108] VERBOSE: world-state:block_stream Starting sync from block number 0 18:44:30 [18:44:30.109] INFO: p2p Starting p2p client from block 0 with empty mempools 18:44:30 [18:44:30.109] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 18:44:30 [18:44:30.110] INFO: epoch-prune-watcher EpochPruneWatcher initialized 18:44:30 [18:44:30.116] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 18:44:30 [18:44:30.117] INFO: slasher Starting Slasher client... 18:44:30 [18:44:30.125] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 18:44:30 [18:44:30.126] VERBOSE: node All Aztec Node subsystems synced 18:44:30 [18:44:30.143] INFO: sequencer-client Deploying forwarder contract 18:44:30 [18:44:30.175] VERBOSE: sequencer-client Sent L1 transaction 0xd55cdb6ebb71ba0fcaadbf6ded6a5b8e0f60991502922716080b2393915bf73f {"gasLimit":323704,"maxFeePerGas":"66.371021863","maxPriorityFeePerGas":"66.247372648"} 18:44:30 [18:44:30.175] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0xd55cdb6ebb71ba0fcaadbf6ded6a5b8e0f60991502922716080b2393915bf73f. 18:44:30 [18:44:30.182] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 18:44:30 [18:44:30.191] INFO: validator Started validator with addresses: 18:44:30 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 18:44:30 [18:44:30.192] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 18:44:30 [18:44:30.192] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/b80278c0/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 18:44:30 [18:44:30.192] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 18:44:30 [18:44:30.193] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 18:44:30 [18:44:30.194] INFO: node Aztec Node version: 0.87.4 18:44:30 [18:44:30.194] 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"} 18:44:30 [18:44:30.195] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 18:44:30 [18:44:30.220] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:46373"} 18:44:30 [18:44:30.224] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/33f8421fa40de734/6b559f85439a3165/archiver with map size 134217728 KB (LMDB v2) 18:44:30 [18:44:30.228] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":1} 18:44:30 [18:44:30.228] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 18:44:30 [18:44:30.328] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:30 [18:44:30.338] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:44:30 [18:44:30.339] WARN: foundation:test-date-provider Time set to 2025-06-02T18:49:04.000Z {"offset":273661,"timeMs":1748890144000} 18:44:30 [18:44:30.461] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:30 [18:44:30.536] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:46373"} 18:44:30 [18:44:30.540] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:46373"} 18:44:30 [18:44:30.540] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 18:44:30 [18:44:30.540] WARN: blob-sink:client:prover-node No archive client configured 18:44:30 [18:44:30.541] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:30 [18:44:30.545] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 23 with hash 0xf72d569d1e414babeec299236f3074d963409931ffc4c8de4375888e9b9bb2e4 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x84b4ce88f7f05e145110d72346dac0c74e50e01ad7112a6e970f2d8a00e6e4c1","l1BlockNumber":18}} 18:44:30 [18:44:30.556] INFO: archiver:prover-node Initial archiver sync to L1 block 23 complete. {"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0xf72d569d1e414babeec299236f3074d963409931ffc4c8de4375888e9b9bb2e4","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 18:44:30 [18:44:30.558] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:46373"} 18:44:30 [18:44:30.558] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 18:44:30 [18:44:30.559] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 18:44:30 [18:44:30.566] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/33f8421fa40de734/6b559f85439a3165/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 18:44:30 [18:44:30.597] INFO: world_state:prover-node Created world state synchroniser with block history of 64 18:44:30 [18:44:30.599] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 18:44:30 [18:44:30.599] INFO: world_state:prover-node Started world state synchronizer from block 1 18:44:30 [18:44:30.600] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 18:44:30 [18:44:30.601] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/33f8421fa40de734/6b559f85439a3165/archiver when loading epoch databases, ignoring 18:44:30 [18:44:30.601] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/33f8421fa40de734/6b559f85439a3165/world_state when loading epoch databases, ignoring 18:44:30 [18:44:30.602] INFO: prover-client:proving-broker:prover-node Proving Broker started 18:44:30 [18:44:30.611] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 18:44:30 [18:44:30.611] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 18:44:30 [18:44:30.612] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 18:44:30 [18:44:30.614] 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/33f8421fa40de734/6b559f85439a3165","l1ChainId":31337,"rollupVersion":265534916} 18:44:30 [18:44:30.614] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 18:44:30 [18:44:30.615] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/c84bd95cbce6709b/pxe_data with map size 134217728 KB (LMDB v2) 18:44:30 [18:44:30.616] INFO: pxe:data:lmdb Starting data store with maxReaders 16 18:44:30 [18:44:30.829] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:30 [18:44:30.919] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:30 [18:44:30.969] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 18:44:30 [18:44:30.970] INFO: pxe:service Started PXE connected to chain 31337 version 265534916 18:44:31 [18:44:31.022] INFO: pxe:service Registered account 0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5 18:44:31 [18:44:31.094] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:31 [18:44:31.096] WARN: pxe:service No artifact found for contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 when looking for its metadata 18:44:31 [18:44:31.101] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 as part of deployment for 0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5 18:44:31 [18:44:31.159] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:31 [18:44:31.286] INFO: pxe:service Added contract SchnorrAccount at 0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5 with class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 18:44:31 [18:44:31.316] VERBOSE: pxe:block_stream Starting sync from block number 0 18:44:31 [18:44:31.351] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:31 [18:44:31.361] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 18:44:31 [18:44:31.388] WARN: sequencer Error closing forks for block processing {"generatedMessage":false,"code":"ERR_ASSERTION","actual":false,"expected":true,"operator":"=="} 18:44:31 [18:44:31.399] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:31 [18:44:31.470] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 18:44:31 [18:44:31.971] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09,0x14bef9e6919fcbb4a8f3fa0e00cb393f0d2c2437d1c39371f7ad09355ff0f2fe,0x1d9edc9e571a9e7ab4d2aa454dd024ee819579e3e22ae0fadf28089b29f3f0bc,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 18:44:32 [18:44:32.104] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 18:44:32 [18:44:32.168] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:32 [18:44:32.194] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:32 [18:44:32.295] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5"} 18:44:32 [18:44:32.348] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 18:44:32 [18:44:32.349] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5"} 18:44:32 [18:44:32.381] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:32 [18:44:32.416] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:32 [18:44:32.422] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5"} 18:44:32 [18:44:32.431] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 18:44:32 [18:44:32.593] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:32 [18:44:32.734] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5"} 18:44:32 [18:44:32.782] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 18:44:32 [18:44:32.783] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5"} 18:44:32 [18:44:32.786] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:32 [18:44:32.809] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:32 [18:44:32.834] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5"} 18:44:32 [18:44:32.837] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 18:44:32 [18:44:32.852] VERBOSE: simulator:client_execution_context:debug_log Setting 0x18e2a76cac99d0ba40ca4d1b6f1ac9d5baf6b4efe3a9710d9a3cb5c6d77e8ac5 as fee payer 18:44:33 [18:44:33.039] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:33 [18:44:33.147] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:33 [18:44:33.303] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:33 [18:44:33.446] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:33 [18:44:33.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:33 [18:44:33.716] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:34 [18:44:34.258] INFO: pxe:service Proving completed in 2949.642631999999ms {"timings":{"total":2949.642631999999,"sync":8.258381000003283,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":162.66566700000112,"oracles":{"callPrivateFunction":{"times":[788.04637,414.4667819999995,282.77301700000316]}}},{"functionName":"private_kernel_init","time":85.28840599999967},{"functionName":"ContractClassRegisterer:register","time":763.3875420000004,"oracles":{"loadCapsule":{"times":[5.613357999998698]},"notifyCreatedNullifier":{"times":[0.5848609999993641]},"debugLog":{"times":[0.5988010000000941]},"notifyCreatedContractClassLog":{"times":[15.3872080000001]}}},{"functionName":"private_kernel_inner","time":136.05227000000014},{"functionName":"SchnorrAccount:constructor","time":367.10912299999836,"oracles":{"getContractInstance":{"times":[1.7260329999990063]},"debugLog":{"times":[0.7532240000000456,0.7556440000007569]},"fetchTaggedLogs":{"times":[78.647696]},"loadCapsule":{"times":[1.223204000001715,1.0847109999995155,0.5256110000009357]},"validateEnqueuedNotes":{"times":[1.708133000000089]},"notifyCreatedNullifier":{"times":[0.3812680000010005,0.383138000001054]},"notifyCreatedNote":{"times":[0.2849950000017998]},"getRandomField":{"times":[0.30582499999945867,0.26057500000024447,0.08390199999848846,0.06436100000064471,0.05797100000199862,0.106021999999939,0.0614209999985178,0.05361099999936414,0.0603609999998298,0.05934200000046985,0.052421999997022795]},"getIndexedTaggingSecretAsSender":{"times":[70.63646099999823]},"incrementAppTaggingSecretIndexAsSender":{"times":[37.05594899999778]}}},{"functionName":"private_kernel_inner","time":114.44799000000057},{"functionName":"SchnorrAccount:entrypoint","time":239.92320499999914,"oracles":{"debugLog":{"times":[0.6477129999984754,0.36132699999870965,0.6889540000011039]},"fetchTaggedLogs":{"times":[53.011098999999376]},"loadCapsule":{"times":[0.19781399999919813,0.21702499999810243,0.18553400000018883]},"validateEnqueuedNotes":{"times":[0.8703969999987748]},"getNotes":{"times":[1.2728040000001783]},"getAuthWitness":{"times":[0.29532599999947706]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4714690000000701]}}},{"functionName":"private_kernel_inner","time":155.84013299999788},{"functionName":"private_kernel_reset","time":271.09411999999793},{"functionName":"private_kernel_tail","time":103.12354100000084}],"unaccounted":542.4522539999998}} 18:44:34 [18:44:34.281] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:34 [18:44:34.388] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e","blockNumber":1,"slot":2} 18:44:34 [18:44:34.396] VERBOSE: p2p:tx_pool Adding tx 0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903 to pool {"eventName":"tx-added-to-pool","txHash":"0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 18:44:34 [18:44:34.421] INFO: node Received tx 0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903 {"txHash":"0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903"} 18:44:34 [18:44:34.422] INFO: pxe:service Sent transaction 0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903 18:44:34 [18:44:34.498] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:34 [18:44:34.608] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 18:44:34 [18:44:34.617] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-02T18:49:16.000Z","now":"2025-06-02T18:49:08.278Z"} 18:44:34 [18:44:34.665] VERBOSE: simulator:public-processor Processed tx 0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903 with no public calls in 24.174889000001713ms {"txHash":"0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903","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":24.174889000001713} 18:44:34 [18:44:34.667] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.048408260000000154s {"duration":0.048408260000000154,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 18:44:34 [18:44:34.768] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:34 [18:44:34.779] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x23c068cc62980221c7028d33eef3b2b58f0853f5af004b0a98a8ab52cb1ec6bf","globalVariables":{"chainId":31337,"version":265534916,"blockNumber":1,"slotNumber":2,"timestamp":1748890156,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1719657f9eaa6c456380fcda3cca275d0aa645fa3479a72a28347fe0c9479903"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":172.47294700000202,"publicProcessDuration":48.88060899999982,"rollupCircuitsDuration":164.01253300000099,"txCount":1,"blockNumber":1,"blockTimestamp":1748890156,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:34 [18:44:34.785] VERBOSE: sequencer Attesting committee is empty 18:44:34 [18:44:34.977] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:35 [18:44:35.191] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:35 [18:44:35.199] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4a1bb4efcad3f46f7192d2e0984b5e139f893eb9cdd11aa411ffabf386366d8f 18:44:35 [18:44:35.199] VERBOSE: node Sent L1 transaction 0x4a1bb4efcad3f46f7192d2e0984b5e139f893eb9cdd11aa411ffabf386366d8f {"gasLimit":555075,"maxFeePerGas":"79.605134246","maxPriorityFeePerGas":"79.496847177","maxFeePerBlobGas":"0.000000001"} 18:44:35 [18:44:35.210] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 18:44:35 [18:44:35.218] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 18:44:35 [18:44:35.225] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 18:44:35 [18:44:35.238] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:44:35 [18:44:35.239] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4a1bb4efcad3f46f7192d2e0984b5e139f893eb9cdd11aa411ffabf386366d8f","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1748890156,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:35 [18:44:35.240] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 18:44:35 [18:44:35.253] INFO: blob-sink:server Received blob sidecar for block 0x87ad91cf78a6a2962d9dee34363eebb10937aba874b80bb7e20a71ca2c2614ca 18:44:35 [18:44:35.274] INFO: blob-sink:server Blob sidecar stored successfully for block 0x87ad91cf78a6a2962d9dee34363eebb10937aba874b80bb7e20a71ca2c2614ca 18:44:35 [18:44:35.402] VERBOSE: archiver:block-helper Store contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 18:44:35 [18:44:35.407] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 18:44:35 [18:44:35.554] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:44:35 [18:44:35.554] WARN: foundation:test-date-provider Time set to 2025-06-02T18:49:16.000Z {"offset":280446,"timeMs":1748890156000} 18:44:35 [18:44:35.558] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x23c068cc62980221c7028d33eef3b2b58f0853f5af004b0a98a8ab52cb1ec6bf","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":265534916,"blockNumber":1,"slotNumber":2,"timestamp":1748890156,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0c08d5a1b2f2eaca5a0d26e97d1357008b268e0dcd75627ac028b503662917d3","archiveNextLeafIndex":2} 18:44:35 [18:44:35.565] VERBOSE: archiver:block-helper:prover-node Store contract class 0x2fa61fb23ee61dc2059834910944b0aae3fa696210c7865caa3965de0f8e7b09 18:44:35 [18:44:35.594] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x23c068cc62980221c7028d33eef3b2b58f0853f5af004b0a98a8ab52cb1ec6bf","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":265534916,"blockNumber":1,"slotNumber":2,"timestamp":1748890156,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0c08d5a1b2f2eaca5a0d26e97d1357008b268e0dcd75627ac028b503662917d3","archiveNextLeafIndex":2} 18:44:35 [18:44:35.597] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1748890192] on http://127.0.0.1:8545 18:44:35 [18:44:35.599] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 18:44:35 [18:44:35.607] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 18:44:35 [18:44:35.617] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x0c08d5a1b2f2eaca5a0d26e97d1357008b268e0dcd75627ac028b503662917d3, 0x0d99431be682bba695361ac3340982acdaad54e13ce94691a50feb9fe377844e) 18:44:35 [18:44:35.622] WARN: ethereum:cheat_codes Warped L1 timestamp to 1748890192 18:44:35 [18:44:35.623] WARN: foundation:test-date-provider Time set to 2025-06-02T18:49:52.000Z {"offset":316377,"timeMs":1748890192000} 18:44:35 [18:44:35.623] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 18:44:35 [18:44:35.627] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 18:44:35 [18:44:35.632] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1748892496] on http://127.0.0.1:8545 18:44:35 [18:44:35.635] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 18:44:35 [18:44:35.645] WARN: ethereum:cheat_codes Warped L1 timestamp to 1748892496 18:44:35 [18:44:35.652] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":9.985054000000673,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1748890156,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:35 [18:44:35.664] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.070152999996935,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1748890156,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:44:35 [18:44:35.667] INFO: node Stopping 18:44:35 [18:44:35.669] INFO: slasher Slasher client stopped. 18:44:35 [18:44:35.670] INFO: sequencer Stopped sequencer 18:44:35 [18:44:35.671] INFO: p2p P2P client stopped. 18:44:35 [18:44:35.673] INFO: world_state Stopped world state synchronizer 18:44:35 [18:44:35.674] INFO: archiver Stopped. 18:44:35 [18:44:35.674] INFO: node Stopped 18:44:35 [18:44:35.674] INFO: prover-node:prover-node Stopping ProverNode 18:44:35 [18:44:35.674] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 18:44:35 [18:44:35.674] INFO: archiver:prover-node Stopped. 18:44:35 [18:44:35.676] INFO: world_state:prover-node Stopped world state synchronizer 18:44:35 [18:44:35.676] INFO: prover-node:prover-node Stopped ProverNode 18:44:35 [18:44:35.676] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 18:44:35 [18:44:35.676] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/b80278c0 18:44:35 [18:44:35.677] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 18:44:35 [18:44:35.681] INFO: blob-sink:server Stopping blob sink 18:44:35 [18:44:35.681] INFO: blob-sink:server Blob sink stopped 18:44:35 [18:44:35.682] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/33f8421fa40de734 18:44:35 FAIL src/e2e_multi_validator_node.test.ts 18:44:35 e2e_multi_validator_node 18:44:35 ✓ should build blocks & attest with multiple validator keys (17570 ms) 18:44:35 ✕ should attest ONLY with the correct validator keys (7337 ms) 18:44:35 18:44:35 ● e2e_multi_validator_node › should attest ONLY with the correct validator keys 18:44:35 18:44:35 ContractFunctionExecutionError: The contract function "initiateWithdraw" reverted. 18:44:35 18:44:35 Error: Staking__NothingToExit(address) 18:44:35 (0x15d34AAf54267DB7D7c367839AAf71A00a2C6A65) 18:44:35 18:44:35 Contract Call: 18:44:35 address: 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 18:44:35 function: initiateWithdraw(address _attester, address _recipient) 18:44:35 args: (0x15d34aaf54267db7d7c367839aaf71a00a2c6a65, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65) 18:44:35 sender: 0x15d34AAf54267DB7D7c367839AAf71A00a2C6A65 18:44:35 18:44:35 Docs: https://viem.sh/docs/contract/writeContract 18:44:35 Version: viem@2.23.7 18:44:35 18:44:35 142 | client: createExtendedL1Client(config.l1RpcUrls, initialValidatorPrivateKeys[VALIDATOR_COUNT - 1]), 18:44:35 143 | }); 18:44:35 > 144 | await rollupContract1.write.initiateWithdraw([ 18:44:35 | ^ 18:44:35 145 | validatorAddresses[VALIDATOR_COUNT - 1], 18:44:35 146 | validatorAddresses[VALIDATOR_COUNT - 1], 18:44:35 147 | ]); 18:44:35 18:44:35 at getContractError (../../node_modules/viem/utils/errors/getContractError.ts:78:10) 18:44:35 at writeContract (../../node_modules/viem/actions/wallet/writeContract.ts:208:11) 18:44:35 at Object.<anonymous> (e2e_multi_validator_node.test.ts:144:5) 18:44:35 18:44:35 Cause: 18:44:35 ContractFunctionRevertedError: The contract function "initiateWithdraw" reverted. 18:44:35 18:44:35 Error: Staking__NothingToExit(address) 18:44:35 (0x15d34AAf54267DB7D7c367839AAf71A00a2C6A65) 18:44:35 18:44:35 Version: viem@2.23.7 18:44:35 18:44:35 142 | client: createExtendedL1Client(config.l1RpcUrls, initialValidatorPrivateKeys[VALIDATOR_COUNT - 1]), 18:44:35 143 | }); 18:44:35 > 144 | await rollupContract1.write.initiateWithdraw([ 18:44:35 | ^ 18:44:35 145 | validatorAddresses[VALIDATOR_COUNT - 1], 18:44:35 146 | validatorAddresses[VALIDATOR_COUNT - 1], 18:44:35 147 | ]); 18:44:35 18:44:35 at ../../node_modules/viem/utils/errors/getContractError.ts:65:14 18:44:35 at getContractError (../../node_modules/viem/utils/errors/getContractError.ts:76:5) 18:44:35 at writeContract (../../node_modules/viem/actions/wallet/writeContract.ts:208:11) 18:44:35 at Object.<anonymous> (e2e_multi_validator_node.test.ts:144:5) 18:44:35 18:44:35 Test Suites: 1 failed, 1 total 18:44:35 Tests: 1 failed, 1 passed, 2 total 18:44:35 Snapshots: 0 total 18:44:35 Time: 32.138 s 18:44:35 Ran all test suites matching /src\/e2e_multi_validator_node.test.ts/i. 18:44:35 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?