Parent Log: http://ci.aztec-labs.com/157a14478d3e36aa Command: d634b34c6dd762bb: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/9b801754ba98479ee645488c29d2fda1eecbfd85 Env: REF_NAME=gh-readonly-queue/next/pr-14963-ee3655e025191bc85c5b3d3122eeedb44e38ffb2 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 20:54:28 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14963_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_45fa6151872caa8b_next 20:54:28 +++ id -u 20:54:28 +++ id -g 20:54:28 ++ 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'\''' 20:54:28 + cid=5217e930a521daaf9f88920da29fcf122599334b13e77e5dc6effc8397c9cb4e 20:54:28 + set +x 20:54:29 {"level":25,"time":1750107269605,"pid":11,"hostname":"5217e930a521","module":"logger","msg":"Logger initialized with level verbose"} 20:54:36 [20:54:36.633] INFO: e2e:e2e_circuit_recorder Running test: Circuit Recorder records circuit execution 20:54:36 [20:54:36.774] INFO: e2e:Circuit Logging metrics to log/Circuit.jsonl 20:54:37 [20:54:37.343] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-hdmKLz/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 20:54:37 [20:54:37.436] INFO: e2e:Circuit Calling anvil_setBlockTimestampInterval with params: [12] 20:54:37 [20:54:37.443] WARN: e2e:Circuit Set block interval to 12 20:54:37 [20:54:37.444] VERBOSE: e2e:Circuit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 20:54:37 [20:54:37.520] VERBOSE: e2e:Circuit Sent L1 transaction 0x6d53100b445d9e43c28859ec0385c20ed5669ffb25bdb01dc1d9e6cd216b3dd2 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 20:54:37 [20:54:37.530] VERBOSE: e2e:Circuit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 20:54:37 [20:54:37.550] VERBOSE: e2e:Circuit Sent L1 transaction 0xf52362270a7f47f546e26855988a1a9caa6b32e9cb4fc217fd3178f0d98b392e {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 20:54:37 [20:54:37.557] VERBOSE: e2e:Circuit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 20:54:37 [20:54:37.583] VERBOSE: e2e:Circuit Sent L1 transaction 0x62fecf0c4fe0a18ec0634e414ba1d6e56537341dd29a2be25adc3d2bcea7a68f {"gasLimit":3073296,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 20:54:37 [20:54:37.597] VERBOSE: e2e:Circuit Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 20:54:37 [20:54:37.619] VERBOSE: e2e:Circuit Sent L1 transaction 0xa62d4fe46e98eae922e4ee3fd7b983785b0636a721b73c84dfa13c13f80f9980 {"gasLimit":1014434,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 20:54:37 [20:54:37.624] VERBOSE: e2e:Circuit Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 20:54:37 [20:54:37.640] VERBOSE: e2e:Circuit Sent L1 transaction 0x18833ed65817a251b69e6b5c397a66167011ce960e32aa7a9d9819e360fde478 {"gasLimit":1966627,"maxFeePerGas":"3.602535441","maxPriorityFeePerGas":"2.48832"} 20:54:37 [20:54:37.645] VERBOSE: e2e:Circuit Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 20:54:37 [20:54:37.682] VERBOSE: e2e:Circuit Sent L1 transaction 0xc883b1774f01db1b012c812b7d7b2a8c2821c9537c54857b0c4dbcdb9afd9c0d {"gasLimit":3042380,"maxFeePerGas":"3.968771807","maxPriorityFeePerGas":"2.985984"} 20:54:37 [20:54:37.686] VERBOSE: e2e:Circuit Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 20:54:37 [20:54:37.698] VERBOSE: e2e:Circuit Sent L1 transaction 0x9a1c775b7dbaebe86663824275203f96ada3050cce2749efdb0ee9deffa8a53e {"gasLimit":100000,"maxFeePerGas":"4.456542195","maxPriorityFeePerGas":"3.5831808"} 20:54:37 [20:54:37.698] VERBOSE: e2e:Circuit Set governance on GSE in 0x9a1c775b7dbaebe86663824275203f96ada3050cce2749efdb0ee9deffa8a53e 20:54:37 [20:54:37.712] VERBOSE: e2e:Circuit Sent L1 transaction 0x7ef54ddd9c9679b68107b14803bebfd6f9efb565431262d3f6fe7dde9e2e3acf {"gasLimit":391719,"maxFeePerGas":"5.082460248","maxPriorityFeePerGas":"4.29981696"} 20:54:37 [20:54:37.718] VERBOSE: e2e:Circuit Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 20:54:37 [20:54:37.718] VERBOSE: e2e:Circuit Waiting for deployments to complete 20:54:37 [20:54:37.718] INFO: e2e:Circuit Waiting for 7 transactions to be mined... 20:54:37 [20:54:37.760] INFO: e2e:Circuit All transactions mined successfully 20:54:37 [20:54:37.777] VERBOSE: e2e:Circuit Sent L1 transaction 0x12a704229c4476bf6f2363e7c694e07ee02a39cfd8e56c4f4666569d6110c53f {"gasLimit":100000,"maxFeePerGas":"5.844895134","maxPriorityFeePerGas":"5.159780352"} 20:54:37 [20:54:37.778] VERBOSE: e2e:Circuit Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x12a704229c4476bf6f2363e7c694e07ee02a39cfd8e56c4f4666569d6110c53f 20:54:37 [20:54:37.791] VERBOSE: e2e:Circuit Sent L1 transaction 0x3829caf2a853bcabcf31c5535cfce8a2090ffe5fa9742bc7f3b21c7356a4f057 {"gasLimit":56661,"maxFeePerGas":"6.793075556","maxPriorityFeePerGas":"6.191736422"} 20:54:37 [20:54:37.804] VERBOSE: e2e:Circuit Sent L1 transaction 0x24da451411444c9ff165c2ea177ee531ce6043a114eaeb0647e95a4f68c512b3 {"gasLimit":339705,"maxFeePerGas":"7.956492664","maxPriorityFeePerGas":"7.430083706"} 20:54:37 [20:54:37.808] VERBOSE: e2e:Circuit Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 20:54:37 [20:54:37.819] VERBOSE: e2e:Circuit Sent L1 transaction 0xcf673be673b634ed1a3bd96e44e43f1d8e9c1f986fd240bedfdd9a2ea8b7da0e {"gasLimit":56804,"maxFeePerGas":"9.376915417","maxPriorityFeePerGas":"8.916100447"} 20:54:37 [20:54:37.819] VERBOSE: e2e:Circuit Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xcf673be673b634ed1a3bd96e44e43f1d8e9c1f986fd240bedfdd9a2ea8b7da0e 20:54:37 [20:54:37.839] VERBOSE: e2e:Circuit Sent L1 transaction 0x070f71d5186e7b1ed4d859dbfeaefb2bea5a2fafe3e02888809f40680c9f04ff {"gasLimit":2474272,"maxFeePerGas":"11.103620729","maxPriorityFeePerGas":"10.699320536"} 20:54:37 [20:54:37.845] VERBOSE: e2e:Circuit Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 20:54:37 [20:54:37.883] VERBOSE: e2e:Circuit Sent L1 transaction 0x083a78da34fb91175504bc3b8fe771a51f6542c225408d04ecae4cd6750b0d3b {"gasLimit":56804,"maxFeePerGas":"13.193106799","maxPriorityFeePerGas":"12.839184643"} 20:54:37 [20:54:37.883] VERBOSE: e2e:Circuit Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x083a78da34fb91175504bc3b8fe771a51f6542c225408d04ecae4cd6750b0d3b 20:54:37 [20:54:37.883] VERBOSE: e2e:Circuit Waiting for deployments to complete 20:54:37 [20:54:37.883] INFO: e2e:Circuit Waiting for 9 transactions to be mined... 20:54:37 [20:54:37.907] INFO: e2e:Circuit All transactions mined successfully 20:54:37 [20:54:37.917] VERBOSE: e2e:Circuit Deployed shared contracts 20:54:37 [20:54:37.934] VERBOSE: e2e:Circuit Sent L1 transaction 0x38acc6ffe4837cab7b50b6856c6dc399fbb992c51de94622b870bd8c437a8d5f {"gasLimit":84837,"maxFeePerGas":"15.722784708","maxPriorityFeePerGas":"15.407021571"} 20:54:37 [20:54:37.935] VERBOSE: e2e:Circuit Funded reward distributor with 10000000000000000000000000 fee asset in 0x38acc6ffe4837cab7b50b6856c6dc399fbb992c51de94622b870bd8c437a8d5f 20:54:37 [20:54:37.985] VERBOSE: e2e:Circuit Sent L1 transaction 0x284a37ae9f4370d6f627717862155eb29d14f0eb6224ced1a522f2bffa19830d {"gasLimit":152965,"maxFeePerGas":"18.764843189","maxPriorityFeePerGas":"18.488425885"} 20:54:37 [20:54:37.995] VERBOSE: e2e:Circuit Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 20:54:37 [20:54:37.995] 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}} 20:54:38 [20:54:38.012] VERBOSE: e2e:Circuit Sent L1 transaction 0x43a9af56b792cc8eb2aba6c44de8f6b8421ab323bdaf116c50d1992d342af5cd {"gasLimit":86397,"maxFeePerGas":"22.428139055","maxPriorityFeePerGas":"22.186111062"} 20:54:38 [20:54:38.060] VERBOSE: e2e:Circuit Sent L1 transaction 0xef15190fa19adc74ff93fa7638efa732f82412ca10920e56cda6f918d0c35277 {"gasLimit":5039811,"maxFeePerGas":"26.835364865","maxPriorityFeePerGas":"26.623333274"} 20:54:38 [20:54:38.090] VERBOSE: e2e:Circuit Sent L1 transaction 0x7f525689716b5fc4701a5e131f1923a37aefdecd2677afa6e8c1b3e6e291cc89 {"gasLimit":2810697,"maxFeePerGas":"32.133654785","maxPriorityFeePerGas":"31.947999928"} 20:54:38 [20:54:38.096] VERBOSE: e2e:Circuit Awaiting for linked libraries to be deployed 20:54:38 [20:54:38.155] VERBOSE: e2e:Circuit Sent L1 transaction 0x72f464770272f5cb8f7610d004a2322e0134c8c9732da50dd7278852a0ca942c {"gasLimit":10876641,"maxFeePerGas":"38.506545592","maxPriorityFeePerGas":"38.337599913"} 20:54:38 [20:54:38.167] 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}} 20:54:38 [20:54:38.168] INFO: e2e:Circuit Waiting for 11 transactions to be mined... 20:54:38 [20:54:38.190] INFO: e2e:Circuit All transactions mined successfully 20:54:38 [20:54:38.190] VERBOSE: e2e:Circuit All core contracts have been deployed 20:54:38 [20:54:38.202] VERBOSE: e2e:Circuit Sent L1 transaction 0x862e7145e6e112c29a3d88e3fdc90c6d2f8322d5ae7b0a24070e674bd20643aa {"gasLimit":64317,"maxFeePerGas":"46.156244971","maxPriorityFeePerGas":"46.005119895"} 20:54:38 [20:54:38.202] VERBOSE: e2e:Circuit Funding fee juice portal with 10000000000000000000000 fee juice in 0x862e7145e6e112c29a3d88e3fdc90c6d2f8322d5ae7b0a24070e674bd20643aa (accelerated test deployments) 20:54:38 [20:54:38.222] VERBOSE: e2e:Circuit Sent L1 transaction 0xf9bd034e851e90c79b4e95d1f9046ddd4a1a40ec6eede47b13ae8228669f5559 {"gasLimit":1040131,"maxFeePerGas":"55.349793131","maxPriorityFeePerGas":"55.206143874"} 20:54:38 [20:54:38.227] VERBOSE: e2e:Circuit Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 20:54:38 [20:54:38.305] VERBOSE: e2e:Circuit Sent L1 transaction 0xd8b4340dd2126e257a75fb6e637c902cd083f56c36e42904b73db2350b3d0e46 {"gasLimit":116979,"maxFeePerGas":"66.37312991","maxPriorityFeePerGas":"66.247372648"} 20:54:38 [20:54:38.305] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0xd8b4340dd2126e257a75fb6e637c902cd083f56c36e42904b73db2350b3d0e46 20:54:38 [20:54:38.334] VERBOSE: e2e:Circuit Sent L1 transaction 0xe7c34d700c6ed75123cf0109ff199ae6624e25a10285168fcaeef198b2116518 {"gasLimit":109478,"maxFeePerGas":"79.607793142","maxPriorityFeePerGas":"79.496847177"} 20:54:38 [20:54:38.335] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xe7c34d700c6ed75123cf0109ff199ae6624e25a10285168fcaeef198b2116518 20:54:38 [20:54:38.341] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 20:54:38 [20:54:38.376] INFO: e2e:Circuit All transactions mined successfully 20:54:38 [20:54:38.385] VERBOSE: e2e:Circuit Rollup deployed 20:54:38 [20:54:38.386] VERBOSE: e2e:Circuit Waiting for rollup and slash factory to be deployed 20:54:38 [20:54:38.386] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 20:54:38 [20:54:38.412] INFO: e2e:Circuit All transactions mined successfully 20:54:38 [20:54:38.413] VERBOSE: e2e:Circuit All transactions for L1 deployment have been mined 20:54:38 [20:54:38.434] 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"} 20:54:38 [20:54:38.435] INFO: e2e:Circuit Handing over to governance 20:54:38 [20:54:38.441] WARN: foundation:test-date-provider Time set to 2025-06-16T20:59:24.000Z {"offset":285559,"timeMs":1750107564000} 20:54:38 [20:54:38.446] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 20:54:38 [20:54:38.447] INFO: telemetry:client Using NoopTelemetryClient 20:54:38 [20:54:38.454] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/f80ac5592d563828/blob-sink with map size 134217728 KB (LMDB v2) 20:54:38 [20:54:38.459] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 20:54:38 [20:54:38.466] INFO: blob-sink:server Server is running on http://localhost:36501 20:54:38 [20:54:38.466] VERBOSE: e2e:Circuit Creating and synching an aztec node... 20:54:38 [20:54:38.467] VERBOSE: e2e:Circuit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/1ca90a94/acvm 20:54:38 [20:54:38.468] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36501"} 20:54:38 [20:54:38.489] VERBOSE: node:MAIN-aztec-node Snapshot sync is disabled. No snapshots URL provided. 20:54:38 [20:54:38.490] INFO: archiver:lmdb Creating archiver data store at directory /tmp/f80ac5592d563828/archiver with map size 134217728 KB (LMDB v2) 20:54:38 [20:54:38.491] INFO: archiver:lmdb Starting data store with maxReaders 16 20:54:38 [20:54:38.891] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:36501"} 20:54:38 [20:54:38.908] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:36501"} 20:54:38 [20:54:38.908] WARN: node:blob-sink:client No L1 consensus host urls configured 20:54:38 [20:54:38.909] WARN: node:blob-sink:client No archive client configured 20:54:38 [20:54:38.912] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xfb731e919bf2f75daa5bb23bd348f45bc4030c39231a806153daa5e3ffb0c188 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x2bc6717b1b945bca3673bc26b28434219f01925fcf6887fe9de5224c6828de4a","l1BlockNumber":20}} 20:54:38 [20:54:38.934] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xfb731e919bf2f75daa5bb23bd348f45bc4030c39231a806153daa5e3ffb0c188","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 20:54:38 [20:54:38.945] INFO: world-state:database Creating world state data store at directory /tmp/f80ac5592d563828/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 20:54:38 [20:54:38.985] INFO: world_state Created world state synchroniser with block history of 64 20:54:38 [20:54:38.985] WARN: node:MAIN-aztec-node Aztec node is accepting fake proofs 20:54:39 [20:54:39.004] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/f80ac5592d563828/p2p with map size 134217728 KB (LMDB v2) 20:54:39 [20:54:39.007] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 20:54:39 [20:54:39.011] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/f80ac5592d563828/p2p-archive with map size 134217728 KB (LMDB v2) 20:54:39 [20:54:39.013] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 20:54:39 [20:54:39.015] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/f80ac5592d563828/p2p-peers with map size 134217728 KB (LMDB v2) 20:54:39 [20:54:39.017] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 20:54:39 [20:54:39.022] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 20:54:39 [20:54:39.023] VERBOSE: p2p P2P is disabled. Using dummy P2P service. 20:54:39 [20:54:39.025] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 20:54:39 [20:54:39.026] INFO: world_state Started world state synchronizer from block 1 20:54:39 [20:54:39.028] VERBOSE: world-state:block_stream Starting sync from block number 0 20:54:39 [20:54:39.034] INFO: p2p Starting p2p client from block 0 with empty mempools 20:54:39 [20:54:39.034] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 20:54:39 [20:54:39.360] INFO: epoch-prune-watcher EpochPruneWatcher initialized 20:54:39 [20:54:39.404] VERBOSE: validator Initialized validator with addresses: 0x6e895d169c0bc7689aca2dcc87ba6e98b3cec9fe 20:54:39 [20:54:39.404] VERBOSE: node:MAIN-aztec-node All Aztec Node subsystems synced 20:54:39 [20:54:39.419] INFO: slasher Starting Slasher client... 20:54:39 [20:54:39.428] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 20:54:39 [20:54:39.430] INFO: sequencer-client Deploying forwarder contract 20:54:39 [20:54:39.455] VERBOSE: sequencer-client Sent L1 transaction 0x37f0b2200c6cd2a7f6467eaaac174580bf6ee00a5bdd5714ed04401e79fc621d {"gasLimit":323704,"maxFeePerGas":"95.493384459","maxPriorityFeePerGas":"95.396216612"} 20:54:39 [20:54:39.456] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0x37f0b2200c6cd2a7f6467eaaac174580bf6ee00a5bdd5714ed04401e79fc621d. 20:54:39 [20:54:39.462] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 20:54:39 [20:54:39.482] INFO: validator Started validator with addresses: 0x6e895d169c0bc7689aca2dcc87ba6e98b3cec9fe 20:54:39 [20:54:39.482] VERBOSE: validator Validators 0x6e895d169c0bc7689aca2dcc87ba6e98b3cec9fe are not on the validator committee for epoch 0 20:54:39 [20:54:39.483] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/1ca90a94/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 20:54:39 [20:54:39.483] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 20:54:39 [20:54:39.486] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 20:54:39 [20:54:39.487] VERBOSE: node:MAIN-aztec-node Sequencer started 20:54:39 [20:54:39.488] INFO: node:MAIN-aztec-node Aztec Node version: 0.87.6 20:54:39 [20:54:39.488] 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"} 20:54:39 [20:54:39.489] VERBOSE: e2e:Circuit Creating a pxe... 20:54:39 [20:54:39.500] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/58bd78ad7593b0c4/pxe_data with map size 134217728 KB (LMDB v2) 20:54:39 [20:54:39.509] 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":1750107565,"syncedToL1Ts":1750107564,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750107552,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750107588},"newBlockNumber":1,"expectedSlot":1} 20:54:39 [20:54:39.511] INFO: pxe:data:lmdb Starting data store with maxReaders 16 20:54:39 [20:54:39.730] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 20:54:39 [20:54:39.731] WARN: foundation:test-date-provider Time set to 2025-06-16T20:59:36.000Z {"offset":296270,"timeMs":1750107576000} 20:54:39 [20:54:39.866] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 20:54:39 [20:54:39.867] INFO: pxe:service Started PXE connected to chain 31337 version 797043270 20:54:39 [20:54:39.919] INFO: pxe:service Registered account 0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5 20:54:40 [20:54:40.036] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 20:54:40 [20:54:40.043] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5 20:54:40 [20:54:40.234] INFO: pxe:service Added contract SchnorrAccount at 0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 20:54:40 [20:54:40.306] VERBOSE: pxe:block_stream Starting sync from block number 0 20:54:40 [20:54:40.374] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 20:54:40 [20:54:40.529] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 20:54:41 [20:54:41.335] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 20:54:41 [20:54:41.338] 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":1750107588,"version":797043270},"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:41 [20:54:41.339] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:41 [20:54:41.465] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 20:54:41 [20:54:41.726] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5"} 20:54:41 [20:54:41.808] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 20:54:41 [20:54:41.810] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5"} 20:54:41 [20:54:41.852] 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":1750107588,"version":797043270},"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:41 [20:54:41.853] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:41 [20:54:41.868] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5"} 20:54:41 [20:54:41.880] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 20:54:42 [20:54:42.187] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5"} 20:54:42 [20:54:42.240] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 20:54:42 [20:54:42.265] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5"} 20:54:42 [20:54:42.336] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5"} 20:54:42 [20:54:42.343] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 20:54:42 [20:54:42.382] 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":1750107588,"version":797043270},"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:42 [20:54:42.383] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:42 [20:54:42.398] VERBOSE: simulator:client_execution_context:debug_log Setting 0x260d70719a2dbdd74974d27862917bd3bee5ddc530975e306c34f4b389e78be5 as fee payer 20:54:43 [20:54:43.066] 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":1750107588,"version":797043270},"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:43 [20:54:43.067] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:43 [20:54:43.845] 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":1750107588,"version":797043270},"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:43 [20:54:43.851] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:43 [20:54:43.914] INFO: pxe:service Proving completed in 3623.395504ms {"timings":{"total":3623.395504,"sync":16.194854999999734,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":247.3755310000015,"oracles":{"callPrivateFunction":{"times":[1136.7413300000007,455.77206300000034,376.7578740000008]}}},{"functionName":"private_kernel_init","time":121.66190399999869},{"functionName":"ContractClassRegisterer:register","time":1106.461761999999,"oracles":{"loadCapsule":{"times":[25.208897000000434]},"notifyCreatedNullifier":{"times":[1.3532749999994849]},"debugLog":{"times":[1.2986239999991085]},"notifyCreatedContractClassLog":{"times":[19.562573000001066]}}},{"functionName":"private_kernel_inner","time":160.91231200000038},{"functionName":"SchnorrAccount:constructor","time":409.96399799999926,"oracles":{"getContractInstance":{"times":[7.513363000000027]},"debugLog":{"times":[0.7046389999995881,0.6649469999993016]},"fetchTaggedLogs":{"times":[65.53438299999834]},"loadCapsule":{"times":[0.5570239999997284,0.29593799999929615,0.656966000000466]},"validateEnqueuedNotesAndEvents":{"times":[3.2853850000010425]},"notifyCreatedNullifier":{"times":[0.3117679999995744,0.2384459999993851]},"notifyCreatedNote":{"times":[0.6243059999997058]},"getRandomField":{"times":[0.26102699999864853,0.21737500000017462,0.09650200000032783,0.08914200000072015,0.09311200000047393,0.1329230000010284,0.06374200000027486,0.07561200000054669,0.0689619999993738,0.07687199999963923,0.06208100000003469]},"getIndexedTaggingSecretAsSender":{"times":[44.549103999999716]},"incrementAppTaggingSecretIndexAsSender":{"times":[46.81308200000058]}}},{"functionName":"private_kernel_inner","time":132.10271199999988},{"functionName":"SchnorrAccount:entrypoint","time":329.3421469999994,"oracles":{"debugLog":{"times":[0.8562920000003942,0.6214159999999538,0.7990200000003824]},"fetchTaggedLogs":{"times":[73.23913999999968]},"loadCapsule":{"times":[0.7734200000013516,0.6557670000001963,1.6489130000009027]},"validateEnqueuedNotesAndEvents":{"times":[12.124080999999933]},"getNotes":{"times":[6.2847209999999905]},"getAuthWitness":{"times":[0.558645000000979]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.3440950000003795]}}},{"functionName":"private_kernel_inner","time":148.48056300000098},{"functionName":"private_kernel_reset","time":258.12487800000054},{"functionName":"private_kernel_tail","time":111.34389899999951}],"unaccounted":581.4309430000012}} 20:54:44 [20:54:44.013] VERBOSE: p2p:tx_pool Adding tx 0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427 to pool {"eventName":"tx-added-to-pool","txHash":"0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 20:54:44 [20:54:44.036] INFO: node:MAIN-aztec-node Received tx 0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427 {"txHash":"0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427"} 20:54:44 [20:54:44.037] INFO: pxe:service Sent transaction 0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427 20:54:44 [20:54:44.415] 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":1750107588,"version":797043270},"chainTipArchive":"0x03045a82fbc67feda1ff7df08097a3f4092ead28d3347309818f6c4b38a289e1","blockNumber":1,"slot":2} 20:54:44 [20:54:44.434] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-16T20:59:48.000Z","now":"2025-06-16T20:59:40.704Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 20:54:44 [20:54:44.509] VERBOSE: simulator:public-processor Processed tx 0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427 with no public calls in 27.840673999999126ms {"txHash":"0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427","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":27.840673999999126} 20:54:44 [20:54:44.512] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.07302866600000016s {"duration":0.07302866600000016,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 20:54:44 [20:54:44.560] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1ee26da0529a9b6dd4a1d2e9f9abfe757a056ff6b3337385cc5b7a0775a52d35","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750107588,"version":797043270},"txHashes":["0x16d47359e679eb60269adc2fc88d29b0ee7243d59bafc35d563b3cee379f3427"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":133.79957599999943,"publicProcessDuration":74.16064400000141,"rollupCircuitsDuration":125.52270299999873,"txCount":1,"blockNumber":1,"blockTimestamp":1750107588,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 20:54:44 [20:54:44.564] VERBOSE: sequencer Attesting committee is empty 20:54:47 [20:54:47.407] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xa07fa76322025fabe0babc882e26ee012fdcb4f764d0be296e33388f0192968d 20:54:47 [20:54:47.408] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0xa07fa76322025fabe0babc882e26ee012fdcb4f764d0be296e33388f0192968d {"gasLimit":476500,"maxFeePerGas":"114.560555674","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 20:54:47 [20:54:47.421] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 20:54:47 [20:54:47.423] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xa07fa76322025fabe0babc882e26ee012fdcb4f764d0be296e33388f0192968d","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":1,"blockTimestamp":1750107588,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 20:54:47 [20:54:47.424] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 20:54:47 [20:54:47.458] INFO: blob-sink:server Received blob sidecar for block 0x31d25ae2d42c0f5d18a3c8a1e679ee6771415cec84f36abebf5b0fa75718cf91 20:54:47 [20:54:47.472] INFO: blob-sink:server Blob sidecar stored successfully for block 0x31d25ae2d42c0f5d18a3c8a1e679ee6771415cec84f36abebf5b0fa75718cf91 20:54:47 [20:54:47.477] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 20:54:47 [20:54:47.477] WARN: foundation:test-date-provider Time set to 2025-06-16T20:59:48.000Z {"offset":300523,"timeMs":1750107588000} 20:54:47 [20:54:47.489] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 20:54:47 [20:54:47.491] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 20:54:47 [20:54:47.609] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750107624 20:54:47 [20:54:47.609] WARN: foundation:test-date-provider Time set to 2025-06-16T21:00:24.000Z {"offset":336391,"timeMs":1750107624000} 20:54:47 [20:54:47.610] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 20:54:47 [20:54:47.765] VERBOSE: archiver:block-helper Store contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 20:54:47 [20:54:47.771] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1ee26da0529a9b6dd4a1d2e9f9abfe757a056ff6b3337385cc5b7a0775a52d35","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750107588,"version":797043270},"archiveRoot":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","archiveNextLeafIndex":2} 20:54:47 [20:54:47.779] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 20:54:47 [20:54:47.798] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":11.47876499999984,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750107588,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 20:54:47 [20:54:47.827] VERBOSE: p2p Synched to latest block 1 20:54:47 [20:54:47.832] INFO: node:MAIN-aztec-node Stopping Aztec Node 20:54:47 [20:54:47.946] 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":1750107624,"version":797043270},"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:47 [20:54:47.947] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:48 [20:54:48.470] 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":1750107624,"version":797043270},"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:48 [20:54:48.472] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:48 [20:54:48.992] 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":1750107624,"version":797043270},"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:48 [20:54:48.993] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:49 [20:54:49.511] 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":1750107624,"version":797043270},"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:49 [20:54:49.512] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x26bc91af895224bcbf79be518a3b57af4fca8cd0d6cfeebefc28614422216cf6","blockNumber":2,"slot":3} 20:54:49 [20:54:49.833] INFO: slasher Slasher client stopped. 20:54:49 [20:54:49.833] INFO: sequencer Stopped sequencer 20:54:49 [20:54:49.834] INFO: p2p P2P client stopped 20:54:49 [20:54:49.837] INFO: world_state Stopped world state synchronizer 20:54:49 [20:54:49.838] INFO: archiver Stopped. 20:54:49 [20:54:49.838] INFO: node:MAIN-aztec-node Stopped Aztec Node 20:54:49 [20:54:49.849] INFO: blob-sink:server Stopping blob sink 20:54:49 [20:54:49.850] INFO: blob-sink:server Blob sink stopped 20:54:49 PASS src/e2e_circuit_recorder.test.ts 20:54:49 Circuit Recorder 20:54:49 ✓ records circuit execution (13227 ms) 20:54:49 20:54:49 Test Suites: 1 passed, 1 total 20:54:49 Tests: 1 passed, 1 total 20:54:49 Snapshots: 0 total 20:54:49 Time: 20.48 s 20:54:49 Ran all test suites matching src/e2e_circuit_recorder.test.ts. 20:54:49 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?