Parent Log: http://ci.aztec-labs.com/921c4fffd37b9303 Command: 95f0f3ba1855a520: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/0c711002a2d6c1c3bec2a827aa06f1ea489b516b Env: REF_NAME=gh-readonly-queue/next/pr-14778-728681209863812d1dc01467fc1e92dfa0b25f0b CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Wed Jun 4 19:49:28 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14778_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/0d13f39a62f4c76d 19:49:28 +++ id -u 19:49:28 +++ id -g 19:49:28 ++ docker run -d --name e2e_multi_validator_node --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_multi_validator_node.test.ts'\''' 19:49:28 + cid=6960e2ba008cc8fdb851aed0388e651f46bb9c10f480846b6a442afe64cb6c1e 19:49:28 + set +x 19:49:29 {"level":25,"time":1749066569678,"pid":12,"hostname":"6960e2ba008c","module":"logger","msg":"Logger initialized with level verbose"} 19:49:36 [19:49:36.321] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should build blocks & attest with multiple validator keys 19:49:36 [19:49:36.853] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 19:49:37 [19:49:37.438] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-izxk1y/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:49:37 [19:49:37.521] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 19:49:37 [19:49:37.559] WARN: e2e:e2e_multi_validator_node Set block interval to 12 19:49:37 [19:49:37.560] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:49:37 [19:49:37.624] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:49:37 [19:49:37.641] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:49:37 [19:49:37.681] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:49:37 [19:49:37.698] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:49:37 [19:49:37.735] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:49:37 [19:49:37.745] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:49:37 [19:49:37.763] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:49:37 [19:49:37.769] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:49:37 [19:49:37.799] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 19:49:37 [19:49:37.807] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:49:37 [19:49:37.851] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 19:49:37 [19:49:37.866] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:49:37 [19:49:37.910] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 19:49:37 [19:49:37.911] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 19:49:37 [19:49:37.930] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 19:49:37 [19:49:37.936] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 19:49:37 [19:49:37.936] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:49:37 [19:49:37.937] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 19:49:37 [19:49:37.979] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:37 [19:49:37.996] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 19:49:37 [19:49:37.996] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 19:49:38 [19:49:38.012] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 19:49:38 [19:49:38.066] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 19:49:38 [19:49:38.098] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:49:38 [19:49:38.116] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 19:49:38 [19:49:38.116] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 19:49:38 [19:49:38.141] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 19:49:38 [19:49:38.147] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 19:49:38 [19:49:38.170] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 19:49:38 [19:49:38.170] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 19:49:38 [19:49:38.170] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:49:38 [19:49:38.170] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 19:49:38 [19:49:38.197] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:38 [19:49:38.210] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 19:49:38 [19:49:38.232] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 19:49:38 [19:49:38.233] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 19:49:38 [19:49:38.239] VERBOSE: e2e:e2e_multi_validator_node Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:49:38 [19:49:38.281] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 19:49:38 [19:49:38.319] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 19:49:38 [19:49:38.327] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 19:49:38 [19:49:38.379] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xdb7dbdf596eccbcb736fd6f35d3d2d0f8473d1c9ffb11fabfe744534d1cb53ae {"gasLimit":10716795,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 19:49:38 [19:49:38.404] VERBOSE: e2e:e2e_multi_validator_node Deployed Rollup at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:49:38 [19:49:38.405] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 19:49:38 [19:49:38.457] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:38 [19:49:38.458] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 19:49:38 [19:49:38.485] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 19:49:38 [19:49:38.486] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 19:49:38 [19:49:38.514] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xd413488be28de232ee67a932daca30e5e7bc4e1ad751dedc3910bbbe185aafe4 {"gasLimit":1040116,"maxFeePerGas":"38.520398451","maxPriorityFeePerGas":"38.337599913"} 19:49:38 [19:49:38.544] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 19:49:38 [19:49:38.594] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec {"gasLimit":116846,"maxFeePerGas":"46.165150264","maxPriorityFeePerGas":"46.005119895"} 19:49:38 [19:49:38.595] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec 19:49:38 [19:49:38.617] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 {"gasLimit":109478,"maxFeePerGas":"55.34732635","maxPriorityFeePerGas":"55.206143874"} 19:49:38 [19:49:38.618] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 19:49:38 [19:49:38.620] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 19:49:38 [19:49:38.684] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:38 [19:49:38.694] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 19:49:38 [19:49:38.694] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 19:49:38 [19:49:38.694] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 19:49:38 [19:49:38.719] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:38 [19:49:38.719] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 19:49:38 [19:49:38.733] INFO: e2e:e2e_multi_validator_node Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 19:49:38 [19:49:38.734] INFO: e2e:e2e_multi_validator_node Handing over to governance 19:49:38 [19:49:38.738] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:49:38 [19:49:38.740] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:38 [19:49:38.741] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 19:49:38 [19:49:38.742] INFO: telemetry:client Using NoopTelemetryClient 19:49:38 [19:49:38.749] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:49:38 [19:49:38.749] WARN: foundation:test-date-provider Time set to 2025-06-04T19:54:00.000Z {"offset":261251,"timeMs":1749066840000} 19:49:38 [19:49:38.750] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/2b88229b3aad4d4a/blob-sink with map size 134217728 KB (LMDB v2) 19:49:38 [19:49:38.754] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:49:38 [19:49:38.768] INFO: blob-sink:server Server is running on http://localhost:35743 19:49:38 [19:49:38.769] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 19:49:38 [19:49:38.770] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/48683257/acvm 19:49:38 [19:49:38.772] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:35743"} 19:49:38 [19:49:38.864] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:49:38 [19:49:38.870] INFO: archiver:lmdb Creating archiver data store at directory /tmp/2b88229b3aad4d4a/archiver with map size 134217728 KB (LMDB v2) 19:49:38 [19:49:38.874] INFO: archiver:lmdb Starting data store with maxReaders 16 19:49:39 [19:49:39.023] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:39 [19:49:39.253] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:39 [19:49:39.550] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:39 [19:49:39.799] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:39 [19:49:39.826] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:35743"} 19:49:39 [19:49:39.881] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:35743"} 19:49:39 [19:49:39.881] WARN: node:blob-sink:client No L1 consensus host urls configured 19:49:39 [19:49:39.881] WARN: node:blob-sink:client No archive client configured 19:49:39 [19:49:39.891] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 22 with hash 0x1f9a4f14f7d21314d3a7d6707f2b3ed50380eb2ecd7f7ce040d4522ed41d814b {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x2f6d2b8853385e9eca6b3d2d75fd41c8d4dbd7e219eefa33a8d6a651a4bc3995","l1BlockNumber":18}} 19:49:39 [19:49:39.927] INFO: archiver Initial archiver sync to L1 block 22 complete. {"l1BlockNumber":22,"syncPoint":{"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0x1f9a4f14f7d21314d3a7d6707f2b3ed50380eb2ecd7f7ce040d4522ed41d814b","l1BlockNumber":22}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:49:39 [19:49:39.938] INFO: world-state:database Creating world state data store at directory /tmp/2b88229b3aad4d4a/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:49:39 [19:49:39.973] INFO: world_state Created world state synchroniser with block history of 64 19:49:39 [19:49:39.973] WARN: node Aztec node is accepting fake proofs 19:49:39 [19:49:39.987] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/2b88229b3aad4d4a/p2p with map size 134217728 KB (LMDB v2) 19:49:39 [19:49:39.989] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:49:39 [19:49:39.991] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/2b88229b3aad4d4a/p2p-archive with map size 134217728 KB (LMDB v2) 19:49:39 [19:49:39.993] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:49:39 [19:49:39.995] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/2b88229b3aad4d4a/p2p-peers with map size 134217728 KB (LMDB v2) 19:49:39 [19:49:39.997] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:49:39 [19:49:39.999] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:49:40 [19:49:40.000] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:49:40 [19:49:40.005] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:49:40 [19:49:40.006] INFO: world_state Started world state synchronizer from block 1 19:49:40 [19:49:40.011] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:40 [19:49:40.015] VERBOSE: world-state:block_stream Starting sync from block number 0 19:49:40 [19:49:40.019] INFO: p2p Starting p2p client from block 0 with empty mempools 19:49:40 [19:49:40.020] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 19:49:40 [19:49:40.021] INFO: epoch-prune-watcher EpochPruneWatcher initialized 19:49:40 [19:49:40.028] INFO: slasher Starting Slasher client... 19:49:40 [19:49:40.093] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:49:40 [19:49:40.094] VERBOSE: node All Aztec Node subsystems synced 19:49:40 [19:49:40.100] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:49:40 [19:49:40.105] INFO: sequencer-client Deploying forwarder contract 19:49:40 [19:49:40.141] VERBOSE: sequencer-client Sent L1 transaction 0x602f411c9ae84deb9da90dad04b3e6b54d91158c82d01934d2b760f3de926311 {"gasLimit":323704,"maxFeePerGas":"66.371021876","maxPriorityFeePerGas":"66.247372648"} 19:49:40 [19:49:40.142] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x602f411c9ae84deb9da90dad04b3e6b54d91158c82d01934d2b760f3de926311. 19:49:40 [19:49:40.155] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 19:49:40 [19:49:40.169] INFO: validator Started validator with addresses: 19:49:40 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:49:40 [19:49:40.170] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 19:49:40 [19:49:40.171] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/48683257/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:49:40 [19:49:40.527] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:49:40 [19:49:40.529] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:49:40 [19:49:40.531] INFO: node Aztec Node version: 0.87.6 19:49:40 [19:49:40.531] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0"} 19:49:40 [19:49:40.533] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 19:49:40 [19:49:40.571] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:35743"} 19:49:40 [19:49:40.574] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:40 [19:49:40.587] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:49:40 [19:49:40.587] WARN: foundation:test-date-provider Time set to 2025-06-04T19:54:12.000Z {"offset":271413,"timeMs":1749066852000} 19:49:40 [19:49:40.590] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/2b88229b3aad4d4a/776f72de519ddf85/archiver with map size 134217728 KB (LMDB v2) 19:49:40 [19:49:40.602] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":1} 19:49:40 [19:49:40.604] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 19:49:40 [19:49:40.818] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:40 [19:49:40.858] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:40 [19:49:40.973] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:35743"} 19:49:40 [19:49:40.976] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:35743"} 19:49:40 [19:49:40.977] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 19:49:40 [19:49:40.977] WARN: blob-sink:client:prover-node No archive client configured 19:49:40 [19:49:40.979] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 23 with hash 0x4233af783e4933c8a392197c65e3beb4c1b19a53afc203d1a43de6e8f977e5b8 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x2f6d2b8853385e9eca6b3d2d75fd41c8d4dbd7e219eefa33a8d6a651a4bc3995","l1BlockNumber":18}} 19:49:40 [19:49:40.993] INFO: archiver:prover-node Initial archiver sync to L1 block 23 complete. {"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x4233af783e4933c8a392197c65e3beb4c1b19a53afc203d1a43de6e8f977e5b8","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:49:40 [19:49:40.999] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:35743"} 19:49:41 [19:49:41.000] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 19:49:41 [19:49:41.003] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 19:49:41 [19:49:41.011] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/2b88229b3aad4d4a/776f72de519ddf85/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:49:41 [19:49:41.040] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:41 [19:49:41.055] INFO: world_state:prover-node Created world state synchroniser with block history of 64 19:49:41 [19:49:41.057] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:49:41 [19:49:41.058] INFO: world_state:prover-node Started world state synchronizer from block 1 19:49:41 [19:49:41.064] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 19:49:41 [19:49:41.065] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/2b88229b3aad4d4a/776f72de519ddf85/archiver when loading epoch databases, ignoring 19:49:41 [19:49:41.066] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/2b88229b3aad4d4a/776f72de519ddf85/world_state when loading epoch databases, ignoring 19:49:41 [19:49:41.069] INFO: prover-client:proving-broker:prover-node Proving Broker started 19:49:41 [19:49:41.104] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 19:49:41 [19:49:41.106] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 19:49:41 [19:49:41.107] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 19:49:41 [19:49:41.112] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:41 [19:49:41.114] 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/2b88229b3aad4d4a/776f72de519ddf85","l1ChainId":31337,"rollupVersion":780793254} 19:49:41 [19:49:41.115] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 19:49:41 [19:49:41.126] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/4c3316ee1017d8b7/pxe_data with map size 134217728 KB (LMDB v2) 19:49:41 [19:49:41.131] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:49:41 [19:49:41.367] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:41 [19:49:41.442] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:41 [19:49:41.484] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:49:41 [19:49:41.485] INFO: pxe:service Started PXE connected to chain 31337 version 780793254 19:49:41 [19:49:41.547] INFO: pxe:service Registered account 0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34 19:49:41 [19:49:41.621] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:41 [19:49:41.623] WARN: pxe:service No artifact found for contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 when looking for its metadata 19:49:41 [19:49:41.628] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 as part of deployment for 0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34 19:49:41 [19:49:41.680] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:41 [19:49:41.794] INFO: pxe:service Added contract SchnorrAccount at 0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34 with class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:49:41 [19:49:41.829] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:41 [19:49:41.836] VERBOSE: pxe:block_stream Starting sync from block number 0 19:49:41 [19:49:41.871] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:49:41 [19:49:41.940] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:41 [19:49:41.995] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:49:43 [19:49:43.072] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0,0x0240bf0e016845a25c6a69d15d5ca1bb78fd38b72dc894232e020c2b188ad937,0x0d7e7b1c04f61ee57629d3be4dc7b937efb93329c57da17d8b5151dd750d818b,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:49:43 [19:49:43.196] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:49:43 [19:49:43.352] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:43 [19:49:43.420] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:43 [19:49:43.586] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:43 [19:49:43.654] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:43 [19:49:43.670] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:49:43 [19:49:43.671] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:43 [19:49:43.730] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:43 [19:49:43.769] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:43 [19:49:43.778] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:49:43 [19:49:43.881] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:43 [19:49:43.972] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:44 [19:49:44.070] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:44 [19:49:44.124] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:49:44 [19:49:44.125] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:44 [19:49:44.127] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:44 [19:49:44.203] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:44 [19:49:44.213] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:44 [19:49:44.216] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:49:44 [19:49:44.231] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34 as fee payer 19:49:44 [19:49:44.424] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:44 [19:49:44.538] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:44 [19:49:44.687] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:44 [19:49:44.833] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:44 [19:49:44.984] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:45 [19:49:45.107] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:45 [19:49:45.581] INFO: pxe:service Proving completed in 3752.994532999999ms {"timings":{"total":3752.994532999999,"sync":8.911935000000085,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":193.107700999999,"oracles":{"callPrivateFunction":{"times":[1419.7440019999995,611.5440799999997,291.74488200000087]}}},{"functionName":"private_kernel_init","time":110.08591700000034},{"functionName":"ContractClassRegisterer:register","time":1385.0986580000008,"oracles":{"loadCapsule":{"times":[72.21071200000006]},"notifyCreatedNullifier":{"times":[37.62366900000052]},"debugLog":{"times":[1.3760950000014418]},"notifyCreatedContractClassLog":{"times":[12.832824000000983]}}},{"functionName":"private_kernel_inner","time":140.5130250000002},{"functionName":"SchnorrAccount:constructor","time":568.2554779999991,"oracles":{"getContractInstance":{"times":[12.565827000000354]},"debugLog":{"times":[0.70590699999957,0.6335060000001249]},"fetchTaggedLogs":{"times":[106.09871700000076]},"loadCapsule":{"times":[0.5428540000011708,0.3126380000012432,0.33974900000066555]},"validateEnqueuedNotes":{"times":[6.388640999999552]},"notifyCreatedNullifier":{"times":[0.3231080000005022,0.19670500000029278]},"notifyCreatedNote":{"times":[0.6981880000003002]},"getRandomField":{"times":[0.6023349999995844,0.21930600000086997,0.08814199999869743,0.07013200000073994,0.0675119999996241,0.06083100000068953,0.12064300000020012,0.09158199999910721,0.06893200000013167,0.11152299999957904,0.0607319999999163]},"getIndexedTaggingSecretAsSender":{"times":[85.057906]},"incrementAppTaggingSecretIndexAsSender":{"times":[38.65182499999901]}}},{"functionName":"private_kernel_inner","time":143.82869800000117},{"functionName":"SchnorrAccount:entrypoint","time":262.3249799999994,"oracles":{"debugLog":{"times":[0.8990229999999428,0.33232800000041607,0.8882219999995868]},"fetchTaggedLogs":{"times":[89.97811999999976]},"loadCapsule":{"times":[0.20840599999974074,0.201455000000351,0.2656860000006418]},"validateEnqueuedNotes":{"times":[0.8163899999999558]},"getNotes":{"times":[1.51213800000005]},"getAuthWitness":{"times":[0.25263600000107544]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0829370000010385]}}},{"functionName":"private_kernel_inner","time":125.97461800000201},{"functionName":"private_kernel_reset","time":212.37831800000276},{"functionName":"private_kernel_tail","time":118.43215800000326}],"unaccounted":484.083046999991}} 19:49:45 [19:49:45.608] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:45 [19:49:45.741] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","blockNumber":1,"slot":2} 19:49:45 [19:49:45.757] VERBOSE: p2p:tx_pool Adding tx 0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2 to pool {"eventName":"tx-added-to-pool","txHash":"0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:49:45 [19:49:45.777] INFO: node Received tx 0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2 {"txHash":"0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2"} 19:49:45 [19:49:45.778] INFO: pxe:service Sent transaction 0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2 19:49:45 [19:49:45.828] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:45 [19:49:45.982] VERBOSE: sequencer:block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-04T19:54:24.000Z","now":"2025-06-04T19:54:17.395Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:49:46 [19:49:46.038] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:46 [19:49:46.067] VERBOSE: simulator:public-processor Processed tx 0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2 with no public calls in 44.99683599999844ms {"txHash":"0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2","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":44.99683599999844} 19:49:46 [19:49:46.080] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08889441299999817s {"duration":0.08889441299999817,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 19:49:46 [19:49:46.209] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2be445ba0d0cea16fd60bcee0cfc672fbf9f6d22fad915f8d903c5623df56740","globalVariables":{"chainId":31337,"version":780793254,"blockNumber":1,"slotNumber":2,"timestamp":1749066864,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2590f9b25d7407d93aba3ffcd71428f81a7a31f2a4fca5747c5c21646c473ee2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":240.62970099999802,"publicProcessDuration":90.83853200000158,"rollupCircuitsDuration":228.1894769999999,"txCount":1,"blockNumber":1,"blockTimestamp":1749066864,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:49:46 [19:49:46.215] VERBOSE: sequencer Attesting committee is empty 19:49:46 [19:49:46.340] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:46 [19:49:46.553] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:46 [19:49:46.698] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x784a17fb8bf44f08f90fa44fc340b058feee6e660d4f66d008b2b415a53b7232 19:49:46 [19:49:46.698] VERBOSE: node Sent L1 transaction 0x784a17fb8bf44f08f90fa44fc340b058feee6e660d4f66d008b2b415a53b7232 {"gasLimit":555061,"maxFeePerGas":"79.605134257","maxPriorityFeePerGas":"79.496847177","maxFeePerBlobGas":"0.000000001"} 19:49:46 [19:49:46.717] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:49:46 [19:49:46.718] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x784a17fb8bf44f08f90fa44fc340b058feee6e660d4f66d008b2b415a53b7232","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1749066864,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:49:46 [19:49:46.719] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:49:46 [19:49:46.751] INFO: blob-sink:server Received blob sidecar for block 0xe88292ff264b362fbd63ece372a68dcfd989050a6e8cc50320e53aa18a945c27 19:49:46 [19:49:46.757] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:46 [19:49:46.767] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:49:46 [19:49:46.768] WARN: foundation:test-date-provider Time set to 2025-06-04T19:54:24.000Z {"offset":277233,"timeMs":1749066864000} 19:49:46 [19:49:46.768] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe88292ff264b362fbd63ece372a68dcfd989050a6e8cc50320e53aa18a945c27 19:49:46 [19:49:46.779] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:49:46 [19:49:46.781] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:49:46 [19:49:46.787] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:49:46 [19:49:46.803] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749066900] on http://127.0.0.1:8545 19:49:46 [19:49:46.807] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:49:46 [19:49:46.810] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749066900 19:49:46 [19:49:46.810] WARN: foundation:test-date-provider Time set to 2025-06-04T19:55:00.000Z {"offset":313190,"timeMs":1749066900000} 19:49:46 [19:49:46.810] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 19:49:46 [19:49:46.988] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:47 [19:49:47.013] VERBOSE: archiver:block-helper:prover-node Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:49:47 [19:49:47.195] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x2be445ba0d0cea16fd60bcee0cfc672fbf9f6d22fad915f8d903c5623df56740","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":780793254,"blockNumber":1,"slotNumber":2,"timestamp":1749066864,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","archiveNextLeafIndex":2} 19:49:47 [19:49:47.207] VERBOSE: archiver:block-helper Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:49:47 [19:49:47.220] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:47 [19:49:47.255] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e, 0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d) 19:49:47 [19:49:47.259] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2be445ba0d0cea16fd60bcee0cfc672fbf9f6d22fad915f8d903c5623df56740","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":780793254,"blockNumber":1,"slotNumber":2,"timestamp":1749066864,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","archiveNextLeafIndex":2} 19:49:47 [19:49:47.268] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 19:49:47 [19:49:47.279] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:49:47 [19:49:47.283] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":8.829882999998517,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749066864,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:49:47 [19:49:47.343] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749069204] on http://127.0.0.1:8545 19:49:47 [19:49:47.345] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:49:47 [19:49:47.348] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749069204 19:49:47 [19:49:47.349] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34 19:49:47 [19:49:47.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:47 [19:49:47.797] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:49:47 [19:49:47.798] WARN: foundation:test-date-provider Time set to 2025-06-04T20:33:24.000Z {"offset":2616202,"timeMs":1749069204000} 19:49:47 [19:49:47.802] INFO: pxe:service Added contract StatefulTest at 0x2d00118444437ffac66265573c97bbb1bd2a629e1df8b91acdec50a77ac1a865 with class 0x0e75e50f67127bddbbf0c6e812b093c4e20dc26681235d9c77c3d57f93ab52a0 19:49:47 [19:49:47.814] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 19:49:47 [19:49:47.815] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 19:49:47 [19:49:47.847] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 19:49:47 [19:49:47.847] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 19:49:47 [19:49:47.875] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":17.266685999999027,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749066864,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:49:47 [19:49:47.924] VERBOSE: p2p Synched to latest block 1 19:49:47 [19:49:47.953] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","header":{"contentCommitment":{"blobsHash":"0x009cedde765d53ecef6812505218f4aff43b7c54ee2af193db0188aa34229917","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749066864,"version":780793254},"lastArchive":"0x0222fca8830cb7a701537074b89d8d7dda5e9f861ff5593858e87dad898c220d","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x023e6ced39af9bcf05d3bc2df8e5282879d666c852f161c8f82761c7a3861433","nullifierTree":"0x00e4b9bda7116c6aac110e4ad233fd43f738f225c2f500f1b901fe5ee737e290","publicDataTree":"0x10e771c301ebb95a3b5fadc1a01c95cc878acd5f0b6eb2d1c328a43d3b3bda92"},"totalFees":2101212240,"totalManaUsed":6324}} 19:49:48 [19:49:48.004] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:48 [19:49:48.092] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:48 [19:49:48.142] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:49:48 [19:49:48.143] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:48 [19:49:48.250] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","blockNumber":2,"slot":67} 19:49:48 [19:49:48.256] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:48 [19:49:48.289] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34"} 19:49:48 [19:49:48.294] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x05967451e1fe1b72031a87c3f5ab97aac76696e3b4a26c88bbb39199f819a5d5 19:49:48 [19:49:48.310] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:49:48 [19:49:48.311] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:49:48 [19:49:48.320] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:49:48 [19:49:48.321] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:49:48 [19:49:48.325] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:49:48 [19:49:48.333] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x221e6d34f78d735a4d76f2f9a12c7e06782a5263ba94f341b8620251eec7aeaf","nullifier":"0x1be637b1887ecacfad293258f6ebf331edc4023d01abe310daa032cd9901bfa0"} 19:49:48 [19:49:48.352] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1b4909e4a310215e7070cdcdeb33e6500c1315ff973cbb23606150891aec6b34 as fee payer 19:49:48 [19:49:48.513] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:48 [19:49:48.573] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x2d00118444437ffac66265573c97bbb1bd2a629e1df8b91acdec50a77ac1a865"} 19:49:48 [19:49:48.601] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:49:48 [19:49:48.601] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2d00118444437ffac66265573c97bbb1bd2a629e1df8b91acdec50a77ac1a865"} 19:49:48 [19:49:48.697] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","blockNumber":2,"slot":67} 19:49:48 [19:49:48.725] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2d00118444437ffac66265573c97bbb1bd2a629e1df8b91acdec50a77ac1a865"} 19:49:48 [19:49:48.731] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:49:48 [19:49:48.799] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:48 [19:49:48.862] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 2 19:49:48 [19:49:48.908] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x2d00118444437ffac66265573c97bbb1bd2a629e1df8b91acdec50a77ac1a865"} 19:49:48 [19:49:48.964] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:49:48 [19:49:48.964] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2d00118444437ffac66265573c97bbb1bd2a629e1df8b91acdec50a77ac1a865"} 19:49:49 [19:49:49.086] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","blockNumber":2,"slot":67} 19:49:49 [19:49:49.110] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2d00118444437ffac66265573c97bbb1bd2a629e1df8b91acdec50a77ac1a865"} 19:49:49 [19:49:49.117] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:49:49 [19:49:49.198] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:49 [19:49:49.414] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:49 [19:49:49.445] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","blockNumber":2,"slot":67} 19:49:49 [19:49:49.684] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:49 [19:49:49.948] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","blockNumber":2,"slot":67} 19:49:50 [19:49:50.101] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:50 [19:49:50.727] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:50 [19:49:50.758] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","blockNumber":2,"slot":67} 19:49:51 [19:49:51.264] INFO: pxe:service Proving completed in 3355.0159319999984ms {"timings":{"total":3355.0159319999984,"sync":46.84678200000053,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":432.5533319999995,"oracles":{"debugLog":{"times":[0.9041330000000016,0.5595940000021074,0.6498670000000857,0.8815930000018852,0.5680739999988873,0.5130930000013905,0.5223030000015569,0.707287000001088]},"fetchTaggedLogs":{"times":[148.46330600000147]},"loadCapsule":{"times":[0.38911000000007334,0.43904100000145263,0.5623439999981201,0.41272100000060163,0.2471159999986412,0.27657600000020466,0.2966280000000552]},"getSharedSecret":{"times":[5.0099260000024515]},"aes128Decrypt":{"times":[1.2801419999996142,1.190150000002177]},"getPublicKeysAndPartialAddress":{"times":[2.235906999998406]},"getKeyValidationRequest":{"times":[2.538624000000709]},"storeCapsule":{"times":[0.8444410000010976,0.381798999998864,0.4376010000014503]},"deleteCapsule":{"times":[0.6958970000014233]},"validateEnqueuedNotes":{"times":[8.332381000000169]},"getNotes":{"times":[2.433892000000924]},"getAuthWitness":{"times":[0.8780720000031579]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.051610999998956686]},"callPrivateFunction":{"times":[933.870003]}}},{"functionName":"private_kernel_init","time":71.09765400000106},{"functionName":"StatefulTest:constructor","time":372.44216799999776,"oracles":{"getContractInstance":{"times":[7.959171000002243]},"debugLog":{"times":[0.6288759999988542,0.538884000001417]},"fetchTaggedLogs":{"times":[128.22256500000003]},"loadCapsule":{"times":[0.22335600000224076,0.22476599999936298,0.28429700000197045]},"validateEnqueuedNotes":{"times":[0.8409509999983129]},"storeInExecutionCache":{"times":[0.25120700000115903]},"callPrivateFunction":{"times":[547.5816860000014]},"notifyCreatedNullifier":{"times":[0.3517790000005334]}}},{"functionName":"private_kernel_inner","time":145.73407699999734},{"functionName":"StatefulTest:create_note_no_init_check","time":491.1343930000039,"oracles":{"debugLog":{"times":[0.6675969999996596,0.5310239999998885]},"fetchTaggedLogs":{"times":[151.96290500000032]},"loadCapsule":{"times":[0.31275900000036927,0.16401499999847147,0.1980249999978696]},"validateEnqueuedNotes":{"times":[0.858591999996861]},"getRandomField":{"times":[0.1683740000007674,0.1078029999989667,0.1383139999998093,0.06056199999875389,0.06366200000047684,0.03808099999878323,0.03917100000035134,0.0444210000023304,0.046651000000565546,0.08686200000011013,0.04705100000137463,0.0585220000029949]},"notifyCreatedNote":{"times":[0.13257399999929476]},"getIndexedTaggingSecretAsSender":{"times":[72.14866099999927]},"incrementAppTaggingSecretIndexAsSender":{"times":[62.085487000000285]}}},{"functionName":"private_kernel_inner","time":156.48863900000288},{"functionName":"private_kernel_reset","time":258.03051100000084},{"functionName":"private_kernel_tail","time":82.01512000000002}],"unaccounted":1298.6732559999946}} 19:49:51 [19:49:51.279] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:51 [19:49:51.331] VERBOSE: p2p:tx_pool Adding tx 0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc to pool {"eventName":"tx-added-to-pool","txHash":"0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:49:51 [19:49:51.343] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e","blockNumber":2,"slot":67} 19:49:51 [19:49:51.362] INFO: node Received tx 0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc {"txHash":"0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc"} 19:49:51 [19:49:51.362] INFO: pxe:service Sent transaction 0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc 19:49:51 [19:49:51.491] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:51 [19:49:51.647] VERBOSE: sequencer:block-builder Building block 2 for slot 67 {"slot":67,"slotStart":"2025-06-04T20:33:24.000Z","now":"2025-06-04T20:33:27.849Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:49:51 [19:49:51.694] VERBOSE: simulator:public-processor Processed tx 0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc with no public calls in 27.645187999998598ms {"txHash":"0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc","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":27.645187999998598} 19:49:51 [19:49:51.696] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.044091621999999914s {"duration":0.044091621999999914,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 19:49:51 [19:49:51.701] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:51 [19:49:51.846] INFO: sequencer Built block 2 for slot 67 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2e0b115a612dd20d8496f80d4d5a2cdb4eae43f1810ccd4619398c5f09b9ddde","globalVariables":{"chainId":31337,"version":780793254,"blockNumber":2,"slotNumber":67,"timestamp":1749069204,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x1707bc69fe052d9c592222a8f84743cae2bcb650a55160c0c795b8370897acdc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":220.3124889999999,"publicProcessDuration":44.6774869999972,"rollupCircuitsDuration":200.53249999999753,"txCount":1,"blockNumber":2,"blockTimestamp":1749069204,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:49:51 [19:49:51.850] VERBOSE: sequencer Attesting committee is empty 19:49:51 [19:49:51.955] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:52 [19:49:52.216] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:52 [19:49:52.225] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4218ac6194280a3d87f79d1dbf2614b38138c2939dbc463342434e6ac579258a 19:49:52 [19:49:52.225] VERBOSE: node Sent L1 transaction 0x4218ac6194280a3d87f79d1dbf2614b38138c2939dbc463342434e6ac579258a {"gasLimit":565458,"maxFeePerGas":"1.273011818","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:49:52 [19:49:52.242] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:49:52 [19:49:52.243] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4218ac6194280a3d87f79d1dbf2614b38138c2939dbc463342434e6ac579258a","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1749069204,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:49:52 [19:49:52.244] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:49:52 [19:49:52.264] INFO: blob-sink:server Received blob sidecar for block 0x0514a6dc521c130ad48ed162f94c04428673a58badb1bd9bc60178208d16e45f 19:49:52 [19:49:52.282] INFO: blob-sink:server Blob sidecar stored successfully for block 0x0514a6dc521c130ad48ed162f94c04428673a58badb1bd9bc60178208d16e45f 19:49:52 [19:49:52.379] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749069240] on http://127.0.0.1:8545 19:49:52 [19:49:52.391] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:49:52 [19:49:52.397] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749069240 19:49:52 [19:49:52.398] WARN: foundation:test-date-provider Time set to 2025-06-04T20:34:00.000Z {"offset":2647602,"timeMs":1749069240000} 19:49:52 [19:49:52.398] INFO: aztecjs:utils:watcher Slot 67 was filled, jumped to next slot 19:49:52 [19:49:52.428] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:52 [19:49:52.449] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:49:52 [19:49:52.457] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:49:52 [19:49:52.462] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:49:52 [19:49:52.661] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:52 [19:49:52.833] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x2e0b115a612dd20d8496f80d4d5a2cdb4eae43f1810ccd4619398c5f09b9ddde","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":780793254,"blockNumber":2,"slotNumber":67,"timestamp":1749069204,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0ee1ce21324c1387b1ae7bf290998e30d07683013207576f0e4638f8f78b460e","archiveNextLeafIndex":3} 19:49:52 [19:49:52.857] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x2e0b115a612dd20d8496f80d4d5a2cdb4eae43f1810ccd4619398c5f09b9ddde","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":780793254,"blockNumber":2,"slotNumber":67,"timestamp":1749069204,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0ee1ce21324c1387b1ae7bf290998e30d07683013207576f0e4638f8f78b460e","archiveNextLeafIndex":3} 19:49:52 [19:49:52.866] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x0ee1ce21324c1387b1ae7bf290998e30d07683013207576f0e4638f8f78b460e, 0x2b4d52b54ffc1c4b5a9113b74d9700ddbc258aa8ef641d94cf1b688354fe575e) 19:49:52 [19:49:52.891] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:52 [19:49:52.931] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":12.90196499999729,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749069204,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:49:52 [19:49:52.934] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":12.616618000000017,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749069204,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:49:53 [19:49:53.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:53 [19:49:53.148] VERBOSE: p2p Synched to latest block 2 19:49:53 [19:49:53.150] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 19:49:53 [19:49:53.151] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:49:53 [19:49:53.300] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0ee1ce21324c1387b1ae7bf290998e30d07683013207576f0e4638f8f78b460e","blockNumber":3,"slot":68} 19:49:53 [19:49:53.312] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:53 [19:49:53.517] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:53 [19:49:53.539] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0ee1ce21324c1387b1ae7bf290998e30d07683013207576f0e4638f8f78b460e","blockNumber":3,"slot":68} 19:49:53 [19:49:53.540] INFO: node Stopping 19:49:53 [19:49:53.543] INFO: slasher Slasher client stopped. 19:49:53 [19:49:53.544] INFO: sequencer Stopped sequencer 19:49:53 [19:49:53.545] INFO: p2p P2P client stopped. 19:49:53 [19:49:53.548] INFO: world_state Stopped world state synchronizer 19:49:53 [19:49:53.549] INFO: archiver Stopped. 19:49:53 [19:49:53.549] INFO: node Stopped 19:49:53 [19:49:53.549] INFO: prover-node:prover-node Stopping ProverNode 19:49:53 [19:49:53.550] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 19:49:53 [19:49:53.550] INFO: archiver:prover-node Stopped. 19:49:53 [19:49:53.552] INFO: world_state:prover-node Stopped world state synchronizer 19:49:53 [19:49:53.553] INFO: prover-node:prover-node Stopped ProverNode 19:49:53 [19:49:53.553] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 19:49:53 [19:49:53.553] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/48683257 19:49:53 [19:49:53.554] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 19:49:53 [19:49:53.568] INFO: blob-sink:server Stopping blob sink 19:49:53 [19:49:53.568] INFO: blob-sink:server Blob sink stopped 19:49:53 [19:49:53.569] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/2b88229b3aad4d4a 19:49:53 [19:49:53.589] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should attest ONLY with the correct validator keys 19:49:53 [19:49:53.895] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 19:49:53 [19:49:53.950] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-wSmZvl/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:49:53 [19:49:53.988] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 19:49:53 [19:49:53.991] WARN: e2e:e2e_multi_validator_node Set block interval to 12 19:49:53 [19:49:53.991] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:49:54 [19:49:54.012] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:49:54 [19:49:54.019] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:49:54 [19:49:54.045] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:49:54 [19:49:54.054] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:49:54 [19:49:54.079] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:49:54 [19:49:54.086] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:49:54 [19:49:54.117] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:49:54 [19:49:54.123] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:49:54 [19:49:54.146] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 19:49:54 [19:49:54.169] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:49:54 [19:49:54.191] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 19:49:55 [19:49:55.212] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:49:55 [19:49:55.279] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 19:49:55 [19:49:55.280] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 19:49:55 [19:49:55.326] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 19:49:55 [19:49:55.344] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 19:49:55 [19:49:55.349] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:49:55 [19:49:55.349] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 19:49:55 [19:49:55.417] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:55 [19:49:55.457] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 19:49:55 [19:49:55.458] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 19:49:55 [19:49:55.507] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 19:49:55 [19:49:55.541] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 19:49:55 [19:49:55.556] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:49:55 [19:49:55.587] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 19:49:55 [19:49:55.587] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 19:49:55 [19:49:55.621] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 19:49:55 [19:49:55.630] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 19:49:55 [19:49:55.647] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 19:49:55 [19:49:55.649] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 19:49:55 [19:49:55.649] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 19:49:55 [19:49:55.649] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 19:49:55 [19:49:55.689] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:55 [19:49:55.704] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 19:49:55 [19:49:55.737] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 19:49:55 [19:49:55.738] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 19:49:55 [19:49:55.744] VERBOSE: e2e:e2e_multi_validator_node Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:49:55 [19:49:55.784] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 19:49:55 [19:49:55.831] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 19:49:55 [19:49:55.840] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 19:49:55 [19:49:55.951] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x028c2b62d2af7d153fbb1b479fb63cc1bd86a137b4979e5a41011d1d060cae32 {"gasLimit":10716795,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 19:49:55 [19:49:55.957] VERBOSE: e2e:e2e_multi_validator_node Deployed Rollup at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:49:55 [19:49:55.958] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 19:49:56 [19:49:56.004] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:56 [19:49:56.004] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 19:49:56 [19:49:56.041] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 19:49:56 [19:49:56.041] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 19:49:56 [19:49:56.078] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xd413488be28de232ee67a932daca30e5e7bc4e1ad751dedc3910bbbe185aafe4 {"gasLimit":1040116,"maxFeePerGas":"38.520398451","maxPriorityFeePerGas":"38.337599913"} 19:49:56 [19:49:56.084] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 19:49:56 [19:49:56.115] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec {"gasLimit":116846,"maxFeePerGas":"46.165150264","maxPriorityFeePerGas":"46.005119895"} 19:49:56 [19:49:56.115] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec 19:49:56 [19:49:56.149] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 {"gasLimit":109478,"maxFeePerGas":"55.34732635","maxPriorityFeePerGas":"55.206143874"} 19:49:56 [19:49:56.149] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 19:49:56 [19:49:56.175] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2baf4763aa17682af85263faf72b939a3b0de80fabfa567cc2614de37cb716e2 {"gasLimit":362859,"maxFeePerGas":"66.371021876","maxPriorityFeePerGas":"66.247372648"} 19:49:56 [19:49:56.200] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xa623e13db3bc03c6828b186ab37039f59d8527e19526127bc6b78030c6e5fea9 {"gasLimit":84823,"maxFeePerGas":"79.605134257","maxPriorityFeePerGas":"79.496847177"} 19:49:56 [19:49:56.259] INFO: e2e:e2e_multi_validator_node Initialized validator set {"validators":[{"attester":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","withdrawer":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","privateKey":"0xac0974bec39a17e36ba4a6b4d238ff944bacb478cbed5efcae784d7bf4f2ff80"},{"attester":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","withdrawer":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","privateKey":"0x59c6995e998f97a5a0044966f0945389dc9e86dae88c7a8412f4603b6b78690d"},{"attester":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","withdrawer":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","privateKey":"0x5de4111afa1a4b94908f83103eb1f1706367c2e68ca870fc3fb9a804cdab365a"},{"attester":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","withdrawer":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","privateKey":"0x7c852118294e51e653712a81e05800f419141751be58f605c371e15141b007a6"},{"attester":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","withdrawer":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","privateKey":"0x47e179ec197488593b187f80a00eb0da91f1b9d0b13f8733639f19c30a34926a"}],"txHash":"0xc005a872652e5180c06511d7b2c65be32bd9db61f5c8a251e60d728456eb4cb3"} 19:49:56 [19:49:56.259] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 19:49:56 [19:49:56.300] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:56 [19:49:56.330] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 19:49:56 [19:49:56.331] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 19:49:56 [19:49:56.332] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 19:49:56 [19:49:56.376] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 19:49:56 [19:49:56.376] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 19:49:56 [19:49:56.424] INFO: e2e:e2e_multi_validator_node Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 19:49:56 [19:49:56.428] INFO: e2e:e2e_multi_validator_node Handing over to governance 19:49:56 [19:49:56.448] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:49:56 [19:49:56.454] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:56 [19:49:56.456] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 19:49:56 [19:49:56.462] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:49:56 [19:49:56.463] WARN: foundation:test-date-provider Time set to 2025-06-04T19:54:53.000Z {"offset":296537,"timeMs":1749066893000} 19:49:56 [19:49:56.467] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/2ae988b8efa14465/blob-sink with map size 134217728 KB (LMDB v2) 19:49:56 [19:49:56.476] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:49:56 [19:49:56.483] INFO: blob-sink:server Server is running on http://localhost:41597 19:49:56 [19:49:56.484] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 19:49:56 [19:49:56.485] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/3388026c/acvm 19:49:56 [19:49:56.487] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:41597"} 19:49:56 [19:49:56.521] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:49:56 [19:49:56.521] INFO: archiver:lmdb Creating archiver data store at directory /tmp/2ae988b8efa14465/archiver with map size 134217728 KB (LMDB v2) 19:49:56 [19:49:56.524] INFO: archiver:lmdb Starting data store with maxReaders 16 19:49:56 [19:49:56.664] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:56 [19:49:56.867] WARN: sequencer:block-builder Error closing forks for block processing {"generatedMessage":false,"code":"ERR_ASSERTION","actual":false,"expected":true,"operator":"=="} 19:49:56 [19:49:56.914] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:56 [19:49:56.932] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:41597"} 19:49:56 [19:49:56.941] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:41597"} 19:49:56 [19:49:56.942] WARN: node:blob-sink:client No L1 consensus host urls configured 19:49:56 [19:49:56.942] WARN: node:blob-sink:client No archive client configured 19:49:56 [19:49:56.946] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 25 with hash 0xab8289c7182a20ce1c7503311e3abb4e38d6d584de14a85577ae51d0c356cea1 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xcd7ab2c5e4e72a32b6443822a782ef4066c67788ae0827cb62b5f87db2411ae6","l1BlockNumber":18}} 19:49:56 [19:49:56.967] INFO: archiver Initial archiver sync to L1 block 25 complete. {"l1BlockNumber":25,"syncPoint":{"blocksSynchedTo":25,"messagesSynchedTo":{"l1BlockHash":"0xab8289c7182a20ce1c7503311e3abb4e38d6d584de14a85577ae51d0c356cea1","l1BlockNumber":25}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:49:56 [19:49:56.976] INFO: world-state:database Creating world state data store at directory /tmp/2ae988b8efa14465/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:49:57 [19:49:57.023] INFO: world_state Created world state synchroniser with block history of 64 19:49:57 [19:49:57.023] WARN: node Aztec node is accepting fake proofs 19:49:57 [19:49:57.034] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/2ae988b8efa14465/p2p with map size 134217728 KB (LMDB v2) 19:49:57 [19:49:57.041] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:49:57 [19:49:57.062] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/2ae988b8efa14465/p2p-archive with map size 134217728 KB (LMDB v2) 19:49:57 [19:49:57.065] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:49:57 [19:49:57.070] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/2ae988b8efa14465/p2p-peers with map size 134217728 KB (LMDB v2) 19:49:57 [19:49:57.072] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:49:57 [19:49:57.077] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:49:57 [19:49:57.078] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:49:57 [19:49:57.082] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:49:57 [19:49:57.083] INFO: world_state Started world state synchronizer from block 1 19:49:57 [19:49:57.086] VERBOSE: world-state:block_stream Starting sync from block number 0 19:49:57 [19:49:57.090] INFO: p2p Starting p2p client from block 0 with empty mempools 19:49:57 [19:49:57.091] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 19:49:57 [19:49:57.092] INFO: epoch-prune-watcher EpochPruneWatcher initialized 19:49:57 [19:49:57.102] INFO: slasher Starting Slasher client... 19:49:57 [19:49:57.110] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:49:57 [19:49:57.110] VERBOSE: node All Aztec Node subsystems synced 19:49:57 [19:49:57.126] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:57 [19:49:57.130] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:49:57 [19:49:57.134] INFO: sequencer-client Deploying forwarder contract 19:49:57 [19:49:57.156] VERBOSE: sequencer-client Sent L1 transaction 0x5f35c2d0e4f65c467262e74571eec910db06feaae6991ac544d9a02dbb6f34dd {"gasLimit":323704,"maxFeePerGas":"95.479418643","maxPriorityFeePerGas":"95.396216612"} 19:49:57 [19:49:57.157] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x5f35c2d0e4f65c467262e74571eec910db06feaae6991ac544d9a02dbb6f34dd. 19:49:57 [19:49:57.165] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 19:49:57 [19:49:57.177] INFO: validator Started validator with addresses: 19:49:57 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 19:49:57 [19:49:57.177] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 19:49:57 [19:49:57.178] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/3388026c/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:49:57 [19:49:57.178] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:49:57 [19:49:57.179] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:49:57 [19:49:57.180] INFO: node Aztec Node version: 0.87.6 19:49:57 [19:49:57.180] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0"} 19:49:57 [19:49:57.181] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 19:49:57 [19:49:57.218] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:41597"} 19:49:57 [19:49:57.226] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/2ae988b8efa14465/6bb617bebb609f91/archiver with map size 134217728 KB (LMDB v2) 19:49:57 [19:49:57.247] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":2} 19:49:57 [19:49:57.252] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 19:49:57 [19:49:57.394] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:57 [19:49:57.399] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:49:57 [19:49:57.399] WARN: foundation:test-date-provider Time set to 2025-06-04T19:55:05.000Z {"offset":307601,"timeMs":1749066905000} 19:49:57 [19:49:57.537] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:49:57 [19:49:57.636] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:57 [19:49:57.649] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:41597"} 19:49:57 [19:49:57.652] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:41597"} 19:49:57 [19:49:57.652] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 19:49:57 [19:49:57.652] WARN: blob-sink:client:prover-node No archive client configured 19:49:57 [19:49:57.654] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 26 with hash 0x9fda5d8de2c3553c70b1367b5b9133c6fa27a366f165a998cc236b96f8aeeeb4 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xcd7ab2c5e4e72a32b6443822a782ef4066c67788ae0827cb62b5f87db2411ae6","l1BlockNumber":18}} 19:49:57 [19:49:57.665] INFO: archiver:prover-node Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26,"messagesSynchedTo":{"l1BlockHash":"0x9fda5d8de2c3553c70b1367b5b9133c6fa27a366f165a998cc236b96f8aeeeb4","l1BlockNumber":26}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:49:57 [19:49:57.668] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:41597"} 19:49:57 [19:49:57.668] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 19:49:57 [19:49:57.669] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 19:49:57 [19:49:57.676] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/2ae988b8efa14465/6bb617bebb609f91/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:49:57 [19:49:57.719] INFO: world_state:prover-node Created world state synchroniser with block history of 64 19:49:57 [19:49:57.729] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 19:49:57 [19:49:57.730] INFO: world_state:prover-node Started world state synchronizer from block 1 19:49:57 [19:49:57.732] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 19:49:57 [19:49:57.733] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/2ae988b8efa14465/6bb617bebb609f91/archiver when loading epoch databases, ignoring 19:49:57 [19:49:57.734] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/2ae988b8efa14465/6bb617bebb609f91/world_state when loading epoch databases, ignoring 19:49:57 [19:49:57.734] INFO: prover-client:proving-broker:prover-node Proving Broker started 19:49:57 [19:49:57.748] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 19:49:57 [19:49:57.749] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 19:49:57 [19:49:57.750] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 19:49:57 [19:49:57.756] 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/2ae988b8efa14465/6bb617bebb609f91","l1ChainId":31337,"rollupVersion":350338869} 19:49:57 [19:49:57.757] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 19:49:57 [19:49:57.762] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:49:57 [19:49:57.765] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/6c3c0604230850c7/pxe_data with map size 134217728 KB (LMDB v2) 19:49:57 [19:49:57.777] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:49:57 [19:49:57.877] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:58 [19:49:58.095] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:58 [19:49:58.097] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:49:58 [19:49:58.138] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:49:58 [19:49:58.138] INFO: pxe:service Started PXE connected to chain 31337 version 350338869 19:49:58 [19:49:58.210] INFO: pxe:service Registered account 0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e 19:49:58 [19:49:58.285] WARN: pxe:service No artifact found for contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 when looking for its metadata 19:49:58 [19:49:58.292] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 as part of deployment for 0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e 19:49:58 [19:49:58.339] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:58 [19:49:58.405] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:49:58 [19:49:58.488] INFO: pxe:service Added contract SchnorrAccount at 0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e with class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:49:58 [19:49:58.538] VERBOSE: pxe:block_stream Starting sync from block number 0 19:49:58 [19:49:58.612] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:49:58 [19:49:58.666] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:58 [19:49:58.686] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:49:58 [19:49:58.786] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:49:59 [19:49:59.321] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0,0x0240bf0e016845a25c6a69d15d5ca1bb78fd38b72dc894232e020c2b188ad937,0x0d7e7b1c04f61ee57629d3be4dc7b937efb93329c57da17d8b5151dd750d818b,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:49:59 [19:49:59.481] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:49:59 [19:49:59.584] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:59 [19:49:59.614] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:49:59 [19:49:59.748] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:49:59 [19:49:59.806] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:49:59 [19:49:59.807] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:49:59 [19:49:59.811] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:49:59 [19:49:59.867] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:49:59 [19:49:59.891] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:49:59 [19:49:59.896] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:50:00 [19:50:00.030] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:00 [19:50:00.161] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:50:00 [19:50:00.228] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:50:00 [19:50:00.228] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:50:00 [19:50:00.238] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:50:00 [19:50:00.240] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:00 [19:50:00.302] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:50:00 [19:50:00.306] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:50:00 [19:50:00.322] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e as fee payer 19:50:00 [19:50:00.526] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:00 [19:50:00.676] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:50:00 [19:50:00.859] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:01 [19:50:01.020] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:50:01 [19:50:01.164] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:01 [19:50:01.288] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:50:01 [19:50:01.756] INFO: pxe:service Proving completed in 3232.8999749999966ms {"timings":{"total":3232.8999749999966,"sync":14.823390000001382,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":209.64382800000385,"oracles":{"callPrivateFunction":{"times":[925.7388800000008,443.026719999998,314.67690199999925]}}},{"functionName":"private_kernel_init","time":97.59116800000265},{"functionName":"ContractClassRegisterer:register","time":891.9195550000004,"oracles":{"loadCapsule":{"times":[3.3840449999988778]},"notifyCreatedNullifier":{"times":[0.6370660000029602]},"debugLog":{"times":[0.8468710000015562]},"notifyCreatedContractClassLog":{"times":[11.52907800000321]}}},{"functionName":"private_kernel_inner","time":171.5254160000004},{"functionName":"SchnorrAccount:constructor","time":395.8712110000015,"oracles":{"getContractInstance":{"times":[3.9423379999971075]},"debugLog":{"times":[0.6342560000011872,0.5659639999976207]},"fetchTaggedLogs":{"times":[87.51393599999938]},"loadCapsule":{"times":[0.4052300000003015,0.37311899999986053,0.31731800000125077]},"validateEnqueuedNotes":{"times":[1.3973640000003797]},"notifyCreatedNullifier":{"times":[0.3441679999996268,0.30917799999951967]},"notifyCreatedNote":{"times":[0.24248599999918952]},"getRandomField":{"times":[0.2574160000003758,0.22661499999958323,0.14162300000316463,0.0979829999996582,0.09433200000057695,0.06731099999888102,0.0888730000006035,0.08676199999899836,0.07096100000126171,0.06460100000185776,0.062092000000120606]},"getIndexedTaggingSecretAsSender":{"times":[50.65591499999937]},"incrementAppTaggingSecretIndexAsSender":{"times":[35.76152400000137]}}},{"functionName":"private_kernel_inner","time":135.71039100000053},{"functionName":"SchnorrAccount:entrypoint","time":268.8338369999983,"oracles":{"debugLog":{"times":[0.7053879999984929,0.46015100000295206,0.8677619999980379]},"fetchTaggedLogs":{"times":[76.69996600000013]},"loadCapsule":{"times":[0.25171599999885075,0.21851500000047963,0.31797699999879114]},"validateEnqueuedNotes":{"times":[0.9778650000007474]},"getNotes":{"times":[2.067291999999725]},"getAuthWitness":{"times":[0.2907070000001113]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5632640000003448]}}},{"functionName":"private_kernel_inner","time":146.03004800000053},{"functionName":"private_kernel_reset","time":219.13045499999862},{"functionName":"private_kernel_tail","time":90.40684899999906}],"unaccounted":591.4138269999894}} 19:50:01 [19:50:01.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:01 [19:50:01.878] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","blockNumber":1,"slot":3} 19:50:01 [19:50:01.889] VERBOSE: p2p:tx_pool Adding tx 0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c to pool {"eventName":"tx-added-to-pool","txHash":"0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:50:01 [19:50:01.916] INFO: node Received tx 0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c {"txHash":"0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c"} 19:50:01 [19:50:01.916] INFO: pxe:service Sent transaction 0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c 19:50:01 [19:50:01.987] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:02 [19:50:02.106] VERBOSE: sequencer:block-builder Building block 1 for slot 3 {"slot":3,"slotStart":"2025-06-04T19:55:17.000Z","now":"2025-06-04T19:55:09.707Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:50:02 [19:50:02.166] VERBOSE: simulator:public-processor Processed tx 0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c with no public calls in 24.575103000002855ms {"txHash":"0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c","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.575103000002855} 19:50:02 [19:50:02.168] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05946972599999572s {"duration":0.05946972599999572,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 19:50:02 [19:50:02.286] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:02 [19:50:02.301] INFO: sequencer Built block 1 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x28a62e8ce3739771fd1bd0a54b804f820cc990ae14d829cd0421da02cbc9c42d","globalVariables":{"chainId":31337,"version":350338869,"blockNumber":1,"slotNumber":3,"timestamp":1749066917,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x05e0581b62fee13335a2b5bdf6814c9ea67ea62a2d71f50a25ac7f278c393f5c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":201.01123299999745,"publicProcessDuration":60.0410600000032,"rollupCircuitsDuration":194.93865100000403,"txCount":1,"blockNumber":1,"blockTimestamp":1749066917,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:50:02 [19:50:02.304] VERBOSE: sequencer Attesting committee is empty 19:50:02 [19:50:02.496] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:02 [19:50:02.755] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:02 [19:50:02.763] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x6ffe58c7b37fe1b136bdffdc1f5ad0cff9489edfaa6cda250cbd1d6130003add 19:50:02 [19:50:02.764] VERBOSE: node Sent L1 transaction 0x6ffe58c7b37fe1b136bdffdc1f5ad0cff9489edfaa6cda250cbd1d6130003add {"gasLimit":554995,"maxFeePerGas":"114.549196547","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 19:50:02 [19:50:02.777] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:50:02 [19:50:02.778] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x6ffe58c7b37fe1b136bdffdc1f5ad0cff9489edfaa6cda250cbd1d6130003add","calldataSize":1444,"calldataGas":12256,"txCount":1,"blockNumber":1,"blockTimestamp":1749066917,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:50:02 [19:50:02.778] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:50:02 [19:50:02.785] INFO: blob-sink:server Received blob sidecar for block 0xbd70694a198b1a803af8cc83261390fee3eea3e43115f3994337d5f5c9f1f7cf 19:50:02 [19:50:02.793] INFO: blob-sink:server Blob sidecar stored successfully for block 0xbd70694a198b1a803af8cc83261390fee3eea3e43115f3994337d5f5c9f1f7cf 19:50:02 [19:50:02.964] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:02 [19:50:02.978] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:50:02 [19:50:02.978] WARN: foundation:test-date-provider Time set to 2025-06-04T19:55:17.000Z {"offset":314022,"timeMs":1749066917000} 19:50:02 [19:50:02.979] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:50:02 [19:50:02.983] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:50:02 [19:50:02.989] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:50:03 [19:50:03.005] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749066953] on http://127.0.0.1:8545 19:50:03 [19:50:03.009] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:50:03 [19:50:03.016] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749066953 19:50:03 [19:50:03.016] WARN: foundation:test-date-provider Time set to 2025-06-04T19:55:53.000Z {"offset":349984,"timeMs":1749066953000} 19:50:03 [19:50:03.016] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 19:50:03 [19:50:03.025] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba, 0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf) 19:50:03 [19:50:03.166] VERBOSE: archiver:block-helper:prover-node Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:50:03 [19:50:03.186] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:03 [19:50:03.285] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x28a62e8ce3739771fd1bd0a54b804f820cc990ae14d829cd0421da02cbc9c42d","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":350338869,"blockNumber":1,"slotNumber":3,"timestamp":1749066917,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","archiveNextLeafIndex":2} 19:50:03 [19:50:03.298] VERBOSE: archiver:block-helper Store contract class 0x2246b4151efae031b241f1d4e56d0cbe1c9781f9cec32f062c2e7a5ba2634aa0 19:50:03 [19:50:03.313] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x28a62e8ce3739771fd1bd0a54b804f820cc990ae14d829cd0421da02cbc9c42d","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":350338869,"blockNumber":1,"slotNumber":3,"timestamp":1749066917,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","archiveNextLeafIndex":2} 19:50:03 [19:50:03.315] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 19:50:03 [19:50:03.328] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:50:03 [19:50:03.333] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba, 0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf) 19:50:03 [19:50:03.434] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.169218999995792,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749066917,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:50:03 [19:50:03.435] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":14.02324000000226,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749066917,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:50:03 [19:50:03.440] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749069257] on http://127.0.0.1:8545 19:50:03 [19:50:03.441] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:50:03 [19:50:03.442] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749069257 19:50:03 [19:50:03.481] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749071561] on http://127.0.0.1:8545 19:50:03 [19:50:03.483] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:50:03 [19:50:03.485] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749071561 19:50:03 [19:50:03.489] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e 19:50:03 [19:50:03.880] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:03 [19:50:03.886] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:50:03 [19:50:03.886] WARN: foundation:test-date-provider Time set to 2025-06-04T21:12:41.000Z {"offset":4957114,"timeMs":1749071561000} 19:50:03 [19:50:03.903] INFO: pxe:service Added contract StatefulTest at 0x2db82779669fa535561c50e16839226babbd15f9e12148ec8dd1e03ff50d9f01 with class 0x0e75e50f67127bddbbf0c6e812b093c4e20dc26681235d9c77c3d57f93ab52a0 19:50:03 [19:50:03.941] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 19:50:03 [19:50:03.941] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 19:50:03 [19:50:03.953] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 19:50:03 [19:50:03.954] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 19:50:03 [19:50:03.969] VERBOSE: p2p Synched to latest block 1 19:50:04 [19:50:04.004] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","header":{"contentCommitment":{"blobsHash":"0x00cfeb8d12dbaf8a1a67a4349ca8851ffaf591deea8fd0afa6959f79cf563896","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749066917,"version":350338869},"lastArchive":"0x1184b25c492c71b77c619c396a75f43ebe1946ff53a0fc3e37c10ba48905c9bf","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x143a5ee7ed2ee63b8353b6ec147a44f209449ca99ad23f571134f9d60fe695d5","nullifierTree":"0x2acca7fedd6dd4445ae94f353e690615bf0e8d6a97d177d2585b1c2679d5be68","publicDataTree":"0x045c649aa4025a62e51190000af843d38fda609ac75c511afd89e560fd8967be"},"totalFees":2101212240,"totalManaUsed":6324}} 19:50:04 [19:50:04.117] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:50:04 [19:50:04.170] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:50:04 [19:50:04.171] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:50:04 [19:50:04.177] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:04 [19:50:04.260] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","blockNumber":2,"slot":132} 19:50:04 [19:50:04.312] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e"} 19:50:04 [19:50:04.319] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1c1f19f2f5f3e43b8eca5f8165e54623bb024c6a161d5ac7d23913b604bbc26e 19:50:04 [19:50:04.332] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:50:04 [19:50:04.333] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:50:04 [19:50:04.339] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:50:04 [19:50:04.339] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:50:04 [19:50:04.342] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:50:04 [19:50:04.347] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2d60dd8634fe0e85219adfaebd52e0cd4ded0d7b4872c170e7dc23edabf57616","nullifier":"0x0545826bf0a06a46e91cc793c547696ad99dd9a194d9660d82548f9044788697"} 19:50:04 [19:50:04.361] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ea01fa55b34d9692c681e4a272f5ceecaae998db42db0db03b03463e0cfe79e as fee payer 19:50:04 [19:50:04.433] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:04 [19:50:04.571] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x2db82779669fa535561c50e16839226babbd15f9e12148ec8dd1e03ff50d9f01"} 19:50:04 [19:50:04.599] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:50:04 [19:50:04.600] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2db82779669fa535561c50e16839226babbd15f9e12148ec8dd1e03ff50d9f01"} 19:50:04 [19:50:04.696] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:04 [19:50:04.707] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","blockNumber":2,"slot":132} 19:50:04 [19:50:04.739] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2db82779669fa535561c50e16839226babbd15f9e12148ec8dd1e03ff50d9f01"} 19:50:04 [19:50:04.744] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:50:04 [19:50:04.886] INFO: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 is on the validator committee for epoch 4 19:50:04 [19:50:04.886] INFO: validator Validator 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 is on the validator committee for epoch 4 19:50:04 [19:50:04.886] INFO: validator Validator 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc is on the validator committee for epoch 4 19:50:05 [19:50:05.227] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x2db82779669fa535561c50e16839226babbd15f9e12148ec8dd1e03ff50d9f01"} 19:50:05 [19:50:05.276] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:50:05 [19:50:05.277] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2db82779669fa535561c50e16839226babbd15f9e12148ec8dd1e03ff50d9f01"} 19:50:05 [19:50:05.291] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:05 [19:50:05.438] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","blockNumber":2,"slot":132} 19:50:05 [19:50:05.471] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2db82779669fa535561c50e16839226babbd15f9e12148ec8dd1e03ff50d9f01"} 19:50:05 [19:50:05.475] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:50:05 [19:50:05.520] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:05 [19:50:05.752] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:05 [19:50:05.881] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","blockNumber":2,"slot":132} 19:50:05 [19:50:05.985] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:06 [19:50:06.318] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:06 [19:50:06.363] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","blockNumber":2,"slot":132} 19:50:06 [19:50:06.593] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:06 [19:50:06.801] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","blockNumber":2,"slot":132} 19:50:06 [19:50:06.815] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:07 [19:50:07.340] INFO: pxe:service Proving completed in 3376.797679999996ms {"timings":{"total":3376.797679999996,"sync":43.93535800000245,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":412.04010300000664,"oracles":{"debugLog":{"times":[0.7326679999969201,0.5965250000008382,0.450581000004604,0.44921099999919534,0.32224800000403775,0.3862500000032014,0.3589280000014696,0.6888770000005024]},"fetchTaggedLogs":{"times":[144.8705900000059]},"loadCapsule":{"times":[0.27725700000155484,0.5108429999963846,0.6154160000005504,0.2763660000055097,0.14609399999608286,0.2423960000014631,0.17563399999926332]},"getSharedSecret":{"times":[4.946923999996216]},"aes128Decrypt":{"times":[0.28411700000287965,0.8301499999943189]},"getPublicKeysAndPartialAddress":{"times":[1.7383740000004764]},"getKeyValidationRequest":{"times":[1.594570000001113]},"storeCapsule":{"times":[0.32638800000131596,0.7844699999986915,0.30246700000134297]},"deleteCapsule":{"times":[0.3050070000026608]},"validateEnqueuedNotes":{"times":[4.447582000000693]},"getNotes":{"times":[1.1342789999980596]},"getAuthWitness":{"times":[0.15388399999937974]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09017199999652803]},"callPrivateFunction":{"times":[1332.8297610000009]}}},{"functionName":"private_kernel_init","time":76.42010999999911},{"functionName":"StatefulTest:constructor","time":654.213915999986,"oracles":{"getContractInstance":{"times":[4.908932999998797]},"debugLog":{"times":[0.6645760000028531,0.4466610000017681]},"fetchTaggedLogs":{"times":[142.56104200000118]},"loadCapsule":{"times":[0.25290700000186916,0.24552600000606617,0.3021179999996093]},"validateEnqueuedNotes":{"times":[1.2566919999953825]},"storeInExecutionCache":{"times":[0.05825099999492522]},"callPrivateFunction":{"times":[942.6512230000008]},"notifyCreatedNullifier":{"times":[0.2956370000028983]}}},{"functionName":"private_kernel_inner","time":149.4089840000015},{"functionName":"StatefulTest:create_note_no_init_check","time":594.6394670000082,"oracles":{"debugLog":{"times":[0.7567479999997886,0.4666120000038063]},"fetchTaggedLogs":{"times":[197.1558770000047]},"loadCapsule":{"times":[0.27031699999497505,0.18526399999973364,0.17066399999748683]},"validateEnqueuedNotes":{"times":[0.9678449999992154]},"getRandomField":{"times":[0.21995500000048196,0.14973299999837764,0.20703499999945052,0.060270999994827434,0.14167399999860208,0.1550139999962994,0.10488199999963399,0.06819099999847822,0.08029199999873526,0.05457200000091689,0.08813199999713106,0.05687200000102166]},"notifyCreatedNote":{"times":[0.17327400000067428]},"getIndexedTaggingSecretAsSender":{"times":[99.47118500000215]},"incrementAppTaggingSecretIndexAsSender":{"times":[74.80571900000359]}}},{"functionName":"private_kernel_inner","time":154.48619000000326},{"functionName":"private_kernel_reset","time":240.84029799999553},{"functionName":"private_kernel_tail","time":106.29690599999594}],"unaccounted":944.5163479999974}} 19:50:07 [19:50:07.382] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:07 [19:50:07.443] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba","blockNumber":2,"slot":132} 19:50:07 [19:50:07.444] VERBOSE: p2p:tx_pool Adding tx 0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff to pool {"eventName":"tx-added-to-pool","txHash":"0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:50:07 [19:50:07.451] INFO: node Received tx 0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff {"txHash":"0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff"} 19:50:07 [19:50:07.452] INFO: pxe:service Sent transaction 0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff 19:50:07 [19:50:07.599] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:07 [19:50:07.708] VERBOSE: sequencer:block-builder Building block 2 for slot 132 {"slot":132,"slotStart":"2025-06-04T21:12:41.000Z","now":"2025-06-04T21:12:44.822Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x14ec80ae247d6466b8a7781a48ca0907b90f46c4992d9724347ae8346a2fda71"},{"classId":"0x05920012da9559f0ec2f21e8b87dc62fd75973f2d285c9f6b84407387f5a6bac"}]}} 19:50:07 [19:50:07.737] VERBOSE: simulator:public-processor Processed tx 0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff with no public calls in 18.481422000004386ms {"txHash":"0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff","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":18.481422000004386} 19:50:07 [19:50:07.739] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.028265857000005782s {"duration":0.028265857000005782,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 19:50:07 [19:50:07.852] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:07 [19:50:07.869] INFO: sequencer Built block 2 for slot 132 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0f311d6f005037e87e1f7cf2ead55d3b58d76ff55c2596479f3fb5b0b82e709d","globalVariables":{"chainId":31337,"version":350338869,"blockNumber":2,"slotNumber":132,"timestamp":1749071561,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x20cb34c3fba9a2471454690f74c3c1369236b552dc7d98bc5d0c87ce47466dff"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":167.17046699999628,"publicProcessDuration":28.94738299999881,"rollupCircuitsDuration":161.64971800000058,"txCount":1,"blockNumber":2,"blockTimestamp":1749071561,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:50:07 [19:50:07.881] VERBOSE: p2p Broadcasting proposal for slot 132 to peers 19:50:07 [19:50:07.897] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 {"signature":"0x06e8b47999c36644a359242877ec12b01b9c9c35acb1a203cd71c521361e51681cf5a2514e2ed9433f58eee8f8571f979be4adba538be4161b5b3b7ada3365921c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","proposalId":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d"} 19:50:07 [19:50:07.907] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 {"signature":"0xed45d2b62b85b7a00209ea90e9e097b3052f8e76d2089be4c35c63fa5e3dbe027ea2802a6190b4c382cf9b5b79b74652b9b5f9e241fef874dd7250077150c6e21c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","proposalId":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d"} 19:50:07 [19:50:07.913] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc {"signature":"0x292b63c2895f4d58d9a3b34f04b2e67d813b42934e82aca73719ea36da1831b07a5b6d7e07b8ea34ebef35eaa7dd1f35fcd39906560ecf48d8632811d9ef8dba1b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","proposalId":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d"} 19:50:07 [19:50:07.913] VERBOSE: validator Collected all 3 attestations for slot 132 19:50:07 [19:50:07.913] VERBOSE: sequencer Collected 3 attestations {"blockHash":"0x0f311d6f005037e87e1f7cf2ead55d3b58d76ff55c2596479f3fb5b0b82e709d","blockNumber":2} 19:50:08 [19:50:08.060] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:08 [19:50:08.253] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xede4812e339b2f525d0325a9841e93ac17b6ca9948aabfea008659f70186bf93 19:50:08 [19:50:08.253] VERBOSE: node Sent L1 transaction 0xede4812e339b2f525d0325a9841e93ac17b6ca9948aabfea008659f70186bf93 {"gasLimit":633229,"maxFeePerGas":"1.233593065","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:50:08 [19:50:08.267] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:08 [19:50:08.274] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 19:50:08 [19:50:08.275] WARN: foundation:test-date-provider Time set to 2025-06-04T21:12:53.000Z {"offset":4964725,"timeMs":1749071573000} 19:50:08 [19:50:08.276] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:50:08 [19:50:08.278] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:50:08 [19:50:08.282] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:50:08 [19:50:08.282] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xede4812e339b2f525d0325a9841e93ac17b6ca9948aabfea008659f70186bf93","calldataSize":1828,"calldataGas":16864,"txCount":1,"blockNumber":2,"blockTimestamp":1749071561,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:50:08 [19:50:08.283] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:50:08 [19:50:08.288] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:50:08 [19:50:08.293] INFO: blob-sink:server Received blob sidecar for block 0xc7a84694642a3b990a8812d2b4187346cb6457915fa49bd3b565d010d501e74b 19:50:08 [19:50:08.302] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc7a84694642a3b990a8812d2b4187346cb6457915fa49bd3b565d010d501e74b 19:50:08 [19:50:08.530] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:08 [19:50:08.667] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0f311d6f005037e87e1f7cf2ead55d3b58d76ff55c2596479f3fb5b0b82e709d","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":350338869,"blockNumber":2,"slotNumber":132,"timestamp":1749071561,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d","archiveNextLeafIndex":3} 19:50:08 [19:50:08.673] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749071597] on http://127.0.0.1:8545 19:50:08 [19:50:08.674] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x0f311d6f005037e87e1f7cf2ead55d3b58d76ff55c2596479f3fb5b0b82e709d","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":350338869,"blockNumber":2,"slotNumber":132,"timestamp":1749071561,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d","archiveNextLeafIndex":3} 19:50:08 [19:50:08.677] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:50:08 [19:50:08.678] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:50:08 [19:50:08.681] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749071597 19:50:08 [19:50:08.682] WARN: foundation:test-date-provider Time set to 2025-06-04T21:13:17.000Z {"offset":4988318,"timeMs":1749071597000} 19:50:08 [19:50:08.682] INFO: aztecjs:utils:watcher Slot 132 was filled, jumped to next slot 19:50:08 [19:50:08.696] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d, 0x051e3a04bee6dc3d9b36fc90d14f541f9a9750e4f4b5f5bd0ad75982988690ba) 19:50:08 [19:50:08.697] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 19:50:08 [19:50:08.747] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:08 [19:50:08.773] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.216724999998405,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749071561,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:50:08 [19:50:08.776] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.91196299999865,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749071561,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:50:08 [19:50:08.926] VERBOSE: p2p Synched to latest block 2 19:50:08 [19:50:08.952] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:09 [19:50:09.134] VERBOSE: sequencer Not enough txs to build block 3 at slot 133 (got 0 txs, need 1) {"chainTipArchive":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d","blockNumber":3,"slot":133} 19:50:09 [19:50:09.160] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:09 [19:50:09.347] VERBOSE: sequencer Not enough txs to build block 3 at slot 133 (got 0 txs, need 1) {"chainTipArchive":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d","blockNumber":3,"slot":133} 19:50:09 [19:50:09.365] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:09 [19:50:09.404] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 19:50:09 [19:50:09.405] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 19:50:09 [19:50:09.408] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 19:50:09 [19:50:09.408] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 19:50:09 [19:50:09.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:50:09 [19:50:09.570] VERBOSE: sequencer Not enough txs to build block 3 at slot 133 (got 0 txs, need 1) {"chainTipArchive":"0x15aaba94e5f8586e4445043074df5cd38936602db18c3390ac720229d853b90d","blockNumber":3,"slot":133} 19:50:09 [19:50:09.740] INFO: node Stopping 19:50:09 [19:50:09.743] INFO: slasher Slasher client stopped. 19:50:09 [19:50:09.743] INFO: sequencer Stopped sequencer 19:50:09 [19:50:09.744] INFO: p2p P2P client stopped. 19:50:09 [19:50:09.748] INFO: world_state Stopped world state synchronizer 19:50:09 [19:50:09.748] INFO: archiver Stopped. 19:50:09 [19:50:09.748] INFO: node Stopped 19:50:09 [19:50:09.748] INFO: prover-node:prover-node Stopping ProverNode 19:50:09 [19:50:09.749] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 19:50:09 [19:50:09.749] INFO: archiver:prover-node Stopped. 19:50:09 [19:50:09.752] INFO: world_state:prover-node Stopped world state synchronizer 19:50:09 [19:50:09.752] INFO: prover-node:prover-node Stopped ProverNode 19:50:09 [19:50:09.752] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 19:50:09 [19:50:09.753] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/3388026c 19:50:09 [19:50:09.760] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 19:50:09 [19:50:09.765] INFO: blob-sink:server Stopping blob sink 19:50:09 [19:50:09.766] INFO: blob-sink:server Blob sink stopped 19:50:09 [19:50:09.766] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/2ae988b8efa14465 19:50:09 FAIL src/e2e_multi_validator_node.test.ts 19:50:09 e2e_multi_validator_node 19:50:09 ✕ should build blocks & attest with multiple validator keys (17256 ms) 19:50:09 ✓ should attest ONLY with the correct validator keys (16188 ms) 19:50:09 19:50:09 ● e2e_multi_validator_node › should build blocks & attest with multiple validator keys 19:50:09 19:50:09 expect(received).toBeGreaterThanOrEqual(expected) 19:50:09 19:50:09 Expected: >= 4 19:50:09 Received: 0 19:50:09 19:50:09 131 | .map(a => new BlockAttestation(new Fr(block.block.number), payload, a.signature)); 19:50:09 132 | 19:50:09 > 133 | expect(attestations.length).toBeGreaterThanOrEqual(4); // Math.floor((5 * 2) / 3) + 1 19:50:09 | ^ 19:50:09 134 | 19:50:09 135 | const signers = attestations.map(att => att.getSender().toString()); 19:50:09 136 | 19:50:09 19:50:09 at Object.toBeGreaterThanOrEqual (e2e_multi_validator_node.test.ts:133:33) 19:50:09 19:50:09 Test Suites: 1 failed, 1 total 19:50:09 Tests: 1 failed, 1 passed, 2 total 19:50:09 Snapshots: 0 total 19:50:09 Time: 40.385 s 19:50:09 Ran all test suites matching /src\/e2e_multi_validator_node.test.ts/i. 19:50:09 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?