Parent Log: http://ci.aztec-labs.com/bac80ed53a95468a Command: 53e9b8d3e8ba3411: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/f4ac84d7ac4041d505399edd8819840bb14d6c9d Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 17:08:21 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15005_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_3177e4e547f012b7_master 17:08:21 +++ id -u 17:08:21 +++ id -g 17:08:21 ++ 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'\''' 17:08:21 + cid=a2ff184604b3f871068c43d025d4fe3459638ee9c305d77c648448e71c287ff0 17:08:21 + set +x 17:08:22 {"level":25,"time":1749834502309,"pid":12,"hostname":"a2ff184604b3","module":"logger","msg":"Logger initialized with level verbose"} 17:08:29 [17:08:29.176] INFO: e2e:e2e_mempool_limit Logging metrics to log/unknown.jsonl 17:08:29 [17:08:29.435] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-MGmOxE/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:08:29 [17:08:29.474] INFO: e2e:e2e_mempool_limit Calling anvil_setBlockTimestampInterval with params: [12] 17:08:29 [17:08:29.500] WARN: e2e:e2e_mempool_limit Set block interval to 12 17:08:29 [17:08:29.501] VERBOSE: e2e:e2e_mempool_limit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:29 [17:08:29.557] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:08:29 [17:08:29.565] VERBOSE: e2e:e2e_mempool_limit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:08:29 [17:08:29.584] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:08:29 [17:08:29.589] VERBOSE: e2e:e2e_mempool_limit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:08:29 [17:08:29.607] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:08:29 [17:08:29.614] VERBOSE: e2e:e2e_mempool_limit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:08:29 [17:08:29.630] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:08:29 [17:08:29.638] VERBOSE: e2e:e2e_mempool_limit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:08:29 [17:08:29.663] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:08:29 [17:08:29.669] VERBOSE: e2e:e2e_mempool_limit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:08:29 [17:08:29.681] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:08:29 [17:08:29.686] VERBOSE: e2e:e2e_mempool_limit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:08:29 [17:08:29.686] VERBOSE: e2e:e2e_mempool_limit Waiting for deployments to complete 17:08:29 [17:08:29.687] INFO: e2e:e2e_mempool_limit Waiting for 6 transactions to be mined... 17:08:29 [17:08:29.714] INFO: e2e:e2e_mempool_limit All transactions mined successfully 17:08:29 [17:08:29.734] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:08:29 [17:08:29.734] VERBOSE: e2e:e2e_mempool_limit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:08:29 [17:08:29.750] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:08:29 [17:08:29.767] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:08:29 [17:08:29.777] VERBOSE: e2e:e2e_mempool_limit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:08:29 [17:08:29.798] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:08:29 [17:08:29.799] VERBOSE: e2e:e2e_mempool_limit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:08:29 [17:08:29.832] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:08:29 [17:08:29.840] VERBOSE: e2e:e2e_mempool_limit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:08:29 [17:08:29.856] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:08:29 [17:08:29.856] VERBOSE: e2e:e2e_mempool_limit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:08:29 [17:08:29.856] VERBOSE: e2e:e2e_mempool_limit Waiting for deployments to complete 17:08:29 [17:08:29.856] INFO: e2e:e2e_mempool_limit Waiting for 8 transactions to be mined... 17:08:29 [17:08:29.882] INFO: e2e:e2e_mempool_limit All transactions mined successfully 17:08:29 [17:08:29.937] VERBOSE: e2e:e2e_mempool_limit Deployed shared contracts 17:08:30 [17:08:30.054] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:08:30 [17:08:30.056] VERBOSE: e2e:e2e_mempool_limit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:08:30 [17:08:30.063] 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} 17:08:30 [17:08:30.092] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:08:30 [17:08:30.136] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:08:30 [17:08:30.144] VERBOSE: e2e:e2e_mempool_limit Awaiting for linked libraries to be deployed 17:08:30 [17:08:30.200] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x20846fa0ad153a286033a5b3d181845efd604a690a2cd814979bbe543b98aa5f {"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:08:30 [17:08:30.209] 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} 17:08:30 [17:08:30.209] INFO: e2e:e2e_mempool_limit Waiting for 9 transactions to be mined... 17:08:30 [17:08:30.232] INFO: e2e:e2e_mempool_limit All transactions mined successfully 17:08:30 [17:08:30.232] VERBOSE: e2e:e2e_mempool_limit All core contracts have been deployed 17:08:30 [17:08:30.246] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:08:30 [17:08:30.247] VERBOSE: e2e:e2e_mempool_limit Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 17:08:30 [17:08:30.262] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a {"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"} 17:08:30 [17:08:30.266] VERBOSE: e2e:e2e_mempool_limit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:08:30 [17:08:30.290] VERBOSE: e2e:e2e_mempool_limit Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 {"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"} 17:08:30 [17:08:30.290] VERBOSE: e2e:e2e_mempool_limit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 17:08:30 [17:08:30.290] INFO: e2e:e2e_mempool_limit Waiting for 10 transactions to be mined... 17:08:30 [17:08:30.312] INFO: e2e:e2e_mempool_limit All transactions mined successfully 17:08:30 [17:08:30.318] VERBOSE: e2e:e2e_mempool_limit Rollup deployed 17:08:30 [17:08:30.319] VERBOSE: e2e:e2e_mempool_limit Waiting for rollup and slash factory to be deployed 17:08:30 [17:08:30.319] INFO: e2e:e2e_mempool_limit Waiting for 10 transactions to be mined... 17:08:30 [17:08:30.337] INFO: e2e:e2e_mempool_limit All transactions mined successfully 17:08:30 [17:08:30.337] VERBOSE: e2e:e2e_mempool_limit All transactions for L1 deployment have been mined 17:08:30 [17:08:30.360] 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"} 17:08:30 [17:08:30.363] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:08:30 [17:08:30.365] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.366] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:08:30 [17:08:30.367] INFO: telemetry:client Using NoopTelemetryClient 17:08:30 [17:08:30.374] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:08:30 [17:08:30.375] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:08:30 [17:08:30.376] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/239bbc18dbf3d690/blob-sink with map size 134217728 KB (LMDB v2) 17:08:30 [17:08:30.379] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.382] INFO: aztecjs:utils:watcher New L1 time: 1749834749 17:08:30 [17:08:30.383] WARN: foundation:test-date-provider Time set to 2025-06-13T17:12:29.000Z {"offset":238618,"timeMs":1749834749000} 17:08:30 [17:08:30.386] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:08:30 [17:08:30.393] INFO: blob-sink:server Server is running on http://localhost:37323 17:08:30 [17:08:30.394] VERBOSE: e2e:e2e_mempool_limit Creating and synching an aztec node... 17:08:30 [17:08:30.395] VERBOSE: e2e:e2e_mempool_limit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/34adb98d/acvm 17:08:30 [17:08:30.396] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:37323"} 17:08:30 [17:08:30.424] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:08:30 [17:08:30.425] INFO: archiver:lmdb Creating archiver data store at directory /tmp/239bbc18dbf3d690/archiver with map size 134217728 KB (LMDB v2) 17:08:30 [17:08:30.426] INFO: archiver:lmdb Starting data store with maxReaders 16 17:08:30 [17:08:30.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.761] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:37323"} 17:08:30 [17:08:30.782] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:37323"} 17:08:30 [17:08:30.783] WARN: node:blob-sink:client No L1 consensus host urls configured 17:08:30 [17:08:30.783] WARN: node:blob-sink:client No archive client configured 17:08:30 [17:08:30.787] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xcdc7a95f560960f312f3cfc848bd88e5804fc3724f731f50eeb9c9b23c4a3172 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xd9f4450adcb565f3d0c3d93149f70e5033da4b77c3a9de65618c25e23b72fff9","l1BlockNumber":16}} 17:08:30 [17:08:30.807] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xcdc7a95f560960f312f3cfc848bd88e5804fc3724f731f50eeb9c9b23c4a3172","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:08:30 [17:08:30.816] INFO: world-state:database Creating world state data store at directory /tmp/239bbc18dbf3d690/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:08:30 [17:08:30.847] INFO: world_state Created world state synchroniser with block history of 64 17:08:30 [17:08:30.848] WARN: node Aztec node is accepting fake proofs 17:08:30 [17:08:30.858] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.870] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/239bbc18dbf3d690/p2p with map size 134217728 KB (LMDB v2) 17:08:30 [17:08:30.872] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:08:30 [17:08:30.893] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/239bbc18dbf3d690/p2p-archive with map size 134217728 KB (LMDB v2) 17:08:30 [17:08:30.902] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:08:30 [17:08:30.903] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/239bbc18dbf3d690/p2p-peers with map size 134217728 KB (LMDB v2) 17:08:30 [17:08:30.905] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:08:30 [17:08:30.907] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:08:30 [17:08:30.908] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:08:30 [17:08:30.913] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:08:30 [17:08:30.915] INFO: world_state Started world state synchronizer from block 1 17:08:30 [17:08:30.919] VERBOSE: world-state:block_stream Starting sync from block number 0 17:08:30 [17:08:30.923] INFO: p2p Starting p2p client from block 0 with empty mempools 17:08:30 [17:08:30.923] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:08:30 [17:08:30.927] INFO: slasher Slasher client initialized 17:08:30 [17:08:30.928] INFO: slasher Starting Slasher client... 17:08:30 [17:08:30.975] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:30 [17:08:30.976] VERBOSE: node All Aztec Node subsystems synced 17:08:31 [17:08:30.999] INFO: sequencer-client Deploying forwarder contract 17:08:31 [17:08:31.012] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:08:31 [17:08:31.033] VERBOSE: sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968 {"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"} 17:08:31 [17:08:31.033] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968. 17:08:31 [17:08:31.042] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:31 [17:08:31.064] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:31 [17:08:31.064] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:08:31 [17:08:31.065] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/34adb98d/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:08:31 [17:08:31.356] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:08:31 [17:08:31.361] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:31 [17:08:31.363] INFO: node Aztec Node version: 0.87.8 17:08:31 [17:08:31.363] 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"} 17:08:31 [17:08:31.365] VERBOSE: e2e:e2e_mempool_limit Creating a pxe... 17:08:31 [17:08:31.371] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.386] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/ea64010477a38675/pxe_data with map size 134217728 KB (LMDB v2) 17:08:31 [17:08:31.403] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0bd359ace40085aceb08164c6cdd0a2242f4d19a850da11dbe6a3b53fbd352fa","blockNumber":1,"slot":2} 17:08:31 [17:08:31.406] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:08:31 [17:08:31.657] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.783] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:08:31 [17:08:31.784] INFO: pxe:service Started PXE connected to chain 31337 version 42270293 17:08:31 [17:08:31.864] INFO: pxe:service Registered account 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 17:08:31 [17:08:31.951] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.955] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:08:31 [17:08:31.963] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 17:08:32 [17:08:32.112] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0bd359ace40085aceb08164c6cdd0a2242f4d19a850da11dbe6a3b53fbd352fa","blockNumber":1,"slot":2} 17:08:32 [17:08:32.183] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.192] INFO: pxe:service Added contract SchnorrAccount at 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:32 [17:08:32.248] VERBOSE: pxe:block_stream Starting sync from block number 0 17:08:32 [17:08:32.278] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:32 [17:08:32.383] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:33 [17:08:33.273] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:08:33 [17:08:33.416] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:33 [17:08:33.517] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.560] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0bd359ace40085aceb08164c6cdd0a2242f4d19a850da11dbe6a3b53fbd352fa","blockNumber":1,"slot":2} 17:08:33 [17:08:33.689] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:33 [17:08:33.788] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.798] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:33 [17:08:33.799] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:33 [17:08:33.910] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:33 [17:08:33.918] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:34 [17:08:34.009] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.101] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0bd359ace40085aceb08164c6cdd0a2242f4d19a850da11dbe6a3b53fbd352fa","blockNumber":1,"slot":2} 17:08:34 [17:08:34.187] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:34 [17:08:34.230] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:34 [17:08:34.230] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:34 [17:08:34.232] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.282] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:34 [17:08:34.287] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:34 [17:08:34.311] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 as fee payer 17:08:34 [17:08:34.502] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.766] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.819] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0bd359ace40085aceb08164c6cdd0a2242f4d19a850da11dbe6a3b53fbd352fa","blockNumber":1,"slot":2} 17:08:35 [17:08:35.005] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.239] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.682] INFO: pxe:service Proving completed in 3440.8612489999996ms {"timings":{"total":3440.8612489999996,"sync":8.119622999998683,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":185.0077620000029,"oracles":{"callPrivateFunction":{"times":[1173.5392109999993,562.2785750000003,248.84163799999988]}}},{"functionName":"private_kernel_init","time":105.37210400000004},{"functionName":"ContractClassRegisterer:register","time":1153.2773759999982,"oracles":{"loadCapsule":{"times":[19.325120999999854]},"notifyCreatedNullifier":{"times":[2.089789000001474]},"debugLog":{"times":[1.239010999999664]},"notifyCreatedContractClassLog":{"times":[16.481379000000743]}}},{"functionName":"private_kernel_inner","time":176.34354699999858},{"functionName":"SchnorrAccount:constructor","time":524.3862359999985,"oracles":{"getContractInstance":{"times":[10.27786500000002]},"debugLog":{"times":[0.7990150000005087,0.5808039999992616]},"fetchTaggedLogs":{"times":[116.5687109999999]},"loadCapsule":{"times":[0.9493839999995544,0.2984470000010333,0.2659249999996973]},"notifyCreatedNullifier":{"times":[0.40408299999944575,0.35525000000052387]},"notifyCreatedNote":{"times":[1.0817610000012792]},"getRandomField":{"times":[1.5995609999990847,0.24539400000139722,0.06706300000041665,0.04850299999998242,0.04619300000013027,0.04790299999876879,0.04140199999892502,0.0449029999999766,0.04941300000064075,0.08808499999940977,0.06857400000080816]},"getIndexedTaggingSecretAsSender":{"times":[68.7609680000005]},"incrementAppTaggingSecretIndexAsSender":{"times":[38.9717299999993]}}},{"functionName":"private_kernel_inner","time":118.44982899999923},{"functionName":"SchnorrAccount:entrypoint","time":215.4001019999996,"oracles":{"debugLog":{"times":[0.5562019999997574,0.7279620000008435,0.9550649999982852]},"fetchTaggedLogs":{"times":[55.11059900000146]},"loadCapsule":{"times":[0.3265190000001894,0.2915160000011383,0.4057840000004944]},"getNotes":{"times":[5.009874999999738]},"getAuthWitness":{"times":[0.32756899999913003]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.177917000000889]}}},{"functionName":"private_kernel_inner","time":106.02118999999948},{"functionName":"private_kernel_reset","time":162.84144699999888},{"functionName":"private_kernel_tail","time":95.08876699999928}],"unaccounted":590.5532660000063}} 17:08:35 [17:08:35.701] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.777] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0bd359ace40085aceb08164c6cdd0a2242f4d19a850da11dbe6a3b53fbd352fa","blockNumber":1,"slot":2} 17:08:35 [17:08:35.859] VERBOSE: p2p:tx_pool Adding tx 0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656 to pool {"eventName":"tx-added-to-pool","txHash":"0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:35 [17:08:35.881] INFO: node Received tx 0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656 {"txHash":"0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656"} 17:08:35 [17:08:35.882] INFO: pxe:service Sent transaction 0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656 17:08:35 [17:08:35.909] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.114] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.298] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:08:36 [17:08:36.313] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:12:53.000Z","now":"2025-06-13T17:12:34.931Z"} 17:08:36 [17:08:36.340] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.648] VERBOSE: simulator:public-processor Processed tx 0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656 with no public calls in 212.21076100000028ms {"txHash":"0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656","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":212.21076100000028} 17:08:36 [17:08:36.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.653] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3387612599999993s {"duration":0.3387612599999993,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:08:36 [17:08:36.836] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2e0e64e70b17cb3ec75c87bc956908baa68074cdbbbf90bbfa008f8b12475f72","globalVariables":{"chainId":31337,"version":42270293,"blockNumber":1,"slotNumber":2,"timestamp":1749834773,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0f7ebeefd87e692ea8bf3a921b573fb19fa7efc550d435b5026829ad3f489656"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":538.5838949999998,"publicProcessDuration":339.89549500000066,"rollupCircuitsDuration":524.8919850000002,"txCount":1,"blockNumber":1,"blockTimestamp":1749834773,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:36 [17:08:36.839] VERBOSE: sequencer Attesting committee is empty 17:08:36 [17:08:36.946] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.262] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.271] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x5042197c5f5dfe4771ea65f26d27cddceea6f9e4b05b2be6da0da2c11e2272a2 17:08:37 [17:08:37.271] VERBOSE: sequencer-client Sent L1 transaction 0x5042197c5f5dfe4771ea65f26d27cddceea6f9e4b05b2be6da0da2c11e2272a2 {"gasLimit":514585,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:08:37 [17:08:37.286] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:37 [17:08:37.287] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x5042197c5f5dfe4771ea65f26d27cddceea6f9e4b05b2be6da0da2c11e2272a2","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1749834773,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:37 [17:08:37.288] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:37 [17:08:37.308] INFO: blob-sink:server Received blob sidecar for block 0x44e36d42c0b22857d6fbd6885274162f5e3ea7d78e205bc527f4bbe8420ffc38 17:08:37 [17:08:37.322] INFO: blob-sink:server Blob sidecar stored successfully for block 0x44e36d42c0b22857d6fbd6885274162f5e3ea7d78e205bc527f4bbe8420ffc38 17:08:37 [17:08:37.466] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.480] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:08:37 [17:08:37.484] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:08:37 [17:08:37.488] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:08:37 [17:08:37.495] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834809] on http://127.0.0.1:8545 17:08:37 [17:08:37.498] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:37 [17:08:37.500] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834809 17:08:37 [17:08:37.501] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:29.000Z {"offset":291499,"timeMs":1749834809000} 17:08:37 [17:08:37.501] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:08:37 [17:08:37.640] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:37 [17:08:37.649] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2e0e64e70b17cb3ec75c87bc956908baa68074cdbbbf90bbfa008f8b12475f72","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":42270293,"blockNumber":1,"slotNumber":2,"timestamp":1749834773,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0b12a97a459153fc7d604148d2af53765c4aa2f24e0abcd2ccebeac0290dc6d2","archiveNextLeafIndex":2} 17:08:37 [17:08:37.661] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:08:37 [17:08:37.672] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.150] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.157] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 17:08:38 [17:08:38.160] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x12fa2a124b9e0009446a93138013194ecc17c0a66663316032771edc1620f2d6 17:08:38 [17:08:38.399] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.402] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":248.3411789999991,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834773,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:38 [17:08:38.490] VERBOSE: p2p Synched to latest block 1 17:08:38 [17:08:38.810] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.834] INFO: pxe:service Added contract Token at 0x12fa2a124b9e0009446a93138013194ecc17c0a66663316032771edc1620f2d6 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:08:38 [17:08:38.862] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x0b12a97a459153fc7d604148d2af53765c4aa2f24e0abcd2ccebeac0290dc6d2","header":{"contentCommitment":{"blobsHash":"0x0061a9cb78acf6036f2a1450cdfadc1ca48b5c8a6930d5254ca289e4d9d441c2","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834773,"version":42270293},"lastArchive":"0x0bd359ace40085aceb08164c6cdd0a2242f4d19a850da11dbe6a3b53fbd352fa","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x17961b36c97e2831e7499797ec1f15c9066162a2d1a9bad507615b65a1ee1c74","nullifierTree":"0x2c906f75fab3149d05f56bb159af6f4a9bddc945cbd06021bda7c18169b00d9e","publicDataTree":"0x1f90a6f06e545f9843f5cff5195150e9777192fbc8824a54b93302f6a3a537d9"},"totalFees":6794052480,"totalManaUsed":20448}} 17:08:38 [17:08:38.976] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:39 [17:08:39.035] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:39 [17:08:39.036] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:39 [17:08:39.045] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.096] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0b12a97a459153fc7d604148d2af53765c4aa2f24e0abcd2ccebeac0290dc6d2","blockNumber":2,"slot":3} 17:08:39 [17:08:39.151] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:39 [17:08:39.157] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x02d1a494ec3395fc8c12056b6bb10b5ae68f564cc988e55dbcc462fefdb05895 17:08:39 [17:08:39.180] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:39 [17:08:39.181] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:39 [17:08:39.193] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:39 [17:08:39.194] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:39 [17:08:39.260] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x040c5e5e6ca8d7e7bf55316d5fab80970f145b172f1dc38d490f125b51a1b47e","nullifier":"0x06146c8616592b5dd33056697f6735b77d6700a8d76119a957bdfc3448eba35f"} 17:08:39 [17:08:39.262] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.272] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:39 [17:08:39.357] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 as fee payer 17:08:39 [17:08:39.470] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:40 [17:08:40.051] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 17:08:40 [17:08:40.187] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:40 [17:08:40.250] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.359] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:40 [17:08:40.378] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0b12a97a459153fc7d604148d2af53765c4aa2f24e0abcd2ccebeac0290dc6d2","blockNumber":2,"slot":3} 17:08:40 [17:08:40.417] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:40 [17:08:40.429] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x12fa2a124b9e0009446a93138013194ecc17c0a66663316032771edc1620f2d6,0x0000000000000000000000000000000000000000000000000000000000000001,0x02164752d018f84380fa92c60241dc9a849c2b5ebc18d677c698eaf3795a9b95,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x25ead8c3ee3593951535d6180364670d2efc03a87474552a9476e0c3e7fbf9b3,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 17:08:40 [17:08:40.476] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.731] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.968] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.989] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0b12a97a459153fc7d604148d2af53765c4aa2f24e0abcd2ccebeac0290dc6d2","blockNumber":2,"slot":3} 17:08:41 [17:08:41.199] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.610] INFO: pxe:service Proving completed in 2758.789768999999ms {"timings":{"total":2758.789768999999,"sync":13.396592999997665,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":527.0363559999932,"oracles":{"debugLog":{"times":[1.016168000001926,0.5398499999973865,1.115313000002061,1.0036770000006072,1.1140639999975974,0.5804129999996803,0.5737630000003264,0.8775600000008126]},"fetchTaggedLogs":{"times":[118.41392600000108]},"loadCapsule":{"times":[0.46329599999808124,0.7575629999992088,0.5419010000005073,5.451700999998138,0.3076379999984056,0.2990170000011858]},"getSharedSecret":{"times":[14.018538999996963]},"aes128Decrypt":{"times":[1.2286300000014307,1.033728999998857]},"getPublicKeysAndPartialAddress":{"times":[3.2156920000015816]},"getKeyValidationRequest":{"times":[4.526347999999416]},"deliverNote":{"times":[65.45853999999963]},"deleteCapsule":{"times":[3.745943999998417]},"storeCapsule":{"times":[1.2664720000029774]},"getNotes":{"times":[4.168577000000369]},"getAuthWitness":{"times":[0.38286100000186707]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.15093899999919813]},"callPrivateFunction":{"times":[889.0936249999977,184.60413799999878]},"notifyEnqueuedPublicFunctionCall":{"times":[0.32656800000040676]}}},{"functionName":"private_kernel_init","time":91.65083199999935},{"functionName":"ContractClassRegisterer:register","time":864.218159,"oracles":{"loadCapsule":{"times":[6.334050999997999]},"notifyCreatedNullifier":{"times":[0.6062539999984438]},"debugLog":{"times":[0.7970559999994293]},"notifyCreatedContractClassLog":{"times":[11.095461999997497]}}},{"functionName":"private_kernel_inner","time":145.4140449999977},{"functionName":"ContractInstanceDeployer:deploy","time":112.48043700000198,"oracles":{"storeInExecutionCache":{"times":[0.4360839999972086]},"callPrivateFunction":{"times":[55.33866299999863]},"notifyCreatedNullifier":{"times":[0.2882659999995667]},"debugLog":{"times":[0.6174460000002]}}},{"functionName":"private_kernel_inner","time":148.73648400000093},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.03284600000188,"oracles":{}},{"functionName":"private_kernel_inner","time":126.63302399999884},{"functionName":"private_kernel_reset","time":176.78590199999962},{"functionName":"private_kernel_tail","time":90.55189900000187}],"unaccounted":419.85319200000595}} 17:08:41 [17:08:41.636] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.887] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.892] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0b12a97a459153fc7d604148d2af53765c4aa2f24e0abcd2ccebeac0290dc6d2","blockNumber":2,"slot":3} 17:08:41 [17:08:41.912] VERBOSE: p2p:tx_pool Adding tx 0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807 to pool {"eventName":"tx-added-to-pool","txHash":"0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 17:08:41 [17:08:41.954] INFO: node Received tx 0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807 {"txHash":"0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807"} 17:08:41 [17:08:41.954] INFO: pxe:service Sent transaction 0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807 17:08:42 [17:08:42.091] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.295] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.450] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:08:42 [17:08:42.467] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:13:29.000Z","now":"2025-06-13T17:13:33.966Z"} 17:08:42 [17:08:42.654] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.862] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.066] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.268] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.283] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":423.51836900000126} 17:08:43 [17:08:43.488] VERBOSE: simulator:public-processor Processed tx 0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807 with 1 public calls in 818.3123430000014ms {"txHash":"0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807","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":818.3123430000014} 17:08:43 [17:08:43.492] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.494] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.0266550830000014s {"duration":1.0266550830000014,"rate":371917.5079562719,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 17:08:43 [17:08:43.700] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.721] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 300401.8540675517 mana/s {"blockHash":"0x13ca2f4f5a29b8266611fb7862d6bccc0cd12ff03c419bf18104138f56415747","globalVariables":{"chainId":31337,"version":42270293,"blockNumber":2,"slotNumber":3,"timestamp":1749834809,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2f1b0f6d8a382918f32331d878946bf2a7aee53b8a0421c8670452473b73d807"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1270.173666999999,"publicProcessDuration":1027.2176639999998,"rollupCircuitsDuration":1254.3500349999995,"txCount":1,"blockNumber":2,"blockTimestamp":1749834809,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:08:43 [17:08:43.737] VERBOSE: sequencer Attesting committee is empty 17:08:43 [17:08:43.913] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.091] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x73adc816f0e0efb850276e4190e4f124788c6104cceba14aaa53b2bac3f57f2d 17:08:44 [17:08:44.091] VERBOSE: sequencer-client Sent L1 transaction 0x73adc816f0e0efb850276e4190e4f124788c6104cceba14aaa53b2bac3f57f2d {"gasLimit":470248,"maxFeePerGas":"1.303611198","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:44 [17:08:44.106] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834845] on http://127.0.0.1:8545 17:08:44 [17:08:44.110] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:44 [17:08:44.110] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x73adc816f0e0efb850276e4190e4f124788c6104cceba14aaa53b2bac3f57f2d","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1749834809,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:08:44 [17:08:44.110] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:44 [17:08:44.114] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:44 [17:08:44.117] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834845 17:08:44 [17:08:44.117] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:05.000Z {"offset":320883,"timeMs":1749834845000} 17:08:44 [17:08:44.117] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:08:44 [17:08:44.119] INFO: blob-sink:server Received blob sidecar for block 0xb9f8f9ca5254b7f9bb620dfc337015e0222e7ed895f9090e6d349a2d33f005ca 17:08:44 [17:08:44.127] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.134] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb9f8f9ca5254b7f9bb620dfc337015e0222e7ed895f9090e6d349a2d33f005ca 17:08:44 [17:08:44.135] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:08:44 [17:08:44.137] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:08:44 [17:08:44.139] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:08:44 [17:08:44.335] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.611] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.657] VERBOSE: archiver:block-helper Store contract instance at 0x12fa2a124b9e0009446a93138013194ecc17c0a66663316032771edc1620f2d6 17:08:44 [17:08:44.688] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:08:44 [17:08:44.752] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x13ca2f4f5a29b8266611fb7862d6bccc0cd12ff03c419bf18104138f56415747","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":42270293,"blockNumber":2,"slotNumber":3,"timestamp":1749834809,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x056d3f9c52eacb3bbb58b53a7a133bf025e31c4a956f64a762a9377e1c03f70a","archiveNextLeafIndex":3} 17:08:44 [17:08:44.776] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:08:44 [17:08:44.827] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.882] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.832900000001246,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834809,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:08:44 [17:08:44.903] VERBOSE: p2p Synched to latest block 2 17:08:45 [17:08:45.029] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.353] INFO: aztecjs:deploy_sent_tx Contract 0x12fa2a124b9e0009446a93138013194ecc17c0a66663316032771edc1620f2d6 successfully deployed. 17:08:45 [17:08:45.360] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.461] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x056d3f9c52eacb3bbb58b53a7a133bf025e31c4a956f64a762a9377e1c03f70a","blockNumber":3,"slot":4} 17:08:45 [17:08:45.489] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x056d3f9c52eacb3bbb58b53a7a133bf025e31c4a956f64a762a9377e1c03f70a","header":{"contentCommitment":{"blobsHash":"0x00f9be5eb38d243fbbba533ed3c6ac7b2320b87e151d0d87973083b2bdc9a614","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834809,"version":42270293},"lastArchive":"0x0b12a97a459153fc7d604148d2af53765c4aa2f24e0abcd2ccebeac0290dc6d2","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x17961b36c97e2831e7499797ec1f15c9066162a2d1a9bad507615b65a1ee1c74","nullifierTree":"0x0b107501459fa24318f68194bee29ce8ecda330c64769ee58fae1cedbd256590","publicDataTree":"0x1b3b688afdcb6951892b616a9955680e733dd52c43f2ef700d7e6fa7e29bdd39"},"totalFees":139009277500,"totalManaUsed":418375}} 17:08:45 [17:08:45.582] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.613] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:45 [17:08:45.668] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:45 [17:08:45.668] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:45 [17:08:45.814] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:45 [17:08:45.825] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x02d1a494ec3395fc8c12056b6bb10b5ae68f564cc988e55dbcc462fefdb05895 17:08:45 [17:08:45.842] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:45 [17:08:45.843] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:45 [17:08:45.854] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:45 [17:08:45.855] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:45 [17:08:45.860] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x040c5e5e6ca8d7e7bf55316d5fab80970f145b172f1dc38d490f125b51a1b47e","nullifier":"0x06146c8616592b5dd33056697f6735b77d6700a8d76119a957bdfc3448eba35f"} 17:08:45 [17:08:45.863] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:45 [17:08:45.870] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.891] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 as fee payer 17:08:46 [17:08:46.174] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:46 [17:08:46.538] INFO: pxe:service Proving completed in 1112.7302359999994ms {"timings":{"total":1112.7302359999994,"sync":65.90668599999844,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":384.2178799999965,"oracles":{"debugLog":{"times":[0.7411019999999553,0.8657289999973727,0.6343860000015411,0.62428600000203,0.9136230000003707,0.42899499999839463,0.7457620000022871,1.195717999999033]},"fetchTaggedLogs":{"times":[153.588370999998]},"loadCapsule":{"times":[0.4221350000007078,0.40959400000065216,0.6982090000019525,0.34922999999980675,0.4908880000002682,0.3576600000014878]},"getSharedSecret":{"times":[5.769679000000906]},"aes128Decrypt":{"times":[0.5443420000010519,1.5659799999993993]},"getPublicKeysAndPartialAddress":{"times":[4.161846999999398]},"getKeyValidationRequest":{"times":[2.6672420000031707]},"deliverNote":{"times":[5.059538000001339]},"deleteCapsule":{"times":[0.5215290000014647]},"storeCapsule":{"times":[0.3379289999975299]},"getNotes":{"times":[7.6463760000006005]},"getAuthWitness":{"times":[0.33451900000000023]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.18061999999918044]},"notifyEnqueuedPublicFunctionCall":{"times":[0.22164300000076764]}}},{"functionName":"private_kernel_init","time":99.04055299999891},{"functionName":"private_kernel_reset","time":241.2094930000021},{"functionName":"private_kernel_tail","time":121.88006400000086}],"unaccounted":200.4755600000026}} 17:08:46 [17:08:46.583] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x056d3f9c52eacb3bbb58b53a7a133bf025e31c4a956f64a762a9377e1c03f70a","blockNumber":3,"slot":4} 17:08:46 [17:08:46.587] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:46 [17:08:46.626] VERBOSE: p2p:tx_pool Adding tx 0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a to pool {"eventName":"tx-added-to-pool","txHash":"0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:46 [17:08:46.641] INFO: node Received tx 0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a {"txHash":"0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a"} 17:08:46 [17:08:46.642] INFO: pxe:service Sent transaction 0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a 17:08:46 [17:08:46.793] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.002] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.112] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:08:47 [17:08:47.127] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:14:05.000Z","now":"2025-06-13T17:14:08.010Z"} 17:08:47 [17:08:47.200] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x451b5fae completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x451b5fae","duration":40.859418000000005} 17:08:47 [17:08:47.205] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.229] VERBOSE: simulator:public-processor Processed tx 0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a with 1 public calls in 81.84318300000086ms {"txHash":"0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a","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.84318300000086} 17:08:47 [17:08:47.233] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10469122399999833s {"duration":0.10469122399999833,"rate":407761.0172940635,"totalPublicGas":{"daGas":1024,"l2Gas":42689},"totalBlockGas":{"daGas":2048,"l2Gas":68545},"totalSizeInBytes":384} 17:08:47 [17:08:47.353] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 174438.54205795706 mana/s {"blockHash":"0x223d0a112affae88d8b1d04268c4d6604358bd4d92f0cd355b230b624541dfb2","globalVariables":{"chainId":31337,"version":42270293,"blockNumber":3,"slotNumber":4,"timestamp":1749834845,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x233afacfb847371c1fcd9450c822fc4994cab394ee5314d34b408d1b3850ed8a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":244.1487300000008,"publicProcessDuration":105.18873299999905,"rollupCircuitsDuration":226.38996899999984,"txCount":1,"blockNumber":3,"blockTimestamp":1749834845,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:47 [17:08:47.356] VERBOSE: sequencer Attesting committee is empty 17:08:47 [17:08:47.441] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.646] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.656] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8b7a8a209497f3ed530402129c867d1b303d6a099ef16b6d241dd1db0af3e2f5 17:08:47 [17:08:47.657] VERBOSE: sequencer-client Sent L1 transaction 0x8b7a8a209497f3ed530402129c867d1b303d6a099ef16b6d241dd1db0af3e2f5 {"gasLimit":470280,"maxFeePerGas":"1.279583401","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:47 [17:08:47.667] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:08:47 [17:08:47.673] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:08:47 [17:08:47.683] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:08:47 [17:08:47.689] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:47 [17:08:47.689] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8b7a8a209497f3ed530402129c867d1b303d6a099ef16b6d241dd1db0af3e2f5","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1749834845,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:47 [17:08:47.690] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:47 [17:08:47.692] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834881] on http://127.0.0.1:8545 17:08:47 [17:08:47.698] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:47 [17:08:47.700] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834881 17:08:47 [17:08:47.701] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:41.000Z {"offset":353299,"timeMs":1749834881000} 17:08:47 [17:08:47.701] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:08:47 [17:08:47.702] INFO: blob-sink:server Received blob sidecar for block 0x3d9050bdf0b6bf22aabaf667aefeaa2892663e87bda46c7f841ac888d894b84a 17:08:47 [17:08:47.707] INFO: blob-sink:server Blob sidecar stored successfully for block 0x3d9050bdf0b6bf22aabaf667aefeaa2892663e87bda46c7f841ac888d894b84a 17:08:47 [17:08:47.856] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.062] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.409] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.455] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x223d0a112affae88d8b1d04268c4d6604358bd4d92f0cd355b230b624541dfb2","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":42270293,"blockNumber":3,"slotNumber":4,"timestamp":1749834845,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x009adf4f82ae3ca9e101047639aadd048580546f8c62f03d69e333ed55c2ee98","archiveNextLeafIndex":4} 17:08:48 [17:08:48.459] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:08:48 [17:08:48.553] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.141100999997434,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834845,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:48 [17:08:48.573] VERBOSE: p2p Synched to latest block 3 17:08:48 [17:08:48.629] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:48 [17:08:48.671] INFO: e2e:e2e_mempool_limit Running test: e2e_mempool_limit should evict txs if there are too many 17:08:48 [17:08:48.706] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x009adf4f82ae3ca9e101047639aadd048580546f8c62f03d69e333ed55c2ee98","header":{"contentCommitment":{"blobsHash":"0x00f01f608c796fe74d22e567463226b9a27a37fbd3d21e76a1c4c7247d293539","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834845,"version":42270293},"lastArchive":"0x056d3f9c52eacb3bbb58b53a7a133bf025e31c4a956f64a762a9377e1c03f70a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x17961b36c97e2831e7499797ec1f15c9066162a2d1a9bad507615b65a1ee1c74","nullifierTree":"0x29b9ccc00cc25196979cf4785df510e2bf6bcafc7ca173465ea653a01f195a85","publicDataTree":"0x145f1fcb71414653dbd22432b18d4d9e403013ac3ffd9fc4e26a679541994fc0"},"totalFees":22774761700,"totalManaUsed":68545}} 17:08:48 [17:08:48.832] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:48 [17:08:48.968] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:48 [17:08:48.969] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:48 [17:08:48.984] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:49 [17:08:49.111] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x009adf4f82ae3ca9e101047639aadd048580546f8c62f03d69e333ed55c2ee98","blockNumber":4,"slot":5} 17:08:49 [17:08:49.168] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:49 [17:08:49.175] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x02d1a494ec3395fc8c12056b6bb10b5ae68f564cc988e55dbcc462fefdb05895 17:08:49 [17:08:49.187] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:49 [17:08:49.188] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:49 [17:08:49.192] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:49 [17:08:49.205] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:49 [17:08:49.206] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:49 [17:08:49.211] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x040c5e5e6ca8d7e7bf55316d5fab80970f145b172f1dc38d490f125b51a1b47e","nullifier":"0x06146c8616592b5dd33056697f6735b77d6700a8d76119a957bdfc3448eba35f"} 17:08:49 [17:08:49.224] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:49 [17:08:49.245] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 as fee payer 17:08:49 [17:08:49.463] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:49 [17:08:49.794] INFO: pxe:service Proving completed in 1096.0776220000007ms {"timings":{"total":1096.0776220000007,"sync":10.416595000002417,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":506.297515000002,"oracles":{"debugLog":{"times":[0.8973509999996168,0.5540580000015325,0.5787789999994857,0.5766490000023623,0.7932130000008328,0.4500000000007276,0.6344530000023951,0.8076639999999315]},"fetchTaggedLogs":{"times":[204.02930000000197]},"loadCapsule":{"times":[0.23455599999942933,0.16711100000247825,0.3144910000009986,0.7611409999990428,0.7719319999996515,0.5180949999994482]},"getSharedSecret":{"times":[3.7078309999997145]},"aes128Decrypt":{"times":[0.3705150000023423,1.1925709999995888]},"getPublicKeysAndPartialAddress":{"times":[5.574237999997422]},"getKeyValidationRequest":{"times":[7.13585299999977]},"deliverNote":{"times":[4.713328999998339]},"deleteCapsule":{"times":[1.0228489999972226]},"storeCapsule":{"times":[8.906173000003037]},"getNotes":{"times":[2.166576999999961]},"getAuthWitness":{"times":[0.3206720000016503]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.12765800000124727]},"notifyEnqueuedPublicFunctionCall":{"times":[0.11628800000107731]}}},{"functionName":"private_kernel_init","time":63.287366000000475},{"functionName":"private_kernel_reset","time":222.95230099999753},{"functionName":"private_kernel_tail","time":105.79823600000236}],"unaccounted":187.3256089999959}} 17:08:49 [17:08:49.797] INFO: sequencer Sequencer config set {"minTxsPerBlock":4} 17:08:49 [17:08:49.797] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:08:49 [17:08:49.797] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":432930} 17:08:49 [17:08:49.800] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:49 [17:08:49.846] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x009adf4f82ae3ca9e101047639aadd048580546f8c62f03d69e333ed55c2ee98","blockNumber":4,"slot":5} 17:08:49 [17:08:49.953] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:50 [17:08:50.007] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:50 [17:08:50.007] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:50 [17:08:50.012] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:50 [17:08:50.083] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:50 [17:08:50.090] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x02d1a494ec3395fc8c12056b6bb10b5ae68f564cc988e55dbcc462fefdb05895 17:08:50 [17:08:50.101] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:50 [17:08:50.102] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:50 [17:08:50.113] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:50 [17:08:50.114] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:50 [17:08:50.117] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x040c5e5e6ca8d7e7bf55316d5fab80970f145b172f1dc38d490f125b51a1b47e","nullifier":"0x06146c8616592b5dd33056697f6735b77d6700a8d76119a957bdfc3448eba35f"} 17:08:50 [17:08:50.121] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:50 [17:08:50.133] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 as fee payer 17:08:50 [17:08:50.247] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:50 [17:08:50.714] INFO: pxe:service Proving completed in 878.6638459999995ms {"timings":{"total":878.6638459999995,"sync":12.087838999999803,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":277.77784600000086,"oracles":{"debugLog":{"times":[0.6186019999986456,0.6301529999982449,0.6297919999997248,0.7212189999991097,0.8012540000017907,0.4924830000018119,0.3557139999975334,0.963235999999597]},"fetchTaggedLogs":{"times":[80.00718899999993]},"loadCapsule":{"times":[0.24201700000048731,0.23477600000114762,0.4348489999974845,0.4311699999998382,0.15614999999888823,0.4237590000011551]},"getSharedSecret":{"times":[3.283093000001827]},"aes128Decrypt":{"times":[0.2716389999986859,0.9777169999979378]},"getPublicKeysAndPartialAddress":{"times":[4.773003000002063]},"getKeyValidationRequest":{"times":[1.7324579999985872]},"deliverNote":{"times":[3.109561000001122]},"deleteCapsule":{"times":[1.8266640000001644]},"storeCapsule":{"times":[0.22054500000012922]},"getNotes":{"times":[2.0779509999993024]},"getAuthWitness":{"times":[0.17589200000293204]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1109680000008666]},"notifyEnqueuedPublicFunctionCall":{"times":[0.11696800000208896]}}},{"functionName":"private_kernel_init","time":86.63868799999909},{"functionName":"private_kernel_reset","time":232.45166499999686},{"functionName":"private_kernel_tail","time":129.14428800000314}],"unaccounted":140.5635199999997}} 17:08:50 [17:08:50.725] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:50 [17:08:50.766] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x009adf4f82ae3ca9e101047639aadd048580546f8c62f03d69e333ed55c2ee98","blockNumber":4,"slot":5} 17:08:50 [17:08:50.871] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:50 [17:08:50.929] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:50 [17:08:50.930] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:50 [17:08:50.931] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:50 [17:08:50.983] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08"} 17:08:50 [17:08:50.999] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x02d1a494ec3395fc8c12056b6bb10b5ae68f564cc988e55dbcc462fefdb05895 17:08:51 [17:08:51.014] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:51 [17:08:51.015] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:51 [17:08:51.022] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:51 [17:08:51.023] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:51 [17:08:51.068] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x040c5e5e6ca8d7e7bf55316d5fab80970f145b172f1dc38d490f125b51a1b47e","nullifier":"0x06146c8616592b5dd33056697f6735b77d6700a8d76119a957bdfc3448eba35f"} 17:08:51 [17:08:51.072] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:51 [17:08:51.093] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0fb8e10d41cca62000c450f108399dce7da05c8452eadcbfb2b59e2e30d09a08 as fee payer 17:08:51 [17:08:51.172] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:51 [17:08:51.463] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:51 [17:08:51.745] INFO: pxe:service Proving completed in 989.1283280000025ms {"timings":{"total":989.1283280000025,"sync":11.641188999998121,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":371.40777700000035,"oracles":{"debugLog":{"times":[0.7924440000024333,0.7380700000030629,0.42621999999755644,0.6047309999994468,0.8728900000023714,0.6432639999984531,0.8118650000033085,0.7685920000003534]},"fetchTaggedLogs":{"times":[65.52783799999816]},"loadCapsule":{"times":[0.6582349999989674,0.3333020000027318,1.1233659999998054,0.7586310000006051,0.2837199999994482,0.3455629999989469]},"getSharedSecret":{"times":[5.2186040000015055]},"aes128Decrypt":{"times":[0.5259559999976773,1.3837629999979981]},"getPublicKeysAndPartialAddress":{"times":[2.0408879999995406]},"getKeyValidationRequest":{"times":[2.647799999998824]},"deliverNote":{"times":[44.98364700000093]},"deleteCapsule":{"times":[0.6005110000005516]},"storeCapsule":{"times":[0.5978399999985413]},"getNotes":{"times":[2.7949589999989257]},"getAuthWitness":{"times":[0.33947299999999814]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07768600000053993]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07325399999899673]}}},{"functionName":"private_kernel_init","time":91.66844000000128},{"functionName":"private_kernel_reset","time":198.94698599999901},{"functionName":"private_kernel_tail","time":85.15421799999967}],"unaccounted":230.30971800000407}} 17:08:51 [17:08:51.773] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:51 [17:08:51.775] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 4) {"chainTipArchive":"0x009adf4f82ae3ca9e101047639aadd048580546f8c62f03d69e333ed55c2ee98","blockNumber":4,"slot":5} 17:08:51 [17:08:51.800] VERBOSE: p2p:tx_pool Adding tx 0x155f1359f5d47c1b82021e7535c7d5fd1c0c093be6aa4eeeed9f4a10bde13e13 to pool {"eventName":"tx-added-to-pool","txHash":"0x155f1359f5d47c1b82021e7535c7d5fd1c0c093be6aa4eeeed9f4a10bde13e13","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 17:08:51 [17:08:51.808] INFO: node Received tx 0x155f1359f5d47c1b82021e7535c7d5fd1c0c093be6aa4eeeed9f4a10bde13e13 {"txHash":"0x155f1359f5d47c1b82021e7535c7d5fd1c0c093be6aa4eeeed9f4a10bde13e13"} 17:08:51 [17:08:51.808] INFO: pxe:service Sent transaction 0x155f1359f5d47c1b82021e7535c7d5fd1c0c093be6aa4eeeed9f4a10bde13e13 17:08:51 [17:08:51.852] VERBOSE: p2p:tx_pool Adding tx 0x00701959e396f2a612e0c454fd71d67fee1c4d9098df7e8a3ce8d558379f32b9 to pool {"eventName":"tx-added-to-pool","txHash":"0x00701959e396f2a612e0c454fd71d67fee1c4d9098df7e8a3ce8d558379f32b9","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 17:08:51 [17:08:51.860] INFO: node Received tx 0x00701959e396f2a612e0c454fd71d67fee1c4d9098df7e8a3ce8d558379f32b9 {"txHash":"0x00701959e396f2a612e0c454fd71d67fee1c4d9098df7e8a3ce8d558379f32b9"} 17:08:51 [17:08:51.861] INFO: pxe:service Sent transaction 0x00701959e396f2a612e0c454fd71d67fee1c4d9098df7e8a3ce8d558379f32b9 17:08:51 [17:08:51.912] VERBOSE: p2p:tx_pool Adding tx 0x0fa1bcf37994aa051601dbcc6688df808860918fba96ae0b08b83d13f307743f to pool {"eventName":"tx-added-to-pool","txHash":"0x0fa1bcf37994aa051601dbcc6688df808860918fba96ae0b08b83d13f307743f","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226409,"feePaymentMethod":"fee_juice"} 17:08:51 [17:08:51.922] VERBOSE: p2p:tx_pool Evicting tx 0x00701959e396f2a612e0c454fd71d67fee1c4d9098df7e8a3ce8d558379f32b9 from pool due to low priority to satisfy max tx size limit {"txHash":"0x00701959e396f2a612e0c454fd71d67fee1c4d9098df7e8a3ce8d558379f32b9","txSize":173172} 17:08:51 [17:08:51.930] INFO: node Received tx 0x0fa1bcf37994aa051601dbcc6688df808860918fba96ae0b08b83d13f307743f {"txHash":"0x0fa1bcf37994aa051601dbcc6688df808860918fba96ae0b08b83d13f307743f"} 17:08:51 [17:08:51.931] INFO: pxe:service Sent transaction 0x0fa1bcf37994aa051601dbcc6688df808860918fba96ae0b08b83d13f307743f 17:08:51 PASS src/e2e_mempool_limit.test.ts 17:08:51 e2e_mempool_limit 17:08:51 ✓ should evict txs if there are too many (3267 ms) 17:08:51 17:08:51 Test Suites: 1 passed, 1 total 17:08:51 Tests: 1 passed, 1 total 17:08:51 Snapshots: 0 total 17:08:51 Time: 29.825 s 17:08:51 Ran all test suites matching /src\/e2e_mempool_limit.test.ts/i. 17:08:51 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?