Parent Log: http://ci.aztec-labs.com/c4378d58bdcb481c Command: 9d60524367dfa79a: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/056e5230c330d6ad19900135ecf2a4787181496a Env: REF_NAME=gh-readonly-queue/next/pr-12986-a9f91dd1e5946aecfeb192ce869eb3e8eca2742e CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 13:10:48 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-12986_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_45fa6151872caa8b_next 13:10:48 +++ id -u 13:10:48 +++ id -g 13:10:48 ++ 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'\''' 13:10:48 + cid=3eff9011e68420ea7c127a086207c6f63f318b210c15c416763a150c182cce28 13:10:48 + set +x 13:10:49 {"level":25,"time":1750165849561,"pid":12,"hostname":"3eff9011e684","module":"logger","msg":"Logger initialized with level verbose"} 13:10:56 [13:10:56.124] INFO: e2e:e2e_circuit_recorder Running test: Circuit Recorder records circuit execution 13:10:56 [13:10:56.269] INFO: e2e:Circuit Logging metrics to log/Circuit.jsonl 13:10:56 [13:10:56.842] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-PEakWD/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 13:10:56 [13:10:56.910] INFO: e2e:Circuit Calling anvil_setBlockTimestampInterval with params: [12] 13:10:56 [13:10:56.915] WARN: e2e:Circuit Set block interval to 12 13:10:56 [13:10:56.916] VERBOSE: e2e:Circuit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 13:10:56 [13:10:56.955] VERBOSE: e2e:Circuit Sent L1 transaction 0x6d53100b445d9e43c28859ec0385c20ed5669ffb25bdb01dc1d9e6cd216b3dd2 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 13:10:56 [13:10:56.962] VERBOSE: e2e:Circuit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 13:10:56 [13:10:56.978] VERBOSE: e2e:Circuit Sent L1 transaction 0xf52362270a7f47f546e26855988a1a9caa6b32e9cb4fc217fd3178f0d98b392e {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 13:10:56 [13:10:56.982] VERBOSE: e2e:Circuit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 13:10:57 [13:10:57.012] VERBOSE: e2e:Circuit Sent L1 transaction 0x62fecf0c4fe0a18ec0634e414ba1d6e56537341dd29a2be25adc3d2bcea7a68f {"gasLimit":3073296,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 13:10:57 [13:10:57.019] VERBOSE: e2e:Circuit Deployed GSE at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 13:10:57 [13:10:57.040] VERBOSE: e2e:Circuit Sent L1 transaction 0xa62d4fe46e98eae922e4ee3fd7b983785b0636a721b73c84dfa13c13f80f9980 {"gasLimit":1014434,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 13:10:57 [13:10:57.046] VERBOSE: e2e:Circuit Deployed Registry at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 13:10:57 [13:10:57.064] VERBOSE: e2e:Circuit Sent L1 transaction 0x18833ed65817a251b69e6b5c397a66167011ce960e32aa7a9d9819e360fde478 {"gasLimit":1966627,"maxFeePerGas":"3.602535441","maxPriorityFeePerGas":"2.48832"} 13:10:57 [13:10:57.071] VERBOSE: e2e:Circuit Deployed GovernanceProposer at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 13:10:57 [13:10:57.107] VERBOSE: e2e:Circuit Sent L1 transaction 0xc883b1774f01db1b012c812b7d7b2a8c2821c9537c54857b0c4dbcdb9afd9c0d {"gasLimit":3042380,"maxFeePerGas":"3.968771807","maxPriorityFeePerGas":"2.985984"} 13:10:57 [13:10:57.116] VERBOSE: e2e:Circuit Deployed Governance at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 13:10:57 [13:10:57.128] VERBOSE: e2e:Circuit Sent L1 transaction 0x9a1c775b7dbaebe86663824275203f96ada3050cce2749efdb0ee9deffa8a53e {"gasLimit":100000,"maxFeePerGas":"4.456542195","maxPriorityFeePerGas":"3.5831808"} 13:10:57 [13:10:57.129] VERBOSE: e2e:Circuit Set governance on GSE in 0x9a1c775b7dbaebe86663824275203f96ada3050cce2749efdb0ee9deffa8a53e 13:10:57 [13:10:57.142] VERBOSE: e2e:Circuit Sent L1 transaction 0x7ef54ddd9c9679b68107b14803bebfd6f9efb565431262d3f6fe7dde9e2e3acf {"gasLimit":391719,"maxFeePerGas":"5.082460248","maxPriorityFeePerGas":"4.29981696"} 13:10:57 [13:10:57.147] VERBOSE: e2e:Circuit Deployed CoinIssuer at 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 13:10:57 [13:10:57.147] VERBOSE: e2e:Circuit Waiting for deployments to complete 13:10:57 [13:10:57.148] INFO: e2e:Circuit Waiting for 7 transactions to be mined... 13:10:57 [13:10:57.173] INFO: e2e:Circuit All transactions mined successfully 13:10:57 [13:10:57.180] VERBOSE: e2e:Circuit Sent L1 transaction 0x12a704229c4476bf6f2363e7c694e07ee02a39cfd8e56c4f4666569d6110c53f {"gasLimit":100000,"maxFeePerGas":"5.844895134","maxPriorityFeePerGas":"5.159780352"} 13:10:57 [13:10:57.180] VERBOSE: e2e:Circuit Added coin issuer 0xa513e6e4b8f2a923d98304ec87f64353c4d5c853 as minter on fee asset in 0x12a704229c4476bf6f2363e7c694e07ee02a39cfd8e56c4f4666569d6110c53f 13:10:57 [13:10:57.199] VERBOSE: e2e:Circuit Sent L1 transaction 0x3829caf2a853bcabcf31c5535cfce8a2090ffe5fa9742bc7f3b21c7356a4f057 {"gasLimit":56661,"maxFeePerGas":"6.793075556","maxPriorityFeePerGas":"6.191736422"} 13:10:57 [13:10:57.215] VERBOSE: e2e:Circuit Sent L1 transaction 0x24da451411444c9ff165c2ea177ee531ce6043a114eaeb0647e95a4f68c512b3 {"gasLimit":339705,"maxFeePerGas":"7.956492664","maxPriorityFeePerGas":"7.430083706"} 13:10:57 [13:10:57.222] VERBOSE: e2e:Circuit Deployed FeeAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 13:10:57 [13:10:57.237] VERBOSE: e2e:Circuit Sent L1 transaction 0xcf673be673b634ed1a3bd96e44e43f1d8e9c1f986fd240bedfdd9a2ea8b7da0e {"gasLimit":56804,"maxFeePerGas":"9.376915417","maxPriorityFeePerGas":"8.916100447"} 13:10:57 [13:10:57.237] VERBOSE: e2e:Circuit Added fee asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on fee asset in 0xcf673be673b634ed1a3bd96e44e43f1d8e9c1f986fd240bedfdd9a2ea8b7da0e 13:10:57 [13:10:57.256] VERBOSE: e2e:Circuit Sent L1 transaction 0x070f71d5186e7b1ed4d859dbfeaefb2bea5a2fafe3e02888809f40680c9f04ff {"gasLimit":2474272,"maxFeePerGas":"11.103620729","maxPriorityFeePerGas":"10.699320536"} 13:10:57 [13:10:57.261] VERBOSE: e2e:Circuit Deployed StakingAssetHandler at 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 13:10:57 [13:10:57.280] VERBOSE: e2e:Circuit Sent L1 transaction 0x083a78da34fb91175504bc3b8fe771a51f6542c225408d04ecae4cd6750b0d3b {"gasLimit":56804,"maxFeePerGas":"13.193106799","maxPriorityFeePerGas":"12.839184643"} 13:10:57 [13:10:57.280] VERBOSE: e2e:Circuit Added staking asset handler 0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0 as minter on staking asset in 0x083a78da34fb91175504bc3b8fe771a51f6542c225408d04ecae4cd6750b0d3b 13:10:57 [13:10:57.280] VERBOSE: e2e:Circuit Waiting for deployments to complete 13:10:57 [13:10:57.280] INFO: e2e:Circuit Waiting for 9 transactions to be mined... 13:10:57 [13:10:57.306] INFO: e2e:Circuit All transactions mined successfully 13:10:57 [13:10:57.318] VERBOSE: e2e:Circuit Deployed shared contracts 13:10:57 [13:10:57.338] VERBOSE: e2e:Circuit Sent L1 transaction 0x38acc6ffe4837cab7b50b6856c6dc399fbb992c51de94622b870bd8c437a8d5f {"gasLimit":84837,"maxFeePerGas":"15.722784708","maxPriorityFeePerGas":"15.407021571"} 13:10:57 [13:10:57.339] VERBOSE: e2e:Circuit Funded reward distributor with 10000000000000000000000000 fee asset in 0x38acc6ffe4837cab7b50b6856c6dc399fbb992c51de94622b870bd8c437a8d5f 13:10:57 [13:10:57.355] VERBOSE: e2e:Circuit Sent L1 transaction 0x284a37ae9f4370d6f627717862155eb29d14f0eb6224ced1a522f2bffa19830d {"gasLimit":152965,"maxFeePerGas":"18.764843189","maxPriorityFeePerGas":"18.488425885"} 13:10:57 [13:10:57.359] VERBOSE: e2e:Circuit Rollup will use the mock verifier at 0x0b306bf915c4d645ff596e518faf3f9669b97016 13:10:57 [13:10:57.360] 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}} 13:10:57 [13:10:57.372] VERBOSE: e2e:Circuit Sent L1 transaction 0xa2aa91eff08cb21917863e98f7fe89fec4058127080483e8bae14662ef06eb90 {"gasLimit":86397,"maxFeePerGas":"22.428139055","maxPriorityFeePerGas":"22.186111062"} 13:10:57 [13:10:57.410] VERBOSE: e2e:Circuit Sent L1 transaction 0xbb277e12e8750494662c93c71532f45fd833b2e04c13eb13a11a334c9d1afd67 {"gasLimit":5019565,"maxFeePerGas":"26.835364865","maxPriorityFeePerGas":"26.623333274"} 13:10:57 [13:10:57.440] VERBOSE: e2e:Circuit Sent L1 transaction 0x0e993519fce6f2b8f7f6c568a5f32f75278ac5f9194a1d49d436084a1bcfee68 {"gasLimit":2810697,"maxFeePerGas":"32.133654785","maxPriorityFeePerGas":"31.947999928"} 13:10:57 [13:10:57.448] VERBOSE: e2e:Circuit Awaiting for linked libraries to be deployed 13:10:57 [13:10:57.498] VERBOSE: e2e:Circuit Sent L1 transaction 0xb38d3cd880e70c54813ebbe40e27b1a867e1800b168bb5815b2fb5b291905c79 {"gasLimit":10876627,"maxFeePerGas":"38.506519487","maxPriorityFeePerGas":"38.337599913"} 13:10:57 [13:10:57.507] 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}} 13:10:57 [13:10:57.508] INFO: e2e:Circuit Waiting for 11 transactions to be mined... 13:10:57 [13:10:57.536] INFO: e2e:Circuit All transactions mined successfully 13:10:57 [13:10:57.537] VERBOSE: e2e:Circuit All core contracts have been deployed 13:10:57 [13:10:57.558] VERBOSE: e2e:Circuit Sent L1 transaction 0x42d3955070a785a541790e239793c54c08639e00975631775ce96ad9f15d180f {"gasLimit":64317,"maxFeePerGas":"46.15622162","maxPriorityFeePerGas":"46.005119895"} 13:10:57 [13:10:57.559] VERBOSE: e2e:Circuit Funding fee juice portal with 10000000000000000000000 fee juice in 0x42d3955070a785a541790e239793c54c08639e00975631775ce96ad9f15d180f (accelerated test deployments) 13:10:57 [13:10:57.571] VERBOSE: e2e:Circuit Sent L1 transaction 0x05693982f49a54a2ce11a6c94ddf2b677c305f14f9128146b2a7b7cac56ce0e1 {"gasLimit":1040131,"maxFeePerGas":"55.34977092","maxPriorityFeePerGas":"55.206143874"} 13:10:57 [13:10:57.575] VERBOSE: e2e:Circuit Deployed SlashFactory at 0x59b670e9fa9d0a427751af201d676719a970857b 13:10:57 [13:10:57.596] VERBOSE: e2e:Circuit Sent L1 transaction 0x54f6e4ef6019f88926591675f225f2521519b2c6410152c2453d7c9a43c74f06 {"gasLimit":116979,"maxFeePerGas":"66.373110464","maxPriorityFeePerGas":"66.247372648"} 13:10:57 [13:10:57.596] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to registry 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0x54f6e4ef6019f88926591675f225f2521519b2c6410152c2453d7c9a43c74f06 13:10:57 [13:10:57.613] VERBOSE: e2e:Circuit Sent L1 transaction 0x3ee02d74ef77cd2347340726f658b4a94cdfbc2447ba3ee01b1c43f45abc3ae8 {"gasLimit":109478,"maxFeePerGas":"79.607775989","maxPriorityFeePerGas":"79.496847177"} 13:10:57 [13:10:57.613] VERBOSE: e2e:Circuit Adding rollup 0x3aa5ebb10dc797cac828524e59a333d0a371443c to GSE 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x3ee02d74ef77cd2347340726f658b4a94cdfbc2447ba3ee01b1c43f45abc3ae8 13:10:57 [13:10:57.617] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 13:10:57 [13:10:57.637] INFO: e2e:Circuit All transactions mined successfully 13:10:57 [13:10:57.643] VERBOSE: e2e:Circuit Rollup deployed 13:10:57 [13:10:57.643] VERBOSE: e2e:Circuit Waiting for rollup and slash factory to be deployed 13:10:57 [13:10:57.643] INFO: e2e:Circuit Waiting for 12 transactions to be mined... 13:10:57 [13:10:57.667] INFO: e2e:Circuit All transactions mined successfully 13:10:57 [13:10:57.668] VERBOSE: e2e:Circuit All transactions for L1 deployment have been mined 13:10:57 [13:10:57.704] 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"} 13:10:57 [13:10:57.705] INFO: e2e:Circuit Handing over to governance 13:10:57 [13:10:57.718] WARN: foundation:test-date-provider Time set to 2025-06-17T13:15:44.000Z {"offset":286282,"timeMs":1750166144000} 13:10:57 [13:10:57.733] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 13:10:57 [13:10:57.734] INFO: telemetry:client Using NoopTelemetryClient 13:10:57 [13:10:57.742] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/1352214b2ede9ad9/blob-sink with map size 134217728 KB (LMDB v2) 13:10:57 [13:10:57.750] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 13:10:57 [13:10:57.756] INFO: blob-sink:server Server is running on http://localhost:40417 13:10:57 [13:10:57.756] VERBOSE: e2e:Circuit Creating and synching an aztec node... 13:10:57 [13:10:57.757] VERBOSE: e2e:Circuit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/401e5011/acvm 13:10:57 [13:10:57.759] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:40417"} 13:10:57 [13:10:57.780] VERBOSE: node:MAIN-aztec-node Snapshot sync is disabled. No snapshots URL provided. 13:10:57 [13:10:57.781] INFO: archiver:lmdb Creating archiver data store at directory /tmp/1352214b2ede9ad9/archiver with map size 134217728 KB (LMDB v2) 13:10:57 [13:10:57.783] INFO: archiver:lmdb Starting data store with maxReaders 16 13:10:58 [13:10:58.196] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:40417"} 13:10:58 [13:10:58.213] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:40417"} 13:10:58 [13:10:58.213] WARN: node:blob-sink:client No L1 consensus host urls configured 13:10:58 [13:10:58.213] WARN: node:blob-sink:client No archive client configured 13:10:58 [13:10:58.216] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xf6aa5f8f6c511c66655a7f3c458393094c62ae4f1f4a352691dfcb8c3eb72d10 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xb184b68f7fd737f87ad94084042ec430894e48c0ef3d1f651f2faefde49d9591","l1BlockNumber":20}} 13:10:58 [13:10:58.228] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xf6aa5f8f6c511c66655a7f3c458393094c62ae4f1f4a352691dfcb8c3eb72d10","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 13:10:58 [13:10:58.235] INFO: world-state:database Creating world state data store at directory /tmp/1352214b2ede9ad9/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 13:10:58 [13:10:58.267] INFO: world_state Created world state synchroniser with block history of 64 13:10:58 [13:10:58.268] WARN: node:MAIN-aztec-node Aztec node is accepting fake proofs 13:10:58 [13:10:58.286] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/1352214b2ede9ad9/p2p with map size 134217728 KB (LMDB v2) 13:10:58 [13:10:58.288] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 13:10:58 [13:10:58.290] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/1352214b2ede9ad9/p2p-archive with map size 134217728 KB (LMDB v2) 13:10:58 [13:10:58.292] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 13:10:58 [13:10:58.294] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/1352214b2ede9ad9/p2p-peers with map size 134217728 KB (LMDB v2) 13:10:58 [13:10:58.295] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 13:10:58 [13:10:58.296] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 13:10:58 [13:10:58.296] VERBOSE: p2p P2P is disabled. Using dummy P2P service. 13:10:58 [13:10:58.299] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 13:10:58 [13:10:58.299] INFO: world_state Started world state synchronizer from block 1 13:10:58 [13:10:58.302] VERBOSE: world-state:block_stream Starting sync from block number 0 13:10:58 [13:10:58.303] INFO: p2p Starting p2p client from block 0 with empty mempools 13:10:58 [13:10:58.303] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 13:10:58 [13:10:58.590] INFO: epoch-prune-watcher EpochPruneWatcher initialized 13:10:58 [13:10:58.638] VERBOSE: validator Initialized validator with addresses: 0xe1e516eacb189b92b02eb7e4004a5e93d9cba270 13:10:58 [13:10:58.639] VERBOSE: node:MAIN-aztec-node All Aztec Node subsystems synced 13:10:58 [13:10:58.650] INFO: slasher Starting Slasher client... 13:10:58 [13:10:58.658] INFO: sequencer-client Deploying forwarder contract 13:10:58 [13:10:58.660] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 13:10:58 [13:10:58.673] VERBOSE: sequencer-client Sent L1 transaction 0x36a474db7ae2d9aa4bc7d9f6dbf39cd1ce91779040aa62d2aece0cb9d824f237 {"gasLimit":323704,"maxFeePerGas":"95.493369435","maxPriorityFeePerGas":"95.396216612"} 13:10:58 [13:10:58.673] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0x36a474db7ae2d9aa4bc7d9f6dbf39cd1ce91779040aa62d2aece0cb9d824f237. 13:10:58 [13:10:58.677] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 13:10:58 [13:10:58.683] INFO: validator Started validator with addresses: 0xe1e516eacb189b92b02eb7e4004a5e93d9cba270 13:10:58 [13:10:58.683] VERBOSE: validator Validators 0xe1e516eacb189b92b02eb7e4004a5e93d9cba270 are not on the validator committee for epoch 0 13:10:58 [13:10:58.684] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/401e5011/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 13:10:58 [13:10:58.684] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 13:10:58 [13:10:58.685] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 13:10:58 [13:10:58.686] VERBOSE: node:MAIN-aztec-node Sequencer started 13:10:58 [13:10:58.686] INFO: node:MAIN-aztec-node Aztec Node version: 0.87.6 13:10:58 [13:10:58.686] 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"} 13:10:58 [13:10:58.687] VERBOSE: e2e:Circuit Creating a pxe... 13:10:58 [13:10:58.695] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/c06214ce12094642/pxe_data with map size 134217728 KB (LMDB v2) 13:10:58 [13:10:58.698] 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":1750166144,"syncedToL1Ts":1750166144,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750166132,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750166168},"newBlockNumber":1,"expectedSlot":1} 13:10:58 [13:10:58.699] INFO: pxe:data:lmdb Starting data store with maxReaders 16 13:10:58 [13:10:58.989] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:10:58 [13:10:58.990] WARN: foundation:test-date-provider Time set to 2025-06-17T13:15:56.000Z {"offset":297011,"timeMs":1750166156000} 13:10:59 [13:10:59.124] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 13:10:59 [13:10:59.125] INFO: pxe:service Started PXE connected to chain 31337 version 3970327055 13:10:59 [13:10:59.195] INFO: pxe:service Registered account 0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24 13:10:59 [13:10:59.299] WARN: pxe:service No artifact found for contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 when looking for its metadata 13:10:59 [13:10:59.306] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 as part of deployment for 0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24 13:10:59 [13:10:59.365] 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":1750166168,"version":3970327055},"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:10:59 [13:10:59.369] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:10:59 [13:10:59.578] INFO: pxe:service Added contract SchnorrAccount at 0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24 with class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 13:10:59 [13:10:59.638] VERBOSE: pxe:block_stream Starting sync from block number 0 13:10:59 [13:10:59.722] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 13:10:59 [13:10:59.940] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 13:11:01 [13:11:01.077] 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":1750166168,"version":3970327055},"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:01 [13:11:01.081] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:01 [13:11:01.087] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2,0x1957d1ce818946c748798e559ad49f7f8cde3f3354114d1283b33b6a89100d84,0x25001159661e67f498b5874e31e434e254a328f93390888fe41be70dca9d8f41,0x0760738ac70fb3a6282af9a84ad00f3ccaee25deea3156d5c9f81542674af4d2 13:11:01 [13:11:01.221] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 13:11:01 [13:11:01.499] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24"} 13:11:01 [13:11:01.555] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 13:11:01 [13:11:01.557] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24"} 13:11:01 [13:11:01.605] 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":1750166168,"version":3970327055},"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:01 [13:11:01.607] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:01 [13:11:01.643] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24"} 13:11:01 [13:11:01.651] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 13:11:01 [13:11:01.891] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24"} 13:11:01 [13:11:01.933] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 13:11:01 [13:11:01.934] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24"} 13:11:01 [13:11:01.974] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24"} 13:11:01 [13:11:01.977] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 13:11:02 [13:11:02.005] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1cc5617e25b751933260de1c75329a76c2d2203f7cc1bc8908c518fe2a940c24 as fee payer 13:11:02 [13:11:02.256] 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":1750166168,"version":3970327055},"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:02 [13:11:02.260] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:02 [13:11:02.875] 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":1750166168,"version":3970327055},"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:02 [13:11:02.942] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:03 [13:11:03.393] INFO: pxe:service Proving completed in 3764.770813000001ms {"timings":{"total":3764.770813000001,"sync":9.911167999998725,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":258.04177400000117,"oracles":{"callPrivateFunction":{"times":[1578.9711879999995,429.3575180000007,230.2055679999994]}}},{"functionName":"private_kernel_init","time":136.36758199999895},{"functionName":"ContractClassRegisterer:register","time":1533.0968519999988,"oracles":{"loadCapsule":{"times":[60.728368000000046]},"notifyCreatedNullifier":{"times":[0.6144270000004326]},"debugLog":{"times":[0.8260239999999612]},"notifyCreatedContractClassLog":{"times":[15.073319000000993]}}},{"functionName":"private_kernel_inner","time":142.6218370000006},{"functionName":"SchnorrAccount:constructor","time":392.92251399999986,"oracles":{"getContractInstance":{"times":[0.8839589999988675]},"debugLog":{"times":[0.5978469999990921,0.6286380000001373]},"fetchTaggedLogs":{"times":[91.37110399999983]},"loadCapsule":{"times":[0.4976280000009865,0.2664710000008199,0.29792300000008254]},"validateEnqueuedNotesAndEvents":{"times":[3.735289999998713]},"notifyCreatedNullifier":{"times":[0.3787590000010823,0.21964699999989534]},"notifyCreatedNote":{"times":[0.6040670000002137]},"getRandomField":{"times":[0.48343800000111514,0.2483990000000631,0.18846399999893038,0.0726859999995213,0.07427600000119128,0.05965500000093016,0.0647850000004837,0.0565439999991213,0.07052500000099826,0.32228500000019267,0.1264499999997497]},"getIndexedTaggingSecretAsSender":{"times":[50.28910899999937]},"incrementAppTaggingSecretIndexAsSender":{"times":[35.332649999998466]}}},{"functionName":"private_kernel_inner","time":135.8947850000004},{"functionName":"SchnorrAccount:entrypoint","time":194.24412999999913,"oracles":{"debugLog":{"times":[0.8192230000004201,0.412120999999388,1.1402390000002924]},"fetchTaggedLogs":{"times":[41.89414800000122]},"loadCapsule":{"times":[0.1937660000003234,0.19395500000064203,0.22338700000000244]},"validateEnqueuedNotesAndEvents":{"times":[2.4003860000011628]},"getNotes":{"times":[3.10678100000041]},"getAuthWitness":{"times":[0.3253450000011071]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8522959999991144]}}},{"functionName":"private_kernel_inner","time":119.73076299999957},{"functionName":"private_kernel_reset","time":216.5343069999999},{"functionName":"private_kernel_tail","time":93.82655400000112}],"unaccounted":531.5785470000028}} 13:11:03 [13:11:03.482] VERBOSE: p2p:tx_pool Adding tx 0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5 to pool {"eventName":"tx-added-to-pool","txHash":"0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 13:11:03 [13:11:03.515] 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":1750166168,"version":3970327055},"chainTipArchive":"0x2cbc484af9b6a18d7e11a465fbe7c1e27d83da4b8744bb99acb2959a2380fdbb","blockNumber":1,"slot":2} 13:11:03 [13:11:03.516] INFO: node:MAIN-aztec-node Received tx 0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5 {"txHash":"0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5"} 13:11:03 [13:11:03.516] INFO: pxe:service Sent transaction 0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5 13:11:03 [13:11:03.530] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-17T13:16:08.000Z","now":"2025-06-17T13:16:00.541Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 13:11:03 [13:11:03.581] VERBOSE: simulator:public-processor Processed tx 0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5 with no public calls in 25.385307999998986ms {"txHash":"0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5","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":25.385307999998986} 13:11:03 [13:11:03.585] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05231916699999965s {"duration":0.05231916699999965,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 13:11:03 [13:11:03.617] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x10a79cbc21e57da79d9ed7ae752afee18551d001fb36d1fbd9a40258a6854df2","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750166168,"version":3970327055},"txHashes":["0x27263bff80922830a73fae1cd1f299d9dbd5bc16d390221e57b9ac15c09118b5"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":94.7125329999999,"publicProcessDuration":53.23650799999996,"rollupCircuitsDuration":87.79491700000108,"txCount":1,"blockNumber":1,"blockTimestamp":1750166168,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 13:11:03 [13:11:03.619] VERBOSE: sequencer Attesting committee is empty 13:11:06 [13:11:06.606] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x0af13cb6205c8beccd051384095f270f2464207d4e5d24e1e4f2c078ff79d2a3 13:11:06 [13:11:06.606] VERBOSE: node:MAIN-aztec-node Sent L1 transaction 0x0af13cb6205c8beccd051384095f270f2464207d4e5d24e1e4f2c078ff79d2a3 {"gasLimit":472051,"maxFeePerGas":"114.560542517","maxPriorityFeePerGas":"114.475459934","maxFeePerBlobGas":"0.000000001"} 13:11:06 [13:11:06.617] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 13:11:06 [13:11:06.618] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0af13cb6205c8beccd051384095f270f2464207d4e5d24e1e4f2c078ff79d2a3","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":1,"blockTimestamp":1750166168,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 13:11:06 [13:11:06.618] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 13:11:06 [13:11:06.634] INFO: blob-sink:server Received blob sidecar for block 0x2827906d72cefb661eab32709fa1c55e7869d7d129270520c7e7d9cc2369ae0f 13:11:06 [13:11:06.639] INFO: blob-sink:server Blob sidecar stored successfully for block 0x2827906d72cefb661eab32709fa1c55e7869d7d129270520c7e7d9cc2369ae0f 13:11:06 [13:11:06.662] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 13:11:06 [13:11:06.663] WARN: foundation:test-date-provider Time set to 2025-06-17T13:16:08.000Z {"offset":301337,"timeMs":1750166168000} 13:11:06 [13:11:06.667] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 13:11:06 [13:11:06.669] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 13:11:06 [13:11:06.772] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750166204 13:11:06 [13:11:06.772] WARN: foundation:test-date-provider Time set to 2025-06-17T13:16:44.000Z {"offset":337228,"timeMs":1750166204000} 13:11:06 [13:11:06.772] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 13:11:07 [13:11:07.148] VERBOSE: archiver:block-helper Store contract class 0x283534733d3e93162ef71f581e6c7f1f82cad301c27b79c2cc5ba34e2b3f9cc2 13:11:07 [13:11:07.153] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x10a79cbc21e57da79d9ed7ae752afee18551d001fb36d1fbd9a40258a6854df2","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750166168,"version":3970327055},"archiveRoot":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","archiveNextLeafIndex":2} 13:11:07 [13:11:07.158] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 13:11:07 [13:11:07.226] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":9.347133999999642,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750166168,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 13:11:07 [13:11:07.282] VERBOSE: p2p Synched to latest block 1 13:11:07 [13:11:07.284] INFO: node:MAIN-aztec-node Stopping Aztec Node 13:11:07 [13:11:07.659] 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":1750166204,"version":3970327055},"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:07 [13:11:07.660] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:08 [13:11:08.181] 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":1750166204,"version":3970327055},"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:08 [13:11:08.183] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:08 [13:11:08.732] 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":1750166204,"version":3970327055},"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:08 [13:11:08.735] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:09 [13:11:09.255] 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":1750166204,"version":3970327055},"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:09 [13:11:09.257] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x08519d4d4ea41e90fdc5ef1ed71de6536982b6147c2477e84c6141568c10b51d","blockNumber":2,"slot":3} 13:11:09 [13:11:09.289] INFO: slasher Slasher client stopped. 13:11:09 [13:11:09.290] INFO: sequencer Stopped sequencer 13:11:09 [13:11:09.292] INFO: p2p P2P client stopped 13:11:09 [13:11:09.295] INFO: world_state Stopped world state synchronizer 13:11:09 [13:11:09.295] INFO: archiver Stopped. 13:11:09 [13:11:09.295] INFO: node:MAIN-aztec-node Stopped Aztec Node 13:11:09 [13:11:09.308] INFO: blob-sink:server Stopping blob sink 13:11:09 [13:11:09.309] INFO: blob-sink:server Blob sink stopped 13:11:09 PASS src/e2e_circuit_recorder.test.ts 13:11:09 Circuit Recorder 13:11:09 ✓ records circuit execution (13192 ms) 13:11:09 13:11:09 Test Suites: 1 passed, 1 total 13:11:09 Tests: 1 passed, 1 total 13:11:09 Snapshots: 0 total 13:11:09 Time: 20.14 s 13:11:09 Ran all test suites matching src/e2e_circuit_recorder.test.ts. 13:11:09 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?