Parent Log: http://ci.aztec-labs.com/8e8dd02b40b54e5e Command: 97e7ef9a556fd7e6:ISOLATE=1:NAME=e2e_nested_contract/manual_private_call yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_nested_contract/manual_private_call.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/cf4d4501e7edfb97cb6406ee7f30893939a522f9 Env: REF_NAME=gh-readonly-queue/master/pr-14912-015cb0cadef6a41094c3649f32a735392e1b9693 CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Wed Jun 18 15:31:32 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14912_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_90fb6749f0a6bca0_master 15:31:32 +++ id -u 15:31:32 +++ id -g 15:31:32 ++ docker run -d --name e2e_nested_contract_manual_private_call --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_private_call.test.ts'\''' 15:31:32 + cid=0945ab5a8d0de665453d455e99a689f9ee77c0cccb65cc1f38408e3fcf4dffc6 15:31:32 + set +x 15:31:33 {"level":25,"time":1750260693722,"pid":12,"hostname":"0945ab5a8d0d","module":"logger","msg":"Logger initialized with level verbose"} 15:31:41 [15:31:41.929] WARN: e2e:snapshot_manager:e2e_nested_contract/manual-1 No data path given, will not persist any snapshots. 15:31:41 [15:31:41.983] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Initializing state... 15:31:41 [15:31:41.988] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Starting anvil... 15:31:42 [15:31:42.116] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deploying L1 contracts... 15:31:42 [15:31:42.987] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-actp3u/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:31:43 [15:31:43.043] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Calling anvil_setBlockTimestampInterval with params: [12] 15:31:43 [15:31:43.082] WARN: e2e:snapshot_manager:e2e_nested_contract/manual-1 Set block interval to 12 15:31:43 [15:31:43.083] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:31:43 [15:31:43.161] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:31:43 [15:31:43.173] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:31:43 [15:31:43.201] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:31:43 [15:31:43.210] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:31:43 [15:31:43.235] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:31:43 [15:31:43.242] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:31:43 [15:31:43.260] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:31:43 [15:31:43.265] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:31:43 [15:31:43.290] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 15:31:43 [15:31:43.299] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:31:43 [15:31:43.317] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 15:31:43 [15:31:43.327] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:31:43 [15:31:43.329] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for deployments to complete 15:31:43 [15:31:43.333] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 6 transactions to be mined... 15:31:43 [15:31:43.375] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 15:31:43 [15:31:43.399] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 15:31:43 [15:31:43.400] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 15:31:43 [15:31:43.420] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 15:31:43 [15:31:43.443] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 15:31:43 [15:31:43.451] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 15:31:43 [15:31:43.473] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 15:31:43 [15:31:43.483] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 15:31:43 [15:31:43.525] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 15:31:43 [15:31:43.538] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:31:43 [15:31:43.560] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 15:31:43 [15:31:43.561] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 15:31:43 [15:31:43.561] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for deployments to complete 15:31:43 [15:31:43.561] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 8 transactions to be mined... 15:31:43 [15:31:43.587] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 15:31:43 [15:31:43.598] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed shared contracts 15:31:43 [15:31:43.615] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 15:31:43 [15:31:43.615] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 15:31:43 [15:31:43.619] 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} 15:31:43 [15:31:43.645] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 15:31:43 [15:31:43.686] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 15:31:43 [15:31:43.693] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Awaiting for linked libraries to be deployed 15:31:43 [15:31:43.757] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x694ba2a2fabc2411e168ae2b97bc9f602c12a100846d4a492e0c4d973d945e74 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 15:31:43 [15:31:43.772] 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} 15:31:43 [15:31:43.773] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 9 transactions to be mined... 15:31:43 [15:31:43.803] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 15:31:43 [15:31:43.804] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 All core contracts have been deployed 15:31:43 [15:31:43.828] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xbd01daccbcf5983a6ba91804e7473977cce191320d0d8e2da4627ddd5bb6d2ae {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 15:31:43 [15:31:43.829] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Funding fee juice portal with 110000000000000000000000 fee juice in 0xbd01daccbcf5983a6ba91804e7473977cce191320d0d8e2da4627ddd5bb6d2ae (accelerated test deployments) 15:31:43 [15:31:43.859] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 15:31:43 [15:31:43.865] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 15:31:43 [15:31:43.921] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 15:31:43 [15:31:43.922] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 15:31:43 [15:31:43.922] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 10 transactions to be mined... 15:31:43 [15:31:43.959] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 15:31:43 [15:31:43.970] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Rollup deployed 15:31:43 [15:31:43.970] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for rollup and slash factory to be deployed 15:31:43 [15:31:43.970] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 10 transactions to be mined... 15:31:44 [15:31:44.002] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 15:31:44 [15:31:44.002] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions for L1 deployment have been mined 15:31:44 [15:31:44.041] 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"} 15:31:44 [15:31:44.045] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 15:31:44 [15:31:44.048] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 15:31:44 [15:31:44.063] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/97e7c57c/acvm 15:31:44 [15:31:44.070] INFO: telemetry:client Using NoopTelemetryClient 15:31:44 [15:31:44.076] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/c8fef158863c55ab/blob-sink with map size 134217728 KB (LMDB v2) 15:31:44 [15:31:44.089] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:31:44 [15:31:44.103] INFO: blob-sink:server Server is running on http://localhost:46781 15:31:44 [15:31:44.104] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Creating and synching an aztec node... 15:31:44 [15:31:44.105] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://127.0.0.1:46781"} 15:31:44 [15:31:44.149] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:31:44 [15:31:44.154] INFO: archiver:lmdb Creating archiver data store at directory /tmp/c8fef158863c55ab/archiver with map size 134217728 KB (LMDB v2) 15:31:44 [15:31:44.158] INFO: archiver:lmdb Starting data store with maxReaders 16 15:31:44 [15:31:44.613] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://127.0.0.1:46781"} 15:31:44 [15:31:44.634] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://127.0.0.1:46781"} 15:31:44 [15:31:44.635] WARN: node:blob-sink:client No L1 consensus host urls configured 15:31:44 [15:31:44.635] WARN: node:blob-sink:client No archive client configured 15:31:44 [15:31:44.641] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 19 with hash 0x41baf377c06f8506be3c976a1d363c7e791b7eb78e8924c843d818edcade477a {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x96209a6b959b47a56752533712061929cce4548035862614704c73e6c3180c85","l1BlockNumber":16}} 15:31:44 [15:31:44.669] INFO: archiver Initial archiver sync to L1 block 19 complete. {"l1BlockNumber":19,"syncPoint":{"blocksSynchedTo":19},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:31:44 [15:31:44.701] INFO: world-state:database Creating world state data store at directory /tmp/c8fef158863c55ab/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:31:44 [15:31:44.748] INFO: world_state Created world state synchroniser with block history of 64 15:31:44 [15:31:44.749] WARN: node Aztec node is accepting fake proofs 15:31:44 [15:31:44.763] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/c8fef158863c55ab/p2p with map size 134217728 KB (LMDB v2) 15:31:44 [15:31:44.767] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:31:44 [15:31:44.769] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/c8fef158863c55ab/p2p-archive with map size 134217728 KB (LMDB v2) 15:31:44 [15:31:44.771] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:31:44 [15:31:44.772] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/c8fef158863c55ab/p2p-peers with map size 134217728 KB (LMDB v2) 15:31:44 [15:31:44.773] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:31:44 [15:31:44.775] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:31:44 [15:31:44.776] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:31:44 [15:31:44.779] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:31:44 [15:31:44.780] INFO: world_state Started world state synchronizer from block 1 15:31:44 [15:31:44.782] VERBOSE: world-state:block_stream Starting sync from block number 0 15:31:44 [15:31:44.788] INFO: p2p Starting p2p client from block 0 with empty mempools 15:31:44 [15:31:44.789] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:31:44 [15:31:44.791] INFO: slasher Slasher client initialized 15:31:44 [15:31:44.791] INFO: slasher Starting Slasher client... 15:31:44 [15:31:44.854] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:31:44 [15:31:44.854] VERBOSE: node All Aztec Node subsystems synced 15:31:44 [15:31:44.868] INFO: sequencer-client Deploying forwarder contract 15:31:44 [15:31:44.877] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:31:44 [15:31:44.915] VERBOSE: sequencer-client Sent L1 transaction 0x76bde6988e4024633a8681e88eac509c66759e12da8897a0ef88bc765edc52fb {"gasLimit":436981,"maxFeePerGas":"38.512961458","maxPriorityFeePerGas":"38.337599913"} 15:31:44 [15:31:44.915] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0x76bde6988e4024633a8681e88eac509c66759e12da8897a0ef88bc765edc52fb. 15:31:44 [15:31:44.922] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:31:44 [15:31:44.955] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:31:44 [15:31:44.956] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 15:31:44 [15:31:44.957] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/97e7c57c/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:31:45 [15:31:45.203] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:31:45 [15:31:45.206] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:31:45 [15:31:45.208] INFO: node Aztec Node version: 0.87.9 15:31:45 [15:31:45.208] 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"} 15:31:45 [15:31:45.209] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Creating pxe... 15:31:45 [15:31:45.231] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/c8fef158863c55ab/797198784c575f01/pxe_data with map size 134217728 KB (LMDB v2) 15:31:45 [15:31:45.248] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x294d2b03eac2b61ef83c3bdc13376cc5f2b8e7df2b33fac1cb54dc34f8eebcf3","blockNumber":1,"slot":1} 15:31:45 [15:31:45.251] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:31:45 [15:31:45.583] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:31:45 [15:31:45.585] INFO: pxe:service Started PXE connected to chain 31337 version 1311980022 15:31:45 [15:31:45.585] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for accounts... 15:31:45 [15:31:45.586] VERBOSE: e2e:e2e_nested_contract:manual Deploying accounts funded with fee juice... 15:31:45 [15:31:45.646] INFO: pxe:service Registered account 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 15:31:45 [15:31:45.723] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 15:31:45 [15:31:45.725] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 15:31:45 [15:31:45.883] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x294d2b03eac2b61ef83c3bdc13376cc5f2b8e7df2b33fac1cb54dc34f8eebcf3","blockNumber":1,"slot":1} 15:31:45 [15:31:45.886] INFO: pxe:service Added contract SchnorrAccount at 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:31:45 [15:31:45.944] VERBOSE: pxe:block_stream Starting sync from block number 0 15:31:45 [15:31:45.977] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:31:46 [15:31:46.081] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:31:46 [15:31:46.848] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:31:46 [15:31:46.985] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:31:47 [15:31:47.212] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x294d2b03eac2b61ef83c3bdc13376cc5f2b8e7df2b33fac1cb54dc34f8eebcf3","blockNumber":1,"slot":1} 15:31:47 [15:31:47.366] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:47 [15:31:47.427] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:31:47 [15:31:47.428] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:47 [15:31:47.503] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:47 [15:31:47.513] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:31:47 [15:31:47.719] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:47 [15:31:47.763] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:31:47 [15:31:47.763] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:47 [15:31:47.810] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x294d2b03eac2b61ef83c3bdc13376cc5f2b8e7df2b33fac1cb54dc34f8eebcf3","blockNumber":1,"slot":1} 15:31:47 [15:31:47.844] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:47 [15:31:47.853] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:31:47 [15:31:47.875] VERBOSE: simulator:client_execution_context:debug_log Setting 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 as fee payer 15:31:48 [15:31:48.701] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x294d2b03eac2b61ef83c3bdc13376cc5f2b8e7df2b33fac1cb54dc34f8eebcf3","blockNumber":1,"slot":1} 15:31:49 [15:31:49.545] INFO: pxe:service Proving completed in 3611.86967ms {"timings":{"total":3611.86967,"sync":11.72276199999942,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":165.64581499999804,"oracles":{"callPrivateFunction":{"times":[1096.2406249999985,501.82142300000123,267.93206999999893]}}},{"functionName":"private_kernel_init","time":138.10917700000027},{"functionName":"ContractClassRegisterer:register","time":1075.4619470000016,"oracles":{"loadCapsule":{"times":[50.909905000000435]},"notifyCreatedNullifier":{"times":[19.33759100000134]},"debugLog":{"times":[1.040524000000005]},"notifyCreatedContractClassLog":{"times":[14.606649999999718]}}},{"functionName":"private_kernel_inner","time":199.4509820000003},{"functionName":"SchnorrAccount:constructor","time":468.7999519999994,"oracles":{"getContractInstance":{"times":[3.9090799999994488]},"debugLog":{"times":[0.9736400000001595,0.5133109999987937]},"fetchTaggedLogs":{"times":[78.70712800000001]},"loadCapsule":{"times":[1.6225800000011077,0.26531600000089384,0.22240299999975832]},"notifyCreatedNullifier":{"times":[0.2392039999995177,0.33390999999937776]},"notifyCreatedNote":{"times":[0.45913800000016636]},"getRandomField":{"times":[0.49104999999872234,0.2556650000005902,0.07903500000065833,0.08680500000082247,0.10550599999987753,0.07588500000019849,0.07902500000091095,0.08730500000092434,0.07919399999991583,0.09807700000055775,0.06194400000094902]},"getIndexedTaggingSecretAsSender":{"times":[38.58544400000028]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.72707799999989]}}},{"functionName":"private_kernel_inner","time":176.29970500000127},{"functionName":"SchnorrAccount:entrypoint","time":236.1392479999995,"oracles":{"debugLog":{"times":[0.6853019999998651,0.7898880000011559,0.8982450000003155]},"fetchTaggedLogs":{"times":[87.71845700000085]},"loadCapsule":{"times":[0.4508269999987533,0.777656999998726,2.0148319999989326]},"getNotes":{"times":[4.24547800000073]},"getAuthWitness":{"times":[0.37395199999991746]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.2353349999993952]}}},{"functionName":"private_kernel_inner","time":193.2796670000007},{"functionName":"private_kernel_reset","time":250.11881899999935},{"functionName":"private_kernel_tail","time":100.27239799999734}],"unaccounted":596.5691980000029}} 15:31:49 [15:31:49.687] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x294d2b03eac2b61ef83c3bdc13376cc5f2b8e7df2b33fac1cb54dc34f8eebcf3","blockNumber":1,"slot":1} 15:31:49 [15:31:49.784] VERBOSE: p2p:tx_pool Adding tx 0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95 to pool {"eventName":"tx-added-to-pool","txHash":"0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:31:49 [15:31:49.839] INFO: node Received tx 0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95 {"txHash":"0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95"} 15:31:49 [15:31:49.839] INFO: pxe:service Sent transaction 0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95 15:31:50 [15:31:50.253] VERBOSE: sequencer Building block 1 for slot 1 {"slot":1,"blockNumber":1,"msgCount":0} 15:31:50 [15:31:50.291] VERBOSE: sequencer Processing pending txs {"slot":1,"slotStart":"2025-06-18T15:35:30.000Z","now":"2025-06-18T15:31:50.291Z"} 15:31:50 [15:31:50.620] VERBOSE: simulator:public-processor Processed tx 0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95 with no public calls in 226.37157600000137ms {"txHash":"0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95","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":226.37157600000137} 15:31:50 [15:31:50.626] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3329413379999969s {"duration":0.3329413379999969,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 15:31:50 [15:31:50.829] INFO: sequencer Built block 1 for slot 1 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2311348f6a886194a999301b72e868cee7a21c887a72b42731b185d7fba027e0","globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":1,"slotNumber":1,"timestamp":1750260930,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1ab23e24eb70ff27442984a601aede515398337248903c412c970634d1467e95"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":578.4478769999987,"publicProcessDuration":334.34270299999844,"rollupCircuitsDuration":543.1206700000002,"txCount":1,"blockNumber":1,"blockTimestamp":1750260930,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:31:50 [15:31:50.833] VERBOSE: sequencer Attesting committee is empty 15:31:51 [15:31:51.312] VERBOSE: sequencer-client Sent L1 transaction 0x23364dee5719f743d95c093c478fb0bc1b337695f61703b10782e52b95dd09ef {"gasLimit":514556,"maxFeePerGas":"46.158703672","maxPriorityFeePerGas":"46.005119895","maxFeePerBlobGas":"0.000000001"} 15:31:51 [15:31:51.331] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:31:51 [15:31:51.333] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x23364dee5719f743d95c093c478fb0bc1b337695f61703b10782e52b95dd09ef","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1750260930,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:31:51 [15:31:51.334] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:31:51 [15:31:51.341] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260966] on http://127.0.0.1:8545 15:31:51 [15:31:51.345] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:31:51 [15:31:51.347] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750260966 15:31:51 [15:31:51.347] INFO: aztecjs:utils:watcher Slot 1 was filled, jumped to next slot 15:31:51 [15:31:51.361] INFO: blob-sink:server Received blob sidecar for block 0x19ce4e878e53f5fbd983be89bb55627faeb8b9e11e14e635989abc6b8b99a33a 15:31:51 [15:31:51.374] INFO: blob-sink:server Blob sidecar stored successfully for block 0x19ce4e878e53f5fbd983be89bb55627faeb8b9e11e14e635989abc6b8b99a33a 15:31:51 [15:31:51.514] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 15:31:51 [15:31:51.516] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:31:51 [15:31:51.519] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:31:51 [15:31:51.863] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:31:51 [15:31:51.878] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2311348f6a886194a999301b72e868cee7a21c887a72b42731b185d7fba027e0","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":1,"slotNumber":1,"timestamp":1750260930,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2a9da6bc471cf34f35cc474e6e8b7e05fae581215a86e50e4130aaaa2a9dccfb","archiveNextLeafIndex":2} 15:31:51 [15:31:51.899] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:31:51 [15:31:51.959] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for accounts complete. 15:31:51 [15:31:51.977] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.421736000000237,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750260930,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:31:51 [15:31:51.981] VERBOSE: e2e:e2e_nested_contract:manual Wallet 0 address: 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 15:31:51 [15:31:51.981] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for public_deploy... 15:31:51 [15:31:51.982] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for public_deploy complete. 15:31:51 [15:31:51.982] VERBOSE: e2e:e2e_nested_contract:manual Public deploy accounts... 15:31:52 [15:31:52.044] VERBOSE: p2p Synched to latest block 1 15:31:52 [15:31:52.182] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2a9da6bc471cf34f35cc474e6e8b7e05fae581215a86e50e4130aaaa2a9dccfb","header":{"contentCommitment":{"blobsHash":"0x00a0989fc3b1da13f86f6a7e540b93395902f367e5d0c02c195076330300ccb4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750260930,"version":1311980022},"lastArchive":"0x294d2b03eac2b61ef83c3bdc13376cc5f2b8e7df2b33fac1cb54dc34f8eebcf3","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x06a69d142443d76ccba12721747a4ae2b3f2aa039c007a0fe4c0050c7e703b41","nullifierTree":"0x225ed8cf1f49ba23d80c1b49a18b12b8a69739981c006ba2b6af949bf644c06a","publicDataTree":"0x08b33d1bba1e1309b34806806cb4a811f32c07ce75a69ff0f90285050e2cfebf"},"totalFees":6794052480,"totalManaUsed":20448}} 15:31:52 [15:31:52.292] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:52 [15:31:52.348] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:31:52 [15:31:52.349] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:52 [15:31:52.452] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a9da6bc471cf34f35cc474e6e8b7e05fae581215a86e50e4130aaaa2a9dccfb","blockNumber":2,"slot":2} 15:31:52 [15:31:52.480] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:52 [15:31:52.495] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x08354c9281a53e0a323a365d19954ec92ee7dd701fe774d8977e346ac63c1b31 15:31:52 [15:31:52.513] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:31:52 [15:31:52.514] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:31:52 [15:31:52.528] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:31:52 [15:31:52.529] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:31:52 [15:31:52.537] VERBOSE: pxe:service Added note {"index":0,"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x190b926d1df34fa798ce6f076c0dd04d7026da68549ed01213ce194fe68daca8","nullifier":"0x0ac366212c6501ca4e1a6253c55c06a8c5e2baf720122199d5132dc068ded65a"} 15:31:52 [15:31:52.539] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:31:52 [15:31:52.562] VERBOSE: simulator:client_execution_context:debug_log Setting 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 as fee payer 15:31:52 [15:31:52.605] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:31:52 [15:31:52.662] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:31:52 [15:31:52.679] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201,0x0000000000000000000000000000000000000000000000000000000000000001,0x249ae080d5dfc5c70c7f9068b47f793dbc6135d6f2796477ca50aa8ac5465601,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x05a7b0c6e2b5b1915a137d6606fbd1bfef93f03e1691dca4b40077019e59ecdc,0x1e574c7d2fecb7141f956d5ac60e2a87548a040d27b7d89d20eed7694cd727ec,0x0a7b9034cc9c9d10f3a0d32851cf5c5336397e13d2c4967b864b8098283634d5,0x06cb30286dd8c80497a1bc3f291131f6f9dfa61fdebfaf7f89bfe39d6f1612d0,0x0d57494a895dc817dcbdb9c1eb835c501e7701e2711c5f2d2ef2c9a277116c53,0x0e5494fb0a9b789fdfb295e85833f50f6929c56e52bc0c8e89ff9ea93085cce2,0x08338d843a8e6bb159a0b70b39afc1506e7d109a90db998d8f6446d11006f589,0x18f47d3ffd1650e5b770a8910aacb9d3119e4d103ccac4c9ea10fe6734b48ead,0x14a09bd28c00d770afcc7f575954174a9c401763b638621000e303ef0ec54595,0x0000000000000000000000000000000000000000000000000000000000000000 15:31:53 [15:31:53.292] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a9da6bc471cf34f35cc474e6e8b7e05fae581215a86e50e4130aaaa2a9dccfb","blockNumber":2,"slot":2} 15:31:53 [15:31:53.798] INFO: pxe:service Proving completed in 1624.068041999999ms {"timings":{"total":1624.068041999999,"sync":10.76834400000007,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":365.491575,"oracles":{"debugLog":{"times":[0.9235159999989264,0.415076000001136,0.6227269999981218,0.5801460000002407,0.47191899999961606,0.8764130000017758,0.36977200000183075,0.7685469999996712]},"fetchTaggedLogs":{"times":[140.46028900000238]},"loadCapsule":{"times":[3.633441000001767,0.4269060000005993,0.5068009999995411,0.4046349999989616,0.20253300000331365,0.24680499999885797]},"getSharedSecret":{"times":[10.27298399999927]},"aes128Decrypt":{"times":[0.9673479999983101,0.9656979999999749]},"getPublicKeysAndPartialAddress":{"times":[7.150625000002037]},"getKeyValidationRequest":{"times":[3.6059190000014496]},"deliverNote":{"times":[7.338076000000001]},"deleteCapsule":{"times":[0.42996599999969476]},"storeCapsule":{"times":[0.4126650000034715]},"getNotes":{"times":[5.631452000001445]},"getAuthWitness":{"times":[0.29632800000035786]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08748500000001513]},"callPrivateFunction":{"times":[121.94666599999982]}}},{"functionName":"private_kernel_init","time":88.69017600000006},{"functionName":"ContractInstanceDeployer:deploy","time":67.58316299999933,"oracles":{"storeInExecutionCache":{"times":[0.7401050000007672]},"callPrivateFunction":{"times":[53.888042000002315]},"notifyCreatedNullifier":{"times":[0.4921189999986382]},"debugLog":{"times":[0.7280840000021271]}}},{"functionName":"private_kernel_inner","time":144.31760399999985},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.27683600000091,"oracles":{}},{"functionName":"private_kernel_inner","time":153.67032100000142},{"functionName":"private_kernel_reset","time":247.33025900000212},{"functionName":"private_kernel_tail","time":86.2969099999973}],"unaccounted":420.6428539999979}} 15:31:53 [15:31:53.866] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2a9da6bc471cf34f35cc474e6e8b7e05fae581215a86e50e4130aaaa2a9dccfb","blockNumber":2,"slot":2} 15:31:53 [15:31:53.877] VERBOSE: p2p:tx_pool Adding tx 0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f to pool {"eventName":"tx-added-to-pool","txHash":"0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 15:31:53 [15:31:53.882] INFO: node Received tx 0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f {"txHash":"0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f"} 15:31:53 [15:31:53.882] INFO: pxe:service Sent transaction 0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f 15:31:54 [15:31:54.407] VERBOSE: sequencer Building block 2 for slot 2 {"slot":2,"blockNumber":2,"msgCount":0} 15:31:54 [15:31:54.446] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T15:36:06.000Z","now":"2025-06-18T15:31:54.446Z"} 15:31:54 [15:31:54.521] VERBOSE: simulator:public-processor Processed tx 0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f with no public calls in 36.1734269999979ms {"txHash":"0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f","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":36.1734269999979} 15:31:54 [15:31:54.523] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.07616699499999958s {"duration":0.07616699499999958,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":9728,"l2Gas":11200},"totalSizeInBytes":832} 15:31:54 [15:31:54.676] INFO: sequencer Built block 2 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0d516adfa6179276c4defe7082121e03f84623a9a89e01e1cca210637c7f2d7d","globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":2,"slotNumber":2,"timestamp":1750260966,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2e51ac9a28c6b2dd7b4313c2661193ea189172bdbca78c2de3fdaab66d865c0f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":270.7471310000001,"publicProcessDuration":76.5934219999981,"rollupCircuitsDuration":238.00850300000093,"txCount":1,"blockNumber":2,"blockTimestamp":1750260966,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:31:54 [15:31:54.678] VERBOSE: sequencer Attesting committee is empty 15:31:54 [15:31:54.974] VERBOSE: sequencer-client Sent L1 transaction 0x5acfedada232456a3fbfbf55410bc9f17ac386d59b3638012b91dfe177989029 {"gasLimit":470283,"maxFeePerGas":"1.318412781","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:31:54 [15:31:54.993] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:31:54 [15:31:54.993] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x5acfedada232456a3fbfbf55410bc9f17ac386d59b3638012b91dfe177989029","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1750260966,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:31:54 [15:31:54.993] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:31:55 [15:31:55.010] INFO: blob-sink:server Received blob sidecar for block 0x30b54614dae601754770865ecdbd1671846f6bd125b2fde5920e26f210868843 15:31:55 [15:31:55.013] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261002] on http://127.0.0.1:8545 15:31:55 [15:31:55.016] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:31:55 [15:31:55.019] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261002 15:31:55 [15:31:55.019] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:31:55 [15:31:55.019] INFO: blob-sink:server Blob sidecar stored successfully for block 0x30b54614dae601754770865ecdbd1671846f6bd125b2fde5920e26f210868843 15:31:55 [15:31:55.173] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 15:31:55 [15:31:55.176] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 15:31:55 [15:31:55.182] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 15:31:55 [15:31:55.718] VERBOSE: archiver:block-helper Store contract instance at 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 15:31:55 [15:31:55.722] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0d516adfa6179276c4defe7082121e03f84623a9a89e01e1cca210637c7f2d7d","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":2,"slotNumber":2,"timestamp":1750260966,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","archiveNextLeafIndex":3} 15:31:55 [15:31:55.725] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 15:31:55 [15:31:55.829] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":12.209251000000222,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750260966,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:31:55 [15:31:55.839] VERBOSE: p2p Synched to latest block 2 15:31:55 [15:31:55.981] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for manual... 15:31:56 [15:31:56.139] WARN: pxe:service No artifact found for contract class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b when looking for its metadata 15:31:56 [15:31:56.142] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b as part of deployment for 0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e 15:31:56 [15:31:56.309] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","blockNumber":3,"slot":3} 15:31:56 [15:31:56.485] INFO: pxe:service Added contract Parent at 0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e with class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b 15:31:56 [15:31:56.517] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","header":{"contentCommitment":{"blobsHash":"0x005241aa38aa025f3ac5c2e7885dc61cffe60e492aa0a650532526c1241f65a3","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750260966,"version":1311980022},"lastArchive":"0x2a9da6bc471cf34f35cc474e6e8b7e05fae581215a86e50e4130aaaa2a9dccfb","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x06a69d142443d76ccba12721747a4ae2b3f2aa039c007a0fe4c0050c7e703b41","nullifierTree":"0x18bb7e42adf286326966865b399fd32ce915bedd9b4cd0fa2dbf590cc6a63618","publicDataTree":"0x058ce495db7133861dd7f5bb689baa3acb17aa8780dddbe4834639d88cf4685d"},"totalFees":3721312000,"totalManaUsed":11200}} 15:31:56 [15:31:56.680] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:56 [15:31:56.720] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:31:56 [15:31:56.721] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:56 [15:31:56.866] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:31:56 [15:31:56.889] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","blockNumber":3,"slot":3} 15:31:56 [15:31:56.899] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x08354c9281a53e0a323a365d19954ec92ee7dd701fe774d8977e346ac63c1b31 15:31:56 [15:31:56.915] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:31:56 [15:31:56.916] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:31:56 [15:31:56.935] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:31:56 [15:31:56.937] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:31:56 [15:31:56.963] VERBOSE: pxe:service Added note {"index":0,"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x190b926d1df34fa798ce6f076c0dd04d7026da68549ed01213ce194fe68daca8","nullifier":"0x0ac366212c6501ca4e1a6253c55c06a8c5e2baf720122199d5132dc068ded65a"} 15:31:56 [15:31:56.974] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:31:57 [15:31:57.018] VERBOSE: simulator:client_execution_context:debug_log Setting 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 as fee payer 15:31:57 [15:31:57.086] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:31:57 [15:31:57.697] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b,0x2fcc71bf82a0d2fb44c6e69c227f45ec3b849e42384f895d3e5264986023446a,0x046c8c9617995ee143a721d7e1e29705b90693ed664d0303750827345e2d2c06,0x0bd9d45bf91246ff3cab80ea1687192bffcfc1935fd339933d8d60154324397b 15:31:57 [15:31:57.831] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:31:57 [15:31:57.992] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:31:58 [15:31:58.003] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","blockNumber":3,"slot":3} 15:31:58 [15:31:58.071] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:31:58 [15:31:58.087] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e,0x0000000000000000000000000000000000000000000000000000000000000001,0x2b8a17e96bfd1d4f2368d841654d46fd1f94e6c674966d252475c2620598edd9,0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 15:31:58 [15:31:58.868] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","blockNumber":3,"slot":3} 15:31:59 [15:31:59.462] INFO: pxe:service Proving completed in 2954.542614000002ms {"timings":{"total":2954.542614000002,"sync":12.872701000000234,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":515.4834340000016,"oracles":{"debugLog":{"times":[1.261846000001242,0.5654450000001816,0.5251320000024862,0.48319899999842164,0.8096789999981411,0.5887359999978798,0.847061999997095,1.1850720000002184]},"fetchTaggedLogs":{"times":[175.04436999999962]},"loadCapsule":{"times":[1.2289449999989301,0.24525500000163447,0.4508769999993092,0.46257800000239513,4.026645000001736,2.0478949999996985]},"getSharedSecret":{"times":[4.081248000002233]},"aes128Decrypt":{"times":[0.3089490000020305,1.0535239999990154]},"getPublicKeysAndPartialAddress":{"times":[5.5562969999991765]},"getKeyValidationRequest":{"times":[9.299525000002177]},"deliverNote":{"times":[25.876122000001487]},"deleteCapsule":{"times":[1.0511340000011842]},"storeCapsule":{"times":[3.42305800000031]},"getNotes":{"times":[23.974606000003405]},"getAuthWitness":{"times":[0.853211999998166]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.12342699999862816]},"callPrivateFunction":{"times":[876.0449970000009,195.76692800000092]}}},{"functionName":"private_kernel_init","time":112.3598729999976},{"functionName":"ContractClassRegisterer:register","time":855.4213149999996,"oracles":{"loadCapsule":{"times":[7.0406980000007025]},"notifyCreatedNullifier":{"times":[0.4896499999995285]},"debugLog":{"times":[0.7409249999982421]},"notifyCreatedContractClassLog":{"times":[7.3966289999989385]}}},{"functionName":"private_kernel_inner","time":139.08151500000167},{"functionName":"ContractInstanceDeployer:deploy","time":107.8919309999983,"oracles":{"storeInExecutionCache":{"times":[0.0672340000019176]},"callPrivateFunction":{"times":[83.62327800000276]},"notifyCreatedNullifier":{"times":[0.3495619999994233]},"debugLog":{"times":[0.6507200000014564]}}},{"functionName":"private_kernel_inner","time":144.59483100000216},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":61.78794299999936,"oracles":{}},{"functionName":"private_kernel_inner","time":158.99160499999925},{"functionName":"private_kernel_reset","time":237.8330530000021},{"functionName":"private_kernel_tail","time":88.86141599999974}],"unaccounted":519.3629970000002}} 15:31:59 [15:31:59.735] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","blockNumber":3,"slot":3} 15:31:59 [15:31:59.737] VERBOSE: p2p:tx_pool Adding tx 0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32 to pool {"eventName":"tx-added-to-pool","txHash":"0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":257,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:31:59 [15:31:59.783] INFO: node Received tx 0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32 {"txHash":"0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32"} 15:31:59 [15:31:59.783] INFO: pxe:service Sent transaction 0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32 15:32:00 [15:32:00.298] VERBOSE: sequencer Building block 3 for slot 3 {"slot":3,"blockNumber":3,"msgCount":0} 15:32:00 [15:32:00.325] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T15:36:42.000Z","now":"2025-06-18T15:32:00.325Z"} 15:32:00 [15:32:00.861] VERBOSE: simulator:public-processor Processed tx 0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32 with no public calls in 369.2316819999978ms {"txHash":"0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32","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":369.2316819999978} 15:32:00 [15:32:00.869] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.5425064539999985s {"duration":0.5425064539999985,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":142848,"l2Gas":16544},"totalSizeInBytes":9184} 15:32:01 [15:32:01.147] INFO: sequencer Built block 3 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2b75dce6221cc558cb9021965cc3340c0ce0b0889f217275b94ff006fa863f3f","globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":3,"slotNumber":3,"timestamp":1750261002,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x14d256340e35cfe5cb5c167dd2ff7d5067e7de533f39cd85d731dd88e0a58f32"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":851.4037610000014,"publicProcessDuration":543.2654599999987,"rollupCircuitsDuration":823.9102420000017,"txCount":1,"blockNumber":3,"blockTimestamp":1750261002,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":257} 15:32:01 [15:32:01.151] VERBOSE: sequencer Attesting committee is empty 15:32:01 [15:32:01.584] VERBOSE: sequencer-client Sent L1 transaction 0x163f3264552c09221112a62dd890c402176fa0db62452dd81e5f5f7ea1ba9029 {"gasLimit":470283,"maxFeePerGas":"1.290952447","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:32:01 [15:32:01.603] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:32:01 [15:32:01.603] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x163f3264552c09221112a62dd890c402176fa0db62452dd81e5f5f7ea1ba9029","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":3,"blockTimestamp":1750261002,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":257} 15:32:01 [15:32:01.604] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:32:01 [15:32:01.608] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261038] on http://127.0.0.1:8545 15:32:01 [15:32:01.611] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:32:01 [15:32:01.614] INFO: blob-sink:server Received blob sidecar for block 0xe2c9da9abcbe90bf76fd6f6cfdf41f63bda8e5153aa550b5c3fd582a8d96c7c7 15:32:01 [15:32:01.617] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261038 15:32:01 [15:32:01.617] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 15:32:01 [15:32:01.624] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe2c9da9abcbe90bf76fd6f6cfdf41f63bda8e5153aa550b5c3fd582a8d96c7c7 15:32:01 [15:32:01.798] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 15:32:01 [15:32:01.800] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 15:32:01 [15:32:01.801] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 15:32:02 [15:32:02.155] VERBOSE: archiver:block-helper Store contract instance at 0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e 15:32:02 [15:32:02.172] VERBOSE: archiver:block-helper Store contract class 0x0605594e62cfcaf2925aa1fa1cdf56f53e7a0d4c9ae1770b62bb4c55fa7df73b 15:32:02 [15:32:02.221] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x2b75dce6221cc558cb9021965cc3340c0ce0b0889f217275b94ff006fa863f3f","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":3,"slotNumber":3,"timestamp":1750261002,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","archiveNextLeafIndex":4} 15:32:02 [15:32:02.240] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 15:32:02 [15:32:02.294] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":33.69388600000093,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750261002,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":257} 15:32:02 [15:32:02.323] VERBOSE: p2p Synched to latest block 3 15:32:02 [15:32:02.760] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","blockNumber":4,"slot":4} 15:32:03 [15:32:03.008] INFO: aztecjs:deploy_sent_tx Contract 0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e successfully deployed. 15:32:03 [15:32:03.099] WARN: pxe:service No artifact found for contract class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 when looking for its metadata 15:32:03 [15:32:03.101] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 as part of deployment for 0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33 15:32:03 [15:32:03.386] INFO: pxe:service Added contract Child at 0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33 with class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 15:32:03 [15:32:03.433] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","blockNumber":4,"slot":4} 15:32:03 [15:32:03.460] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","header":{"contentCommitment":{"blobsHash":"0x004a3c35000eac2c57148ec201a1c6914ff152a58e778d4d6fede7f5f1cb8cf4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750261002,"version":1311980022},"lastArchive":"0x27a5c648cba610dd8ea091aa41176354b2228453d9750bb0e17779c671bfe070","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x06a69d142443d76ccba12721747a4ae2b3f2aa039c007a0fe4c0050c7e703b41","nullifierTree":"0x0d72e48897ed71892cebbc09c29571fc6dc0d02204c442070bcf15bae9445612","publicDataTree":"0x2e5f58b1d2482412634b4293aeb7ce563120edf3f5a1cec37863043a3624d39d"},"totalFees":5496909440,"totalManaUsed":16544}} 15:32:03 [15:32:03.688] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:03 [15:32:03.755] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:32:03 [15:32:03.756] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:03 [15:32:03.886] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:03 [15:32:03.904] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x08354c9281a53e0a323a365d19954ec92ee7dd701fe774d8977e346ac63c1b31 15:32:03 [15:32:03.972] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:32:03 [15:32:03.973] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:32:04 [15:32:04.150] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:32:04 [15:32:04.151] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:32:04 [15:32:04.202] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","blockNumber":4,"slot":4} 15:32:04 [15:32:04.203] VERBOSE: pxe:service Added note {"index":0,"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x190b926d1df34fa798ce6f076c0dd04d7026da68549ed01213ce194fe68daca8","nullifier":"0x0ac366212c6501ca4e1a6253c55c06a8c5e2baf720122199d5132dc068ded65a"} 15:32:04 [15:32:04.210] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:32:04 [15:32:04.236] VERBOSE: simulator:client_execution_context:debug_log Setting 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 as fee payer 15:32:04 [15:32:04.344] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:32:05 [15:32:05.012] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9,0x1a4c0bde05ac32ea9ae2f4a5b141d3ff84b80b42d18e584a0ba0d19f7c2f82fb,0x01a5de0647b8e04e7f2e9f75bc1b474a527192215c030d10ebfc6751ce804506,0x2da71b8e2649f39f83e4bfa9280968a015fa13c148faf6eae97621dea667fdf7 15:32:05 [15:32:05.155] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:32:05 [15:32:05.364] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:32:05 [15:32:05.377] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","blockNumber":4,"slot":4} 15:32:05 [15:32:05.429] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:32:05 [15:32:05.450] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33,0x0000000000000000000000000000000000000000000000000000000000000001,0x209eaa07d26754fda2a0276d5103676e9a8bd4ce84887068bce034e32a587101,0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 15:32:06 [15:32:06.375] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","blockNumber":4,"slot":4} 15:32:07 [15:32:07.366] INFO: pxe:service Proving completed in 3940.8217369999984ms {"timings":{"total":3940.8217369999984,"sync":39.0420610000001,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":775.3827889999993,"oracles":{"debugLog":{"times":[1.009001000002172,0.7404740000019956,1.7236339999981283,0.6546699999998964,0.7791870000000927,0.594507000001613,1.5646750000014435,0.83683199999723]},"fetchTaggedLogs":{"times":[144.39252900000065]},"loadCapsule":{"times":[0.4873989999978221,0.433125999999902,0.8312009999972361,3.656652000001486,0.2461750000002212,0.39596399999936693]},"getSharedSecret":{"times":[8.47757499999716]},"aes128Decrypt":{"times":[0.4022049999985029,1.63195899999846]},"getPublicKeysAndPartialAddress":{"times":[116.97077300000092]},"getKeyValidationRequest":{"times":[52.90417200000229]},"deliverNote":{"times":[51.99009699999806]},"deleteCapsule":{"times":[0.46865799999795854]},"storeCapsule":{"times":[1.6464000000014494]},"getNotes":{"times":[2.396096000000398]},"getAuthWitness":{"times":[0.46273800000199117]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.10385600000154227]},"callPrivateFunction":{"times":[1007.0037279999997,208.8746769999998]}}},{"functionName":"private_kernel_init","time":110.82402600000205},{"functionName":"ContractClassRegisterer:register","time":971.0500460000003,"oracles":{"loadCapsule":{"times":[5.486508000001777]},"notifyCreatedNullifier":{"times":[0.4427670000004582]},"debugLog":{"times":[0.5587949999971897]},"notifyCreatedContractClassLog":{"times":[13.424984999997832]}}},{"functionName":"private_kernel_inner","time":208.82666400000016},{"functionName":"ContractInstanceDeployer:deploy","time":124.8638899999969,"oracles":{"storeInExecutionCache":{"times":[0.18305099999997765]},"callPrivateFunction":{"times":[71.40621200000169]},"notifyCreatedNullifier":{"times":[0.3149200000007113]},"debugLog":{"times":[0.6590299999988929]}}},{"functionName":"private_kernel_inner","time":224.655356999996},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":49.45207200000368,"oracles":{}},{"functionName":"private_kernel_inner","time":147.75053800000023},{"functionName":"private_kernel_reset","time":254.5793679999988},{"functionName":"private_kernel_tail","time":83.7955940000029}],"unaccounted":950.599331999998}} 15:32:07 [15:32:07.525] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","blockNumber":4,"slot":4} 15:32:07 [15:32:07.540] VERBOSE: p2p:tx_pool Adding tx 0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af to pool {"eventName":"tx-added-to-pool","txHash":"0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":146,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:32:07 [15:32:07.566] INFO: node Received tx 0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af {"txHash":"0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af"} 15:32:07 [15:32:07.566] INFO: pxe:service Sent transaction 0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af 15:32:08 [15:32:08.047] VERBOSE: sequencer Building block 4 for slot 4 {"slot":4,"blockNumber":4,"msgCount":0} 15:32:08 [15:32:08.068] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T15:37:18.000Z","now":"2025-06-18T15:32:08.068Z"} 15:32:08 [15:32:08.338] VERBOSE: simulator:public-processor Processed tx 0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af with no public calls in 178.26309400000173ms {"txHash":"0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af","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":178.26309400000173} 15:32:08 [15:32:08.339] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2707043599999961s {"duration":0.2707043599999961,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":86016,"l2Gas":16544},"totalSizeInBytes":5632} 15:32:08 [15:32:08.506] INFO: sequencer Built block 4 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0de422f7d17c43e03ab0d177fbbe0a3f1a6d5481bfee53e02a72a2f13283c6ee","globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":4,"slotNumber":4,"timestamp":1750261038,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x23890c4e42929199bd299257a06cba237e0ab1322a819370329771ac3d9c38af"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":459.4153870000009,"publicProcessDuration":271.1391469999944,"rollupCircuitsDuration":440.24153800000204,"txCount":1,"blockNumber":4,"blockTimestamp":1750261038,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":146} 15:32:08 [15:32:08.510] VERBOSE: sequencer Attesting committee is empty 15:32:08 [15:32:08.915] VERBOSE: sequencer-client Sent L1 transaction 0x4ae50a6c2d3baef3a2f533c9a5775873e1d98d6ec77d693a0b20db130a0865ba {"gasLimit":470283,"maxFeePerGas":"1.26986026","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:32:08 [15:32:08.926] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 15:32:08 [15:32:08.932] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 15:32:08 [15:32:08.938] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 15:32:08 [15:32:08.939] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261074] on http://127.0.0.1:8545 15:32:08 [15:32:08.947] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:32:08 [15:32:08.947] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4ae50a6c2d3baef3a2f533c9a5775873e1d98d6ec77d693a0b20db130a0865ba","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1750261038,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":146} 15:32:08 [15:32:08.948] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:32:08 [15:32:08.952] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:32:08 [15:32:08.955] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261074 15:32:08 [15:32:08.956] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 15:32:08 [15:32:08.959] INFO: blob-sink:server Received blob sidecar for block 0x4c2b699c0a8282d3fb229a116a525ccbae7602a2f2b4c84d70bd72c08659e5f2 15:32:08 [15:32:08.966] INFO: blob-sink:server Blob sidecar stored successfully for block 0x4c2b699c0a8282d3fb229a116a525ccbae7602a2f2b4c84d70bd72c08659e5f2 15:32:09 [15:32:09.403] VERBOSE: archiver:block-helper Store contract instance at 0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33 15:32:09 [15:32:09.412] VERBOSE: archiver:block-helper Store contract class 0x1ba3f95ec83f729667e07449e429595733617537277b04ba4fd770e5afb4d9e9 15:32:09 [15:32:09.438] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0de422f7d17c43e03ab0d177fbbe0a3f1a6d5481bfee53e02a72a2f13283c6ee","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":4,"slotNumber":4,"timestamp":1750261038,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x143d198c67f78d0d7bc5a356c18c72fa2b3cf59cca6d28fbad8ae00e013c24b3","archiveNextLeafIndex":5} 15:32:09 [15:32:09.452] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 15:32:09 [15:32:09.512] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":8.674373000001651,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750261038,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":146} 15:32:09 [15:32:09.573] VERBOSE: p2p Synched to latest block 4 15:32:09 [15:32:09.725] INFO: aztecjs:deploy_sent_tx Contract 0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33 successfully deployed. 15:32:09 [15:32:09.726] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for manual complete. 15:32:09 [15:32:09.901] INFO: e2e:manual_private_call Running test: e2e_nested_contract manual performs nested calls 15:32:09 [15:32:09.965] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x143d198c67f78d0d7bc5a356c18c72fa2b3cf59cca6d28fbad8ae00e013c24b3","header":{"contentCommitment":{"blobsHash":"0x0057c1b0ab55aa563e34fc3feae36959d8d7f659ae51ca953780d3faa20cec2d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750261038,"version":1311980022},"lastArchive":"0x0f7cb0fd81d879b07ff36aaa4c3ff30ade5d683a2cef9a7eb7750844ce47c77a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x06a69d142443d76ccba12721747a4ae2b3f2aa039c007a0fe4c0050c7e703b41","nullifierTree":"0x21e213ac17454b38cc42f8de3548d2a38d1c0dd85239fbcf5047b044c928a204","publicDataTree":"0x0bc7efc8e109f6a96263e7c3b3b00035abae5026b972a3468c274488dad96438"},"totalFees":5496909440,"totalManaUsed":16544}} 15:32:10 [15:32:10.092] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:10 [15:32:10.141] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:32:10 [15:32:10.141] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:10 [15:32:10.151] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x143d198c67f78d0d7bc5a356c18c72fa2b3cf59cca6d28fbad8ae00e013c24b3","blockNumber":5,"slot":5} 15:32:10 [15:32:10.244] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:10 [15:32:10.250] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x08354c9281a53e0a323a365d19954ec92ee7dd701fe774d8977e346ac63c1b31 15:32:10 [15:32:10.273] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:32:10 [15:32:10.275] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:32:10 [15:32:10.283] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:32:10 [15:32:10.283] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:32:10 [15:32:10.287] VERBOSE: pxe:service Added note {"index":0,"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x190b926d1df34fa798ce6f076c0dd04d7026da68549ed01213ce194fe68daca8","nullifier":"0x0ac366212c6501ca4e1a6253c55c06a8c5e2baf720122199d5132dc068ded65a"} 15:32:10 [15:32:10.297] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:32:10 [15:32:10.317] VERBOSE: simulator:client_execution_context:debug_log Setting 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 as fee payer 15:32:10 [15:32:10.606] VERBOSE: simulator:private_execution Executing private function Parent:entry_point {"contract":"0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e"} 15:32:10 [15:32:10.628] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:32:10 [15:32:10.628] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e"} 15:32:10 [15:32:10.800] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e"} 15:32:10 [15:32:10.806] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x143d198c67f78d0d7bc5a356c18c72fa2b3cf59cca6d28fbad8ae00e013c24b3","blockNumber":5,"slot":5} 15:32:10 [15:32:10.817] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:32:11 [15:32:11.001] VERBOSE: simulator:private_execution Executing private function Child:value {"contract":"0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33"} 15:32:11 [15:32:11.029] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:32:11 [15:32:11.029] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33"} 15:32:11 [15:32:11.166] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33"} 15:32:11 [15:32:11.180] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:32:11 [15:32:11.898] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x143d198c67f78d0d7bc5a356c18c72fa2b3cf59cca6d28fbad8ae00e013c24b3","blockNumber":5,"slot":5} 15:32:12 [15:32:12.761] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x143d198c67f78d0d7bc5a356c18c72fa2b3cf59cca6d28fbad8ae00e013c24b3","blockNumber":5,"slot":5} 15:32:13 [15:32:13.167] INFO: pxe:service Proving completed in 3229.9327129999947ms {"timings":{"total":3229.9327129999947,"sync":32.22714200000337,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":425.4020340000061,"oracles":{"debugLog":{"times":[0.6220179999945685,0.62645799999882,0.6446700000014971,0.5514340000008815,0.5437230000025011,0.3758430000016233,0.9033159999962663,0.9475989999991725]},"fetchTaggedLogs":{"times":[106.595776999995]},"loadCapsule":{"times":[0.5000010000003385,0.1945720000003348,0.4558279999982915,0.65168999999878,4.08325099999638,0.4317469999950845]},"getSharedSecret":{"times":[13.869183000002522]},"aes128Decrypt":{"times":[0.36984300000040093,1.1637310000005527]},"getPublicKeysAndPartialAddress":{"times":[1.5918080000046757]},"getKeyValidationRequest":{"times":[2.384775999998965]},"deliverNote":{"times":[4.807656000004499]},"deleteCapsule":{"times":[1.5070530000011786]},"storeCapsule":{"times":[1.0779360000015004]},"getNotes":{"times":[4.401701000002504]},"getAuthWitness":{"times":[0.22052399999665795]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.17514099999971222]},"callPrivateFunction":{"times":[876.335450999999]}}},{"functionName":"private_kernel_init","time":81.3328130000009},{"functionName":"Parent:entry_point","time":477.10536599999614,"oracles":{"debugLog":{"times":[0.7970889999996871,1.0890570000046864]},"fetchTaggedLogs":{"times":[185.54824299999746]},"loadCapsule":{"times":[1.4420180000015534,0.3308699999979581,0.41936599999462487]},"storeInExecutionCache":{"times":[0.11625700000149664,0.06551500000205124]},"callPrivateFunction":{"times":[369.18653800000175]},"loadFromExecutionCache":{"times":[0.2604559999963385]}}},{"functionName":"private_kernel_inner","time":210.49920700000075},{"functionName":"Child:value","time":303.1013230000026,"oracles":{"debugLog":{"times":[0.715303999997559,0.5954169999968144]},"fetchTaggedLogs":{"times":[148.05350700000417]},"loadCapsule":{"times":[0.7153539999999339,0.5038209999984247,0.3160989999960293]},"storeInExecutionCache":{"times":[0.0648529999962193]}}},{"functionName":"private_kernel_inner","time":147.20988499999658},{"functionName":"private_kernel_reset","time":180.1178579999978},{"functionName":"private_kernel_tail","time":73.82022100000177}],"unaccounted":1299.1168639999887}} 15:32:13 [15:32:13.204] VERBOSE: p2p:tx_pool Adding tx 0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931 to pool {"eventName":"tx-added-to-pool","txHash":"0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 15:32:13 [15:32:13.214] INFO: node Received tx 0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931 {"txHash":"0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931"} 15:32:13 [15:32:13.214] INFO: pxe:service Sent transaction 0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931 15:32:13 [15:32:13.310] VERBOSE: sequencer Building block 5 for slot 5 {"slot":5,"blockNumber":5,"msgCount":0} 15:32:13 [15:32:13.332] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-18T15:37:54.000Z","now":"2025-06-18T15:32:13.332Z"} 15:32:13 [15:32:13.366] VERBOSE: simulator:public-processor Processed tx 0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931 with no public calls in 19.793236999998044ms {"txHash":"0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931","txFee":296899200,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1024,"l2Gas":5856},"billedGas":{"daGas":1024,"l2Gas":5856},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":19.793236999998044} 15:32:13 [15:32:13.367] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.034792130000001635s {"duration":0.034792130000001635,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1024,"l2Gas":5856},"totalSizeInBytes":256} 15:32:13 [15:32:13.556] INFO: sequencer Built block 5 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x14d7487c50fc5b732bb38e82d0e708a6eed42020f49df226aac70dd71b34826d","globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":5,"slotNumber":5,"timestamp":1750261074,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x30085ccd62c32d0ab6c7b8dfea3c8a6a0471f368d97a0d4785e271460b9da931"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":247.49512200000026,"publicProcessDuration":35.428989,"rollupCircuitsDuration":225.74278400000185,"txCount":1,"blockNumber":5,"blockTimestamp":1750261074,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:32:13 [15:32:13.559] VERBOSE: sequencer Attesting committee is empty 15:32:13 [15:32:13.855] VERBOSE: sequencer-client Sent L1 transaction 0x40ac77650bb9b4220b9d5eed20bbd26cc3d001b82d69de85e39fb481a631700e {"gasLimit":470310,"maxFeePerGas":"1.253659425","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:32:13 [15:32:13.868] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 15:32:13 [15:32:13.872] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:32:13 [15:32:13.872] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x40ac77650bb9b4220b9d5eed20bbd26cc3d001b82d69de85e39fb481a631700e","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":5,"blockTimestamp":1750261074,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:32:13 [15:32:13.873] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:32:13 [15:32:13.876] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 15:32:13 [15:32:13.881] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 15:32:13 [15:32:13.886] INFO: blob-sink:server Received blob sidecar for block 0x1938a64b5e2ab1facc51a64728585f49980f875751dca04b1555465102868c98 15:32:13 [15:32:13.895] INFO: blob-sink:server Blob sidecar stored successfully for block 0x1938a64b5e2ab1facc51a64728585f49980f875751dca04b1555465102868c98 15:32:13 [15:32:13.904] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750261110] on http://127.0.0.1:8545 15:32:13 [15:32:13.906] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:32:13 [15:32:13.915] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750261110 15:32:13 [15:32:13.915] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 15:32:14 [15:32:14.456] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x14d7487c50fc5b732bb38e82d0e708a6eed42020f49df226aac70dd71b34826d","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":1311980022,"blockNumber":5,"slotNumber":5,"timestamp":1750261074,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0e1d3d2cdf1428a7da61b438ef77f1d25523338950a5d6374d9da27a987901b7","archiveNextLeafIndex":6} 15:32:14 [15:32:14.464] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 15:32:14 [15:32:14.561] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":9.654404000000795,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750261074,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:32:14 [15:32:14.573] VERBOSE: p2p Synched to latest block 5 15:32:14 [15:32:14.994] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0e1d3d2cdf1428a7da61b438ef77f1d25523338950a5d6374d9da27a987901b7","blockNumber":6,"slot":6} 15:32:15 [15:32:15.225] INFO: e2e:manual_private_call Running test: e2e_nested_contract manual fails simulation if calling a function not allowed to be called externally 15:32:15 [15:32:15.271] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 {"origin":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000004e3339f6","authWitnesses":["0x1efba86315b5ab7fbd1e549820f64f279c427befcdbe41e5ba1a7e94a11766de"]} 15:32:15 [15:32:15.282] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x0e1d3d2cdf1428a7da61b438ef77f1d25523338950a5d6374d9da27a987901b7","header":{"contentCommitment":{"blobsHash":"0x00d8f77908cde9aa100431985120e2313cbbd30c594920ba65bcb611055265cc","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750261074,"version":1311980022},"lastArchive":"0x143d198c67f78d0d7bc5a356c18c72fa2b3cf59cca6d28fbad8ae00e013c24b3","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x06a69d142443d76ccba12721747a4ae2b3f2aa039c007a0fe4c0050c7e703b41","nullifierTree":"0x1a8a98c9765230670aa50dede21ee0c94d2da0ab1cfe61c81b45e97b45dc08a7","publicDataTree":"0x2e7aafbbadfedb5ad21e8e80664aa6af519a93924ddaa2c0749008cc653ca20c"},"totalFees":296899200,"totalManaUsed":5856}} 15:32:15 [15:32:15.392] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:15 [15:32:15.428] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:32:15 [15:32:15.429] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:15 [15:32:15.495] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201"} 15:32:15 [15:32:15.523] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x08354c9281a53e0a323a365d19954ec92ee7dd701fe774d8977e346ac63c1b31 15:32:15 [15:32:15.526] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0e1d3d2cdf1428a7da61b438ef77f1d25523338950a5d6374d9da27a987901b7","blockNumber":6,"slot":6} 15:32:15 [15:32:15.539] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:32:15 [15:32:15.540] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:32:15 [15:32:15.564] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:32:15 [15:32:15.566] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:32:15 [15:32:15.572] VERBOSE: pxe:service Added note {"index":0,"contract":"0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x190b926d1df34fa798ce6f076c0dd04d7026da68549ed01213ce194fe68daca8","nullifier":"0x0ac366212c6501ca4e1a6253c55c06a8c5e2baf720122199d5132dc068ded65a"} 15:32:15 [15:32:15.575] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:32:15 [15:32:15.593] VERBOSE: simulator:client_execution_context:debug_log Setting 0x14d4695ed273c21dd9c52523705eb4347a6adb4523c5ba5aad8abaea8c41e201 as fee payer 15:32:15 [15:32:15.836] VERBOSE: simulator:private_execution Executing private function Parent:entry_point {"contract":"0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e"} 15:32:15 [15:32:15.845] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:32:15 [15:32:15.846] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e"} 15:32:15 [15:32:15.929] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x17a6cb241e8847e8ceb4c80d586c60229ec2dae2a92cc0db9de8a9c27a07221e"} 15:32:15 [15:32:15.932] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:32:16 [15:32:16.057] VERBOSE: simulator:private_execution Executing private function Child:value_internal {"contract":"0x0bb9bd530263e552f95dc30b6cf15e6329d864648382a7f9304ce4af4aabad33"} 15:32:16 [15:32:16.205] INFO: e2e:e2e_nested_contract Tearing down subsystems 15:32:16 [15:32:16.206] INFO: node Stopping 15:32:16 [15:32:16.227] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0e1d3d2cdf1428a7da61b438ef77f1d25523338950a5d6374d9da27a987901b7","blockNumber":6,"slot":6} 15:32:16 [15:32:16.228] INFO: slasher Slasher client stopped. 15:32:16 [15:32:16.228] INFO: sequencer Stopped sequencer 15:32:16 [15:32:16.228] INFO: p2p P2P client stopped. 15:32:16 [15:32:16.232] INFO: world_state Stopped world state synchronizer 15:32:16 [15:32:16.233] INFO: archiver Stopped. 15:32:16 [15:32:16.233] INFO: node Stopped 15:32:16 [15:32:16.234] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Cleaning up ACVM temp directory /tmp/97e7c57c 15:32:16 [15:32:16.244] INFO: blob-sink:server Stopping blob sink 15:32:16 [15:32:16.245] INFO: blob-sink:server Blob sink stopped 15:32:16 PASS src/e2e_nested_contract/manual_private_call.test.ts 15:32:16 e2e_nested_contract manual 15:32:16 performs nested calls (5327 ms) 15:32:16 fails simulation if calling a function not allowed to be called externally (980 ms) 15:32:16 15:32:16 Test Suites: 1 passed, 1 total 15:32:16 Tests: 2 passed, 2 total 15:32:16 Snapshots: 0 total 15:32:16 Time: 42.74 s 15:32:16 Ran all test suites matching /src\/e2e_nested_contract\/manual_private_call.test.ts/i. 15:32:16 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?