ACI ·

Parent Log: http://ci.aztec-labs.com/a0947d4e5c3fb9d9 Command: 3cad4e1fd0756a5c: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/e9a2301883801edbe36ea8bba05dcca7e714f30a Env: REF_NAME=gh-readonly-queue/master/pr-15131-464e1a9d9b40b5188586643b44bc52bffccbc3e6 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Wed Jun 18 12:49:48 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15131_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_3177e4e547f012b7_master 12:49:48 +++ id -u 12:49:48 +++ id -g 12:49:48 ++ 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'\''' 12:49:49 + cid=3a8370cd911c4fe009a5bdf319b6bc5c646305f40d5ec9779d18db535c650caf 12:49:49 + set +x 12:49:50 {"level":25,"time":1750250990033,"pid":12,"hostname":"3a8370cd911c","module":"logger","msg":"Logger initialized with level verbose"} 12:49:56 [12:49:56.745] INFO: e2e:e2e_mempool_limit Logging metrics to log/unknown.jsonl 12:49:57 [12:49:57.019] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-FpdyIE/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 12:49:57 [12:49:57.062] INFO: e2e:e2e_mempool_limit Calling anvil_setBlockTimestampInterval with params: [12] 12:49:57 [12:49:57.090] WARN: e2e:e2e_mempool_limit Set block interval to 12 12:49:57 [12:49:57.090] VERBOSE: e2e:e2e_mempool_limit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 12:49:57 [12:49:57.171] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 12:49:57 [12:49:57.184] VERBOSE: e2e:e2e_mempool_limit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 12:49:57 [12:49:57.213] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 12:49:57 [12:49:57.224] VERBOSE: e2e:e2e_mempool_limit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 12:49:57 [12:49:57.248] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 12:49:57 [12:49:57.254] VERBOSE: e2e:e2e_mempool_limit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 12:49:57 [12:49:57.279] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 12:49:57 [12:49:57.302] VERBOSE: e2e:e2e_mempool_limit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 12:49:57 [12:49:57.340] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 12:49:57 [12:49:57.345] VERBOSE: e2e:e2e_mempool_limit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 12:49:57 [12:49:57.359] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 12:49:57 [12:49:57.373] VERBOSE: e2e:e2e_mempool_limit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 12:49:57 [12:49:57.374] VERBOSE: e2e:e2e_mempool_limit Waiting for deployments to complete 12:49:57 [12:49:57.375] INFO: e2e:e2e_mempool_limit Waiting for 6 transactions to be mined... 12:49:57 [12:49:57.405] INFO: e2e:e2e_mempool_limit All transactions mined successfully 12:49:57 [12:49:57.422] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 12:49:57 [12:49:57.422] VERBOSE: e2e:e2e_mempool_limit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 12:49:57 [12:49:57.433] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 12:49:57 [12:49:57.445] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 12:49:57 [12:49:57.452] VERBOSE: e2e:e2e_mempool_limit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 12:49:57 [12:49:57.504] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 12:49:57 [12:49:57.504] VERBOSE: e2e:e2e_mempool_limit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 12:49:57 [12:49:57.524] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 12:49:57 [12:49:57.532] VERBOSE: e2e:e2e_mempool_limit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 12:49:57 [12:49:57.546] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 12:49:57 [12:49:57.546] VERBOSE: e2e:e2e_mempool_limit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 12:49:57 [12:49:57.546] VERBOSE: e2e:e2e_mempool_limit Waiting for deployments to complete 12:49:57 [12:49:57.546] INFO: e2e:e2e_mempool_limit Waiting for 8 transactions to be mined... 12:49:57 [12:49:57.565] INFO: e2e:e2e_mempool_limit All transactions mined successfully 12:49:57 [12:49:57.578] VERBOSE: e2e:e2e_mempool_limit Deployed shared contracts 12:49:57 [12:49:57.596] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 12:49:57 [12:49:57.596] VERBOSE: e2e:e2e_mempool_limit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 12:49:57 [12:49:57.600] 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} 12:49:57 [12:49:57.619] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 12:49:57 [12:49:57.660] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 12:49:57 [12:49:57.679] VERBOSE: e2e:e2e_mempool_limit Awaiting for linked libraries to be deployed 12:49:57 [12:49:57.733] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xa87aed1163022094a4cd5b0b426f4ff82f90e1bb18ebab81646922dc4aeb9936 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 12:49:57 [12:49:57.742] 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} 12:49:57 [12:49:57.743] INFO: e2e:e2e_mempool_limit Waiting for 9 transactions to be mined... 12:49:57 [12:49:57.776] INFO: e2e:e2e_mempool_limit All transactions mined successfully 12:49:57 [12:49:57.777] VERBOSE: e2e:e2e_mempool_limit All core contracts have been deployed 12:49:57 [12:49:57.793] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 12:49:57 [12:49:57.794] VERBOSE: e2e:e2e_mempool_limit Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 12:49:57 [12:49:57.813] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 12:49:57 [12:49:57.819] VERBOSE: e2e:e2e_mempool_limit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 12:49:57 [12:49:57.854] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 12:49:57 [12:49:57.855] VERBOSE: e2e:e2e_mempool_limit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 12:49:57 [12:49:57.855] INFO: e2e:e2e_mempool_limit Waiting for 10 transactions to be mined... 12:49:57 [12:49:57.880] INFO: e2e:e2e_mempool_limit All transactions mined successfully 12:49:57 [12:49:57.888] VERBOSE: e2e:e2e_mempool_limit Rollup deployed 12:49:57 [12:49:57.888] VERBOSE: e2e:e2e_mempool_limit Waiting for rollup and slash factory to be deployed 12:49:57 [12:49:57.888] INFO: e2e:e2e_mempool_limit Waiting for 10 transactions to be mined... 12:49:57 [12:49:57.918] INFO: e2e:e2e_mempool_limit All transactions mined successfully 12:49:57 [12:49:57.918] VERBOSE: e2e:e2e_mempool_limit All transactions for L1 deployment have been mined 12:49:57 [12:49:57.937] 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"} 12:49:57 [12:49:57.940] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 12:49:57 [12:49:57.943] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.944] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 12:49:57 [12:49:57.945] INFO: telemetry:client Using NoopTelemetryClient 12:49:57 [12:49:57.951] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/39ee1b97972217aa/blob-sink with map size 134217728 KB (LMDB v2) 12:49:57 [12:49:57.951] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 12:49:57 [12:49:57.952] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 12:49:57 [12:49:57.955] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.958] INFO: aztecjs:utils:watcher New L1 time: 1750251236 12:49:57 [12:49:57.959] WARN: foundation:test-date-provider Time set to 2025-06-18T12:53:56.000Z {"offset":238042,"timeMs":1750251236000} 12:49:57 [12:49:57.961] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 12:49:57 [12:49:57.967] INFO: blob-sink:server Server is running on http://localhost:38655 12:49:57 [12:49:57.967] VERBOSE: e2e:e2e_mempool_limit Creating and synching an aztec node... 12:49:57 [12:49:57.968] VERBOSE: e2e:e2e_mempool_limit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/7e65c92d/acvm 12:49:57 [12:49:57.970] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:38655"} 12:49:57 [12:49:57.985] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 12:49:57 [12:49:57.986] INFO: archiver:lmdb Creating archiver data store at directory /tmp/39ee1b97972217aa/archiver with map size 134217728 KB (LMDB v2) 12:49:57 [12:49:57.987] INFO: archiver:lmdb Starting data store with maxReaders 16 12:49:58 [12:49:58.247] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:58 [12:49:58.345] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:38655"} 12:49:58 [12:49:58.360] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:38655"} 12:49:58 [12:49:58.361] WARN: node:blob-sink:client No L1 consensus host urls configured 12:49:58 [12:49:58.361] WARN: node:blob-sink:client No archive client configured 12:49:58 [12:49:58.364] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xcb1243f2953bbc3e6fa7045ada1e41845f34c38665700df13543b8f4a651742c {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xd3cb2b910a6324120e763c5b3cf15ebce8818e57db4aef9f0e29415b126f266c","l1BlockNumber":16}} 12:49:58 [12:49:58.383] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 12:49:58 [12:49:58.395] INFO: world-state:database Creating world state data store at directory /tmp/39ee1b97972217aa/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 12:49:58 [12:49:58.424] INFO: world_state Created world state synchroniser with block history of 64 12:49:58 [12:49:58.425] WARN: node Aztec node is accepting fake proofs 12:49:58 [12:49:58.436] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/39ee1b97972217aa/p2p with map size 134217728 KB (LMDB v2) 12:49:58 [12:49:58.437] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 12:49:58 [12:49:58.439] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/39ee1b97972217aa/p2p-archive with map size 134217728 KB (LMDB v2) 12:49:58 [12:49:58.440] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 12:49:58 [12:49:58.441] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/39ee1b97972217aa/p2p-peers with map size 134217728 KB (LMDB v2) 12:49:58 [12:49:58.442] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 12:49:58 [12:49:58.443] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 12:49:58 [12:49:58.444] VERBOSE: p2p P2P is disabled. Using dummy P2P service 12:49:58 [12:49:58.447] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 12:49:58 [12:49:58.448] INFO: world_state Started world state synchronizer from block 1 12:49:58 [12:49:58.450] VERBOSE: world-state:block_stream Starting sync from block number 0 12:49:58 [12:49:58.452] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:58 [12:49:58.455] INFO: p2p Starting p2p client from block 0 with empty mempools 12:49:58 [12:49:58.455] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 12:49:58 [12:49:58.457] INFO: slasher Slasher client initialized 12:49:58 [12:49:58.457] INFO: slasher Starting Slasher client... 12:49:58 [12:49:58.502] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:58 [12:49:58.503] VERBOSE: node All Aztec Node subsystems synced 12:49:58 [12:49:58.515] INFO: sequencer-client Deploying forwarder contract 12:49:58 [12:49:58.527] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 12:49:58 [12:49:58.540] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 12:49:58 [12:49:58.540] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 12:49:58 [12:49:58.545] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 12:49:58 [12:49:58.562] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:58 [12:49:58.563] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 12:49:58 [12:49:58.563] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/7e65c92d/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 12:49:58 [12:49:58.762] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 12:49:58 [12:49:58.764] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:58 [12:49:58.765] INFO: node Aztec Node version: 0.87.8 12:49:58 [12:49:58.766] 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"} 12:49:58 [12:49:58.767] VERBOSE: e2e:e2e_mempool_limit Creating a pxe... 12:49:58 [12:49:58.770] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:58 [12:49:58.778] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/51c75a89c8e30ebc/pxe_data with map size 134217728 KB (LMDB v2) 12:49:58 [12:49:58.788] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x297d7a3321b913974627de30cc6b42a40a4eb854796e95af69593179e833e09e","blockNumber":1,"slot":2} 12:49:58 [12:49:58.789] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:49:59 [12:49:59.003] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:59 [12:49:59.039] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 12:49:59 [12:49:59.040] INFO: pxe:service Started PXE connected to chain 31337 version 965945136 12:49:59 [12:49:59.094] INFO: pxe:service Registered account 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 12:49:59 [12:49:59.155] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 12:49:59 [12:49:59.156] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 12:49:59 [12:49:59.236] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:59 [12:49:59.290] INFO: pxe:service Added contract SchnorrAccount at 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 12:49:59 [12:49:59.344] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x297d7a3321b913974627de30cc6b42a40a4eb854796e95af69593179e833e09e","blockNumber":1,"slot":2} 12:49:59 [12:49:59.347] VERBOSE: pxe:block_stream Starting sync from block number 0 12:49:59 [12:49:59.370] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 12:49:59 [12:49:59.451] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:50:00 [12:50:00.161] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 12:50:00 [12:50:00.277] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 12:50:00 [12:50:00.358] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:00 [12:50:00.486] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:00 [12:50:00.532] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x297d7a3321b913974627de30cc6b42a40a4eb854796e95af69593179e833e09e","blockNumber":1,"slot":2} 12:50:00 [12:50:00.544] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:00 [12:50:00.545] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:00 [12:50:00.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:00 [12:50:00.589] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:00 [12:50:00.593] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:00 [12:50:00.785] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:00 [12:50:00.824] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:00 [12:50:00.824] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:00 [12:50:00.829] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:00 [12:50:00.872] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:00 [12:50:00.875] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:00 [12:50:00.891] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 as fee payer 12:50:01 [12:50:01.096] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:01 [12:50:01.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:01 [12:50:01.361] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x297d7a3321b913974627de30cc6b42a40a4eb854796e95af69593179e833e09e","blockNumber":1,"slot":2} 12:50:01 [12:50:01.639] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:01 [12:50:01.964] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:02 [12:50:02.074] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x297d7a3321b913974627de30cc6b42a40a4eb854796e95af69593179e833e09e","blockNumber":1,"slot":2} 12:50:02 [12:50:02.556] INFO: pxe:service Proving completed in 3213.2495550000003ms {"timings":{"total":3213.2495550000003,"sync":3.803212999999232,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":152.41792099999657,"oracles":{"callPrivateFunction":{"times":[941.0506049999985,355.9888200000005,192.12005599999975]}}},{"functionName":"private_kernel_init","time":139.38839200000075},{"functionName":"ContractClassRegisterer:register","time":924.1313960000007,"oracles":{"loadCapsule":{"times":[21.29144599999927]},"notifyCreatedNullifier":{"times":[0.9464279999992868]},"debugLog":{"times":[0.9758899999997084]},"notifyCreatedContractClassLog":{"times":[11.614772999999332]}}},{"functionName":"private_kernel_inner","time":259.7333150000013},{"functionName":"SchnorrAccount:constructor","time":314.86991800000214,"oracles":{"getContractInstance":{"times":[6.862110999998549]},"debugLog":{"times":[0.5770360000005894,0.5271130000000994]},"fetchTaggedLogs":{"times":[46.55874600000061]},"loadCapsule":{"times":[0.38173400000050606,0.22033299999930023,0.22028300000056333]},"notifyCreatedNullifier":{"times":[0.20865299999968556,0.2667669999991631]},"notifyCreatedNote":{"times":[0.44698800000151095]},"getRandomField":{"times":[0.3725819999999658,0.4760200000000623,0.08253499999955238,0.11157699999967008,0.07813499999974738,0.08524500000021362,0.07001400000081048,0.05599400000028254,0.048703000000386965,0.09755600000062259,0.05443299999933515]},"getIndexedTaggingSecretAsSender":{"times":[47.1396220000006]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.89994099999967]}}},{"functionName":"private_kernel_inner","time":165.64148300000124},{"functionName":"SchnorrAccount:entrypoint","time":164.18800200000078,"oracles":{"debugLog":{"times":[0.5888260000010632,0.36062200000014855,0.7078030000011495]},"fetchTaggedLogs":{"times":[49.6320850000011]},"loadCapsule":{"times":[0.21636300000136544,0.18393099999957485,0.17014000000017404]},"getNotes":{"times":[2.3943269999999757]},"getAuthWitness":{"times":[0.5188809999999648]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7727869999998802]}}},{"functionName":"private_kernel_inner","time":177.90813499999967},{"functionName":"private_kernel_reset","time":229.4435570000005},{"functionName":"private_kernel_tail","time":64.5800820000004}],"unaccounted":617.144140999997}} 12:50:02 [12:50:02.573] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:02 [12:50:02.698] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x297d7a3321b913974627de30cc6b42a40a4eb854796e95af69593179e833e09e","blockNumber":1,"slot":2} 12:50:02 [12:50:02.706] VERBOSE: p2p:tx_pool Adding tx 0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e to pool {"eventName":"tx-added-to-pool","txHash":"0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 12:50:02 [12:50:02.722] INFO: node Received tx 0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e {"txHash":"0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e"} 12:50:02 [12:50:02.722] INFO: pxe:service Sent transaction 0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e 12:50:02 [12:50:02.780] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:02 [12:50:02.984] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:03 [12:50:03.187] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:03 [12:50:03.214] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 12:50:03 [12:50:03.227] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T12:54:20.000Z","now":"2025-06-18T12:54:01.269Z"} 12:50:03 [12:50:03.399] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:03 [12:50:03.455] VERBOSE: simulator:public-processor Processed tx 0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e with no public calls in 161.1794089999985ms {"txHash":"0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e","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":161.1794089999985} 12:50:03 [12:50:03.458] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23045105799999874s {"duration":0.23045105799999874,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 12:50:03 [12:50:03.603] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1c7e38dc3ec00e6318722b3309834e3f2044308a720e26e33f57be772c592922","globalVariables":{"chainId":31337,"version":965945136,"blockNumber":1,"slotNumber":2,"timestamp":1750251260,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x04ede83f7d1da5c7770efc74ee479b7c0867c452c55a797fb32719bf0a27802e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":389.2712819999997,"publicProcessDuration":231.2391469999984,"rollupCircuitsDuration":377.3710919999994,"txCount":1,"blockNumber":1,"blockTimestamp":1750251260,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:50:03 [12:50:03.606] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:03 [12:50:03.610] VERBOSE: sequencer Attesting committee is empty 12:50:04 [12:50:04.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.045] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xe937915ff6e0ac69a2c48a84e156b983a43987fa907d2de3fccc7b9f49b4022c 12:50:04 [12:50:04.045] VERBOSE: sequencer-client Sent L1 transaction 0xe937915ff6e0ac69a2c48a84e156b983a43987fa907d2de3fccc7b9f49b4022c {"gasLimit":514570,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 12:50:04 [12:50:04.061] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 12:50:04 [12:50:04.067] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 12:50:04 [12:50:04.074] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:50:04 [12:50:04.076] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xe937915ff6e0ac69a2c48a84e156b983a43987fa907d2de3fccc7b9f49b4022c","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1750251260,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:50:04 [12:50:04.076] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:50:04 [12:50:04.081] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 12:50:04 [12:50:04.082] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251296] on http://127.0.0.1:8545 12:50:04 [12:50:04.089] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:50:04 [12:50:04.093] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251296 12:50:04 [12:50:04.093] WARN: foundation:test-date-provider Time set to 2025-06-18T12:54:56.000Z {"offset":291907,"timeMs":1750251296000} 12:50:04 [12:50:04.093] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 12:50:04 [12:50:04.109] INFO: blob-sink:server Received blob sidecar for block 0x0608d212b7240202592f5eac320835f6671b7d7cfcd3a6c2a215bd076c3601de 12:50:04 [12:50:04.118] INFO: blob-sink:server Blob sidecar stored successfully for block 0x0608d212b7240202592f5eac320835f6671b7d7cfcd3a6c2a215bd076c3601de 12:50:04 [12:50:04.242] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.456] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 12:50:04 [12:50:04.466] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.477] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1c7e38dc3ec00e6318722b3309834e3f2044308a720e26e33f57be772c592922","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":965945136,"blockNumber":1,"slotNumber":2,"timestamp":1750251260,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0523d2bc75fe1c82bd2b10bcfe71177a9c1b47bd0cdfb9deaf6d174944719044","archiveNextLeafIndex":2} 12:50:04 [12:50:04.486] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 12:50:04 [12:50:04.983] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.990] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 12:50:04 [12:50:04.996] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x23843c4e04333f7dc226faec033e646221291a44508731ae64e2226f3a3b1253 12:50:05 [12:50:05.200] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:05 [12:50:05.203] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":216.01130199999898,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750251260,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:50:05 [12:50:05.406] VERBOSE: p2p Synched to latest block 1 12:50:05 [12:50:05.459] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:05 [12:50:05.748] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:05 [12:50:05.763] INFO: pxe:service Added contract Token at 0x23843c4e04333f7dc226faec033e646221291a44508731ae64e2226f3a3b1253 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 12:50:05 [12:50:05.778] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0523d2bc75fe1c82bd2b10bcfe71177a9c1b47bd0cdfb9deaf6d174944719044","blockNumber":2,"slot":3} 12:50:05 [12:50:05.787] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x0523d2bc75fe1c82bd2b10bcfe71177a9c1b47bd0cdfb9deaf6d174944719044","header":{"contentCommitment":{"blobsHash":"0x00bd3d2c6290d32037d1c8de6178cf1a038cf8caec6acd1655d7b4cf3070dd82","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750251260,"version":965945136},"lastArchive":"0x297d7a3321b913974627de30cc6b42a40a4eb854796e95af69593179e833e09e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x251b6c8bfd7d892762e90116aab645ba8be3ba70e36186b82d14cb021ee658e5","nullifierTree":"0x14468ec4da3add0cd364a99fa1fe45bbbf51f400542cd55ed8e09d309fa44693","publicDataTree":"0x15b2ed9c00fc6f38fb15ee60f7d2aba89abb78263a37b39fc292a7d25f75c6c5"},"totalFees":6794052480,"totalManaUsed":20448}} 12:50:05 [12:50:05.896] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:05 [12:50:05.937] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:05 [12:50:05.937] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:05 [12:50:05.979] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:06 [12:50:06.123] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:06 [12:50:06.128] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07e6b60327950919f524688e9892f1e9c863530f488c4fb4ef7444772d4d80b9 12:50:06 [12:50:06.145] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:06 [12:50:06.146] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:06 [12:50:06.157] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:06 [12:50:06.158] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:06 [12:50:06.166] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0dcf9b86c668bc18a28b4fd982a3e62694464c55fc5391293e1ab5e55cdffee6","nullifier":"0x087ba01061152fcd052bb420366e74a4fb1e915c88b2eaf5863831bce1f49210"} 12:50:06 [12:50:06.168] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:06 [12:50:06.187] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 as fee payer 12:50:06 [12:50:06.191] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:06 [12:50:06.241] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:50:06 [12:50:06.789] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 12:50:06 [12:50:06.899] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 12:50:06 [12:50:06.981] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:07 [12:50:07.089] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 12:50:07 [12:50:07.111] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0523d2bc75fe1c82bd2b10bcfe71177a9c1b47bd0cdfb9deaf6d174944719044","blockNumber":2,"slot":3} 12:50:07 [12:50:07.152] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:50:07 [12:50:07.170] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x23843c4e04333f7dc226faec033e646221291a44508731ae64e2226f3a3b1253,0x0000000000000000000000000000000000000000000000000000000000000001,0x162bc1956fa824f1c1a8f136cb507c78c9993c7a630aea67d98f7c82141c3333,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x02079fb120271cde4dc8508a3228792fca7906dadd54a134c4fd0dddf0ef26aa,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 12:50:07 [12:50:07.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:07 [12:50:07.581] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:07 [12:50:07.754] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0523d2bc75fe1c82bd2b10bcfe71177a9c1b47bd0cdfb9deaf6d174944719044","blockNumber":2,"slot":3} 12:50:07 [12:50:07.927] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:08 [12:50:08.214] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:08 [12:50:08.582] INFO: pxe:service Proving completed in 2803.7933539999976ms {"timings":{"total":2803.7933539999976,"sync":11.119921999998041,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":424.78173199999947,"oracles":{"debugLog":{"times":[0.6175279999988561,0.5410929999998189,0.5312319999975443,0.5997669999997015,0.5409529999997176,0.5162909999999101,0.4054649999998219,0.6422490000004473]},"fetchTaggedLogs":{"times":[188.69934699999794]},"loadCapsule":{"times":[0.26403600000048755,0.40208500000153435,0.754135999999562,0.2735160000011092,0.29298800000105985,0.20849299999827053]},"getSharedSecret":{"times":[5.2746640000004845]},"aes128Decrypt":{"times":[1.2868089999974472,1.3016799999968498]},"getPublicKeysAndPartialAddress":{"times":[2.228226999999606]},"getKeyValidationRequest":{"times":[5.340127999999822]},"deliverNote":{"times":[7.846860999998171]},"deleteCapsule":{"times":[0.509701999999379]},"storeCapsule":{"times":[0.43306700000175624]},"getNotes":{"times":[1.859283999998297]},"getAuthWitness":{"times":[0.29412800000136485]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06980399999883957]},"callPrivateFunction":{"times":[787.6730640000023,199.2680160000018]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4486670000005688]}}},{"functionName":"private_kernel_init","time":66.08288399999947},{"functionName":"ContractClassRegisterer:register","time":770.9898900000007,"oracles":{"loadCapsule":{"times":[5.706171000001632]},"notifyCreatedNullifier":{"times":[0.3239190000022063]},"debugLog":{"times":[0.5000209999998333]},"notifyCreatedContractClassLog":{"times":[7.956629000000248]}}},{"functionName":"private_kernel_inner","time":142.52605400000175},{"functionName":"ContractInstanceDeployer:deploy","time":118.88398299999972,"oracles":{"storeInExecutionCache":{"times":[0.36298299999907613]},"callPrivateFunction":{"times":[65.69708099999843]},"notifyCreatedNullifier":{"times":[0.3279400000028545]},"debugLog":{"times":[0.6926519999979064]}}},{"functionName":"private_kernel_inner","time":171.12771900000007},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":47.02182499999981,"oracles":{}},{"functionName":"private_kernel_inner","time":169.17516899999828},{"functionName":"private_kernel_reset","time":229.25097499999902},{"functionName":"private_kernel_tail","time":137.35535700000037}],"unaccounted":515.4778440000009}} 12:50:08 [12:50:08.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:08 [12:50:08.852] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:08 [12:50:08.879] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0523d2bc75fe1c82bd2b10bcfe71177a9c1b47bd0cdfb9deaf6d174944719044","blockNumber":2,"slot":3} 12:50:08 [12:50:08.887] VERBOSE: p2p:tx_pool Adding tx 0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e to pool {"eventName":"tx-added-to-pool","txHash":"0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 12:50:08 [12:50:08.916] INFO: node Received tx 0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e {"txHash":"0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e"} 12:50:08 [12:50:08.917] INFO: pxe:service Sent transaction 0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e 12:50:09 [12:50:09.055] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:09 [12:50:09.271] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:09 [12:50:09.421] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 12:50:09 [12:50:09.446] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T12:54:56.000Z","now":"2025-06-18T12:55:01.353Z"} 12:50:09 [12:50:09.479] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:09 [12:50:09.819] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.056] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.218] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":401.725486000003} 12:50:10 [12:50:10.418] VERBOSE: simulator:public-processor Processed tx 0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e with 1 public calls in 788.7436999999991ms {"txHash":"0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e","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":788.7436999999991} 12:50:10 [12:50:10.420] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.423] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.9756008939999993s {"duration":0.9756008939999993,"rate":391380.33016193635,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 12:50:10 [12:50:10.624] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.640] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 313105.45557238196 mana/s {"blockHash":"0x0b1a58b16aaf939ad77a9ecfde7dc4d7a1dc8edc3d2c599e84a5cfedbd262691","globalVariables":{"chainId":31337,"version":965945136,"blockNumber":2,"slotNumber":3,"timestamp":1750251296,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0a0c1309334d1173efb6cc16ccfccd4481247ca5646f13d918ffd73c3e63ad0e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1218.6451349999988,"publicProcessDuration":975.9367139999995,"rollupCircuitsDuration":1194.5921479999997,"txCount":1,"blockNumber":2,"blockTimestamp":1750251296,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 12:50:10 [12:50:10.644] VERBOSE: sequencer Attesting committee is empty 12:50:10 [12:50:10.832] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.988] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xe1b0c53f867b0d1bd03afe07d8ae78eb5d86210e39537bc6525c4c35c985843e 12:50:10 [12:50:10.988] VERBOSE: sequencer-client Sent L1 transaction 0xe1b0c53f867b0d1bd03afe07d8ae78eb5d86210e39537bc6525c4c35c985843e {"gasLimit":470312,"maxFeePerGas":"1.303611197","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 12:50:11 [12:50:11.000] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:50:11 [12:50:11.001] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xe1b0c53f867b0d1bd03afe07d8ae78eb5d86210e39537bc6525c4c35c985843e","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":2,"blockTimestamp":1750251296,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 12:50:11 [12:50:11.001] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:50:11 [12:50:11.005] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251332] on http://127.0.0.1:8545 12:50:11 [12:50:11.007] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:50:11 [12:50:11.012] INFO: blob-sink:server Received blob sidecar for block 0x2157b2ef6e277c5aff201fa0a9423a91121ef6f3da4371b6728fbbfecaed2ead 12:50:11 [12:50:11.017] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251332 12:50:11 [12:50:11.017] WARN: foundation:test-date-provider Time set to 2025-06-18T12:55:32.000Z {"offset":320983,"timeMs":1750251332000} 12:50:11 [12:50:11.017] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 12:50:11 [12:50:11.020] INFO: blob-sink:server Blob sidecar stored successfully for block 0x2157b2ef6e277c5aff201fa0a9423a91121ef6f3da4371b6728fbbfecaed2ead 12:50:11 [12:50:11.036] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.042] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 12:50:11 [12:50:11.043] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 12:50:11 [12:50:11.044] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 12:50:11 [12:50:11.238] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.527] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.562] VERBOSE: archiver:block-helper Store contract instance at 0x23843c4e04333f7dc226faec033e646221291a44508731ae64e2226f3a3b1253 12:50:11 [12:50:11.597] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 12:50:11 [12:50:11.651] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0b1a58b16aaf939ad77a9ecfde7dc4d7a1dc8edc3d2c599e84a5cfedbd262691","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":965945136,"blockNumber":2,"slotNumber":3,"timestamp":1750251296,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x252b6ee0266ab0fd7c8c1de9fe06bc5981a3b6b8719d9e7a22ab2175fa0c163a","archiveNextLeafIndex":3} 12:50:11 [12:50:11.668] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 12:50:11 [12:50:11.739] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.794] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":30.02068899999722,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750251296,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 12:50:11 [12:50:11.860] VERBOSE: p2p Synched to latest block 2 12:50:11 [12:50:11.942] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:12 [12:50:12.194] INFO: aztecjs:deploy_sent_tx Contract 0x23843c4e04333f7dc226faec033e646221291a44508731ae64e2226f3a3b1253 successfully deployed. 12:50:12 [12:50:12.198] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:12 [12:50:12.267] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x252b6ee0266ab0fd7c8c1de9fe06bc5981a3b6b8719d9e7a22ab2175fa0c163a","blockNumber":3,"slot":4} 12:50:12 [12:50:12.275] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x252b6ee0266ab0fd7c8c1de9fe06bc5981a3b6b8719d9e7a22ab2175fa0c163a","header":{"contentCommitment":{"blobsHash":"0x006235b46030cd740c8c5cbec4753bec254d8e93438011ccb11952f017e7a910","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750251296,"version":965945136},"lastArchive":"0x0523d2bc75fe1c82bd2b10bcfe71177a9c1b47bd0cdfb9deaf6d174944719044","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x251b6c8bfd7d892762e90116aab645ba8be3ba70e36186b82d14cb021ee658e5","nullifierTree":"0x0af91b50fcb331c1ee84d89c24dc576be18ee9c53033dde0726f05c0b3f578cb","publicDataTree":"0x1f10b86479848ceda27e96ad0f907b3afbcb98b03cc7388c5eac8857e4459134"},"totalFees":139009277500,"totalManaUsed":418375}} 12:50:12 [12:50:12.370] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:12 [12:50:12.413] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:12 [12:50:12.413] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:12 [12:50:12.414] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:12 [12:50:12.504] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:12 [12:50:12.511] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07e6b60327950919f524688e9892f1e9c863530f488c4fb4ef7444772d4d80b9 12:50:12 [12:50:12.530] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:12 [12:50:12.531] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:12 [12:50:12.540] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:12 [12:50:12.541] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:12 [12:50:12.545] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0dcf9b86c668bc18a28b4fd982a3e62694464c55fc5391293e1ab5e55cdffee6","nullifier":"0x087ba01061152fcd052bb420366e74a4fb1e915c88b2eaf5863831bce1f49210"} 12:50:12 [12:50:12.555] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:12 [12:50:12.568] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 as fee payer 12:50:12 [12:50:12.618] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:13 [12:50:13.141] INFO: pxe:service Proving completed in 898.9007020000026ms {"timings":{"total":898.9007020000026,"sync":35.13032600000224,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":266.61244900000383,"oracles":{"debugLog":{"times":[0.8665959999998449,0.4792510000006587,0.5270239999990736,0.3795639999989362,0.46324900000035996,0.27075799999875017,1.0378559999990102,0.4772999999986496]},"fetchTaggedLogs":{"times":[95.20595799999865]},"loadCapsule":{"times":[0.241954999997688,0.18267199999900186,0.497482000002492,4.61107500000071,0.3240609999993467,0.3730040000009467]},"getSharedSecret":{"times":[8.249187000001257]},"aes128Decrypt":{"times":[0.4815410000010161,0.7524780000021565]},"getPublicKeysAndPartialAddress":{"times":[3.8458150000005844]},"getKeyValidationRequest":{"times":[2.662600999999995]},"deliverNote":{"times":[4.819977999999537]},"deleteCapsule":{"times":[0.8733759999995527]},"storeCapsule":{"times":[2.271824999999808]},"getNotes":{"times":[2.0470009999989998]},"getAuthWitness":{"times":[0.18937200000073062]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07104500000059488]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08009600000150385]}}},{"functionName":"private_kernel_init","time":87.957484999999},{"functionName":"private_kernel_reset","time":224.12660200000028},{"functionName":"private_kernel_tail","time":120.92175300000235}],"unaccounted":164.15208699999494}} 12:50:13 [12:50:13.168] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:13 [12:50:13.209] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x252b6ee0266ab0fd7c8c1de9fe06bc5981a3b6b8719d9e7a22ab2175fa0c163a","blockNumber":3,"slot":4} 12:50:13 [12:50:13.218] VERBOSE: p2p:tx_pool Adding tx 0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69 to pool {"eventName":"tx-added-to-pool","txHash":"0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 12:50:13 [12:50:13.234] INFO: node Received tx 0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69 {"txHash":"0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69"} 12:50:13 [12:50:13.234] INFO: pxe:service Sent transaction 0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69 12:50:13 [12:50:13.384] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:13 [12:50:13.598] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:13 [12:50:13.746] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 12:50:13 [12:50:13.769] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T12:55:32.000Z","now":"2025-06-18T12:55:34.752Z"} 12:50:13 [12:50:13.801] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:13 [12:50:13.908] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x451b5fae completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x451b5fae","duration":93.74060499999905} 12:50:13 [12:50:13.942] VERBOSE: simulator:public-processor Processed tx 0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69 with 1 public calls in 144.7320550000004ms {"txHash":"0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69","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":144.7320550000004} 12:50:13 [12:50:13.944] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.17462555699999938s {"duration":0.17462555699999938,"rate":244460.20807824912,"totalPublicGas":{"daGas":1024,"l2Gas":42689},"totalBlockGas":{"daGas":2048,"l2Gas":68545},"totalSizeInBytes":384} 12:50:14 [12:50:14.068] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.095] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 121406.13323513279 mana/s {"blockHash":"0x285be17847113753b13f267c59821a414f8e1f559d43f5c99cab928c58178de5","globalVariables":{"chainId":31337,"version":965945136,"blockNumber":3,"slotNumber":4,"timestamp":1750251332,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2d7c97b498a043274821ae6a13ba9a889c3f6796edf3b569a3374cf909aead69"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":350.6250110000001,"publicProcessDuration":175.2555969999994,"rollupCircuitsDuration":327.0378729999975,"txCount":1,"blockNumber":3,"blockTimestamp":1750251332,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:14 [12:50:14.099] VERBOSE: sequencer Attesting committee is empty 12:50:14 [12:50:14.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.399] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xdf19bb9fa9b31143f50957190e41fd19c3936f9aa485df8f78069de0c28790fa 12:50:14 [12:50:14.399] VERBOSE: sequencer-client Sent L1 transaction 0xdf19bb9fa9b31143f50957190e41fd19c3936f9aa485df8f78069de0c28790fa {"gasLimit":470263,"maxFeePerGas":"1.279583419","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 12:50:14 [12:50:14.421] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251368] on http://127.0.0.1:8545 12:50:14 [12:50:14.424] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:50:14 [12:50:14.428] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:50:14 [12:50:14.429] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdf19bb9fa9b31143f50957190e41fd19c3936f9aa485df8f78069de0c28790fa","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750251332,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:14 [12:50:14.430] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:50:14 [12:50:14.434] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251368 12:50:14 [12:50:14.434] WARN: foundation:test-date-provider Time set to 2025-06-18T12:56:08.000Z {"offset":353566,"timeMs":1750251368000} 12:50:14 [12:50:14.434] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 12:50:14 [12:50:14.436] INFO: blob-sink:server Received blob sidecar for block 0x197903aff6b9e2914cb06ba0485d3ea729a398eac583ed5a7fc8c8e3b47b18d8 12:50:14 [12:50:14.440] INFO: blob-sink:server Blob sidecar stored successfully for block 0x197903aff6b9e2914cb06ba0485d3ea729a398eac583ed5a7fc8c8e3b47b18d8 12:50:14 [12:50:14.478] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.482] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 12:50:14 [12:50:14.484] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 12:50:14 [12:50:14.485] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 12:50:14 [12:50:14.680] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.882] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:15 [12:50:15.050] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x285be17847113753b13f267c59821a414f8e1f559d43f5c99cab928c58178de5","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":965945136,"blockNumber":3,"slotNumber":4,"timestamp":1750251332,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1c9e481442e229ae8f3abac6842110e84848bc68862bffa4fca683929799ceb2","archiveNextLeafIndex":4} 12:50:15 [12:50:15.061] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 12:50:15 [12:50:15.085] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:15 [12:50:15.161] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":9.522038999999495,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750251332,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:15 [12:50:15.174] VERBOSE: p2p Synched to latest block 3 12:50:15 [12:50:15.243] INFO: e2e:e2e_mempool_limit Running test: e2e_mempool_limit should evict txs if there are too many 12:50:15 [12:50:15.282] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x1c9e481442e229ae8f3abac6842110e84848bc68862bffa4fca683929799ceb2","header":{"contentCommitment":{"blobsHash":"0x0039cf6dd0f0a67a26d4b21b585a188ecc56823fb4e486229cd55334efa6f342","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750251332,"version":965945136},"lastArchive":"0x252b6ee0266ab0fd7c8c1de9fe06bc5981a3b6b8719d9e7a22ab2175fa0c163a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x251b6c8bfd7d892762e90116aab645ba8be3ba70e36186b82d14cb021ee658e5","nullifierTree":"0x25743b39fb9e9d763afee5a4f0057a2071fab951279eb4ba71e587d3c9ffcf06","publicDataTree":"0x2d8eeabd9faec8816df9a60b60fae9398fbdc0858af2647497bd39f01ea10bb1"},"totalFees":22774761700,"totalManaUsed":68545}} 12:50:15 [12:50:15.288] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:15 [12:50:15.362] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:15 [12:50:15.400] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:15 [12:50:15.401] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:15 [12:50:15.457] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:15 [12:50:15.462] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07e6b60327950919f524688e9892f1e9c863530f488c4fb4ef7444772d4d80b9 12:50:15 [12:50:15.475] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:15 [12:50:15.476] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:15 [12:50:15.491] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:15 [12:50:15.491] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:15 [12:50:15.495] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0dcf9b86c668bc18a28b4fd982a3e62694464c55fc5391293e1ab5e55cdffee6","nullifier":"0x087ba01061152fcd052bb420366e74a4fb1e915c88b2eaf5863831bce1f49210"} 12:50:15 [12:50:15.497] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:15 [12:50:15.512] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 as fee payer 12:50:15 [12:50:15.552] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:15 [12:50:15.724] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1c9e481442e229ae8f3abac6842110e84848bc68862bffa4fca683929799ceb2","blockNumber":4,"slot":5} 12:50:16 [12:50:16.042] INFO: pxe:service Proving completed in 779.4598040000019ms {"timings":{"total":779.4598040000019,"sync":21.308333000000857,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":217.1755869999979,"oracles":{"debugLog":{"times":[0.6142689999978757,0.4509490000018559,0.4686200000032841,0.6223100000024715,0.36200300000200514,0.37301299999671755,0.30988000000070315,0.6926840000014636]},"fetchTaggedLogs":{"times":[59.24662800000078]},"loadCapsule":{"times":[0.25871600000027684,0.2170140000016545,0.3999259999982314,0.20695300000079442,0.17208100000061677,0.16435099999944214]},"getSharedSecret":{"times":[3.8736279999975523]},"aes128Decrypt":{"times":[0.290088999998261,1.101039999997738]},"getPublicKeysAndPartialAddress":{"times":[4.074080999998841]},"getKeyValidationRequest":{"times":[6.70466899999883]},"deliverNote":{"times":[4.171376999998756]},"deleteCapsule":{"times":[0.303979000000254]},"storeCapsule":{"times":[0.228054000002885]},"getNotes":{"times":[1.4431820000027074]},"getAuthWitness":{"times":[0.2007530000009865]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09523600000102306]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07278500000029453]}}},{"functionName":"private_kernel_init","time":79.99859600000127},{"functionName":"private_kernel_reset","time":198.4265290000003},{"functionName":"private_kernel_tail","time":121.07887299999857}],"unaccounted":141.471886000003}} 12:50:16 [12:50:16.045] INFO: sequencer Sequencer config set {"minTxsPerBlock":4} 12:50:16 [12:50:16.046] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 12:50:16 [12:50:16.046] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":432930} 12:50:16 [12:50:16.052] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:16 [12:50:16.169] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:16 [12:50:16.222] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:16 [12:50:16.223] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:16 [12:50:16.257] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:16 [12:50:16.260] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x1c9e481442e229ae8f3abac6842110e84848bc68862bffa4fca683929799ceb2","blockNumber":4,"slot":5} 12:50:16 [12:50:16.304] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:16 [12:50:16.311] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07e6b60327950919f524688e9892f1e9c863530f488c4fb4ef7444772d4d80b9 12:50:16 [12:50:16.361] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:16 [12:50:16.362] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:16 [12:50:16.372] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:16 [12:50:16.372] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:16 [12:50:16.376] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0dcf9b86c668bc18a28b4fd982a3e62694464c55fc5391293e1ab5e55cdffee6","nullifier":"0x087ba01061152fcd052bb420366e74a4fb1e915c88b2eaf5863831bce1f49210"} 12:50:16 [12:50:16.378] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:16 [12:50:16.391] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 as fee payer 12:50:16 [12:50:16.488] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:16 [12:50:16.989] INFO: pxe:service Proving completed in 911.5165290000004ms {"timings":{"total":911.5165290000004,"sync":7.265974999998434,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":366.5922720000017,"oracles":{"debugLog":{"times":[0.5769469999977446,0.4134269999995013,0.4584099999992759,0.5347340000007534,0.4703699999990931,0.40958600000158185,0.3864839999987453,0.4417380000013509]},"fetchTaggedLogs":{"times":[86.1928020000014]},"loadCapsule":{"times":[0.33679100000153994,0.26128700000117533,0.595978000001196,0.25650599999789847,0.33804199999940465,0.42736800000056974]},"getSharedSecret":{"times":[42.85547999999835]},"aes128Decrypt":{"times":[0.425427000001946,0.7873500000023341]},"getPublicKeysAndPartialAddress":{"times":[5.151899000000412]},"getKeyValidationRequest":{"times":[1.379507999998168]},"deliverNote":{"times":[3.429269000000204]},"deleteCapsule":{"times":[0.32088999999905354]},"storeCapsule":{"times":[0.26546700000108103]},"getNotes":{"times":[1.9006810000028054]},"getAuthWitness":{"times":[0.4028260000013688]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08540599999832921]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0610240000023623]}}},{"functionName":"private_kernel_init","time":63.045311999998376},{"functionName":"private_kernel_reset","time":183.144182},{"functionName":"private_kernel_tail","time":109.12892900000224}],"unaccounted":182.3398589999997}} 12:50:16 [12:50:16.997] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:17 [12:50:17.045] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x1c9e481442e229ae8f3abac6842110e84848bc68862bffa4fca683929799ceb2","blockNumber":4,"slot":5} 12:50:17 [12:50:17.138] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:17 [12:50:17.190] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:17 [12:50:17.191] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:17 [12:50:17.229] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:17 [12:50:17.254] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9"} 12:50:17 [12:50:17.258] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07e6b60327950919f524688e9892f1e9c863530f488c4fb4ef7444772d4d80b9 12:50:17 [12:50:17.269] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:17 [12:50:17.270] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:17 [12:50:17.280] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:17 [12:50:17.281] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:17 [12:50:17.284] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0dcf9b86c668bc18a28b4fd982a3e62694464c55fc5391293e1ab5e55cdffee6","nullifier":"0x087ba01061152fcd052bb420366e74a4fb1e915c88b2eaf5863831bce1f49210"} 12:50:17 [12:50:17.286] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:17 [12:50:17.306] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0785d1ad409e75d4bb2f957d129fe49d5c5a555c305a4df4c908d3800bb71cf9 as fee payer 12:50:17 [12:50:17.495] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:17 [12:50:17.784] INFO: pxe:service Proving completed in 743.0912189999981ms {"timings":{"total":743.0912189999981,"sync":5.889246999999159,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":239.35105599999952,"oracles":{"debugLog":{"times":[0.7056750000010652,0.31606099999771686,0.4887510000007751,0.6432910000003176,0.5839379999997618,0.372613999999885,0.39266500000303495,0.6294809999999416]},"fetchTaggedLogs":{"times":[66.23052499999903]},"loadCapsule":{"times":[0.20046300000103656,0.16361999999935506,0.2953589999997348,0.1843509999998787,0.23096399999849382,0.16464999999880092]},"getSharedSecret":{"times":[3.2933499999999185]},"aes128Decrypt":{"times":[0.5008820000002743,1.0539669999998296]},"getPublicKeysAndPartialAddress":{"times":[4.654058000000077]},"getKeyValidationRequest":{"times":[2.003607999999076]},"deliverNote":{"times":[3.597539999998844]},"deleteCapsule":{"times":[0.33375099999830127]},"storeCapsule":{"times":[0.2694870000013907]},"getNotes":{"times":[1.6082429999987653]},"getAuthWitness":{"times":[0.2613070000006701]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05819400000109454]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07610500000009779]}}},{"functionName":"private_kernel_init","time":67.14178399999946},{"functionName":"private_kernel_reset","time":190.02724200000011},{"functionName":"private_kernel_tail","time":97.73697999999786}],"unaccounted":142.94491000000198}} 12:50:17 [12:50:17.821] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:17 [12:50:17.854] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x1c9e481442e229ae8f3abac6842110e84848bc68862bffa4fca683929799ceb2","blockNumber":4,"slot":5} 12:50:17 [12:50:17.860] VERBOSE: p2p:tx_pool Adding tx 0x3040e0e1ec9383b7ab4d7ace94f14462b740d1372d6fed78d33d4f57733c291e to pool {"eventName":"tx-added-to-pool","txHash":"0x3040e0e1ec9383b7ab4d7ace94f14462b740d1372d6fed78d33d4f57733c291e","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 12:50:17 [12:50:17.870] INFO: node Received tx 0x3040e0e1ec9383b7ab4d7ace94f14462b740d1372d6fed78d33d4f57733c291e {"txHash":"0x3040e0e1ec9383b7ab4d7ace94f14462b740d1372d6fed78d33d4f57733c291e"} 12:50:17 [12:50:17.870] INFO: pxe:service Sent transaction 0x3040e0e1ec9383b7ab4d7ace94f14462b740d1372d6fed78d33d4f57733c291e 12:50:17 [12:50:17.922] VERBOSE: p2p:tx_pool Adding tx 0x266d5c50a3250c9e45e8b7195461be7c385869cc90f2d27d3a9722897116188b to pool {"eventName":"tx-added-to-pool","txHash":"0x266d5c50a3250c9e45e8b7195461be7c385869cc90f2d27d3a9722897116188b","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 12:50:17 [12:50:17.935] INFO: node Received tx 0x266d5c50a3250c9e45e8b7195461be7c385869cc90f2d27d3a9722897116188b {"txHash":"0x266d5c50a3250c9e45e8b7195461be7c385869cc90f2d27d3a9722897116188b"} 12:50:17 [12:50:17.935] INFO: pxe:service Sent transaction 0x266d5c50a3250c9e45e8b7195461be7c385869cc90f2d27d3a9722897116188b 12:50:17 [12:50:17.994] VERBOSE: p2p:tx_pool Adding tx 0x0207e1c572d9f401ae2bf64a4da7de33e9df4ab4494db1b1a94af9f4909b2a1b to pool {"eventName":"tx-added-to-pool","txHash":"0x0207e1c572d9f401ae2bf64a4da7de33e9df4ab4494db1b1a94af9f4909b2a1b","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 12:50:18 [12:50:18.001] VERBOSE: p2p:tx_pool Evicting tx 0x0207e1c572d9f401ae2bf64a4da7de33e9df4ab4494db1b1a94af9f4909b2a1b from pool due to low priority to satisfy max tx size limit {"txHash":"0x0207e1c572d9f401ae2bf64a4da7de33e9df4ab4494db1b1a94af9f4909b2a1b","txSize":173172} 12:50:18 [12:50:18.005] INFO: node Received tx 0x0207e1c572d9f401ae2bf64a4da7de33e9df4ab4494db1b1a94af9f4909b2a1b {"txHash":"0x0207e1c572d9f401ae2bf64a4da7de33e9df4ab4494db1b1a94af9f4909b2a1b"} 12:50:18 [12:50:18.005] INFO: pxe:service Sent transaction 0x0207e1c572d9f401ae2bf64a4da7de33e9df4ab4494db1b1a94af9f4909b2a1b 12:50:18 PASS src/e2e_mempool_limit.test.ts 12:50:18 e2e_mempool_limit 12:50:18 ✓ should evict txs if there are too many (2767 ms) 12:50:18 12:50:18 Test Suites: 1 passed, 1 total 12:50:18 Tests: 1 passed, 1 total 12:50:18 Snapshots: 0 total 12:50:18 Time: 28.194 s 12:50:18 Ran all test suites matching /src\/e2e_mempool_limit.test.ts/i. 12:50:18 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?