Parent Log: http://ci.aztec-labs.com/6651d1742cbe3cdd Command: 1ec640ec363e58a6:ISOLATE=1:NAME=e2e_circuit_recorder yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_circuit_recorder.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/26c5a39fe03723d11540f721293d7aebd1f478d9 Env: REF_NAME=gh-readonly-queue/next/pr-14995-75d792847d8434a0c504e7adf5c102a913065272 CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Fri Jun 13 09:00:24 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-14995_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_45fa6151872caa8b_next 09:00:24 +++ id -u 09:00:24 +++ id -g 09:00:24 ++ docker run -d --name e2e_circuit_recorder --net=none --cpuset-cpus=0-63 --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_circuit_recorder.test.ts'\''' 09:00:24 + cid=cd1edc97dc0fd393b16574ce818c5dbd45d91a64b4a2d4e1f22c9b0883b81a12 09:00:24 + set +x 09:00:24 {"level":25,"time":1749805224867,"pid":12,"hostname":"cd1edc97dc0f","module":"logger","msg":"Logger initialized with level verbose"} 09:00:28 [09:00:28.950] INFO: e2e:e2e_circuit_recorder Running test: Circuit Recorder records circuit execution 09:00:29 [09:00:29.027] INFO: e2e:Circuit Logging metrics to log/Circuit.jsonl 09:00:29 [09:00:29.492] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-6MgGX1/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 09:00:29 [09:00:29.528] INFO: e2e:Circuit Calling anvil_setBlockTimestampInterval with params: [12] 09:00:29 [09:00:29.549] WARN: e2e:Circuit Set block interval to 12 09:00:29 [09:00:29.549] VERBOSE: e2e:Circuit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 09:00:29 [09:00:29.595] VERBOSE: e2e:Circuit Sent L1 transaction 0x5f6007147b276ec3270f42c9cc4c2453661a1882dd03ebb0a7663e0351326302 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 09:00:29 [09:00:29.603] VERBOSE: e2e:Circuit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 09:00:29 [09:00:29.619] VERBOSE: e2e:Circuit Sent L1 transaction 0xaf47cdb235bd1f13781af7e220955c2cdc0e084c2ebf03be2e261fd9e4cd20e4 {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 09:00:29 [09:00:29.624] VERBOSE: e2e:Circuit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 09:00:29 [09:00:29.641] VERBOSE: e2e:Circuit Sent L1 transaction 0x127d08cafb8afc3d7c988fa49d05483d6d2b44a017de0544d9d53ed8e954f028 {"gasLimit":3068916,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 09:00:29 [09:00:29.646] VERBOSE: e2e:Circuit Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 09:00:29 [09:00:29.660] VERBOSE: e2e:Circuit Sent L1 transaction 0xdb9612b2166822d6497afb75ab3fe675145b118f9d3ef58bc23bdb9816e5d0f5 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 09:00:29 [09:00:29.664] VERBOSE: e2e:Circuit Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 09:00:29 [09:00:29.682] VERBOSE: e2e:Circuit Sent L1 transaction 0x32ed4059fca555e8be9e05117cb7e979fafb635b31d08729d246c0704eaa1138 {"gasLimit":1966612,"maxFeePerGas":"3.602497631","maxPriorityFeePerGas":"2.48832"} 09:00:29 [09:00:29.686] VERBOSE: e2e:Circuit Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 09:00:29 [09:00:29.702] VERBOSE: e2e:Circuit Sent L1 transaction 0xf29078d6fdb1fd1334c85ea0a8f17d2b4c4766e863a0822c2fb665091b723499 {"gasLimit":3042380,"maxFeePerGas":"3.968738902","maxPriorityFeePerGas":"2.985984"} 09:00:29 [09:00:29.706] VERBOSE: e2e:Circuit Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 09:00:29 [09:00:29.716] VERBOSE: e2e:Circuit Sent L1 transaction 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 {"gasLimit":100000,"maxFeePerGas":"4.456512857","maxPriorityFeePerGas":"3.5831808"} 09:00:29 [09:00:29.717] VERBOSE: e2e:Circuit Set governance on GSE in 0xb1ee83a7dc467ba966679060fa6683b6cb0ae294ddd576326f77273f9fd15167 09:00:29 [09:00:29.728] VERBOSE: e2e:Circuit Sent L1 transaction 0xd7c909c2f426dbb387bba51539e35cd537bbd9383154eb2618179b00ef0008b2 {"gasLimit":391705,"maxFeePerGas":"5.082433956","maxPriorityFeePerGas":"4.29981696"} 09:00:29 [09:00:29.732] VERBOSE: e2e:Circuit Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 09:00:29 [09:00:29.732] VERBOSE: e2e:Circuit Waiting for deployments to complete 09:00:29 [09:00:29.733] INFO: e2e:Circuit Waiting for 7 transactions to be mined... 09:00:29 [09:00:29.754] INFO: e2e:Circuit All transactions mined successfully 09:00:29 [09:00:29.766] VERBOSE: e2e:Circuit Sent L1 transaction 0x50623955002e1e57158f557090a59024971ab40a20dee71f36c8bea1ae79dcca {"gasLimit":100000,"maxFeePerGas":"5.844872118","maxPriorityFeePerGas":"5.159780352"} 09:00:29 [09:00:29.767] VERBOSE: e2e:Circuit Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x50623955002e1e57158f557090a59024971ab40a20dee71f36c8bea1ae79dcca 09:00:29 [09:00:29.780] VERBOSE: e2e:Circuit Sent L1 transaction 0x7ef4acce2d29fb2e046cebc7a8a26e7c7540e156376f7b1c5bb5b863cbe564c3 {"gasLimit":56661,"maxFeePerGas":"6.793055288","maxPriorityFeePerGas":"6.191736422"} 09:00:29 [09:00:29.792] VERBOSE: e2e:Circuit Sent L1 transaction 0xb25c5ab4294e8fbc0c9624e56aa31ec351526cb6af6350c11417f282dd0f9bd3 {"gasLimit":339705,"maxFeePerGas":"7.956474918","maxPriorityFeePerGas":"7.430083706"} 09:00:29 [09:00:29.796] VERBOSE: e2e:Circuit Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 09:00:29 [09:00:29.807] VERBOSE: e2e:Circuit Sent L1 transaction 0x08a4b0382909196399efe606a9ab1253db3a33421ff5f1c3d76a1d9d2ca06484 {"gasLimit":56804,"maxFeePerGas":"9.376899884","maxPriorityFeePerGas":"8.916100447"} 09:00:29 [09:00:29.808] VERBOSE: e2e:Circuit Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0x08a4b0382909196399efe606a9ab1253db3a33421ff5f1c3d76a1d9d2ca06484 09:00:29 [09:00:29.824] VERBOSE: e2e:Circuit Sent L1 transaction 0xf9401b33d177baeffffb49aad9037387d78c09beb9e9ec7ba1d3f2570522b753 {"gasLimit":2474287,"maxFeePerGas":"11.103607102","maxPriorityFeePerGas":"10.699320536"} 09:00:29 [09:00:29.829] VERBOSE: e2e:Circuit Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 09:00:29 [09:00:29.839] VERBOSE: e2e:Circuit Sent L1 transaction 0x28e1ecce4a1baaa32ca177534485a033b735c7dcb2864165719cbade0787fac3 {"gasLimit":56804,"maxFeePerGas":"13.193094869","maxPriorityFeePerGas":"12.839184643"} 09:00:29 [09:00:29.840] VERBOSE: e2e:Circuit Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x28e1ecce4a1baaa32ca177534485a033b735c7dcb2864165719cbade0787fac3 09:00:29 [09:00:29.840] VERBOSE: e2e:Circuit Waiting for deployments to complete 09:00:29 [09:00:29.840] INFO: e2e:Circuit Waiting for 9 transactions to be mined... 09:00:29 [09:00:29.862] INFO: e2e:Circuit All transactions mined successfully 09:00:29 [09:00:29.873] VERBOSE: e2e:Circuit Deployed shared contracts 09:00:29 [09:00:29.888] VERBOSE: e2e:Circuit Sent L1 transaction 0x32fc7527e2716a4d58ec1bdeb099b80d5244cd705c9519555b6b565b7ba2a111 {"gasLimit":84837,"maxFeePerGas":"15.722774098","maxPriorityFeePerGas":"15.407021571"} 09:00:29 [09:00:29.888] VERBOSE: e2e:Circuit Funded reward distributor with 10000000000000000000000000 fee asset in 0x32fc7527e2716a4d58ec1bdeb099b80d5244cd705c9519555b6b565b7ba2a111 09:00:29 [09:00:29.901] VERBOSE: e2e:Circuit Sent L1 transaction 0xdef66310c9d0b7dd201d14d81f0afe9cb0a7a1bcdfb3985c400aaac3112b99a8 {"gasLimit":152965,"maxFeePerGas":"18.764833904","maxPriorityFeePerGas":"18.488425885"} 09:00:29 [09:00:29.905] VERBOSE: e2e:Circuit Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 09:00:29 [09:00:29.905] VERBOSE: e2e:Circuit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 09:00:29 [09:00:29.916] VERBOSE: e2e:Circuit Sent L1 transaction 0xa30936656c85bd30a140fccee2cc68506bbb2794b4d16485d9d2cef61cfec969 {"gasLimit":86383,"maxFeePerGas":"22.428130924","maxPriorityFeePerGas":"22.186111062"} 09:00:29 [09:00:29.937] VERBOSE: e2e:Circuit Sent L1 transaction 0xbe78ed180cb67f2324e0f55f5bcf89cc6f9feb261fdc97fb4688481193c42049 {"gasLimit":5075920,"maxFeePerGas":"26.835357743","maxPriorityFeePerGas":"26.623333274"} 09:00:29 [09:00:29.958] VERBOSE: e2e:Circuit Sent L1 transaction 0xadefaa698fbe2ccad8b7262edf757f1bbec31f893ad6df9dc23634f426ba2e27 {"gasLimit":2439043,"maxFeePerGas":"32.133648528","maxPriorityFeePerGas":"31.947999928"} 09:00:29 [09:00:29.963] VERBOSE: e2e:Circuit Awaiting for linked libraries to be deployed 09:00:29 [09:00:30.000] VERBOSE: e2e:Circuit Sent L1 transaction 0xabd144be8939e4a1d16a5c53d32e8ed43b2077d26e41a87771d5b7d24a6dcfef {"gasLimit":10498896,"maxFeePerGas":"38.506586449","maxPriorityFeePerGas":"38.337599913"} 09:00:30 [09:00:30.005] VERBOSE: e2e:Circuit Deployed Rollup at 0x3aa5ebb10dc797cac828524e59a333d0a371443c {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 09:00:30 [09:00:30.006] INFO: e2e:Circuit Waiting for 11 transactions to be mined... 09:00:30 [09:00:30.031] INFO: e2e:Circuit All transactions mined successfully 09:00:30 [09:00:30.031] VERBOSE: e2e:Circuit All core contracts have been deployed 09:00:30 [09:00:30.044] VERBOSE: e2e:Circuit Sent L1 transaction 0x0a0174e8d0005aa9a9551eee71e39afebdb2de9976dcbd47f8af4f474230fcb2 {"gasLimit":64317,"maxFeePerGas":"46.155845375","maxPriorityFeePerGas":"46.005119895"} 09:00:30 [09:00:30.045] VERBOSE: e2e:Circuit Funding fee juice portal with 10000000000000000000000 fee juice in 0x0a0174e8d0005aa9a9551eee71e39afebdb2de9976dcbd47f8af4f474230fcb2 (accelerated test deployments) 09:00:30 [09:00:30.056] VERBOSE: e2e:Circuit Sent L1 transaction 0x6a926be81b73dd91dae704702483da1c551ca87b055c30c4ea85773cbb8c17f2 {"gasLimit":1040131,"maxFeePerGas":"55.349017914","maxPriorityFeePerGas":"55.206143874"} 09:00:30 [09:00:30.060] VERBOSE: e2e:Circuit Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 09:00:30 [09:00:30.079] VERBOSE: e2e:Circuit Sent L1 transaction 0x0acdf75a39c0fe97fc7d072ffe5aed05f55df6cc237b6d433d4708e019236c9a {"gasLimit":116846,"maxFeePerGas":"66.372451249","maxPriorityFeePerGas":"66.247372648"} 09:00:30 [09:00:30.079] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x0acdf75a39c0fe97fc7d072ffe5aed05f55df6cc237b6d433d4708e019236c9a 09:00:30 [09:00:30.093] VERBOSE: e2e:Circuit Sent L1 transaction 0x1019a21ee117e4e7e203f44054937179d452ee7dc01f25842f0b0ed5d9ffb02e {"gasLimit":109478,"maxFeePerGas":"79.607194411","maxPriorityFeePerGas":"79.496847177"} 09:00:30 [09:00:30.093] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x1019a21ee117e4e7e203f44054937179d452ee7dc01f25842f0b0ed5d9ffb02e 09:00:30 [09:00:30.097] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 09:00:30 [09:00:30.122] INFO: e2e:Circuit All transactions mined successfully 09:00:30 [09:00:30.128] VERBOSE: e2e:Circuit Rollup deployed 09:00:30 [09:00:30.128] VERBOSE: e2e:Circuit Waiting for rollup and slash factory to be deployed 09:00:30 [09:00:30.128] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 09:00:30 [09:00:30.151] INFO: e2e:Circuit All transactions mined successfully 09:00:30 [09:00:30.152] VERBOSE: e2e:Circuit All transactions for L1 deployment have been mined 09:00:30 [09:00:30.168] INFO: e2e:Circuit Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 09:00:30 [09:00:30.168] INFO: e2e:Circuit Handing over to governance 09:00:30 [09:00:30.177] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 09:00:30 [09:00:30.177] INFO: telemetry:client Using NoopTelemetryClient 09:00:30 [09:00:30.182] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:00:30 [09:00:30.183] WARN: foundation:test-date-provider Time set to 2025-06-13T09:05:17.000Z {"offset":286817,"timeMs":1749805517000} 09:00:30 [09:00:30.183] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/5408b6069acf70b0/blob-sink with map size 134217728 KB (LMDB v2) 09:00:30 [09:00:30.188] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 09:00:30 [09:00:30.193] INFO: blob-sink:server Server is running on http://localhost:42819 09:00:30 [09:00:30.193] VERBOSE: e2e:Circuit Creating and synching an aztec node... 09:00:30 [09:00:30.194] VERBOSE: e2e:Circuit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/d7602ab7/acvm 09:00:30 [09:00:30.194] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42819"} 09:00:30 [09:00:30.215] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 09:00:30 [09:00:30.215] INFO: archiver:lmdb Creating archiver data store at directory /tmp/5408b6069acf70b0/archiver with map size 134217728 KB (LMDB v2) 09:00:30 [09:00:30.216] INFO: archiver:lmdb Starting data store with maxReaders 16 09:00:30 [09:00:30.505] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:42819"} 09:00:30 [09:00:30.519] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:42819"} 09:00:30 [09:00:30.519] WARN: node:blob-sink:client No L1 consensus host urls configured 09:00:30 [09:00:30.520] WARN: node:blob-sink:client No archive client configured 09:00:30 [09:00:30.522] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x3cc1a10ca2440e97f02667b6922d01c3706590e0480e02a9a19fd325f637faf2 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x6abbcaeffabc304e705fb07b05f48c7c86d15035c6fb5514836ff473aa19e178","l1BlockNumber":20}} 09:00:30 [09:00:30.535] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x3cc1a10ca2440e97f02667b6922d01c3706590e0480e02a9a19fd325f637faf2","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:00:30 [09:00:30.539] INFO: world-state:database Creating world state data store at directory /tmp/5408b6069acf70b0/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 09:00:30 [09:00:30.560] INFO: world_state Created world state synchroniser with block history of 64 09:00:30 [09:00:30.561] WARN: node Aztec node is accepting fake proofs 09:00:30 [09:00:30.570] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/5408b6069acf70b0/p2p with map size 134217728 KB (LMDB v2) 09:00:30 [09:00:30.571] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 09:00:30 [09:00:30.572] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/5408b6069acf70b0/p2p-archive with map size 134217728 KB (LMDB v2) 09:00:30 [09:00:30.573] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 09:00:30 [09:00:30.574] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/5408b6069acf70b0/p2p-peers with map size 134217728 KB (LMDB v2) 09:00:30 [09:00:30.575] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 09:00:30 [09:00:30.576] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 09:00:30 [09:00:30.576] VERBOSE: p2p P2P is disabled. Using dummy P2P service 09:00:30 [09:00:30.579] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 09:00:30 [09:00:30.579] INFO: world_state Started world state synchronizer from block 1 09:00:30 [09:00:30.582] VERBOSE: world-state:block_stream Starting sync from block number 0 09:00:30 [09:00:30.583] INFO: p2p Starting p2p client from block 0 with empty mempools 09:00:30 [09:00:30.583] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 09:00:30 [09:00:30.814] INFO: epoch-prune-watcher EpochPruneWatcher initialized 09:00:30 [09:00:30.848] VERBOSE: validator Initialized validator with addresses: 0x1ecfaefc29ebfc6c8ee3fd2a61b63b5aab3bed4c 09:00:30 [09:00:30.848] VERBOSE: node All Aztec Node subsystems synced 09:00:30 [09:00:30.861] INFO: slasher Starting Slasher client... 09:00:30 [09:00:30.870] INFO: sequencer-client Deploying forwarder contract 09:00:30 [09:00:30.872] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 09:00:30 [09:00:30.888] VERBOSE: sequencer-client Sent L1 transaction 0x864850f8ffc128a17e70ea6cef66d26c8919aaaae5fe5c53ab1c47d0444d3ffb {"gasLimit":323704,"maxFeePerGas":"95.492859983","maxPriorityFeePerGas":"95.396216612"} 09:00:30 [09:00:30.889] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0x864850f8ffc128a17e70ea6cef66d26c8919aaaae5fe5c53ab1c47d0444d3ffb. 09:00:30 [09:00:30.893] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 09:00:30 [09:00:30.900] INFO: validator Started validator with addresses: 0x1ecfaefc29ebfc6c8ee3fd2a61b63b5aab3bed4c 09:00:30 [09:00:30.900] VERBOSE: validator Validators 0x1ecfaefc29ebfc6c8ee3fd2a61b63b5aab3bed4c are not on the validator committee for epoch 0 09:00:30 [09:00:30.901] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/d7602ab7/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 09:00:30 [09:00:30.901] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 09:00:30 [09:00:30.903] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:00:30 [09:00:30.903] INFO: node Aztec Node version: 0.87.6 09:00:30 [09:00:30.904] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x59b670e9fa9d0a427751af201d676719a970857b","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 09:00:30 [09:00:30.904] VERBOSE: e2e:Circuit Creating a pxe... 09:00:30 [09:00:30.910] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/ab711468d6cdc133/pxe_data with map size 134217728 KB (LMDB v2) 09:00:30 [09:00:30.913] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:00:30 [09:00:30.914] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:00:31 [09:00:31.096] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:00:31 [09:00:31.096] WARN: foundation:test-date-provider Time set to 2025-06-13T09:05:29.000Z {"offset":297904,"timeMs":1749805529000} 09:00:31 [09:00:31.200] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 09:00:31 [09:00:31.201] INFO: pxe:service Started PXE connected to chain 31337 version 4042478560 09:00:31 [09:00:31.248] INFO: pxe:service Registered account 0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14 09:00:31 [09:00:31.302] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 09:00:31 [09:00:31.304] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14 09:00:31 [09:00:31.439] INFO: pxe:service Added contract SchnorrAccount at 0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:00:31 [09:00:31.457] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:31 [09:00:31.460] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:31 [09:00:31.485] VERBOSE: pxe:block_stream Starting sync from block number 0 09:00:31 [09:00:31.524] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 09:00:31 [09:00:31.627] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 09:00:32 [09:00:32.095] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 09:00:32 [09:00:32.174] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 09:00:32 [09:00:32.176] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:32 [09:00:32.177] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:32 [09:00:32.315] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14"} 09:00:32 [09:00:32.364] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:00:32 [09:00:32.366] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14"} 09:00:32 [09:00:32.402] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14"} 09:00:32 [09:00:32.407] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:00:32 [09:00:32.578] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14"} 09:00:32 [09:00:32.621] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:00:32 [09:00:32.623] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14"} 09:00:32 [09:00:32.656] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14"} 09:00:32 [09:00:32.660] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:00:32 [09:00:32.679] VERBOSE: simulator:client_execution_context:debug_log Setting 0x139433a8121e8e68d3a77e6accc78c36d71b065fd1d001a08340318e664a1d14 as fee payer 09:00:32 [09:00:32.740] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:32 [09:00:32.746] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:33 [09:00:33.278] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:33 [09:00:33.318] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:33 [09:00:33.861] INFO: pxe:service Proving completed in 2377.4542380000003ms {"timings":{"total":2377.4542380000003,"sync":2.262735999999677,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":165.12096300000212,"oracles":{"callPrivateFunction":{"times":[664.2140169999993,264.70118999999977,232.8207450000009]}}},{"functionName":"private_kernel_init","time":113.33818500000052},{"functionName":"ContractClassRegisterer:register","time":646.0682479999987,"oracles":{"loadCapsule":{"times":[73.07887500000015]},"notifyCreatedNullifier":{"times":[0.5892519999997603]},"debugLog":{"times":[0.8713189999998576]},"notifyCreatedContractClassLog":{"times":[7.642289000000346]}}},{"functionName":"private_kernel_inner","time":131.51325799999904},{"functionName":"SchnorrAccount:constructor","time":237.91441000000032,"oracles":{"getContractInstance":{"times":[2.5731329999998707]},"debugLog":{"times":[0.4653260000004593,0.4349979999997231]},"fetchTaggedLogs":{"times":[38.55289100000027]},"loadCapsule":{"times":[0.4170959999992192,0.2632849999999962,0.25187300000015966]},"validateEnqueuedNotesAndEvents":{"times":[1.822943999999552]},"notifyCreatedNullifier":{"times":[0.22087899999951333,0.24491800000032526]},"notifyCreatedNote":{"times":[0.5008499999994456]},"getRandomField":{"times":[0.21700800000053277,0.15633900000011636,0.11095399999976507,0.0901160000003074,0.0890479999998206,0.1421570000002248,0.1513230000000476,0.08914699999968434,0.08605600000009872,0.10051500000008673,0.08370199999990291]},"getIndexedTaggingSecretAsSender":{"times":[30.531488000000536]},"incrementAppTaggingSecretIndexAsSender":{"times":[24.509231]}}},{"functionName":"private_kernel_inner","time":112.30499099999906},{"functionName":"SchnorrAccount:entrypoint","time":205.9286830000001,"oracles":{"debugLog":{"times":[0.48330600000008417,0.3955359999999928,0.6110370000005787]},"fetchTaggedLogs":{"times":[35.39776400000119]},"loadCapsule":{"times":[0.2312899999997171,0.20945599999868136,0.27381100000093284]},"validateEnqueuedNotesAndEvents":{"times":[1.9784949999993842]},"getNotes":{"times":[1.8050189999994473]},"getAuthWitness":{"times":[0.42188199999873177]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.918152000000191]}}},{"functionName":"private_kernel_inner","time":109.83712599999853},{"functionName":"private_kernel_reset","time":190.5215079999998},{"functionName":"private_kernel_tail","time":74.69139899999936}],"unaccounted":387.95273100000304}} 09:00:33 [09:00:33.940] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:33 [09:00:33.941] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:33 [09:00:33.941] VERBOSE: p2p:tx_pool Adding tx 0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3 to pool {"eventName":"tx-added-to-pool","txHash":"0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 09:00:33 [09:00:33.961] INFO: node Received tx 0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3 {"txHash":"0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3"} 09:00:33 [09:00:33.961] INFO: pxe:service Sent transaction 0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3 09:00:34 [09:00:34.449] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"chainTipArchive":"0x29d73118cc668ab3ea0ba005ba30e0c43db709dafadde0fff2dc248df873c793","blockNumber":1,"slot":2} 09:00:34 [09:00:34.461] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-13T09:05:41.000Z","now":"2025-06-13T09:05:32.365Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:00:34 [09:00:34.504] VERBOSE: simulator:public-processor Processed tx 0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3 with no public calls in 20.72604499999943ms {"txHash":"0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3","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":20.72604499999943} 09:00:34 [09:00:34.505] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.042129006999999545s {"duration":0.042129006999999545,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:00:34 [09:00:34.530] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x05804049c4a3e8fc15e5d87b9289dba22122fb27cee8f54f63576e3ebf6fd7f7","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"txHashes":["0x2ce20a8f3df0479a46e13045e7e65f7038a0bcf5db2505a230a89d5f66ac7df3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":75.33824099999947,"publicProcessDuration":42.86457199999859,"rollupCircuitsDuration":69.05710199999885,"txCount":1,"blockNumber":1,"blockTimestamp":1749805541,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:00:34 [09:00:34.532] VERBOSE: sequencer Attesting committee is empty 09:00:37 [09:00:37.230] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x726b8217f108643c01218d9784869a57737b65c3af04d8d39ea9db8bfd6ea755 09:00:37 [09:00:37.230] VERBOSE: node Sent L1 transaction 0x726b8217f108643c01218d9784869a57737b65c3af04d8d39ea9db8bfd6ea755 {"gasLimit":487012,"maxFeePerGas":"114.56009636","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 09:00:37 [09:00:37.241] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:00:37 [09:00:37.241] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x726b8217f108643c01218d9784869a57737b65c3af04d8d39ea9db8bfd6ea755","calldataSize":1252,"calldataGas":9964,"txCount":1,"blockNumber":1,"blockTimestamp":1749805541,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:00:37 [09:00:37.242] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:00:37 [09:00:37.256] INFO: blob-sink:server Received blob sidecar for block 0x315318c16dec17e654ecfabbf0faeb3f00bf1cc42704fbb67b7679ceff362b96 09:00:37 [09:00:37.260] INFO: blob-sink:server Blob sidecar stored successfully for block 0x315318c16dec17e654ecfabbf0faeb3f00bf1cc42704fbb67b7679ceff362b96 09:00:37 [09:00:37.291] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749805577 09:00:37 [09:00:37.292] WARN: foundation:test-date-provider Time set to 2025-06-13T09:06:17.000Z {"offset":339708,"timeMs":1749805577000} 09:00:37 [09:00:37.292] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 09:00:37 [09:00:37.416] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 09:00:37 [09:00:37.418] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 09:00:37 [09:00:37.566] VERBOSE: archiver:block-helper Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:00:37 [09:00:37.571] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x05804049c4a3e8fc15e5d87b9289dba22122fb27cee8f54f63576e3ebf6fd7f7","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749805541,"version":4042478560},"archiveRoot":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","archiveNextLeafIndex":2} 09:00:37 [09:00:37.575] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:00:37 [09:00:37.617] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.590850000000501,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749805541,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:00:37 [09:00:37.622] VERBOSE: p2p Synched to latest block 1 09:00:37 [09:00:37.671] INFO: node Stopping Aztec Node 09:00:37 [09:00:37.759] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749805577,"version":4042478560},"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:37 [09:00:37.760] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:38 [09:00:38.275] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749805577,"version":4042478560},"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:38 [09:00:38.277] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:38 [09:00:38.792] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749805577,"version":4042478560},"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:38 [09:00:38.793] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:39 [09:00:39.306] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749805577,"version":4042478560},"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:39 [09:00:39.307] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c220e673ecb2c705b12c7ed27eb90f14b4d4c4240433bfa452c07cbc2eba27","blockNumber":2,"slot":3} 09:00:39 [09:00:39.671] INFO: slasher Slasher client stopped. 09:00:39 [09:00:39.672] INFO: sequencer Stopped sequencer 09:00:39 [09:00:39.672] INFO: p2p P2P client stopped 09:00:39 [09:00:39.673] INFO: world_state Stopped world state synchronizer 09:00:39 [09:00:39.673] INFO: archiver Stopped. 09:00:39 [09:00:39.674] INFO: node Stopped Aztec Node 09:00:39 [09:00:39.682] INFO: blob-sink:server Stopping blob sink 09:00:39 [09:00:39.682] INFO: blob-sink:server Blob sink stopped 09:00:39 PASS src/e2e_circuit_recorder.test.ts 09:00:39 Circuit Recorder 09:00:39 records circuit execution (10737 ms) 09:00:39 09:00:39 Test Suites: 1 passed, 1 total 09:00:39 Tests: 1 passed, 1 total 09:00:39 Snapshots: 0 total 09:00:39 Time: 14.977 s 09:00:39 Ran all test suites matching /src\/e2e_circuit_recorder.test.ts/i. 09:00:39 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?