Parent Log: http://ci.aztec-labs.com/8c777221874880dc Command: 4a03bf7c4810b853: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/991b313d676f7cf820bb62a33e57cf5a4c8cf9cf Env: REF_NAME=gh-readonly-queue/next/pr-15075-af42fafbeb7d6a4440329d9e9e5b1df459fa2e2e CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Mon Jun 16 15:54:41 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15075_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_45fa6151872caa8b_next 15:54:41 +++ id -u 15:54:41 +++ id -g 15:54:41 ++ 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'\''' 15:54:41 + cid=261465fb8f45a7e50679fe5d42430ffc00875dfa0150f7717ae61cfa34ce65e4 15:54:41 + set +x 15:54:41 {"level":25,"time":1750089281985,"pid":12,"hostname":"261465fb8f45","module":"logger","msg":"Logger initialized with level verbose"} 15:54:46 [15:54:46.407] INFO: e2e:e2e_circuit_recorder Running test: Circuit Recorder records circuit execution 15:54:46 [15:54:46.491] INFO: e2e:Circuit Logging metrics to log/Circuit.jsonl 15:54:46 [15:54:46.879] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-ejc53X/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:54:46 [15:54:46.929] INFO: e2e:Circuit Calling anvil_setBlockTimestampInterval with params: [12] 15:54:46 [15:54:46.934] WARN: e2e:Circuit Set block interval to 12 15:54:46 [15:54:46.935] VERBOSE: e2e:Circuit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:54:46 [15:54:46.978] VERBOSE: e2e:Circuit Sent L1 transaction 0x5f6007147b276ec3270f42c9cc4c2453661a1882dd03ebb0a7663e0351326302 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:54:46 [15:54:46.986] VERBOSE: e2e:Circuit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:54:47 [15:54:47.002] VERBOSE: e2e:Circuit Sent L1 transaction 0xaf47cdb235bd1f13781af7e220955c2cdc0e084c2ebf03be2e261fd9e4cd20e4 {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:54:47 [15:54:47.007] VERBOSE: e2e:Circuit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:54:47 [15:54:47.028] VERBOSE: e2e:Circuit Sent L1 transaction 0xfd84f46abe4100d056b133b0a960de7a614472acf388c66a70c817703efb422e {"gasLimit":3068930,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:54:47 [15:54:47.033] VERBOSE: e2e:Circuit Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:54:47 [15:54:47.048] VERBOSE: e2e:Circuit Sent L1 transaction 0x6b891a0f072b12d8f9358f4dd386e4e6e5c60d346faee5fcd49328e2afb83077 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:54:47 [15:54:47.052] VERBOSE: e2e:Circuit Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:54:47 [15:54:47.068] VERBOSE: e2e:Circuit Sent L1 transaction 0x9712ac97dbdbe36311492dc6de3b627d6aff28b690269e131f7924106c3d1d47 {"gasLimit":1966627,"maxFeePerGas":"3.602497756","maxPriorityFeePerGas":"2.48832"} 15:54:47 [15:54:47.072] VERBOSE: e2e:Circuit Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:54:47 [15:54:47.088] VERBOSE: e2e:Circuit Sent L1 transaction 0xcd7afd4f1fe673b6270b61238415317a3653c7277d2e9e2634adba7c73f8e8fd {"gasLimit":3042380,"maxFeePerGas":"3.968739012","maxPriorityFeePerGas":"2.985984"} 15:54:47 [15:54:47.092] VERBOSE: e2e:Circuit Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:54:47 [15:54:47.104] VERBOSE: e2e:Circuit Sent L1 transaction 0x8c90825653eed644185a1275b124b6a068ec868c56a0cf9bdb2ab0c1352dd2c0 {"gasLimit":100000,"maxFeePerGas":"4.456513053","maxPriorityFeePerGas":"3.5831808"} 15:54:47 [15:54:47.104] VERBOSE: e2e:Circuit Set governance on GSE in 0x8c90825653eed644185a1275b124b6a068ec868c56a0cf9bdb2ab0c1352dd2c0 15:54:47 [15:54:47.117] VERBOSE: e2e:Circuit Sent L1 transaction 0xa2bb86c18e2617c94613459391f5e6656698a41f047da7afd6dcd9bfbed505d2 {"gasLimit":391705,"maxFeePerGas":"5.082434132","maxPriorityFeePerGas":"4.29981696"} 15:54:47 [15:54:47.121] VERBOSE: e2e:Circuit Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 15:54:47 [15:54:47.121] VERBOSE: e2e:Circuit Waiting for deployments to complete 15:54:47 [15:54:47.121] INFO: e2e:Circuit Waiting for 7 transactions to be mined... 15:54:47 [15:54:47.147] INFO: e2e:Circuit All transactions mined successfully 15:54:47 [15:54:47.155] VERBOSE: e2e:Circuit Sent L1 transaction 0x342c35507be14cc80347fb50cfe1316a4f0f16e481e952913098406e51916d1c {"gasLimit":100000,"maxFeePerGas":"5.844872273","maxPriorityFeePerGas":"5.159780352"} 15:54:47 [15:54:47.156] VERBOSE: e2e:Circuit Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x342c35507be14cc80347fb50cfe1316a4f0f16e481e952913098406e51916d1c 15:54:47 [15:54:47.168] VERBOSE: e2e:Circuit Sent L1 transaction 0x686c1c4c08ccec07917331d9aef267eb669ab87e450238b0ae5c4e47fdba78a4 {"gasLimit":56661,"maxFeePerGas":"6.793055424","maxPriorityFeePerGas":"6.191736422"} 15:54:47 [15:54:47.181] VERBOSE: e2e:Circuit Sent L1 transaction 0x99062d0aeba2783588e2dfcf3023779109d9481ff381f1376a0dee8451299097 {"gasLimit":339705,"maxFeePerGas":"7.956475038","maxPriorityFeePerGas":"7.430083706"} 15:54:47 [15:54:47.186] VERBOSE: e2e:Circuit Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:54:47 [15:54:47.198] VERBOSE: e2e:Circuit Sent L1 transaction 0x7d1e1921694f089735b07559e9adc61423065cc77204d2a9de7844ac3383b7c5 {"gasLimit":56804,"maxFeePerGas":"9.376899992","maxPriorityFeePerGas":"8.916100447"} 15:54:47 [15:54:47.198] VERBOSE: e2e:Circuit Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0x7d1e1921694f089735b07559e9adc61423065cc77204d2a9de7844ac3383b7c5 15:54:47 [15:54:47.215] VERBOSE: e2e:Circuit Sent L1 transaction 0x934e1283892efb91aac5ebdfac16f951995d98ab225cc3ca5b223e7d901e7911 {"gasLimit":2474287,"maxFeePerGas":"11.103607194","maxPriorityFeePerGas":"10.699320536"} 15:54:47 [15:54:47.220] VERBOSE: e2e:Circuit Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 15:54:47 [15:54:47.234] VERBOSE: e2e:Circuit Sent L1 transaction 0xc781cd4eb98c620d32922bb8386d18faac2cd707e60867fba723a2a252579e99 {"gasLimit":56804,"maxFeePerGas":"13.193094951","maxPriorityFeePerGas":"12.839184643"} 15:54:47 [15:54:47.235] VERBOSE: e2e:Circuit Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0xc781cd4eb98c620d32922bb8386d18faac2cd707e60867fba723a2a252579e99 15:54:47 [15:54:47.235] VERBOSE: e2e:Circuit Waiting for deployments to complete 15:54:47 [15:54:47.235] INFO: e2e:Circuit Waiting for 9 transactions to be mined... 15:54:47 [15:54:47.254] INFO: e2e:Circuit All transactions mined successfully 15:54:47 [15:54:47.265] VERBOSE: e2e:Circuit Deployed shared contracts 15:54:47 [15:54:47.281] VERBOSE: e2e:Circuit Sent L1 transaction 0x7257b355e2f758fb87063495f4aef4f1575c285d61795bab2f2e6c956fe031a7 {"gasLimit":84837,"maxFeePerGas":"15.722774173","maxPriorityFeePerGas":"15.407021571"} 15:54:47 [15:54:47.281] VERBOSE: e2e:Circuit Funded reward distributor with 10000000000000000000000000 fee asset in 0x7257b355e2f758fb87063495f4aef4f1575c285d61795bab2f2e6c956fe031a7 15:54:47 [15:54:47.295] VERBOSE: e2e:Circuit Sent L1 transaction 0xe8fadf4d44151bad1e3173c1202353591318b51dbeee4b03a4f2e18f628cf5ff {"gasLimit":152965,"maxFeePerGas":"18.764833968","maxPriorityFeePerGas":"18.488425885"} 15:54:47 [15:54:47.299] VERBOSE: e2e:Circuit Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 15:54:47 [15:54:47.299] VERBOSE: e2e:Circuit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":0,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 15:54:47 [15:54:47.311] VERBOSE: e2e:Circuit Sent L1 transaction 0x4bdd46772368aeb7f8c0c98f4c2b3ed572118ebb6ea0d851966f79449f999364 {"gasLimit":86397,"maxFeePerGas":"22.42813098","maxPriorityFeePerGas":"22.186111062"} 15:54:47 [15:54:47.335] VERBOSE: e2e:Circuit Sent L1 transaction 0x9894982a322f0e0ee1bf2097923b47a8065e72fd1bcc345beb3bcfc8bf422c12 {"gasLimit":5039811,"maxFeePerGas":"26.83535779","maxPriorityFeePerGas":"26.623333274"} 15:54:47 [15:54:47.353] VERBOSE: e2e:Circuit Sent L1 transaction 0x9aa34d48e140b121c866a8006d332659f474a94cc786bafd534aa3fcac8b354b {"gasLimit":2810697,"maxFeePerGas":"32.133648591","maxPriorityFeePerGas":"31.947999928"} 15:54:47 [15:54:47.358] VERBOSE: e2e:Circuit Awaiting for linked libraries to be deployed 15:54:47 [15:54:47.396] VERBOSE: e2e:Circuit Sent L1 transaction 0xac4908d90db51f48716f04e03023443009b7f3dec5493df136bed6e03b750ebc {"gasLimit":10876656,"maxFeePerGas":"38.506539955","maxPriorityFeePerGas":"38.337599913"} 15:54:47 [15:54:47.401] VERBOSE: e2e:Circuit Deployed Rollup at 0x3aa5ebb10dc797cac828524e59a333d0a371443c {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":0,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 15:54:47 [15:54:47.401] INFO: e2e:Circuit Waiting for 11 transactions to be mined... 15:54:47 [15:54:47.424] INFO: e2e:Circuit All transactions mined successfully 15:54:47 [15:54:47.424] VERBOSE: e2e:Circuit All core contracts have been deployed 15:54:47 [15:54:47.437] VERBOSE: e2e:Circuit Sent L1 transaction 0xd5323fa2c4caaf9b5456a63849223c0bd4a51085aa616e3d80fbbe50c8eed027 {"gasLimit":64317,"maxFeePerGas":"46.156239927","maxPriorityFeePerGas":"46.005119895"} 15:54:47 [15:54:47.437] VERBOSE: e2e:Circuit Funding fee juice portal with 10000000000000000000000 fee juice in 0xd5323fa2c4caaf9b5456a63849223c0bd4a51085aa616e3d80fbbe50c8eed027 (accelerated test deployments) 15:54:47 [15:54:47.448] VERBOSE: e2e:Circuit Sent L1 transaction 0xc3fd7f109b82e9ff61ca42534e2894aab0eef434531c7cd921f3b1196059ab8e {"gasLimit":1040131,"maxFeePerGas":"55.349788352","maxPriorityFeePerGas":"55.206143874"} 15:54:47 [15:54:47.452] VERBOSE: e2e:Circuit Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 15:54:47 [15:54:47.471] VERBOSE: e2e:Circuit Sent L1 transaction 0xb630b07d324bc00d6da23a278fbc1b432a1d924621d91bc585a1a44a4b80d903 {"gasLimit":116979,"maxFeePerGas":"66.373125726","maxPriorityFeePerGas":"66.247372648"} 15:54:47 [15:54:47.471] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0xb630b07d324bc00d6da23a278fbc1b432a1d924621d91bc585a1a44a4b80d903 15:54:47 [15:54:47.487] VERBOSE: e2e:Circuit Sent L1 transaction 0x189b9d337344aef08eeb15aedb807fb86ac8c44ad879af063aaf6a7460ec1574 {"gasLimit":109478,"maxFeePerGas":"79.607789452","maxPriorityFeePerGas":"79.496847177"} 15:54:47 [15:54:47.487] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x189b9d337344aef08eeb15aedb807fb86ac8c44ad879af063aaf6a7460ec1574 15:54:47 [15:54:47.491] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 15:54:47 [15:54:47.513] INFO: e2e:Circuit All transactions mined successfully 15:54:47 [15:54:47.519] VERBOSE: e2e:Circuit Rollup deployed 15:54:47 [15:54:47.519] VERBOSE: e2e:Circuit Waiting for rollup and slash factory to be deployed 15:54:47 [15:54:47.519] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 15:54:47 [15:54:47.541] INFO: e2e:Circuit All transactions mined successfully 15:54:47 [15:54:47.541] VERBOSE: e2e:Circuit All transactions for L1 deployment have been mined 15:54:47 [15:54:47.560] 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"} 15:54:47 [15:54:47.560] INFO: e2e:Circuit Handing over to governance 15:54:47 [15:54:47.565] WARN: foundation:test-date-provider Time set to 2025-06-16T15:59:34.000Z {"offset":286435,"timeMs":1750089574000} 15:54:47 [15:54:47.570] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 15:54:47 [15:54:47.571] INFO: telemetry:client Using NoopTelemetryClient 15:54:47 [15:54:47.576] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/230fb99e335daaea/blob-sink with map size 134217728 KB (LMDB v2) 15:54:47 [15:54:47.580] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:54:47 [15:54:47.585] INFO: blob-sink:server Server is running on http://localhost:34049 15:54:47 [15:54:47.585] VERBOSE: e2e:Circuit Creating and synching an aztec node... 15:54:47 [15:54:47.586] VERBOSE: e2e:Circuit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/c3785808/acvm 15:54:47 [15:54:47.586] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34049"} 15:54:47 [15:54:47.604] VERBOSE: node:MAIN-aztec-node Snapshot sync is disabled. No snapshots URL provided. 15:54:47 [15:54:47.605] INFO: archiver:lmdb Creating archiver data store at directory /tmp/230fb99e335daaea/archiver with map size 134217728 KB (LMDB v2) 15:54:47 [15:54:47.606] INFO: archiver:lmdb Starting data store with maxReaders 16 15:54:47 [15:54:47.904] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:34049"} 15:54:47 [15:54:47.918] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:34049"} 15:54:47 [15:54:47.918] WARN: node:blob-sink:client No L1 consensus host urls configured 15:54:47 [15:54:47.918] WARN: node:blob-sink:client No archive client configured 15:54:47 [15:54:47.921] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x9ee5e1486ab8705002f9782e7ea3c0681be47c49a0f9d53e7ad7879a16ce88e2 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xe5c72d2fdd2504fd2d996cba618adbf8bc34d5af2691e15f87d79240e957342f","l1BlockNumber":20}} 15:54:47 [15:54:47.935] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x9ee5e1486ab8705002f9782e7ea3c0681be47c49a0f9d53e7ad7879a16ce88e2","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:54:47 [15:54:47.939] INFO: world-state:database Creating world state data store at directory /tmp/230fb99e335daaea/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:54:47 [15:54:47.960] INFO: world_state Created world state synchroniser with block history of 64 15:54:47 [15:54:47.960] WARN: node:MAIN-aztec-node Aztec node is accepting fake proofs 15:54:47 [15:54:47.970] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/230fb99e335daaea/p2p with map size 134217728 KB (LMDB v2) 15:54:47 [15:54:47.971] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:54:47 [15:54:47.972] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/230fb99e335daaea/p2p-archive with map size 134217728 KB (LMDB v2) 15:54:47 [15:54:47.973] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:54:47 [15:54:47.974] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/230fb99e335daaea/p2p-peers with map size 134217728 KB (LMDB v2) 15:54:47 [15:54:47.975] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:54:47 [15:54:47.976] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:54:47 [15:54:47.977] VERBOSE: p2p P2P is disabled. Using dummy P2P service. 15:54:47 [15:54:47.979] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:54:47 [15:54:47.980] INFO: world_state Started world state synchronizer from block 1 15:54:47 [15:54:47.982] VERBOSE: world-state:block_stream Starting sync from block number 0 15:54:47 [15:54:47.984] INFO: p2p Starting p2p client from block 0 with empty mempools 15:54:47 [15:54:47.984] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:54:48 [15:54:48.221] INFO: epoch-prune-watcher EpochPruneWatcher initialized 15:54:48 [15:54:48.255] VERBOSE: validator Initialized validator with addresses: 0xf0646ba329b397c4df88cc1050f233feb87376a9 15:54:48 [15:54:48.255] VERBOSE: node:MAIN-aztec-node All Aztec Node subsystems synced 15:54:48 [15:54:48.267] INFO: slasher Starting Slasher client... 15:54:48 [15:54:48.277] INFO: sequencer-client Deploying forwarder contract 15:54:48 [15:54:48.280] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:54:48 [15:54:48.295] VERBOSE: sequencer-client Sent L1 transaction 0x4fbff9cba794756d6d862519e683b61923b2c92a425bb03a12e3fd6f74b03750 {"gasLimit":323704,"maxFeePerGas":"95.493381229","maxPriorityFeePerGas":"95.396216612"} 15:54:48 [15:54:48.296] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0x4fbff9cba794756d6d862519e683b61923b2c92a425bb03a12e3fd6f74b03750. 15:54:48 [15:54:48.300] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 15:54:48 [15:54:48.308] INFO: validator Started validator with addresses: 0xf0646ba329b397c4df88cc1050f233feb87376a9 15:54:48 [15:54:48.309] VERBOSE: validator Validators 0xf0646ba329b397c4df88cc1050f233feb87376a9 are not on the validator committee for epoch 0 15:54:48 [15:54:48.309] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/c3785808/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:54:48 [15:54:48.310] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:54:48 [15:54:48.311] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:54:48 [15:54:48.312] VERBOSE: node:MAIN-aztec-node Sequencer started 15:54:48 [15:54:48.312] INFO: node:MAIN-aztec-node Aztec Node version: 0.87.6 15:54:48 [15:54:48.312] INFO: node:MAIN-aztec-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"} 15:54:48 [15:54:48.313] VERBOSE: e2e:Circuit Creating a pxe... 15:54:48 [15:54:48.319] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/6a31489c6fa95f98/pxe_data with map size 134217728 KB (LMDB v2) 15:54:48 [15:54:48.322] 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. {"now":1750089574,"syncedToL1Ts":1750089574,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750089562,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750089598},"newBlockNumber":1,"expectedSlot":1} 15:54:48 [15:54:48.323] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:54:48 [15:54:48.512] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:54:48 [15:54:48.513] WARN: foundation:test-date-provider Time set to 2025-06-16T15:59:46.000Z {"offset":297487,"timeMs":1750089586000} 15:54:48 [15:54:48.618] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:54:48 [15:54:48.618] INFO: pxe:service Started PXE connected to chain 31337 version 2457225229 15:54:48 [15:54:48.668] INFO: pxe:service Registered account 0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0 15:54:48 [15:54:48.724] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 15:54:48 [15:54:48.727] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0 15:54:48 [15:54:48.864] INFO: pxe:service Added contract SchnorrAccount at 0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 15:54:48 [15:54:48.886] 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":1750089598,"version":2457225229},"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:48 [15:54:48.911] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:48 [15:54:48.914] VERBOSE: pxe:block_stream Starting sync from block number 0 15:54:48 [15:54:48.955] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:54:49 [15:54:49.062] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:54:49 [15:54:49.491] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:54:49 [15:54:49.574] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:54:49 [15:54:49.580] 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":1750089598,"version":2457225229},"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:49 [15:54:49.630] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:49 [15:54:49.730] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0"} 15:54:49 [15:54:49.773] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:54:49 [15:54:49.774] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0"} 15:54:49 [15:54:49.821] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0"} 15:54:49 [15:54:49.825] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:54:50 [15:54:50.018] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0"} 15:54:50 [15:54:50.059] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:54:50 [15:54:50.062] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0"} 15:54:50 [15:54:50.100] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0"} 15:54:50 [15:54:50.103] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:54:50 [15:54:50.119] VERBOSE: simulator:client_execution_context:debug_log Setting 0x16a13819f62cb939af22c47dfbafe648adf920f7dfdbdc6778032c243daf2fe0 as fee payer 15:54:50 [15:54:50.164] 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":1750089598,"version":2457225229},"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:50 [15:54:50.177] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:50 [15:54:50.745] 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":1750089598,"version":2457225229},"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:50 [15:54:50.764] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:51 [15:54:51.293] INFO: pxe:service Proving completed in 2381.9808840000005ms {"timings":{"total":2381.9808840000005,"sync":3.265693000000283,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":167.41030199999932,"oracles":{"callPrivateFunction":{"times":[642.6782410000005,287.6283029999995,198.1959339999994]}}},{"functionName":"private_kernel_init","time":102.98497099999986},{"functionName":"ContractClassRegisterer:register","time":623.1899299999986,"oracles":{"loadCapsule":{"times":[5.142250000000786]},"notifyCreatedNullifier":{"times":[0.5419609999999011]},"debugLog":{"times":[0.7807699999993929]},"notifyCreatedContractClassLog":{"times":[8.847959000000628]}}},{"functionName":"private_kernel_inner","time":128.8831390000014},{"functionName":"SchnorrAccount:constructor","time":258.687226,"oracles":{"getContractInstance":{"times":[0.7706260000013572]},"debugLog":{"times":[0.5193170000002283,0.43802899999900546]},"fetchTaggedLogs":{"times":[49.18233700000019]},"loadCapsule":{"times":[0.3541319999985717,0.2561280000008992,0.23066500000095402]},"validateEnqueuedNotesAndEvents":{"times":[1.7607399999997142]},"notifyCreatedNullifier":{"times":[0.2194130000007135,0.2601630000008299]},"notifyCreatedNote":{"times":[0.49066099999981816]},"getRandomField":{"times":[0.23532300000078976,0.1602419999999256,0.1369059999997262,0.1375370000005205,0.14682900000116206,0.13779000000067754,0.1078880000004574,0.10092199999962759,0.10051400000156718,0.13385399999970105,0.08181300000069314]},"getIndexedTaggingSecretAsSender":{"times":[33.73150600000008]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.35136600000078]}}},{"functionName":"private_kernel_inner","time":124.42584200000056},{"functionName":"SchnorrAccount:entrypoint","time":167.72568300000057,"oracles":{"debugLog":{"times":[0.5159519999997428,0.4007400000009511,0.5998989999989135]},"fetchTaggedLogs":{"times":[38.734371000000465]},"loadCapsule":{"times":[0.25668899999982386,0.2506150000008347,0.3265109999993001]},"validateEnqueuedNotesAndEvents":{"times":[1.490176999999676]},"getNotes":{"times":[1.585425999999643]},"getAuthWitness":{"times":[0.3901269999987562]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8769630000006146]}}},{"functionName":"private_kernel_inner","time":116.82275200000004},{"functionName":"private_kernel_reset","time":198.8682579999986},{"functionName":"private_kernel_tail","time":80.1555900000003}],"unaccounted":409.56149800000094}} 15:54:51 [15:54:51.369] 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":1750089598,"version":2457225229},"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:51 [15:54:51.370] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:51 [15:54:51.380] VERBOSE: p2p:tx_pool Adding tx 0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90 to pool {"eventName":"tx-added-to-pool","txHash":"0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 15:54:51 [15:54:51.403] INFO: node:MAIN-aztec-node Received tx 0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90 {"txHash":"0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90"} 15:54:51 [15:54:51.403] INFO: pxe:service Sent transaction 0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90 15:54:51 [15:54:51.878] 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":1750089598,"version":2457225229},"chainTipArchive":"0x089a1735f2a77d8290c058b3013d594849831ffff93b3071c937bec49e0c45d8","blockNumber":1,"slot":2} 15:54:51 [15:54:51.890] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-16T15:59:58.000Z","now":"2025-06-16T15:59:49.377Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:54:51 [15:54:51.939] VERBOSE: simulator:public-processor Processed tx 0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90 with no public calls in 23.29826999999932ms {"txHash":"0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90","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":23.29826999999932} 15:54:51 [15:54:51.941] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.047981677999998286s {"duration":0.047981677999998286,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 15:54:51 [15:54:51.964] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x185265d21b4e3ac0fad6082e835bbc33d0392de21619e3943df5bee6e0076792","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750089598,"version":2457225229},"txHashes":["0x2b6330043c0861c86fb636d8f39469d1b4830d86ee8cfcc93660638ee2a3ad90"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":80.42998399999851,"publicProcessDuration":48.78978300000017,"rollupCircuitsDuration":74.01414300000033,"txCount":1,"blockNumber":1,"blockTimestamp":1750089598,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:54:51 [15:54:51.967] VERBOSE: sequencer Attesting committee is empty 15:54:54 [15:54:54.672] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xdf8b453b08668df5c46278e4a5fe45048b8bda8f4409784dd8af0a07a9aa7b9e 15:54:54 [15:54:54.673] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0xdf8b453b08668df5c46278e4a5fe45048b8bda8f4409784dd8af0a07a9aa7b9e {"gasLimit":476529,"maxFeePerGas":"114.560552846","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 15:54:54 [15:54:54.683] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:54:54 [15:54:54.684] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdf8b453b08668df5c46278e4a5fe45048b8bda8f4409784dd8af0a07a9aa7b9e","calldataSize":1252,"calldataGas":9964,"txCount":1,"blockNumber":1,"blockTimestamp":1750089598,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:54:54 [15:54:54.685] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:54:54 [15:54:54.700] INFO: blob-sink:server Received blob sidecar for block 0x40695c0374a068fed29fa885a218a0d19d599ab906f4429210d9f3db3d61c656 15:54:54 [15:54:54.704] INFO: blob-sink:server Blob sidecar stored successfully for block 0x40695c0374a068fed29fa885a218a0d19d599ab906f4429210d9f3db3d61c656 15:54:54 [15:54:54.833] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 15:54:54 [15:54:54.833] WARN: foundation:test-date-provider Time set to 2025-06-16T15:59:58.000Z {"offset":303167,"timeMs":1750089598000} 15:54:54 [15:54:54.841] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:54:54 [15:54:54.844] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:54:54 [15:54:54.844] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750089634 15:54:54 [15:54:54.845] WARN: foundation:test-date-provider Time set to 2025-06-16T16:00:34.000Z {"offset":339155,"timeMs":1750089634000} 15:54:54 [15:54:54.845] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:54:54 [15:54:54.996] VERBOSE: archiver:block-helper Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 15:54:55 [15:54:55.001] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x185265d21b4e3ac0fad6082e835bbc33d0392de21619e3943df5bee6e0076792","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750089598,"version":2457225229},"archiveRoot":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","archiveNextLeafIndex":2} 15:54:55 [15:54:55.007] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:54:55 [15:54:55.042] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.825607000000673,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750089598,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:54:55 [15:54:55.054] VERBOSE: p2p Synched to latest block 1 15:54:55 [15:54:55.100] INFO: node:MAIN-aztec-node Stopping Aztec Node 15:54:55 [15:54:55.204] 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":1750089634,"version":2457225229},"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:55 [15:54:55.205] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:55 [15:54:55.723] 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":1750089634,"version":2457225229},"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:55 [15:54:55.724] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:56 [15:54:56.238] 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":1750089634,"version":2457225229},"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:56 [15:54:56.239] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:56 [15:54:56.754] 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":1750089634,"version":2457225229},"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:56 [15:54:56.755] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1e066d555772e80f2ae81bd9a5ab5c88a6a94b9b69962dca9449bbff875888b9","blockNumber":2,"slot":3} 15:54:57 [15:54:57.101] INFO: slasher Slasher client stopped. 15:54:57 [15:54:57.102] INFO: sequencer Stopped sequencer 15:54:57 [15:54:57.102] INFO: p2p P2P client stopped 15:54:57 [15:54:57.103] INFO: world_state Stopped world state synchronizer 15:54:57 [15:54:57.104] INFO: archiver Stopped. 15:54:57 [15:54:57.104] INFO: node:MAIN-aztec-node Stopped Aztec Node 15:54:57 [15:54:57.112] INFO: blob-sink:server Stopping blob sink 15:54:57 [15:54:57.113] INFO: blob-sink:server Blob sink stopped 15:54:57 PASS src/e2e_circuit_recorder.test.ts 15:54:57 Circuit Recorder 15:54:57 records circuit execution (10710 ms) 15:54:57 15:54:57 Test Suites: 1 passed, 1 total 15:54:57 Tests: 1 passed, 1 total 15:54:57 Snapshots: 0 total 15:54:57 Time: 15.312 s 15:54:57 Ran all test suites matching src/e2e_circuit_recorder.test.ts. 15:54:57 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?