Parent Log: http://ci.aztec-labs.com/a0e0bc0e0aa231dc Command: 731d98bdb3377842: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/daebab2c4bace59ef25ddb29040a040926f095e6 Env: REF_NAME=gh-readonly-queue/next/pr-14986-b80949775e5c27908a6055ad24592f7d98bdc45a CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 09:08:09 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14986_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_45fa6151872caa8b_next 09:08:09 +++ id -u 09:08:09 +++ id -g 09:08:09 ++ 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'\''' 09:08:09 + cid=1314b3781413ee45aab3fa1929356aa724e1ef8a07f34da07e0c778c0967431d 09:08:09 + set +x 09:08:10 {"level":25,"time":1750064890279,"pid":12,"hostname":"1314b3781413","module":"logger","msg":"Logger initialized with level verbose"} 09:08:16 [09:08:16.216] INFO: e2e:e2e_circuit_recorder Running test: Circuit Recorder records circuit execution 09:08:16 [09:08:16.342] INFO: e2e:Circuit Logging metrics to log/Circuit.jsonl 09:08:16 [09:08:16.927] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-dyxYip/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 09:08:17 [09:08:17.000] INFO: e2e:Circuit Calling anvil_setBlockTimestampInterval with params: [12] 09:08:17 [09:08:17.006] WARN: e2e:Circuit Set block interval to 12 09:08:17 [09:08:17.007] VERBOSE: e2e:Circuit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 09:08:17 [09:08:17.053] VERBOSE: e2e:Circuit Sent L1 transaction 0x5f6007147b276ec3270f42c9cc4c2453661a1882dd03ebb0a7663e0351326302 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 09:08:17 [09:08:17.061] VERBOSE: e2e:Circuit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 09:08:17 [09:08:17.093] VERBOSE: e2e:Circuit Sent L1 transaction 0xaf47cdb235bd1f13781af7e220955c2cdc0e084c2ebf03be2e261fd9e4cd20e4 {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 09:08:17 [09:08:17.100] VERBOSE: e2e:Circuit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 09:08:17 [09:08:17.124] VERBOSE: e2e:Circuit Sent L1 transaction 0x9a6320aea66118feff70b116e53b0fbdaa3acc08151689d8748a33ef04cadea0 {"gasLimit":3068930,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 09:08:17 [09:08:17.131] VERBOSE: e2e:Circuit Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 09:08:17 [09:08:17.150] VERBOSE: e2e:Circuit Sent L1 transaction 0x76f971f0e0b98d2d02dc3199997a3289028c49ea36787520d56affb6d4e3bec6 {"gasLimit":1014492,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 09:08:17 [09:08:17.156] VERBOSE: e2e:Circuit Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 09:08:17 [09:08:17.190] VERBOSE: e2e:Circuit Sent L1 transaction 0x72b989ec8d0fb385b88b2b9565e4d11db0a94f71e422d800901b73e9997d73ab {"gasLimit":1966641,"maxFeePerGas":"3.602497756","maxPriorityFeePerGas":"2.48832"} 09:08:17 [09:08:17.195] VERBOSE: e2e:Circuit Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 09:08:17 [09:08:17.217] VERBOSE: e2e:Circuit Sent L1 transaction 0xcd7afd4f1fe673b6270b61238415317a3653c7277d2e9e2634adba7c73f8e8fd {"gasLimit":3042380,"maxFeePerGas":"3.968739012","maxPriorityFeePerGas":"2.985984"} 09:08:17 [09:08:17.227] VERBOSE: e2e:Circuit Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 09:08:17 [09:08:17.240] VERBOSE: e2e:Circuit Sent L1 transaction 0xde86a24b11f0b7bb7b27402d5d442a7a9d58053011d5356633878d2d61019c0f {"gasLimit":100000,"maxFeePerGas":"4.456513152","maxPriorityFeePerGas":"3.5831808"} 09:08:17 [09:08:17.241] VERBOSE: e2e:Circuit Set governance on GSE in 0xde86a24b11f0b7bb7b27402d5d442a7a9d58053011d5356633878d2d61019c0f 09:08:17 [09:08:17.267] VERBOSE: e2e:Circuit Sent L1 transaction 0x2484b2acf9a4bf4fb96f65b8bb17d5123d6b62c0930310a5ee253dd1f92f3041 {"gasLimit":391705,"maxFeePerGas":"5.082434221","maxPriorityFeePerGas":"4.29981696"} 09:08:17 [09:08:17.275] VERBOSE: e2e:Circuit Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 09:08:17 [09:08:17.276] VERBOSE: e2e:Circuit Waiting for deployments to complete 09:08:17 [09:08:17.276] INFO: e2e:Circuit Waiting for 7 transactions to be mined... 09:08:17 [09:08:17.317] INFO: e2e:Circuit All transactions mined successfully 09:08:17 [09:08:17.326] VERBOSE: e2e:Circuit Sent L1 transaction 0x2ca205bdc08dcb4c03a5c9e85fcc1a0d4dfbb970c0c886535069251773127162 {"gasLimit":100000,"maxFeePerGas":"5.844872351","maxPriorityFeePerGas":"5.159780352"} 09:08:17 [09:08:17.326] VERBOSE: e2e:Circuit Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x2ca205bdc08dcb4c03a5c9e85fcc1a0d4dfbb970c0c886535069251773127162 09:08:17 [09:08:17.339] VERBOSE: e2e:Circuit Sent L1 transaction 0x131afc0991c1cfdf8639072e6f8db345387227adb140274071a5fb41ba59adc3 {"gasLimit":56661,"maxFeePerGas":"6.793055492","maxPriorityFeePerGas":"6.191736422"} 09:08:17 [09:08:17.351] VERBOSE: e2e:Circuit Sent L1 transaction 0x1cb3e5da04f9e7ddcc92000e35ed4c901d5d886aac84cffb7d89238f6fa9a65b {"gasLimit":339705,"maxFeePerGas":"7.956475098","maxPriorityFeePerGas":"7.430083706"} 09:08:17 [09:08:17.356] VERBOSE: e2e:Circuit Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 09:08:17 [09:08:17.371] VERBOSE: e2e:Circuit Sent L1 transaction 0x15dbc23ca137b3166edfd3c43496b907b96729c6cfca3f25b6d87b8c0ec38146 {"gasLimit":56804,"maxFeePerGas":"9.376900043","maxPriorityFeePerGas":"8.916100447"} 09:08:17 [09:08:17.372] VERBOSE: e2e:Circuit Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0x15dbc23ca137b3166edfd3c43496b907b96729c6cfca3f25b6d87b8c0ec38146 09:08:17 [09:08:17.400] VERBOSE: e2e:Circuit Sent L1 transaction 0x5b1976d65abb643d56d12c3da7422fc9a38d1406502e17591f7bf4242e07177a {"gasLimit":2474287,"maxFeePerGas":"11.103607241","maxPriorityFeePerGas":"10.699320536"} 09:08:17 [09:08:17.406] VERBOSE: e2e:Circuit Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 09:08:17 [09:08:17.419] VERBOSE: e2e:Circuit Sent L1 transaction 0x959a45dec5ca94783b7d01c298b49aa965775e09c3071c6deea0ba51d2f6dc14 {"gasLimit":56804,"maxFeePerGas":"13.193094991","maxPriorityFeePerGas":"12.839184643"} 09:08:17 [09:08:17.419] VERBOSE: e2e:Circuit Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x959a45dec5ca94783b7d01c298b49aa965775e09c3071c6deea0ba51d2f6dc14 09:08:17 [09:08:17.420] VERBOSE: e2e:Circuit Waiting for deployments to complete 09:08:17 [09:08:17.420] INFO: e2e:Circuit Waiting for 9 transactions to be mined... 09:08:17 [09:08:17.439] INFO: e2e:Circuit All transactions mined successfully 09:08:17 [09:08:17.451] VERBOSE: e2e:Circuit Deployed shared contracts 09:08:17 [09:08:17.470] VERBOSE: e2e:Circuit Sent L1 transaction 0xbb96dfbf9267e155aa8109517838cfeaad71ff31e774525a59bbeb59ed6e13fa {"gasLimit":84837,"maxFeePerGas":"15.722774208","maxPriorityFeePerGas":"15.407021571"} 09:08:17 [09:08:17.470] VERBOSE: e2e:Circuit Funded reward distributor with 10000000000000000000000000 fee asset in 0xbb96dfbf9267e155aa8109517838cfeaad71ff31e774525a59bbeb59ed6e13fa 09:08:17 [09:08:17.494] VERBOSE: e2e:Circuit Sent L1 transaction 0x431ee18de9f419d25f3256ec9b2107bfa0c6f96e99de80395eb47a5a1b77f55b {"gasLimit":152965,"maxFeePerGas":"18.764833998","maxPriorityFeePerGas":"18.488425885"} 09:08:17 [09:08:17.498] VERBOSE: e2e:Circuit Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 09:08:17 [09:08:17.498] VERBOSE: e2e:Circuit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"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}} 09:08:17 [09:08:17.511] VERBOSE: e2e:Circuit Sent L1 transaction 0x37edfee9519fef23e18ff0505be95b0752fa2331c1cd9843d68a503e577dc44d {"gasLimit":86397,"maxFeePerGas":"22.428131008","maxPriorityFeePerGas":"22.186111062"} 09:08:17 [09:08:17.533] VERBOSE: e2e:Circuit Sent L1 transaction 0xd3045546bfdcd79bc08b301ed2e986754bf1af14d905967e25122cd25b07e994 {"gasLimit":5075920,"maxFeePerGas":"26.835357814","maxPriorityFeePerGas":"26.623333274"} 09:08:17 [09:08:17.552] VERBOSE: e2e:Circuit Sent L1 transaction 0xd0767e5c9fa57228e55e3e246ba6e2eab0e529b62d65ea4da31181c951b762a7 {"gasLimit":2838685,"maxFeePerGas":"32.133648612","maxPriorityFeePerGas":"31.947999928"} 09:08:17 [09:08:17.558] VERBOSE: e2e:Circuit Awaiting for linked libraries to be deployed 09:08:17 [09:08:17.633] VERBOSE: e2e:Circuit Sent L1 transaction 0x8be15b4483a96e5e40827fe961db77237b778658eb7e1ac09dd9167fc7437561 {"gasLimit":10900550,"maxFeePerGas":"38.506586527","maxPriorityFeePerGas":"38.337599913"} 09:08:17 [09:08:17.642] VERBOSE: e2e:Circuit Deployed Rollup at 0x3aa5ebb10dc797cac828524e59a333d0a371443c {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"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}} 09:08:17 [09:08:17.643] INFO: e2e:Circuit Waiting for 11 transactions to be mined... 09:08:17 [09:08:17.672] INFO: e2e:Circuit All transactions mined successfully 09:08:17 [09:08:17.672] VERBOSE: e2e:Circuit All core contracts have been deployed 09:08:17 [09:08:17.691] VERBOSE: e2e:Circuit Sent L1 transaction 0x067196ffcdbe9f0c23283916f03082506da7cb0094e78651df3134dc52c937a4 {"gasLimit":64317,"maxFeePerGas":"46.15631443","maxPriorityFeePerGas":"46.005119895"} 09:08:17 [09:08:17.691] VERBOSE: e2e:Circuit Funding fee juice portal with 10000000000000000000000 fee juice in 0x067196ffcdbe9f0c23283916f03082506da7cb0094e78651df3134dc52c937a4 (accelerated test deployments) 09:08:17 [09:08:17.712] VERBOSE: e2e:Circuit Sent L1 transaction 0xef882c9a411ad3b14753c0b423f68d0988517035eb0c1d4c14a06bf4065cd793 {"gasLimit":1040131,"maxFeePerGas":"55.34988426","maxPriorityFeePerGas":"55.206143874"} 09:08:17 [09:08:17.723] VERBOSE: e2e:Circuit Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 09:08:17 [09:08:17.776] VERBOSE: e2e:Circuit Sent L1 transaction 0x05aab426af3c1f07ee39bb9c52a7f4bbc65ca8936463a52b5da4d1fc7941638f {"gasLimit":116979,"maxFeePerGas":"66.373209686","maxPriorityFeePerGas":"66.247372648"} 09:08:17 [09:08:17.777] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x05aab426af3c1f07ee39bb9c52a7f4bbc65ca8936463a52b5da4d1fc7941638f 09:08:17 [09:08:17.795] VERBOSE: e2e:Circuit Sent L1 transaction 0x11153bddd7bf5a7d72ed37d2807ab57c0f2a9eeb725e69cdc2d3d0917aa79151 {"gasLimit":109478,"maxFeePerGas":"79.607863524","maxPriorityFeePerGas":"79.496847177"} 09:08:17 [09:08:17.796] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x11153bddd7bf5a7d72ed37d2807ab57c0f2a9eeb725e69cdc2d3d0917aa79151 09:08:17 [09:08:17.802] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 09:08:17 [09:08:17.854] INFO: e2e:Circuit All transactions mined successfully 09:08:17 [09:08:17.864] VERBOSE: e2e:Circuit Rollup deployed 09:08:17 [09:08:17.865] VERBOSE: e2e:Circuit Waiting for rollup and slash factory to be deployed 09:08:17 [09:08:17.865] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 09:08:17 [09:08:17.905] INFO: e2e:Circuit All transactions mined successfully 09:08:17 [09:08:17.905] VERBOSE: e2e:Circuit All transactions for L1 deployment have been mined 09:08:17 [09:08:17.927] 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:08:17 [09:08:17.928] INFO: e2e:Circuit Handing over to governance 09:08:17 [09:08:17.935] WARN: foundation:test-date-provider Time set to 2025-06-16T09:13:04.000Z {"offset":286065,"timeMs":1750065184000} 09:08:17 [09:08:17.941] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 09:08:17 [09:08:17.942] INFO: telemetry:client Using NoopTelemetryClient 09:08:17 [09:08:17.948] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/d104ee1263c6b135/blob-sink with map size 134217728 KB (LMDB v2) 09:08:17 [09:08:17.952] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 09:08:17 [09:08:17.959] INFO: blob-sink:server Server is running on http://localhost:45017 09:08:17 [09:08:17.959] VERBOSE: e2e:Circuit Creating and synching an aztec node... 09:08:17 [09:08:17.960] VERBOSE: e2e:Circuit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/b6773e77/acvm 09:08:17 [09:08:17.962] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:45017"} 09:08:17 [09:08:17.993] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 09:08:17 [09:08:17.996] INFO: archiver:lmdb Creating archiver data store at directory /tmp/d104ee1263c6b135/archiver with map size 134217728 KB (LMDB v2) 09:08:18 [09:08:18.002] INFO: archiver:lmdb Starting data store with maxReaders 16 09:08:18 [09:08:18.419] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:45017"} 09:08:18 [09:08:18.439] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:45017"} 09:08:18 [09:08:18.440] WARN: node:blob-sink:client No L1 consensus host urls configured 09:08:18 [09:08:18.440] WARN: node:blob-sink:client No archive client configured 09:08:18 [09:08:18.449] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xb1ea8488807b63a85737190f478ef89d5dbabed52a66c4a1575a78b4cfc89719 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xa7b7418e4e86fbf22177cb812c1cca2bb1a92e594cc3e1bb777098ed29c19f9b","l1BlockNumber":20}} 09:08:18 [09:08:18.482] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xb1ea8488807b63a85737190f478ef89d5dbabed52a66c4a1575a78b4cfc89719","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:08:18 [09:08:18.497] INFO: world-state:database Creating world state data store at directory /tmp/d104ee1263c6b135/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 09:08:18 [09:08:18.537] INFO: world_state Created world state synchroniser with block history of 64 09:08:18 [09:08:18.537] WARN: node Aztec node is accepting fake proofs 09:08:18 [09:08:18.554] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/d104ee1263c6b135/p2p with map size 134217728 KB (LMDB v2) 09:08:18 [09:08:18.557] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 09:08:18 [09:08:18.558] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/d104ee1263c6b135/p2p-archive with map size 134217728 KB (LMDB v2) 09:08:18 [09:08:18.560] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 09:08:18 [09:08:18.563] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/d104ee1263c6b135/p2p-peers with map size 134217728 KB (LMDB v2) 09:08:18 [09:08:18.570] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 09:08:18 [09:08:18.574] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 09:08:18 [09:08:18.574] VERBOSE: p2p P2P is disabled. Using dummy P2P service. 09:08:18 [09:08:18.579] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 09:08:18 [09:08:18.580] INFO: world_state Started world state synchronizer from block 1 09:08:18 [09:08:18.582] VERBOSE: world-state:block_stream Starting sync from block number 0 09:08:18 [09:08:18.584] INFO: p2p Starting p2p client from block 0 with empty mempools 09:08:18 [09:08:18.585] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 09:08:18 [09:08:18.888] INFO: epoch-prune-watcher EpochPruneWatcher initialized 09:08:18 [09:08:18.932] VERBOSE: validator Initialized validator with addresses: 0xe5305536b72f04b77342c0910ffde4336b6d5171 09:08:18 [09:08:18.932] VERBOSE: node All Aztec Node subsystems synced 09:08:18 [09:08:18.944] INFO: slasher Starting Slasher client... 09:08:18 [09:08:18.954] INFO: sequencer-client Deploying forwarder contract 09:08:18 [09:08:18.957] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 09:08:18 [09:08:18.972] VERBOSE: sequencer-client Sent L1 transaction 0xebd109029113a25c0e160d5fe5637a5d45571c58bccf765ab690a6c4b01aaa05 {"gasLimit":323704,"maxFeePerGas":"95.493446101","maxPriorityFeePerGas":"95.396216612"} 09:08:18 [09:08:18.973] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0xebd109029113a25c0e160d5fe5637a5d45571c58bccf765ab690a6c4b01aaa05. 09:08:18 [09:08:18.977] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 09:08:18 [09:08:18.985] INFO: validator Started validator with addresses: 0xe5305536b72f04b77342c0910ffde4336b6d5171 09:08:18 [09:08:18.985] VERBOSE: validator Validators 0xe5305536b72f04b77342c0910ffde4336b6d5171 are not on the validator committee for epoch 0 09:08:18 [09:08:18.986] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/b6773e77/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 09:08:18 [09:08:18.986] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 09:08:18 [09:08:18.988] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:08:18 [09:08:18.988] VERBOSE: node Sequencer started 09:08:18 [09:08:18.989] INFO: node Aztec Node version: 0.87.6 09:08:18 [09:08:18.989] 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:08:18 [09:08:18.990] VERBOSE: e2e:Circuit Creating a pxe... 09:08:18 [09:08:19.000] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/d93b3482b752dd90/pxe_data with map size 134217728 KB (LMDB v2) 09:08:19 [09:08:19.005] 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":1750065185,"syncedToL1Ts":1750065184,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750065172,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750065208},"newBlockNumber":1,"expectedSlot":1} 09:08:19 [09:08:19.010] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:08:19 [09:08:19.241] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:08:19 [09:08:19.242] WARN: foundation:test-date-provider Time set to 2025-06-16T09:13:16.000Z {"offset":296758,"timeMs":1750065196000} 09:08:19 [09:08:19.354] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 09:08:19 [09:08:19.354] INFO: pxe:service Started PXE connected to chain 31337 version 1040949320 09:08:19 [09:08:19.416] INFO: pxe:service Registered account 0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418 09:08:19 [09:08:19.500] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 09:08:19 [09:08:19.502] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418 09:08:19 [09:08:19.640] 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":1750065208,"version":1040949320},"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:19 [09:08:19.687] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:19 [09:08:19.692] INFO: pxe:service Added contract SchnorrAccount at 0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:08:19 [09:08:19.740] VERBOSE: pxe:block_stream Starting sync from block number 0 09:08:19 [09:08:19.842] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 09:08:19 [09:08:19.992] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 09:08:20 [09:08:20.685] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 09:08:20 [09:08:20.689] 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":1750065208,"version":1040949320},"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:20 [09:08:20.808] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 09:08:20 [09:08:20.810] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:21 [09:08:21.006] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418"} 09:08:21 [09:08:21.061] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:08:21 [09:08:21.062] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418"} 09:08:21 [09:08:21.129] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418"} 09:08:21 [09:08:21.135] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:08:21 [09:08:21.393] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418"} 09:08:21 [09:08:21.463] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 09:08:21 [09:08:21.471] 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":1750065208,"version":1040949320},"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:21 [09:08:21.473] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418"} 09:08:21 [09:08:21.474] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:21 [09:08:21.541] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418"} 09:08:21 [09:08:21.548] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 09:08:21 [09:08:21.578] VERBOSE: simulator:client_execution_context:debug_log Setting 0x105b6aaff0c9bbca623d563ae21506e4a11c5e5881b5ecab28aa6597ff938418 as fee payer 09:08:22 [09:08:22.055] 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":1750065208,"version":1040949320},"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:22 [09:08:22.055] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:22 [09:08:22.613] 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":1750065208,"version":1040949320},"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:22 [09:08:22.638] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:23 [09:08:23.014] INFO: pxe:service Proving completed in 3275.9934840000005ms {"timings":{"total":3275.9934840000005,"sync":2.8861349999988306,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":217.93372499999714,"oracles":{"callPrivateFunction":{"times":[991.660946,364.5930309999985,338.93023299999913]}}},{"functionName":"private_kernel_init","time":141.99400699999933},{"functionName":"ContractClassRegisterer:register","time":963.0065300000006,"oracles":{"loadCapsule":{"times":[22.323511000000508]},"notifyCreatedNullifier":{"times":[0.7651289999994333]},"debugLog":{"times":[0.9831460000004881]},"notifyCreatedContractClassLog":{"times":[6.823416999999608]}}},{"functionName":"private_kernel_inner","time":147.05951900000036},{"functionName":"SchnorrAccount:constructor","time":333.4508100000003,"oracles":{"getContractInstance":{"times":[1.119818999999552]},"debugLog":{"times":[0.5649440000015602,0.4302610000013374]},"fetchTaggedLogs":{"times":[70.83858399999917]},"loadCapsule":{"times":[0.3968800000002375,0.23357600000053935,0.30226799999945797]},"validateEnqueuedNotesAndEvents":{"times":[2.414082999999664]},"notifyCreatedNullifier":{"times":[0.2429969999993773,0.2869680000003427]},"notifyCreatedNote":{"times":[0.5811950000006618]},"getRandomField":{"times":[0.18586499999946682,0.1602840000014112,0.09988299999895389,0.08125199999994948,0.0663620000013907,0.06660200000078476,0.0548819999985426,0.05863100000169652,0.05677099999957136,0.07814200000029814,0.04818200000045181]},"getIndexedTaggingSecretAsSender":{"times":[53.57971499999985]},"incrementAppTaggingSecretIndexAsSender":{"times":[33.75384900000063]}}},{"functionName":"private_kernel_inner","time":150.95454900000004},{"functionName":"SchnorrAccount:entrypoint","time":289.6279800000011,"oracles":{"debugLog":{"times":[0.8235409999997501,0.48077200000079756,0.7888410000014119]},"fetchTaggedLogs":{"times":[71.21166300000004]},"loadCapsule":{"times":[0.5479540000014822,0.3659800000004907,0.6645680000001448]},"validateEnqueuedNotesAndEvents":{"times":[4.8793569999998]},"getNotes":{"times":[2.981007000000318]},"getAuthWitness":{"times":[0.5511239999996178]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0988290000004781]}}},{"functionName":"private_kernel_inner","time":154.88992199999848},{"functionName":"private_kernel_reset","time":224.0035310000003},{"functionName":"private_kernel_tail","time":106.89093299999877}],"unaccounted":543.2958430000053}} 09:08:23 [09:08:23.100] VERBOSE: p2p:tx_pool Adding tx 0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53 to pool {"eventName":"tx-added-to-pool","txHash":"0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 09:08:23 [09:08:23.117] INFO: node Received tx 0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53 {"txHash":"0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53"} 09:08:23 [09:08:23.118] INFO: pxe:service Sent transaction 0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53 09:08:23 [09:08:23.153] 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":1750065208,"version":1040949320},"chainTipArchive":"0x01672bce985a290962418e832ca979916a08fa067c4a69a8b37cda0a2e796dec","blockNumber":1,"slot":2} 09:08:23 [09:08:23.168] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-16T09:13:28.000Z","now":"2025-06-16T09:13:19.926Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 09:08:23 [09:08:23.228] VERBOSE: simulator:public-processor Processed tx 0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53 with no public calls in 26.886649999998554ms {"txHash":"0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53","txFee":2101212240,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":6324},"billedGas":{"daGas":16896,"l2Gas":6324},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":26.886649999998554} 09:08:23 [09:08:23.231] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05859997599999951s {"duration":0.05859997599999951,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:08:23 [09:08:23.265] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x12541020079039aeb5e42676d8111096970e7839fe55395381ee33591f5a3548","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750065208,"version":1040949320},"txHashes":["0x065faed6faadf0a36a2c4de73632b1663eee097bd43b2449f86f3e29e9f4ac53"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":105.49371699999938,"publicProcessDuration":59.61692299999959,"rollupCircuitsDuration":96.81925099999899,"txCount":1,"blockNumber":1,"blockTimestamp":1750065208,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:08:23 [09:08:23.269] VERBOSE: sequencer Attesting committee is empty 09:08:26 [09:08:26.252] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x535f4b80bae912b783cdedfd8e36d8641e5954145550e6fc0d622241f3020889 09:08:26 [09:08:26.256] VERBOSE: node Sent L1 transaction 0x535f4b80bae912b783cdedfd8e36d8641e5954145550e6fc0d622241f3020889 {"gasLimit":487130,"maxFeePerGas":"114.560609658","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 09:08:26 [09:08:26.286] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:08:26 [09:08:26.290] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x535f4b80bae912b783cdedfd8e36d8641e5954145550e6fc0d622241f3020889","calldataSize":1252,"calldataGas":9964,"txCount":1,"blockNumber":1,"blockTimestamp":1750065208,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:08:26 [09:08:26.291] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 09:08:26 [09:08:26.315] INFO: blob-sink:server Received blob sidecar for block 0x962c86c8900a24c36b098000b4afbdbc19828f21b1494a52c5210132702387f1 09:08:26 [09:08:26.327] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:08:26 [09:08:26.327] WARN: foundation:test-date-provider Time set to 2025-06-16T09:13:28.000Z {"offset":301673,"timeMs":1750065208000} 09:08:26 [09:08:26.329] INFO: blob-sink:server Blob sidecar stored successfully for block 0x962c86c8900a24c36b098000b4afbdbc19828f21b1494a52c5210132702387f1 09:08:26 [09:08:26.337] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 09:08:26 [09:08:26.339] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 09:08:26 [09:08:26.389] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750065244 09:08:26 [09:08:26.390] WARN: foundation:test-date-provider Time set to 2025-06-16T09:14:04.000Z {"offset":337610,"timeMs":1750065244000} 09:08:26 [09:08:26.390] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 09:08:26 [09:08:26.577] VERBOSE: archiver:block-helper Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:08:26 [09:08:26.584] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x12541020079039aeb5e42676d8111096970e7839fe55395381ee33591f5a3548","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750065208,"version":1040949320},"archiveRoot":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","archiveNextLeafIndex":2} 09:08:26 [09:08:26.589] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:08:26 [09:08:26.695] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":17.485595000001922,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750065208,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:08:26 [09:08:26.716] VERBOSE: p2p Synched to latest block 1 09:08:26 [09:08:26.719] INFO: node Stopping Aztec Node 09:08:26 [09:08:26.829] 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":1750065244,"version":1040949320},"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:26 [09:08:26.830] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:27 [09:08:27.350] 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":1750065244,"version":1040949320},"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:27 [09:08:27.351] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:27 [09:08:27.872] 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":1750065244,"version":1040949320},"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:27 [09:08:27.874] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:28 [09:08:28.391] 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":1750065244,"version":1040949320},"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:28 [09:08:28.393] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2e3c7e234f301a751d9389d19dd1be3141a4769183587adc040de65b88abc58a","blockNumber":2,"slot":3} 09:08:28 [09:08:28.722] INFO: slasher Slasher client stopped. 09:08:28 [09:08:28.723] INFO: sequencer Stopped sequencer 09:08:28 [09:08:28.723] INFO: p2p P2P client stopped 09:08:28 [09:08:28.725] INFO: world_state Stopped world state synchronizer 09:08:28 [09:08:28.725] INFO: archiver Stopped. 09:08:28 [09:08:28.725] INFO: node Stopped Aztec Node 09:08:28 [09:08:28.735] INFO: blob-sink:server Stopping blob sink 09:08:28 [09:08:28.736] INFO: blob-sink:server Blob sink stopped 09:08:28 PASS src/e2e_circuit_recorder.test.ts 09:08:28 Circuit Recorder 09:08:28 ✓ records circuit execution (12528 ms) 09:08:28 09:08:28 Test Suites: 1 passed, 1 total 09:08:28 Tests: 1 passed, 1 total 09:08:28 Snapshots: 0 total 09:08:28 Time: 18.663 s 09:08:28 Ran all test suites matching /src\/e2e_circuit_recorder.test.ts/i. 09:08:28 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?