Parent Log: http://ci.aztec-labs.com/3331709b9043bb65 Command: 97e7ef9a556fd7e6:ISOLATE=1:NAME=e2e_nested_contract/manual_public yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_nested_contract/manual_public.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/015cb0cadef6a41094c3649f32a735392e1b9693 Env: REF_NAME=gh-readonly-queue/master/pr-15027-e9a2301883801edbe36ea8bba05dcca7e714f30a CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Wed Jun 18 14:21:50 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15027_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_d4c4a9987398261c_master 14:21:50 +++ id -u 14:21:50 +++ id -g 14:21:50 ++ docker run -d --name e2e_nested_contract_manual_public --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_nested_contract/manual_public.test.ts'\''' 14:21:51 + cid=94c8b09431c41b1fe63f7dd8330ebb13ed3edbdb8b0de4bfa6e0d1aafc89aea4 14:21:51 + set +x 14:21:51 {"level":25,"time":1750256511819,"pid":12,"hostname":"94c8b09431c4","module":"logger","msg":"Logger initialized with level verbose"} 14:21:59 [14:21:59.716] WARN: e2e:snapshot_manager:e2e_nested_contract/manual-1 No data path given, will not persist any snapshots. 14:21:59 [14:21:59.724] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Initializing state... 14:21:59 [14:21:59.728] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Starting anvil... 14:21:59 [14:21:59.894] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deploying L1 contracts... 14:22:00 [14:22:00.841] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-EjLXZM/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 14:22:00 [14:22:00.905] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Calling anvil_setBlockTimestampInterval with params: [12] 14:22:00 [14:22:00.941] WARN: e2e:snapshot_manager:e2e_nested_contract/manual-1 Set block interval to 12 14:22:00 [14:22:00.941] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:22:01 [14:22:01.022] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 14:22:01 [14:22:01.031] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 14:22:01 [14:22:01.046] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 14:22:01 [14:22:01.051] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 14:22:01 [14:22:01.080] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 14:22:01 [14:22:01.086] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 14:22:01 [14:22:01.122] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 14:22:01 [14:22:01.129] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 14:22:01 [14:22:01.151] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 14:22:01 [14:22:01.161] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 14:22:01 [14:22:01.201] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 14:22:01 [14:22:01.208] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 14:22:01 [14:22:01.208] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for deployments to complete 14:22:01 [14:22:01.209] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 6 transactions to be mined... 14:22:01 [14:22:01.249] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 14:22:01 [14:22:01.272] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 14:22:01 [14:22:01.273] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 14:22:01 [14:22:01.288] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 14:22:01 [14:22:01.305] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 14:22:01 [14:22:01.315] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 14:22:01 [14:22:01.331] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 14:22:01 [14:22:01.332] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 14:22:01 [14:22:01.354] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 14:22:01 [14:22:01.364] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 14:22:01 [14:22:01.385] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 14:22:01 [14:22:01.386] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 14:22:01 [14:22:01.386] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for deployments to complete 14:22:01 [14:22:01.386] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 8 transactions to be mined... 14:22:01 [14:22:01.416] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 14:22:01 [14:22:01.430] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed shared contracts 14:22:01 [14:22:01.453] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 14:22:01 [14:22:01.453] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 14:22:01 [14:22:01.459] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 14:22:01 [14:22:01.473] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 14:22:01 [14:22:01.504] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 14:22:01 [14:22:01.528] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Awaiting for linked libraries to be deployed 14:22:01 [14:22:01.578] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x8f4c0b1a045eadf2be5727414360c59ac2f472ec167c0e8fe1705ae462b3947f {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 14:22:01 [14:22:01.589] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 14:22:01 [14:22:01.589] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 9 transactions to be mined... 14:22:01 [14:22:01.611] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 14:22:01 [14:22:01.612] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 All core contracts have been deployed 14:22:01 [14:22:01.634] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xbd01daccbcf5983a6ba91804e7473977cce191320d0d8e2da4627ddd5bb6d2ae {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 14:22:01 [14:22:01.635] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Funding fee juice portal with 110000000000000000000000 fee juice in 0xbd01daccbcf5983a6ba91804e7473977cce191320d0d8e2da4627ddd5bb6d2ae (accelerated test deployments) 14:22:01 [14:22:01.656] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 14:22:01 [14:22:01.662] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 14:22:01 [14:22:01.701] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 14:22:01 [14:22:01.702] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 14:22:01 [14:22:01.702] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 10 transactions to be mined... 14:22:01 [14:22:01.727] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 14:22:01 [14:22:01.733] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Rollup deployed 14:22:01 [14:22:01.733] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for rollup and slash factory to be deployed 14:22:01 [14:22:01.734] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 10 transactions to be mined... 14:22:01 [14:22:01.773] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 14:22:01 [14:22:01.773] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions for L1 deployment have been mined 14:22:01 [14:22:01.795] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 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"} 14:22:01 [14:22:01.799] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 14:22:01 [14:22:01.803] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 14:22:01 [14:22:01.809] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/690bc597/acvm 14:22:01 [14:22:01.812] INFO: telemetry:client Using NoopTelemetryClient 14:22:01 [14:22:01.815] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/c8b303ab5c0dca51/blob-sink with map size 134217728 KB (LMDB v2) 14:22:01 [14:22:01.824] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 14:22:01 [14:22:01.833] INFO: blob-sink:server Server is running on http://localhost:46843 14:22:01 [14:22:01.836] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Creating and synching an aztec node... 14:22:01 [14:22:01.838] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://127.0.0.1:46843"} 14:22:01 [14:22:01.867] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 14:22:01 [14:22:01.869] INFO: archiver:lmdb Creating archiver data store at directory /tmp/c8b303ab5c0dca51/archiver with map size 134217728 KB (LMDB v2) 14:22:01 [14:22:01.874] INFO: archiver:lmdb Starting data store with maxReaders 16 14:22:02 [14:22:02.212] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://127.0.0.1:46843"} 14:22:02 [14:22:02.222] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://127.0.0.1:46843"} 14:22:02 [14:22:02.222] WARN: node:blob-sink:client No L1 consensus host urls configured 14:22:02 [14:22:02.222] WARN: node:blob-sink:client No archive client configured 14:22:02 [14:22:02.227] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 19 with hash 0xcce3f747e999b47843ae9bcd88cd0d302baeb17a875d24baa07114151ccdb395 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x89713d4d6af363327ae4e2f550abbf8fbb03a34275a1e3017d311fa0a63f70f5","l1BlockNumber":16}} 14:22:02 [14:22:02.241] INFO: archiver Initial archiver sync to L1 block 19 complete. {"l1BlockNumber":19,"syncPoint":{"blocksSynchedTo":19},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 14:22:02 [14:22:02.249] INFO: world-state:database Creating world state data store at directory /tmp/c8b303ab5c0dca51/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 14:22:02 [14:22:02.282] INFO: world_state Created world state synchroniser with block history of 64 14:22:02 [14:22:02.282] WARN: node Aztec node is accepting fake proofs 14:22:02 [14:22:02.296] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/c8b303ab5c0dca51/p2p with map size 134217728 KB (LMDB v2) 14:22:02 [14:22:02.299] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 14:22:02 [14:22:02.301] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/c8b303ab5c0dca51/p2p-archive with map size 134217728 KB (LMDB v2) 14:22:02 [14:22:02.303] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 14:22:02 [14:22:02.304] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/c8b303ab5c0dca51/p2p-peers with map size 134217728 KB (LMDB v2) 14:22:02 [14:22:02.306] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 14:22:02 [14:22:02.307] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 14:22:02 [14:22:02.308] VERBOSE: p2p P2P is disabled. Using dummy P2P service 14:22:02 [14:22:02.312] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 14:22:02 [14:22:02.313] INFO: world_state Started world state synchronizer from block 1 14:22:02 [14:22:02.317] VERBOSE: world-state:block_stream Starting sync from block number 0 14:22:02 [14:22:02.320] INFO: p2p Starting p2p client from block 0 with empty mempools 14:22:02 [14:22:02.320] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 14:22:02 [14:22:02.322] INFO: slasher Slasher client initialized 14:22:02 [14:22:02.322] INFO: slasher Starting Slasher client... 14:22:02 [14:22:02.364] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:22:02 [14:22:02.365] VERBOSE: node All Aztec Node subsystems synced 14:22:02 [14:22:02.377] INFO: sequencer-client Deploying forwarder contract 14:22:02 [14:22:02.384] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 14:22:02 [14:22:02.400] VERBOSE: sequencer-client Sent L1 transaction 0x76bde6988e4024633a8681e88eac509c66759e12da8897a0ef88bc765edc52fb {"gasLimit":436981,"maxFeePerGas":"38.512961458","maxPriorityFeePerGas":"38.337599913"} 14:22:02 [14:22:02.400] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0x76bde6988e4024633a8681e88eac509c66759e12da8897a0ef88bc765edc52fb. 14:22:02 [14:22:02.405] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:22:02 [14:22:02.418] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:22:02 [14:22:02.418] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 14:22:02 [14:22:02.419] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/690bc597/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 14:22:02 [14:22:02.667] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 14:22:02 [14:22:02.670] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:22:02 [14:22:02.672] INFO: node Aztec Node version: 0.87.8 14:22:02 [14:22:02.673] 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"} 14:22:02 [14:22:02.673] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Creating pxe... 14:22:02 [14:22:02.684] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/c8b303ab5c0dca51/f0df8ca9d76a7f61/pxe_data with map size 134217728 KB (LMDB v2) 14:22:02 [14:22:02.695] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","blockNumber":1,"slot":1} 14:22:02 [14:22:02.695] INFO: pxe:data:lmdb Starting data store with maxReaders 16 14:22:03 [14:22:03.074] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 14:22:03 [14:22:03.075] INFO: pxe:service Started PXE connected to chain 31337 version 2957328342 14:22:03 [14:22:03.076] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for accounts... 14:22:03 [14:22:03.077] VERBOSE: e2e:e2e_nested_contract:manual Deploying accounts funded with fee juice... 14:22:03 [14:22:03.147] INFO: pxe:service Registered account 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec 14:22:03 [14:22:03.247] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 14:22:03 [14:22:03.250] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec 14:22:03 [14:22:03.476] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","blockNumber":1,"slot":1} 14:22:03 [14:22:03.477] INFO: pxe:service Added contract SchnorrAccount at 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:22:03 [14:22:03.537] VERBOSE: pxe:block_stream Starting sync from block number 0 14:22:03 [14:22:03.568] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 14:22:03 [14:22:03.693] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:22:04 [14:22:04.476] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 14:22:04 [14:22:04.633] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:22:04 [14:22:04.770] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","blockNumber":1,"slot":1} 14:22:04 [14:22:04.917] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:04 [14:22:04.977] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:04 [14:22:04.978] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:05 [14:22:05.106] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:05 [14:22:05.112] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:05 [14:22:05.365] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","blockNumber":1,"slot":1} 14:22:05 [14:22:05.411] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:05 [14:22:05.467] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:05 [14:22:05.468] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:05 [14:22:05.533] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:05 [14:22:05.536] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:05 [14:22:05.553] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec as fee payer 14:22:06 [14:22:06.055] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","blockNumber":1,"slot":1} 14:22:06 [14:22:06.787] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","blockNumber":1,"slot":1} 14:22:07 [14:22:07.412] INFO: pxe:service Proving completed in 3881.835572ms {"timings":{"total":3881.835572,"sync":8.095617999999376,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":200.93665300000066,"oracles":{"callPrivateFunction":{"times":[1116.2802589999992,532.6694269999989,308.20756600000095]}}},{"functionName":"private_kernel_init","time":148.1634299999987},{"functionName":"ContractClassRegisterer:register","time":1088.5716360000006,"oracles":{"loadCapsule":{"times":[52.662280999998984]},"notifyCreatedNullifier":{"times":[1.4034890000002633]},"debugLog":{"times":[1.516791000000012]},"notifyCreatedContractClassLog":{"times":[13.334807000001092]}}},{"functionName":"private_kernel_inner","time":237.9533510000001},{"functionName":"SchnorrAccount:constructor","time":492.3830730000009,"oracles":{"getContractInstance":{"times":[3.96443200000067]},"debugLog":{"times":[0.9115089999995689,0.6214629999994941]},"fetchTaggedLogs":{"times":[131.14617700000053]},"loadCapsule":{"times":[1.692945000000691,0.3443569999999454,1.9307989999997517]},"notifyCreatedNullifier":{"times":[0.31392699999923934,0.32699700000011944]},"notifyCreatedNote":{"times":[0.6719439999997121]},"getRandomField":{"times":[0.4215089999997872,0.37926799999877403,0.18773399999918183,0.08259100000032049,0.07144100000004983,0.05218099999910919,0.07204099999944447,0.0746820000003936,0.07071199999882083,0.10385200000018813,0.07340199999998731]},"getIndexedTaggingSecretAsSender":{"times":[61.11697699999968]},"incrementAppTaggingSecretIndexAsSender":{"times":[40.68679300000076]}}},{"functionName":"private_kernel_inner","time":154.66373399999975},{"functionName":"SchnorrAccount:entrypoint","time":254.29208799999833,"oracles":{"debugLog":{"times":[0.9232289999999921,0.3661179999999149,0.8598779999992985]},"fetchTaggedLogs":{"times":[66.91272600000048]},"loadCapsule":{"times":[0.32523700000092504,0.1892840000000433,0.18767300000035902]},"getNotes":{"times":[1.9942009999995207]},"getAuthWitness":{"times":[0.2879460000003746]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.1988239999991492]}}},{"functionName":"private_kernel_inner","time":222.42316800000117},{"functionName":"private_kernel_reset","time":277.17675299999974},{"functionName":"private_kernel_tail","time":100.93611200000123}],"unaccounted":696.2399559999994}} 14:22:07 [14:22:07.559] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","blockNumber":1,"slot":1} 14:22:07 [14:22:07.656] VERBOSE: p2p:tx_pool Adding tx 0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d to pool {"eventName":"tx-added-to-pool","txHash":"0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:22:07 [14:22:07.685] INFO: node Received tx 0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d {"txHash":"0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d"} 14:22:07 [14:22:07.685] INFO: pxe:service Sent transaction 0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d 14:22:08 [14:22:08.096] VERBOSE: sequencer Building block 1 for slot 1 {"slot":1,"blockNumber":1,"msgCount":0} 14:22:08 [14:22:08.112] VERBOSE: sequencer Processing pending txs {"slot":1,"slotStart":"2025-06-18T14:25:47.000Z","now":"2025-06-18T14:22:08.112Z"} 14:22:08 [14:22:08.447] VERBOSE: simulator:public-processor Processed tx 0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d with no public calls in 230.31911200000104ms {"txHash":"0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d","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":230.31911200000104} 14:22:08 [14:22:08.450] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.33657144300000075s {"duration":0.33657144300000075,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 14:22:08 [14:22:08.594] INFO: sequencer Built block 1 for slot 1 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x24cfd1bf35316a82cc1d5f25a6a3bc3bf6af718993b63c90007dccc260de6ce6","globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":1,"slotNumber":1,"timestamp":1750256747,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1470c53a52c50f69de45102e015bbf76cb6ac690190725269a9a270a406dcc5d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":499.1711230000001,"publicProcessDuration":337.5392439999996,"rollupCircuitsDuration":483.78021400000216,"txCount":1,"blockNumber":1,"blockTimestamp":1750256747,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:22:08 [14:22:08.599] VERBOSE: sequencer Attesting committee is empty 14:22:09 [14:22:09.057] VERBOSE: sequencer-client Sent L1 transaction 0x75620653a24be4d479090929263194aac95e5e46d474faa8308074273d87e3d5 {"gasLimit":514567,"maxFeePerGas":"46.158703672","maxPriorityFeePerGas":"46.005119895","maxFeePerBlobGas":"0.000000001"} 14:22:09 [14:22:09.081] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 14:22:09 [14:22:09.085] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 14:22:09 [14:22:09.088] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:09 [14:22:09.089] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x75620653a24be4d479090929263194aac95e5e46d474faa8308074273d87e3d5","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750256747,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:22:09 [14:22:09.089] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:09 [14:22:09.092] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 14:22:09 [14:22:09.093] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256783] on http://127.0.0.1:8545 14:22:09 [14:22:09.096] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:09 [14:22:09.111] INFO: blob-sink:server Received blob sidecar for block 0x451e67c0130fa0569fc0623f038b3bcebc9fea562d0fcf19894a7b21dd0b6737 14:22:09 [14:22:09.117] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256783 14:22:09 [14:22:09.117] INFO: aztecjs:utils:watcher Slot 1 was filled, jumped to next slot 14:22:09 [14:22:09.126] INFO: blob-sink:server Blob sidecar stored successfully for block 0x451e67c0130fa0569fc0623f038b3bcebc9fea562d0fcf19894a7b21dd0b6737 14:22:09 [14:22:09.317] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:22:09 [14:22:09.330] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x24cfd1bf35316a82cc1d5f25a6a3bc3bf6af718993b63c90007dccc260de6ce6","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":1,"slotNumber":1,"timestamp":1750256747,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x21242527badc5a7f6be0f3406a3213e2ad399a470aafc99f131d4b7f84f57f04","archiveNextLeafIndex":2} 14:22:09 [14:22:09.342] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 14:22:09 [14:22:09.417] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for accounts complete. 14:22:09 [14:22:09.419] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":14.890589000002365,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750256747,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:22:09 [14:22:09.435] VERBOSE: e2e:e2e_nested_contract:manual Wallet 0 address: 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec 14:22:09 [14:22:09.436] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for public_deploy... 14:22:09 [14:22:09.436] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for public_deploy complete. 14:22:09 [14:22:09.436] VERBOSE: e2e:e2e_nested_contract:manual Public deploy accounts... 14:22:09 [14:22:09.489] VERBOSE: p2p Synched to latest block 1 14:22:09 [14:22:09.652] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21242527badc5a7f6be0f3406a3213e2ad399a470aafc99f131d4b7f84f57f04","blockNumber":2,"slot":2} 14:22:09 [14:22:09.662] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x21242527badc5a7f6be0f3406a3213e2ad399a470aafc99f131d4b7f84f57f04","header":{"contentCommitment":{"blobsHash":"0x006407307e33fed7ac7d0ba1c247bd64dab285ca6a4be5647139dd32b2816158","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750256747,"version":2957328342},"lastArchive":"0x29fe0daee17d016be2abbe0e9835ea2dee6d38581e30e67aeb5838d3796b12fb","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1f41b7ea2d52ca0e2256640958d536cf1acda6e7c9af5792fe262ab19a82fbb9","nullifierTree":"0x09a0ac12860483ff0c1f3e1be56feab4f74a2b3c596e098fe7e37f57fab429c3","publicDataTree":"0x062c15b73146d7ca6388835f89650daa1df68f7364306196cea6804178e8915c"},"totalFees":6794052480,"totalManaUsed":20448}} 14:22:09 [14:22:09.781] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:09 [14:22:09.839] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:09 [14:22:09.839] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:09 [14:22:09.966] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:09 [14:22:09.972] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1d1a59f7a643b5ec854ebf5a87e162e45aeb0b5a88d97cc8db4b723310c1927a 14:22:09 [14:22:09.988] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:22:09 [14:22:09.989] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:22:10 [14:22:09.997] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:22:10 [14:22:09.997] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:22:10 [14:22:10.004] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x04f929cc6b6572216207e5cce59436353ab926a19946966bfe77c27a012a6657","nullifier":"0x0c762b2e36f59ce4fee1a0507dd0dabd7e757be6328c408310c7d6b5920d39f4"} 14:22:10 [14:22:10.007] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:10 [14:22:10.040] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec as fee payer 14:22:10 [14:22:10.087] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:22:10 [14:22:10.132] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:22:10 [14:22:10.145] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec,0x0000000000000000000000000000000000000000000000000000000000000001,0x196490a2575e2e1676b98cd046e23a39b22e60bcffb54dde9aebc8fb322f5555,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x22e94ef5335562275a35f1ab5feece187ba41daf49ee6a2d78e111ff2b481bec,0x237cf77aceb4a7f105f6a434bee0536527ba09f266c0fe604369ca28efac6421,0x2ac9e5d2e4d1b42b2dca247ab4d2458cb605977a3dde1288d934b5fa0c1d4989,0x119807a5d3b87b588bbd19295a367a4af20e932f1f22174376cab55880353908,0x0f3923d9e648124e1e87cb085bb2f4ecb50aaa10788ceb268141170415a722d7,0x129e876209432fe8a09f20a1cdf296c1690ef596512106da1d45208e1b7eafa6,0x0e64092570c12adccdd6d8187b9f13efa8b87f0be9c91bd061355c95118a0b51,0x26c8e55e940dcc7da811dea66d375f78f410f62968f812834f155ee4777032f8,0x16d49d3d58b7bf6bc590872e22e3cac18a4bb922a69a21000493dbcd97961c44,0x0000000000000000000000000000000000000000000000000000000000000000 14:22:10 [14:22:10.312] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21242527badc5a7f6be0f3406a3213e2ad399a470aafc99f131d4b7f84f57f04","blockNumber":2,"slot":2} 14:22:11 [14:22:11.270] INFO: pxe:service Proving completed in 1624.4686500000025ms {"timings":{"total":1624.4686500000025,"sync":18.739927999999054,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":361.56990099999894,"oracles":{"debugLog":{"times":[0.6961450000017066,0.49673099999927217,0.6821540000019013,0.5891719999999623,0.4099790000000212,0.2940660000022035,0.32104599999729544,0.672074000001885]},"fetchTaggedLogs":{"times":[129.1807860000008]},"loadCapsule":{"times":[0.287265999999363,0.6065830000006827,0.5502620000006573,0.2092239999983576,0.526810999999725,0.46956999999747495]},"getSharedSecret":{"times":[6.107606999998097]},"aes128Decrypt":{"times":[1.2709759999997914,1.2155449999991106]},"getPublicKeysAndPartialAddress":{"times":[2.193315000000439]},"getKeyValidationRequest":{"times":[2.0320520000022952]},"deliverNote":{"times":[7.081497000002855]},"deleteCapsule":{"times":[0.3836779999983264]},"storeCapsule":{"times":[0.5009599999975762]},"getNotes":{"times":[12.407725999997638]},"getAuthWitness":{"times":[0.3133669999988342]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.057770999999775086]},"callPrivateFunction":{"times":[111.78072600000087]}}},{"functionName":"private_kernel_init","time":93.86307400000078},{"functionName":"ContractInstanceDeployer:deploy","time":67.41896799999449,"oracles":{"storeInExecutionCache":{"times":[0.48977000000013504]},"callPrivateFunction":{"times":[44.111613999997644]},"notifyCreatedNullifier":{"times":[0.3883079999977781]},"debugLog":{"times":[1.776386999998067]}}},{"functionName":"private_kernel_inner","time":141.78816800000277},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.881489000003057,"oracles":{}},{"functionName":"private_kernel_inner","time":161.22869100000025},{"functionName":"private_kernel_reset","time":267.254197000002},{"functionName":"private_kernel_tail","time":95.24548399999912}],"unaccounted":386.47875000000204}} 14:22:11 [14:22:11.312] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21242527badc5a7f6be0f3406a3213e2ad399a470aafc99f131d4b7f84f57f04","blockNumber":2,"slot":2} 14:22:11 [14:22:11.328] VERBOSE: p2p:tx_pool Adding tx 0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16 to pool {"eventName":"tx-added-to-pool","txHash":"0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 14:22:11 [14:22:11.340] INFO: node Received tx 0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16 {"txHash":"0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16"} 14:22:11 [14:22:11.340] INFO: pxe:service Sent transaction 0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16 14:22:11 [14:22:11.834] VERBOSE: sequencer Building block 2 for slot 2 {"slot":2,"blockNumber":2,"msgCount":0} 14:22:11 [14:22:11.854] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T14:26:23.000Z","now":"2025-06-18T14:22:11.854Z"} 14:22:11 [14:22:11.908] VERBOSE: simulator:public-processor Processed tx 0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16 with no public calls in 24.82722400000057ms {"txHash":"0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16","txFee":3721312000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":9728,"l2Gas":11200},"billedGas":{"daGas":9728,"l2Gas":11200},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":24.82722400000057} 14:22:11 [14:22:11.911] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05605888199999754s {"duration":0.05605888199999754,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":9728,"l2Gas":11200},"totalSizeInBytes":832} 14:22:12 [14:22:12.060] INFO: sequencer Built block 2 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x16ae648eb67de2200caa10f6ac3151d80f39b0f13f59a5372cb6716b629db599","globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":2,"slotNumber":2,"timestamp":1750256783,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2e0f2a1daf0511b5a78242fd64923e304c26fe3a4629dfcb46ffe0172306eb16"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":226.27063800000178,"publicProcessDuration":56.425889000001916,"rollupCircuitsDuration":207.16632200000095,"txCount":1,"blockNumber":2,"blockTimestamp":1750256783,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:12 [14:22:12.062] VERBOSE: sequencer Attesting committee is empty 14:22:12 [14:22:12.490] VERBOSE: sequencer-client Sent L1 transaction 0x4febc3a98e3793330026d904f0c20b5d4b2e4cc76c6b6b3762d88b4c669c67a9 {"gasLimit":470234,"maxFeePerGas":"1.318412808","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:22:12 [14:22:12.501] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 14:22:12 [14:22:12.507] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 14:22:12 [14:22:12.511] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 14:22:12 [14:22:12.522] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:12 [14:22:12.526] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4febc3a98e3793330026d904f0c20b5d4b2e4cc76c6b6b3762d88b4c669c67a9","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1750256783,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:12 [14:22:12.526] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:12 [14:22:12.537] INFO: blob-sink:server Received blob sidecar for block 0x55a21eb515ec2e1b71bdeabdec8f6ce6b5dcb48ab9ad043460f772509f735d2e 14:22:12 [14:22:12.548] INFO: blob-sink:server Blob sidecar stored successfully for block 0x55a21eb515ec2e1b71bdeabdec8f6ce6b5dcb48ab9ad043460f772509f735d2e 14:22:12 [14:22:12.745] VERBOSE: archiver:block-helper Store contract instance at 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec 14:22:12 [14:22:12.750] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x16ae648eb67de2200caa10f6ac3151d80f39b0f13f59a5372cb6716b629db599","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":2,"slotNumber":2,"timestamp":1750256783,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","archiveNextLeafIndex":3} 14:22:12 [14:22:12.754] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256819] on http://127.0.0.1:8545 14:22:12 [14:22:12.756] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:12 [14:22:12.757] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 14:22:12 [14:22:12.758] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256819 14:22:12 [14:22:12.759] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 14:22:12 [14:22:12.861] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.841283000001567,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750256783,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:12 [14:22:12.868] VERBOSE: p2p Synched to latest block 2 14:22:13 [14:22:13.057] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","blockNumber":3,"slot":3} 14:22:13 [14:22:13.503] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for manual... 14:22:13 [14:22:13.690] WARN: pxe:service No artifact found for contract class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b when looking for its metadata 14:22:13 [14:22:13.698] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b as part of deployment for 0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563 14:22:13 [14:22:13.891] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","blockNumber":3,"slot":3} 14:22:14 [14:22:14.058] INFO: pxe:service Added contract Parent at 0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563 with class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b 14:22:14 [14:22:14.093] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","header":{"contentCommitment":{"blobsHash":"0x00afac6d5c3fdfd66d31dc298f63a79d42165cef86af4f5c89049b60fefea229","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750256783,"version":2957328342},"lastArchive":"0x21242527badc5a7f6be0f3406a3213e2ad399a470aafc99f131d4b7f84f57f04","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1f41b7ea2d52ca0e2256640958d536cf1acda6e7c9af5792fe262ab19a82fbb9","nullifierTree":"0x1a9009a230d2842abf378fb02759c10b6ddf6aade51992077134ff1553fcdfad","publicDataTree":"0x13deab2a29de406878dfdbd6667d67728e2735907bc856fed77f5b4c92042ed4"},"totalFees":3721312000,"totalManaUsed":11200}} 14:22:14 [14:22:14.222] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:14 [14:22:14.262] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:14 [14:22:14.263] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:14 [14:22:14.371] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:14 [14:22:14.380] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1d1a59f7a643b5ec854ebf5a87e162e45aeb0b5a88d97cc8db4b723310c1927a 14:22:14 [14:22:14.391] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:22:14 [14:22:14.392] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:22:14 [14:22:14.406] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:22:14 [14:22:14.406] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:22:14 [14:22:14.415] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","blockNumber":3,"slot":3} 14:22:14 [14:22:14.417] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x04f929cc6b6572216207e5cce59436353ab926a19946966bfe77c27a012a6657","nullifier":"0x0c762b2e36f59ce4fee1a0507dd0dabd7e757be6328c408310c7d6b5920d39f4"} 14:22:14 [14:22:14.419] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:14 [14:22:14.442] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec as fee payer 14:22:14 [14:22:14.497] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:22:15 [14:22:15.050] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b,0x2fcc71bf82a0d2fb44c6e69c227f45ec3b849e42384f895d3e5264986023446a,0x046c8c9617995ee143a721d7e1e29705b90693ed664d0303750827345e2d2c06,0x0bd9d45bf91246ff3cab80ea1687192bffcfc1935fd339933d8d60154324397b 14:22:15 [14:22:15.185] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:22:15 [14:22:15.361] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:22:15 [14:22:15.376] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","blockNumber":3,"slot":3} 14:22:15 [14:22:15.445] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:22:15 [14:22:15.462] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563,0x0000000000000000000000000000000000000000000000000000000000000001,0x058c37003c11f0a47c2d26e0f618d2ddc207e3cfdac898e7a738d6dbd9335ae5,0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec 14:22:16 [14:22:16.225] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","blockNumber":3,"slot":3} 14:22:17 [14:22:17.151] INFO: pxe:service Proving completed in 3070.2931959999987ms {"timings":{"total":3070.2931959999987,"sync":15.388488999997207,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":346.9398879999935,"oracles":{"debugLog":{"times":[0.7578360000006796,0.36136700000133715,0.3905080000004091,0.47159000000101514,0.4090790000009292,0.43736899999930756,0.46973000000070897,1.0838519999997516]},"fetchTaggedLogs":{"times":[114.97084199999881]},"loadCapsule":{"times":[0.3572870000025432,0.3068359999997483,0.4994399999995949,0.22678499999892665,0.27762499999880674,0.2181239999990794]},"getSharedSecret":{"times":[3.2502170000007027]},"aes128Decrypt":{"times":[0.30044700000144076,1.1051430000006803]},"getPublicKeysAndPartialAddress":{"times":[5.84925099999964]},"getKeyValidationRequest":{"times":[4.89560100000017]},"deliverNote":{"times":[10.687691999999515]},"deleteCapsule":{"times":[0.31171700000049896]},"storeCapsule":{"times":[0.3710270000010496]},"getNotes":{"times":[1.9619910000001255]},"getAuthWitness":{"times":[0.32343699999910314]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.13211300000330084]},"callPrivateFunction":{"times":[815.2515219999987,206.3141140000007]}}},{"functionName":"private_kernel_init","time":93.19532099999924},{"functionName":"ContractClassRegisterer:register","time":796.3803710000029,"oracles":{"loadCapsule":{"times":[3.296097999998892]},"notifyCreatedNullifier":{"times":[0.5023799999980838]},"debugLog":{"times":[0.6186029999989842]},"notifyCreatedContractClassLog":{"times":[8.383254000000306]}}},{"functionName":"private_kernel_inner","time":221.30318500000067},{"functionName":"ContractInstanceDeployer:deploy","time":126.05821300000025,"oracles":{"storeInExecutionCache":{"times":[0.1215219999976398]},"callPrivateFunction":{"times":[87.0888449999984]},"notifyCreatedNullifier":{"times":[0.38110800000140443]},"debugLog":{"times":[0.5894220000009227]}}},{"functionName":"private_kernel_inner","time":149.48491699999795},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":61.05016400000022,"oracles":{}},{"functionName":"private_kernel_inner","time":178.4875690000008},{"functionName":"private_kernel_reset","time":300.5145760000014},{"functionName":"private_kernel_tail","time":102.32648100000006}],"unaccounted":679.1640220000045}} 14:22:17 [14:22:17.420] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","blockNumber":3,"slot":3} 14:22:17 [14:22:17.440] VERBOSE: p2p:tx_pool Adding tx 0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2 to pool {"eventName":"tx-added-to-pool","txHash":"0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":257,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:22:17 [14:22:17.468] INFO: node Received tx 0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2 {"txHash":"0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2"} 14:22:17 [14:22:17.469] INFO: pxe:service Sent transaction 0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2 14:22:17 [14:22:17.985] VERBOSE: sequencer Building block 3 for slot 3 {"slot":3,"blockNumber":3,"msgCount":0} 14:22:18 [14:22:18.027] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T14:26:59.000Z","now":"2025-06-18T14:22:18.027Z"} 14:22:18 [14:22:18.421] VERBOSE: simulator:public-processor Processed tx 0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2 with no public calls in 268.4615730000005ms {"txHash":"0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2","txFee":5496909440,"revertCode":0,"gasUsed":{"totalGas":{"daGas":142848,"l2Gas":16544},"billedGas":{"daGas":142848,"l2Gas":16544},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":268.4615730000005} 14:22:18 [14:22:18.425] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3969942459999984s {"duration":0.3969942459999984,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":142848,"l2Gas":16544},"totalSizeInBytes":9184} 14:22:18 [14:22:18.766] INFO: sequencer Built block 3 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0a4a1e70346494b5e761700852cb41605a334359dbae418fceef92c49e84f878","globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":3,"slotNumber":3,"timestamp":1750256819,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0564af7e9ff75c81eaff31855e54bb3ece03723cb261087059b76cc1a4c65cf2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":785.9595950000003,"publicProcessDuration":397.5974580000002,"rollupCircuitsDuration":739.7522370000006,"txCount":1,"blockNumber":3,"blockTimestamp":1750256819,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":257} 14:22:18 [14:22:18.770] VERBOSE: sequencer Attesting committee is empty 14:22:19 [14:22:19.297] VERBOSE: sequencer-client Sent L1 transaction 0x0011bb699b1387b2dbca61b133a40ccfbe9ccf78e4d15d8b735e8df2372a30d2 {"gasLimit":470280,"maxFeePerGas":"1.290952457","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:22:19 [14:22:19.364] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256855] on http://127.0.0.1:8545 14:22:19 [14:22:19.374] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:19 [14:22:19.379] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0011bb699b1387b2dbca61b133a40ccfbe9ccf78e4d15d8b735e8df2372a30d2","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750256819,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":257} 14:22:19 [14:22:19.380] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:19 [14:22:19.387] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:19 [14:22:19.392] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256855 14:22:19 [14:22:19.393] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 14:22:19 [14:22:19.396] INFO: blob-sink:server Received blob sidecar for block 0x23e90fad7f113d5521986af2f12fae0ccc23b28b6fa0fc961db385c270a4f9e0 14:22:19 [14:22:19.405] INFO: blob-sink:server Blob sidecar stored successfully for block 0x23e90fad7f113d5521986af2f12fae0ccc23b28b6fa0fc961db385c270a4f9e0 14:22:19 [14:22:19.522] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 14:22:19 [14:22:19.526] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 14:22:19 [14:22:19.538] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 14:22:19 [14:22:19.702] VERBOSE: archiver:block-helper Store contract instance at 0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563 14:22:19 [14:22:19.717] VERBOSE: archiver:block-helper Store contract class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b 14:22:19 [14:22:19.753] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x0a4a1e70346494b5e761700852cb41605a334359dbae418fceef92c49e84f878","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":3,"slotNumber":3,"timestamp":1750256819,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","archiveNextLeafIndex":4} 14:22:19 [14:22:19.853] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":29.47051300000021,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750256819,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":257} 14:22:19 [14:22:19.888] VERBOSE: p2p Synched to latest block 3 14:22:19 [14:22:19.926] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","blockNumber":4,"slot":4} 14:22:20 [14:22:20.316] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 14:22:20 [14:22:20.496] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","blockNumber":4,"slot":4} 14:22:20 [14:22:20.625] INFO: aztecjs:deploy_sent_tx Contract 0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563 successfully deployed. 14:22:20 [14:22:20.732] WARN: pxe:service No artifact found for contract class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 when looking for its metadata 14:22:20 [14:22:20.734] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 as part of deployment for 0x020a2964dc7140e018c865622f5eb178b25cbf97acff4d86f1b3a03c654492c9 14:22:21 [14:22:21.048] INFO: pxe:service Added contract Child at 0x020a2964dc7140e018c865622f5eb178b25cbf97acff4d86f1b3a03c654492c9 with class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 14:22:21 [14:22:21.119] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","blockNumber":4,"slot":4} 14:22:21 [14:22:21.128] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","header":{"contentCommitment":{"blobsHash":"0x004de18073e4900b85a3ab8f542a3ea7ad079d8da8086d871319061f1669098c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750256819,"version":2957328342},"lastArchive":"0x1d6e885ac137b70dd722494661f0e60b80529174d1a9a139b5f87bd0d975eb88","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1f41b7ea2d52ca0e2256640958d536cf1acda6e7c9af5792fe262ab19a82fbb9","nullifierTree":"0x23025bcf16fbf2b1cf07ce979375c15617b7bd239da8276333245bd23a5253a0","publicDataTree":"0x07ba93fbf9907956fca0dab12f44aa461768cc5a08aa721504bbc92140fb5c77"},"totalFees":5496909440,"totalManaUsed":16544}} 14:22:21 [14:22:21.252] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:21 [14:22:21.297] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:21 [14:22:21.298] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:21 [14:22:21.451] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:21 [14:22:21.473] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1d1a59f7a643b5ec854ebf5a87e162e45aeb0b5a88d97cc8db4b723310c1927a 14:22:21 [14:22:21.501] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:22:21 [14:22:21.503] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:22:21 [14:22:21.527] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:22:21 [14:22:21.527] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:22:21 [14:22:21.539] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x04f929cc6b6572216207e5cce59436353ab926a19946966bfe77c27a012a6657","nullifier":"0x0c762b2e36f59ce4fee1a0507dd0dabd7e757be6328c408310c7d6b5920d39f4"} 14:22:21 [14:22:21.548] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:21 [14:22:21.584] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec as fee payer 14:22:21 [14:22:21.635] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:22:22 [14:22:22.321] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9,0x1a4c0bde05ac32ea9ae2f4a5b141d3ff84b80b42d18e584a0ba0d19f7c2f82fb,0x01a5de0647b8e04e7f2e9f75bc1b474a527192215c030d10ebfc6751ce804506,0x2da71b8e2649f39f83e4bfa9280968a015fa13c148faf6eae97621dea667fdf7 14:22:22 [14:22:22.457] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:22:22 [14:22:22.671] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:22:22 [14:22:22.686] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","blockNumber":4,"slot":4} 14:22:22 [14:22:22.725] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:22:22 [14:22:22.738] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x020a2964dc7140e018c865622f5eb178b25cbf97acff4d86f1b3a03c654492c9,0x0000000000000000000000000000000000000000000000000000000000000001,0x0613e22b70cae9c7ee9d302c92dbfa93c81510a05e2718834f80cef56286dc92,0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec 14:22:23 [14:22:23.706] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","blockNumber":4,"slot":4} 14:22:24 [14:22:24.310] INFO: pxe:service Proving completed in 3203.3419010000034ms {"timings":{"total":3203.3419010000034,"sync":25.566745000000083,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":484.07595000000583,"oracles":{"debugLog":{"times":[0.673172999999224,0.684253000003082,0.7142340000027616,0.761304999999993,0.551010999999562,0.3374870000006922,2.74407500000234,0.8331660000003467]},"fetchTaggedLogs":{"times":[170.9382889999979]},"loadCapsule":{"times":[0.44626900000002934,0.2332639999985986,1.8993679999985034,5.342125999999553,0.24312499999723514,1.687432999999146]},"getSharedSecret":{"times":[11.740012000002025]},"aes128Decrypt":{"times":[3.60269100000005,3.050810000000638]},"getPublicKeysAndPartialAddress":{"times":[8.082689999999275]},"getKeyValidationRequest":{"times":[4.818155000000843]},"deliverNote":{"times":[12.858695000002626]},"deleteCapsule":{"times":[0.5025999999998021]},"storeCapsule":{"times":[0.3140959999982442]},"getNotes":{"times":[10.987436999999773]},"getAuthWitness":{"times":[0.2966859999978624]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06460100000185776]},"callPrivateFunction":{"times":[946.4092840000012,206.74691800000073]}}},{"functionName":"private_kernel_init","time":81.83421799999996},{"functionName":"ContractClassRegisterer:register","time":929.301905999997,"oracles":{"loadCapsule":{"times":[14.034446999998181]},"notifyCreatedNullifier":{"times":[0.9513480000023264]},"debugLog":{"times":[1.4043369999999413]},"notifyCreatedContractClassLog":{"times":[14.877034000001004]}}},{"functionName":"private_kernel_inner","time":175.82660599999872},{"functionName":"ContractInstanceDeployer:deploy","time":145.33507400000235,"oracles":{"storeInExecutionCache":{"times":[0.1490029999986291]},"callPrivateFunction":{"times":[52.0194190000002]},"notifyCreatedNullifier":{"times":[0.333877000000939]},"debugLog":{"times":[0.5866820000010193]}}},{"functionName":"private_kernel_inner","time":171.89593899999818},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":37.439619999997376,"oracles":{}},{"functionName":"private_kernel_inner","time":174.79271599999993},{"functionName":"private_kernel_reset","time":241.65858799999842},{"functionName":"private_kernel_tail","time":103.21932099999685}],"unaccounted":632.3952180000088}} 14:22:24 [14:22:24.545] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","blockNumber":4,"slot":4} 14:22:24 [14:22:24.546] VERBOSE: p2p:tx_pool Adding tx 0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01 to pool {"eventName":"tx-added-to-pool","txHash":"0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":146,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:22:24 [14:22:24.565] INFO: node Received tx 0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01 {"txHash":"0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01"} 14:22:24 [14:22:24.566] INFO: pxe:service Sent transaction 0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01 14:22:25 [14:22:25.098] VERBOSE: sequencer Building block 4 for slot 4 {"slot":4,"blockNumber":4,"msgCount":0} 14:22:25 [14:22:25.124] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T14:27:35.000Z","now":"2025-06-18T14:22:25.124Z"} 14:22:25 [14:22:25.457] VERBOSE: simulator:public-processor Processed tx 0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01 with no public calls in 232.43477600000188ms {"txHash":"0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01","txFee":5496909440,"revertCode":0,"gasUsed":{"totalGas":{"daGas":86016,"l2Gas":16544},"billedGas":{"daGas":86016,"l2Gas":16544},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":232.43477600000188} 14:22:25 [14:22:25.460] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3337977099999989s {"duration":0.3337977099999989,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":86016,"l2Gas":16544},"totalSizeInBytes":5632} 14:22:25 [14:22:25.667] INFO: sequencer Built block 4 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1b0e12b497a2dd319e2e5af98532cef8bc6de818cd0b85642506555b913831d6","globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":4,"slotNumber":4,"timestamp":1750256855,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2af2f98882ce64f798497fbb9b20b928681a7197eea3fa5b3286ce93c3294d01"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":574.5643810000038,"publicProcessDuration":334.1831680000032,"rollupCircuitsDuration":544.7101909999983,"txCount":1,"blockNumber":4,"blockTimestamp":1750256855,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":146} 14:22:25 [14:22:25.674] VERBOSE: sequencer Attesting committee is empty 14:22:26 [14:22:26.098] VERBOSE: sequencer-client Sent L1 transaction 0x015864afb28ca0f8c3ad6e0c42e700a16d45a6f9cebb8fc0a395807b923130cc {"gasLimit":470185,"maxFeePerGas":"1.269860277","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:22:26 [14:22:26.111] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 14:22:26 [14:22:26.114] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 14:22:26 [14:22:26.118] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 14:22:26 [14:22:26.120] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:26 [14:22:26.120] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x015864afb28ca0f8c3ad6e0c42e700a16d45a6f9cebb8fc0a395807b923130cc","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":4,"blockTimestamp":1750256855,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":146} 14:22:26 [14:22:26.120] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:26 [14:22:26.125] INFO: blob-sink:server Received blob sidecar for block 0x07c0353549c2832719bc880a96b867adcc9f35172efbfb18c3050502b16bd00e 14:22:26 [14:22:26.131] INFO: blob-sink:server Blob sidecar stored successfully for block 0x07c0353549c2832719bc880a96b867adcc9f35172efbfb18c3050502b16bd00e 14:22:26 [14:22:26.320] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256891] on http://127.0.0.1:8545 14:22:26 [14:22:26.321] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:26 [14:22:26.323] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256891 14:22:26 [14:22:26.323] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 14:22:26 [14:22:26.523] VERBOSE: archiver:block-helper Store contract instance at 0x020a2964dc7140e018c865622f5eb178b25cbf97acff4d86f1b3a03c654492c9 14:22:26 [14:22:26.531] VERBOSE: archiver:block-helper Store contract class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 14:22:26 [14:22:26.548] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1b0e12b497a2dd319e2e5af98532cef8bc6de818cd0b85642506555b913831d6","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":4,"slotNumber":4,"timestamp":1750256855,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1c9f563ed429de931873ea4a8aee720b6270ae7a962b2fb77327423f1ef17c4c","archiveNextLeafIndex":5} 14:22:26 [14:22:26.557] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 14:22:26 [14:22:26.635] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":10.65335100000084,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750256855,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":146} 14:22:26 [14:22:26.713] INFO: aztecjs:deploy_sent_tx Contract 0x020a2964dc7140e018c865622f5eb178b25cbf97acff4d86f1b3a03c654492c9 successfully deployed. 14:22:26 [14:22:26.714] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for manual complete. 14:22:26 [14:22:26.727] VERBOSE: p2p Synched to latest block 4 14:22:26 [14:22:26.880] INFO: e2e:manual_public Running test: e2e_nested_contract manual performs public nested calls 14:22:27 [14:22:26.999] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x1c9f563ed429de931873ea4a8aee720b6270ae7a962b2fb77327423f1ef17c4c","header":{"contentCommitment":{"blobsHash":"0x006b3bb0cb3a0b5c9871ea26cad1eaa2bd8aeeea9d936a5fe7f72287d8924048","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750256855,"version":2957328342},"lastArchive":"0x1c7bbc49b8d0056d4d0e894f4d8a6bf8071bd252388b78e03475c82efd0b33a1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1f41b7ea2d52ca0e2256640958d536cf1acda6e7c9af5792fe262ab19a82fbb9","nullifierTree":"0x0a8360c29021efa2ddaeaa8090a40daa3af3de593bff5a37b64e4e34dee8a683","publicDataTree":"0x054db87731b1ddcef1b4702826200dd1d424cefb40a35673c25633d2ac7952ce"},"totalFees":5496909440,"totalManaUsed":16544}} 14:22:27 [14:22:27.173] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:27 [14:22:27.249] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:27 [14:22:27.250] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:27 [14:22:27.395] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1c9f563ed429de931873ea4a8aee720b6270ae7a962b2fb77327423f1ef17c4c","blockNumber":5,"slot":5} 14:22:27 [14:22:27.438] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:27 [14:22:27.462] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1d1a59f7a643b5ec854ebf5a87e162e45aeb0b5a88d97cc8db4b723310c1927a 14:22:27 [14:22:27.498] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:22:27 [14:22:27.499] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:22:27 [14:22:27.520] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:22:27 [14:22:27.521] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:22:27 [14:22:27.524] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x04f929cc6b6572216207e5cce59436353ab926a19946966bfe77c27a012a6657","nullifier":"0x0c762b2e36f59ce4fee1a0507dd0dabd7e757be6328c408310c7d6b5920d39f4"} 14:22:27 [14:22:27.526] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:27 [14:22:27.545] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec as fee payer 14:22:28 [14:22:28.241] INFO: pxe:service Proving completed in 1296.4456150000042ms {"timings":{"total":1296.4456150000042,"sync":60.98992599999474,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":489.40862699999707,"oracles":{"debugLog":{"times":[1.1408819999996922,0.7896449999971082,0.5937820000035572,0.6643629999962286,0.5096000000048662,0.36238800000137417,0.5231700000003912,0.6876240000055986]},"fetchTaggedLogs":{"times":[207.34560000000056]},"loadCapsule":{"times":[0.7533350000012433,0.42075800000020536,0.6898539999965578,0.21343399999750545,0.21260400000028312,0.19160399999964284]},"getSharedSecret":{"times":[25.310749999996915]},"aes128Decrypt":{"times":[0.7193540000007488,1.3274460000029649]},"getPublicKeysAndPartialAddress":{"times":[14.048008000005211]},"getKeyValidationRequest":{"times":[2.8967780000020866]},"deliverNote":{"times":[3.332675999998173]},"deleteCapsule":{"times":[0.3635969999959343]},"storeCapsule":{"times":[0.28819600000133505]},"getNotes":{"times":[1.9646689999935916]},"getAuthWitness":{"times":[0.2993360000036773]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07467200000246521]},"notifyEnqueuedPublicFunctionCall":{"times":[0.49923999999737134]}}},{"functionName":"private_kernel_init","time":103.95084499999939},{"functionName":"private_kernel_reset","time":297.55300400000124},{"functionName":"private_kernel_tail","time":141.74879299999884}],"unaccounted":202.7944200000129}} 14:22:28 [14:22:28.380] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1c9f563ed429de931873ea4a8aee720b6270ae7a962b2fb77327423f1ef17c4c","blockNumber":5,"slot":5} 14:22:28 [14:22:28.396] VERBOSE: p2p:tx_pool Adding tx 0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce to pool {"eventName":"tx-added-to-pool","txHash":"0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 14:22:28 [14:22:28.410] INFO: node Received tx 0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce {"txHash":"0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce"} 14:22:28 [14:22:28.410] INFO: pxe:service Sent transaction 0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce 14:22:28 [14:22:28.949] VERBOSE: sequencer Building block 5 for slot 5 {"slot":5,"blockNumber":5,"msgCount":0} 14:22:28 [14:22:28.984] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-18T14:28:11.000Z","now":"2025-06-18T14:22:28.984Z"} 14:22:29 [14:22:29.109] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x6efc2c54 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x6efc2c54","duration":79.11500399999932} 14:22:29 [14:22:29.153] VERBOSE: simulator:public-processor Processed tx 0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce with 1 public calls in 141.84941499999695ms {"txHash":"0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce","txFee":1748896500,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1024,"l2Gas":34495},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":8639},"billedGas":{"daGas":1024,"l2Gas":34495}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":141.84941499999695} 14:22:29 [14:22:29.155] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.17029086699999607s {"duration":0.17029086699999607,"rate":50730.84747404686,"totalPublicGas":{"daGas":0,"l2Gas":8639},"totalBlockGas":{"daGas":1024,"l2Gas":34495},"totalSizeInBytes":256} 14:22:29 [14:22:29.326] INFO: sequencer Built block 5 for slot 5 with 1 txs and 0 messages. 22637.00567509921 mana/s {"blockHash":"0x1097b7836c52028805c1c987c8916dad45de7acc8df4816244d85c30f21bab92","globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":5,"slotNumber":5,"timestamp":1750256891,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x081a1924df00c2517b0f8428dacc432bf6a71b5d2fc7ae45d27480dbd0d91dce"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":380.9370920000001,"publicProcessDuration":171.55382200000167,"rollupCircuitsDuration":344.9335299999948,"txCount":1,"blockNumber":5,"blockTimestamp":1750256891,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:29 [14:22:29.329] VERBOSE: sequencer Attesting committee is empty 14:22:29 [14:22:29.700] VERBOSE: sequencer-client Sent L1 transaction 0xaab1cf7dedce5378d8694a9c84c7acd6e73d37e2644125bdd0e403f302867ab3 {"gasLimit":470277,"maxFeePerGas":"1.253659425","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:22:29 [14:22:29.711] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256927] on http://127.0.0.1:8545 14:22:29 [14:22:29.713] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:29 [14:22:29.717] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:29 [14:22:29.717] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xaab1cf7dedce5378d8694a9c84c7acd6e73d37e2644125bdd0e403f302867ab3","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":5,"blockTimestamp":1750256891,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:29 [14:22:29.717] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:29 [14:22:29.720] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256927 14:22:29 [14:22:29.721] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 14:22:29 [14:22:29.725] INFO: blob-sink:server Received blob sidecar for block 0x3065fa7be01c22ee4f36251cd45d0496d4acf880b5518daab9bc2b7dcffc78b2 14:22:29 [14:22:29.730] INFO: blob-sink:server Blob sidecar stored successfully for block 0x3065fa7be01c22ee4f36251cd45d0496d4acf880b5518daab9bc2b7dcffc78b2 14:22:29 [14:22:29.741] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 14:22:29 [14:22:29.743] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 14:22:29 [14:22:29.745] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 14:22:30 [14:22:30.430] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x1097b7836c52028805c1c987c8916dad45de7acc8df4816244d85c30f21bab92","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":5,"slotNumber":5,"timestamp":1750256891,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x05540ebaa628cd8e3a4950c7364be341e0d22756a07da94125cd2bb7aad6e840","archiveNextLeafIndex":6} 14:22:30 [14:22:30.435] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 14:22:30 [14:22:30.447] INFO: e2e:manual_public Running test: e2e_nested_contract manual reads fresh value after write within the same tx 14:22:30 [14:22:30.489] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x05540ebaa628cd8e3a4950c7364be341e0d22756a07da94125cd2bb7aad6e840","header":{"contentCommitment":{"blobsHash":"0x00340662f7b95726c41e80087277754d9bd940186c056ac52226cf178ce02302","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750256891,"version":2957328342},"lastArchive":"0x1c9f563ed429de931873ea4a8aee720b6270ae7a962b2fb77327423f1ef17c4c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1f41b7ea2d52ca0e2256640958d536cf1acda6e7c9af5792fe262ab19a82fbb9","nullifierTree":"0x185227ba07ede436f328407df2528d64027907a73ef19c547345267e5d1fb2e6","publicDataTree":"0x0281ee6d85df9ea90877a2bba637dcfdf8aef60f06d297b47a9b1ae7531207b0"},"totalFees":1748896500,"totalManaUsed":34495}} 14:22:30 [14:22:30.513] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":9.096678999994765,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750256891,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:30 [14:22:30.656] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:30 [14:22:30.721] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:30 [14:22:30.721] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:30 [14:22:30.797] VERBOSE: p2p Synched to latest block 5 14:22:30 [14:22:30.835] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:30 [14:22:30.860] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1d1a59f7a643b5ec854ebf5a87e162e45aeb0b5a88d97cc8db4b723310c1927a 14:22:30 [14:22:30.921] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:22:30 [14:22:30.922] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:22:30 [14:22:30.960] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:22:30 [14:22:30.961] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:22:30 [14:22:30.970] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x04f929cc6b6572216207e5cce59436353ab926a19946966bfe77c27a012a6657","nullifier":"0x0c762b2e36f59ce4fee1a0507dd0dabd7e757be6328c408310c7d6b5920d39f4"} 14:22:31 [14:22:31.026] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:31 [14:22:31.090] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec as fee payer 14:22:31 [14:22:31.658] INFO: pxe:service Proving completed in 1184.859798999998ms {"timings":{"total":1184.859798999998,"sync":18.873843000001216,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":581.8431049999999,"oracles":{"debugLog":{"times":[0.7743160000027274,0.6362220000009984,0.6169430000009015,0.5756019999971613,0.6718029999974533,0.5185399999973015,0.7019430000000284,0.7204639999981737]},"fetchTaggedLogs":{"times":[134.5859810000038]},"loadCapsule":{"times":[1.443239000000176,0.4417489999977988,0.5940919999993639,49.38718700000027,1.1755929999999353,33.03166400000191]},"getSharedSecret":{"times":[13.206140999995114]},"aes128Decrypt":{"times":[0.563401999999769,1.4926489999998012]},"getPublicKeysAndPartialAddress":{"times":[25.76150900000357]},"getKeyValidationRequest":{"times":[8.267753000000084]},"deliverNote":{"times":[9.26831300000049]},"deleteCapsule":{"times":[2.0209000000031665]},"storeCapsule":{"times":[2.1000310000017635]},"getNotes":{"times":[11.801134000001184]},"getAuthWitness":{"times":[0.24138500000117347]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06394100000034086]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07235099999525119]}}},{"functionName":"private_kernel_init","time":90.72215400000277},{"functionName":"private_kernel_reset","time":217.30424700000003},{"functionName":"private_kernel_tail","time":102.11152899999433}],"unaccounted":174.00492099999974}} 14:22:31 [14:22:31.750] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x05540ebaa628cd8e3a4950c7364be341e0d22756a07da94125cd2bb7aad6e840","blockNumber":6,"slot":6} 14:22:31 [14:22:31.760] VERBOSE: p2p:tx_pool Adding tx 0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9 to pool {"eventName":"tx-added-to-pool","txHash":"0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 14:22:31 [14:22:31.770] INFO: node Received tx 0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9 {"txHash":"0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9"} 14:22:31 [14:22:31.771] INFO: pxe:service Sent transaction 0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9 14:22:32 [14:22:32.278] VERBOSE: sequencer Building block 6 for slot 6 {"slot":6,"blockNumber":6,"msgCount":0} 14:22:32 [14:22:32.292] VERBOSE: sequencer Processing pending txs {"slot":6,"slotStart":"2025-06-18T14:28:47.000Z","now":"2025-06-18T14:22:32.292Z"} 14:22:32 [14:22:32.452] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x132874f5 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x132874f5","duration":98.32554400000663} 14:22:32 [14:22:32.478] VERBOSE: simulator:public-processor Processed tx 0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9 with 1 public calls in 163.58749399999942ms {"txHash":"0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9","txFee":2878036200,"revertCode":0,"gasUsed":{"totalGas":{"daGas":3072,"l2Gas":56766},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":2048,"l2Gas":30910},"billedGas":{"daGas":3072,"l2Gas":56766}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":2,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":163.58749399999942} 14:22:32 [14:22:32.480] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.18713865999999688s {"duration":0.18713865999999688,"rate":165171.64331517878,"totalPublicGas":{"daGas":2048,"l2Gas":30910},"totalBlockGas":{"daGas":3072,"l2Gas":56766},"totalSizeInBytes":544} 14:22:32 [14:22:32.619] INFO: sequencer Built block 6 for slot 6 with 1 txs and 0 messages. 90496.69522523109 mana/s {"blockHash":"0x0fe5d7d21286b7b3b238d1b1a703fce570807769e0c2ff5a8fbdd4aa2ff1049c","globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":6,"slotNumber":6,"timestamp":1750256927,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x041dde421fc9937238ba7ac67a82df3de97c425e2b2ab2c7d9e78e39376cadf9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":341.05565399999614,"publicProcessDuration":187.69640100000106,"rollupCircuitsDuration":327.8900530000028,"txCount":1,"blockNumber":6,"blockTimestamp":1750256927,"privateLogCount":0,"publicLogCount":2,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:32 [14:22:32.626] VERBOSE: sequencer Attesting committee is empty 14:22:32 [14:22:32.902] VERBOSE: sequencer-client Sent L1 transaction 0x13fca3aecb787f3d1ae02b42f3934b90d8ebe7f800ffa8485c550ddc9685daae {"gasLimit":470277,"maxFeePerGas":"1.241215624","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:22:32 [14:22:32.914] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256963] on http://127.0.0.1:8545 14:22:32 [14:22:32.917] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:32 [14:22:32.919] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:32 [14:22:32.920] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x13fca3aecb787f3d1ae02b42f3934b90d8ebe7f800ffa8485c550ddc9685daae","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":6,"blockTimestamp":1750256927,"privateLogCount":0,"publicLogCount":2,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:32 [14:22:32.920] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:32 [14:22:32.924] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256963 14:22:32 [14:22:32.924] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 14:22:32 [14:22:32.926] INFO: blob-sink:server Received blob sidecar for block 0x62e10ba831718b6d2d565b4a782ca04d3c9b5960fd3a810ef184e52c2b4e5a74 14:22:32 [14:22:32.931] INFO: blob-sink:server Blob sidecar stored successfully for block 0x62e10ba831718b6d2d565b4a782ca04d3c9b5960fd3a810ef184e52c2b4e5a74 14:22:33 [14:22:33.107] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on http://127.0.0.1:8545 14:22:33 [14:22:33.108] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 14:22:33 [14:22:33.110] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 14:22:33 [14:22:33.601] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x0fe5d7d21286b7b3b238d1b1a703fce570807769e0c2ff5a8fbdd4aa2ff1049c","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":6,"slotNumber":6,"timestamp":1750256927,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x1e3aad0a9a21c5631a0a64e145d466d6fc4702efea2bcb5262d8bcc6acae97e0","archiveNextLeafIndex":7} 14:22:33 [14:22:33.603] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 14:22:33 [14:22:33.715] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":14.446366000003763,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750256927,"privateLogCount":0,"publicLogCount":2,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:33 [14:22:33.725] VERBOSE: p2p Synched to latest block 6 14:22:33 [14:22:33.785] INFO: e2e:manual_public Running test: e2e_nested_contract manual executes public calls in expected order 14:22:33 [14:22:33.810] VERBOSE: pxe:service Updated pxe last block to 6 {"blockHash":{},"archive":"0x1e3aad0a9a21c5631a0a64e145d466d6fc4702efea2bcb5262d8bcc6acae97e0","header":{"contentCommitment":{"blobsHash":"0x00259aa15b8a78d48427e05245f61da2e47b081e60dc732463f44bc0dc66c49f","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750256927,"version":2957328342},"lastArchive":"0x05540ebaa628cd8e3a4950c7364be341e0d22756a07da94125cd2bb7aad6e840","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1f41b7ea2d52ca0e2256640958d536cf1acda6e7c9af5792fe262ab19a82fbb9","nullifierTree":"0x04aabfe237176fac4a697496d8e038b1a46960bf37d9939205f2f4e306707378","publicDataTree":"0x231d65e19c45c44f45f470b7363070b0d23015d7270e9a4605aded7f040bae41"},"totalFees":2878036200,"totalManaUsed":56766}} 14:22:33 [14:22:33.901] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:33 [14:22:33.936] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:33 [14:22:33.937] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:33 [14:22:33.988] VERBOSE: sequencer Not enough txs to build block 7 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1e3aad0a9a21c5631a0a64e145d466d6fc4702efea2bcb5262d8bcc6acae97e0","blockNumber":7,"slot":7} 14:22:33 [14:22:33.994] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec"} 14:22:34 [14:22:34.000] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1d1a59f7a643b5ec854ebf5a87e162e45aeb0b5a88d97cc8db4b723310c1927a 14:22:34 [14:22:34.007] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:22:34 [14:22:34.008] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:22:34 [14:22:34.017] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:22:34 [14:22:34.018] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:22:34 [14:22:34.021] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x04f929cc6b6572216207e5cce59436353ab926a19946966bfe77c27a012a6657","nullifier":"0x0c762b2e36f59ce4fee1a0507dd0dabd7e757be6328c408310c7d6b5920d39f4"} 14:22:34 [14:22:34.022] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:34 [14:22:34.037] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0ff3d8dd7a1d25bdc2f513dc22ace6a166553e95a00ad733ec45501e7de2c5ec as fee payer 14:22:34 [14:22:34.254] VERBOSE: simulator:private_execution Executing private function Parent:enqueue_call_to_child {"contract":"0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563"} 14:22:34 [14:22:34.269] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:34 [14:22:34.270] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563"} 14:22:34 [14:22:34.383] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2603dae75f537f530da6b7f8a1e6032b90838916e4a7346c25501446d7653563"} 14:22:34 [14:22:34.390] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:34 [14:22:34.781] VERBOSE: sequencer Not enough txs to build block 7 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1e3aad0a9a21c5631a0a64e145d466d6fc4702efea2bcb5262d8bcc6acae97e0","blockNumber":7,"slot":7} 14:22:35 [14:22:35.559] INFO: pxe:service Proving completed in 1758.6668559999962ms {"timings":{"total":1758.6668559999962,"sync":10.569680000000517,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":304.3184669999973,"oracles":{"debugLog":{"times":[0.6531729999987874,0.3111460000000079,0.29092499999387655,0.3976579999944079,0.333225999995193,0.2875160000039614,0.36488700000336394,0.6945839999971213]},"fetchTaggedLogs":{"times":[61.126517999997304]},"loadCapsule":{"times":[0.2077339999959804,0.13251199999649543,0.3157260000007227,0.21250500000314787,0.14655299999867566,0.16126300000178162]},"getSharedSecret":{"times":[2.440338000000338]},"aes128Decrypt":{"times":[0.2633659999992233,0.6614130000016303]},"getPublicKeysAndPartialAddress":{"times":[2.060110000005807]},"getKeyValidationRequest":{"times":[4.869496999999683]},"deliverNote":{"times":[2.897326999998768]},"deleteCapsule":{"times":[0.26688499999727355]},"storeCapsule":{"times":[0.2089239999986603]},"getNotes":{"times":[1.0361510000002454]},"getAuthWitness":{"times":[0.19211400000494905]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07457199999771547]},"notifyEnqueuedPublicFunctionCall":{"times":[0.1000220000059926]},"callPrivateFunction":{"times":[357.01822900000116]}}},{"functionName":"private_kernel_init","time":76.29811899999913},{"functionName":"Parent:enqueue_call_to_child","time":274.90589600000385,"oracles":{"debugLog":{"times":[0.5924509999967995,0.4505189999981667]},"fetchTaggedLogs":{"times":[117.35584099999687]},"loadCapsule":{"times":[1.7805559999978868,0.32780600000114646,0.3010260000010021]},"storeInExecutionCache":{"times":[0.045670999999856576]},"notifyEnqueuedPublicFunctionCall":{"times":[0.049580999999307096]}}},{"functionName":"private_kernel_inner","time":139.63077100000373},{"functionName":"private_kernel_reset","time":179.877797000001},{"functionName":"private_kernel_tail","time":112.31329999999434}],"unaccounted":660.7528259999963}} 14:22:35 [14:22:35.633] VERBOSE: sequencer Not enough txs to build block 7 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1e3aad0a9a21c5631a0a64e145d466d6fc4702efea2bcb5262d8bcc6acae97e0","blockNumber":7,"slot":7} 14:22:35 [14:22:35.639] VERBOSE: p2p:tx_pool Adding tx 0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff to pool {"eventName":"tx-added-to-pool","txHash":"0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226413,"feePaymentMethod":"fee_juice"} 14:22:35 [14:22:35.649] INFO: node Received tx 0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff {"txHash":"0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff"} 14:22:35 [14:22:35.650] INFO: pxe:service Sent transaction 0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff 14:22:36 [14:22:36.171] VERBOSE: sequencer Building block 7 for slot 7 {"slot":7,"blockNumber":7,"msgCount":0} 14:22:36 [14:22:36.185] VERBOSE: sequencer Processing pending txs {"slot":7,"slotStart":"2025-06-18T14:29:23.000Z","now":"2025-06-18T14:22:36.185Z"} 14:22:36 [14:22:36.230] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xeb1e3342 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xeb1e3342","duration":22.88919299999543} 14:22:36 [14:22:36.259] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xeb1e3342 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xeb1e3342","duration":28.68678400000499} 14:22:36 [14:22:36.290] VERBOSE: simulator:public-processor Processed tx 0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff with 2 public calls in 90.1309240000046ms {"txHash":"0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff","txFee":3178180200,"revertCode":0,"gasUsed":{"totalGas":{"daGas":3072,"l2Gas":62686},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":2048,"l2Gas":16830},"billedGas":{"daGas":3072,"l2Gas":62686}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":2,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":90.1309240000046} 14:22:36 [14:22:36.292] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10625160699999833s {"duration":0.10625160699999833,"rate":158397.60428282522,"totalPublicGas":{"daGas":2048,"l2Gas":16830},"totalBlockGas":{"daGas":3072,"l2Gas":62686},"totalSizeInBytes":544} 14:22:36 [14:22:36.445] INFO: sequencer Built block 7 for slot 7 with 1 txs and 0 messages. 61367.703204608144 mana/s {"blockHash":"0x11c535843d50e364c4d7c9db7b4b4507f8d8288177f34239cdd4452870349c8a","globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":7,"slotNumber":7,"timestamp":1750256963,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x20213eb78891b5032e2d6882636c51f93e7b1238c219fb41406a14e3de4a1fff"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":273.50594600000477,"publicProcessDuration":106.77571799999714,"rollupCircuitsDuration":260.85342399999354,"txCount":1,"blockNumber":7,"blockTimestamp":1750256963,"privateLogCount":0,"publicLogCount":2,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:36 [14:22:36.449] VERBOSE: sequencer Attesting committee is empty 14:22:36 [14:22:36.758] VERBOSE: sequencer-client Sent L1 transaction 0xa49f11a3b3d0dd66276ed34bcb9409581b754b246d02559a384e2b1a1cdb0f90 {"gasLimit":470229,"maxFeePerGas":"1.231657581","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:22:36 [14:22:36.771] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:36 [14:22:36.772] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xa49f11a3b3d0dd66276ed34bcb9409581b754b246d02559a384e2b1a1cdb0f90","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":7,"blockTimestamp":1750256963,"privateLogCount":0,"publicLogCount":2,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:36 [14:22:36.772] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:36 [14:22:36.779] INFO: blob-sink:server Received blob sidecar for block 0x5ae209c26b4aab2d3b478987452a9b7d914bca6c9e17f9d27d80858ad40c07e9 14:22:36 [14:22:36.784] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5ae209c26b4aab2d3b478987452a9b7d914bca6c9e17f9d27d80858ad40c07e9 14:22:36 [14:22:36.787] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256999] on http://127.0.0.1:8545 14:22:36 [14:22:36.788] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:36 [14:22:36.789] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256999 14:22:36 [14:22:36.790] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 14:22:36 [14:22:36.847] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on http://127.0.0.1:8545 14:22:36 [14:22:36.848] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 14:22:36 [14:22:36.849] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 14:22:37 [14:22:37.313] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x11c535843d50e364c4d7c9db7b4b4507f8d8288177f34239cdd4452870349c8a","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":2957328342,"blockNumber":7,"slotNumber":7,"timestamp":1750256963,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0d81e75161a3572e164c3edd968a438338e73fc201b535d8e901e8fa29f2582f","archiveNextLeafIndex":8} 14:22:37 [14:22:37.323] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 14:22:37 [14:22:37.419] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":7.155478000000585,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750256963,"privateLogCount":0,"publicLogCount":2,"contractClassLogCount":0,"contractClassLogSize":0} 14:22:37 [14:22:37.433] VERBOSE: p2p Synched to latest block 7 14:22:37 [14:22:37.662] INFO: e2e:e2e_nested_contract Tearing down subsystems 14:22:37 [14:22:37.663] INFO: node Stopping 14:22:37 [14:22:37.664] INFO: slasher Slasher client stopped. 14:22:37 [14:22:37.664] INFO: sequencer Stopped sequencer 14:22:37 [14:22:37.664] INFO: p2p P2P client stopped. 14:22:37 [14:22:37.666] INFO: world_state Stopped world state synchronizer 14:22:37 [14:22:37.667] INFO: archiver Stopped. 14:22:37 [14:22:37.667] INFO: node Stopped 14:22:37 [14:22:37.667] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Cleaning up ACVM temp directory /tmp/690bc597 14:22:37 [14:22:37.686] INFO: blob-sink:server Stopping blob sink 14:22:37 [14:22:37.687] INFO: blob-sink:server Blob sink stopped 14:22:37 PASS src/e2e_nested_contract/manual_public.test.ts 14:22:37 e2e_nested_contract manual 14:22:37 ✓ performs public nested calls (3568 ms) 14:22:37 ✓ reads fresh value after write within the same tx (3338 ms) 14:22:37 ✓ executes public calls in expected order (3876 ms) 14:22:37 14:22:37 Test Suites: 1 passed, 1 total 14:22:37 Tests: 3 passed, 3 total 14:22:37 Snapshots: 0 total 14:22:37 Time: 46.073 s 14:22:37 Ran all test suites matching /src\/e2e_nested_contract\/manual_public.test.ts/i. 14:22:37 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?