Parent Log: http://ci.aztec-labs.com/1071e86ad98466a6 Command: 33ef202a67c76ec0: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/8354a48916f20f3f67a800f4a4b6afc7aa71bf4d Env: REF_NAME=gh-readonly-queue/next/pr-14763-4c3c8fa5f9ebcc6a40e9eade93f3191a6254833f CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Wed Jun 4 22:46:54 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14763_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/0d13f39a62f4c76d 22:46:54 +++ id -u 22:46:54 +++ id -g 22:46:54 ++ 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'\''' 22:46:55 + cid=3b3d8ed73d22fbc992174ad315a9f7c36375d26a089b16dc7df34a657de82037 22:46:55 + set +x 22:46:56 {"level":25,"time":1749077216038,"pid":12,"hostname":"3b3d8ed73d22","module":"logger","msg":"Logger initialized with level verbose"} 22:47:02 [22:47:02.548] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should build blocks & attest with multiple validator keys 22:47:03 [22:47:03.027] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 22:47:03 [22:47:03.589] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-UVlzoz/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 22:47:03 [22:47:03.677] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 22:47:03 [22:47:03.723] WARN: e2e:e2e_multi_validator_node Set block interval to 12 22:47:03 [22:47:03.724] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 22:47:03 [22:47:03.776] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 22:47:03 [22:47:03.790] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 22:47:03 [22:47:03.813] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 22:47:03 [22:47:03.820] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 22:47:03 [22:47:03.847] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 22:47:03 [22:47:03.854] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 22:47:03 [22:47:03.871] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 22:47:03 [22:47:03.876] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 22:47:03 [22:47:03.894] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 22:47:03 [22:47:03.900] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 22:47:03 [22:47:03.917] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 22:47:03 [22:47:03.930] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 22:47:03 [22:47:03.950] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 22:47:03 [22:47:03.950] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 22:47:03 [22:47:03.963] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 22:47:03 [22:47:03.967] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 22:47:03 [22:47:03.968] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 22:47:03 [22:47:03.968] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 22:47:03 [22:47:03.999] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:04 [22:47:04.018] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 22:47:04 [22:47:04.019] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 22:47:04 [22:47:04.033] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 22:47:04 [22:47:04.048] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 22:47:04 [22:47:04.053] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 22:47:04 [22:47:04.066] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 22:47:04 [22:47:04.067] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 22:47:04 [22:47:04.118] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 22:47:04 [22:47:04.125] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 22:47:04 [22:47:04.150] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 22:47:04 [22:47:04.151] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 22:47:04 [22:47:04.151] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 22:47:04 [22:47:04.152] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 22:47:04 [22:47:04.178] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:04 [22:47:04.192] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 22:47:04 [22:47:04.215] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 22:47:04 [22:47:04.215] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 22:47:04 [22:47:04.219] 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} 22:47:04 [22:47:04.233] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 22:47:04 [22:47:04.294] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 22:47:04 [22:47:04.308] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 22:47:04 [22:47:04.377] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xd8d59f9bcc4d2f77b928630ef3456f29e1bf50a38da37c6363c43b1f079133bf {"gasLimit":10716781,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 22:47:04 [22:47:04.386] 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} 22:47:04 [22:47:04.387] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 22:47:04 [22:47:04.437] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:04 [22:47:04.440] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 22:47:04 [22:47:04.491] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 22:47:04 [22:47:04.497] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 22:47:04 [22:47:04.543] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xa8897c0adb59c20b46f23cd39fab84926417a78cc6c803792273c45350f8ad09 {"gasLimit":1040116,"maxFeePerGas":"38.520398432","maxPriorityFeePerGas":"38.337599913"} 22:47:04 [22:47:04.558] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 22:47:04 [22:47:04.601] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 {"gasLimit":116846,"maxFeePerGas":"46.165150248","maxPriorityFeePerGas":"46.005119895"} 22:47:04 [22:47:04.603] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 22:47:04 [22:47:04.626] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf {"gasLimit":109478,"maxFeePerGas":"55.347326337","maxPriorityFeePerGas":"55.206143874"} 22:47:04 [22:47:04.627] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf 22:47:04 [22:47:04.631] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 22:47:04 [22:47:04.682] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:04 [22:47:04.697] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 22:47:04 [22:47:04.698] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 22:47:04 [22:47:04.698] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 22:47:04 [22:47:04.770] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:04 [22:47:04.770] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 22:47:04 [22:47:04.799] 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"} 22:47:04 [22:47:04.800] INFO: e2e:e2e_multi_validator_node Handing over to governance 22:47:04 [22:47:04.809] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 22:47:04 [22:47:04.812] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:04 [22:47:04.814] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 22:47:04 [22:47:04.815] INFO: telemetry:client Using NoopTelemetryClient 22:47:04 [22:47:04.823] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:04 [22:47:04.825] WARN: foundation:test-date-provider Time set to 2025-06-04T22:51:27.000Z {"offset":262176,"timeMs":1749077487000} 22:47:04 [22:47:04.827] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/e58209948bf11e3c/blob-sink with map size 134217728 KB (LMDB v2) 22:47:04 [22:47:04.839] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 22:47:04 [22:47:04.860] INFO: blob-sink:server Server is running on http://localhost:36913 22:47:04 [22:47:04.860] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 22:47:04 [22:47:04.865] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/a0363cb8/acvm 22:47:04 [22:47:04.867] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36913"} 22:47:04 [22:47:04.910] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 22:47:04 [22:47:04.913] INFO: archiver:lmdb Creating archiver data store at directory /tmp/e58209948bf11e3c/archiver with map size 134217728 KB (LMDB v2) 22:47:04 [22:47:04.915] INFO: archiver:lmdb Starting data store with maxReaders 16 22:47:05 [22:47:05.050] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:05 [22:47:05.360] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:05 [22:47:05.522] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:36913"} 22:47:05 [22:47:05.545] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:36913"} 22:47:05 [22:47:05.545] WARN: node:blob-sink:client No L1 consensus host urls configured 22:47:05 [22:47:05.546] WARN: node:blob-sink:client No archive client configured 22:47:05 [22:47:05.550] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 22 with hash 0x2d35fc8fee43c2370564868a96d4910dc7839f74d76e742efc8bbbd74c5d3a36 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xe36135fd554b8dd4718e29493060aa909dc35ffeae75a25a9e8c364657004485","l1BlockNumber":18}} 22:47:05 [22:47:05.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:05 [22:47:05.578] INFO: archiver Initial archiver sync to L1 block 22 complete. {"l1BlockNumber":22,"syncPoint":{"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0x2d35fc8fee43c2370564868a96d4910dc7839f74d76e742efc8bbbd74c5d3a36","l1BlockNumber":22}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 22:47:05 [22:47:05.588] INFO: world-state:database Creating world state data store at directory /tmp/e58209948bf11e3c/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 22:47:05 [22:47:05.616] INFO: world_state Created world state synchroniser with block history of 64 22:47:05 [22:47:05.616] WARN: node Aztec node is accepting fake proofs 22:47:05 [22:47:05.636] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/e58209948bf11e3c/p2p with map size 134217728 KB (LMDB v2) 22:47:05 [22:47:05.638] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 22:47:05 [22:47:05.640] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/e58209948bf11e3c/p2p-archive with map size 134217728 KB (LMDB v2) 22:47:05 [22:47:05.642] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 22:47:05 [22:47:05.643] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/e58209948bf11e3c/p2p-peers with map size 134217728 KB (LMDB v2) 22:47:05 [22:47:05.645] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 22:47:05 [22:47:05.646] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 22:47:05 [22:47:05.647] VERBOSE: p2p P2P is disabled. Using dummy P2P service 22:47:05 [22:47:05.650] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 22:47:05 [22:47:05.651] INFO: world_state Started world state synchronizer from block 1 22:47:05 [22:47:05.654] VERBOSE: world-state:block_stream Starting sync from block number 0 22:47:05 [22:47:05.656] INFO: p2p Starting p2p client from block 0 with empty mempools 22:47:05 [22:47:05.656] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 22:47:05 [22:47:05.657] INFO: epoch-prune-watcher EpochPruneWatcher initialized 22:47:05 [22:47:05.667] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 22:47:05 [22:47:05.669] INFO: slasher Starting Slasher client... 22:47:05 [22:47:05.720] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 22:47:05 [22:47:05.721] VERBOSE: node All Aztec Node subsystems synced 22:47:05 [22:47:05.733] INFO: sequencer-client Deploying forwarder contract 22:47:05 [22:47:05.754] VERBOSE: sequencer-client Sent L1 transaction 0xd55cdb6ebb71ba0fcaadbf6ded6a5b8e0f60991502922716080b2393915bf73f {"gasLimit":323704,"maxFeePerGas":"66.371021863","maxPriorityFeePerGas":"66.247372648"} 22:47:05 [22:47:05.754] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0xd55cdb6ebb71ba0fcaadbf6ded6a5b8e0f60991502922716080b2393915bf73f. 22:47:05 [22:47:05.759] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 22:47:05 [22:47:05.767] INFO: validator Started validator with addresses: 22:47:05 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 22:47:05 [22:47:05.768] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 22:47:05 [22:47:05.769] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/a0363cb8/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 22:47:06 [22:47:06.095] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 22:47:06 [22:47:06.098] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 22:47:06 [22:47:06.099] INFO: node Aztec Node version: 0.87.6 22:47:06 [22:47:06.100] 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"} 22:47:06 [22:47:06.101] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 22:47:06 [22:47:06.140] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36913"} 22:47:06 [22:47:06.142] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:06 [22:47:06.149] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:06 [22:47:06.149] WARN: foundation:test-date-provider Time set to 2025-06-04T22:51:39.000Z {"offset":272851,"timeMs":1749077499000} 22:47:06 [22:47:06.161] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/e58209948bf11e3c/b2126c0d2b7bd3f2/archiver with map size 134217728 KB (LMDB v2) 22:47:06 [22:47:06.176] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:06 [22:47:06.182] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 22:47:06 [22:47:06.406] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:06 [22:47:06.456] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:06 [22:47:06.537] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:36913"} 22:47:06 [22:47:06.540] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:36913"} 22:47:06 [22:47:06.541] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 22:47:06 [22:47:06.541] WARN: blob-sink:client:prover-node No archive client configured 22:47:06 [22:47:06.544] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 23 with hash 0x4151cc665f1af8e0533a14ea5db50633686dba92c9a9eaf16258e4436a97350a {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xe36135fd554b8dd4718e29493060aa909dc35ffeae75a25a9e8c364657004485","l1BlockNumber":18}} 22:47:06 [22:47:06.561] INFO: archiver:prover-node Initial archiver sync to L1 block 23 complete. {"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x4151cc665f1af8e0533a14ea5db50633686dba92c9a9eaf16258e4436a97350a","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 22:47:06 [22:47:06.565] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36913"} 22:47:06 [22:47:06.566] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 22:47:06 [22:47:06.569] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 22:47:06 [22:47:06.577] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/e58209948bf11e3c/b2126c0d2b7bd3f2/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 22:47:06 [22:47:06.603] INFO: world_state:prover-node Created world state synchroniser with block history of 64 22:47:06 [22:47:06.605] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 22:47:06 [22:47:06.606] INFO: world_state:prover-node Started world state synchronizer from block 1 22:47:06 [22:47:06.609] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 22:47:06 [22:47:06.609] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/e58209948bf11e3c/b2126c0d2b7bd3f2/archiver when loading epoch databases, ignoring 22:47:06 [22:47:06.610] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/e58209948bf11e3c/b2126c0d2b7bd3f2/world_state when loading epoch databases, ignoring 22:47:06 [22:47:06.611] INFO: prover-client:proving-broker:prover-node Proving Broker started 22:47:06 [22:47:06.622] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:06 [22:47:06.632] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 22:47:06 [22:47:06.634] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 22:47:06 [22:47:06.635] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 22:47:06 [22:47:06.641] 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/e58209948bf11e3c/b2126c0d2b7bd3f2","l1ChainId":31337,"rollupVersion":2085183025} 22:47:06 [22:47:06.642] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 22:47:06 [22:47:06.645] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/2a9806422908067d/pxe_data with map size 134217728 KB (LMDB v2) 22:47:06 [22:47:06.647] INFO: pxe:data:lmdb Starting data store with maxReaders 16 22:47:06 [22:47:06.883] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:06 [22:47:06.887] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:06 [22:47:06.991] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 22:47:06 [22:47:06.991] INFO: pxe:service Started PXE connected to chain 31337 version 2085183025 22:47:07 [22:47:07.050] INFO: pxe:service Registered account 0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2 22:47:07 [22:47:07.119] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:07 [22:47:07.122] WARN: pxe:service No artifact found for contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b when looking for its metadata 22:47:07 [22:47:07.130] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b as part of deployment for 0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2 22:47:07 [22:47:07.184] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:07 [22:47:07.340] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:07 [22:47:07.349] INFO: pxe:service Added contract SchnorrAccount at 0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2 with class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b 22:47:07 [22:47:07.429] VERBOSE: pxe:block_stream Starting sync from block number 0 22:47:07 [22:47:07.430] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:07 [22:47:07.485] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 22:47:07 [22:47:07.572] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:07 [22:47:07.633] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 22:47:08 [22:47:08.735] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b,0x1999a7be421b7ee05b82c7c5d724475a7895bb2f73fe84f7d5f029d017e45d08,0x0d7e7b1c04f61ee57629d3be4dc7b937efb93329c57da17d8b5151dd750d818b,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 22:47:08 [22:47:08.926] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 22:47:09 [22:47:09.091] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:09 [22:47:09.137] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:09 [22:47:09.338] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:09 [22:47:09.386] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:09 [22:47:09.437] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:09 [22:47:09.439] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:09 [22:47:09.461] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:09 [22:47:09.549] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:09 [22:47:09.559] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:09 [22:47:09.648] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:09 [22:47:09.724] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:09 [22:47:09.840] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:09 [22:47:09.886] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:09 [22:47:09.887] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:09 [22:47:09.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:09 [22:47:09.935] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:09 [22:47:09.961] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:09 [22:47:09.966] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:10 [22:47:09.999] VERBOSE: simulator:client_execution_context:debug_log Setting 0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2 as fee payer 22:47:10 [22:47:10.106] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:10 [22:47:10.317] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:10 [22:47:10.476] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:10 [22:47:10.650] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:10 [22:47:10.856] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:11 [22:47:11.040] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:11 [22:47:11.211] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:11 [22:47:11.337] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:11 [22:47:11.891] INFO: pxe:service Proving completed in 4487.96579ms {"timings":{"total":4487.96579,"sync":26.460025999998834,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":236.33654999999817,"oracles":{"callPrivateFunction":{"times":[1514.2730759999995,659.2987900000007,301.41118300000016]}}},{"functionName":"private_kernel_init","time":139.44361599999866},{"functionName":"ContractClassRegisterer:register","time":1477.8204339999993,"oracles":{"loadCapsule":{"times":[51.28064500000073]},"notifyCreatedNullifier":{"times":[34.32645500000035]},"debugLog":{"times":[8.54667899999913]},"notifyCreatedContractClassLog":{"times":[36.90176699999938]}}},{"functionName":"private_kernel_inner","time":188.36445999999887},{"functionName":"SchnorrAccount:constructor","time":596.5030890000016,"oracles":{"getContractInstance":{"times":[7.010917999999947]},"debugLog":{"times":[0.7670249999991938,0.8253390000008949]},"fetchTaggedLogs":{"times":[118.33704899999975]},"loadCapsule":{"times":[0.838659999999436,0.5096800000010262,0.4478870000002644]},"validateEnqueuedNotesAndEvents":{"times":[4.727590999998938]},"notifyCreatedNullifier":{"times":[0.4239849999994476,0.49891999999999825]},"notifyCreatedNote":{"times":[0.5947550000000774]},"getRandomField":{"times":[0.458716999999524,0.3600319999986823,0.19213099999979022,0.12580800000068848,0.1071460000002844,0.06355400000029476,0.05324300000029325,0.059812999999849126,0.06453400000100373,0.11571699999876728,0.05600299999969138]},"getIndexedTaggingSecretAsSender":{"times":[63.664661999999225]},"incrementAppTaggingSecretIndexAsSender":{"times":[40.93720899999971]}}},{"functionName":"private_kernel_inner","time":150.07222899999942},{"functionName":"SchnorrAccount:entrypoint","time":264.09907000000203,"oracles":{"debugLog":{"times":[0.8015080000004673,0.5030200000001059,0.9542870000004768]},"fetchTaggedLogs":{"times":[77.70470800000112]},"loadCapsule":{"times":[0.40876399999979185,0.2410249999993539,0.2716660000005504]},"validateEnqueuedNotesAndEvents":{"times":[2.9892780000009225]},"getNotes":{"times":[2.528081000000384]},"getAuthWitness":{"times":[0.5815540000003239]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.2731459999995423]}}},{"functionName":"private_kernel_inner","time":154.98411099999976},{"functionName":"private_kernel_reset","time":251.96644799999922},{"functionName":"private_kernel_tail","time":123.67779599999994}],"unaccounted":878.2379610000044}} 22:47:11 [22:47:11.915] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:12 [22:47:12.020] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","blockNumber":1,"slot":2} 22:47:12 [22:47:12.031] VERBOSE: p2p:tx_pool Adding tx 0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf to pool {"eventName":"tx-added-to-pool","txHash":"0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 22:47:12 [22:47:12.049] INFO: node Received tx 0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf {"txHash":"0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf"} 22:47:12 [22:47:12.049] INFO: pxe:service Sent transaction 0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf 22:47:12 [22:47:12.130] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:12 [22:47:12.249] VERBOSE: sequencer:block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-04T22:51:51.000Z","now":"2025-06-04T22:51:45.100Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x2b0850a4e7ff148a55b27ce003d2713401b9f3bd4484d4d53c1aeecd5ca27126"},{"classId":"0x1d67ec95e53a19062e838f31a622b933858e54ae8efe1aa2572dd7692691c9b0"}]}} 22:47:12 [22:47:12.317] VERBOSE: simulator:public-processor Processed tx 0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf with no public calls in 34.01179599999887ms {"txHash":"0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf","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":34.01179599999887} 22:47:12 [22:47:12.326] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.07290731299999971s {"duration":0.07290731299999971,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 22:47:12 [22:47:12.425] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:12 [22:47:12.440] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1ff8490aa1c24736b07f624048526be6f213aae14922645ad2273a7ee436e88f","globalVariables":{"chainId":31337,"version":2085183025,"blockNumber":1,"slotNumber":2,"timestamp":1749077511,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2c1269257982d55e5e88b1ba15ede8d77031e4a62e44a0036d5d20478889dacf"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":200.11007900000186,"publicProcessDuration":74.31110600000102,"rollupCircuitsDuration":191.98665600000095,"txCount":1,"blockNumber":1,"blockTimestamp":1749077511,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:12 [22:47:12.443] VERBOSE: sequencer Attesting committee is empty 22:47:12 [22:47:12.635] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:12 [22:47:12.875] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:12 [22:47:12.894] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x55dfb507a3ec9a83d7ad4793f4cd2df2fcf94daaaabe409d6334ae1200eb8777 22:47:12 [22:47:12.894] VERBOSE: node Sent L1 transaction 0x55dfb507a3ec9a83d7ad4793f4cd2df2fcf94daaaabe409d6334ae1200eb8777 {"gasLimit":555104,"maxFeePerGas":"79.605134246","maxPriorityFeePerGas":"79.496847177","maxFeePerBlobGas":"0.000000001"} 22:47:12 [22:47:12.979] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:47:12 [22:47:12.981] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x55dfb507a3ec9a83d7ad4793f4cd2df2fcf94daaaabe409d6334ae1200eb8777","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":1,"blockTimestamp":1749077511,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:12 [22:47:12.982] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 22:47:13 [22:47:13.038] INFO: blob-sink:server Received blob sidecar for block 0xd881fe5877bba32c63c053c3504ce171c6da7e0ada485c9e06664ca847a2a626 22:47:13 [22:47:13.054] INFO: blob-sink:server Blob sidecar stored successfully for block 0xd881fe5877bba32c63c053c3504ce171c6da7e0ada485c9e06664ca847a2a626 22:47:13 [22:47:13.109] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:13 [22:47:13.132] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:13 [22:47:13.132] WARN: foundation:test-date-provider Time set to 2025-06-04T22:51:51.000Z {"offset":277868,"timeMs":1749077511000} 22:47:13 [22:47:13.259] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 22:47:13 [22:47:13.281] VERBOSE: archiver:block-helper:prover-node Store contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b 22:47:13 [22:47:13.288] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 22:47:13 [22:47:13.301] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 22:47:13 [22:47:13.310] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749077547] on http://127.0.0.1:8545 22:47:13 [22:47:13.312] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x1ff8490aa1c24736b07f624048526be6f213aae14922645ad2273a7ee436e88f","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2085183025,"blockNumber":1,"slotNumber":2,"timestamp":1749077511,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","archiveNextLeafIndex":2} 22:47:13 [22:47:13.417] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:13 [22:47:13.421] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 22:47:13 [22:47:13.437] VERBOSE: archiver:block-helper Store contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b 22:47:13 [22:47:13.451] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749077547 22:47:13 [22:47:13.452] WARN: foundation:test-date-provider Time set to 2025-06-04T22:52:27.000Z {"offset":313548,"timeMs":1749077547000} 22:47:13 [22:47:13.452] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 22:47:13 [22:47:13.461] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638, 0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591) 22:47:13 [22:47:13.474] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1ff8490aa1c24736b07f624048526be6f213aae14922645ad2273a7ee436e88f","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2085183025,"blockNumber":1,"slotNumber":2,"timestamp":1749077511,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","archiveNextLeafIndex":2} 22:47:13 [22:47:13.569] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":20.92675700000109,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749077511,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:13 [22:47:13.575] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":21.739835000000312,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749077511,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:13 [22:47:13.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:13 [22:47:13.657] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749079851] on http://127.0.0.1:8545 22:47:13 [22:47:13.663] VERBOSE: p2p Synched to latest block 1 22:47:13 [22:47:13.666] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 22:47:13 [22:47:13.678] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749079851 22:47:13 [22:47:13.679] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2 22:47:14 [22:47:14.121] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:14 [22:47:14.152] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:14 [22:47:14.153] WARN: foundation:test-date-provider Time set to 2025-06-04T23:30:51.000Z {"offset":2616847,"timeMs":1749079851000} 22:47:14 [22:47:14.158] INFO: pxe:service Added contract StatefulTest at 0x2796464df1e037a9d3c08b47f2b796e17a1d8b6b67549ec74d73717970d04e0a with class 0x1fcd82d187cb5ed9f7030e5163de20b38d8dbae55363038635e57abd6d41a817 22:47:14 [22:47:14.196] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:14 [22:47:14.219] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 22:47:14 [22:47:14.225] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 22:47:14 [22:47:14.241] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","header":{"contentCommitment":{"blobsHash":"0x0056506f100e613f3b522fc5cfa36e9a599d148c07a4a48d822d15ce197534f7","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749077511,"version":2085183025},"lastArchive":"0x1d4dc6da80fa2fd4d92e03aea81428519d16cb868e85d3567b806b4c42f24591","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x27d11c68ecf712f7a60e694a210fe6fad20c563ea30bc92806d23e70e1dc49da","nullifierTree":"0x0da3c2cc5fed5c6701722eaa45ee3ff2746b56ff84411633ef06ad72aa90e782","publicDataTree":"0x2ff7f763614973918d889d9d89b9137699215b0f799809c9836bdc6911f928c5"},"totalFees":2101212240,"totalManaUsed":6324}} 22:47:14 [22:47:14.262] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 2 22:47:14 [22:47:14.326] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 22:47:14 [22:47:14.327] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 22:47:14 [22:47:14.395] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:14 [22:47:14.406] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 22:47:14 [22:47:14.407] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 22:47:14 [22:47:14.459] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:14 [22:47:14.516] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:14 [22:47:14.517] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:14 [22:47:14.646] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:14 [22:47:14.679] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2"} 22:47:14 [22:47:14.685] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d2cb9029b2d0cc07e5e07d57dc1fca645b4ccb3ca016b14b958e79a2b69e695 22:47:14 [22:47:14.697] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 22:47:14 [22:47:14.698] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 22:47:14 [22:47:14.706] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 22:47:14 [22:47:14.707] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 22:47:14 [22:47:14.711] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:14 [22:47:14.736] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:14 [22:47:14.772] VERBOSE: pxe:service Added note {"index":0,"contract":"0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x161e81af0d6d5359cc9fd051893a267d23497e1e97756085b8cfb7a95f477b72","nullifier":"0x20d079bd93921f650fb84186e9e58f46e35622d47d9a27a3e78899eec3627221"} 22:47:14 [22:47:14.818] VERBOSE: simulator:client_execution_context:debug_log Setting 0x119e832336939621a72608d0b877530d780db605dd69b58e0ac9e8f0b38ea9c2 as fee payer 22:47:15 [22:47:15.022] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x2796464df1e037a9d3c08b47f2b796e17a1d8b6b67549ec74d73717970d04e0a"} 22:47:15 [22:47:15.040] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:15 [22:47:15.049] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:15 [22:47:15.049] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2796464df1e037a9d3c08b47f2b796e17a1d8b6b67549ec74d73717970d04e0a"} 22:47:15 [22:47:15.237] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:15 [22:47:15.258] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:15 [22:47:15.319] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2796464df1e037a9d3c08b47f2b796e17a1d8b6b67549ec74d73717970d04e0a"} 22:47:15 [22:47:15.327] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:15 [22:47:15.618] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:15 [22:47:15.871] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x2796464df1e037a9d3c08b47f2b796e17a1d8b6b67549ec74d73717970d04e0a"} 22:47:15 [22:47:15.941] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:15 [22:47:15.942] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2796464df1e037a9d3c08b47f2b796e17a1d8b6b67549ec74d73717970d04e0a"} 22:47:15 [22:47:15.970] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:16 [22:47:16.127] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:16 [22:47:16.159] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2796464df1e037a9d3c08b47f2b796e17a1d8b6b67549ec74d73717970d04e0a"} 22:47:16 [22:47:16.173] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:16 [22:47:16.209] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:16 [22:47:16.436] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:16 [22:47:16.739] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:16 [22:47:16.780] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:17 [22:47:17.042] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:17 [22:47:17.404] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:17 [22:47:17.449] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:17 [22:47:17.661] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:17 [22:47:17.994] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:18 [22:47:18.035] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:18 [22:47:18.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:18 [22:47:18.763] INFO: pxe:service Proving completed in 4555.868345000003ms {"timings":{"total":4555.868345000003,"sync":43.38907400000244,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":582.0916410000063,"oracles":{"debugLog":{"times":[0.9935699999987264,0.5897960000002058,0.6111869999986084,0.6223769999996875,0.6625700000004144,0.479258999999729,0.5164409999997588,0.9748579999977665]},"fetchTaggedLogs":{"times":[165.29044499999873]},"loadCapsule":{"times":[0.29672800000116695,0.5485230000012962,0.5548630000012054,0.28891700000167475,0.24330400000326335,0.28757799999948475,0.3060780000014347]},"getSharedSecret":{"times":[4.192658999996638]},"aes128Decrypt":{"times":[1.0677539999996952,0.8911540000008245]},"getPublicKeysAndPartialAddress":{"times":[2.082083999997849]},"getKeyValidationRequest":{"times":[2.391482000002725]},"storeCapsule":{"times":[0.5936760000004142,0.363231999999698,0.3189889999994193]},"deleteCapsule":{"times":[0.5185419999979786]},"validateEnqueuedNotesAndEvents":{"times":[76.4414829999987]},"getNotes":{"times":[12.179205000000366]},"getAuthWitness":{"times":[0.37120300000242423]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.11676699999952689]},"callPrivateFunction":{"times":[1656.8048149999995]}}},{"functionName":"private_kernel_init","time":101.73493999999846},{"functionName":"StatefulTest:constructor","time":603.3728189999965,"oracles":{"getContractInstance":{"times":[6.530359000000317]},"debugLog":{"times":[0.7961170000016864,0.5532430000021122]},"fetchTaggedLogs":{"times":[275.10164599999916]},"loadCapsule":{"times":[0.8977130000021134,0.3812629999993078,0.23167400000238558]},"validateEnqueuedNotesAndEvents":{"times":[4.040639999999257]},"storeInExecutionCache":{"times":[0.20383199999923818]},"callPrivateFunction":{"times":[1137.3586649999997]},"notifyCreatedNullifier":{"times":[0.4187449999990349]}}},{"functionName":"private_kernel_inner","time":187.41155300000173},{"functionName":"StatefulTest:create_note_no_init_check","time":983.8321810000016,"oracles":{"debugLog":{"times":[1.0583630000000994,0.7415540000001783]},"fetchTaggedLogs":{"times":[227.77030699999887]},"loadCapsule":{"times":[0.9651469999989786,0.36245100000087405,0.36162100000001374]},"validateEnqueuedNotesAndEvents":{"times":[4.712970000000496]},"getRandomField":{"times":[0.3521309999996447,0.3303799999994226,0.2758659999999509,0.08278499999869382,0.06315299999914714,0.06906399999934365,0.06386399999973946,0.05905400000119698,0.07241400000202702,0.08749499999976251,0.06264300000111689,0.07443399999829126]},"notifyCreatedNote":{"times":[0.5988859999997658]},"getIndexedTaggingSecretAsSender":{"times":[105.80187099999966]},"incrementAppTaggingSecretIndexAsSender":{"times":[144.25106199999937]}}},{"functionName":"private_kernel_inner","time":201.1716320000014},{"functionName":"private_kernel_reset","time":329.5958720000017},{"functionName":"private_kernel_tail","time":177.94908900000155}],"unaccounted":1345.3195439999909}} 22:47:18 [22:47:18.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:18 [22:47:18.862] VERBOSE: sequencer Not enough txs to build block 2 at slot 67 (got 0 txs, need 1) {"chainTipArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blockNumber":2,"slot":67} 22:47:18 [22:47:18.873] VERBOSE: p2p:tx_pool Adding tx 0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c to pool {"eventName":"tx-added-to-pool","txHash":"0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 22:47:18 [22:47:18.881] INFO: node Received tx 0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c {"txHash":"0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c"} 22:47:18 [22:47:18.882] INFO: pxe:service Sent transaction 0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c 22:47:19 [22:47:19.039] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:19 [22:47:19.139] VERBOSE: sequencer:block-builder Building block 2 for slot 67 {"slot":67,"slotStart":"2025-06-04T23:30:51.000Z","now":"2025-06-04T23:30:55.986Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x2b0850a4e7ff148a55b27ce003d2713401b9f3bd4484d4d53c1aeecd5ca27126"},{"classId":"0x1d67ec95e53a19062e838f31a622b933858e54ae8efe1aa2572dd7692691c9b0"}]}} 22:47:19 [22:47:19.186] VERBOSE: simulator:public-processor Processed tx 0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c with no public calls in 31.088572000000568ms {"txHash":"0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c","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":31.088572000000568} 22:47:19 [22:47:19.189] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04611628700000074s {"duration":0.04611628700000074,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 22:47:19 [22:47:19.298] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:19 [22:47:19.333] INFO: sequencer Built block 2 for slot 67 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0747bf0d42782b06ce0f5f8e1713c31f013cd11fb9c725b29adf376060638bcf","globalVariables":{"chainId":31337,"version":2085183025,"blockNumber":2,"slotNumber":67,"timestamp":1749079851,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x156f2c77778ff16c2cd29dfabf40bdf71a4eb3d3898e3159339bc11d6a7c140c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":201.71133499999996,"publicProcessDuration":46.96419700000115,"rollupCircuitsDuration":195.1843459999982,"txCount":1,"blockNumber":2,"blockTimestamp":1749079851,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:19 [22:47:19.340] VERBOSE: sequencer Attesting committee is empty 22:47:19 [22:47:19.541] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:19 [22:47:19.724] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x95d3c83dc5e4d55266d07844323de170012328514276d65f421ac51ade635c27 22:47:19 [22:47:19.724] VERBOSE: node Sent L1 transaction 0x95d3c83dc5e4d55266d07844323de170012328514276d65f421ac51ade635c27 {"gasLimit":565458,"maxFeePerGas":"1.273011836","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 22:47:19 [22:47:19.757] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:19 [22:47:19.775] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:19 [22:47:19.776] WARN: foundation:test-date-provider Time set to 2025-06-04T23:31:03.000Z {"offset":2623224,"timeMs":1749079863000} 22:47:19 [22:47:19.777] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 22:47:19 [22:47:19.789] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:47:19 [22:47:19.790] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x95d3c83dc5e4d55266d07844323de170012328514276d65f421ac51ade635c27","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1749079851,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:19 [22:47:19.791] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 22:47:19 [22:47:19.796] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 22:47:19 [22:47:19.812] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 22:47:19 [22:47:19.823] INFO: blob-sink:server Received blob sidecar for block 0xa8225edf95ef8149e7b9722f4f687cf9d186eed2c7544a402355ef8b7916dd6f 22:47:19 [22:47:19.836] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749079887] on http://127.0.0.1:8545 22:47:19 [22:47:19.841] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa8225edf95ef8149e7b9722f4f687cf9d186eed2c7544a402355ef8b7916dd6f 22:47:19 [22:47:19.844] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 22:47:19 [22:47:19.850] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749079887 22:47:19 [22:47:19.851] WARN: foundation:test-date-provider Time set to 2025-06-04T23:31:27.000Z {"offset":2647150,"timeMs":1749079887000} 22:47:19 [22:47:19.851] INFO: aztecjs:utils:watcher Slot 67 was filled, jumped to next slot 22:47:19 [22:47:19.856] WARN: archiver:prover-node Failed to reach L2 block 2 at 26 (latest is 1). Rolling back last synched L1 block number to 24. {"latestLocalL2BlockNumber":1,"latestLocalL2BlockArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","blocksSynchedTo":24,"currentL1BlockNumber":26,"provenBlockNumber":1,"provenArchive":"0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638","pendingBlockNumber":2,"pendingArchive":"0x0473f30c98d5b9aa4bbf7f1b145fff3aa3b9b3c9541a7e060ca82b82a01210bf"} 22:47:19 [22:47:19.977] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:20 [22:47:20.054] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x0473f30c98d5b9aa4bbf7f1b145fff3aa3b9b3c9541a7e060ca82b82a01210bf, 0x011d6dd83d0991ef1a88ad476dfd0c01629ac7b09a22559290f35e272e1d6638) 22:47:20 [22:47:20.207] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:20 [22:47:20.230] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0747bf0d42782b06ce0f5f8e1713c31f013cd11fb9c725b29adf376060638bcf","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2085183025,"blockNumber":2,"slotNumber":67,"timestamp":1749079851,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0473f30c98d5b9aa4bbf7f1b145fff3aa3b9b3c9541a7e060ca82b82a01210bf","archiveNextLeafIndex":3} 22:47:20 [22:47:20.234] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 22:47:20 [22:47:20.372] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x0747bf0d42782b06ce0f5f8e1713c31f013cd11fb9c725b29adf376060638bcf","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2085183025,"blockNumber":2,"slotNumber":67,"timestamp":1749079851,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0473f30c98d5b9aa4bbf7f1b145fff3aa3b9b3c9541a7e060ca82b82a01210bf","archiveNextLeafIndex":3} 22:47:20 [22:47:20.385] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 22:47:20 [22:47:20.417] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:20 [22:47:20.446] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.491878000000725,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749079851,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:20 [22:47:20.448] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.9514479999998,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749079851,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:20 [22:47:20.471] VERBOSE: p2p Synched to latest block 2 22:47:20 [22:47:20.576] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0473f30c98d5b9aa4bbf7f1b145fff3aa3b9b3c9541a7e060ca82b82a01210bf","blockNumber":3,"slot":68} 22:47:20 [22:47:20.622] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:20 [22:47:20.806] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0473f30c98d5b9aa4bbf7f1b145fff3aa3b9b3c9541a7e060ca82b82a01210bf","blockNumber":3,"slot":68} 22:47:20 [22:47:20.826] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:20 [22:47:20.844] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 22:47:20 [22:47:20.845] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 22:47:20 [22:47:20.847] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 22:47:20 [22:47:20.847] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 22:47:21 [22:47:21.044] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:21 [22:47:21.092] VERBOSE: sequencer Not enough txs to build block 3 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x0473f30c98d5b9aa4bbf7f1b145fff3aa3b9b3c9541a7e060ca82b82a01210bf","blockNumber":3,"slot":68} 22:47:21 [22:47:21.102] INFO: node Stopping 22:47:21 [22:47:21.105] INFO: slasher Slasher client stopped. 22:47:21 [22:47:21.106] INFO: sequencer Stopped sequencer 22:47:21 [22:47:21.108] INFO: p2p P2P client stopped. 22:47:21 [22:47:21.114] INFO: world_state Stopped world state synchronizer 22:47:21 [22:47:21.114] INFO: archiver Stopped. 22:47:21 [22:47:21.115] INFO: node Stopped 22:47:21 [22:47:21.115] INFO: prover-node:prover-node Stopping ProverNode 22:47:21 [22:47:21.115] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 22:47:21 [22:47:21.116] INFO: archiver:prover-node Stopped. 22:47:21 [22:47:21.119] INFO: world_state:prover-node Stopped world state synchronizer 22:47:21 [22:47:21.119] INFO: prover-node:prover-node Stopped ProverNode 22:47:21 [22:47:21.120] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 22:47:21 [22:47:21.120] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/a0363cb8 22:47:21 [22:47:21.122] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 22:47:21 [22:47:21.144] INFO: blob-sink:server Stopping blob sink 22:47:21 [22:47:21.145] INFO: blob-sink:server Blob sink stopped 22:47:21 [22:47:21.146] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/e58209948bf11e3c 22:47:21 [22:47:21.169] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should attest ONLY with the correct validator keys 22:47:21 [22:47:21.482] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 22:47:21 [22:47:21.540] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-Pt4Wzy/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 22:47:21 [22:47:21.580] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 22:47:21 [22:47:21.585] WARN: e2e:e2e_multi_validator_node Set block interval to 12 22:47:21 [22:47:21.585] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 22:47:21 [22:47:21.614] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 22:47:21 [22:47:21.624] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 22:47:21 [22:47:21.659] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 22:47:21 [22:47:21.690] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 22:47:21 [22:47:21.727] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 22:47:21 [22:47:21.735] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 22:47:21 [22:47:21.760] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 22:47:21 [22:47:21.766] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 22:47:21 [22:47:21.796] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 22:47:21 [22:47:21.813] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 22:47:21 [22:47:21.849] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 22:47:21 [22:47:21.859] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 22:47:21 [22:47:21.886] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 22:47:21 [22:47:21.886] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 22:47:21 [22:47:21.908] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 22:47:21 [22:47:21.914] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 22:47:21 [22:47:21.915] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 22:47:21 [22:47:21.915] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 22:47:21 [22:47:21.938] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:21 [22:47:21.964] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 22:47:21 [22:47:21.964] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 22:47:22 [22:47:22.006] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 22:47:22 [22:47:22.033] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 22:47:22 [22:47:22.041] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 22:47:22 [22:47:22.060] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 22:47:22 [22:47:22.061] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 22:47:22 [22:47:22.076] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 22:47:22 [22:47:22.081] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 22:47:22 [22:47:22.095] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 22:47:22 [22:47:22.096] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 22:47:22 [22:47:22.096] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 22:47:22 [22:47:22.096] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 22:47:22 [22:47:22.125] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:22 [22:47:22.147] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 22:47:22 [22:47:22.172] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 22:47:22 [22:47:22.173] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 22:47:22 [22:47:22.178] 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} 22:47:22 [22:47:22.196] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 22:47:22 [22:47:22.234] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 22:47:22 [22:47:22.244] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 22:47:22 [22:47:22.291] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2af9b4f913e579761d23cf7f877d663c7c1ee06c794838e4797a5b73057d8518 {"gasLimit":10716781,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 22:47:22 [22:47:22.298] 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} 22:47:22 [22:47:22.299] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 22:47:22 [22:47:22.329] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:22 [22:47:22.330] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 22:47:22 [22:47:22.346] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 22:47:22 [22:47:22.347] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 22:47:22 [22:47:22.373] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xa8897c0adb59c20b46f23cd39fab84926417a78cc6c803792273c45350f8ad09 {"gasLimit":1040116,"maxFeePerGas":"38.520398432","maxPriorityFeePerGas":"38.337599913"} 22:47:22 [22:47:22.386] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 22:47:22 [22:47:22.419] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 {"gasLimit":116846,"maxFeePerGas":"46.165150248","maxPriorityFeePerGas":"46.005119895"} 22:47:22 [22:47:22.421] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x7bc3134cb4f006cb0eba3309cde2b12b5fc725d64f94cb000683899c40dc2c49 22:47:22 [22:47:22.445] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf {"gasLimit":109478,"maxFeePerGas":"55.347326337","maxPriorityFeePerGas":"55.206143874"} 22:47:22 [22:47:22.446] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x388f02bfd5668c6cfde7e35cf05ecf7fe659d4f8c1be0f621681b4b668e000cf 22:47:22 [22:47:22.476] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf67b1f1a8fadaaa657e2704a0cdb495263f20eedc959e0027719f7c285a36fdb {"gasLimit":362859,"maxFeePerGas":"66.371021863","maxPriorityFeePerGas":"66.247372648"} 22:47:22 [22:47:22.505] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4627582215b058d08ad1d7108f731ce7fa174636ff2ec947460a13f0ae86eb97 {"gasLimit":84823,"maxFeePerGas":"79.605134246","maxPriorityFeePerGas":"79.496847177"} 22:47:22 [22:47:22.580] INFO: e2e:e2e_multi_validator_node Initialized validator set {"validators":[{"attester":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","withdrawer":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","privateKey":"0xac0974bec39a17e36ba4a6b4d238ff944bacb478cbed5efcae784d7bf4f2ff80"},{"attester":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","withdrawer":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","privateKey":"0x59c6995e998f97a5a0044966f0945389dc9e86dae88c7a8412f4603b6b78690d"},{"attester":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","withdrawer":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","privateKey":"0x5de4111afa1a4b94908f83103eb1f1706367c2e68ca870fc3fb9a804cdab365a"},{"attester":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","withdrawer":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","privateKey":"0x7c852118294e51e653712a81e05800f419141751be58f605c371e15141b007a6"},{"attester":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","withdrawer":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","privateKey":"0x47e179ec197488593b187f80a00eb0da91f1b9d0b13f8733639f19c30a34926a"}],"txHash":"0x4e4ec8f9b1f0e9e09d869af02a453d313ad0901dd3dce5bfcb39fd47d053dbc2"} 22:47:22 [22:47:22.581] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 22:47:22 [22:47:22.640] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:22 [22:47:22.655] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 22:47:22 [22:47:22.655] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 22:47:22 [22:47:22.656] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 22:47:22 [22:47:22.693] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 22:47:22 [22:47:22.693] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 22:47:22 [22:47:22.725] 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"} 22:47:22 [22:47:22.726] INFO: e2e:e2e_multi_validator_node Handing over to governance 22:47:22 [22:47:22.733] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 22:47:22 [22:47:22.735] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:22 [22:47:22.735] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 22:47:22 [22:47:22.739] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/0151b2e2e9dbb4e1/blob-sink with map size 134217728 KB (LMDB v2) 22:47:22 [22:47:22.740] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:22 [22:47:22.740] WARN: foundation:test-date-provider Time set to 2025-06-04T22:52:21.000Z {"offset":298260,"timeMs":1749077541000} 22:47:22 [22:47:22.746] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 22:47:22 [22:47:22.752] INFO: blob-sink:server Server is running on http://localhost:37955 22:47:22 [22:47:22.753] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 22:47:22 [22:47:22.753] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/7e150b3a/acvm 22:47:22 [22:47:22.754] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:37955"} 22:47:22 [22:47:22.774] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 22:47:22 [22:47:22.775] INFO: archiver:lmdb Creating archiver data store at directory /tmp/0151b2e2e9dbb4e1/archiver with map size 134217728 KB (LMDB v2) 22:47:22 [22:47:22.777] INFO: archiver:lmdb Starting data store with maxReaders 16 22:47:22 [22:47:22.967] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:23 [22:47:23.080] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:37955"} 22:47:23 [22:47:23.085] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:37955"} 22:47:23 [22:47:23.086] WARN: node:blob-sink:client No L1 consensus host urls configured 22:47:23 [22:47:23.086] WARN: node:blob-sink:client No archive client configured 22:47:23 [22:47:23.088] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 25 with hash 0xa811851031b6fcef3b1b9a2d87d19844c3e9e2a89bfd35c96d75a1aeeee40077 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xadf4df2b168adf2ecb7e7e089bcc9809afafb834be91f5b7dfbbe9711d8ddaed","l1BlockNumber":18}} 22:47:23 [22:47:23.099] INFO: archiver Initial archiver sync to L1 block 25 complete. {"l1BlockNumber":25,"syncPoint":{"blocksSynchedTo":25,"messagesSynchedTo":{"l1BlockHash":"0xa811851031b6fcef3b1b9a2d87d19844c3e9e2a89bfd35c96d75a1aeeee40077","l1BlockNumber":25}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 22:47:23 [22:47:23.108] INFO: world-state:database Creating world state data store at directory /tmp/0151b2e2e9dbb4e1/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 22:47:23 [22:47:23.156] INFO: world_state Created world state synchroniser with block history of 64 22:47:23 [22:47:23.156] WARN: node Aztec node is accepting fake proofs 22:47:23 [22:47:23.168] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/0151b2e2e9dbb4e1/p2p with map size 134217728 KB (LMDB v2) 22:47:23 [22:47:23.170] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:23 [22:47:23.174] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 22:47:23 [22:47:23.177] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/0151b2e2e9dbb4e1/p2p-archive with map size 134217728 KB (LMDB v2) 22:47:23 [22:47:23.181] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 22:47:23 [22:47:23.184] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/0151b2e2e9dbb4e1/p2p-peers with map size 134217728 KB (LMDB v2) 22:47:23 [22:47:23.185] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 22:47:23 [22:47:23.187] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 22:47:23 [22:47:23.188] VERBOSE: p2p P2P is disabled. Using dummy P2P service 22:47:23 [22:47:23.189] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 22:47:23 [22:47:23.190] INFO: world_state Started world state synchronizer from block 1 22:47:23 [22:47:23.192] VERBOSE: world-state:block_stream Starting sync from block number 0 22:47:23 [22:47:23.200] INFO: p2p Starting p2p client from block 0 with empty mempools 22:47:23 [22:47:23.201] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 22:47:23 [22:47:23.201] INFO: epoch-prune-watcher EpochPruneWatcher initialized 22:47:23 [22:47:23.205] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 22:47:23 [22:47:23.206] INFO: slasher Starting Slasher client... 22:47:23 [22:47:23.211] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 22:47:23 [22:47:23.212] VERBOSE: node All Aztec Node subsystems synced 22:47:23 [22:47:23.216] INFO: sequencer-client Deploying forwarder contract 22:47:23 [22:47:23.235] VERBOSE: sequencer-client Sent L1 transaction 0x73b8a88fe86e88bd3176c01e809308cfc403d0da0dad9e2bb353a1e7ea55f50a {"gasLimit":323704,"maxFeePerGas":"95.479418634","maxPriorityFeePerGas":"95.396216612"} 22:47:23 [22:47:23.235] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x73b8a88fe86e88bd3176c01e809308cfc403d0da0dad9e2bb353a1e7ea55f50a. 22:47:23 [22:47:23.241] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 22:47:23 [22:47:23.247] INFO: validator Started validator with addresses: 22:47:23 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 22:47:23 [22:47:23.248] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 22:47:23 [22:47:23.248] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/7e150b3a/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 22:47:23 [22:47:23.249] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 22:47:23 [22:47:23.249] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 22:47:23 [22:47:23.250] INFO: node Aztec Node version: 0.87.6 22:47:23 [22:47:23.250] 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"} 22:47:23 [22:47:23.251] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 22:47:23 [22:47:23.277] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:37955"} 22:47:23 [22:47:23.281] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/0151b2e2e9dbb4e1/6501b990e13199c2/archiver with map size 134217728 KB (LMDB v2) 22:47:23 [22:47:23.285] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":2} 22:47:23 [22:47:23.287] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 22:47:23 [22:47:23.408] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:23 [22:47:23.419] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:23 [22:47:23.419] WARN: foundation:test-date-provider Time set to 2025-06-04T22:52:33.000Z {"offset":309581,"timeMs":1749077553000} 22:47:23 [22:47:23.563] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:23 [22:47:23.622] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:23 [22:47:23.684] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:37955"} 22:47:23 [22:47:23.686] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:37955"} 22:47:23 [22:47:23.686] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 22:47:23 [22:47:23.687] WARN: blob-sink:client:prover-node No archive client configured 22:47:23 [22:47:23.688] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 26 with hash 0x8c38dd4ec2ba555441a68f72092b10bd6ea25cfc81f5d91b6c3f711b7b6ed0f7 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xadf4df2b168adf2ecb7e7e089bcc9809afafb834be91f5b7dfbbe9711d8ddaed","l1BlockNumber":18}} 22:47:23 [22:47:23.715] INFO: archiver:prover-node Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26,"messagesSynchedTo":{"l1BlockHash":"0x8c38dd4ec2ba555441a68f72092b10bd6ea25cfc81f5d91b6c3f711b7b6ed0f7","l1BlockNumber":26}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 22:47:23 [22:47:23.717] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:37955"} 22:47:23 [22:47:23.718] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 22:47:23 [22:47:23.719] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 22:47:23 [22:47:23.728] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/0151b2e2e9dbb4e1/6501b990e13199c2/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 22:47:23 [22:47:23.767] INFO: world_state:prover-node Created world state synchroniser with block history of 64 22:47:23 [22:47:23.769] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 22:47:23 [22:47:23.769] INFO: world_state:prover-node Started world state synchronizer from block 1 22:47:23 [22:47:23.772] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 22:47:23 [22:47:23.772] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/0151b2e2e9dbb4e1/6501b990e13199c2/archiver when loading epoch databases, ignoring 22:47:23 [22:47:23.772] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/0151b2e2e9dbb4e1/6501b990e13199c2/world_state when loading epoch databases, ignoring 22:47:23 [22:47:23.773] INFO: prover-client:proving-broker:prover-node Proving Broker started 22:47:23 [22:47:23.784] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 22:47:23 [22:47:23.784] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 22:47:23 [22:47:23.785] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 22:47:23 [22:47:23.786] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:23 [22:47:23.787] 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/0151b2e2e9dbb4e1/6501b990e13199c2","l1ChainId":31337,"rollupVersion":2620374900} 22:47:23 [22:47:23.788] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 22:47:23 [22:47:23.789] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/9e7dfccce882984a/pxe_data with map size 134217728 KB (LMDB v2) 22:47:23 [22:47:23.791] INFO: pxe:data:lmdb Starting data store with maxReaders 16 22:47:23 [22:47:23.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:24 [22:47:24.185] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:24 [22:47:24.188] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 22:47:24 [22:47:24.189] INFO: pxe:service Started PXE connected to chain 31337 version 2620374900 22:47:24 [22:47:24.237] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:24 [22:47:24.253] INFO: pxe:service Registered account 0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1 22:47:24 [22:47:24.343] WARN: sequencer:block-builder Error closing forks for block processing {"generatedMessage":false,"code":"ERR_ASSERTION","actual":false,"expected":true,"operator":"=="} 22:47:24 [22:47:24.344] WARN: pxe:service No artifact found for contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b when looking for its metadata 22:47:24 [22:47:24.348] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b as part of deployment for 0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1 22:47:24 [22:47:24.409] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:24 [22:47:24.468] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:24 [22:47:24.522] INFO: pxe:service Added contract SchnorrAccount at 0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1 with class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b 22:47:24 [22:47:24.549] VERBOSE: pxe:block_stream Starting sync from block number 0 22:47:24 [22:47:24.583] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 22:47:24 [22:47:24.624] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:24 [22:47:24.684] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 22:47:25 [22:47:25.255] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b,0x1999a7be421b7ee05b82c7c5d724475a7895bb2f73fe84f7d5f029d017e45d08,0x0d7e7b1c04f61ee57629d3be4dc7b937efb93329c57da17d8b5151dd750d818b,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 22:47:25 [22:47:25.415] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 22:47:25 [22:47:25.483] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:25 [22:47:25.503] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:25 [22:47:25.626] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:25 [22:47:25.683] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:25 [22:47:25.683] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:25 [22:47:25.812] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:25 [22:47:25.837] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:25 [22:47:25.904] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:25 [22:47:25.910] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:26 [22:47:26.031] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:26 [22:47:26.058] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:26 [22:47:26.271] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:26 [22:47:26.378] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:26 [22:47:26.439] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:26 [22:47:26.440] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:26 [22:47:26.454] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:26 [22:47:26.536] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:26 [22:47:26.537] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:26 [22:47:26.547] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:26 [22:47:26.570] VERBOSE: simulator:client_execution_context:debug_log Setting 0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1 as fee payer 22:47:26 [22:47:26.678] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:26 [22:47:26.822] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:26 [22:47:26.989] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:27 [22:47:27.172] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:27 [22:47:27.332] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:27 [22:47:27.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:27 [22:47:27.636] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:28 [22:47:28.128] INFO: pxe:service Proving completed in 3582.0605829999986ms {"timings":{"total":3582.0605829999986,"sync":3.390954000002239,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":169.4840249999943,"oracles":{"callPrivateFunction":{"times":[875.1080689999981,740.8038980000019,363.7787639999988]}}},{"functionName":"private_kernel_init","time":119.42967500000304},{"functionName":"ContractClassRegisterer:register","time":853.1761360000019,"oracles":{"loadCapsule":{"times":[9.88094700000147]},"notifyCreatedNullifier":{"times":[0.7600559999991674]},"debugLog":{"times":[0.7671260000024631]},"notifyCreatedContractClassLog":{"times":[9.527385000001232]}}},{"functionName":"private_kernel_inner","time":159.7529969999996},{"functionName":"SchnorrAccount:constructor","time":701.8581690000028,"oracles":{"getContractInstance":{"times":[11.533505999999761]},"debugLog":{"times":[0.7537350000020524,0.7065929999989748]},"fetchTaggedLogs":{"times":[225.02438400000028]},"loadCapsule":{"times":[0.5597939999970549,0.5659740000010061,0.28699799999958486]},"validateEnqueuedNotesAndEvents":{"times":[3.728095000002213]},"notifyCreatedNullifier":{"times":[0.3208999999988009,0.51035100000081]},"notifyCreatedNote":{"times":[0.14075899999807007]},"getRandomField":{"times":[0.2235340000006545,0.23139399999854504,0.26678499999979977,0.08388599999670987,0.07138400000258116,0.07467499999984284,0.08932500000082655,0.07322500000009313,0.08213500000056229,0.06829400000060559,0.09575599999880069]},"getIndexedTaggingSecretAsSender":{"times":[192.43404799999917]},"incrementAppTaggingSecretIndexAsSender":{"times":[75.73955900000146]}}},{"functionName":"private_kernel_inner","time":136.36735599999884},{"functionName":"SchnorrAccount:entrypoint","time":304.6756089999981,"oracles":{"debugLog":{"times":[0.5933149999982561,1.1563089999981457,1.0645640000002459]},"fetchTaggedLogs":{"times":[104.74876900000163]},"loadCapsule":{"times":[0.5736649999998917,0.30641800000012154,0.5550530000000435]},"validateEnqueuedNotesAndEvents":{"times":[2.21580399999948]},"getNotes":{"times":[1.2439049999993586]},"getAuthWitness":{"times":[0.3605620000016643]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8476110000010522]}}},{"functionName":"private_kernel_inner","time":141.58893199999875},{"functionName":"private_kernel_reset","time":238.619794000002},{"functionName":"private_kernel_tail","time":103.24041800000123}],"unaccounted":650.4765179999958}} 22:47:28 [22:47:28.149] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:28 [22:47:28.253] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","blockNumber":1,"slot":3} 22:47:28 [22:47:28.265] VERBOSE: p2p:tx_pool Adding tx 0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6 to pool {"eventName":"tx-added-to-pool","txHash":"0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 22:47:28 [22:47:28.290] INFO: node Received tx 0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6 {"txHash":"0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6"} 22:47:28 [22:47:28.291] INFO: pxe:service Sent transaction 0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6 22:47:28 [22:47:28.360] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:28 [22:47:28.480] VERBOSE: sequencer:block-builder Building block 1 for slot 3 {"slot":3,"slotStart":"2025-06-04T22:52:45.000Z","now":"2025-06-04T22:52:38.061Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x2b0850a4e7ff148a55b27ce003d2713401b9f3bd4484d4d53c1aeecd5ca27126"},{"classId":"0x1d67ec95e53a19062e838f31a622b933858e54ae8efe1aa2572dd7692691c9b0"}]}} 22:47:28 [22:47:28.528] VERBOSE: simulator:public-processor Processed tx 0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6 with no public calls in 21.58255199999985ms {"txHash":"0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6","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":21.58255199999985} 22:47:28 [22:47:28.529] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04656391900000017s {"duration":0.04656391900000017,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 22:47:28 [22:47:28.648] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:28 [22:47:28.664] INFO: sequencer Built block 1 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x222cfdfce5737ee3d27d8fd2cae8f7fef877388a407292dfae1e9017a9248d7d","globalVariables":{"chainId":31337,"version":2620374900,"blockNumber":1,"slotNumber":3,"timestamp":1749077565,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x00f1bbece1756b47ca587cf8650ae7f79d7bdadd8fd7590f78b0a6b7f4245ab6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":190.2034530000019,"publicProcessDuration":47.08513099999982,"rollupCircuitsDuration":183.75192400000378,"txCount":1,"blockNumber":1,"blockTimestamp":1749077565,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:28 [22:47:28.666] VERBOSE: sequencer Attesting committee is empty 22:47:28 [22:47:28.855] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:29 [22:47:29.065] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:29 [22:47:29.073] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x028a4313d96849cfa889acbd32cd7cf5f10938b198ce7389560835a31a91fbf7 22:47:29 [22:47:29.073] VERBOSE: node Sent L1 transaction 0x028a4313d96849cfa889acbd32cd7cf5f10938b198ce7389560835a31a91fbf7 {"gasLimit":555026,"maxFeePerGas":"114.549196538","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 22:47:29 [22:47:29.086] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 22:47:29 [22:47:29.091] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 22:47:29 [22:47:29.097] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 22:47:29 [22:47:29.101] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:47:29 [22:47:29.102] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x028a4313d96849cfa889acbd32cd7cf5f10938b198ce7389560835a31a91fbf7","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1749077565,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:29 [22:47:29.103] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 22:47:29 [22:47:29.124] INFO: blob-sink:server Received blob sidecar for block 0xb5824256a3f5475921ee267d2af5f468ab5a1f86ff741c148b11822d8958d6f3 22:47:29 [22:47:29.135] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb5824256a3f5475921ee267d2af5f468ab5a1f86ff741c148b11822d8958d6f3 22:47:29 [22:47:29.277] VERBOSE: archiver:block-helper:prover-node Store contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b 22:47:29 [22:47:29.279] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:29 [22:47:29.296] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:29 [22:47:29.297] WARN: foundation:test-date-provider Time set to 2025-06-04T22:52:45.000Z {"offset":315703,"timeMs":1749077565000} 22:47:29 [22:47:29.300] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x222cfdfce5737ee3d27d8fd2cae8f7fef877388a407292dfae1e9017a9248d7d","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2620374900,"blockNumber":1,"slotNumber":3,"timestamp":1749077565,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","archiveNextLeafIndex":2} 22:47:29 [22:47:29.433] VERBOSE: archiver:block-helper Store contract class 0x02808784720b1df9faad6776e30aa121b5b5d25cf148050ded9f87ab4f0c221b 22:47:29 [22:47:29.451] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749077601] on http://127.0.0.1:8545 22:47:29 [22:47:29.455] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 22:47:29 [22:47:29.457] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x222cfdfce5737ee3d27d8fd2cae8f7fef877388a407292dfae1e9017a9248d7d","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2620374900,"blockNumber":1,"slotNumber":3,"timestamp":1749077565,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","archiveNextLeafIndex":2} 22:47:29 [22:47:29.458] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 22:47:29 [22:47:29.467] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749077601 22:47:29 [22:47:29.468] WARN: foundation:test-date-provider Time set to 2025-06-04T22:53:21.000Z {"offset":351532,"timeMs":1749077601000} 22:47:29 [22:47:29.468] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 22:47:29 [22:47:29.480] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd, 0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3) 22:47:29 [22:47:29.484] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 22:47:29 [22:47:29.499] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:29 [22:47:29.503] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":9.45064999999886,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749077565,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:29 [22:47:29.508] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.532274000004691,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749077565,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:47:29 [22:47:29.535] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 22:47:29 [22:47:29.536] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 22:47:29 [22:47:29.541] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 22:47:29 [22:47:29.541] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 22:47:29 [22:47:29.562] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749079905] on http://127.0.0.1:8545 22:47:29 [22:47:29.564] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 22:47:29 [22:47:29.567] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749079905 22:47:29 [22:47:29.607] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749082209] on http://127.0.0.1:8545 22:47:29 [22:47:29.611] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 22:47:29 [22:47:29.615] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749082209 22:47:29 [22:47:29.620] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1 22:47:30 [22:47:30.075] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:30 [22:47:30.086] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:47:30 [22:47:30.087] WARN: foundation:test-date-provider Time set to 2025-06-05T00:10:09.000Z {"offset":4958913,"timeMs":1749082209000} 22:47:30 [22:47:30.103] INFO: pxe:service Added contract StatefulTest at 0x0adb7d4081d62521ade39a9ffa84fb0de047911b72a654e053096377152a7a15 with class 0x1fcd82d187cb5ed9f7030e5163de20b38d8dbae55363038635e57abd6d41a817 22:47:30 [22:47:30.176] VERBOSE: p2p Synched to latest block 1 22:47:30 [22:47:30.199] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","header":{"contentCommitment":{"blobsHash":"0x004a0d69018194be56adfb3c487f709f85e1a65ea53abedfd24c7d7c5b024bc4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749077565,"version":2620374900},"lastArchive":"0x0ce02f4a1131aed34cb37f200234c940ad2dc72a248065ff8763e512d17d7cd3","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1ab311e71fd6fd26625f442b0216c4fff0496ea1b77c50e591aedcd9cf8dee2c","nullifierTree":"0x26d053a1b2535014f5866cca0fe2308c292cdb1816f1c85ebbe5e479ee3552aa","publicDataTree":"0x14a93eb74674063857a2f319f5b28cf1bc69ecbfbae6e2f31aa70fdba42a5fe2"},"totalFees":2101212240,"totalManaUsed":6324}} 22:47:30 [22:47:30.318] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:30 [22:47:30.355] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:30 [22:47:30.407] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:30 [22:47:30.408] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:30 [22:47:30.506] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:30 [22:47:30.530] INFO: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 is on the validator committee for epoch 4 22:47:30 [22:47:30.530] INFO: validator Validator 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 is on the validator committee for epoch 4 22:47:30 [22:47:30.530] INFO: validator Validator 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc is on the validator committee for epoch 4 22:47:30 [22:47:30.543] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1"} 22:47:30 [22:47:30.547] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1fb38e67489422c12725fd8677a08e947d271daf80fb426fd7900659796ec297 22:47:30 [22:47:30.556] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 22:47:30 [22:47:30.557] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 22:47:30 [22:47:30.564] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 22:47:30 [22:47:30.565] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 22:47:30 [22:47:30.567] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:30 [22:47:30.572] VERBOSE: pxe:service Added note {"index":0,"contract":"0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x20711c719dc78d480968911e48839973101fe42073ceb1cf126fa7337a0f5e5d","nullifier":"0x24a49f50d08fea5b57d11a3b0e0c51e4e50c0f20c9ca36c0d5efd0b0f99cac7f"} 22:47:30 [22:47:30.586] VERBOSE: simulator:client_execution_context:debug_log Setting 0x185bce6edfcb6dc59a3464b7d701f8a8d94ff105a24eb85e4cf61096d5532fa1 as fee payer 22:47:30 [22:47:30.663] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:30 [22:47:30.814] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x0adb7d4081d62521ade39a9ffa84fb0de047911b72a654e053096377152a7a15"} 22:47:30 [22:47:30.841] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:30 [22:47:30.841] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0adb7d4081d62521ade39a9ffa84fb0de047911b72a654e053096377152a7a15"} 22:47:30 [22:47:30.861] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:30 [22:47:30.935] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:30 [22:47:30.975] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0adb7d4081d62521ade39a9ffa84fb0de047911b72a654e053096377152a7a15"} 22:47:30 [22:47:30.980] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:31 [22:47:31.205] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x0adb7d4081d62521ade39a9ffa84fb0de047911b72a654e053096377152a7a15"} 22:47:31 [22:47:31.257] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 22:47:31 [22:47:31.258] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0adb7d4081d62521ade39a9ffa84fb0de047911b72a654e053096377152a7a15"} 22:47:31 [22:47:31.260] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:31 [22:47:31.377] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:31 [22:47:31.498] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:31 [22:47:31.594] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0adb7d4081d62521ade39a9ffa84fb0de047911b72a654e053096377152a7a15"} 22:47:31 [22:47:31.631] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 22:47:31 [22:47:31.634] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:31 [22:47:31.714] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:31 [22:47:31.936] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:32 [22:47:32.034] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:32 [22:47:32.248] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:32 [22:47:32.291] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:32 [22:47:32.514] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:32 [22:47:32.864] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:32 [22:47:32.879] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:33 [22:47:33.093] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:33 [22:47:33.313] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:33 [22:47:33.341] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:33 [22:47:33.878] INFO: pxe:service Proving completed in 3709.153818999999ms {"timings":{"total":3709.153818999999,"sync":32.86310200000298,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":443.23326800001087,"oracles":{"debugLog":{"times":[1.0073610000035842,0.3744619999997667,0.5239419999998063,0.8086489999986952,0.41799600000376813,0.3279099999999744,0.41205400000035297,0.7523250000012922]},"fetchTaggedLogs":{"times":[136.3699160000033]},"loadCapsule":{"times":[0.27039700000023004,0.1896409999972093,0.35900100000435486,0.30433899999479763,0.21393299999908777,0.22650399999838555,0.2806769999951939]},"getSharedSecret":{"times":[2.920116000001144]},"aes128Decrypt":{"times":[0.24175499999546446,0.8361900000018068]},"getPublicKeysAndPartialAddress":{"times":[1.9260269999940647]},"getKeyValidationRequest":{"times":[1.6380589999971562]},"storeCapsule":{"times":[0.3947439999974449,0.2947769999955199,0.28034699999989243]},"deleteCapsule":{"times":[0.34191099999588914]},"validateEnqueuedNotesAndEvents":{"times":[5.145070999999007]},"getNotes":{"times":[1.317799999997078]},"getAuthWitness":{"times":[0.28515700000571087]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09595599999738624]},"callPrivateFunction":{"times":[1479.596034999995]}}},{"functionName":"private_kernel_init","time":83.62115500000073},{"functionName":"StatefulTest:constructor","time":402.72758399999293,"oracles":{"getContractInstance":{"times":[9.208275999997568]},"debugLog":{"times":[0.5375819999972009,0.5262019999936456]},"fetchTaggedLogs":{"times":[136.71254700000281]},"loadCapsule":{"times":[0.31126899999799207,0.25678599999810103,0.29000799999630544]},"validateEnqueuedNotesAndEvents":{"times":[2.7514759999976377]},"storeInExecutionCache":{"times":[0.11652699999831384]},"callPrivateFunction":{"times":[1074.693779000001]},"notifyCreatedNullifier":{"times":[0.3365300000004936]}}},{"functionName":"private_kernel_inner","time":141.66088500000478},{"functionName":"StatefulTest:create_note_no_init_check","time":994.9019160000025,"oracles":{"debugLog":{"times":[0.7207839999973658,0.5710139999937383]},"fetchTaggedLogs":{"times":[366.435845]},"loadCapsule":{"times":[4.888794999998936,0.4095149999993737,1.836490000001504]},"validateEnqueuedNotesAndEvents":{"times":[58.24557300000015]},"getRandomField":{"times":[0.26205599999957485,0.18611199999577366,0.2512249999999767,0.09351500000047963,0.06277399999817135,0.06933399999979883,0.17442100000334904,0.07859499999904074,0.054683999995177146,0.06513400000403635,0.05234300000302028,0.060534000003826804]},"notifyCreatedNote":{"times":[0.25651499999366933]},"getIndexedTaggingSecretAsSender":{"times":[213.51512999999977]},"incrementAppTaggingSecretIndexAsSender":{"times":[114.51837800000067]}}},{"functionName":"private_kernel_inner","time":166.3970279999994},{"functionName":"private_kernel_reset","time":260.34120500000427},{"functionName":"private_kernel_tail","time":100.74202700000023}],"unaccounted":1082.6656489999805}} 22:47:33 [22:47:33.896] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:33 [22:47:33.954] VERBOSE: sequencer Not enough txs to build block 2 at slot 132 (got 0 txs, need 1) {"chainTipArchive":"0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd","blockNumber":2,"slot":132} 22:47:33 [22:47:33.959] VERBOSE: p2p:tx_pool Adding tx 0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93 to pool {"eventName":"tx-added-to-pool","txHash":"0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 22:47:33 [22:47:33.975] INFO: node Received tx 0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93 {"txHash":"0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93"} 22:47:33 [22:47:33.975] INFO: pxe:service Sent transaction 0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93 22:47:34 [22:47:34.109] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:34 [22:47:34.189] VERBOSE: sequencer:block-builder Building block 2 for slot 132 {"slot":132,"slotStart":"2025-06-05T00:10:09.000Z","now":"2025-06-05T00:10:13.102Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x2b0850a4e7ff148a55b27ce003d2713401b9f3bd4484d4d53c1aeecd5ca27126"},{"classId":"0x1d67ec95e53a19062e838f31a622b933858e54ae8efe1aa2572dd7692691c9b0"}]}} 22:47:34 [22:47:34.243] VERBOSE: simulator:public-processor Processed tx 0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93 with no public calls in 19.966413999994984ms {"txHash":"0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93","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":19.966413999994984} 22:47:34 [22:47:34.245] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05220696999999928s {"duration":0.05220696999999928,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 22:47:34 [22:47:34.332] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:34 [22:47:34.350] INFO: sequencer Built block 2 for slot 132 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1c2e2b6ac0642cfc3248fac768340381453941e4f2425c6fb31caf78184092ac","globalVariables":{"chainId":31337,"version":2620374900,"blockNumber":2,"slotNumber":132,"timestamp":1749082209,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x0aebda16009d88ecbc8f3f81a1adc2ba3e54e84c41e843848e899c1f85b18f93"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":170.55472900000314,"publicProcessDuration":52.944084000002476,"rollupCircuitsDuration":162.90107700000226,"txCount":1,"blockNumber":2,"blockTimestamp":1749082209,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:34 [22:47:34.360] VERBOSE: p2p Broadcasting proposal for slot 132 to peers 22:47:34 [22:47:34.375] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 {"signature":"0x8151975e07c78d33df41a0909237aa499ebf170e6a589410dc88227b73cc297702d33964ba8427b32419e9d5f50ad9f95e3cabd55f56239bbe86cc83b071f8561c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","proposalId":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad"} 22:47:34 [22:47:34.382] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 {"signature":"0xf9164626e9a5b6cb07e39ff1ea5576fb3fe1c05722cb8b7a88568c038e93a8c24a11798c326e74e5ed1896db2eea8837aaf43d91fb2e1655cb327c86bbfc84b61b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","proposalId":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad"} 22:47:34 [22:47:34.388] VERBOSE: p2p:attestation_pool Added attestation for slot 132 from 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc {"signature":"0x7d7d3007dbbdb86753b0bff67b047bab4338f61be591c80771157946be26a14330eb799d9a5f409c81a368a3a1b3260889b57bfbb1910aeea76cef5cd8af8ad41b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000084","address":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","proposalId":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad"} 22:47:34 [22:47:34.389] VERBOSE: validator Collected all 3 attestations for slot 132 22:47:34 [22:47:34.390] VERBOSE: sequencer Collected 3 attestations {"blockHash":"0x1c2e2b6ac0642cfc3248fac768340381453941e4f2425c6fb31caf78184092ac","blockNumber":2} 22:47:34 [22:47:34.541] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:34 [22:47:34.705] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x01aa217561b487ba0510ff951cdc04a11a1786b02e23d9c4968d1ab5db88935b 22:47:34 [22:47:34.705] VERBOSE: node Sent L1 transaction 0x01aa217561b487ba0510ff951cdc04a11a1786b02e23d9c4968d1ab5db88935b {"gasLimit":633260,"maxFeePerGas":"1.233593065","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 22:47:34 [22:47:34.723] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:47:34 [22:47:34.723] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x01aa217561b487ba0510ff951cdc04a11a1786b02e23d9c4968d1ab5db88935b","calldataSize":1828,"calldataGas":16876,"txCount":1,"blockNumber":2,"blockTimestamp":1749082209,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:34 [22:47:34.724] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 22:47:34 [22:47:34.731] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749082245] on http://127.0.0.1:8545 22:47:34 [22:47:34.734] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 22:47:34 [22:47:34.737] INFO: blob-sink:server Received blob sidecar for block 0x9551fd072ccf9f7dac56b268e2ba76279ca639fa05bbf9f462c2fc01af7cd68f 22:47:34 [22:47:34.741] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749082245 22:47:34 [22:47:34.742] WARN: foundation:test-date-provider Time set to 2025-06-05T00:10:45.000Z {"offset":4990259,"timeMs":1749082245000} 22:47:34 [22:47:34.742] INFO: aztecjs:utils:watcher Slot 132 was filled, jumped to next slot 22:47:34 [22:47:34.746] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:34 [22:47:34.747] INFO: blob-sink:server Blob sidecar stored successfully for block 0x9551fd072ccf9f7dac56b268e2ba76279ca639fa05bbf9f462c2fc01af7cd68f 22:47:34 [22:47:34.759] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 22:47:34 [22:47:34.762] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 22:47:34 [22:47:34.766] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 22:47:34 [22:47:34.998] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:35 [22:47:35.025] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x1c2e2b6ac0642cfc3248fac768340381453941e4f2425c6fb31caf78184092ac","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2620374900,"blockNumber":2,"slotNumber":132,"timestamp":1749082209,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad","archiveNextLeafIndex":3} 22:47:35 [22:47:35.042] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1c2e2b6ac0642cfc3248fac768340381453941e4f2425c6fb31caf78184092ac","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2620374900,"blockNumber":2,"slotNumber":132,"timestamp":1749082209,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad","archiveNextLeafIndex":3} 22:47:35 [22:47:35.044] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 22:47:35 [22:47:35.049] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 22:47:35 [22:47:35.056] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad, 0x02d7bf44782ae104e4452f09037c39bfd7d74cbabcca50e196fa8f75eefae6dd) 22:47:35 [22:47:35.210] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:35 [22:47:35.236] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.599028000004182,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749082209,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:35 [22:47:35.238] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":7.690592999999353,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749082209,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:47:35 [22:47:35.273] VERBOSE: p2p Synched to latest block 2 22:47:35 [22:47:35.412] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:35 [22:47:35.477] VERBOSE: sequencer Not enough txs to build block 3 at slot 133 (got 0 txs, need 1) {"chainTipArchive":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad","blockNumber":3,"slot":133} 22:47:35 [22:47:35.615] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:35 [22:47:35.688] VERBOSE: sequencer Not enough txs to build block 3 at slot 133 (got 0 txs, need 1) {"chainTipArchive":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad","blockNumber":3,"slot":133} 22:47:35 [22:47:35.818] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:35 [22:47:35.900] VERBOSE: sequencer Not enough txs to build block 3 at slot 133 (got 0 txs, need 1) {"chainTipArchive":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad","blockNumber":3,"slot":133} 22:47:36 [22:47:36.007] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 22:47:36 [22:47:36.008] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 22:47:36 [22:47:36.009] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 22:47:36 [22:47:36.010] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 22:47:36 [22:47:36.117] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 22:47:36 [22:47:36.169] VERBOSE: sequencer Not enough txs to build block 3 at slot 133 (got 0 txs, need 1) {"chainTipArchive":"0x0cb8760a313fd44cbcf5c023589256b3b015ad61a0fb21d368fb06fa2ff6e8ad","blockNumber":3,"slot":133} 22:47:36 [22:47:36.174] INFO: node Stopping 22:47:36 [22:47:36.175] INFO: slasher Slasher client stopped. 22:47:36 [22:47:36.176] INFO: sequencer Stopped sequencer 22:47:36 [22:47:36.176] INFO: p2p P2P client stopped. 22:47:36 [22:47:36.179] INFO: world_state Stopped world state synchronizer 22:47:36 [22:47:36.181] INFO: archiver Stopped. 22:47:36 [22:47:36.181] INFO: node Stopped 22:47:36 [22:47:36.181] INFO: prover-node:prover-node Stopping ProverNode 22:47:36 [22:47:36.181] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 22:47:36 [22:47:36.181] INFO: archiver:prover-node Stopped. 22:47:36 [22:47:36.183] INFO: world_state:prover-node Stopped world state synchronizer 22:47:36 [22:47:36.183] INFO: prover-node:prover-node Stopped ProverNode 22:47:36 [22:47:36.183] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 22:47:36 [22:47:36.183] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/7e150b3a 22:47:36 [22:47:36.184] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 22:47:36 [22:47:36.187] INFO: blob-sink:server Stopping blob sink 22:47:36 [22:47:36.187] INFO: blob-sink:server Blob sink stopped 22:47:36 [22:47:36.188] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/0151b2e2e9dbb4e1 22:47:36 FAIL src/e2e_multi_validator_node.test.ts 22:47:36 e2e_multi_validator_node 22:47:36 ✕ should build blocks & attest with multiple validator keys (18608 ms) 22:47:36 ✓ should attest ONLY with the correct validator keys (15025 ms) 22:47:36 22:47:36 ● e2e_multi_validator_node › should build blocks & attest with multiple validator keys 22:47:36 22:47:36 expect(received).toBeGreaterThanOrEqual(expected) 22:47:36 22:47:36 Expected: >= 4 22:47:36 Received: 0 22:47:36 22:47:36 130 | .map(a => new BlockAttestation(new Fr(block.block.number), payload, a.signature)); 22:47:36 131 | 22:47:36 > 132 | expect(attestations.length).toBeGreaterThanOrEqual(4); // Math.floor((5 * 2) / 3) + 1 22:47:36 | ^ 22:47:36 133 | 22:47:36 134 | const signers = attestations.map(att => att.getSender().toString()); 22:47:36 135 | 22:47:36 22:47:36 at Object.toBeGreaterThanOrEqual (e2e_multi_validator_node.test.ts:132:33) 22:47:36 22:47:36 Test Suites: 1 failed, 1 total 22:47:36 Tests: 1 failed, 1 passed, 2 total 22:47:36 Snapshots: 0 total 22:47:36 Time: 40.397 s 22:47:36 Ran all test suites matching /src\/e2e_multi_validator_node.test.ts/i. 22:47:36 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?