Parent Log: http://ci.aztec-labs.com/7d0067d7530e6504 Command: 59d7caa3bc5b3609: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/1338cef09c870378254c56748f972ae827c4d482 Env: REF_NAME=gh-readonly-queue/master/pr-14982-dada14e07a974e905ef606b4fac7c777b922587f CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Thu Jun 12 06:48:42 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14982_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_45fa6151872caa8b_master 06:48:42 +++ id -u 06:48:42 +++ id -g 06:48:42 ++ docker run -d --name e2e_circuit_recorder --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_circuit_recorder.test.ts'\''' 06:48:42 + cid=be12a437154cfed69cc225be4e7ab326a6657fb9035ad26f35ca4b95bbddf45a 06:48:42 + set +x 06:48:43 {"level":25,"time":1749710923576,"pid":12,"hostname":"be12a437154c","module":"logger","msg":"Logger initialized with level verbose"} 06:48:49 [06:48:49.407] INFO: e2e:e2e_circuit_recorder Running test: Circuit Recorder records circuit execution 06:48:49 [06:48:49.505] INFO: e2e:Circuit Logging metrics to log/Circuit.jsonl 06:48:49 [06:48:49.762] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-FEaQNw/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 06:48:49 [06:48:49.802] INFO: e2e:Circuit Calling anvil_setBlockTimestampInterval with params: [12] 06:48:49 [06:48:49.830] WARN: e2e:Circuit Set block interval to 12 06:48:49 [06:48:49.831] VERBOSE: e2e:Circuit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 06:48:49 [06:48:49.886] VERBOSE: e2e:Circuit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 06:48:49 [06:48:49.896] VERBOSE: e2e:Circuit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 06:48:49 [06:48:49.913] VERBOSE: e2e:Circuit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 06:48:49 [06:48:49.918] VERBOSE: e2e:Circuit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 06:48:49 [06:48:49.934] VERBOSE: e2e:Circuit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 06:48:49 [06:48:49.940] VERBOSE: e2e:Circuit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 06:48:49 [06:48:49.971] VERBOSE: e2e:Circuit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 06:48:49 [06:48:49.976] VERBOSE: e2e:Circuit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 06:48:49 [06:48:49.994] VERBOSE: e2e:Circuit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 06:48:49 [06:48:49.998] VERBOSE: e2e:Circuit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 06:48:50 [06:48:50.011] VERBOSE: e2e:Circuit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 06:48:50 [06:48:50.016] VERBOSE: e2e:Circuit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 06:48:50 [06:48:50.017] VERBOSE: e2e:Circuit Waiting for deployments to complete 06:48:50 [06:48:50.017] INFO: e2e:Circuit Waiting for 6 transactions to be mined... 06:48:50 [06:48:50.040] INFO: e2e:Circuit All transactions mined successfully 06:48:50 [06:48:50.056] VERBOSE: e2e:Circuit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 06:48:50 [06:48:50.056] VERBOSE: e2e:Circuit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 06:48:50 [06:48:50.077] VERBOSE: e2e:Circuit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 06:48:50 [06:48:50.093] VERBOSE: e2e:Circuit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 06:48:50 [06:48:50.098] VERBOSE: e2e:Circuit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 06:48:50 [06:48:50.116] VERBOSE: e2e:Circuit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 06:48:50 [06:48:50.116] VERBOSE: e2e:Circuit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 06:48:50 [06:48:50.130] VERBOSE: e2e:Circuit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 06:48:50 [06:48:50.136] VERBOSE: e2e:Circuit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 06:48:50 [06:48:50.150] VERBOSE: e2e:Circuit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 06:48:50 [06:48:50.150] VERBOSE: e2e:Circuit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 06:48:50 [06:48:50.150] VERBOSE: e2e:Circuit Waiting for deployments to complete 06:48:50 [06:48:50.150] INFO: e2e:Circuit Waiting for 8 transactions to be mined... 06:48:50 [06:48:50.169] INFO: e2e:Circuit All transactions mined successfully 06:48:50 [06:48:50.184] VERBOSE: e2e:Circuit Deployed shared contracts 06:48:50 [06:48:50.202] VERBOSE: e2e:Circuit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 06:48:50 [06:48:50.203] VERBOSE: e2e:Circuit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 06:48:50 [06:48:50.207] VERBOSE: e2e:Circuit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 06:48:50 [06:48:50.222] VERBOSE: e2e:Circuit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 06:48:50 [06:48:50.257] VERBOSE: e2e:Circuit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 06:48:50 [06:48:50.263] VERBOSE: e2e:Circuit Awaiting for linked libraries to be deployed 06:48:50 [06:48:50.309] VERBOSE: e2e:Circuit Sent L1 transaction 0xa135b94660a682de17f4d085bad9f90910ee01bdc4016eba034ae7c6b689b9a4 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 06:48:50 [06:48:50.320] VERBOSE: e2e:Circuit Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 06:48:50 [06:48:50.321] INFO: e2e:Circuit Waiting for 9 transactions to be mined... 06:48:50 [06:48:50.348] INFO: e2e:Circuit All transactions mined successfully 06:48:50 [06:48:50.348] VERBOSE: e2e:Circuit All core contracts have been deployed 06:48:50 [06:48:50.371] VERBOSE: e2e:Circuit Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 06:48:50 [06:48:50.371] VERBOSE: e2e:Circuit Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 06:48:50 [06:48:50.387] VERBOSE: e2e:Circuit Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 06:48:50 [06:48:50.392] VERBOSE: e2e:Circuit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 06:48:50 [06:48:50.421] VERBOSE: e2e:Circuit Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 06:48:50 [06:48:50.421] VERBOSE: e2e:Circuit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 06:48:50 [06:48:50.421] INFO: e2e:Circuit Waiting for 10 transactions to be mined... 06:48:50 [06:48:50.449] INFO: e2e:Circuit All transactions mined successfully 06:48:50 [06:48:50.456] VERBOSE: e2e:Circuit Rollup deployed 06:48:50 [06:48:50.456] VERBOSE: e2e:Circuit Waiting for rollup and slash factory to be deployed 06:48:50 [06:48:50.456] INFO: e2e:Circuit Waiting for 10 transactions to be mined... 06:48:50 [06:48:50.482] INFO: e2e:Circuit All transactions mined successfully 06:48:50 [06:48:50.483] VERBOSE: e2e:Circuit All transactions for L1 deployment have been mined 06:48:50 [06:48:50.504] INFO: e2e:Circuit Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 06:48:50 [06:48:50.508] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 06:48:50 [06:48:50.510] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:50 [06:48:50.511] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 06:48:50 [06:48:50.512] INFO: telemetry:client Using NoopTelemetryClient 06:48:50 [06:48:50.518] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/d4e7270aac7644c0/blob-sink with map size 134217728 KB (LMDB v2) 06:48:50 [06:48:50.519] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 06:48:50 [06:48:50.519] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 06:48:50 [06:48:50.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:50 [06:48:50.524] INFO: aztecjs:utils:watcher New L1 time: 1749711169 06:48:50 [06:48:50.525] WARN: foundation:test-date-provider Time set to 2025-06-12T06:52:49.000Z {"offset":238475,"timeMs":1749711169000} 06:48:50 [06:48:50.527] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 06:48:50 [06:48:50.534] INFO: blob-sink:server Server is running on http://localhost:37393 06:48:50 [06:48:50.535] VERBOSE: e2e:Circuit Creating and synching an aztec node... 06:48:50 [06:48:50.535] VERBOSE: e2e:Circuit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/346a30bc/acvm 06:48:50 [06:48:50.536] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:37393"} 06:48:50 [06:48:50.550] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 06:48:50 [06:48:50.550] INFO: archiver:lmdb Creating archiver data store at directory /tmp/d4e7270aac7644c0/archiver with map size 134217728 KB (LMDB v2) 06:48:50 [06:48:50.554] INFO: archiver:lmdb Starting data store with maxReaders 16 06:48:50 [06:48:50.726] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:50 [06:48:50.821] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:37393"} 06:48:50 [06:48:50.840] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:37393"} 06:48:50 [06:48:50.840] WARN: node:blob-sink:client No L1 consensus host urls configured 06:48:50 [06:48:50.840] WARN: node:blob-sink:client No archive client configured 06:48:50 [06:48:50.843] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xa8c4b923b114d5be19ba71101911d0c977db3ff8b4d291b07a9ca258e518ddab {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x6654baec2ab1890b6e35175fe4f2c88d7ffd6d9ada24b8bf365e4d7c7578fa63","l1BlockNumber":16}} 06:48:50 [06:48:50.858] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xa8c4b923b114d5be19ba71101911d0c977db3ff8b4d291b07a9ca258e518ddab","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 06:48:50 [06:48:50.865] INFO: world-state:database Creating world state data store at directory /tmp/d4e7270aac7644c0/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 06:48:50 [06:48:50.890] INFO: world_state Created world state synchroniser with block history of 64 06:48:50 [06:48:50.891] WARN: node Aztec node is accepting fake proofs 06:48:50 [06:48:50.902] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/d4e7270aac7644c0/p2p with map size 134217728 KB (LMDB v2) 06:48:50 [06:48:50.907] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 06:48:50 [06:48:50.908] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/d4e7270aac7644c0/p2p-archive with map size 134217728 KB (LMDB v2) 06:48:50 [06:48:50.910] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 06:48:50 [06:48:50.911] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/d4e7270aac7644c0/p2p-peers with map size 134217728 KB (LMDB v2) 06:48:50 [06:48:50.912] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 06:48:50 [06:48:50.913] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 06:48:50 [06:48:50.914] VERBOSE: p2p P2P is disabled. Using dummy P2P service 06:48:50 [06:48:50.917] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 06:48:50 [06:48:50.918] INFO: world_state Started world state synchronizer from block 1 06:48:50 [06:48:50.919] VERBOSE: world-state:block_stream Starting sync from block number 0 06:48:50 [06:48:50.921] INFO: p2p Starting p2p client from block 0 with empty mempools 06:48:50 [06:48:50.921] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 06:48:50 [06:48:50.922] INFO: slasher Slasher client initialized 06:48:50 [06:48:50.922] INFO: slasher Starting Slasher client... 06:48:50 [06:48:50.952] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 06:48:50 [06:48:50.952] VERBOSE: node All Aztec Node subsystems synced 06:48:50 [06:48:50.959] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:50 [06:48:50.962] INFO: sequencer-client Deploying forwarder contract 06:48:50 [06:48:50.970] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 06:48:50 [06:48:50.984] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 06:48:50 [06:48:50.984] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 06:48:50 [06:48:50.992] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 06:48:51 [06:48:51.008] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 06:48:51 [06:48:51.009] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 06:48:51 [06:48:51.009] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/346a30bc/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 06:48:51 [06:48:51.251] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 06:48:51 [06:48:51.253] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 06:48:51 [06:48:51.254] INFO: node Aztec Node version: 0.87.8 06:48:51 [06:48:51.254] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 06:48:51 [06:48:51.256] VERBOSE: e2e:Circuit Creating a pxe... 06:48:51 [06:48:51.260] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:51 [06:48:51.268] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/d013a881b3fe1ec3/pxe_data with map size 134217728 KB (LMDB v2) 06:48:51 [06:48:51.281] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f2cb6551b2a77fbd0524812aa58dee633f0165e89831a2fbcd42595e9cb0910","blockNumber":1,"slot":2} 06:48:51 [06:48:51.282] INFO: pxe:data:lmdb Starting data store with maxReaders 16 06:48:51 [06:48:51.496] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:51 [06:48:51.594] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 06:48:51 [06:48:51.594] INFO: pxe:service Started PXE connected to chain 31337 version 1040561355 06:48:51 [06:48:51.637] INFO: pxe:service Registered account 0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216 06:48:51 [06:48:51.690] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 06:48:51 [06:48:51.690] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216 06:48:51 [06:48:51.713] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:51 [06:48:51.809] INFO: pxe:service Added contract SchnorrAccount at 0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 06:48:51 [06:48:51.818] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f2cb6551b2a77fbd0524812aa58dee633f0165e89831a2fbcd42595e9cb0910","blockNumber":1,"slot":2} 06:48:51 [06:48:51.844] VERBOSE: pxe:block_stream Starting sync from block number 0 06:48:51 [06:48:51.862] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 06:48:51 [06:48:51.920] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:51 [06:48:51.946] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 06:48:52 [06:48:52.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:52 [06:48:52.724] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:52 [06:48:52.734] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 06:48:52 [06:48:52.743] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f2cb6551b2a77fbd0524812aa58dee633f0165e89831a2fbcd42595e9cb0910","blockNumber":1,"slot":2} 06:48:52 [06:48:52.860] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 06:48:52 [06:48:52.928] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:53 [06:48:53.059] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216"} 06:48:53 [06:48:53.113] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 06:48:53 [06:48:53.115] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216"} 06:48:53 [06:48:53.141] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:53 [06:48:53.164] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216"} 06:48:53 [06:48:53.171] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 06:48:53 [06:48:53.260] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f2cb6551b2a77fbd0524812aa58dee633f0165e89831a2fbcd42595e9cb0910","blockNumber":1,"slot":2} 06:48:53 [06:48:53.355] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:53 [06:48:53.375] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216"} 06:48:53 [06:48:53.421] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 06:48:53 [06:48:53.426] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216"} 06:48:53 [06:48:53.458] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216"} 06:48:53 [06:48:53.462] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 06:48:53 [06:48:53.477] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c925a036d470824ee6ff3d6072ea8e05c3f05aaf58ee6d3d6d0c050d3eed216 as fee payer 06:48:53 [06:48:53.604] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:53 [06:48:53.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:53 [06:48:53.891] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f2cb6551b2a77fbd0524812aa58dee633f0165e89831a2fbcd42595e9cb0910","blockNumber":1,"slot":2} 06:48:54 [06:48:54.050] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:54 [06:48:54.260] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:54 [06:48:54.529] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:54 [06:48:54.655] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f2cb6551b2a77fbd0524812aa58dee633f0165e89831a2fbcd42595e9cb0910","blockNumber":1,"slot":2} 06:48:54 [06:48:54.743] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:54 [06:48:54.793] INFO: pxe:service Proving completed in 2951.238051999999ms {"timings":{"total":2951.238051999999,"sync":2.7160640000001877,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":154.24806499999977,"oracles":{"callPrivateFunction":{"times":[1034.5923509999993,363.2949800000006,181.33405800000037]}}},{"functionName":"private_kernel_init","time":107.75138399999923},{"functionName":"ContractClassRegisterer:register","time":1017.0964169999988,"oracles":{"loadCapsule":{"times":[28.952336000000287]},"notifyCreatedNullifier":{"times":[1.143937000000733]},"debugLog":{"times":[1.0892749999984517]},"notifyCreatedContractClassLog":{"times":[13.537390999999843]}}},{"functionName":"private_kernel_inner","time":157.22145699999965},{"functionName":"SchnorrAccount:constructor","time":316.74773800000185,"oracles":{"getContractInstance":{"times":[3.4310310000000754]},"debugLog":{"times":[0.6129449999989447,0.780507999999827]},"fetchTaggedLogs":{"times":[52.55285599999843]},"loadCapsule":{"times":[0.5347529999999097,0.7681780000002618,0.5365830000009737]},"notifyCreatedNullifier":{"times":[0.2716660000005504,0.2654659999989235]},"notifyCreatedNote":{"times":[0.47372100000029604]},"getRandomField":{"times":[0.23074500000075204,0.2897370000009687,0.24619499999971595,0.07244200000059209,0.0617419999998674,0.11180199999944307,0.05538200000046345,0.058202000000164844,0.061160999999628984,0.10350199999993492,0.07189199999993434]},"getIndexedTaggingSecretAsSender":{"times":[45.746893999999884]},"incrementAppTaggingSecretIndexAsSender":{"times":[38.74443799999972]}}},{"functionName":"private_kernel_inner","time":153.81248500000038},{"functionName":"SchnorrAccount:entrypoint","time":157.24871600000006,"oracles":{"debugLog":{"times":[0.6215750000010303,0.36078899999847636,0.6216650000005757]},"fetchTaggedLogs":{"times":[34.35820500000045]},"loadCapsule":{"times":[0.2635659999996278,0.19535399999949732,0.21174499999870022]},"getNotes":{"times":[1.6174279999995633]},"getAuthWitness":{"times":[0.3188769999997021]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8286090000001423]}}},{"functionName":"private_kernel_inner","time":141.0117760000012},{"functionName":"private_kernel_reset","time":237.74975099999938},{"functionName":"private_kernel_tail","time":91.74784499999987}],"unaccounted":413.8863539999984}} 06:48:54 [06:48:54.937] VERBOSE: p2p:tx_pool Adding tx 0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e to pool {"eventName":"tx-added-to-pool","txHash":"0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 06:48:55 [06:48:55.002] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:55 [06:48:55.010] INFO: node Received tx 0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e {"txHash":"0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e"} 06:48:55 [06:48:55.010] INFO: pxe:service Sent transaction 0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e 06:48:55 [06:48:55.173] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 06:48:55 [06:48:55.190] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-12T06:53:13.000Z","now":"2025-06-12T06:52:53.665Z"} 06:48:55 [06:48:55.211] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:55 [06:48:55.535] VERBOSE: simulator:public-processor Processed tx 0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e with no public calls in 184.00390199999856ms {"txHash":"0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e","txFee":6794052480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":20448},"billedGas":{"daGas":16896,"l2Gas":20448},"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":184.00390199999856} 06:48:55 [06:48:55.548] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:55 [06:48:55.554] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3589417190000004s {"duration":0.3589417190000004,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 06:48:55 [06:48:55.700] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1cb61bef1e753869a38cb77013731e6ce4ce287bf4efbc505ab28ace15fcc2ad","globalVariables":{"chainId":31337,"version":1040561355,"blockNumber":1,"slotNumber":2,"timestamp":1749711193,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1506f76563999208d839d809eace939c33fe80c2a1816613bee60ce961bed91e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":527.5893890000007,"publicProcessDuration":362.38541500000065,"rollupCircuitsDuration":514.7756900000004,"txCount":1,"blockNumber":1,"blockTimestamp":1749711193,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 06:48:55 [06:48:55.703] VERBOSE: sequencer Attesting committee is empty 06:48:55 [06:48:55.787] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:55 [06:48:55.999] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:56 [06:48:56.214] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf0d7b037e12466e00e0ddd2df08ce4a1732f903561740ce06ec7020f04c1d511 06:48:56 [06:48:56.215] VERBOSE: sequencer-client Sent L1 transaction 0xf0d7b037e12466e00e0ddd2df08ce4a1732f903561740ce06ec7020f04c1d511 {"gasLimit":514567,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 06:48:56 [06:48:56.234] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 06:48:56 [06:48:56.235] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf0d7b037e12466e00e0ddd2df08ce4a1732f903561740ce06ec7020f04c1d511","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1749711193,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 06:48:56 [06:48:56.236] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 06:48:56 [06:48:56.265] INFO: blob-sink:server Received blob sidecar for block 0x769c30983cd36c31f6327a47b6f6e6bd2be960dd345fedebadeb6d087aba389e 06:48:56 [06:48:56.269] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:56 [06:48:56.278] INFO: blob-sink:server Blob sidecar stored successfully for block 0x769c30983cd36c31f6327a47b6f6e6bd2be960dd345fedebadeb6d087aba389e 06:48:56 [06:48:56.281] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 06:48:56 [06:48:56.293] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 06:48:56 [06:48:56.300] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 06:48:56 [06:48:56.301] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749711229] on http://127.0.0.1:8545 06:48:56 [06:48:56.303] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 06:48:56 [06:48:56.305] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749711229 06:48:56 [06:48:56.306] WARN: foundation:test-date-provider Time set to 2025-06-12T06:53:49.000Z {"offset":292694,"timeMs":1749711229000} 06:48:56 [06:48:56.306] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 06:48:56 [06:48:56.485] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:56 [06:48:56.779] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 06:48:56 [06:48:56.810] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 06:48:56 [06:48:56.830] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1cb61bef1e753869a38cb77013731e6ce4ce287bf4efbc505ab28ace15fcc2ad","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":1040561355,"blockNumber":1,"slotNumber":2,"timestamp":1749711193,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x02e563133c8206faab9bc3ee55d547967026f8b25b175fe280aa406bab0c9fc9","archiveNextLeafIndex":2} 06:48:56 [06:48:56.837] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 06:48:56 [06:48:56.911] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":16.948582000000897,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749711193,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 06:48:56 [06:48:56.946] VERBOSE: p2p Synched to latest block 1 06:48:56 [06:48:56.948] INFO: node Stopping 06:48:56 [06:48:56.949] INFO: slasher Slasher client stopped. 06:48:56 [06:48:56.949] INFO: sequencer Stopped sequencer 06:48:56 [06:48:56.949] INFO: p2p P2P client stopped. 06:48:56 [06:48:56.951] INFO: world_state Stopped world state synchronizer 06:48:56 [06:48:56.951] INFO: archiver Stopped. 06:48:56 [06:48:56.952] INFO: node Stopped 06:48:56 [06:48:56.952] VERBOSE: e2e:Circuit Cleaning up ACVM state 06:48:56 [06:48:56.952] INFO: e2e:Circuit Cleaning up ACVM temp directory /tmp/346a30bc 06:48:56 [06:48:56.957] VERBOSE: e2e:Circuit Cleaning up BB state 06:48:56 [06:48:56.967] INFO: blob-sink:server Stopping blob sink 06:48:56 [06:48:56.968] INFO: blob-sink:server Blob sink stopped 06:48:56 [06:48:56.968] VERBOSE: e2e:Circuit Cleaning up data directory at /tmp/d4e7270aac7644c0 06:48:56 PASS src/e2e_circuit_recorder.test.ts 06:48:56 Circuit Recorder 06:48:56 records circuit execution (7567 ms) 06:48:56 06:48:56 Test Suites: 1 passed, 1 total 06:48:56 Tests: 1 passed, 1 total 06:48:56 Snapshots: 0 total 06:48:56 Time: 13.591 s 06:48:56 Ran all test suites matching /src\/e2e_circuit_recorder.test.ts/i. 06:48:56 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?