ACI ·

Parent Log: http://ci.aztec-labs.com/a5b67224fbbb0c47 Command: 4a9a70b3aa9ef563: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/7f1c5a6c83a6be0fb4209bc05fc2f886d4d1b6b4 Env: REF_NAME=gh-readonly-queue/next/pr-14738-273ea3ad258072bc0d4f2ce50347b2c83a55cdc7 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Wed Jun 4 15:55:49 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14738_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/0d13f39a62f4c76d 15:55:49 +++ id -u 15:55:49 +++ id -g 15:55:49 ++ 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'\''' 15:55:49 + cid=de4408ac494c8520553d56b8f40bc483e38e99696c8e3cc24864a790a723ccb7 15:55:49 + set +x 15:55:50 {"level":25,"time":1749052550316,"pid":12,"hostname":"de4408ac494c","module":"logger","msg":"Logger initialized with level verbose"} 15:55:57 [15:55:57.277] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should build blocks & attest with multiple validator keys 15:55:57 [15:55:57.839] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 15:55:58 [15:55:58.380] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-9YuiPG/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:55:58 [15:55:58.420] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 15:55:58 [15:55:58.446] WARN: e2e:e2e_multi_validator_node Set block interval to 12 15:55:58 [15:55:58.447] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:55:58 [15:55:58.501] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:55:58 [15:55:58.511] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:55:58 [15:55:58.534] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:55:58 [15:55:58.540] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:55:58 [15:55:58.563] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:55:58 [15:55:58.569] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:55:58 [15:55:58.587] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:55:58 [15:55:58.595] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:55:58 [15:55:58.626] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 15:55:58 [15:55:58.636] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:55:58 [15:55:58.670] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 15:55:58 [15:55:58.681] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:55:58 [15:55:58.706] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 15:55:58 [15:55:58.707] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 15:55:58 [15:55:58.736] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 15:55:58 [15:55:58.745] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 15:55:58 [15:55:58.745] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 15:55:58 [15:55:58.746] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 15:55:58 [15:55:58.781] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:55:58 [15:55:58.800] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 15:55:58 [15:55:58.801] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 15:55:58 [15:55:58.815] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 15:55:58 [15:55:58.836] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 15:55:58 [15:55:58.841] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:55:58 [15:55:58.879] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 15:55:58 [15:55:58.880] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 15:55:58 [15:55:58.914] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 15:55:58 [15:55:58.928] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 15:55:58 [15:55:58.950] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 15:55:58 [15:55:58.951] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 15:55:58 [15:55:58.951] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 15:55:58 [15:55:58.951] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 15:55:58 [15:55:58.973] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:55:58 [15:55:58.992] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 15:55:59 [15:55:59.013] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 15:55:59 [15:55:59.014] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 15:55:59 [15:55:59.017] 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} 15:55:59 [15:55:59.037] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 15:55:59 [15:55:59.083] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 15:55:59 [15:55:59.090] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 15:55:59 [15:55:59.138] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8650284d6e4c59f5c02de16f5a50a3abad5a2a3e39452273e073b26b65c3126c {"gasLimit":10716795,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 15:55:59 [15:55:59.146] 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} 15:55:59 [15:55:59.147] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 15:55:59 [15:55:59.181] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:55:59 [15:55:59.181] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 15:55:59 [15:55:59.199] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 15:55:59 [15:55:59.200] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 15:55:59 [15:55:59.215] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xd413488be28de232ee67a932daca30e5e7bc4e1ad751dedc3910bbbe185aafe4 {"gasLimit":1040116,"maxFeePerGas":"38.520398451","maxPriorityFeePerGas":"38.337599913"} 15:55:59 [15:55:59.220] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 15:55:59 [15:55:59.244] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec {"gasLimit":116846,"maxFeePerGas":"46.165150264","maxPriorityFeePerGas":"46.005119895"} 15:55:59 [15:55:59.245] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec 15:55:59 [15:55:59.258] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 {"gasLimit":109478,"maxFeePerGas":"55.34732635","maxPriorityFeePerGas":"55.206143874"} 15:55:59 [15:55:59.259] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 15:55:59 [15:55:59.280] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2baf4763aa17682af85263faf72b939a3b0de80fabfa567cc2614de37cb716e2 {"gasLimit":362859,"maxFeePerGas":"66.371021876","maxPriorityFeePerGas":"66.247372648"} 15:55:59 [15:55:59.299] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xa623e13db3bc03c6828b186ab37039f59d8527e19526127bc6b78030c6e5fea9 {"gasLimit":84823,"maxFeePerGas":"79.605134257","maxPriorityFeePerGas":"79.496847177"} 15:55:59 [15:55:59.361] INFO: e2e:e2e_multi_validator_node Initialized validator set {"validators":[{"attester":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","withdrawer":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","privateKey":"0xac0974bec39a17e36ba4a6b4d238ff944bacb478cbed5efcae784d7bf4f2ff80"},{"attester":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","withdrawer":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","privateKey":"0x59c6995e998f97a5a0044966f0945389dc9e86dae88c7a8412f4603b6b78690d"},{"attester":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","withdrawer":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","privateKey":"0x5de4111afa1a4b94908f83103eb1f1706367c2e68ca870fc3fb9a804cdab365a"},{"attester":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","withdrawer":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","privateKey":"0x7c852118294e51e653712a81e05800f419141751be58f605c371e15141b007a6"},{"attester":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","withdrawer":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","privateKey":"0x47e179ec197488593b187f80a00eb0da91f1b9d0b13f8733639f19c30a34926a"}],"txHash":"0xc005a872652e5180c06511d7b2c65be32bd9db61f5c8a251e60d728456eb4cb3"} 15:55:59 [15:55:59.362] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 15:55:59 [15:55:59.393] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:55:59 [15:55:59.404] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 15:55:59 [15:55:59.405] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 15:55:59 [15:55:59.405] INFO: e2e:e2e_multi_validator_node Waiting for 12 transactions to be mined... 15:55:59 [15:55:59.444] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:55:59 [15:55:59.444] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 15:55:59 [15:55:59.466] 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"} 15:55:59 [15:55:59.467] INFO: e2e:e2e_multi_validator_node Handing over to governance 15:55:59 [15:55:59.491] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 15:55:59 [15:55:59.494] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:55:59 [15:55:59.495] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 15:55:59 [15:55:59.497] INFO: telemetry:client Using NoopTelemetryClient 15:55:59 [15:55:59.502] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/8db74ed7c9b94007/blob-sink with map size 134217728 KB (LMDB v2) 15:55:59 [15:55:59.503] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:55:59 [15:55:59.504] WARN: foundation:test-date-provider Time set to 2025-06-04T16:00:57.000Z {"offset":297496,"timeMs":1749052857000} 15:55:59 [15:55:59.511] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:55:59 [15:55:59.517] INFO: blob-sink:server Server is running on http://localhost:34611 15:55:59 [15:55:59.517] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 15:55:59 [15:55:59.518] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/5d9ef337/acvm 15:55:59 [15:55:59.520] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34611"} 15:55:59 [15:55:59.545] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:55:59 [15:55:59.546] INFO: archiver:lmdb Creating archiver data store at directory /tmp/8db74ed7c9b94007/archiver with map size 134217728 KB (LMDB v2) 15:55:59 [15:55:59.548] INFO: archiver:lmdb Starting data store with maxReaders 16 15:55:59 [15:55:59.910] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:00 [15:56:00.127] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:00 [15:56:00.131] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:34611"} 15:56:00 [15:56:00.158] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:34611"} 15:56:00 [15:56:00.158] WARN: node:blob-sink:client No L1 consensus host urls configured 15:56:00 [15:56:00.159] WARN: node:blob-sink:client No archive client configured 15:56:00 [15:56:00.164] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 25 with hash 0x99dbeb2b91cb1a89a0da96fc65adf0a9733c08cb43ca21d930415f3438648e1a {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x9fa20be59d04a63c06209c8ba59f6296d845101628ddfe3ce4bd9bd829898d11","l1BlockNumber":18}} 15:56:00 [15:56:00.212] INFO: archiver Initial archiver sync to L1 block 25 complete. {"l1BlockNumber":25,"syncPoint":{"blocksSynchedTo":25,"messagesSynchedTo":{"l1BlockHash":"0x99dbeb2b91cb1a89a0da96fc65adf0a9733c08cb43ca21d930415f3438648e1a","l1BlockNumber":25}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:56:00 [15:56:00.224] INFO: world-state:database Creating world state data store at directory /tmp/8db74ed7c9b94007/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:56:00 [15:56:00.285] INFO: world_state Created world state synchroniser with block history of 64 15:56:00 [15:56:00.286] WARN: node Aztec node is accepting fake proofs 15:56:00 [15:56:00.313] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/8db74ed7c9b94007/p2p with map size 134217728 KB (LMDB v2) 15:56:00 [15:56:00.318] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:56:00 [15:56:00.319] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/8db74ed7c9b94007/p2p-archive with map size 134217728 KB (LMDB v2) 15:56:00 [15:56:00.324] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:56:00 [15:56:00.326] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/8db74ed7c9b94007/p2p-peers with map size 134217728 KB (LMDB v2) 15:56:00 [15:56:00.334] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:56:00 [15:56:00.336] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:56:00 [15:56:00.337] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:56:00 [15:56:00.344] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:00 [15:56:00.352] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 15:56:00 [15:56:00.353] INFO: world_state Started world state synchronizer from block 1 15:56:00 [15:56:00.361] VERBOSE: world-state:block_stream Starting sync from block number 0 15:56:00 [15:56:00.372] INFO: p2p Starting p2p client from block 0 with empty mempools 15:56:00 [15:56:00.372] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 15:56:00 [15:56:00.377] INFO: epoch-prune-watcher EpochPruneWatcher initialized 15:56:00 [15:56:00.384] INFO: slasher Starting Slasher client... 15:56:00 [15:56:00.537] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 15:56:00 [15:56:00.538] VERBOSE: node All Aztec Node subsystems synced 15:56:00 [15:56:00.551] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:56:00 [15:56:00.559] INFO: sequencer-client Deploying forwarder contract 15:56:00 [15:56:00.564] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:00 [15:56:00.611] VERBOSE: sequencer-client Sent L1 transaction 0x5f35c2d0e4f65c467262e74571eec910db06feaae6991ac544d9a02dbb6f34dd {"gasLimit":323704,"maxFeePerGas":"95.479418643","maxPriorityFeePerGas":"95.396216612"} 15:56:00 [15:56:00.612] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x5f35c2d0e4f65c467262e74571eec910db06feaae6991ac544d9a02dbb6f34dd. 15:56:00 [15:56:00.625] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 15:56:00 [15:56:00.641] INFO: validator Started validator with addresses: 15:56:00 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 15:56:00 [15:56:00.642] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 15:56:00 [15:56:00.643] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/5d9ef337/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:56:01 [15:56:01.052] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:56:01 [15:56:01.056] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:56:01 [15:56:01.064] INFO: node Aztec Node version: 0.87.6 15:56:01 [15:56:01.065] 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"} 15:56:01 [15:56:01.067] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 15:56:01 [15:56:01.111] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34611"} 15:56:01 [15:56:01.113] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:01 [15:56:01.122] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:56:01 [15:56:01.122] WARN: foundation:test-date-provider Time set to 2025-06-04T16:01:09.000Z {"offset":307878,"timeMs":1749052869000} 15:56:01 [15:56:01.128] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/8db74ed7c9b94007/ba7a281e551bdf1f/archiver with map size 134217728 KB (LMDB v2) 15:56:01 [15:56:01.142] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:01 [15:56:01.147] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 15:56:01 [15:56:01.357] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:01 [15:56:01.395] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:01 [15:56:01.499] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:34611"} 15:56:01 [15:56:01.503] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:34611"} 15:56:01 [15:56:01.503] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 15:56:01 [15:56:01.503] WARN: blob-sink:client:prover-node No archive client configured 15:56:01 [15:56:01.505] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 26 with hash 0x9745fc2d7007757ce06e17d2c5cbe2b5f065ad06135f1925b0805cf9f524fd14 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x9fa20be59d04a63c06209c8ba59f6296d845101628ddfe3ce4bd9bd829898d11","l1BlockNumber":18}} 15:56:01 [15:56:01.527] INFO: archiver:prover-node Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26,"messagesSynchedTo":{"l1BlockHash":"0x9745fc2d7007757ce06e17d2c5cbe2b5f065ad06135f1925b0805cf9f524fd14","l1BlockNumber":26}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:56:01 [15:56:01.531] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34611"} 15:56:01 [15:56:01.531] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 15:56:01 [15:56:01.533] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 15:56:01 [15:56:01.541] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/8db74ed7c9b94007/ba7a281e551bdf1f/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:56:01 [15:56:01.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:01 [15:56:01.589] INFO: world_state:prover-node Created world state synchroniser with block history of 64 15:56:01 [15:56:01.596] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 15:56:01 [15:56:01.597] INFO: world_state:prover-node Started world state synchronizer from block 1 15:56:01 [15:56:01.606] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 15:56:01 [15:56:01.607] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/8db74ed7c9b94007/ba7a281e551bdf1f/archiver when loading epoch databases, ignoring 15:56:01 [15:56:01.608] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/8db74ed7c9b94007/ba7a281e551bdf1f/world_state when loading epoch databases, ignoring 15:56:01 [15:56:01.611] INFO: prover-client:proving-broker:prover-node Proving Broker started 15:56:01 [15:56:01.645] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 15:56:01 [15:56:01.649] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 15:56:01 [15:56:01.650] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 15:56:01 [15:56:01.664] 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/8db74ed7c9b94007/ba7a281e551bdf1f","l1ChainId":31337,"rollupVersion":3201058510} 15:56:01 [15:56:01.665] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 15:56:01 [15:56:01.679] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:01 [15:56:01.681] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/a454e065685ded45/pxe_data with map size 134217728 KB (LMDB v2) 15:56:01 [15:56:01.684] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:56:01 [15:56:01.808] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:02 [15:56:02.000] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:02 [15:56:02.034] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:02 [15:56:02.040] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:56:02 [15:56:02.041] INFO: pxe:service Started PXE connected to chain 31337 version 3201058510 15:56:02 [15:56:02.134] INFO: pxe:service Registered account 0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd 15:56:02 [15:56:02.220] WARN: pxe:service No artifact found for contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 when looking for its metadata 15:56:02 [15:56:02.223] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 as part of deployment for 0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd 15:56:02 [15:56:02.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:02 [15:56:02.275] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:02 [15:56:02.430] INFO: pxe:service Added contract SchnorrAccount at 0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd with class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 15:56:02 [15:56:02.483] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:02 [15:56:02.516] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:02 [15:56:02.518] VERBOSE: pxe:block_stream Starting sync from block number 0 15:56:02 [15:56:02.570] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:56:02 [15:56:02.706] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:56:03 [15:56:03.619] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284,0x290a48e538e9392add98e2100e7a62cfbd47f755ac046f9cc9b55c24fe79091f,0x1d9edc9e571a9e7ab4d2aa454dd024ee819579e3e22ae0fadf28089b29f3f0bc,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:56:03 [15:56:03.754] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:56:03 [15:56:03.845] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:03 [15:56:03.888] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:04 [15:56:04.004] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:04 [15:56:04.055] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:56:04 [15:56:04.056] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:04 [15:56:04.084] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:04 [15:56:04.106] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:04 [15:56:04.135] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:04 [15:56:04.140] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:56:04 [15:56:04.298] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:04 [15:56:04.384] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:04 [15:56:04.542] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:04 [15:56:04.613] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:56:04 [15:56:04.613] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:04 [15:56:04.618] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:04 [15:56:04.691] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:04 [15:56:04.724] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:04 [15:56:04.734] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:56:04 [15:56:04.755] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd as fee payer 15:56:05 [15:56:05.091] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:05 [15:56:05.396] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:05 [15:56:05.405] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:05 [15:56:05.653] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:05 [15:56:05.790] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:05 [15:56:05.948] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:06 [15:56:06.055] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:06 [15:56:06.513] INFO: pxe:service Proving completed in 4032.945754999999ms {"timings":{"total":4032.945754999999,"sync":37.78822299999956,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":207.28541600000244,"oracles":{"callPrivateFunction":{"times":[1209.126354,504.0612149999997,427.08818000000065]}}},{"functionName":"private_kernel_init","time":250.84689900000012},{"functionName":"ContractClassRegisterer:register","time":1174.657912999999,"oracles":{"loadCapsule":{"times":[61.47077300000092]},"notifyCreatedNullifier":{"times":[28.4658359999994]},"debugLog":{"times":[1.3386569999984204]},"notifyCreatedContractClassLog":{"times":[9.409740000000966]}}},{"functionName":"private_kernel_inner","time":229.77183800000057},{"functionName":"SchnorrAccount:constructor","time":465.29556599999887,"oracles":{"getContractInstance":{"times":[0.8790709999993851]},"debugLog":{"times":[0.5354010000010021,0.5179100000004837]},"fetchTaggedLogs":{"times":[82.31270099999892]},"loadCapsule":{"times":[0.5036289999989094,0.25874499999918044,0.282376999999542]},"validateEnqueuedNotes":{"times":[1.603093000001536]},"notifyCreatedNullifier":{"times":[0.2454040000011446,0.4373250000007829]},"notifyCreatedNote":{"times":[0.46772600000076636]},"getRandomField":{"times":[0.3017569999992702,0.19956100000126753,0.13454700000147568,0.0925150000002759,0.08027399999991758,0.06472399999984191,0.06947399999990012,0.06613300000026356,0.07896500000060769,0.08616500000061933,0.05197299999963434]},"getIndexedTaggingSecretAsSender":{"times":[59.323920000000726]},"incrementAppTaggingSecretIndexAsSender":{"times":[80.02232999999978]}}},{"functionName":"private_kernel_inner","time":148.02412900000127},{"functionName":"SchnorrAccount:entrypoint","time":388.08062699999937,"oracles":{"debugLog":{"times":[0.8408790000012232,0.6706490000015037,0.8065660000011121]},"fetchTaggedLogs":{"times":[117.24014999999963]},"loadCapsule":{"times":[1.6450150000000576,0.5461420000010548,0.41223299999910523]},"validateEnqueuedNotes":{"times":[2.2924419999999373]},"getNotes":{"times":[2.6923549999992247]},"getAuthWitness":{"times":[0.34350999999878695]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.154406999999992]}}},{"functionName":"private_kernel_inner","time":146.07465700000103},{"functionName":"private_kernel_reset","time":201.05340699999942},{"functionName":"private_kernel_tail","time":102.51665299999877}],"unaccounted":681.5504269999983}} 15:56:06 [15:56:06.536] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:06 [15:56:06.603] VERBOSE: sequencer Not enough txs to build block 1 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","blockNumber":1,"slot":3} 15:56:06 [15:56:06.614] VERBOSE: p2p:tx_pool Adding tx 0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c to pool {"eventName":"tx-added-to-pool","txHash":"0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:56:06 [15:56:06.639] INFO: node Received tx 0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c {"txHash":"0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c"} 15:56:06 [15:56:06.639] INFO: pxe:service Sent transaction 0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c 15:56:06 [15:56:06.748] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:06 [15:56:06.827] VERBOSE: sequencer:block-builder Building block 1 for slot 3 {"slot":3,"slotStart":"2025-06-04T16:01:21.000Z","now":"2025-06-04T16:01:14.705Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x1039bc996b6808cb1b90c68b723a34af1883ab5ef692eb0702d3af85e956ea8d"},{"classId":"0x0318e775c9181ca9feb9de489bdbb70959b35be41d23316762899211ab3a3265"}]}} 15:56:06 [15:56:06.879] VERBOSE: simulator:public-processor Processed tx 0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c with no public calls in 22.91285699999935ms {"txHash":"0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c","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":22.91285699999935} 15:56:06 [15:56:06.881] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.050934457999999724s {"duration":0.050934457999999724,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 15:56:06 [15:56:06.989] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:07 [15:56:07.005] INFO: sequencer Built block 1 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x244009bd233127b6f8334683998fa20438f039f4c64719b65839a4bfe96ce001","globalVariables":{"chainId":31337,"version":3201058510,"blockNumber":1,"slotNumber":3,"timestamp":1749052881,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x21a6e3a402f012d975c40e2c1c2a68879335702d01c5abea6edb6d7999566d1c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":185.6463909999984,"publicProcessDuration":51.83511999999973,"rollupCircuitsDuration":178.34521200000017,"txCount":1,"blockNumber":1,"blockTimestamp":1749052881,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:56:07 [15:56:07.009] VERBOSE: sequencer Attesting committee is empty 15:56:07 [15:56:07.197] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:07 [15:56:07.360] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf3279cc11a7aa1302b545a6f7da607ee95916ddb54609f4a281134d401a7f2ce 15:56:07 [15:56:07.360] VERBOSE: node Sent L1 transaction 0xf3279cc11a7aa1302b545a6f7da607ee95916ddb54609f4a281134d401a7f2ce {"gasLimit":555012,"maxFeePerGas":"114.549196547","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 15:56:07 [15:56:07.377] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:56:07 [15:56:07.378] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf3279cc11a7aa1302b545a6f7da607ee95916ddb54609f4a281134d401a7f2ce","calldataSize":1444,"calldataGas":12256,"txCount":1,"blockNumber":1,"blockTimestamp":1749052881,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:56:07 [15:56:07.379] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:56:07 [15:56:07.399] INFO: blob-sink:server Received blob sidecar for block 0xd38d90f4ea510d19070d9f66e8bab72769b82626f5d7bcf134bfe5bf677e7a13 15:56:07 [15:56:07.405] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:07 [15:56:07.416] INFO: blob-sink:server Blob sidecar stored successfully for block 0xd38d90f4ea510d19070d9f66e8bab72769b82626f5d7bcf134bfe5bf677e7a13 15:56:07 [15:56:07.420] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 15:56:07 [15:56:07.423] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:56:07 [15:56:07.436] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:56:07 [15:56:07.436] WARN: foundation:test-date-provider Time set to 2025-06-04T16:01:21.000Z {"offset":313564,"timeMs":1749052881000} 15:56:07 [15:56:07.438] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:56:07 [15:56:07.675] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:07 [15:56:07.703] VERBOSE: archiver:block-helper Store contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 15:56:07 [15:56:07.724] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x244009bd233127b6f8334683998fa20438f039f4c64719b65839a4bfe96ce001","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3201058510,"blockNumber":1,"slotNumber":3,"timestamp":1749052881,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","archiveNextLeafIndex":2} 15:56:07 [15:56:07.848] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749052917] on http://127.0.0.1:8545 15:56:07 [15:56:07.863] VERBOSE: archiver:block-helper:prover-node Store contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 15:56:07 [15:56:07.868] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:56:07 [15:56:07.878] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c, 0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e) 15:56:07 [15:56:07.880] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749052917 15:56:07 [15:56:07.880] WARN: foundation:test-date-provider Time set to 2025-06-04T16:01:57.000Z {"offset":349120,"timeMs":1749052917000} 15:56:07 [15:56:07.881] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 15:56:07 [15:56:07.888] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:56:07 [15:56:07.890] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x244009bd233127b6f8334683998fa20438f039f4c64719b65839a4bfe96ce001","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3201058510,"blockNumber":1,"slotNumber":3,"timestamp":1749052881,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","archiveNextLeafIndex":2} 15:56:07 [15:56:07.909] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:07 [15:56:07.914] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 15:56:07 [15:56:07.918] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749055221] on http://127.0.0.1:8545 15:56:07 [15:56:07.921] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:56:07 [15:56:07.923] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":10.0014749999973,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749052881,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:56:07 [15:56:07.925] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":13.694406999999046,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749052881,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:56:07 [15:56:07.927] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749055221 15:56:07 [15:56:07.928] INFO: e2e:e2e_multi_validator_node Deploying contract from 0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd 15:56:08 [15:56:08.284] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:08 [15:56:08.299] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:56:08 [15:56:08.299] WARN: foundation:test-date-provider Time set to 2025-06-04T16:40:21.000Z {"offset":2652701,"timeMs":1749055221000} 15:56:08 [15:56:08.304] INFO: pxe:service Added contract StatefulTest at 0x0d09e031a45c986c914112b6f8a975f34971b1ed407e886bcf5d467359984f34 with class 0x0e75e50f67127bddbbf0c6e812b093c4e20dc26681235d9c77c3d57f93ab52a0 15:56:08 [15:56:08.519] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:08 [15:56:08.530] VERBOSE: p2p Synched to latest block 1 15:56:08 [15:56:08.551] INFO: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 is on the validator committee for epoch 2 15:56:08 [15:56:08.551] INFO: validator Validator 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 is on the validator committee for epoch 2 15:56:08 [15:56:08.551] INFO: validator Validator 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc is on the validator committee for epoch 2 15:56:08 [15:56:08.552] INFO: validator Validator 0x90f79bf6eb2c4f870365e785982e1f101e93b906 is on the validator committee for epoch 2 15:56:08 [15:56:08.552] INFO: validator Validator 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 is on the validator committee for epoch 2 15:56:08 [15:56:08.572] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:08 [15:56:08.572] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","header":{"contentCommitment":{"blobsHash":"0x00b3d93d673bda76970d3d7fe195ca77aee7d7a3b1c98dadb9dafb129cf42f61","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749052881,"version":3201058510},"lastArchive":"0x086dad863c7d95bb95a47663817189890b9031fc4cd919711f3935c1459e390e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1c8e7658f200016f896c9f83ec67233bbf2a209f8c5a7e83f58c5c454d14ebc9","nullifierTree":"0x24d010cb37ce1d4176ff31f6a067520bde9b4a058069115a50fa7cbafa65f367","publicDataTree":"0x1ae87df11f8f5d0199e93eeae8a1219717c0e8c2eaf27062b616d84146eafa0c"},"totalFees":2101212240,"totalManaUsed":6324}} 15:56:08 [15:56:08.678] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:08 [15:56:08.731] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:56:08 [15:56:08.731] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:08 [15:56:08.733] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:08 [15:56:08.770] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 1 from coordination 15:56:08 [15:56:08.772] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 15:56:08 [15:56:08.803] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 15:56:08 [15:56:08.804] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 15:56:08 [15:56:08.926] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:08 [15:56:08.944] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:08 [15:56:08.966] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd"} 15:56:08 [15:56:08.971] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x29392d39b45dd6eb1cbcf99fedb0e5ca551de245a9db7bf0a457229ac6fe8399 15:56:08 [15:56:08.990] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:56:08 [15:56:08.991] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:56:09 [15:56:09.000] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:56:09 [15:56:09.000] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:56:09 [15:56:09.003] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:56:09 [15:56:09.009] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x25a67eb13af4bcbd996bde460812821baba09936e4132b437503c3f69d0f53d5","nullifier":"0x02b3b835c853dfbae51da8244dc2e400447d951362f5bebc7368309b94b862b2"} 15:56:09 [15:56:09.026] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0b47d60c042aed8180bd5b85c709c0ad0fdf774a71c639e906e1abd1a54d97dd as fee payer 15:56:09 [15:56:09.200] VERBOSE: simulator:private_execution Executing private function StatefulTest:constructor {"contract":"0x0d09e031a45c986c914112b6f8a975f34971b1ed407e886bcf5d467359984f34"} 15:56:09 [15:56:09.215] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:09 [15:56:09.225] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:56:09 [15:56:09.225] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0d09e031a45c986c914112b6f8a975f34971b1ed407e886bcf5d467359984f34"} 15:56:09 [15:56:09.254] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:09 [15:56:09.357] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0d09e031a45c986c914112b6f8a975f34971b1ed407e886bcf5d467359984f34"} 15:56:09 [15:56:09.376] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:56:09 [15:56:09.489] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:09 [15:56:09.587] VERBOSE: simulator:private_execution Executing private function StatefulTest:create_note_no_init_check {"contract":"0x0d09e031a45c986c914112b6f8a975f34971b1ed407e886bcf5d467359984f34"} 15:56:09 [15:56:09.629] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:56:09 [15:56:09.629] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0d09e031a45c986c914112b6f8a975f34971b1ed407e886bcf5d467359984f34"} 15:56:09 [15:56:09.664] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:09 [15:56:09.744] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:09 [15:56:09.755] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0d09e031a45c986c914112b6f8a975f34971b1ed407e886bcf5d467359984f34"} 15:56:09 [15:56:09.768] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:56:09 [15:56:09.917] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:09 [15:56:09.968] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:10 [15:56:10.170] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:10 [15:56:10.270] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:10 [15:56:10.601] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:10 [15:56:10.645] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:10 [15:56:10.880] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:11 [15:56:11.219] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:11 [15:56:11.243] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:11 [15:56:11.425] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:11 [15:56:11.723] INFO: pxe:service Proving completed in 3286.149117000001ms {"timings":{"total":3286.149117000001,"sync":137.82116199999655,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":500.24275499999203,"oracles":{"debugLog":{"times":[0.8492289999994682,0.46456599999874015,0.6230959999993502,0.6347569999998086,0.520489999998972,0.33654999999998836,0.33847899999818765,0.6404270000020915]},"fetchTaggedLogs":{"times":[237.40689600000042]},"loadCapsule":{"times":[0.31108799999856274,0.42742400000133784,0.5260600000001432,0.26041500000064843,0.22937399999864283,0.2529739999990852,0.2413940000005823]},"getSharedSecret":{"times":[8.00028999999995]},"aes128Decrypt":{"times":[1.1809479999974428,1.2052399999993213]},"getPublicKeysAndPartialAddress":{"times":[2.2757700000001932]},"getKeyValidationRequest":{"times":[2.651192000001174]},"storeCapsule":{"times":[0.45162599999821396,0.3182879999985744,0.3136180000001332]},"deleteCapsule":{"times":[0.3903219999992871]},"validateEnqueuedNotes":{"times":[5.821804999999586]},"getNotes":{"times":[1.6700459999992745]},"getAuthWitness":{"times":[0.28694699999687145]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.056502999999793246]},"callPrivateFunction":{"times":[963.9661119999982]}}},{"functionName":"private_kernel_init","time":91.41736499999752},{"functionName":"StatefulTest:constructor","time":352.2631190000029,"oracles":{"getContractInstance":{"times":[7.422536000001855]},"debugLog":{"times":[0.6241850000005797,0.650696999997308]},"fetchTaggedLogs":{"times":[148.89402900000277]},"loadCapsule":{"times":[0.4071139999978186,0.26657500000146683,0.36515200000212644]},"validateEnqueuedNotes":{"times":[4.988247000001138]},"storeInExecutionCache":{"times":[0.3062469999968016]},"callPrivateFunction":{"times":[601.5549290000017]},"notifyCreatedNullifier":{"times":[0.24374399999942398]}}},{"functionName":"private_kernel_inner","time":145.87656499999866},{"functionName":"StatefulTest:create_note_no_init_check","time":546.9669810000014,"oracles":{"debugLog":{"times":[0.5983350000024075,0.7051110000029439]},"fetchTaggedLogs":{"times":[137.676534000002]},"loadCapsule":{"times":[0.2775050000018382,0.21984299999894574,5.7382200000029115]},"validateEnqueuedNotes":{"times":[1.293573999999353]},"getRandomField":{"times":[0.2444039999973029,0.11300699999992503,0.1851799999967625,0.10776699999769335,0.08412500000122236,0.08013500000015483,0.08694499999910477,0.07563400000071852,0.07528399999864632,0.06718399999954272,0.06500299999970593,0.05093299999862211]},"notifyCreatedNote":{"times":[0.170509999999922]},"getIndexedTaggingSecretAsSender":{"times":[104.38664000000063]},"incrementAppTaggingSecretIndexAsSender":{"times":[66.01287500000035]}}},{"functionName":"private_kernel_inner","time":170.48407000000225},{"functionName":"private_kernel_reset","time":198.159681000001},{"functionName":"private_kernel_tail","time":101.22910899999988}],"unaccounted":1041.6883100000086}} 15:56:11 [15:56:11.780] VERBOSE: sequencer Not enough txs to build block 2 at slot 68 (got 0 txs, need 1) {"chainTipArchive":"0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c","blockNumber":2,"slot":68} 15:56:11 [15:56:11.781] VERBOSE: p2p:tx_pool Adding tx 0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de to pool {"eventName":"tx-added-to-pool","txHash":"0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 15:56:11 [15:56:11.786] INFO: node Received tx 0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de {"txHash":"0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de"} 15:56:11 [15:56:11.787] INFO: pxe:service Sent transaction 0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de 15:56:11 [15:56:11.951] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:12 [15:56:12.026] VERBOSE: sequencer:block-builder Building block 2 for slot 68 {"slot":68,"slotStart":"2025-06-04T16:40:21.000Z","now":"2025-06-04T16:40:24.727Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x1039bc996b6808cb1b90c68b723a34af1883ab5ef692eb0702d3af85e956ea8d"},{"classId":"0x0318e775c9181ca9feb9de489bdbb70959b35be41d23316762899211ab3a3265"}]}} 15:56:12 [15:56:12.055] VERBOSE: simulator:public-processor Processed tx 0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de with no public calls in 17.61847299999863ms {"txHash":"0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de","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":17.61847299999863} 15:56:12 [15:56:12.056] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.027997739999998886s {"duration":0.027997739999998886,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 15:56:12 [15:56:12.155] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:12 [15:56:12.166] INFO: sequencer Built block 2 for slot 68 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1b449e3f2b1da46f6489b32fa46faa03e02742058001208cc56953f20a6eecad","globalVariables":{"chainId":31337,"version":3201058510,"blockNumber":2,"slotNumber":68,"timestamp":1749055221,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x1ed6f99578c2dbb25b847cf5eb9c59ca8465e00c88ae88587977ed21ef2911de"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":145.19837700000062,"publicProcessDuration":28.511608000000706,"rollupCircuitsDuration":139.8435189999982,"txCount":1,"blockNumber":2,"blockTimestamp":1749055221,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:56:12 [15:56:12.176] VERBOSE: p2p Broadcasting proposal for slot 68 to peers 15:56:12 [15:56:12.193] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 {"signature":"0xf9d10af441fcdf019ceb9257e5a9658e818ba2572cf5f1a33d5276a25db62bb2545e4a81d91718c2bff39c1b30f5d82eaa0c45894ade9c69c0c55360427065f61b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","proposalId":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b"} 15:56:12 [15:56:12.196] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x70997970c51812dc3a010c7d01b50e0d17dc79c8 {"signature":"0x603dc3d0f418ec21bd6a3100757c8d67645f30c0320ff59d189ce4d3419d20d71a34e9cb3a5f6bb6ad254b0ddd3738fd5129a13be027133e0c3599c225eacc061c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x70997970c51812dc3a010c7d01b50e0d17dc79c8","proposalId":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b"} 15:56:12 [15:56:12.199] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc {"signature":"0x3188b1f754f149687ed701f21d0b78c04f26eafbb39ecb308a4afb4aa8ad6a0e4043d7ef2d5c6687c01ce63d8a1eae588ae5843b95e4ff8bb68235b9204407861b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc","proposalId":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b"} 15:56:12 [15:56:12.202] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x90f79bf6eb2c4f870365e785982e1f101e93b906 {"signature":"0xdc53e7871253e6fa0f763ed3f0341418603c5e585dd724a59e264b7af51d2bc63387dc7d480f1621324252a52b2984997a8f4d69ee1e855d50ccb5eb3b8147d61b","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x90f79bf6eb2c4f870365e785982e1f101e93b906","proposalId":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b"} 15:56:12 [15:56:12.205] VERBOSE: p2p:attestation_pool Added attestation for slot 68 from 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 {"signature":"0xf2b6eab38380f7b8297b501fa523432227f8a2fb7209f00325ca2e65ab32e0fb3580c94d2f93ff2280900e667426e53066e64be6d7c8030cc4c8df4f9bc894691c","slotNumber":"0x0000000000000000000000000000000000000000000000000000000000000044","address":"0x15d34aaf54267db7d7c367839aaf71a00a2c6a65","proposalId":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b"} 15:56:12 [15:56:12.205] VERBOSE: validator Collected all 4 attestations for slot 68 15:56:12 [15:56:12.206] VERBOSE: sequencer Collected 5 attestations {"blockHash":"0x1b449e3f2b1da46f6489b32fa46faa03e02742058001208cc56953f20a6eecad","blockNumber":2} 15:56:12 [15:56:12.360] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:12 [15:56:12.495] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4ee2fc06af86120144a7ef8365d4e514de648835dd2fb73999c812528460d255 15:56:12 [15:56:12.495] VERBOSE: node Sent L1 transaction 0x4ee2fc06af86120144a7ef8365d4e514de648835dd2fb73999c812528460d255 {"gasLimit":660402,"maxFeePerGas":"1.249716399","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:56:12 [15:56:12.520] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:56:12 [15:56:12.520] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4ee2fc06af86120144a7ef8365d4e514de648835dd2fb73999c812528460d255","calldataSize":2084,"calldataGas":19904,"txCount":1,"blockNumber":2,"blockTimestamp":1749055221,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:56:12 [15:56:12.521] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:56:12 [15:56:12.527] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749055257] on http://127.0.0.1:8545 15:56:12 [15:56:12.531] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:56:12 [15:56:12.534] INFO: blob-sink:server Received blob sidecar for block 0x19b4b84e1c5d79fe36858bd3cdfd7abd1da84b5d8c88b5dc7f5deb583ac2d959 15:56:12 [15:56:12.539] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749055257 15:56:12 [15:56:12.539] WARN: foundation:test-date-provider Time set to 2025-06-04T16:40:57.000Z {"offset":2684461,"timeMs":1749055257000} 15:56:12 [15:56:12.539] INFO: aztecjs:utils:watcher Slot 68 was filled, jumped to next slot 15:56:12 [15:56:12.542] INFO: blob-sink:server Blob sidecar stored successfully for block 0x19b4b84e1c5d79fe36858bd3cdfd7abd1da84b5d8c88b5dc7f5deb583ac2d959 15:56:12 [15:56:12.563] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:12 [15:56:12.579] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 15:56:12 [15:56:12.587] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 15:56:12 [15:56:12.597] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 15:56:12 [15:56:12.841] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:12 [15:56:12.876] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1b449e3f2b1da46f6489b32fa46faa03e02742058001208cc56953f20a6eecad","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3201058510,"blockNumber":2,"slotNumber":68,"timestamp":1749055221,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b","archiveNextLeafIndex":3} 15:56:12 [15:56:12.886] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x1b449e3f2b1da46f6489b32fa46faa03e02742058001208cc56953f20a6eecad","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3201058510,"blockNumber":2,"slotNumber":68,"timestamp":1749055221,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b","archiveNextLeafIndex":3} 15:56:12 [15:56:12.898] VERBOSE: prover-node:prover-node Fetching 1 tx hashes for block number 2 from coordination 15:56:12 [15:56:12.899] INFO: prover-node:combined-prover-coordination:prover-node Check for 1 txs found 1 missing. Will gather from nodes and p2p 15:56:12 [15:56:12.905] VERBOSE: prover-node:combined-prover-coordination:prover-node Gathered 1 of 1 txs from a node 15:56:12 [15:56:12.905] INFO: prover-node:combined-prover-coordination:prover-node Found all 1 txs directly from nodes 15:56:12 [15:56:12.911] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b, 0x07bbb467798dd4bbcc1eea0050434fbdce872b90878325b766c7025bf4f6cd3c) 15:56:13 [15:56:13.062] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:13 [15:56:13.083] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.428325000000768,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749055221,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:56:13 [15:56:13.084] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.25447400000121,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749055221,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:56:13 [15:56:13.124] VERBOSE: p2p Synched to latest block 2 15:56:13 [15:56:13.125] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 15:56:13 [15:56:13.128] INFO: archiver:prover-node Updated proven chain to block 2 {"provenBlockNumber":2} 15:56:13 [15:56:13.264] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:13 [15:56:13.350] VERBOSE: sequencer Not enough txs to build block 3 at slot 69 (got 0 txs, need 1) {"chainTipArchive":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b","blockNumber":3,"slot":69} 15:56:13 [15:56:13.466] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:13 [15:56:13.570] VERBOSE: sequencer Not enough txs to build block 3 at slot 69 (got 0 txs, need 1) {"chainTipArchive":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b","blockNumber":3,"slot":69} 15:56:13 [15:56:13.669] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:13 [15:56:13.796] VERBOSE: sequencer Not enough txs to build block 3 at slot 69 (got 0 txs, need 1) {"chainTipArchive":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b","blockNumber":3,"slot":69} 15:56:13 [15:56:13.874] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:14 [15:56:14.078] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:14 [15:56:14.091] VERBOSE: sequencer Not enough txs to build block 3 at slot 69 (got 0 txs, need 1) {"chainTipArchive":"0x0fbd38603f4172c777c64da2511adbb7e3d349cb1ae6f6bfe7f1ee4bdb62316b","blockNumber":3,"slot":69} 15:56:14 [15:56:14.096] INFO: node Stopping 15:56:14 [15:56:14.098] INFO: slasher Slasher client stopped. 15:56:14 [15:56:14.098] INFO: sequencer Stopped sequencer 15:56:14 [15:56:14.099] INFO: p2p P2P client stopped. 15:56:14 [15:56:14.101] INFO: world_state Stopped world state synchronizer 15:56:14 [15:56:14.102] INFO: archiver Stopped. 15:56:14 [15:56:14.102] INFO: node Stopped 15:56:14 [15:56:14.102] INFO: prover-node:prover-node Stopping ProverNode 15:56:14 [15:56:14.102] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 15:56:14 [15:56:14.104] INFO: archiver:prover-node Stopped. 15:56:14 [15:56:14.108] INFO: world_state:prover-node Stopped world state synchronizer 15:56:14 [15:56:14.111] INFO: prover-node:prover-node Stopped ProverNode 15:56:14 [15:56:14.111] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 15:56:14 [15:56:14.111] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/5d9ef337 15:56:14 [15:56:14.113] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 15:56:14 [15:56:14.128] INFO: blob-sink:server Stopping blob sink 15:56:14 [15:56:14.129] INFO: blob-sink:server Blob sink stopped 15:56:14 [15:56:14.129] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/8db74ed7c9b94007 15:56:14 [15:56:14.137] INFO: e2e:e2e_multi_validator_node Running test: e2e_multi_validator_node should attest ONLY with the correct validator keys 15:56:14 [15:56:14.399] INFO: e2e:e2e_multi_validator_node Logging metrics to log/e2e_multi_validator_node.jsonl 15:56:14 [15:56:14.444] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-TnnN8Q/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:56:14 [15:56:14.488] INFO: e2e:e2e_multi_validator_node Calling anvil_setBlockTimestampInterval with params: [12] 15:56:14 [15:56:14.493] WARN: e2e:e2e_multi_validator_node Set block interval to 12 15:56:14 [15:56:14.493] VERBOSE: e2e:e2e_multi_validator_node Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:56:14 [15:56:14.517] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:56:14 [15:56:14.523] VERBOSE: e2e:e2e_multi_validator_node Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:56:14 [15:56:14.536] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:56:14 [15:56:14.541] VERBOSE: e2e:e2e_multi_validator_node Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:56:14 [15:56:14.579] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x15a910452a602ec46131d746d66411db81d7fc72b90362a00ee4d18cc6abe51b {"gasLimit":3064716,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:56:14 [15:56:14.596] VERBOSE: e2e:e2e_multi_validator_node Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:56:14 [15:56:14.631] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x263f559e4ac0e4916749f1cfef6c86ab177d4ed50b4e9dd5b714b2907c3ea485 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:56:14 [15:56:14.637] VERBOSE: e2e:e2e_multi_validator_node Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:56:14 [15:56:14.663] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x20a9b0b462f62bc3be8ca34c505c34cf2a4c1358e5584da2d561d72abc96aed1 {"gasLimit":1945066,"maxFeePerGas":"3.602461376","maxPriorityFeePerGas":"2.48832"} 15:56:14 [15:56:14.672] VERBOSE: e2e:e2e_multi_validator_node Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:56:14 [15:56:14.697] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x28a12a8c995db07c5f5cafec9b82f038e63dc5e97dcd98daa9cfc9f4a5ab8de7 {"gasLimit":3043143,"maxFeePerGas":"3.968706922","maxPriorityFeePerGas":"2.985984"} 15:56:14 [15:56:14.701] VERBOSE: e2e:e2e_multi_validator_node Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:56:14 [15:56:14.715] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f {"gasLimit":55548,"maxFeePerGas":"4.456337397","maxPriorityFeePerGas":"3.5831808"} 15:56:14 [15:56:14.716] VERBOSE: e2e:e2e_multi_validator_node Set governance on GSE in 0xc1f7b41d75ca1c1d5ae465e404bbd8504ed5ce0a989a57516345a51ea9ed0c0f 15:56:14 [15:56:14.728] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5d35a155eec0ed0c7deff752275abe3c6d5f448014ad234660feb820ef8620df {"gasLimit":391705,"maxFeePerGas":"5.082281352","maxPriorityFeePerGas":"4.29981696"} 15:56:14 [15:56:14.737] VERBOSE: e2e:e2e_multi_validator_node Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 15:56:14 [15:56:14.737] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 15:56:14 [15:56:14.737] INFO: e2e:e2e_multi_validator_node Waiting for 7 transactions to be mined... 15:56:14 [15:56:14.755] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:56:14 [15:56:14.768] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed {"gasLimit":56804,"maxFeePerGas":"5.84473853","maxPriorityFeePerGas":"5.159780352"} 15:56:14 [15:56:14.769] VERBOSE: e2e:e2e_multi_validator_node Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0xc37d056a228d0e8692a00fea58194c1400046912bffddf048101dc45c4dd47ed 15:56:14 [15:56:14.781] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x8e92b552cc623d62987e85e1df7c096f9eae4836710a4f62deed3668e8d02fa6 {"gasLimit":56661,"maxFeePerGas":"6.792938035","maxPriorityFeePerGas":"6.191736422"} 15:56:14 [15:56:14.793] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2c50b6224c5aaa3d953e1f1029dcd0ea319c195a3237972ff224e8c29a1434cd {"gasLimit":339691,"maxFeePerGas":"7.956372276","maxPriorityFeePerGas":"7.430083706"} 15:56:14 [15:56:14.798] VERBOSE: e2e:e2e_multi_validator_node Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:56:14 [15:56:14.809] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c {"gasLimit":56804,"maxFeePerGas":"9.376810034","maxPriorityFeePerGas":"8.916100447"} 15:56:14 [15:56:14.809] VERBOSE: e2e:e2e_multi_validator_node Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xf95284a2480bb65b51365bc5970e8e5f171ce8b045dbcb10348d28e0f1ce646c 15:56:14 [15:56:14.823] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x3bf548a99420047e1164bf2dfa64c5fc4ed32845f7019722b8db00da065120d2 {"gasLimit":1089256,"maxFeePerGas":"11.103528222","maxPriorityFeePerGas":"10.699320536"} 15:56:14 [15:56:14.831] VERBOSE: e2e:e2e_multi_validator_node Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 15:56:14 [15:56:14.842] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 {"gasLimit":56804,"maxFeePerGas":"13.193025819","maxPriorityFeePerGas":"12.839184643"} 15:56:14 [15:56:14.842] VERBOSE: e2e:e2e_multi_validator_node Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x2197583f4a2bcdf7d6daa20a2db857e2546f0103d8255cb45b2685bf59dd1510 15:56:14 [15:56:14.842] VERBOSE: e2e:e2e_multi_validator_node Waiting for deployments to complete 15:56:14 [15:56:14.842] INFO: e2e:e2e_multi_validator_node Waiting for 9 transactions to be mined... 15:56:14 [15:56:14.860] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:56:14 [15:56:14.870] VERBOSE: e2e:e2e_multi_validator_node Deployed shared contracts 15:56:14 [15:56:14.882] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 {"gasLimit":84837,"maxFeePerGas":"15.719309155","maxPriorityFeePerGas":"15.407021571"} 15:56:14 [15:56:14.883] VERBOSE: e2e:e2e_multi_validator_node Funded reward distributor with 10000000000000000000000000 fee asset in 0x9961b6827a28c68d0c814620c5debe7fce125c59adfd8478604c1d94d12b26b3 15:56:14 [15:56:14.884] 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} 15:56:14 [15:56:14.900] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x4b00bf010016af1a686fa82a49ffcd696fe6567f2fafe88a5077a3196ed3622b {"gasLimit":86397,"maxFeePerGas":"18.761800709","maxPriorityFeePerGas":"18.488425885"} 15:56:14 [15:56:14.982] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x5ab770e71a294d59a299893ceef963b3326d216a75236785d0f3ad5811b5880e {"gasLimit":6285180,"maxFeePerGas":"22.425475094","maxPriorityFeePerGas":"22.186111062"} 15:56:14 [15:56:14.995] VERBOSE: e2e:e2e_multi_validator_node Awaiting for linked libraries to be deployed 15:56:15 [15:56:15.068] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xbee8d9c2e9b43b853db9a0b6cdb99a33b47d29f882cc6f2265afb5d27496f401 {"gasLimit":10716795,"maxFeePerGas":"26.832920416","maxPriorityFeePerGas":"26.623333274"} 15:56:15 [15:56:15.078] 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} 15:56:15 [15:56:15.079] INFO: e2e:e2e_multi_validator_node Waiting for 10 transactions to be mined... 15:56:15 [15:56:15.110] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:56:15 [15:56:15.110] VERBOSE: e2e:e2e_multi_validator_node All core contracts have been deployed 15:56:15 [15:56:15.130] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a {"gasLimit":64317,"maxFeePerGas":"32.140536546","maxPriorityFeePerGas":"31.947999928"} 15:56:15 [15:56:15.131] VERBOSE: e2e:e2e_multi_validator_node Funding fee juice portal with 10000000000000000000000 fee juice in 0x876c00941611afeae461e4b49171cda3531c73fd49dd55a0d5ee01076127408a (accelerated test deployments) 15:56:15 [15:56:15.154] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0xd413488be28de232ee67a932daca30e5e7bc4e1ad751dedc3910bbbe185aafe4 {"gasLimit":1040116,"maxFeePerGas":"38.520398451","maxPriorityFeePerGas":"38.337599913"} 15:56:15 [15:56:15.161] VERBOSE: e2e:e2e_multi_validator_node Deployed SlashFactory at 0x3aa5ebb10dc797cac828524e59a333d0a371443c 15:56:15 [15:56:15.201] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec {"gasLimit":116846,"maxFeePerGas":"46.165150264","maxPriorityFeePerGas":"46.005119895"} 15:56:15 [15:56:15.202] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x9cf2e8cc19e5a14c92d6ffc7b824d5af7abcd5e99d83ce8f9d8f18174a0f48ec 15:56:15 [15:56:15.231] VERBOSE: e2e:e2e_multi_validator_node Sent L1 transaction 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 {"gasLimit":109478,"maxFeePerGas":"55.34732635","maxPriorityFeePerGas":"55.206143874"} 15:56:15 [15:56:15.232] VERBOSE: e2e:e2e_multi_validator_node Adding rollup 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x2a5b9e16c5abd0a75879e886c16c1174a5bec7f4574004840187d6fdb1602285 15:56:15 [15:56:15.236] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 15:56:15 [15:56:15.276] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:56:15 [15:56:15.285] VERBOSE: e2e:e2e_multi_validator_node Rollup deployed 15:56:15 [15:56:15.286] VERBOSE: e2e:e2e_multi_validator_node Waiting for rollup and slash factory to be deployed 15:56:15 [15:56:15.286] INFO: e2e:e2e_multi_validator_node Waiting for 11 transactions to be mined... 15:56:15 [15:56:15.317] INFO: e2e:e2e_multi_validator_node All transactions mined successfully 15:56:15 [15:56:15.317] VERBOSE: e2e:e2e_multi_validator_node All transactions for L1 deployment have been mined 15:56:15 [15:56:15.343] 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"} 15:56:15 [15:56:15.344] INFO: e2e:e2e_multi_validator_node Handing over to governance 15:56:15 [15:56:15.350] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 15:56:15 [15:56:15.353] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:15 [15:56:15.354] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 15:56:15 [15:56:15.368] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/84c71aed097fb4b5/blob-sink with map size 134217728 KB (LMDB v2) 15:56:15 [15:56:15.373] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:56:15 [15:56:15.373] WARN: foundation:test-date-provider Time set to 2025-06-04T16:00:38.000Z {"offset":262627,"timeMs":1749052838000} 15:56:15 [15:56:15.382] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:56:15 [15:56:15.388] INFO: blob-sink:server Server is running on http://localhost:42333 15:56:15 [15:56:15.389] VERBOSE: e2e:e2e_multi_validator_node Creating and synching an aztec node... 15:56:15 [15:56:15.390] VERBOSE: e2e:e2e_multi_validator_node Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/ddd885ff/acvm 15:56:15 [15:56:15.391] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42333"} 15:56:15 [15:56:15.419] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:56:15 [15:56:15.420] INFO: archiver:lmdb Creating archiver data store at directory /tmp/84c71aed097fb4b5/archiver with map size 134217728 KB (LMDB v2) 15:56:15 [15:56:15.422] INFO: archiver:lmdb Starting data store with maxReaders 16 15:56:15 [15:56:15.655] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:15 [15:56:15.775] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:42333"} 15:56:15 [15:56:15.780] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:42333"} 15:56:15 [15:56:15.780] WARN: node:blob-sink:client No L1 consensus host urls configured 15:56:15 [15:56:15.780] WARN: node:blob-sink:client No archive client configured 15:56:15 [15:56:15.783] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 22 with hash 0x7c0c737feec4502dab2d924029ac2182ad909dc557c1e355ab7b5e4ced6d4aa0 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xb3b06daf57d925b4961db1e0e5e05326c4d9f0d3fa56ad92efe00bcbc6110d1f","l1BlockNumber":18}} 15:56:15 [15:56:15.813] INFO: archiver Initial archiver sync to L1 block 22 complete. {"l1BlockNumber":22,"syncPoint":{"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0x7c0c737feec4502dab2d924029ac2182ad909dc557c1e355ab7b5e4ced6d4aa0","l1BlockNumber":22}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:56:15 [15:56:15.829] INFO: world-state:database Creating world state data store at directory /tmp/84c71aed097fb4b5/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:56:15 [15:56:15.856] INFO: world_state Created world state synchroniser with block history of 64 15:56:15 [15:56:15.857] WARN: node Aztec node is accepting fake proofs 15:56:15 [15:56:15.861] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:15 [15:56:15.869] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/84c71aed097fb4b5/p2p with map size 134217728 KB (LMDB v2) 15:56:15 [15:56:15.872] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:56:15 [15:56:15.878] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/84c71aed097fb4b5/p2p-archive with map size 134217728 KB (LMDB v2) 15:56:15 [15:56:15.879] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:56:15 [15:56:15.884] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/84c71aed097fb4b5/p2p-peers with map size 134217728 KB (LMDB v2) 15:56:15 [15:56:15.886] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:56:15 [15:56:15.889] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:56:15 [15:56:15.890] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:56:15 [15:56:15.892] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":200} 15:56:15 [15:56:15.892] INFO: world_state Started world state synchronizer from block 1 15:56:15 [15:56:15.896] VERBOSE: world-state:block_stream Starting sync from block number 0 15:56:15 [15:56:15.899] INFO: p2p Starting p2p client from block 0 with empty mempools 15:56:15 [15:56:15.900] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":200,"startingBlock":0} 15:56:15 [15:56:15.900] INFO: epoch-prune-watcher EpochPruneWatcher initialized 15:56:15 [15:56:15.905] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:56:15 [15:56:15.906] INFO: slasher Starting Slasher client... 15:56:15 [15:56:15.911] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 15:56:15 [15:56:15.911] VERBOSE: node All Aztec Node subsystems synced 15:56:15 [15:56:15.916] INFO: sequencer-client Deploying forwarder contract 15:56:15 [15:56:15.929] VERBOSE: sequencer-client Sent L1 transaction 0x602f411c9ae84deb9da90dad04b3e6b54d91158c82d01934d2b760f3de926311 {"gasLimit":323704,"maxFeePerGas":"66.371021876","maxPriorityFeePerGas":"66.247372648"} 15:56:15 [15:56:15.929] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x83ac846879C81f414bDf47961839F4E842ead017 in tx 0x602f411c9ae84deb9da90dad04b3e6b54d91158c82d01934d2b760f3de926311. 15:56:15 [15:56:15.934] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 15:56:15 [15:56:15.941] INFO: validator Started validator with addresses: 15:56:15 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 15:56:15 [15:56:15.941] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266, 0x70997970c51812dc3a010c7d01b50e0d17dc79c8, 0x3c44cdddb6a900fa2b585dd299e03d12fa4293bc, 0x90f79bf6eb2c4f870365e785982e1f101e93b906, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65 are not on the validator committee for epoch 0 15:56:15 [15:56:15.942] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":200,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/ddd885ff/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:56:15 [15:56:15.942] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:56:15 [15:56:15.943] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:56:15 [15:56:15.944] INFO: node Aztec Node version: 0.87.6 15:56:15 [15:56:15.944] 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"} 15:56:15 [15:56:15.945] VERBOSE: e2e:e2e_multi_validator_node Creating and syncing a simulated prover node... 15:56:15 [15:56:15.979] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42333"} 15:56:15 [15:56:15.983] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/84c71aed097fb4b5/d27e769a57144974/archiver with map size 134217728 KB (LMDB v2) 15:56:15 [15:56:15.988] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":1} 15:56:15 [15:56:15.988] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 15:56:16 [15:56:16.109] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:16 [15:56:16.116] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:56:16 [15:56:16.116] WARN: foundation:test-date-provider Time set to 2025-06-04T16:00:50.000Z {"offset":273884,"timeMs":1749052850000} 15:56:16 [15:56:16.253] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:16 [15:56:16.318] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:16 [15:56:16.377] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:42333"} 15:56:16 [15:56:16.381] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:42333"} 15:56:16 [15:56:16.381] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 15:56:16 [15:56:16.381] WARN: blob-sink:client:prover-node No archive client configured 15:56:16 [15:56:16.384] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 23 with hash 0x870468bacc9a1b5ea3bce49fd3fe11114345de0d0e3a5dbb11385cc3b7a37de7 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0xb3b06daf57d925b4961db1e0e5e05326c4d9f0d3fa56ad92efe00bcbc6110d1f","l1BlockNumber":18}} 15:56:16 [15:56:16.410] INFO: archiver:prover-node Initial archiver sync to L1 block 23 complete. {"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x870468bacc9a1b5ea3bce49fd3fe11114345de0d0e3a5dbb11385cc3b7a37de7","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:56:16 [15:56:16.413] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42333"} 15:56:16 [15:56:16.413] VERBOSE: prover-node:prover-node Snapshot sync is disabled. No snapshots URL provided. 15:56:16 [15:56:16.416] VERBOSE: prover-node:prover-node Created archiver and synced to block 0 15:56:16 [15:56:16.430] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/84c71aed097fb4b5/d27e769a57144974/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:56:16 [15:56:16.514] INFO: world_state:prover-node Created world state synchroniser with block history of 64 15:56:16 [15:56:16.523] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":200} 15:56:16 [15:56:16.524] INFO: world_state:prover-node Started world state synchronizer from block 1 15:56:16 [15:56:16.525] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:16 [15:56:16.526] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 15:56:16 [15:56:16.527] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/84c71aed097fb4b5/d27e769a57144974/archiver when loading epoch databases, ignoring 15:56:16 [15:56:16.527] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/84c71aed097fb4b5/d27e769a57144974/world_state when loading epoch databases, ignoring 15:56:16 [15:56:16.527] INFO: prover-client:proving-broker:prover-node Proving Broker started 15:56:16 [15:56:16.537] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 15:56:16 [15:56:16.538] INFO: e2e:e2e_multi_validator_node:prover-node Created and synced prover node {"publisherAddress":"0x3C44CdDdB6a900fa2b585dd299e03d12FA4293BC"} 15:56:16 [15:56:16.539] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 15:56:16 [15:56:16.542] 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/84c71aed097fb4b5/d27e769a57144974","l1ChainId":31337,"rollupVersion":2399585236} 15:56:16 [15:56:16.543] VERBOSE: e2e:e2e_multi_validator_node Creating a pxe... 15:56:16 [15:56:16.544] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/07ed247621fc6468/pxe_data with map size 134217728 KB (LMDB v2) 15:56:16 [15:56:16.545] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:56:16 [15:56:16.591] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:16 [15:56:16.883] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:16 [15:56:16.885] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:16 [15:56:16.923] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:56:16 [15:56:16.924] INFO: pxe:service Started PXE connected to chain 31337 version 2399585236 15:56:16 [15:56:16.982] INFO: pxe:service Registered account 0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123 15:56:17 [15:56:17.054] WARN: pxe:service No artifact found for contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 when looking for its metadata 15:56:17 [15:56:17.058] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 as part of deployment for 0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123 15:56:17 [15:56:17.173] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:17 [15:56:17.174] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:17 [15:56:17.183] WARN: sequencer:block-builder Error closing forks for block processing {"generatedMessage":false,"code":"ERR_ASSERTION","actual":false,"expected":true,"operator":"=="} 15:56:17 [15:56:17.248] INFO: pxe:service Added contract SchnorrAccount at 0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123 with class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 15:56:17 [15:56:17.275] VERBOSE: pxe:block_stream Starting sync from block number 0 15:56:17 [15:56:17.319] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:56:17 [15:56:17.413] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:56:18 [15:56:18.031] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284,0x290a48e538e9392add98e2100e7a62cfbd47f755ac046f9cc9b55c24fe79091f,0x1d9edc9e571a9e7ab4d2aa454dd024ee819579e3e22ae0fadf28089b29f3f0bc,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:56:18 [15:56:18.168] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:56:18 [15:56:18.238] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:18 [15:56:18.261] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:18 [15:56:18.386] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123"} 15:56:18 [15:56:18.469] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:18 [15:56:18.481] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:56:18 [15:56:18.482] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123"} 15:56:18 [15:56:18.532] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:18 [15:56:18.579] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123"} 15:56:18 [15:56:18.586] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:56:18 [15:56:18.700] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:18 [15:56:18.836] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123"} 15:56:18 [15:56:18.902] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:56:18 [15:56:18.902] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123"} 15:56:18 [15:56:18.912] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:18 [15:56:18.944] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:19 [15:56:19.005] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123"} 15:56:19 [15:56:19.009] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:56:19 [15:56:19.023] VERBOSE: simulator:client_execution_context:debug_log Setting 0x06698932d877db0323946fb917b756122522f58b4b917e94b19f414de51ae123 as fee payer 15:56:19 [15:56:19.179] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:19 [15:56:19.290] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:19 [15:56:19.447] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:19 [15:56:19.642] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:19 [15:56:19.822] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:19 [15:56:19.965] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:20 [15:56:20.430] INFO: pxe:service Proving completed in 3156.3647950000013ms {"timings":{"total":3156.3647950000013,"sync":1.8985290000018722,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":173.85996500000692,"oracles":{"callPrivateFunction":{"times":[896.5059599999986,456.4188950000025,340.2161589999996]}}},{"functionName":"private_kernel_init","time":73.74976400000014},{"functionName":"ContractClassRegisterer:register","time":871.9018239999969,"oracles":{"loadCapsule":{"times":[6.975891000001866]},"notifyCreatedNullifier":{"times":[0.5766629999998258]},"debugLog":{"times":[0.6090249999979278]},"notifyCreatedContractClassLog":{"times":[14.393577999999252]}}},{"functionName":"private_kernel_inner","time":144.37734900000214},{"functionName":"SchnorrAccount:constructor","time":408.764733,"oracles":{"getContractInstance":{"times":[17.580050999997184]},"debugLog":{"times":[0.706079999999929,0.4546359999985725]},"fetchTaggedLogs":{"times":[101.61133800000243]},"loadCapsule":{"times":[0.2726550000006682,0.2443840000014461,0.2683450000004086]},"validateEnqueuedNotes":{"times":[1.8614070000003267]},"notifyCreatedNullifier":{"times":[0.21175199999925098,0.23570399999880465]},"notifyCreatedNote":{"times":[0.6994200000008277]},"getRandomField":{"times":[0.16829999999754364,0.2593639999977313,0.0738950000013574,0.05760299999747076,0.0625240000008489,0.05693299999984447,0.05549400000018068,0.05288300000029267,0.05987300000197138,0.06517400000302587,0.05293300000266754]},"getIndexedTaggingSecretAsSender":{"times":[47.22969799999919]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.324627000001783]}}},{"functionName":"private_kernel_inner","time":158.62667800000054},{"functionName":"SchnorrAccount:entrypoint","time":292.03515499999776,"oracles":{"debugLog":{"times":[0.7141009999977541,0.44265599999926053,0.5086489999994228]},"fetchTaggedLogs":{"times":[105.34219200000007]},"loadCapsule":{"times":[0.21009199999753037,0.16992000000027474,0.20207100000334322]},"validateEnqueuedNotes":{"times":[0.7197909999995318]},"getNotes":{"times":[1.5409579999977723]},"getAuthWitness":{"times":[0.23142399999778718]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5872739999977057]}}},{"functionName":"private_kernel_inner","time":146.1484700000001},{"functionName":"private_kernel_reset","time":201.69259600000078},{"functionName":"private_kernel_tail","time":100.24643900000228}],"unaccounted":583.063292999992}} 15:56:20 [15:56:20.449] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:20 [15:56:20.532] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1","blockNumber":1,"slot":2} 15:56:20 [15:56:20.540] VERBOSE: p2p:tx_pool Adding tx 0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592 to pool {"eventName":"tx-added-to-pool","txHash":"0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:56:20 [15:56:20.561] INFO: node Received tx 0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592 {"txHash":"0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592"} 15:56:20 [15:56:20.562] INFO: pxe:service Sent transaction 0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592 15:56:20 [15:56:20.659] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:20 [15:56:20.756] VERBOSE: sequencer:block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-04T16:01:02.000Z","now":"2025-06-04T16:00:54.640Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000},"txPublicSetupAllowList":[{"address":"0x0000000000000000000000000000000000000000000000000000000000000001"},{"address":"0x0000000000000000000000000000000000000000000000000000000000000005"},{"classId":"0x1039bc996b6808cb1b90c68b723a34af1883ab5ef692eb0702d3af85e956ea8d"},{"classId":"0x0318e775c9181ca9feb9de489bdbb70959b35be41d23316762899211ab3a3265"}]}} 15:56:20 [15:56:20.810] VERBOSE: simulator:public-processor Processed tx 0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592 with no public calls in 26.466652999999496ms {"txHash":"0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592","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":26.466652999999496} 15:56:20 [15:56:20.817] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.058948861999997465s {"duration":0.058948861999997465,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 15:56:20 [15:56:20.915] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:20 [15:56:20.925] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x285f930db2b62388577e89bd55743959441ba0333a1600eb3a15a121c3f37d9b","globalVariables":{"chainId":31337,"version":2399585236,"blockNumber":1,"slotNumber":2,"timestamp":1749052862,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x064b2df661eadd0fa1cfe5ed1587018e1372234c31bddf68dbe4e9a582abe592"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":175.56291299999793,"publicProcessDuration":59.51089499999944,"rollupCircuitsDuration":169.90497700000196,"txCount":1,"blockNumber":1,"blockTimestamp":1749052862,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:56:20 [15:56:20.929] VERBOSE: sequencer Attesting committee is empty 15:56:21 [15:56:21.122] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:21 [15:56:21.317] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xd08dd2a2232258c01cf8dfe027a3dd039ae55c7e885799b648208a0b5853e5b6 15:56:21 [15:56:21.317] VERBOSE: node Sent L1 transaction 0xd08dd2a2232258c01cf8dfe027a3dd039ae55c7e885799b648208a0b5853e5b6 {"gasLimit":555040,"maxFeePerGas":"79.605134257","maxPriorityFeePerGas":"79.496847177","maxFeePerBlobGas":"0.000000001"} 15:56:21 [15:56:21.328] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:21 [15:56:21.331] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:56:21 [15:56:21.331] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xd08dd2a2232258c01cf8dfe027a3dd039ae55c7e885799b648208a0b5853e5b6","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1749052862,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:56:21 [15:56:21.332] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:56:21 [15:56:21.341] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:56:21 [15:56:21.342] WARN: foundation:test-date-provider Time set to 2025-06-04T16:01:02.000Z {"offset":280658,"timeMs":1749052862000} 15:56:21 [15:56:21.342] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 15:56:21 [15:56:21.344] INFO: blob-sink:server Received blob sidecar for block 0x87a64ad3133d6fb9d9164a856ec10818ccc1c2ff41ac018ff2c366dc5286f8d4 15:56:21 [15:56:21.347] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:56:21 [15:56:21.352] INFO: blob-sink:server Blob sidecar stored successfully for block 0x87a64ad3133d6fb9d9164a856ec10818ccc1c2ff41ac018ff2c366dc5286f8d4 15:56:21 [15:56:21.353] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:56:21 [15:56:21.515] VERBOSE: archiver:block-helper:prover-node Store contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 15:56:21 [15:56:21.670] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:56:21 [15:56:21.683] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x285f930db2b62388577e89bd55743959441ba0333a1600eb3a15a121c3f37d9b","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2399585236,"blockNumber":1,"slotNumber":2,"timestamp":1749052862,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2aafdc775dddafc20963b139468c1913648955a88a59d32aedffbcabf4e093d4","archiveNextLeafIndex":2} 15:56:21 [15:56:21.692] VERBOSE: archiver:block-helper Store contract class 0x0c0dce911596a2731ea1d1c335e303de5491715dccbbe54960f0a1120d6a3284 15:56:21 [15:56:21.712] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x285f930db2b62388577e89bd55743959441ba0333a1600eb3a15a121c3f37d9b","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2399585236,"blockNumber":1,"slotNumber":2,"timestamp":1749052862,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2aafdc775dddafc20963b139468c1913648955a88a59d32aedffbcabf4e093d4","archiveNextLeafIndex":2} 15:56:21 [15:56:21.717] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749052898] on http://127.0.0.1:8545 15:56:21 [15:56:21.719] INFO: archiver:prover-node Updated proven chain to block 1 {"provenBlockNumber":1} 15:56:21 [15:56:21.726] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:56:21 [15:56:21.732] VERBOSE: sequencer Unable to build/enqueue block Rollup__InvalidArchive(0x2aafdc775dddafc20963b139468c1913648955a88a59d32aedffbcabf4e093d4, 0x02a6b33581cf5833e6f96c3c4dd9b9a24733761c3e02a5843b62a3539f5f0bc1) 15:56:21 [15:56:21.734] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749052898 15:56:21 [15:56:21.734] WARN: foundation:test-date-provider Time set to 2025-06-04T16:01:38.000Z {"offset":316266,"timeMs":1749052898000} 15:56:21 [15:56:21.735] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:56:21 [15:56:21.735] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:56:21 [15:56:21.835] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749055202] on http://127.0.0.1:8545 15:56:21 [15:56:21.838] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:56:21 [15:56:21.841] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749055202 15:56:21 [15:56:21.861] INFO: node Stopping 15:56:21 [15:56:21.863] INFO: slasher Slasher client stopped. 15:56:21 [15:56:21.864] INFO: sequencer Stopped sequencer 15:56:21 [15:56:21.864] INFO: p2p P2P client stopped. 15:56:21 [15:56:21.866] INFO: world_state Stopped world state synchronizer 15:56:21 [15:56:21.866] INFO: archiver Stopped. 15:56:21 [15:56:21.866] INFO: node Stopped 15:56:21 [15:56:21.867] INFO: prover-node:prover-node Stopping ProverNode 15:56:21 [15:56:21.867] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 15:56:21 [15:56:21.867] INFO: archiver:prover-node Stopped. 15:56:21 [15:56:21.868] INFO: world_state:prover-node Stopped world state synchronizer 15:56:21 [15:56:21.868] INFO: prover-node:prover-node Stopped ProverNode 15:56:21 [15:56:21.868] VERBOSE: e2e:e2e_multi_validator_node Cleaning up ACVM state 15:56:21 [15:56:21.868] INFO: e2e:e2e_multi_validator_node Cleaning up ACVM temp directory /tmp/ddd885ff 15:56:21 [15:56:21.869] VERBOSE: e2e:e2e_multi_validator_node Cleaning up BB state 15:56:21 [15:56:21.871] INFO: blob-sink:server Stopping blob sink 15:56:21 [15:56:21.872] INFO: blob-sink:server Blob sink stopped 15:56:21 [15:56:21.872] VERBOSE: e2e:e2e_multi_validator_node Cleaning up data directory at /tmp/84c71aed097fb4b5 15:56:21 FAIL src/e2e_multi_validator_node.test.ts 15:56:21 e2e_multi_validator_node 15:56:21 ✓ should build blocks & attest with multiple validator keys (16861 ms) 15:56:21 ✕ should attest ONLY with the correct validator keys (7744 ms) 15:56:21 15:56:21 ● e2e_multi_validator_node › should attest ONLY with the correct validator keys 15:56:21 15:56:21 ContractFunctionExecutionError: The contract function "initiateWithdraw" reverted. 15:56:21 15:56:21 Error: Staking__NothingToExit(address) 15:56:21 (0x15d34AAf54267DB7D7c367839AAf71A00a2C6A65) 15:56:21 15:56:21 Contract Call: 15:56:21 address: 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 15:56:21 function: initiateWithdraw(address _attester, address _recipient) 15:56:21 args: (0x15d34aaf54267db7d7c367839aaf71a00a2c6a65, 0x15d34aaf54267db7d7c367839aaf71a00a2c6a65) 15:56:21 sender: 0x15d34AAf54267DB7D7c367839AAf71A00a2C6A65 15:56:21 15:56:21 Docs: https://viem.sh/docs/contract/writeContract 15:56:21 Version: viem@2.23.7 15:56:21 15:56:21 142 | client: createExtendedL1Client(config.l1RpcUrls, initialValidatorPrivateKeys[VALIDATOR_COUNT - 1]), 15:56:21 143 | }); 15:56:21 > 144 | await rollupContract1.write.initiateWithdraw([ 15:56:21 | ^ 15:56:21 145 | validatorAddresses[VALIDATOR_COUNT - 1], 15:56:21 146 | validatorAddresses[VALIDATOR_COUNT - 1], 15:56:21 147 | ]); 15:56:21 15:56:21 at getContractError (../../node_modules/viem/utils/errors/getContractError.ts:78:10) 15:56:21 at writeContract (../../node_modules/viem/actions/wallet/writeContract.ts:208:11) 15:56:21 at Object.<anonymous> (e2e_multi_validator_node.test.ts:144:5) 15:56:21 15:56:21 Cause: 15:56:21 ContractFunctionRevertedError: The contract function "initiateWithdraw" reverted. 15:56:21 15:56:21 Error: Staking__NothingToExit(address) 15:56:21 (0x15d34AAf54267DB7D7c367839AAf71A00a2C6A65) 15:56:21 15:56:21 Version: viem@2.23.7 15:56:21 15:56:21 142 | client: createExtendedL1Client(config.l1RpcUrls, initialValidatorPrivateKeys[VALIDATOR_COUNT - 1]), 15:56:21 143 | }); 15:56:21 > 144 | await rollupContract1.write.initiateWithdraw([ 15:56:21 | ^ 15:56:21 145 | validatorAddresses[VALIDATOR_COUNT - 1], 15:56:21 146 | validatorAddresses[VALIDATOR_COUNT - 1], 15:56:21 147 | ]); 15:56:21 15:56:21 at ../../node_modules/viem/utils/errors/getContractError.ts:65:14 15:56:21 at getContractError (../../node_modules/viem/utils/errors/getContractError.ts:76:5) 15:56:21 at writeContract (../../node_modules/viem/actions/wallet/writeContract.ts:208:11) 15:56:21 at Object.<anonymous> (e2e_multi_validator_node.test.ts:144:5) 15:56:21 15:56:21 Test Suites: 1 failed, 1 total 15:56:21 Tests: 1 failed, 1 passed, 2 total 15:56:21 Snapshots: 0 total 15:56:21 Time: 31.826 s 15:56:21 Ran all test suites matching /src\/e2e_multi_validator_node.test.ts/i. 15:56:21 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?