Parent Log: http://ci.aztec-labs.com/ad41d2c01b79593b Command: 21081b81c02e2d2a:ISOLATE=1:NAME=e2e_mempool_limit yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_mempool_limit.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/c06f30929f18b85bcea93c0926a8d640a3819f00 Env: REF_NAME=gh-readonly-queue/master/pr-15074-2707ec99de02004f3e30e7af0810e0d741ab9794 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Mon Jun 16 16:19:32 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15074_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_3177e4e547f012b7_master 16:19:32 +++ id -u 16:19:32 +++ id -g 16:19:32 ++ docker run -d --name e2e_mempool_limit --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_mempool_limit.test.ts'\''' 16:19:33 + cid=5643c77bd94ca450921ae04cdc7b43957a40148140955d4267de50fe03d2e031 16:19:33 + set +x 16:19:33 {"level":25,"time":1750090773993,"pid":12,"hostname":"5643c77bd94c","module":"logger","msg":"Logger initialized with level verbose"} 16:19:39 [16:19:39.758] INFO: e2e:e2e_mempool_limit Logging metrics to log/unknown.jsonl 16:19:39 [16:19:39.981] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-zeMg6A/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 16:19:40 [16:19:40.023] INFO: e2e:e2e_mempool_limit Calling anvil_setBlockTimestampInterval with params: [12] 16:19:40 [16:19:40.049] WARN: e2e:e2e_mempool_limit Set block interval to 12 16:19:40 [16:19:40.050] VERBOSE: e2e:e2e_mempool_limit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:19:40 [16:19:40.099] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 16:19:40 [16:19:40.109] VERBOSE: e2e:e2e_mempool_limit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 16:19:40 [16:19:40.124] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 16:19:40 [16:19:40.129] VERBOSE: e2e:e2e_mempool_limit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 16:19:40 [16:19:40.142] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 16:19:40 [16:19:40.147] VERBOSE: e2e:e2e_mempool_limit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 16:19:40 [16:19:40.162] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 16:19:40 [16:19:40.168] VERBOSE: e2e:e2e_mempool_limit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 16:19:40 [16:19:40.200] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 16:19:40 [16:19:40.207] VERBOSE: e2e:e2e_mempool_limit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 16:19:40 [16:19:40.223] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 16:19:40 [16:19:40.229] VERBOSE: e2e:e2e_mempool_limit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 16:19:40 [16:19:40.231] VERBOSE: e2e:e2e_mempool_limit Waiting for deployments to complete 16:19:40 [16:19:40.231] INFO: e2e:e2e_mempool_limit Waiting for 6 transactions to be mined... 16:19:40 [16:19:40.255] INFO: e2e:e2e_mempool_limit All transactions mined successfully 16:19:40 [16:19:40.276] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 16:19:40 [16:19:40.277] VERBOSE: e2e:e2e_mempool_limit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 16:19:40 [16:19:40.308] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 16:19:40 [16:19:40.333] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 16:19:40 [16:19:40.342] VERBOSE: e2e:e2e_mempool_limit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 16:19:40 [16:19:40.359] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 16:19:40 [16:19:40.360] VERBOSE: e2e:e2e_mempool_limit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 16:19:40 [16:19:40.384] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 16:19:40 [16:19:40.390] VERBOSE: e2e:e2e_mempool_limit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 16:19:40 [16:19:40.406] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 16:19:40 [16:19:40.406] VERBOSE: e2e:e2e_mempool_limit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 16:19:40 [16:19:40.406] VERBOSE: e2e:e2e_mempool_limit Waiting for deployments to complete 16:19:40 [16:19:40.406] INFO: e2e:e2e_mempool_limit Waiting for 8 transactions to be mined... 16:19:40 [16:19:40.431] INFO: e2e:e2e_mempool_limit All transactions mined successfully 16:19:40 [16:19:40.441] VERBOSE: e2e:e2e_mempool_limit Deployed shared contracts 16:19:40 [16:19:40.470] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 16:19:40 [16:19:40.471] VERBOSE: e2e:e2e_mempool_limit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 16:19:40 [16:19:40.475] VERBOSE: e2e:e2e_mempool_limit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 16:19:40 [16:19:40.489] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 16:19:40 [16:19:40.521] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 16:19:40 [16:19:40.529] VERBOSE: e2e:e2e_mempool_limit Awaiting for linked libraries to be deployed 16:19:40 [16:19:40.583] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xd765dfc480c4ec8666664eba105cf9f3d9b3d847cb0505c6ee326155bffa3422 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 16:19:40 [16:19:40.590] VERBOSE: e2e:e2e_mempool_limit Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 16:19:40 [16:19:40.591] INFO: e2e:e2e_mempool_limit Waiting for 9 transactions to be mined... 16:19:40 [16:19:40.615] INFO: e2e:e2e_mempool_limit All transactions mined successfully 16:19:40 [16:19:40.616] VERBOSE: e2e:e2e_mempool_limit All core contracts have been deployed 16:19:40 [16:19:40.631] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 16:19:40 [16:19:40.632] VERBOSE: e2e:e2e_mempool_limit Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 16:19:40 [16:19:40.655] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 16:19:40 [16:19:40.661] VERBOSE: e2e:e2e_mempool_limit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 16:19:40 [16:19:40.691] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 16:19:40 [16:19:40.691] VERBOSE: e2e:e2e_mempool_limit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 16:19:40 [16:19:40.692] INFO: e2e:e2e_mempool_limit Waiting for 10 transactions to be mined... 16:19:40 [16:19:40.713] INFO: e2e:e2e_mempool_limit All transactions mined successfully 16:19:40 [16:19:40.720] VERBOSE: e2e:e2e_mempool_limit Rollup deployed 16:19:40 [16:19:40.720] VERBOSE: e2e:e2e_mempool_limit Waiting for rollup and slash factory to be deployed 16:19:40 [16:19:40.720] INFO: e2e:e2e_mempool_limit Waiting for 10 transactions to be mined... 16:19:40 [16:19:40.744] INFO: e2e:e2e_mempool_limit All transactions mined successfully 16:19:40 [16:19:40.745] VERBOSE: e2e:e2e_mempool_limit All transactions for L1 deployment have been mined 16:19:40 [16:19:40.771] INFO: e2e:e2e_mempool_limit Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 16:19:40 [16:19:40.774] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 16:19:40 [16:19:40.776] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:40 [16:19:40.777] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 16:19:40 [16:19:40.778] INFO: telemetry:client Using NoopTelemetryClient 16:19:40 [16:19:40.783] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 16:19:40 [16:19:40.784] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 16:19:40 [16:19:40.784] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/0465a509b812dbc1/blob-sink with map size 134217728 KB (LMDB v2) 16:19:40 [16:19:40.786] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:40 [16:19:40.789] INFO: aztecjs:utils:watcher New L1 time: 1750091019 16:19:40 [16:19:40.789] WARN: foundation:test-date-provider Time set to 2025-06-16T16:23:39.000Z {"offset":238211,"timeMs":1750091019000} 16:19:40 [16:19:40.793] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 16:19:40 [16:19:40.804] INFO: blob-sink:server Server is running on http://localhost:40087 16:19:40 [16:19:40.805] VERBOSE: e2e:e2e_mempool_limit Creating and synching an aztec node... 16:19:40 [16:19:40.806] VERBOSE: e2e:e2e_mempool_limit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/2b62e0a4/acvm 16:19:40 [16:19:40.807] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:40087"} 16:19:40 [16:19:40.824] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 16:19:40 [16:19:40.824] INFO: archiver:lmdb Creating archiver data store at directory /tmp/0465a509b812dbc1/archiver with map size 134217728 KB (LMDB v2) 16:19:40 [16:19:40.826] INFO: archiver:lmdb Starting data store with maxReaders 16 16:19:41 [16:19:41.064] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:41 [16:19:41.186] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:40087"} 16:19:41 [16:19:41.212] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:40087"} 16:19:41 [16:19:41.213] WARN: node:blob-sink:client No L1 consensus host urls configured 16:19:41 [16:19:41.213] WARN: node:blob-sink:client No archive client configured 16:19:41 [16:19:41.217] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x081fc438b9c4c34518bc84af806e4b84b7224465acabb50157cc15bb67463ec6 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x05bcdc13d35ba4757a5d6b9e0e90b80b1df5e0b23062becae4df3fdf2009b4f2","l1BlockNumber":16}} 16:19:41 [16:19:41.236] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x081fc438b9c4c34518bc84af806e4b84b7224465acabb50157cc15bb67463ec6","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 16:19:41 [16:19:41.246] INFO: world-state:database Creating world state data store at directory /tmp/0465a509b812dbc1/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 16:19:41 [16:19:41.276] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:41 [16:19:41.282] INFO: world_state Created world state synchroniser with block history of 64 16:19:41 [16:19:41.283] WARN: node Aztec node is accepting fake proofs 16:19:41 [16:19:41.296] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/0465a509b812dbc1/p2p with map size 134217728 KB (LMDB v2) 16:19:41 [16:19:41.304] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 16:19:41 [16:19:41.308] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/0465a509b812dbc1/p2p-archive with map size 134217728 KB (LMDB v2) 16:19:41 [16:19:41.310] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 16:19:41 [16:19:41.312] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/0465a509b812dbc1/p2p-peers with map size 134217728 KB (LMDB v2) 16:19:41 [16:19:41.314] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 16:19:41 [16:19:41.316] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 16:19:41 [16:19:41.317] VERBOSE: p2p P2P is disabled. Using dummy P2P service 16:19:41 [16:19:41.320] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 16:19:41 [16:19:41.321] INFO: world_state Started world state synchronizer from block 1 16:19:41 [16:19:41.324] VERBOSE: world-state:block_stream Starting sync from block number 0 16:19:41 [16:19:41.326] INFO: p2p Starting p2p client from block 0 with empty mempools 16:19:41 [16:19:41.326] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 16:19:41 [16:19:41.328] INFO: slasher Slasher client initialized 16:19:41 [16:19:41.328] INFO: slasher Starting Slasher client... 16:19:41 [16:19:41.384] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:19:41 [16:19:41.385] VERBOSE: node All Aztec Node subsystems synced 16:19:41 [16:19:41.396] INFO: sequencer-client Deploying forwarder contract 16:19:41 [16:19:41.404] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 16:19:41 [16:19:41.418] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 16:19:41 [16:19:41.419] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 16:19:41 [16:19:41.424] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:19:41 [16:19:41.444] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:19:41 [16:19:41.444] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 16:19:41 [16:19:41.445] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/2b62e0a4/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 16:19:41 [16:19:41.692] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 16:19:41 [16:19:41.694] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:19:41 [16:19:41.696] INFO: node Aztec Node version: 0.87.8 16:19:41 [16:19:41.696] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 16:19:41 [16:19:41.697] VERBOSE: e2e:e2e_mempool_limit Creating a pxe... 16:19:41 [16:19:41.703] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:41 [16:19:41.713] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/41e1e8ed39e7583b/pxe_data with map size 134217728 KB (LMDB v2) 16:19:41 [16:19:41.729] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2648afbc7734d708de1e51ecc79c92f7df68332188f5d5db57b2896dbd3506f1","blockNumber":1,"slot":2} 16:19:41 [16:19:41.731] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:19:41 [16:19:41.911] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:42 [16:19:42.016] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 16:19:42 [16:19:42.017] INFO: pxe:service Started PXE connected to chain 31337 version 2695071053 16:19:42 [16:19:42.098] INFO: pxe:service Registered account 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 16:19:42 [16:19:42.198] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:42 [16:19:42.201] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 16:19:42 [16:19:42.205] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 16:19:42 [16:19:42.321] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2648afbc7734d708de1e51ecc79c92f7df68332188f5d5db57b2896dbd3506f1","blockNumber":1,"slot":2} 16:19:42 [16:19:42.379] INFO: pxe:service Added contract SchnorrAccount at 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:19:42 [16:19:42.432] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:42 [16:19:42.438] VERBOSE: pxe:block_stream Starting sync from block number 0 16:19:42 [16:19:42.472] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 16:19:42 [16:19:42.568] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:19:43 [16:19:43.374] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 16:19:43 [16:19:43.480] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:19:43 [16:19:43.547] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:43 [16:19:43.626] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2648afbc7734d708de1e51ecc79c92f7df68332188f5d5db57b2896dbd3506f1","blockNumber":1,"slot":2} 16:19:43 [16:19:43.657] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:43 [16:19:43.700] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:19:43 [16:19:43.701] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:43 [16:19:43.750] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:43 [16:19:43.756] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:43 [16:19:43.759] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:19:43 [16:19:43.981] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:44 [16:19:44.015] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:44 [16:19:44.060] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:19:44 [16:19:44.061] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:44 [16:19:44.127] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:44 [16:19:44.139] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:19:44 [16:19:44.143] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2648afbc7734d708de1e51ecc79c92f7df68332188f5d5db57b2896dbd3506f1","blockNumber":1,"slot":2} 16:19:44 [16:19:44.159] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 as fee payer 16:19:44 [16:19:44.355] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:44 [16:19:44.821] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:44 [16:19:44.981] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2648afbc7734d708de1e51ecc79c92f7df68332188f5d5db57b2896dbd3506f1","blockNumber":1,"slot":2} 16:19:45 [16:19:45.137] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:45 [16:19:45.663] INFO: pxe:service Proving completed in 3233.407414000001ms {"timings":{"total":3233.407414000001,"sync":9.00037599999996,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":173.95655499999884,"oracles":{"callPrivateFunction":{"times":[1019.8217910000003,380.20885199999975,257.5955679999988]}}},{"functionName":"private_kernel_init","time":120.69077800000014},{"functionName":"ContractClassRegisterer:register","time":997.0630009999986,"oracles":{"loadCapsule":{"times":[57.660071000000244]},"notifyCreatedNullifier":{"times":[0.873185000000376]},"debugLog":{"times":[1.0304909999995289]},"notifyCreatedContractClassLog":{"times":[9.227462000000742]}}},{"functionName":"private_kernel_inner","time":248.7833300000002},{"functionName":"SchnorrAccount:constructor","time":342.6232540000019,"oracles":{"getContractInstance":{"times":[1.3881099999998696]},"debugLog":{"times":[0.6809200000006967,0.393621000001076]},"fetchTaggedLogs":{"times":[54.98277100000087]},"loadCapsule":{"times":[1.6175569999995787,1.1721350000007078,0.940787999999884]},"notifyCreatedNullifier":{"times":[0.2047969999985071,0.4363130000001547]},"notifyCreatedNote":{"times":[0.4239629999992758]},"getRandomField":{"times":[0.22076600000036706,0.27058799999940675,0.2712179999998625,0.1751349999995,0.14115400000082445,0.10394300000007206,0.10697199999958684,0.10549300000093353,0.09163300000000163,0.14641500000107044,0.10569199999918055]},"getIndexedTaggingSecretAsSender":{"times":[58.218996000001425]},"incrementAppTaggingSecretIndexAsSender":{"times":[63.24854500000038]}}},{"functionName":"private_kernel_inner","time":148.47359499999948},{"functionName":"SchnorrAccount:entrypoint","time":217.24699599999985,"oracles":{"debugLog":{"times":[0.6911209999998391,0.7343309999996563,1.106071999998676]},"fetchTaggedLogs":{"times":[75.460556]},"loadCapsule":{"times":[0.2558370000006107,1.8670249999995576,0.3539700000001176]},"getNotes":{"times":[3.2915069999999105]},"getAuthWitness":{"times":[0.5744270000013785]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.4558729999989737]}}},{"functionName":"private_kernel_inner","time":149.59683899999982},{"functionName":"private_kernel_reset","time":178.12680799999907},{"functionName":"private_kernel_tail","time":79.26188600000023}],"unaccounted":568.583996000003}} 16:19:45 [16:19:45.677] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:45 [16:19:45.821] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2648afbc7734d708de1e51ecc79c92f7df68332188f5d5db57b2896dbd3506f1","blockNumber":1,"slot":2} 16:19:45 [16:19:45.831] VERBOSE: p2p:tx_pool Adding tx 0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31 to pool {"eventName":"tx-added-to-pool","txHash":"0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 16:19:45 [16:19:45.863] INFO: node Received tx 0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31 {"txHash":"0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31"} 16:19:45 [16:19:45.863] INFO: pxe:service Sent transaction 0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31 16:19:45 [16:19:45.888] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:46 [16:19:46.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:46 [16:19:46.302] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:46 [16:19:46.356] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 16:19:46 [16:19:46.369] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-16T16:24:03.000Z","now":"2025-06-16T16:23:44.580Z"} 16:19:46 [16:19:46.593] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:46 [16:19:46.675] VERBOSE: simulator:public-processor Processed tx 0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31 with no public calls in 218.60792100000072ms {"txHash":"0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31","txFee":6794052480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":20448},"billedGas":{"daGas":16896,"l2Gas":20448},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":218.60792100000072} 16:19:46 [16:19:46.682] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.31099854699999924s {"duration":0.31099854699999924,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 16:19:46 [16:19:46.800] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:46 [16:19:46.809] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x20ce9db3b5d88e9a1b396333c53b3e387bee700f1dfde739cdf1dd14ca072ec3","globalVariables":{"chainId":31337,"version":2695071053,"blockNumber":1,"slotNumber":2,"timestamp":1750091043,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0231014b4de97b70aa79c2de5b436e89d15a9a2cd07261e2913add92bc22fd31"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":454.3655859999999,"publicProcessDuration":312.03968800000075,"rollupCircuitsDuration":441.69734900000003,"txCount":1,"blockNumber":1,"blockTimestamp":1750091043,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:19:46 [16:19:46.812] VERBOSE: sequencer Attesting committee is empty 16:19:47 [16:19:47.005] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:47 [16:19:47.223] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xc955c4f9032f256086506532f0315153f027ae715cd7c4b3751308aab8028d6e 16:19:47 [16:19:47.223] VERBOSE: sequencer-client Sent L1 transaction 0xc955c4f9032f256086506532f0315153f027ae715cd7c4b3751308aab8028d6e {"gasLimit":514599,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 16:19:47 [16:19:47.227] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:47 [16:19:47.248] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 16:19:47 [16:19:47.251] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 16:19:47 [16:19:47.260] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:19:47 [16:19:47.262] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xc955c4f9032f256086506532f0315153f027ae715cd7c4b3751308aab8028d6e","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":1,"blockTimestamp":1750091043,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:19:47 [16:19:47.263] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:19:47 [16:19:47.268] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 16:19:47 [16:19:47.283] INFO: blob-sink:server Received blob sidecar for block 0xb37492fad45d75ed79bc58935ed489476b6f6dd15ddcf64566abbcd34d71294f 16:19:47 [16:19:47.289] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb37492fad45d75ed79bc58935ed489476b6f6dd15ddcf64566abbcd34d71294f 16:19:47 [16:19:47.442] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:47 [16:19:47.458] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750091079] on http://127.0.0.1:8545 16:19:47 [16:19:47.460] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:19:47 [16:19:47.462] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750091079 16:19:47 [16:19:47.463] WARN: foundation:test-date-provider Time set to 2025-06-16T16:24:39.000Z {"offset":291538,"timeMs":1750091079000} 16:19:47 [16:19:47.463] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 16:19:47 [16:19:47.650] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:47 [16:19:47.881] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:47 [16:19:47.906] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:19:47 [16:19:47.916] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x20ce9db3b5d88e9a1b396333c53b3e387bee700f1dfde739cdf1dd14ca072ec3","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2695071053,"blockNumber":1,"slotNumber":2,"timestamp":1750091043,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x22382efe8e7419d13bc32c2de38002a5e35aa5222ea1a092e49f069f3775bb32","archiveNextLeafIndex":2} 16:19:47 [16:19:47.925] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 16:19:48 [16:19:48.390] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:48 [16:19:48.400] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":407.2850210000015,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750091043,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:19:48 [16:19:48.401] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 16:19:48 [16:19:48.413] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x0871cddfd178c2b77c8fb5164666bd4667bde3f90bfdd23ce7bf0a4d7a6c6914 16:19:48 [16:19:48.649] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:48 [16:19:48.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:48 [16:19:48.925] VERBOSE: p2p Synched to latest block 1 16:19:49 [16:19:49.276] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:49 [16:19:49.311] INFO: pxe:service Added contract Token at 0x0871cddfd178c2b77c8fb5164666bd4667bde3f90bfdd23ce7bf0a4d7a6c6914 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 16:19:49 [16:19:49.333] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x22382efe8e7419d13bc32c2de38002a5e35aa5222ea1a092e49f069f3775bb32","blockNumber":2,"slot":3} 16:19:49 [16:19:49.365] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x22382efe8e7419d13bc32c2de38002a5e35aa5222ea1a092e49f069f3775bb32","header":{"contentCommitment":{"blobsHash":"0x009a6c5ae5919dff5744554cce9e29db9dac0a64380188159e855416d0e42860","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750091043,"version":2695071053},"lastArchive":"0x2648afbc7734d708de1e51ecc79c92f7df68332188f5d5db57b2896dbd3506f1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x13248cee25eb75ceb61946b2959719cfc515aed10f43640991a92ea7fcac8f30","nullifierTree":"0x0f6a898bb4bb31c2714cd69abf46139e0cfd4112a40cfeeefd60bbb170eedc46","publicDataTree":"0x250b816ca2819b97263d18998d2eea61d7ed73521cdde52ec6882e409ad49f9b"},"totalFees":6794052480,"totalManaUsed":20448}} 16:19:49 [16:19:49.505] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:49 [16:19:49.544] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:19:49 [16:19:49.546] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:49 [16:19:49.564] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:49 [16:19:49.776] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:49 [16:19:49.894] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:49 [16:19:49.907] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x22382efe8e7419d13bc32c2de38002a5e35aa5222ea1a092e49f069f3775bb32","blockNumber":2,"slot":3} 16:19:49 [16:19:49.912] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x29ea7150870e14e245456cbc59bd181c5940c54a59b23f6dbf7c1e31b0d8298b 16:19:49 [16:19:49.927] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:19:49 [16:19:49.928] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:19:49 [16:19:49.937] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:19:49 [16:19:49.938] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:19:49 [16:19:49.946] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e31b2cc9e600dd6bf1098639784d385f02cd7f8d0f8513d34a89e585b634fc6","nullifier":"0x1b71fca42bffc73e083cf07177aec0034b0f55faa48311c01b967f62b8f02c20"} 16:19:49 [16:19:49.949] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:19:49 [16:19:49.969] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 as fee payer 16:19:49 [16:19:49.991] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:50 [16:19:50.033] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:19:50 [16:19:50.466] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 16:19:50 [16:19:50.578] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:19:50 [16:19:50.644] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:50 [16:19:50.738] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:19:50 [16:19:50.756] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x22382efe8e7419d13bc32c2de38002a5e35aa5222ea1a092e49f069f3775bb32","blockNumber":2,"slot":3} 16:19:50 [16:19:50.797] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:19:50 [16:19:50.806] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0871cddfd178c2b77c8fb5164666bd4667bde3f90bfdd23ce7bf0a4d7a6c6914,0x0000000000000000000000000000000000000000000000000000000000000001,0x0e7b9c9b0daa926a5540947d362e85493b7d135402d6bd17d4edab052c895f5c,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x0285917e48dbd20cd31246424771ed86b28986d9bafcd7e116eba534192005a3,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 16:19:50 [16:19:50.913] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:51 [16:19:51.173] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:51 [16:19:51.402] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:51 [16:19:51.624] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:51 [16:19:51.625] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x22382efe8e7419d13bc32c2de38002a5e35aa5222ea1a092e49f069f3775bb32","blockNumber":2,"slot":3} 16:19:51 [16:19:51.886] INFO: pxe:service Proving completed in 2533.7310690000013ms {"timings":{"total":2533.7310690000013,"sync":20.67617000000064,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":603.9697650000016,"oracles":{"debugLog":{"times":[1.483154999999897,0.4683740000000398,0.6930109999993874,0.7512029999998049,0.5322959999975865,0.47865399999864167,0.42516299999988405,0.7430029999995895]},"fetchTaggedLogs":{"times":[362.39722300000176]},"loadCapsule":{"times":[0.8045640000018466,0.40331199999855016,0.7903240000014193,0.541826000000583,0.29200899999705143,0.20165600000109407]},"getSharedSecret":{"times":[5.148997000000236]},"aes128Decrypt":{"times":[1.275829000001977,1.269679000000906]},"getPublicKeysAndPartialAddress":{"times":[2.161626000000979]},"getKeyValidationRequest":{"times":[2.2636290000009467]},"deliverNote":{"times":[7.947252000001754]},"deleteCapsule":{"times":[0.9694500000005064]},"storeCapsule":{"times":[0.45743399999992107]},"getNotes":{"times":[3.152745999999752]},"getAuthWitness":{"times":[0.3414299999967625]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06357299999945099]},"callPrivateFunction":{"times":[668.9445149999992,169.42181300000084]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3545699999995122]}}},{"functionName":"private_kernel_init","time":70.65096300000005},{"functionName":"ContractClassRegisterer:register","time":643.4377060000006,"oracles":{"loadCapsule":{"times":[4.713943999999174]},"notifyCreatedNullifier":{"times":[0.5101450000001932]},"debugLog":{"times":[0.78257400000075]},"notifyCreatedContractClassLog":{"times":[7.230070999998134]}}},{"functionName":"private_kernel_inner","time":110.23158900000271},{"functionName":"ContractInstanceDeployer:deploy","time":111.88047899999583,"oracles":{"storeInExecutionCache":{"times":[0.38280200000008335]},"callPrivateFunction":{"times":[56.990836000000854]},"notifyCreatedNullifier":{"times":[0.21586699999897974]},"debugLog":{"times":[0.4340329999977257]}}},{"functionName":"private_kernel_inner","time":136.81536899999992},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.588558000003104,"oracles":{}},{"functionName":"private_kernel_inner","time":113.1246570000003},{"functionName":"private_kernel_reset","time":167.6174370000008},{"functionName":"private_kernel_tail","time":96.1613010000001}],"unaccounted":416.5770749999956}} 16:19:52 [16:19:52.121] VERBOSE: p2p:tx_pool Adding tx 0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4 to pool {"eventName":"tx-added-to-pool","txHash":"0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 16:19:52 [16:19:52.127] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:52 [16:19:52.153] INFO: node Received tx 0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4 {"txHash":"0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4"} 16:19:52 [16:19:52.153] INFO: pxe:service Sent transaction 0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4 16:19:52 [16:19:52.205] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 16:19:52 [16:19:52.219] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-16T16:24:39.000Z","now":"2025-06-16T16:24:43.757Z"} 16:19:52 [16:19:52.365] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:52 [16:19:52.629] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:52 [16:19:52.806] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":268.84766300000047} 16:19:52 [16:19:52.967] VERBOSE: simulator:public-processor Processed tx 0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4 with 1 public calls in 590.1456030000008ms {"txHash":"0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4","txFee":139009277500,"revertCode":0,"gasUsed":{"totalGas":{"daGas":380416,"l2Gas":418375},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":6144,"l2Gas":381831},"billedGas":{"daGas":380416,"l2Gas":418375}},"publicDataWriteCount":12,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":590.1456030000008} 16:19:52 [16:19:52.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:52 [16:19:52.973] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.753708077000003s {"duration":0.753708077000003,"rate":506603.3012672604,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 16:19:53 [16:19:53.179] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:53 [16:19:53.197] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 384405.9706874743 mana/s {"blockHash":"0x0dd1db2bbd5012ff853ba7fa62a7f41c965455a2c32e30b2f67c9ec16a5970cb","globalVariables":{"chainId":31337,"version":2695071053,"blockNumber":2,"slotNumber":3,"timestamp":1750091079,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1ddc273908020ffd5d472f5c1a1ae2e5751d3902e96f7ea9f67bbf1dce48a0c4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":992.502543999999,"publicProcessDuration":754.3435669999999,"rollupCircuitsDuration":978.972052000001,"txCount":1,"blockNumber":2,"blockTimestamp":1750091079,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 16:19:53 [16:19:53.201] VERBOSE: sequencer Attesting committee is empty 16:19:53 [16:19:53.386] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:53 [16:19:53.592] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xc00d9325dcafea828c9ab363938b6aa986e3b1ff9130082022cee2584a30d576 16:19:53 [16:19:53.592] VERBOSE: sequencer-client Sent L1 transaction 0xc00d9325dcafea828c9ab363938b6aa986e3b1ff9130082022cee2584a30d576 {"gasLimit":470312,"maxFeePerGas":"1.303611222","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:19:53 [16:19:53.603] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750091115] on http://127.0.0.1:8545 16:19:53 [16:19:53.605] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:19:53 [16:19:53.608] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:19:53 [16:19:53.608] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xc00d9325dcafea828c9ab363938b6aa986e3b1ff9130082022cee2584a30d576","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":2,"blockTimestamp":1750091079,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 16:19:53 [16:19:53.608] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:19:53 [16:19:53.615] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:53 [16:19:53.619] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 16:19:53 [16:19:53.619] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 16:19:53 [16:19:53.620] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750091115 16:19:53 [16:19:53.621] WARN: foundation:test-date-provider Time set to 2025-06-16T16:25:15.000Z {"offset":321379,"timeMs":1750091115000} 16:19:53 [16:19:53.621] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 16:19:53 [16:19:53.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:53 [16:19:53.629] INFO: blob-sink:server Received blob sidecar for block 0x6eb8fb741c66560fad5095c66d3cbf13bc2baa8e2af3a774bded555da268d1a2 16:19:53 [16:19:53.633] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 16:19:53 [16:19:53.635] INFO: aztecjs:utils:watcher New L1 time: 1750091127 16:19:53 [16:19:53.635] WARN: foundation:test-date-provider Time set to 2025-06-16T16:25:27.000Z {"offset":333365,"timeMs":1750091127000} 16:19:53 [16:19:53.638] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 16:19:53 [16:19:53.640] INFO: blob-sink:server Blob sidecar stored successfully for block 0x6eb8fb741c66560fad5095c66d3cbf13bc2baa8e2af3a774bded555da268d1a2 16:19:53 [16:19:53.641] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 16:19:53 [16:19:53.836] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:54 [16:19:54.081] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:54 [16:19:54.103] VERBOSE: archiver:block-helper Store contract instance at 0x0871cddfd178c2b77c8fb5164666bd4667bde3f90bfdd23ce7bf0a4d7a6c6914 16:19:54 [16:19:54.136] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 16:19:54 [16:19:54.182] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0dd1db2bbd5012ff853ba7fa62a7f41c965455a2c32e30b2f67c9ec16a5970cb","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2695071053,"blockNumber":2,"slotNumber":3,"timestamp":1750091079,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0387c3a17bf9ec4de76c0e97d2df5d390b6decca04da854bda196c7751976090","archiveNextLeafIndex":3} 16:19:54 [16:19:54.202] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 16:19:54 [16:19:54.222] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":10.054996999999275,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750091079,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 16:19:54 [16:19:54.442] INFO: aztecjs:deploy_sent_tx Contract 0x0871cddfd178c2b77c8fb5164666bd4667bde3f90bfdd23ce7bf0a4d7a6c6914 successfully deployed. 16:19:54 [16:19:54.445] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:54 [16:19:54.501] VERBOSE: p2p Synched to latest block 2 16:19:54 [16:19:54.507] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x0387c3a17bf9ec4de76c0e97d2df5d390b6decca04da854bda196c7751976090","header":{"contentCommitment":{"blobsHash":"0x007d50420f1127a6ad3ba7535572ecbb53068c0fc46f4d51fa43120108c71343","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750091079,"version":2695071053},"lastArchive":"0x22382efe8e7419d13bc32c2de38002a5e35aa5222ea1a092e49f069f3775bb32","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x13248cee25eb75ceb61946b2959719cfc515aed10f43640991a92ea7fcac8f30","nullifierTree":"0x048495fbbe0eed5c41a89845be676dc4ce03cd27333e5093efecaf252877109d","publicDataTree":"0x2cf930d0af21e61fed0efeeaec602345ef0e12421c26d0cf28656b1fbadaf1fb"},"totalFees":139009277500,"totalManaUsed":418375}} 16:19:54 [16:19:54.689] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:54 [16:19:54.792] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:19:54 [16:19:54.792] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:54 [16:19:54.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:54 [16:19:54.921] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0387c3a17bf9ec4de76c0e97d2df5d390b6decca04da854bda196c7751976090","blockNumber":3,"slot":4} 16:19:54 [16:19:54.938] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:54 [16:19:54.945] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x29ea7150870e14e245456cbc59bd181c5940c54a59b23f6dbf7c1e31b0d8298b 16:19:54 [16:19:54.968] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:19:54 [16:19:54.970] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:19:54 [16:19:54.979] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:19:54 [16:19:54.980] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:19:54 [16:19:54.982] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e31b2cc9e600dd6bf1098639784d385f02cd7f8d0f8513d34a89e585b634fc6","nullifier":"0x1b71fca42bffc73e083cf07177aec0034b0f55faa48311c01b967f62b8f02c20"} 16:19:54 [16:19:54.984] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:19:55 [16:19:55.003] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 as fee payer 16:19:55 [16:19:55.066] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:55 [16:19:55.522] INFO: pxe:service Proving completed in 1052.5448529999994ms {"timings":{"total":1052.5448529999994,"sync":39.78710199999841,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":388.69581499999913,"oracles":{"debugLog":{"times":[0.792833999999857,1.0627320000021427,1.7902439999998023,0.9318480000001728,0.5099359999985609,0.36319100000036997,0.4333630000000994,0.58868799999982]},"fetchTaggedLogs":{"times":[149.6364790000007]},"loadCapsule":{"times":[0.39095200000156183,0.3656009999976959,0.8153149999998277,0.22533699999985402,0.2806080000009388,0.27146799999900395]},"getSharedSecret":{"times":[7.733815999999933]},"aes128Decrypt":{"times":[0.7896839999993972,2.47879599999942]},"getPublicKeysAndPartialAddress":{"times":[4.254618999999366]},"getKeyValidationRequest":{"times":[1.5406069999989995]},"deliverNote":{"times":[2.885608000000502]},"deleteCapsule":{"times":[0.3689220000014757]},"storeCapsule":{"times":[0.3204200000000128]},"getNotes":{"times":[1.8601359999993292]},"getAuthWitness":{"times":[0.30957000000125845]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05581099999835715]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0624420000021928]}}},{"functionName":"private_kernel_init","time":82.95564800000284},{"functionName":"private_kernel_reset","time":187.07874100000117},{"functionName":"private_kernel_tail","time":107.85516700000153}],"unaccounted":246.17237999999634}} 16:19:55 [16:19:55.561] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:55 [16:19:55.612] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0387c3a17bf9ec4de76c0e97d2df5d390b6decca04da854bda196c7751976090","blockNumber":3,"slot":4} 16:19:55 [16:19:55.618] VERBOSE: p2p:tx_pool Adding tx 0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020 to pool {"eventName":"tx-added-to-pool","txHash":"0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 16:19:55 [16:19:55.625] INFO: node Received tx 0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020 {"txHash":"0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020"} 16:19:55 [16:19:55.626] INFO: pxe:service Sent transaction 0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020 16:19:55 [16:19:55.768] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:55 [16:19:55.972] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:56 [16:19:56.151] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 16:19:56 [16:19:56.166] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-16T16:25:15.000Z","now":"2025-06-16T16:25:29.531Z"} 16:19:56 [16:19:56.177] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:56 [16:19:56.245] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x451b5fae completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x451b5fae","duration":49.824398000000656} 16:19:56 [16:19:56.266] VERBOSE: simulator:public-processor Processed tx 0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020 with 1 public calls in 81.90702600000077ms {"txHash":"0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020","txFee":22774761700,"revertCode":0,"gasUsed":{"totalGas":{"daGas":2048,"l2Gas":68545},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":1024,"l2Gas":42689},"billedGas":{"daGas":2048,"l2Gas":68545}},"publicDataWriteCount":3,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":81.90702600000077} 16:19:56 [16:19:56.268] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10117833400000018s {"duration":0.10117833400000018,"rate":421918.39213323995,"totalPublicGas":{"daGas":1024,"l2Gas":42689},"totalBlockGas":{"daGas":2048,"l2Gas":68545},"totalSizeInBytes":384} 16:19:56 [16:19:56.389] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:56 [16:19:56.399] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 171769.49291319106 mana/s {"blockHash":"0x29ba5484987b932cc8b308c5584192ce46a36a49b5a2729b8d6f58a300ee9573","globalVariables":{"chainId":31337,"version":2695071053,"blockNumber":3,"slotNumber":4,"timestamp":1750091115,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1caeeefe0ad7958efa5c7ee251a655ac14d2e512796e02d82f47e806be53b020"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":248.0174369999986,"publicProcessDuration":101.71046000000206,"rollupCircuitsDuration":233.69562100000257,"txCount":1,"blockNumber":3,"blockTimestamp":1750091115,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:19:56 [16:19:56.401] VERBOSE: sequencer Attesting committee is empty 16:19:56 [16:19:56.658] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:56 [16:19:56.667] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x03dd40fff6a063f575afb66b0c76687b068eea56c1c0dc444860a75821b62d5b 16:19:56 [16:19:56.668] VERBOSE: sequencer-client Sent L1 transaction 0x03dd40fff6a063f575afb66b0c76687b068eea56c1c0dc444860a75821b62d5b {"gasLimit":470217,"maxFeePerGas":"1.269635508","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:19:56 [16:19:56.683] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:19:56 [16:19:56.684] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x03dd40fff6a063f575afb66b0c76687b068eea56c1c0dc444860a75821b62d5b","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":3,"blockTimestamp":1750091115,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:19:56 [16:19:56.684] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:19:56 [16:19:56.688] INFO: blob-sink:server Received blob sidecar for block 0xa8e3eaba0a02461a8fe6675fe0647b99440368d1c621c104a1b31f3576becee4 16:19:56 [16:19:56.700] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa8e3eaba0a02461a8fe6675fe0647b99440368d1c621c104a1b31f3576becee4 16:19:56 [16:19:56.704] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750091151] on http://127.0.0.1:8545 16:19:56 [16:19:56.705] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:19:56 [16:19:56.707] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750091151 16:19:56 [16:19:56.707] WARN: foundation:test-date-provider Time set to 2025-06-16T16:25:51.000Z {"offset":354293,"timeMs":1750091151000} 16:19:56 [16:19:56.707] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 16:19:56 [16:19:56.862] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:56 [16:19:56.867] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 16:19:56 [16:19:56.868] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 16:19:56 [16:19:56.870] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 16:19:57 [16:19:57.063] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:57 [16:19:57.352] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:57 [16:19:57.369] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x29ba5484987b932cc8b308c5584192ce46a36a49b5a2729b8d6f58a300ee9573","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2695071053,"blockNumber":3,"slotNumber":4,"timestamp":1750091115,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0407e54eb9ff3c812c4a8292132742261a444fba5238ee7d5bfcdaed04e5af19","archiveNextLeafIndex":4} 16:19:57 [16:19:57.372] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 16:19:57 [16:19:57.475] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.7882869999994,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750091115,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:19:57 [16:19:57.490] VERBOSE: p2p Synched to latest block 3 16:19:57 [16:19:57.559] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:57 [16:19:57.671] INFO: e2e:e2e_mempool_limit Running test: e2e_mempool_limit should evict txs if there are too many 16:19:57 [16:19:57.697] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0407e54eb9ff3c812c4a8292132742261a444fba5238ee7d5bfcdaed04e5af19","header":{"contentCommitment":{"blobsHash":"0x00d88c3e500045bc6a0e2383df26cb1fa589adbe976dada469d7f4384e1e4680","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750091115,"version":2695071053},"lastArchive":"0x0387c3a17bf9ec4de76c0e97d2df5d390b6decca04da854bda196c7751976090","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x13248cee25eb75ceb61946b2959719cfc515aed10f43640991a92ea7fcac8f30","nullifierTree":"0x26f8c94dac647bf4b9a1bae62ed788ab43e801d2ab741636a04f320a54c2ba83","publicDataTree":"0x16827daebd5192ae65cf6aee4c3ce109a03a3323f430bdff87da2420a5834686"},"totalFees":22774761700,"totalManaUsed":68545}} 16:19:57 [16:19:57.762] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:57 [16:19:57.796] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:57 [16:19:57.845] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:19:57 [16:19:57.845] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:57 [16:19:57.904] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0407e54eb9ff3c812c4a8292132742261a444fba5238ee7d5bfcdaed04e5af19","blockNumber":4,"slot":5} 16:19:57 [16:19:57.922] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:57 [16:19:57.926] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x29ea7150870e14e245456cbc59bd181c5940c54a59b23f6dbf7c1e31b0d8298b 16:19:57 [16:19:57.935] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:19:57 [16:19:57.936] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:19:57 [16:19:57.944] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:19:57 [16:19:57.944] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:19:57 [16:19:57.947] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e31b2cc9e600dd6bf1098639784d385f02cd7f8d0f8513d34a89e585b634fc6","nullifier":"0x1b71fca42bffc73e083cf07177aec0034b0f55faa48311c01b967f62b8f02c20"} 16:19:57 [16:19:57.949] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:19:57 [16:19:57.965] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 as fee payer 16:19:58 [16:19:58.079] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:58 [16:19:58.476] INFO: pxe:service Proving completed in 789.8733390000016ms {"timings":{"total":789.8733390000016,"sync":13.08288900000116,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":244.3808370000006,"oracles":{"debugLog":{"times":[0.7261020000005374,0.35391099999833386,0.5202060000010533,0.5501069999991159,0.43952299999727984,0.37591100000281585,0.302758999998332,0.6159389999993437]},"fetchTaggedLogs":{"times":[79.44235100000151]},"loadCapsule":{"times":[0.1595549999983632,0.10760400000071968,0.23274700000183657,0.18692599999849335,0.1773959999991348,0.17139599999791244]},"getSharedSecret":{"times":[2.47477500000241]},"aes128Decrypt":{"times":[0.19608599999992293,1.133894999999029]},"getPublicKeysAndPartialAddress":{"times":[1.7712439999995695]},"getKeyValidationRequest":{"times":[1.7323120000000927]},"deliverNote":{"times":[2.9373190000005707]},"deleteCapsule":{"times":[0.27106799999819486]},"storeCapsule":{"times":[0.2300070000019332]},"getNotes":{"times":[1.2176280000021507]},"getAuthWitness":{"times":[0.3045190000011644]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06920300000274437]},"notifyEnqueuedPublicFunctionCall":{"times":[0.1278340000026219]}}},{"functionName":"private_kernel_init","time":101.3732799999998},{"functionName":"private_kernel_reset","time":200.14829899999677},{"functionName":"private_kernel_tail","time":80.48101200000019}],"unaccounted":150.40702200000305}} 16:19:58 [16:19:58.478] INFO: sequencer Sequencer config set {"minTxsPerBlock":4} 16:19:58 [16:19:58.478] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 16:19:58 [16:19:58.479] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":432930} 16:19:58 [16:19:58.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:58 [16:19:58.519] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x0407e54eb9ff3c812c4a8292132742261a444fba5238ee7d5bfcdaed04e5af19","blockNumber":4,"slot":5} 16:19:58 [16:19:58.580] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:58 [16:19:58.613] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:19:58 [16:19:58.613] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:58 [16:19:58.685] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:58 [16:19:58.689] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:58 [16:19:58.754] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x29ea7150870e14e245456cbc59bd181c5940c54a59b23f6dbf7c1e31b0d8298b 16:19:58 [16:19:58.778] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:19:58 [16:19:58.779] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:19:58 [16:19:58.860] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:19:58 [16:19:58.861] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:19:58 [16:19:58.866] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e31b2cc9e600dd6bf1098639784d385f02cd7f8d0f8513d34a89e585b634fc6","nullifier":"0x1b71fca42bffc73e083cf07177aec0034b0f55faa48311c01b967f62b8f02c20"} 16:19:58 [16:19:58.869] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:19:58 [16:19:58.885] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 as fee payer 16:19:58 [16:19:58.902] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.292] INFO: pxe:service Proving completed in 781.7766630000006ms {"timings":{"total":781.7766630000006,"sync":9.684905999998591,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":362.64369099999385,"oracles":{"debugLog":{"times":[0.5862879999986035,0.552466999997705,0.5175359999993816,0.7365219999992405,0.5754869999982475,0.4479539999992994,0.36107999999876483,0.5811680000006163]},"fetchTaggedLogs":{"times":[77.45746000000145]},"loadCapsule":{"times":[1.2947889999995823,1.0867730000027223,59.87267499999871,0.24042799999733688,0.24457699999766191,0.23336700000072597]},"getSharedSecret":{"times":[15.471252000003005]},"aes128Decrypt":{"times":[0.35836100000233273,1.33136100000047]},"getPublicKeysAndPartialAddress":{"times":[72.66351399999985]},"getKeyValidationRequest":{"times":[3.468085999997129]},"deliverNote":{"times":[5.741723999999522]},"deleteCapsule":{"times":[0.3078300000015588]},"storeCapsule":{"times":[0.26222799999959534]},"getNotes":{"times":[1.5716279999978724]},"getAuthWitness":{"times":[0.24187700000038603]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05868200000259094]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07368199999837088]}}},{"functionName":"private_kernel_init","time":58.841043000000354},{"functionName":"private_kernel_reset","time":152.92167999999947},{"functionName":"private_kernel_tail","time":73.80150899999717}],"unaccounted":123.88383400001112}} 16:19:59 [16:19:59.299] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.329] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x0407e54eb9ff3c812c4a8292132742261a444fba5238ee7d5bfcdaed04e5af19","blockNumber":4,"slot":5} 16:19:59 [16:19:59.400] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:59 [16:19:59.432] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:19:59 [16:19:59.433] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:59 [16:19:59.477] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8"} 16:19:59 [16:19:59.482] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x29ea7150870e14e245456cbc59bd181c5940c54a59b23f6dbf7c1e31b0d8298b 16:19:59 [16:19:59.494] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:19:59 [16:19:59.495] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:19:59 [16:19:59.502] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:19:59 [16:19:59.503] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:19:59 [16:19:59.504] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.508] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0e31b2cc9e600dd6bf1098639784d385f02cd7f8d0f8513d34a89e585b634fc6","nullifier":"0x1b71fca42bffc73e083cf07177aec0034b0f55faa48311c01b967f62b8f02c20"} 16:19:59 [16:19:59.509] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:19:59 [16:19:59.520] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0e8e5f31254ce0d798866bf33be00add13fc52228c5442001d1625ea3f9c1dc8 as fee payer 16:19:59 [16:19:59.899] INFO: pxe:service Proving completed in 575.0363629999993ms {"timings":{"total":575.0363629999993,"sync":6.436535999997432,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":177.47683700000198,"oracles":{"debugLog":{"times":[0.5627370000001974,0.43559300000197254,0.5075660000002244,0.6717600000010862,0.39772199999788427,0.36068100000193226,0.21868700000050012,0.3885420000005979]},"fetchTaggedLogs":{"times":[47.570560000000114]},"loadCapsule":{"times":[0.263517999999749,0.231246999999712,0.43561400000180583,0.2103160000006028,0.1411340000013297,0.18795500000123866]},"getSharedSecret":{"times":[3.577299000000494]},"aes128Decrypt":{"times":[0.43947299999854295,1.2860600000021805]},"getPublicKeysAndPartialAddress":{"times":[1.698312000000442]},"getKeyValidationRequest":{"times":[1.7027720000005502]},"deliverNote":{"times":[4.83886700000221]},"deleteCapsule":{"times":[0.19734600000083447]},"storeCapsule":{"times":[0.24452799999926356]},"getNotes":{"times":[1.0462320000006002]},"getAuthWitness":{"times":[0.21305600000050617]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04807199999777367]},"notifyEnqueuedPublicFunctionCall":{"times":[0.04450100000030943]}}},{"functionName":"private_kernel_init","time":52.094598000003316},{"functionName":"private_kernel_reset","time":163.14348099999916},{"functionName":"private_kernel_tail","time":81.74370099999942}],"unaccounted":94.14120999999795}} 16:19:59 [16:19:59.924] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:19:59 [16:19:59.952] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x0407e54eb9ff3c812c4a8292132742261a444fba5238ee7d5bfcdaed04e5af19","blockNumber":4,"slot":5} 16:19:59 [16:19:59.958] VERBOSE: p2p:tx_pool Adding tx 0x1e766a75ca202bdbebda3fa232b656a920fd175c9f57fc6551e3bd8e9385f108 to pool {"eventName":"tx-added-to-pool","txHash":"0x1e766a75ca202bdbebda3fa232b656a920fd175c9f57fc6551e3bd8e9385f108","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 16:19:59 [16:19:59.966] INFO: node Received tx 0x1e766a75ca202bdbebda3fa232b656a920fd175c9f57fc6551e3bd8e9385f108 {"txHash":"0x1e766a75ca202bdbebda3fa232b656a920fd175c9f57fc6551e3bd8e9385f108"} 16:19:59 [16:19:59.966] INFO: pxe:service Sent transaction 0x1e766a75ca202bdbebda3fa232b656a920fd175c9f57fc6551e3bd8e9385f108 16:20:00 [16:20:00.009] VERBOSE: p2p:tx_pool Adding tx 0x0fa6a954a1423487785e87432e8deefe5acc48db926d08562baea25ef7c2d7c6 to pool {"eventName":"tx-added-to-pool","txHash":"0x0fa6a954a1423487785e87432e8deefe5acc48db926d08562baea25ef7c2d7c6","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 16:20:00 [16:20:00.020] INFO: node Received tx 0x0fa6a954a1423487785e87432e8deefe5acc48db926d08562baea25ef7c2d7c6 {"txHash":"0x0fa6a954a1423487785e87432e8deefe5acc48db926d08562baea25ef7c2d7c6"} 16:20:00 [16:20:00.020] INFO: pxe:service Sent transaction 0x0fa6a954a1423487785e87432e8deefe5acc48db926d08562baea25ef7c2d7c6 16:20:00 [16:20:00.064] VERBOSE: p2p:tx_pool Adding tx 0x10d637051c983dcb975cc80f4a0d2cb6aac9ab7be2ae58ff75094a12f449f36e to pool {"eventName":"tx-added-to-pool","txHash":"0x10d637051c983dcb975cc80f4a0d2cb6aac9ab7be2ae58ff75094a12f449f36e","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 16:20:00 [16:20:00.071] VERBOSE: p2p:tx_pool Evicting tx 0x0fa6a954a1423487785e87432e8deefe5acc48db926d08562baea25ef7c2d7c6 from pool due to low priority to satisfy max tx size limit {"txHash":"0x0fa6a954a1423487785e87432e8deefe5acc48db926d08562baea25ef7c2d7c6","txSize":173172} 16:20:00 [16:20:00.075] INFO: node Received tx 0x10d637051c983dcb975cc80f4a0d2cb6aac9ab7be2ae58ff75094a12f449f36e {"txHash":"0x10d637051c983dcb975cc80f4a0d2cb6aac9ab7be2ae58ff75094a12f449f36e"} 16:20:00 [16:20:00.076] INFO: pxe:service Sent transaction 0x10d637051c983dcb975cc80f4a0d2cb6aac9ab7be2ae58ff75094a12f449f36e 16:20:00 PASS src/e2e_mempool_limit.test.ts 16:20:00 e2e_mempool_limit 16:20:00 ✓ should evict txs if there are too many (2408 ms) 16:20:00 16:20:00 Test Suites: 1 passed, 1 total 16:20:00 Tests: 1 passed, 1 total 16:20:00 Snapshots: 0 total 16:20:00 Time: 26.284 s 16:20:00 Ran all test suites matching /src\/e2e_mempool_limit.test.ts/i. 16:20:00 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?