Parent Log: http://ci.aztec-labs.com/648ff1e64e53304b Command: 3958aa6b125d960d:ISOLATE=1:NAME=e2e_2_pxes yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_2_pxes.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/14cf4d3d103c5f816297929a93306c74eec40f14 Env: REF_NAME=gh-readonly-queue/master/pr-15027-f4ac84d7ac4041d505399edd8819840bb14d6c9d CURRENT_VERSION=0.87.8 CI_FULL=0 Date: Fri Jun 13 17:48:37 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15027_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_dbac5eb88a185e46_master 17:48:37 +++ id -u 17:48:37 +++ id -g 17:48:37 ++ docker run -d --name e2e_2_pxes --net=none --cpuset-cpus=0-63 --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_2_pxes.test.ts'\''' 17:48:37 + cid=3ad08f06b88c328c2f1c84603329a7c470cc315961578907b07f305f9ad29cb3 17:48:37 + set +x 17:48:38 {"level":25,"time":1749836918230,"pid":12,"hostname":"3ad08f06b88c","module":"logger","msg":"Logger initialized with level verbose"} 17:48:42 [17:48:42.165] INFO: e2e:e2e_2_pxes Running test: e2e_2_pxes transfers funds from user A to B via PXE A followed by transfer from B to A via PXE B 17:48:42 [17:48:42.299] INFO: e2e:e2e_2_pxes Logging metrics to log/e2e_2_pxes.jsonl 17:48:42 [17:48:42.545] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-7ZGFT3/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:48:42 [17:48:42.574] INFO: e2e:e2e_2_pxes Calling anvil_setBlockTimestampInterval with params: [12] 17:48:42 [17:48:42.595] WARN: e2e:e2e_2_pxes Set block interval to 12 17:48:42 [17:48:42.596] VERBOSE: e2e:e2e_2_pxes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:48:42 [17:48:42.645] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:48:42 [17:48:42.652] VERBOSE: e2e:e2e_2_pxes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:48:42 [17:48:42.668] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:48:42 [17:48:42.673] VERBOSE: e2e:e2e_2_pxes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:48:42 [17:48:42.687] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:48:42 [17:48:42.691] VERBOSE: e2e:e2e_2_pxes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:48:42 [17:48:42.704] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:48:42 [17:48:42.708] VERBOSE: e2e:e2e_2_pxes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:48:42 [17:48:42.725] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:48:42 [17:48:42.729] VERBOSE: e2e:e2e_2_pxes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:48:42 [17:48:42.740] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:48:42 [17:48:42.744] VERBOSE: e2e:e2e_2_pxes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:48:42 [17:48:42.745] VERBOSE: e2e:e2e_2_pxes Waiting for deployments to complete 17:48:42 [17:48:42.745] INFO: e2e:e2e_2_pxes Waiting for 6 transactions to be mined... 17:48:42 [17:48:42.766] INFO: e2e:e2e_2_pxes All transactions mined successfully 17:48:42 [17:48:42.780] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:48:42 [17:48:42.780] VERBOSE: e2e:e2e_2_pxes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:48:42 [17:48:42.791] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:48:42 [17:48:42.802] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:48:42 [17:48:42.806] VERBOSE: e2e:e2e_2_pxes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:48:42 [17:48:42.817] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:48:42 [17:48:42.817] VERBOSE: e2e:e2e_2_pxes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:48:42 [17:48:42.831] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:48:42 [17:48:42.835] VERBOSE: e2e:e2e_2_pxes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:48:42 [17:48:42.845] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:48:42 [17:48:42.846] VERBOSE: e2e:e2e_2_pxes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:48:42 [17:48:42.846] VERBOSE: e2e:e2e_2_pxes Waiting for deployments to complete 17:48:42 [17:48:42.846] INFO: e2e:e2e_2_pxes Waiting for 8 transactions to be mined... 17:48:42 [17:48:42.865] INFO: e2e:e2e_2_pxes All transactions mined successfully 17:48:42 [17:48:42.874] VERBOSE: e2e:e2e_2_pxes Deployed shared contracts 17:48:42 [17:48:42.888] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:48:42 [17:48:42.888] VERBOSE: e2e:e2e_2_pxes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:48:42 [17:48:42.890] VERBOSE: e2e:e2e_2_pxes Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:48:42 [17:48:42.901] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:48:42 [17:48:42.921] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:48:42 [17:48:42.925] VERBOSE: e2e:e2e_2_pxes Awaiting for linked libraries to be deployed 17:48:42 [17:48:42.960] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x688fbc471d3903463439b58389663f0878ad07b109d2d2d258ad232ea2bbf858 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:48:42 [17:48:42.965] VERBOSE: e2e:e2e_2_pxes Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:48:42 [17:48:42.966] INFO: e2e:e2e_2_pxes Waiting for 9 transactions to be mined... 17:48:42 [17:48:42.982] INFO: e2e:e2e_2_pxes All transactions mined successfully 17:48:42 [17:48:42.983] VERBOSE: e2e:e2e_2_pxes All core contracts have been deployed 17:48:42 [17:48:42.995] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0xbfa47d1bfb29e5eb859ce4313ea464f71a4bc867491a7c0c7080df70cdb36272 {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:48:42 [17:48:42.995] VERBOSE: e2e:e2e_2_pxes Funding fee juice portal with 30000000000000000000000 fee juice in 0xbfa47d1bfb29e5eb859ce4313ea464f71a4bc867491a7c0c7080df70cdb36272 (accelerated test deployments) 17:48:43 [17:48:43.006] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 17:48:43 [17:48:43.010] VERBOSE: e2e:e2e_2_pxes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:48:43 [17:48:43.027] VERBOSE: e2e:e2e_2_pxes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 17:48:43 [17:48:43.028] VERBOSE: e2e:e2e_2_pxes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 17:48:43 [17:48:43.028] INFO: e2e:e2e_2_pxes Waiting for 10 transactions to be mined... 17:48:43 [17:48:43.048] INFO: e2e:e2e_2_pxes All transactions mined successfully 17:48:43 [17:48:43.053] VERBOSE: e2e:e2e_2_pxes Rollup deployed 17:48:43 [17:48:43.054] VERBOSE: e2e:e2e_2_pxes Waiting for rollup and slash factory to be deployed 17:48:43 [17:48:43.054] INFO: e2e:e2e_2_pxes Waiting for 10 transactions to be mined... 17:48:43 [17:48:43.070] INFO: e2e:e2e_2_pxes All transactions mined successfully 17:48:43 [17:48:43.070] VERBOSE: e2e:e2e_2_pxes All transactions for L1 deployment have been mined 17:48:43 [17:48:43.086] INFO: e2e:e2e_2_pxes 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:48:43 [17:48:43.088] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:48:43 [17:48:43.090] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:43 [17:48:43.091] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:48:43 [17:48:43.092] INFO: telemetry:client Using NoopTelemetryClient 17:48:43 [17:48:43.097] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:48:43 [17:48:43.097] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:48:43 [17:48:43.098] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/fd9917fbd34dec18/blob-sink with map size 134217728 KB (LMDB v2) 17:48:43 [17:48:43.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:43 [17:48:43.102] INFO: aztecjs:utils:watcher New L1 time: 1749837162 17:48:43 [17:48:43.102] WARN: foundation:test-date-provider Time set to 2025-06-13T17:52:42.000Z {"offset":238898,"timeMs":1749837162000} 17:48:43 [17:48:43.103] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:48:43 [17:48:43.108] INFO: blob-sink:server Server is running on http://localhost:34873 17:48:43 [17:48:43.109] VERBOSE: e2e:e2e_2_pxes Creating and synching an aztec node... 17:48:43 [17:48:43.109] VERBOSE: e2e:e2e_2_pxes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/8c6d18c7/acvm 17:48:43 [17:48:43.110] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34873"} 17:48:43 [17:48:43.125] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:48:43 [17:48:43.125] INFO: archiver:lmdb Creating archiver data store at directory /tmp/fd9917fbd34dec18/archiver with map size 134217728 KB (LMDB v2) 17:48:43 [17:48:43.126] INFO: archiver:lmdb Starting data store with maxReaders 16 17:48:43 [17:48:43.302] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:43 [17:48:43.376] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:34873"} 17:48:43 [17:48:43.390] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:34873"} 17:48:43 [17:48:43.391] WARN: node:blob-sink:client No L1 consensus host urls configured 17:48:43 [17:48:43.391] WARN: node:blob-sink:client No archive client configured 17:48:43 [17:48:43.393] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xd2da4e69756aad8ce431d7d5204497daa43be30d19e551b797d85346ef96789f {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xc840571120bbfccef8571115b38900dbe7a90978d634edde4062a87fb7dd0b6f","l1BlockNumber":16}} 17:48:43 [17:48:43.405] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xd2da4e69756aad8ce431d7d5204497daa43be30d19e551b797d85346ef96789f","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:48:43 [17:48:43.409] INFO: world-state:database Creating world state data store at directory /tmp/fd9917fbd34dec18/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:48:43 [17:48:43.432] INFO: world_state Created world state synchroniser with block history of 64 17:48:43 [17:48:43.432] WARN: node Aztec node is accepting fake proofs 17:48:43 [17:48:43.441] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/fd9917fbd34dec18/p2p with map size 134217728 KB (LMDB v2) 17:48:43 [17:48:43.442] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:48:43 [17:48:43.443] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/fd9917fbd34dec18/p2p-archive with map size 134217728 KB (LMDB v2) 17:48:43 [17:48:43.444] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:48:43 [17:48:43.444] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/fd9917fbd34dec18/p2p-peers with map size 134217728 KB (LMDB v2) 17:48:43 [17:48:43.445] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:48:43 [17:48:43.446] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:48:43 [17:48:43.447] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:48:43 [17:48:43.449] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:48:43 [17:48:43.449] INFO: world_state Started world state synchronizer from block 1 17:48:43 [17:48:43.451] VERBOSE: world-state:block_stream Starting sync from block number 0 17:48:43 [17:48:43.453] INFO: p2p Starting p2p client from block 0 with empty mempools 17:48:43 [17:48:43.453] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:48:43 [17:48:43.454] INFO: slasher Slasher client initialized 17:48:43 [17:48:43.454] INFO: slasher Starting Slasher client... 17:48:43 [17:48:43.482] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:48:43 [17:48:43.483] VERBOSE: node All Aztec Node subsystems synced 17:48:43 [17:48:43.489] INFO: sequencer-client Deploying forwarder contract 17:48:43 [17:48:43.494] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:48:43 [17:48:43.505] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:43 [17:48:43.507] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 17:48:43 [17:48:43.507] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 17:48:43 [17:48:43.512] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:48:43 [17:48:43.524] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:48:43 [17:48:43.524] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:48:43 [17:48:43.524] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/8c6d18c7/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:48:43 [17:48:43.705] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:48:43 [17:48:43.706] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:48:43 [17:48:43.707] INFO: node Aztec Node version: 0.87.8 17:48:43 [17:48:43.707] 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:48:43 [17:48:43.709] VERBOSE: e2e:e2e_2_pxes Creating a pxe... 17:48:43 [17:48:43.712] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:43 [17:48:43.720] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/151df23c01ce4bf4/pxe_data with map size 134217728 KB (LMDB v2) 17:48:43 [17:48:43.729] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2273ee1fffc44ba8fac480c7fb021fb37aeef77b709af1ef80d8379af2876","blockNumber":1,"slot":2} 17:48:43 [17:48:43.730] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:48:43 [17:48:43.923] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:43 [17:48:43.951] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:48:43 [17:48:43.952] INFO: pxe:service Started PXE connected to chain 31337 version 3706351679 17:48:43 [17:48:43.999] INFO: pxe:service Registered account 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab 17:48:44 [17:48:44.052] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:48:44 [17:48:44.052] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab 17:48:44 [17:48:44.162] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:44 [17:48:44.165] INFO: pxe:service Added contract SchnorrAccount at 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:48:44 [17:48:44.202] VERBOSE: pxe:block_stream Starting sync from block number 0 17:48:44 [17:48:44.217] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:48:44 [17:48:44.293] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2273ee1fffc44ba8fac480c7fb021fb37aeef77b709af1ef80d8379af2876","blockNumber":1,"slot":2} 17:48:44 [17:48:44.300] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:48:44 [17:48:44.691] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:48:44 [17:48:44.764] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:48:44 [17:48:44.821] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:44 [17:48:44.847] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2273ee1fffc44ba8fac480c7fb021fb37aeef77b709af1ef80d8379af2876","blockNumber":1,"slot":2} 17:48:44 [17:48:44.912] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:44 [17:48:44.947] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:44 [17:48:44.948] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:44 [17:48:44.981] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:44 [17:48:44.985] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:45 [17:48:45.033] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:45 [17:48:45.140] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:45 [17:48:45.173] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:45 [17:48:45.173] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:45 [17:48:45.202] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:45 [17:48:45.205] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:45 [17:48:45.218] VERBOSE: simulator:client_execution_context:debug_log Setting 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab as fee payer 17:48:45 [17:48:45.239] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:45 [17:48:45.448] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:45 [17:48:45.450] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2273ee1fffc44ba8fac480c7fb021fb37aeef77b709af1ef80d8379af2876","blockNumber":1,"slot":2} 17:48:45 [17:48:45.665] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:46 [17:48:46.275] INFO: pxe:service Proving completed in 2080.1256790000007ms {"timings":{"total":2080.1256790000007,"sync":7.659410999999636,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":117.0734250000005,"oracles":{"callPrivateFunction":{"times":[560.6900779999996,251.70988699999998,158.70350700000017]}}},{"functionName":"private_kernel_init","time":93.28307799999948},{"functionName":"ContractClassRegisterer:register","time":547.5120270000007,"oracles":{"loadCapsule":{"times":[14.864316000000144]},"notifyCreatedNullifier":{"times":[0.49750200000016775]},"debugLog":{"times":[0.6923980000001393]},"notifyCreatedContractClassLog":{"times":[7.9471999999996115]}}},{"functionName":"private_kernel_inner","time":117.38995800000066},{"functionName":"SchnorrAccount:constructor","time":227.26548699999967,"oracles":{"getContractInstance":{"times":[1.2290789999997287]},"debugLog":{"times":[0.46926600000006147,0.46417399999972986]},"fetchTaggedLogs":{"times":[35.97585100000015]},"loadCapsule":{"times":[0.35183799999958865,0.2205760000006194,0.2550569999993968]},"notifyCreatedNullifier":{"times":[0.22163799999998446,0.22400999999990745]},"notifyCreatedNote":{"times":[0.3640420000001541]},"getRandomField":{"times":[0.3464979999998832,0.16162900000017544,0.08720700000048964,0.08370999999988271,0.07708300000012969,0.07876800000030926,0.06465000000025611,0.07074100000045291,0.08057800000005955,0.08696899999995367,0.07012899999972433]},"getIndexedTaggingSecretAsSender":{"times":[31.184470000000147]},"incrementAppTaggingSecretIndexAsSender":{"times":[22.858971999999994]}}},{"functionName":"private_kernel_inner","time":107.52536899999996},{"functionName":"SchnorrAccount:entrypoint","time":136.38128499999948,"oracles":{"debugLog":{"times":[0.49199399999997695,0.38823599999977887,0.5351649999993242]},"fetchTaggedLogs":{"times":[30.601176999999552]},"loadCapsule":{"times":[0.204171999999744,0.19714500000009139,0.23932799999965937]},"getNotes":{"times":[1.3459170000005543]},"getAuthWitness":{"times":[0.3309239999998681]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7508429999998043]}}},{"functionName":"private_kernel_inner","time":106.11126500000137},{"functionName":"private_kernel_reset","time":163.82346599999983},{"functionName":"private_kernel_tail","time":70.15831299999991}],"unaccounted":385.9425949999995}} 17:48:46 [17:48:46.289] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:46 [17:48:46.352] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2273ee1fffc44ba8fac480c7fb021fb37aeef77b709af1ef80d8379af2876","blockNumber":1,"slot":2} 17:48:46 [17:48:46.413] VERBOSE: p2p:tx_pool Adding tx 0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381 to pool {"eventName":"tx-added-to-pool","txHash":"0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:48:46 [17:48:46.431] INFO: node Received tx 0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381 {"txHash":"0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381"} 17:48:46 [17:48:46.431] INFO: pxe:service Sent transaction 0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381 17:48:46 [17:48:46.495] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:46 [17:48:46.698] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:46 [17:48:46.864] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:48:46 [17:48:46.876] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:53:06.000Z","now":"2025-06-13T17:52:45.774Z"} 17:48:46 [17:48:46.938] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:47 [17:48:47.102] VERBOSE: simulator:public-processor Processed tx 0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381 with no public calls in 154.51900900000146ms {"txHash":"0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381","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":154.51900900000146} 17:48:47 [17:48:47.108] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23137332399999833s {"duration":0.23137332399999833,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:48:47 [17:48:47.220] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:47 [17:48:47.234] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2c7aa443f1bdb8caf8bfe9d6130b3bd169ead8aa5b32ed640707c122381aba75","globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":1,"slotNumber":2,"timestamp":1749837186,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x22c1940561f7436dffe6be30e85b7db3f8b20427d31ff8dd463a6ddc4e8b9381"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":369.64140699999916,"publicProcessDuration":232.09001999999964,"rollupCircuitsDuration":358.55205000000024,"txCount":1,"blockNumber":1,"blockTimestamp":1749837186,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:48:47 [17:48:47.236] VERBOSE: sequencer Attesting committee is empty 17:48:47 [17:48:47.426] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:47 [17:48:47.589] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x0d76c641dc12760a97dc9eb106da7dfee0809f04d1e8b41424159068491f6627 17:48:47 [17:48:47.589] VERBOSE: sequencer-client Sent L1 transaction 0x0d76c641dc12760a97dc9eb106da7dfee0809f04d1e8b41424159068491f6627 {"gasLimit":514476,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:48:47 [17:48:47.599] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:48:47 [17:48:47.599] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0d76c641dc12760a97dc9eb106da7dfee0809f04d1e8b41424159068491f6627","calldataSize":1444,"calldataGas":12244,"txCount":1,"blockNumber":1,"blockTimestamp":1749837186,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:48:47 [17:48:47.600] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:48:47 [17:48:47.613] INFO: blob-sink:server Received blob sidecar for block 0x45202d2e80c864aa1b611493d2834bd7ea55c495d8c40f699ebaf85c7e869bb9 17:48:47 [17:48:47.618] INFO: blob-sink:server Blob sidecar stored successfully for block 0x45202d2e80c864aa1b611493d2834bd7ea55c495d8c40f699ebaf85c7e869bb9 17:48:47 [17:48:47.628] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:47 [17:48:47.633] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:48:47 [17:48:47.634] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:48:47 [17:48:47.635] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:48:47 [17:48:47.648] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749837222] on http://127.0.0.1:8545 17:48:47 [17:48:47.649] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:48:47 [17:48:47.650] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749837222 17:48:47 [17:48:47.651] WARN: foundation:test-date-provider Time set to 2025-06-13T17:53:42.000Z {"offset":294349,"timeMs":1749837222000} 17:48:47 [17:48:47.651] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:48:47 [17:48:47.832] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:48 [17:48:48.075] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:48 [17:48:48.092] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:48:48 [17:48:48.101] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2c7aa443f1bdb8caf8bfe9d6130b3bd169ead8aa5b32ed640707c122381aba75","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":1,"slotNumber":2,"timestamp":1749837186,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x151a66b21341365bba7744e117d9e20ee6b9c93c4be96de1968aa75b372806a7","archiveNextLeafIndex":2} 17:48:48 [17:48:48.109] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:48:48 [17:48:48.197] INFO: pxe:data:lmdb:a2a671 Creating pxe_data data store at directory /tmp/1b06e6a2d1c295f5/pxe_data with map size 134217728 KB (LMDB v2) 17:48:48 [17:48:48.205] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":12.305146999999124,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749837186,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:48:48 [17:48:48.214] INFO: pxe:data:lmdb:a2a671 Starting data store with maxReaders 16 17:48:48 [17:48:48.251] VERBOSE: p2p Synched to latest block 1 17:48:48 [17:48:48.280] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:48 [17:48:48.436] VERBOSE: pxe:service:a2a671 Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:48:48 [17:48:48.436] INFO: pxe:service:a2a671 Started PXE connected to chain 31337 version 3706351679 17:48:48 [17:48:48.468] INFO: pxe:service:a2a671 Registered account 0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3 17:48:48 [17:48:48.520] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:48 [17:48:48.522] WARN: pxe:service:a2a671 No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:48:48 [17:48:48.555] INFO: pxe:service:a2a671 Added contract SchnorrAccount at 0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:48:48 [17:48:48.575] VERBOSE: pxe:block_stream Starting sync from block number 0 17:48:48 [17:48:48.580] VERBOSE: pxe:service:a2a671 Updated pxe last block to 1 {"blockHash":{},"archive":"0x151a66b21341365bba7744e117d9e20ee6b9c93c4be96de1968aa75b372806a7","header":{"contentCommitment":{"blobsHash":"0x006b2c80bd36e714e56c7188408e9c3b24b4d19567f4b539ef1404990798b72e","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749837186,"version":3706351679},"lastArchive":"0x0fb2273ee1fffc44ba8fac480c7fb021fb37aeef77b709af1ef80d8379af2876","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x004874927abd032a068fe91f380d8888f7940ae66309e484ff5db472ff17981c","nullifierTree":"0x06ce1d7415b50d9c4018987ea5f54564a07f91c86af7286c274981d04b8d10e6","publicDataTree":"0x00903f053db1a079753d9476cf86ca0d668610cf12054c928120287b29bee752"},"totalFees":6794052480,"totalManaUsed":20448}} 17:48:48 [17:48:48.600] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:48:48 [17:48:48.708] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3"} 17:48:48 [17:48:48.744] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:48 [17:48:48.744] VERBOSE: pxe:service:a2a671 Searching for tagged logs {"contract":"0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3"} 17:48:48 [17:48:48.748] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x151a66b21341365bba7744e117d9e20ee6b9c93c4be96de1968aa75b372806a7","blockNumber":2,"slot":3} 17:48:48 [17:48:48.769] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:48 [17:48:48.781] VERBOSE: pxe:service:a2a671 Searching for nullifiers of known notes {"contract":"0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3"} 17:48:48 [17:48:48.783] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:48 [17:48:48.979] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:49 [17:48:49.027] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3"} 17:48:49 [17:48:49.059] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:49 [17:48:49.060] VERBOSE: pxe:service:a2a671 Searching for tagged logs {"contract":"0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3"} 17:48:49 [17:48:49.092] VERBOSE: pxe:service:a2a671 Searching for nullifiers of known notes {"contract":"0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3"} 17:48:49 [17:48:49.095] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:49 [17:48:49.107] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3 as fee payer 17:48:49 [17:48:49.212] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:49 [17:48:49.447] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:49 [17:48:49.475] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x151a66b21341365bba7744e117d9e20ee6b9c93c4be96de1968aa75b372806a7","blockNumber":2,"slot":3} 17:48:49 [17:48:49.864] INFO: pxe:service:a2a671 Proving completed in 1293.242932000001ms {"timings":{"total":1293.242932000001,"sync":11.01119000000108,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":76.61176499999965,"oracles":{"callPrivateFunction":{"times":[341.6045610000001,164.0154020000009]}}},{"functionName":"private_kernel_init","time":54.34171999999853},{"functionName":"SchnorrAccount:constructor","time":313.6269370000009,"oracles":{"getContractInstance":{"times":[5.759681999999884]},"debugLog":{"times":[0.46198199999889766,0.39543400000002293]},"fetchTaggedLogs":{"times":[38.09137800000099]},"loadCapsule":{"times":[0.19639099999949394,0.31926500000008673,2.011293999999907]},"notifyCreatedNullifier":{"times":[0.21242899999924703,0.24982099999942875]},"notifyCreatedNote":{"times":[0.11244600000100036]},"getRandomField":{"times":[0.12345099999947706,0.14424599999983911,0.10942199999954028,0.1067590000002383,0.07437100000061037,0.07642900000064401,0.0737570000001142,0.07809999999881256,0.0673850000002858,0.071194000000105,0.06238300000040908]},"getIndexedTaggingSecretAsSender":{"times":[65.67528800000036]},"incrementAppTaggingSecretIndexAsSender":{"times":[75.35210400000142]}}},{"functionName":"private_kernel_inner","time":109.5187249999999},{"functionName":"SchnorrAccount:entrypoint","time":140.65684399999918,"oracles":{"debugLog":{"times":[0.48401600000033795,0.387483999998949,0.43770799999947485]},"fetchTaggedLogs":{"times":[34.1940510000004]},"loadCapsule":{"times":[0.19909399999960442,0.18780400000105146,0.20703099999991537]},"getNotes":{"times":[1.0593250000001717]},"getAuthWitness":{"times":[0.22398699999939709]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4417059999996127]}}},{"functionName":"private_kernel_inner","time":105.11895200000072},{"functionName":"private_kernel_reset","time":157.97542900000008},{"functionName":"private_kernel_tail","time":66.76972700000078}],"unaccounted":257.6116430000002}} 17:48:49 [17:48:49.879] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:49 [17:48:49.902] VERBOSE: p2p:tx_pool Adding tx 0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e to pool {"eventName":"tx-added-to-pool","txHash":"0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:48:49 [17:48:49.906] INFO: node Received tx 0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e {"txHash":"0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e"} 17:48:49 [17:48:49.906] INFO: pxe:service:a2a671 Sent transaction 0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e 17:48:49 [17:48:49.996] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:48:50 [17:48:50.010] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:53:42.000Z","now":"2025-06-13T17:53:44.359Z"} 17:48:50 [17:48:50.028] VERBOSE: simulator:public-processor Processed tx 0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e with no public calls in 12.474017000000458ms {"txHash":"0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e","txFee":5018455040,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":15104},"billedGas":{"daGas":11776,"l2Gas":15104},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":12.474017000000458} 17:48:50 [17:48:50.029] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019057881999999155s {"duration":0.019057881999999155,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 17:48:50 [17:48:50.145] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:50 [17:48:50.161] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0e1523814e1fac13ea199264efd77906618eec496fceba8b3650d376896ab48c","globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":2,"slotNumber":3,"timestamp":1749837222,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2b75541daf125d3a4b7353c3f4eebe827220cc4220844de92fccfaf0901af73e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":164.1343109999998,"publicProcessDuration":19.388661999999385,"rollupCircuitsDuration":151.46320299999934,"txCount":1,"blockNumber":2,"blockTimestamp":1749837222,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:48:50 [17:48:50.163] VERBOSE: sequencer Attesting committee is empty 17:48:50 [17:48:50.423] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:50 [17:48:50.432] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x688b110d056c1aa990ea02880a3d138a8225662c734c56c1ae5ec405c4d115d4 17:48:50 [17:48:50.432] VERBOSE: sequencer-client Sent L1 transaction 0x688b110d056c1aa990ea02880a3d138a8225662c734c56c1ae5ec405c4d115d4 {"gasLimit":470283,"maxFeePerGas":"1.303611161","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:48:50 [17:48:50.440] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749837258] on http://127.0.0.1:8545 17:48:50 [17:48:50.443] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:48:50 [17:48:50.445] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:48:50 [17:48:50.446] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x688b110d056c1aa990ea02880a3d138a8225662c734c56c1ae5ec405c4d115d4","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1749837222,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:48:50 [17:48:50.446] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:48:50 [17:48:50.448] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749837258 17:48:50 [17:48:50.448] WARN: foundation:test-date-provider Time set to 2025-06-13T17:54:18.000Z {"offset":327552,"timeMs":1749837258000} 17:48:50 [17:48:50.448] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:48:50 [17:48:50.450] INFO: blob-sink:server Received blob sidecar for block 0x923d5a21f3a1f6398c7f5148a81342f4ef0e5f3482662eede7fd942af96f1263 17:48:50 [17:48:50.454] INFO: blob-sink:server Blob sidecar stored successfully for block 0x923d5a21f3a1f6398c7f5148a81342f4ef0e5f3482662eede7fd942af96f1263 17:48:50 [17:48:50.696] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:50 [17:48:50.712] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:48:50 [17:48:50.715] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:48:50 [17:48:50.718] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0e1523814e1fac13ea199264efd77906618eec496fceba8b3650d376896ab48c","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":2,"slotNumber":3,"timestamp":1749837222,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","archiveNextLeafIndex":3} 17:48:50 [17:48:50.723] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:48:50 [17:48:50.819] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.285923000001276,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749837222,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:48:50 [17:48:50.836] VERBOSE: p2p Synched to latest block 2 17:48:50 [17:48:50.902] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:50 [17:48:50.963] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:51 [17:48:51.105] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:51 [17:48:51.235] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:48:51 [17:48:51.306] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:51 [17:48:51.474] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:51 [17:48:51.508] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:51 [17:48:51.710] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:51 [17:48:51.911] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:51 [17:48:51.985] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:52 [17:48:52.114] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:52 [17:48:52.315] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:52 [17:48:52.496] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:52 [17:48:52.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:52 [17:48:52.718] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:52 [17:48:52.919] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:53 [17:48:53.006] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:53 [17:48:53.122] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:53 [17:48:53.323] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:53 [17:48:53.517] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:53 [17:48:53.525] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:53 [17:48:53.727] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:53 [17:48:53.928] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:54 [17:48:54.028] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:54 [17:48:54.130] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:54 [17:48:54.333] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:54 [17:48:54.534] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:54 [17:48:54.542] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:54 [17:48:54.736] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:54 [17:48:54.937] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:55 [17:48:55.059] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:55 [17:48:55.139] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:55 [17:48:55.343] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:55 [17:48:55.545] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:55 [17:48:55.571] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:55 [17:48:55.748] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:55 [17:48:55.814] INFO: pxe:service Added sender: 17:48:55 0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3 17:48:55 [17:48:55.815] INFO: pxe:service:a2a671 Added sender: 17:48:55 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab 17:48:55 [17:48:55.816] INFO: e2e:e2e_2_pxes Deploying Token contract... 17:48:56 [17:48:56.122] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:56 [17:48:56.123] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 17:48:56 [17:48:56.128] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f 17:48:56 [17:48:56.338] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:56 [17:48:56.347] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:56 [17:48:56.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:56 [17:48:56.582] INFO: pxe:service Added contract Token at 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:48:56 [17:48:56.626] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","header":{"contentCommitment":{"blobsHash":"0x00561b7b718e4267ff5dd9ddc92c234c5fa8a4dae467489d934f8ed0fd8cb711","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749837222,"version":3706351679},"lastArchive":"0x151a66b21341365bba7744e117d9e20ee6b9c93c4be96de1968aa75b372806a7","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x25b979e72418d45b32a23eb45333e4185d31223b9c4b369f5c87e5c6c4b2ae9e","nullifierTree":"0x1143036b70033fb354369620ae57b725116a4bca5a2ce412476a440c2390070c","publicDataTree":"0x10ed6518f2eb3cb905686c7b56c2df26d481fbeed9d26722064c9b6d4cf62ebf"},"totalFees":5018455040,"totalManaUsed":15104}} 17:48:56 [17:48:56.743] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:56 [17:48:56.775] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:56 [17:48:56.776] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:56 [17:48:56.777] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:56 [17:48:56.832] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:48:56 [17:48:56.836] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x30582b76a9e76eb7743d11f7db04d248d17c38a0fc7e71b61c4030f90d8326c9 17:48:56 [17:48:56.846] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:48:56 [17:48:56.847] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:48:56 [17:48:56.863] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:48:56 [17:48:56.864] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:48:56 [17:48:56.874] VERBOSE: pxe:service Added note {"index":0,"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x3025a781e2aa846e532d93cc385a4bc180593fcaccb3b32719e393d72a23718c","nullifier":"0x0d6a47f866faa4f87af7edb73a630f433a2cd8b4688de26517913c27c7fb2722"} 17:48:56 [17:48:56.875] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:56 [17:48:56.877] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:56 [17:48:56.890] VERBOSE: simulator:client_execution_context:debug_log Setting 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab as fee payer 17:48:56 [17:48:56.916] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:48:57 [17:48:57.227] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 17:48:57 [17:48:57.296] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:48:57 [17:48:57.349] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:57 [17:48:57.394] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:48:57 [17:48:57.435] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:48:57 [17:48:57.446] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f,0x0000000000000000000000000000000000000000000000000000000000000001,0x03203eeef825e0de0b2fde929942591904549ff6b0516ee877bb26abdebb1b39,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x1f3d06c4cd8818cba5f14ce923389d7a73a193806edd6e270e6bfa7f838c7bd0,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab 17:48:57 [17:48:57.487] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:57 [17:48:57.593] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:57 [17:48:57.822] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:58 [17:48:58.117] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:58 [17:48:58.364] INFO: pxe:service Proving completed in 1765.946565000002ms {"timings":{"total":1765.946565000002,"sync":30.586240999997244,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":251.97047900001053,"oracles":{"debugLog":{"times":[0.46513899999990826,0.37544100000013714,0.3812550000002375,0.4774600000018836,0.37229800000204705,0.3466630000002624,0.32929699999658624,0.42910199999823817]},"fetchTaggedLogs":{"times":[58.14975399999821]},"loadCapsule":{"times":[0.3468289999982517,0.18306500000107917,0.3767120000011346,0.4655739999980142,0.16162999999869498,0.1899020000018936]},"getSharedSecret":{"times":[3.060712999998941]},"aes128Decrypt":{"times":[0.9206109999977343,0.8908059999994293]},"getPublicKeysAndPartialAddress":{"times":[5.734746999998606]},"getKeyValidationRequest":{"times":[7.988326999999117]},"deliverNote":{"times":[10.471605999999156]},"deleteCapsule":{"times":[0.8322889999981271]},"storeCapsule":{"times":[0.3446380000023055]},"getNotes":{"times":[3.0313720000012836]},"getAuthWitness":{"times":[0.2017009999981383]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0560540000005858]},"callPrivateFunction":{"times":[453.49225699999806,104.77208299999984]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2531249999992724]}}},{"functionName":"private_kernel_init","time":54.44079300000158},{"functionName":"ContractClassRegisterer:register","time":443.965481999996,"oracles":{"loadCapsule":{"times":[3.767846999999165]},"notifyCreatedNullifier":{"times":[0.27664200000072015]},"debugLog":{"times":[0.4243270000006305]},"notifyCreatedContractClassLog":{"times":[6.223915999999008]}}},{"functionName":"private_kernel_inner","time":104.10817699999825},{"functionName":"ContractInstanceDeployer:deploy","time":55.19441799999913,"oracles":{"storeInExecutionCache":{"times":[0.19602800000211573]},"callPrivateFunction":{"times":[43.06514900000184]},"notifyCreatedNullifier":{"times":[0.25211900000067544]},"debugLog":{"times":[0.4696379999986675]}}},{"functionName":"private_kernel_inner","time":104.27292599999782},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":32.9556190000003,"oracles":{}},{"functionName":"private_kernel_inner","time":110.11715399999957},{"functionName":"private_kernel_reset","time":166.12317800000164},{"functionName":"private_kernel_tail","time":80.37685400000191}],"unaccounted":331.83524399999806}} 17:48:58 [17:48:58.397] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:58 [17:48:58.398] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","blockNumber":3,"slot":4} 17:48:58 [17:48:58.588] VERBOSE: p2p:tx_pool Adding tx 0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861 to pool {"eventName":"tx-added-to-pool","txHash":"0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 17:48:58 [17:48:58.606] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:58 [17:48:58.608] INFO: node Received tx 0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861 {"txHash":"0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861"} 17:48:58 [17:48:58.608] INFO: pxe:service Sent transaction 0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861 17:48:58 [17:48:58.809] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:58 [17:48:58.911] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:48:58 [17:48:58.922] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:54:18.000Z","now":"2025-06-13T17:54:26.474Z"} 17:48:59 [17:48:59.053] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:59 [17:48:59.275] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:59 [17:48:59.387] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":184.96135700000013} 17:48:59 [17:48:59.536] VERBOSE: simulator:public-processor Processed tx 0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861 with 1 public calls in 473.10127099999954ms {"txHash":"0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861","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":473.10127099999954} 17:48:59 [17:48:59.538] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:59 [17:48:59.541] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.6182042489999985s {"duration":0.6182042489999985,"rate":617645.3827641048,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 17:48:59 [17:48:59.719] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 472349.5367323112 mana/s {"blockHash":"0x0fdd27892295965f1b01211073f1649d953886f3ab178d2ca6849a069bfa4de5","globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":3,"slotNumber":4,"timestamp":1749837258,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2554b270714eff78d460ee90e95057ee57b452b8ddad5ebb1af9dc103e6c6861"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":807.7567579999995,"publicProcessDuration":618.5638360000012,"rollupCircuitsDuration":797.3961459999991,"txCount":1,"blockNumber":3,"blockTimestamp":1749837258,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:48:59 [17:48:59.722] VERBOSE: sequencer Attesting committee is empty 17:48:59 [17:48:59.833] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:00 [17:49:00.035] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4fc7147eed6e4fa78be5d2c740a015351011e7275d6508bd6edcf810bb3102af 17:49:00 [17:49:00.035] VERBOSE: sequencer-client Sent L1 transaction 0x4fc7147eed6e4fa78be5d2c740a015351011e7275d6508bd6edcf810bb3102af {"gasLimit":470280,"maxFeePerGas":"1.279583374","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:49:00 [17:49:00.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:00 [17:49:00.044] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:49:00 [17:49:00.046] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:49:00 [17:49:00.047] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4fc7147eed6e4fa78be5d2c740a015351011e7275d6508bd6edcf810bb3102af","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1749837258,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:49:00 [17:49:00.047] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:49:00 [17:49:00.049] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:49:00 [17:49:00.052] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:49:00 [17:49:00.056] INFO: blob-sink:server Received blob sidecar for block 0x3390c24c60cda437961de5e4831806520351430414bf8208f01dd0f68bab2921 17:49:00 [17:49:00.062] INFO: blob-sink:server Blob sidecar stored successfully for block 0x3390c24c60cda437961de5e4831806520351430414bf8208f01dd0f68bab2921 17:49:00 [17:49:00.063] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749837294] on http://127.0.0.1:8545 17:49:00 [17:49:00.064] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:49:00 [17:49:00.066] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749837294 17:49:00 [17:49:00.066] WARN: foundation:test-date-provider Time set to 2025-06-13T17:54:54.000Z {"offset":353934,"timeMs":1749837294000} 17:49:00 [17:49:00.066] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:49:00 [17:49:00.240] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:00 [17:49:00.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:00 [17:49:00.534] VERBOSE: archiver:block-helper Store contract instance at 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f 17:49:00 [17:49:00.560] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:49:00 [17:49:00.598] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x0fdd27892295965f1b01211073f1649d953886f3ab178d2ca6849a069bfa4de5","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":3,"slotNumber":4,"timestamp":1749837258,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0be901ced6ca73221b6edd5f68222a3ef9513f68a7c15dd8abe0085a057887b1","archiveNextLeafIndex":4} 17:49:00 [17:49:00.612] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:49:00 [17:49:00.636] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":6.499886999998125,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749837258,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 17:49:00 [17:49:00.721] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:00 [17:49:00.726] VERBOSE: p2p Synched to latest block 3 17:49:00 [17:49:00.877] INFO: aztecjs:deploy_sent_tx Contract 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f successfully deployed. 17:49:01 [17:49:01.040] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:01 [17:49:01.061] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0be901ced6ca73221b6edd5f68222a3ef9513f68a7c15dd8abe0085a057887b1","header":{"contentCommitment":{"blobsHash":"0x0019265ce015e9be56632449b818e099918f00e0659eea9731bf196ad70890ee","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749837258,"version":3706351679},"lastArchive":"0x12c83ecc886cfa6b6eaeb3cb0e7ee43c30244a4d4b5225fa09c3823e14d42c8c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x25b979e72418d45b32a23eb45333e4185d31223b9c4b369f5c87e5c6c4b2ae9e","nullifierTree":"0x25f76459a7e2515797af25944728b6514b09bd4612b174852feee993c09beca8","publicDataTree":"0x2506f14e20ae59395abaaead8ec6fc95801140db55dd9bc3f9f8c531647d0ebd"},"totalFees":139009277500,"totalManaUsed":418375}} 17:49:01 [17:49:01.129] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:49:01 [17:49:01.161] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:49:01 [17:49:01.161] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:49:01 [17:49:01.213] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0be901ced6ca73221b6edd5f68222a3ef9513f68a7c15dd8abe0085a057887b1","blockNumber":4,"slot":5} 17:49:01 [17:49:01.225] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:49:01 [17:49:01.229] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x30582b76a9e76eb7743d11f7db04d248d17c38a0fc7e71b61c4030f90d8326c9 17:49:01 [17:49:01.238] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:49:01 [17:49:01.239] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:49:01 [17:49:01.245] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:01 [17:49:01.252] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:49:01 [17:49:01.252] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:49:01 [17:49:01.256] VERBOSE: pxe:service Added note {"index":0,"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x3025a781e2aa846e532d93cc385a4bc180593fcaccb3b32719e393d72a23718c","nullifier":"0x0d6a47f866faa4f87af7edb73a630f433a2cd8b4688de26517913c27c7fb2722"} 17:49:01 [17:49:01.258] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:49:01 [17:49:01.269] VERBOSE: simulator:client_execution_context:debug_log Setting 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab as fee payer 17:49:01 [17:49:01.510] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:01 [17:49:01.539] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:49:01 [17:49:01.539] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:01 [17:49:01.542] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:01 [17:49:01.648] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:01 [17:49:01.653] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:49:01 [17:49:01.749] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:01 [17:49:01.869] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0be901ced6ca73221b6edd5f68222a3ef9513f68a7c15dd8abe0085a057887b1","blockNumber":4,"slot":5} 17:49:01 [17:49:01.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:02 [17:49:02.284] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:02 [17:49:02.688] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0be901ced6ca73221b6edd5f68222a3ef9513f68a7c15dd8abe0085a057887b1","blockNumber":4,"slot":5} 17:49:02 [17:49:02.931] INFO: pxe:service Proving completed in 1877.641294000001ms {"timings":{"total":1877.641294000001,"sync":8.986549000001105,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":274.96637199999896,"oracles":{"debugLog":{"times":[0.43209700000079465,0.39588500000172644,0.39149600000018836,0.48467900000105146,0.40530900000158,0.34231999999974505,0.30077299999902607,0.44225700000242796]},"fetchTaggedLogs":{"times":[65.94897899999705]},"loadCapsule":{"times":[0.18269099999815808,0.1488740000022517,0.3142860000007204,0.19684799999959068,0.14587899999969522,0.1818700000003446]},"getSharedSecret":{"times":[2.720136999996612]},"aes128Decrypt":{"times":[0.20403300000180025,0.8112130000008619]},"getPublicKeysAndPartialAddress":{"times":[2.8650180000004184]},"getKeyValidationRequest":{"times":[7.814134000000195]},"deliverNote":{"times":[4.481331999999384]},"deleteCapsule":{"times":[0.2136529999988852]},"storeCapsule":{"times":[0.20308099999965634]},"getNotes":{"times":[1.238072000000102]},"getAuthWitness":{"times":[0.19606699999712873]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06250999999974738]},"callPrivateFunction":{"times":[688.2577109999984]}}},{"functionName":"private_kernel_init","time":54.126187000001664},{"functionName":"Token:mint_to_private","time":608.6759979999988,"oracles":{"debugLog":{"times":[0.44293699999980163,0.4165979999997944]},"fetchTaggedLogs":{"times":[112.86353599999711]},"loadCapsule":{"times":[0.2143980000000738,0.20099800000025425,0.22860799999762094]},"getRandomField":{"times":[0.10132599999997183,0.12499300000126823,0.12190099999861559,0.08067599999776576,0.0894960000005085,0.07271299999774783,0.07149700000081793,0.05746699999872362,0.0803169999999227,0.0610099999976228,0.0678330000009737,0.07558799999969779]},"getIndexedTaggingSecretAsSender":{"times":[196.38745800000106]},"incrementAppTaggingSecretIndexAsSender":{"times":[81.2836040000002]},"notifyCreatedNullifier":{"times":[0.211513999998715]},"storeInExecutionCache":{"times":[0.046407000001636334]},"notifyEnqueuedPublicFunctionCall":{"times":[0.050076999999873806]}}},{"functionName":"private_kernel_inner","time":103.72930600000109},{"functionName":"private_kernel_reset","time":172.14100400000098},{"functionName":"private_kernel_tail","time":82.86975800000073}],"unaccounted":572.1461199999976}} 17:49:02 [17:49:02.957] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:02 [17:49:02.979] VERBOSE: p2p:tx_pool Adding tx 0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7 to pool {"eventName":"tx-added-to-pool","txHash":"0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 17:49:02 [17:49:02.986] INFO: node Received tx 0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7 {"txHash":"0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7"} 17:49:02 [17:49:02.986] INFO: pxe:service Sent transaction 0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7 17:49:03 [17:49:03.161] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:03 [17:49:03.205] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 17:49:03 [17:49:03.219] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T17:54:54.000Z","now":"2025-06-13T17:54:57.153Z"} 17:49:03 [17:49:03.260] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":24.900541999999405} 17:49:03 [17:49:03.280] VERBOSE: simulator:public-processor Processed tx 0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7 with 1 public calls in 51.30912900000112ms {"txHash":"0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7","txFee":3736336500,"revertCode":0,"gasUsed":{"totalGas":{"daGas":13312,"l2Gas":73695},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":2048,"l2Gas":42495},"billedGas":{"daGas":13312,"l2Gas":73695}},"publicDataWriteCount":2,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":1,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":51.30912900000112} 17:49:03 [17:49:03.281] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06144514699999854s {"duration":0.06144514699999854,"rate":691592.4539980515,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 17:49:03 [17:49:03.390] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:03 [17:49:03.404] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 213701.72268381112 mana/s {"blockHash":"0x0bf8360efb59a3996427a6f1bd874107075087bb5ab78ea3dd8ee34c721d23d0","globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":4,"slotNumber":5,"timestamp":1749837294,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x16e2a95f6c24ad91b1f1cbd1f29993e2ac737b63b0979a98f9c9eb6f301615a7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":198.29675099999804,"publicProcessDuration":61.77949300000182,"rollupCircuitsDuration":185.55550399999993,"txCount":1,"blockNumber":4,"blockTimestamp":1749837294,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:49:03 [17:49:03.406] VERBOSE: sequencer Attesting committee is empty 17:49:03 [17:49:03.670] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:03 [17:49:03.678] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xe5d3df6f4c1c7f8cb96d85ae02e4bfdb2981367c047ded4594e6b32eb26e9616 17:49:03 [17:49:03.678] VERBOSE: sequencer-client Sent L1 transaction 0xe5d3df6f4c1c7f8cb96d85ae02e4bfdb2981367c047ded4594e6b32eb26e9616 {"gasLimit":470277,"maxFeePerGas":"1.261127723","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:49:03 [17:49:03.685] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749837330] on http://127.0.0.1:8545 17:49:03 [17:49:03.687] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:49:03 [17:49:03.689] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:49:03 [17:49:03.690] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xe5d3df6f4c1c7f8cb96d85ae02e4bfdb2981367c047ded4594e6b32eb26e9616","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1749837294,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:49:03 [17:49:03.690] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:49:03 [17:49:03.692] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749837330 17:49:03 [17:49:03.692] WARN: foundation:test-date-provider Time set to 2025-06-13T17:55:30.000Z {"offset":386308,"timeMs":1749837330000} 17:49:03 [17:49:03.693] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 17:49:03 [17:49:03.695] INFO: blob-sink:server Received blob sidecar for block 0x2bc06d037db4d3a5785cfc9c6ba1eea1d93f6087a259df7249311a265ecb4b85 17:49:03 [17:49:03.698] INFO: blob-sink:server Blob sidecar stored successfully for block 0x2bc06d037db4d3a5785cfc9c6ba1eea1d93f6087a259df7249311a265ecb4b85 17:49:03 [17:49:03.874] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:03 [17:49:03.878] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 17:49:03 [17:49:03.879] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 17:49:03 [17:49:03.880] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 17:49:04 [17:49:04.160] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:04 [17:49:04.174] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0bf8360efb59a3996427a6f1bd874107075087bb5ab78ea3dd8ee34c721d23d0","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3706351679,"blockNumber":4,"slotNumber":5,"timestamp":1749837294,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","archiveNextLeafIndex":5} 17:49:04 [17:49:04.178] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 17:49:04 [17:49:04.278] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":6.182559999997466,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749837294,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 17:49:04 [17:49:04.286] VERBOSE: p2p Synched to latest block 4 17:49:04 [17:49:04.364] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:04 [17:49:04.566] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:04 [17:49:04.707] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","blockNumber":5,"slot":6} 17:49:04 [17:49:04.768] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:04 [17:49:04.970] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:04 [17:49:04.990] INFO: e2e:e2e_2_pxes L2 contract deployed 17:49:05 [17:49:05.188] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:05 [17:49:05.197] INFO: pxe:service:a2a671 Added contract Token at 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 17:49:05 [17:49:05.374] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","header":{"contentCommitment":{"blobsHash":"0x00222dbb176d1c22b20e51f7aa20be599cc626ae5872a9b95a92d76f48d113fd","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749837294,"version":3706351679},"lastArchive":"0x0be901ced6ca73221b6edd5f68222a3ef9513f68a7c15dd8abe0085a057887b1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x248c32a346641b7a64ac5b117db2929e9f5027f9094115f7f016103c039af492","nullifierTree":"0x2484cd055a26ab4195f70e0713062abc6509036e8da9ef46413cbf25e92236d1","publicDataTree":"0x00a3e04fa6c81fe6ae0eb4a1e2eb1cbd60c5a2b0ca4cd901ac040c8144640d9a"},"totalFees":3736336500,"totalManaUsed":73695}} 17:49:05 [17:49:05.375] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","blockNumber":5,"slot":6} 17:49:05 [17:49:05.454] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:05 [17:49:05.714] VERBOSE: simulator Executing utility function balance_of_private {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f","selector":"0x4375727c"} 17:49:05 [17:49:05.722] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:05 [17:49:05.725] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:49:05 [17:49:05.726] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:05 [17:49:05.823] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:05 [17:49:05.826] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0a9ffc6e8974525b55eeb815d21832b6ae465f751a9c2053a71785ce2c216774 17:49:05 [17:49:05.837] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 17:49:05 [17:49:05.839] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 17:49:05 [17:49:05.843] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x25eeb370557d556aac7133b2f52e3bf716215981f2e320f78faef022ecb7140f 17:49:05 [17:49:05.843] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f for storage slot 0x2c701a48f58a3681500e55fbf30b249b744eaa7d8607e08cb6eccd00c0951679 17:49:05 [17:49:05.848] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:49:05 [17:49:05.848] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x25eeb370557d556aac7133b2f52e3bf716215981f2e320f78faef022ecb7140f 17:49:05 [17:49:05.850] VERBOSE: pxe:service Added note {"index":192,"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f","slot":"0x2c701a48f58a3681500e55fbf30b249b744eaa7d8607e08cb6eccd00c0951679","noteHash":"0x13bc4499895ea5522f992d6e0618d13797d131d31685625c41fe550a68c283ec","nullifier":"0x1d3da17be5b2fb7d3e346285b0e3d2a33066afbbd4c8a6d031b78b37d489fcba"} 17:49:05 [17:49:05.854] VERBOSE: simulator Utility simulation for 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f.0x4375727c completed 17:49:05 [17:49:05.854] INFO: e2e:e2e_2_pxes Account 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab balance: 987 17:49:06 [17:49:06.010] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:06 [17:49:06.043] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","blockNumber":5,"slot":6} 17:49:06 [17:49:06.050] VERBOSE: pxe:service:a2a671 Updated pxe last block to 4 {"blockHash":{},"archive":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","header":{"contentCommitment":{"blobsHash":"0x00222dbb176d1c22b20e51f7aa20be599cc626ae5872a9b95a92d76f48d113fd","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749837294,"version":3706351679},"lastArchive":"0x0be901ced6ca73221b6edd5f68222a3ef9513f68a7c15dd8abe0085a057887b1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x248c32a346641b7a64ac5b117db2929e9f5027f9094115f7f016103c039af492","nullifierTree":"0x2484cd055a26ab4195f70e0713062abc6509036e8da9ef46413cbf25e92236d1","publicDataTree":"0x00a3e04fa6c81fe6ae0eb4a1e2eb1cbd60c5a2b0ca4cd901ac040c8144640d9a"},"totalFees":3736336500,"totalManaUsed":73695}} 17:49:06 [17:49:06.282] VERBOSE: simulator Executing utility function balance_of_private {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f","selector":"0x4375727c"} 17:49:06 [17:49:06.288] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:06 [17:49:06.292] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:49:06 [17:49:06.292] VERBOSE: pxe:service:a2a671 Searching for tagged logs {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:06 [17:49:06.384] VERBOSE: pxe:service:a2a671 Searching for nullifiers of known notes {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:06 [17:49:06.386] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:49:06 [17:49:06.388] VERBOSE: simulator Utility simulation for 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f.0x4375727c completed 17:49:06 [17:49:06.388] INFO: e2e:e2e_2_pxes Account 0x1201c9394b2d7ea6df970b64997f0f36b07985307fdd2951405ff926336e8dd3 balance: 0 17:49:06 [17:49:06.539] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:06 [17:49:06.573] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","blockNumber":5,"slot":6} 17:49:06 [17:49:06.645] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:49:06 [17:49:06.677] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:49:06 [17:49:06.678] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:49:06 [17:49:06.715] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab"} 17:49:06 [17:49:06.719] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x30582b76a9e76eb7743d11f7db04d248d17c38a0fc7e71b61c4030f90d8326c9 17:49:06 [17:49:06.728] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:49:06 [17:49:06.729] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:49:06 [17:49:06.733] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:49:06 [17:49:06.734] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:49:06 [17:49:06.736] VERBOSE: pxe:service Added note {"index":0,"contract":"0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x3025a781e2aa846e532d93cc385a4bc180593fcaccb3b32719e393d72a23718c","nullifier":"0x0d6a47f866faa4f87af7edb73a630f433a2cd8b4688de26517913c27c7fb2722"} 17:49:06 [17:49:06.737] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:49:06 [17:49:06.748] VERBOSE: simulator:client_execution_context:debug_log Setting 0x115fedfa3f17950d6694e82f181b6048bc489001bf847a120e7d7700c1298fab as fee payer 17:49:06 [17:49:06.750] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:07 [17:49:07.006] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:49:07 [17:49:07.086] VERBOSE: simulator:private_execution Executing private function Token:transfer {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:07 [17:49:07.149] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:49:07 [17:49:07.150] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:07 [17:49:07.256] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0ddb6b38904c133dae484c929eb5efb1c9cb2f9d7f1cc3f783df95c09f18c139","blockNumber":5,"slot":6} 17:49:07 [17:49:07.263] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f"} 17:49:07 [17:49:07.268] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0a9ffc6e8974525b55eeb815d21832b6ae465f751a9c2053a71785ce2c216774 17:49:07 [17:49:07.278] VERBOSE: simulator:client_execution_context:debug_log Processing partial note private msg 17:49:07 [17:49:07.280] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 17:49:07 [17:49:07.284] VERBOSE: simulator:client_execution_context:debug_log Completion log found for partial note with tag 0x25eeb370557d556aac7133b2f52e3bf716215981f2e320f78faef022ecb7140f 17:49:07 [17:49:07.285] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f for storage slot 0x2c701a48f58a3681500e55fbf30b249b744eaa7d8607e08cb6eccd00c0951679 17:49:07 [17:49:07.289] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:49:07 [17:49:07.290] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x25eeb370557d556aac7133b2f52e3bf716215981f2e320f78faef022ecb7140f 17:49:07 [17:49:07.292] VERBOSE: pxe:service Added note {"index":192,"contract":"0x099a5e89692a40e69e4dbabacd26788535b20f6b0edf085882cad28e3332c74f","slot":"0x2c701a48f58a3681500e55fbf30b249b744eaa7d8607e08cb6eccd00c0951679","noteHash":"0x13bc4499895ea5522f992d6e0618d13797d131d31685625c41fe550a68c283ec","nullifier":"0x1d3da17be5b2fb7d3e346285b0e3d2a33066afbbd4c8a6d031b78b37d489fcba"} 17:49:07 [17:49:07.393] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545