Parent Log: http://ci.aztec-labs.com/29ef878f08dca81b Command: ef601da20f8e827b: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/d886120f668032e2640beac56487c6f7b18ce81e Env: REF_NAME=gh-readonly-queue/next/pr-15226-fe574e9be5d341cfa05d23ac296ab738d268f1c0 CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Wed Jun 25 16:14:54 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15226_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_90fb6749f0a6bca0_next 16:14:54 +++ id -u 16:14:54 +++ id -g 16:14:54 ++ docker run -d --name e2e_nested_contract_manual_private_call --net=none --cpuset-cpus=0-63 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_nested_contract/manual_private_call.test.ts'\''' 16:14:54 + cid=f62d67e0c7cf4235094f2a274caafb1e26eaa32fa8bbe50dfe7b5c80d311eb66 16:14:54 + set +x 16:14:55 {"level":25,"time":1750868095152,"pid":12,"hostname":"f62d67e0c7cf","module":"logger","msg":"Logger initialized with level verbose"} 16:14:59 [16:14:59.777] WARN: e2e:snapshot_manager:e2e_nested_contract/manual-1 No data path given, will not persist any snapshots. 16:14:59 [16:14:59.783] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Initializing state... 16:14:59 [16:14:59.788] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Starting anvil... 16:14:59 [16:14:59.868] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deploying L1 contracts... 16:15:00 [16:15:00.683] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-lg7GRs/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 16:15:00 [16:15:00.752] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 16:15:00 [16:15:00.763] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent 0.1 ETH to deployer {"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000} 16:15:00 [16:15:00.773] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Multicall3 16:15:00 [16:15:00.774] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Calling anvil_setBlockTimestampInterval with params: [12] 16:15:00 [16:15:00.777] WARN: e2e:snapshot_manager:e2e_nested_contract/manual-1 Set block interval to 12 16:15:00 [16:15:00.777] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:15:00 [16:15:00.804] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x9442c96dbfb1b64a27527fd1a4f8eb19d84a1a68b868640b29ed6b2c81dc2f50 {"gasLimit":854274,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"} 16:15:00 [16:15:00.809] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Fee Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 16:15:00 [16:15:00.824] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x529d27ea68ffcafebe07526577b61092e24b59c533cc9143f998e4fc6dcfb14b {"gasLimit":854259,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"} 16:15:00 [16:15:00.829] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Staking Asset at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 16:15:00 [16:15:00.851] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x32c8a34af04f77ee6401b14f081d8e23023f8dd7a7a4414d507cfa9dc8f92f24 {"gasLimit":3199922,"maxFeePerGas":"172.377258836","maxPriorityFeePerGas":"171.2876976"} 16:15:00 [16:15:00.856] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed GSE at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 16:15:00 [16:15:00.870] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xb179f4dc676e1a7bbd9db877c23b7b1c7f593b85dc6c3b9135b3f28388914e90 {"gasLimit":1065034,"maxFeePerGas":"206.505066871","maxPriorityFeePerGas":"205.54523712"} 16:15:00 [16:15:00.875] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Registry at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 16:15:00 [16:15:00.892] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x4d3779fb70a31be6dfca451e5712ae49c303998bc106450fa306309a7a0df48f {"gasLimit":2246428,"maxFeePerGas":"247.515464608","maxPriorityFeePerGas":"246.654284544"} 16:15:00 [16:15:00.897] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed GovernanceProposer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 16:15:00 [16:15:00.912] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x81f9e97b2180728eebbeedcc917b79fa7efde5cb3ce305571b33e26faa3eee58 {"gasLimit":3042394,"maxFeePerGas":"296.74504336","maxPriorityFeePerGas":"295.985141452"} 16:15:00 [16:15:00.916] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Governance at 0x0165878a594ca255338adfa4d48449f69242eb8f 16:15:00 [16:15:00.927] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xe1efeb92342377fa75d3a8b005c4d409d18888ec99173693304f4ab9484fbfe0 {"gasLimit":100000,"maxFeePerGas":"355.858938535","maxPriorityFeePerGas":"355.182169742"} 16:15:00 [16:15:00.927] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Set governance on GSE in 0xe1efeb92342377fa75d3a8b005c4d409d18888ec99173693304f4ab9484fbfe0 16:15:00 [16:15:00.939] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xb9e3758380193b478fc441e5dbadefee5960f88639f3841fd03ed0eadfdc283a {"gasLimit":391719,"maxFeePerGas":"426.825074981","maxPriorityFeePerGas":"426.21860369"} 16:15:00 [16:15:00.944] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed CoinIssuer at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 16:15:00 [16:15:00.944] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for deployments to complete 16:15:00 [16:15:00.944] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 7 transactions to be mined... 16:15:00 [16:15:00.965] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 16:15:00 [16:15:00.973] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xbb034e478413c16e920856cdfc16f4274ac628cb053edfdf5ade81d471a918a0 {"gasLimit":100000,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:00 [16:15:00.973] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added coin issuer 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0xbb034e478413c16e920856cdfc16f4274ac628cb053edfdf5ade81d471a918a0 16:15:00 [16:15:00.985] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x13a19479c80c53e28262b8a87b03014d06d51032c11114e38ce7c6906bd5125c {"gasLimit":56661,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.000] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xd431ef3723b2de7ec35591cb862dbc668fe288da15c79822d5658456bc23cde8 {"gasLimit":339705,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.005] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed FeeAssetHandler at 0xb7f8bc63bbcad18155201308c8f3540b07f84f5e 16:15:01 [16:15:01.016] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x824cfd0f6c8dcf5a5b54ab747da9f2f11c9a57fe335f306ba9a136a6036990f8 {"gasLimit":56804,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.016] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added fee asset handler 0xb7f8bc63bbcad18155201308c8f3540b07f84f5e as minter on fee asset in 0x824cfd0f6c8dcf5a5b54ab747da9f2f11c9a57fe335f306ba9a136a6036990f8 16:15:01 [16:15:01.033] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xba3c6c2bcb8fa5696ecac894cbf3f574bb3c516ca8e593a56e8e776e5279750f {"gasLimit":2395347,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.037] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed StakingAssetHandler at 0x0dcd1bf9a1b36ce34237eeafef220932846bcd82 16:15:01 [16:15:01.049] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xf4ac3922b72e1eeafeb5a2c77b993f3702faacfa84ffe84d648d8750d9c065b2 {"gasLimit":56804,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.049] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Added staking asset handler 0x0dcd1bf9a1b36ce34237eeafef220932846bcd82 as minter on staking asset in 0xf4ac3922b72e1eeafeb5a2c77b993f3702faacfa84ffe84d648d8750d9c065b2 16:15:01 [16:15:01.049] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for deployments to complete 16:15:01 [16:15:01.049] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 9 transactions to be mined... 16:15:01 [16:15:01.068] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 16:15:01 [16:15:01.081] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed shared contracts 16:15:01 [16:15:01.097] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x693fb2379519db8efdd4d7147d271bb224a6f416774b8929fbd22f35735980c3 {"gasLimit":84837,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.097] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Funded reward distributor with 10000000000000000000000000 fee asset in 0x693fb2379519db8efdd4d7147d271bb224a6f416774b8929fbd22f35735980c3 16:15:01 [16:15:01.111] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xe864f8598420a3f08ad58dfc390d1839179932035cc0f8f39946ee51d7291728 {"gasLimit":152965,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.114] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Rollup will use the mock verifier at 0x959922be3caee4b8cd9a407cc3ac1c251c2007b1 16:15:01 [16:15:01.115] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":0,"aztecProofSubmissionEpochs":1,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"rewardDistributor":"0x856e4424f806d16e8cbc702b3c0f2ede5468eae5","booster":"0x0000000000000000000000000000000000000000"},"rewardBoostConfig":{"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 16:15:01 [16:15:01.126] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xff02ecccc6afa15638db26acf77f3f923dbcc64f4ad994a2c13f6757649fe019 {"gasLimit":86397,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.146] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xdbcca9d5c6da9e0aba831dbbb98e6951766d777e2d70760969619a33aff31f62 {"gasLimit":4972507,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.167] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x83d647441e3b3892252ffd812a51cbcb0282e79490a3cb02c6f8e80acce274df {"gasLimit":2845143,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.172] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Awaiting for linked libraries to be deployed 16:15:01 [16:15:01.210] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x6c8c20a7ebfe4382e103c519731b8367ee1d38e89600a5fbece347534b780950 {"gasLimit":11566255,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.216] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed Rollup at 0xc6e7df5e7b4f2a278906862b61205850344d4e7d {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":0,"aztecProofSubmissionEpochs":1,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"rewardDistributor":"0x856e4424f806d16e8cbc702b3c0f2ede5468eae5","booster":"0x0000000000000000000000000000000000000000"},"rewardBoostConfig":{"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 16:15:01 [16:15:01.216] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 11 transactions to be mined... 16:15:01 [16:15:01.239] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 16:15:01 [16:15:01.239] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 All core contracts have been deployed 16:15:01 [16:15:01.254] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xc8448869f10f99a42a0e8a5397a99e8169a1eaea1b286e30877574ebcbfed3f9 {"gasLimit":64317,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.254] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Funding fee juice portal with 110000000000000000000000 fee juice in 0xc8448869f10f99a42a0e8a5397a99e8169a1eaea1b286e30877574ebcbfed3f9 (accelerated test deployments) 16:15:01 [16:15:01.266] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xa725a3a4c98a5ca75de70ae892f39d3d62229691c0c98679f300f4fe3181cdc4 {"gasLimit":1040116,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.270] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Deployed SlashFactory at 0x4ed7c70f96b99c776995fb64377f0d4ab3b0e1c1 16:15:01 [16:15:01.289] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0x38d0c0df1284c4e10fc7e4d9d9e01bde374c4db9418e68c9e0384c887a382096 {"gasLimit":117006,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.290] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Adding rollup 0xc6e7df5e7b4f2a278906862b61205850344d4e7d to registry 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 in tx 0x38d0c0df1284c4e10fc7e4d9d9e01bde374c4db9418e68c9e0384c887a382096 16:15:01 [16:15:01.303] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Sent L1 transaction 0xc4733cc09a0710fb70f62577905c30f83f4de70d10f6c9800c07b8baeb0adc89 {"gasLimit":109478,"maxFeePerGas":"500","maxPriorityFeePerGas":"500"} 16:15:01 [16:15:01.303] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Adding rollup 0xc6e7df5e7b4f2a278906862b61205850344d4e7d to GSE 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 in tx 0xc4733cc09a0710fb70f62577905c30f83f4de70d10f6c9800c07b8baeb0adc89 16:15:01 [16:15:01.307] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 12 transactions to be mined... 16:15:01 [16:15:01.331] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 16:15:01 [16:15:01.339] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Rollup deployed 16:15:01 [16:15:01.339] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for rollup and slash factory to be deployed 16:15:01 [16:15:01.340] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Waiting for 12 transactions to be mined... 16:15:01 [16:15:01.361] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions mined successfully 16:15:01 [16:15:01.361] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 All transactions for L1 deployment have been mined 16:15:01 [16:15:01.377] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Aztec L1 contracts initialized {"registryAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x0165878a594ca255338adfa4d48449f69242eb8f","governanceProposerAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","rollupAddress":"0xc6e7df5e7b4f2a278906862b61205850344d4e7d","inboxAddress":"0x94cd1b4dea480e09a1e0d83f6c92b9a5c6136171","outboxAddress":"0x8755d348e575fc4a68ec5d0b609bc7c070ebea3d","feeJuicePortalAddress":"0x18f2c334040d6c8d69cb68c6c6e6f34dfc6f8df6","feeJuiceAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","stakingAssetAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","rewardDistributorAddress":"0x856e4424f806d16e8cbc702b3c0f2ede5468eae5","gseAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 16:15:01 [16:15:01.377] INFO: e2e:snapshot_manager:e2e_nested_contract/manual-1 Handing over to governance 16:15:01 [16:15:01.385] INFO: aztecjs:utils:watcher Watcher started for rollup at 0xc6e7DF5E7b4f2A278906862b61205850344D4e7d 16:15:01 [16:15:01.389] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:15:01 [16:15:01.390] WARN: foundation:test-date-provider Time set to 2025-06-25T16:19:48.000Z {"offset":286611,"timeMs":1750868388000} 16:15:01 [16:15:01.393] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/03f2a6ec/acvm 16:15:01 [16:15:01.394] INFO: telemetry:client Using NoopTelemetryClient 16:15:01 [16:15:01.395] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/12caee3f150371a1/blob-sink with map size 134217728 KB (LMDB v2) 16:15:01 [16:15:01.396] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 16:15:01 [16:15:01.401] INFO: blob-sink:server Server is running on http://localhost:40665 16:15:01 [16:15:01.401] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Creating and synching an aztec node... 16:15:01 [16:15:01.402] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://127.0.0.1:40665"} 16:15:01 [16:15:01.420] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 16:15:01 [16:15:01.421] INFO: archiver:lmdb Creating archiver data store at directory /tmp/12caee3f150371a1/archiver with map size 134217728 KB (LMDB v2) 16:15:01 [16:15:01.422] INFO: archiver:lmdb Starting data store with maxReaders 16 16:15:01 [16:15:01.699] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://127.0.0.1:40665"} 16:15:01 [16:15:01.707] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://127.0.0.1:40665"} 16:15:01 [16:15:01.708] WARN: node:blob-sink:client No L1 consensus host urls configured 16:15:01 [16:15:01.708] WARN: node:blob-sink:client No archive client configured 16:15:01 [16:15:01.710] INFO: archiver Starting archiver sync to rollup contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d from L1 block 22 to current L1 block 26 with hash 0x41a00be8480313664a520135bf57362eb6ebe9435f82e81d038dd11e549d3fd4 {"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0x3a9ebb89992b6cb8ecdbf607f1c6945445f90aaf6d0cc1b3d3e5a3be1242d3e2","l1BlockNumber":22}} 16:15:01 [16:15:01.722] INFO: archiver Initial archiver sync to L1 block 26 complete. {"l1BlockNumber":26,"syncPoint":{"blocksSynchedTo":26},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 16:15:01 [16:15:01.728] INFO: world-state:database Creating world state data store at directory /tmp/12caee3f150371a1/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 16:15:01 [16:15:01.750] INFO: world_state Created world state synchroniser with block history of 64 16:15:01 [16:15:01.750] WARN: node Aztec node is accepting fake proofs 16:15:01 [16:15:01.751] INFO: bb-prover:queued_ivc_verifier Starting QueuedIVCVerifier with 8 concurrent verifiers 16:15:01 [16:15:01.761] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/12caee3f150371a1/p2p with map size 134217728 KB (LMDB v2) 16:15:01 [16:15:01.762] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 16:15:01 [16:15:01.763] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/12caee3f150371a1/p2p-archive with map size 134217728 KB (LMDB v2) 16:15:01 [16:15:01.764] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 16:15:01 [16:15:01.765] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/12caee3f150371a1/p2p-peers with map size 134217728 KB (LMDB v2) 16:15:01 [16:15:01.766] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 16:15:01 [16:15:01.767] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":2147483648} 16:15:01 [16:15:01.767] VERBOSE: p2p P2P is disabled. Using dummy P2P service. 16:15:01 [16:15:01.769] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 16:15:01 [16:15:01.770] INFO: world_state Started world state synchronizer from block 1 16:15:01 [16:15:01.772] VERBOSE: world-state:block_stream Starting sync from block number 0 16:15:01 [16:15:01.774] INFO: p2p Starting p2p client from block 0 with empty mempools 16:15:01 [16:15:01.774] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 16:15:01 [16:15:01.983] INFO: epoch-prune-watcher EpochPruneWatcher initialized 16:15:02 [16:15:02.017] VERBOSE: validator Initialized validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:15:02 [16:15:02.017] VERBOSE: node All Aztec Node subsystems synced 16:15:02 [16:15:02.029] INFO: slasher Starting Slasher client... 16:15:02 [16:15:02.040] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 16:15:02 [16:15:02.046] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:15:02 [16:15:02.046] VERBOSE: validator Validators 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 are not on the validator committee for epoch 0 16:15:02 [16:15:02.047] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/03f2a6ec/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 16:15:02 [16:15:02.047] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 16:15:02 [16:15:02.049] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:15:02 [16:15:02.049] VERBOSE: node Sequencer started 16:15:02 [16:15:02.050] INFO: node Aztec Node version: 0.87.6 16:15:02 [16:15:02.050] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x0165878a594ca255338adfa4d48449f69242eb8f","governanceProposerAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","rollupAddress":"0xc6e7df5e7b4f2a278906862b61205850344d4e7d","inboxAddress":"0x94cd1b4dea480e09a1e0d83f6c92b9a5c6136171","outboxAddress":"0x8755d348e575fc4a68ec5d0b609bc7c070ebea3d","feeJuicePortalAddress":"0x18f2c334040d6c8d69cb68c6c6e6f34dfc6f8df6","feeJuiceAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","stakingAssetAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","rewardDistributorAddress":"0x856e4424f806d16e8cbc702b3c0f2ede5468eae5","gseAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x4ed7c70f96b99c776995fb64377f0d4ab3b0e1c1","feeAssetHandlerAddress":"0xb7f8bc63bbcad18155201308c8f3540b07f84f5e","stakingAssetHandlerAddress":"0x0dcd1bf9a1b36ce34237eeafef220932846bcd82","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 16:15:02 [16:15:02.051] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Creating pxe... 16:15:02 [16:15:02.055] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/12caee3f150371a1/0173e29c6b4fdd26/pxe_data with map size 134217728 KB (LMDB v2) 16:15:02 [16:15:02.063] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:02 [16:15:02.065] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:02 [16:15:02.065] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:15:02 [16:15:02.374] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 16:15:02 [16:15:02.375] INFO: pxe:service Started PXE connected to chain 31337 version 3959990455 16:15:02 [16:15:02.375] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for accounts... 16:15:02 [16:15:02.375] VERBOSE: e2e:e2e_nested_contract:manual Deploying accounts funded with fee juice... 16:15:02 [16:15:02.414] INFO: pxe:service Registered account 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 16:15:02 [16:15:02.477] WARN: pxe:service No artifact found for contract class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc when looking for its metadata 16:15:02 [16:15:02.478] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc as part of deployment for 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 16:15:02 [16:15:02.628] INFO: pxe:service Added contract SchnorrAccount at 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 with class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 16:15:02 [16:15:02.641] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:02 [16:15:02.643] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:02 [16:15:02.670] VERBOSE: pxe:block_stream Starting sync from block number 0 16:15:02 [16:15:02.693] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 16:15:02 [16:15:02.876] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:15:03 [16:15:03.575] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc,0x1cf56b9e4d7531c5bbd1420c27965fb08c22058853d14156ad5de0dc4227945f,0x2781f58a7c5dae3d6a792f5793720e5ab9770ce9764988c151b6c1f945528fdf,0x0760738ac70fb3a6282af9a84ad00f3ccaee25deea3156d5c9f81542674af4d2 16:15:03 [16:15:03.650] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:15:03 [16:15:03.795] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:03 [16:15:03.805] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:03 [16:15:03.837] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:03 [16:15:03.876] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:03 [16:15:03.877] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:03 [16:15:03.909] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:03 [16:15:03.912] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:04 [16:15:04.034] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:04 [16:15:04.071] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:04 [16:15:04.071] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:04 [16:15:04.090] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:04 [16:15:04.094] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:04 [16:15:04.110] VERBOSE: simulator:client_execution_context:debug_log Setting 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 as fee payer 16:15:04 [16:15:04.390] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:04 [16:15:04.391] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:05 [16:15:05.163] INFO: pxe:service Proving completed in 2494.913299ms {"timings":{"total":2494.913299,"sync":2.2549089999993157,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":115.90216800000053,"oracles":{"callPrivateFunction":{"times":[1038.1993970000003,220.13209000000097,134.91864600000008]}}},{"functionName":"private_kernel_init","time":94.46519199999966},{"functionName":"ContractClassRegisterer:register","time":1005.949509,"oracles":{"loadCapsule":{"times":[13.684178999999858]},"notifyCreatedNullifier":{"times":[0.4996519999986049]},"debugLog":{"times":[0.7359149999992951]},"notifyCreatedContractClassLog":{"times":[8.270904999999402]}}},{"functionName":"private_kernel_inner","time":124.67150600000059},{"functionName":"SchnorrAccount:constructor","time":206.34827699999914,"oracles":{"getContractInstance":{"times":[0.9456649999992806]},"debugLog":{"times":[0.4901709999994637,0.432582999999795]},"fetchTaggedLogs":{"times":[34.02271699999983]},"loadCapsule":{"times":[0.3720180000000255,0.2557600000000093,0.2706469999993715,0.222938000000795,0.3417540000009467,0.24311499999930675]},"bulkRetrieveLogs":{"times":[1.6474999999991269]},"validateEnqueuedNotesAndEvents":{"times":[1.4301030000005994]},"notifyCreatedNullifier":{"times":[0.23057499999958964,0.23735800000031304]},"notifyCreatedNote":{"times":[0.3603689999999915]},"getRandomField":{"times":[0.18058100000052946,0.14701400000012654,0.09888300000056915,0.08848299999954179,0.0734439999996539,0.06139599999914935,0.07254699999975855,0.05852000000049884,0.07841300000109186,0.0821589999995922,0.06910400000015215]},"getIndexedTaggingSecretAsSender":{"times":[19.07032899999831]},"incrementAppTaggingSecretIndexAsSender":{"times":[14.50952099999995]}}},{"functionName":"private_kernel_inner","time":114.13526900000033},{"functionName":"SchnorrAccount:entrypoint","time":121.09734299999946,"oracles":{"debugLog":{"times":[0.4709340000008524,0.4323819999990519,0.5819099999989703]},"fetchTaggedLogs":{"times":[21.51731699999982]},"loadCapsule":{"times":[0.22299799999927927,0.3720110000012937,0.2702019999996992,0.1791270000012446,0.18461799999931827,0.15787399999862828]},"bulkRetrieveLogs":{"times":[0.9734329999992042]},"validateEnqueuedNotesAndEvents":{"times":[1.103343999999197]},"getNotes":{"times":[1.4201189999985218]},"getAuthWitness":{"times":[0.3494250000003376]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7428939999990689]}}},{"functionName":"private_kernel_inner","time":108.49519299999884},{"functionName":"private_kernel_reset","time":193.79814700000134},{"functionName":"private_kernel_tail","time":74.8239909999993}],"unaccounted":332.9717950000013}} 16:15:05 [16:15:05.261] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:05 [16:15:05.262] VERBOSE: sequencer Not enough txs to build block 1 at slot 1 (got 0 txs, need 1) {"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:05 [16:15:05.263] VERBOSE: p2p:tx_pool Adding tx 0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028 to pool {"eventName":"tx-added-to-pool","txHash":"0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 16:15:05 [16:15:05.285] INFO: node Received tx 0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028 {"txHash":"0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028"} 16:15:05 [16:15:05.286] INFO: pxe:service Sent transaction 0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028 16:15:05 [16:15:05.770] VERBOSE: sequencer Preparing proposal for block 1 at slot 1 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"chainTipArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","blockNumber":1,"slot":1} 16:15:05 [16:15:05.787] VERBOSE: block-builder Building block 1 for slot 1 {"slot":1,"slotStart":"2025-06-25T16:19:36.000Z","now":"2025-06-25T16:19:52.398Z","blockNumber":1,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1fd848aa69e1633722fe249a5b7f53b094f1c9cef9f5c694b073fd1cc5850dfb","nullifierTree":"0x0c499b373a1f0fe1b510a63563546d2d39e206895056a5af0143c5f30d639073","publicDataTree":"0x1904bfe49347e486170cf48a52bee7c43b69414483b0f7436389c1aaeda08add"},"initialArchiveRoot":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 16:15:05 [16:15:05.836] VERBOSE: simulator:public-processor Processed tx 0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028 with no public calls in 21.90371099999902ms {"txHash":"0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028","txFee":2101212240,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":6324},"billedGas":{"daGas":16896,"l2Gas":6324},"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":21.90371099999902} 16:15:05 [16:15:05.840] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.049392743000000336s {"duration":0.049392743000000336,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 16:15:05 [16:15:05.870] INFO: sequencer Built block 1 for slot 1 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1a123c4a6e586f7d2394c64600b547c60b4e321d0bbb78e0bb7a53a9f6aab9e9","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"txHashes":["0x03f2f0de49756577a1df36d5d1b21a4f89e1deb03d4bffadf44eed70aaead028"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":89.61635500000011,"publicProcessDuration":50.234080000000176,"rollupCircuitsDuration":83.37813599999936,"txCount":1,"blockNumber":1,"blockTimestamp":1750868376,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:15:05 [16:15:05.873] VERBOSE: sequencer Attesting committee is empty 16:15:08 [16:15:08.584] VERBOSE: node Sent L1 transaction 0xd68acfbd3ccb83090cb6404b31025f57fdd437987d0e6486d46b49521d98222c {"gasLimit":472473,"maxFeePerGas":"500","maxPriorityFeePerGas":"500","maxFeePerBlobGas":"0.000000001"} 16:15:08 [16:15:08.595] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:15:08 [16:15:08.595] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xd68acfbd3ccb83090cb6404b31025f57fdd437987d0e6486d46b49521d98222c","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":1,"blockTimestamp":1750868376,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:15:08 [16:15:08.596] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:15:08 [16:15:08.612] INFO: blob-sink:server Received blob sidecar for block 0x65fe4d8d1a598bec69ed22999ea4f908ab37b04a652e3ba99366a4ab580df55e 16:15:08 [16:15:08.620] INFO: blob-sink:server Blob sidecar stored successfully for block 0x65fe4d8d1a598bec69ed22999ea4f908ab37b04a652e3ba99366a4ab580df55e 16:15:08 [16:15:08.688] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 16:15:08 [16:15:08.690] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 16:15:08 [16:15:08.697] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:15:08 [16:15:08.698] WARN: foundation:test-date-provider Time set to 2025-06-25T16:20:00.000Z {"offset":291302,"timeMs":1750868400000} 16:15:08 [16:15:08.763] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750868412 16:15:08 [16:15:08.763] WARN: foundation:test-date-provider Time set to 2025-06-25T16:20:12.000Z {"offset":303237,"timeMs":1750868412000} 16:15:08 [16:15:08.763] INFO: aztecjs:utils:watcher Slot 1 was filled, jumped to next slot 16:15:08 [16:15:08.862] VERBOSE: archiver:block-helper Store contract class 0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc 16:15:08 [16:15:08.867] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1a123c4a6e586f7d2394c64600b547c60b4e321d0bbb78e0bb7a53a9f6aab9e9","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"archiveRoot":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","archiveNextLeafIndex":2} 16:15:08 [16:15:08.873] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 16:15:08 [16:15:08.914] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for accounts complete. 16:15:08 [16:15:08.924] VERBOSE: e2e:e2e_nested_contract:manual Wallet 0 address: 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 16:15:08 [16:15:08.924] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for public_deploy... 16:15:08 [16:15:08.924] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for public_deploy complete. 16:15:08 [16:15:08.924] VERBOSE: e2e:e2e_nested_contract:manual Public deploy accounts... 16:15:08 [16:15:08.926] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.712381000001187,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750868376,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:15:09 [16:15:09.049] VERBOSE: p2p Synched to latest block 1 16:15:09 [16:15:09.067] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","header":{"contentCommitment":{"blobsHash":"0x00df6222fcdbedf774b5cdb889ef555c4a4e2104a7400623d1e92b407d53ecac","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750868376,"version":3959990455},"lastArchive":"0x29766341a22be5425609b853024cb84da0d5f6529790459dca83cc53327a2f19","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x039d205f7d49412b6264ee2203b3e2c7e69ada59f2c3d97d9a3c8129a8024574","publicDataTree":"0x0b77a511d0c3e99ea8429c19fbcc7ca2c69d8505d599f919f6f8eacb4dc89b9e"},"totalFees":2101212240,"totalManaUsed":6324}} 16:15:09 [16:15:09.108] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:09 [16:15:09.141] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:09 [16:15:09.142] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:09 [16:15:09.179] VERBOSE: sequencer Preparing proposal for block 2 at slot 2 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750868412,"version":3959990455},"chainTipArchive":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","blockNumber":2,"slot":2} 16:15:09 [16:15:09.180] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","blockNumber":2,"slot":2} 16:15:09 [16:15:09.192] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:09 [16:15:09.195] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d3a9f86332a05a16793326dd66ebb5f44aed9d525bf2ec0d55fa62b0f4cfc58 16:15:09 [16:15:09.207] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:15:09 [16:15:09.208] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:15:09 [16:15:09.218] VERBOSE: simulator:client_execution_context:debug_log Found valid nonces for a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:15:09 [16:15:09.218] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:15:09 [16:15:09.224] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:09 [16:15:09.231] VERBOSE: pxe:service Added note {"index":0,"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x176630fe53893fe38bdb7c87eb0736744a3417299a502e91d9cd9ee1c352d1dc","nullifier":"0x16ff704cefe1619105c3d0b4d3f35912dada77bae225f461e9f98ac9ae31956b"} 16:15:09 [16:15:09.243] VERBOSE: simulator:client_execution_context:debug_log Setting 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 as fee payer 16:15:09 [16:15:09.271] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:15:09 [16:15:09.307] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:15:09 [16:15:09.319] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459,0x0000000000000000000000000000000000000000000000000000000000000001,0x29c786abcb77c8acf86bc0a35ba6949d8ee79095bc24a3878aa3b38bf46a7f30,0x2a112e862506f21a7a9bff52581bff7283255edd4e87b0319c41b0147c39dddc,0x0153b9bfce7b8ac9dc4cf4b269ffd01da8a71f19e1606acb0823ddd17ec51cf1,0x2a3c04db6e34961ec43fa506210b3a806a0a2cd59bf4207326fef260cece03e2,0x279e4bd153c03ab329354a9ec816172ae7f5fece43da3fcf148152e74cc436c6,0x0d6e1fc114c48c02fcae784f44ce4f0f513e7183cfe16274300a7ba229dcddfc,0x065dd4fcea8474490ab41032e85ebfc0a5040d86fbf495b38b9b49e172620b1b,0x22c5ef5e60fb43fc8a183f1866e263f7371bfdddcd0518fee01ead1a3f901d05,0x081124cf0e18cec85b352516408cccee545f51ea96cd82ce3fce5d11014fa511,0x151e5da6fd8ddccc21c15bc96ced219b0d14cfdbd4158c12d17831993572ed91,0x19b1cebd7e0620741f5a30ce34a06036e3757af785aedf680af11af6f9dc43de,0x0000000000000000000000000000000000000000000000000000000000000000 16:15:09 [16:15:09.882] VERBOSE: sequencer Preparing proposal for block 2 at slot 2 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750868412,"version":3959990455},"chainTipArchive":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","blockNumber":2,"slot":2} 16:15:09 [16:15:09.889] VERBOSE: sequencer Not enough txs to build block 2 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","blockNumber":2,"slot":2} 16:15:10 [16:15:10.152] INFO: pxe:service Proving completed in 1092.9848519999996ms {"timings":{"total":1092.9848519999996,"sync":9.15817700000116,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":187.149222,"oracles":{"debugLog":{"times":[0.4990140000008978,0.4440549999999348,0.4544719999994413,0.5963830000000598,0.524052999999185,0.3898189999999886,0.42259999999987485,0.4803920000013022]},"fetchTaggedLogs":{"times":[51.414404000001014]},"loadCapsule":{"times":[0.1904579999991256,0.2076550000001589,0.429030999999668,1.9505819999994856,0.22157999999944877,0.17683100000067498,0.2297230000003765,0.1660200000005716,0.16369599999961792,0.14642500000081782]},"getSharedSecret":{"times":[3.4408990000010817]},"aes128Decrypt":{"times":[1.0950050000010378,1.055199000000357]},"getPublicKeysAndPartialAddress":{"times":[1.4691879999991215]},"getKeyValidationRequest":{"times":[6.297298999999839]},"storeCapsule":{"times":[0.5072710000004008,0.9168310000004567,0.2207089999992604]},"deleteCapsule":{"times":[0.4057889999985491]},"bulkRetrieveLogs":{"times":[1.1473710000009305]},"validateEnqueuedNotesAndEvents":{"times":[5.680748000000676]},"getNotes":{"times":[1.4853459999994811]},"getAuthWitness":{"times":[0.2397980000005191]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07871200000045064]},"callPrivateFunction":{"times":[83.19176100000004]}}},{"functionName":"private_kernel_init","time":54.85953700000027},{"functionName":"ContractInstanceDeployer:deploy","time":41.66959300000053,"oracles":{"storeInExecutionCache":{"times":[0.19128200000159268]},"callPrivateFunction":{"times":[39.26354900000115]},"notifyCreatedNullifier":{"times":[0.27626599999894097]},"debugLog":{"times":[0.4882870000001276]}}},{"functionName":"private_kernel_inner","time":108.02176099999997},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":26.846967999999833,"oracles":{}},{"functionName":"private_kernel_inner","time":112.15259399999923},{"functionName":"private_kernel_reset","time":203.44286300000022},{"functionName":"private_kernel_tail","time":70.04416999999921}],"unaccounted":279.63996699999916}} 16:15:10 [16:15:10.192] VERBOSE: p2p:tx_pool Adding tx 0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e to pool {"eventName":"tx-added-to-pool","txHash":"0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 16:15:10 [16:15:10.201] INFO: node Received tx 0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e {"txHash":"0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e"} 16:15:10 [16:15:10.202] INFO: pxe:service Sent transaction 0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e 16:15:10 [16:15:10.412] VERBOSE: sequencer Preparing proposal for block 2 at slot 2 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750868412,"version":3959990455},"chainTipArchive":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","blockNumber":2,"slot":2} 16:15:10 [16:15:10.426] VERBOSE: block-builder Building block 2 for slot 2 {"slot":2,"slotStart":"2025-06-25T16:20:12.000Z","now":"2025-06-25T16:20:13.663Z","blockNumber":2,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x039d205f7d49412b6264ee2203b3e2c7e69ada59f2c3d97d9a3c8129a8024574","publicDataTree":"0x0b77a511d0c3e99ea8429c19fbcc7ca2c69d8505d599f919f6f8eacb4dc89b9e"},"initialArchiveRoot":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 16:15:10 [16:15:10.449] VERBOSE: simulator:public-processor Processed tx 0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e with no public calls in 14.199840999999651ms {"txHash":"0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e","txFee":1173542320,"revertCode":0,"gasUsed":{"totalGas":{"daGas":9728,"l2Gas":3532},"billedGas":{"daGas":9728,"l2Gas":3532},"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":14.199840999999651} 16:15:10 [16:15:10.450] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.021528551999999763s {"duration":0.021528551999999763,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":9728,"l2Gas":3532},"totalSizeInBytes":832} 16:15:10 [16:15:10.473] INFO: sequencer Built block 2 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x177534d97a4ed21448dbb57c7991c32a44c72e0f9f5e807db9941fb8ee9e9b42","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750868412,"version":3959990455},"txHashes":["0x0a060e46de4c61e9dca5870d3951aca5dc5c202e228e61a135f16eebb28c788e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":51.89109699999972,"publicProcessDuration":21.862957999999708,"rollupCircuitsDuration":47.224990000000616,"txCount":1,"blockNumber":2,"blockTimestamp":1750868412,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:15:10 [16:15:10.475] VERBOSE: sequencer Attesting committee is empty 16:15:10 [16:15:10.654] VERBOSE: node Sent L1 transaction 0x33b53d3396d94793273240ddcb8c8bda040789bb7c6c10e9819c223b99b28dbe {"gasLimit":386077,"maxFeePerGas":"1.258122641","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:15:10 [16:15:10.672] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:15:10 [16:15:10.672] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x33b53d3396d94793273240ddcb8c8bda040789bb7c6c10e9819c223b99b28dbe","calldataSize":1252,"calldataGas":9916,"txCount":1,"blockNumber":2,"blockTimestamp":1750868412,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:15:10 [16:15:10.672] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:15:10 [16:15:10.674] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750868448 16:15:10 [16:15:10.675] WARN: foundation:test-date-provider Time set to 2025-06-25T16:20:48.000Z {"offset":337325,"timeMs":1750868448000} 16:15:10 [16:15:10.675] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 16:15:10 [16:15:10.676] INFO: blob-sink:server Received blob sidecar for block 0xe48bef85ceaffe92619a8f7e4a9fc1f3bf72a655a6ce30c62c68f5486477b1af 16:15:10 [16:15:10.681] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe48bef85ceaffe92619a8f7e4a9fc1f3bf72a655a6ce30c62c68f5486477b1af 16:15:10 [16:15:10.769] VERBOSE: archiver:block-helper Store contract instance at 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 16:15:10 [16:15:10.770] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x177534d97a4ed21448dbb57c7991c32a44c72e0f9f5e807db9941fb8ee9e9b42","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750868412,"version":3959990455},"archiveRoot":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","archiveNextLeafIndex":3} 16:15:10 [16:15:10.791] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":5.738147999998546,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750868412,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:15:10 [16:15:10.794] VERBOSE: p2p Synched to latest block 2 16:15:10 [16:15:10.855] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 16:15:10 [16:15:10.856] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 16:15:11 [16:15:11.191] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:11 [16:15:11.192] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:11 [16:15:11.204] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 Applying state transition for manual... 16:15:11 [16:15:11.348] WARN: pxe:service No artifact found for contract class 0x1b65c8b0134ffdde2e5bda426e3f768c735fdc51aed59a8b93d4855a312a69c2 when looking for its metadata 16:15:11 [16:15:11.353] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1b65c8b0134ffdde2e5bda426e3f768c735fdc51aed59a8b93d4855a312a69c2 as part of deployment for 0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801 16:15:11 [16:15:11.503] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 16:15:11 [16:15:11.619] INFO: pxe:service Added contract Parent at 0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801 with class 0x1b65c8b0134ffdde2e5bda426e3f768c735fdc51aed59a8b93d4855a312a69c2 16:15:11 [16:15:11.647] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","header":{"contentCommitment":{"blobsHash":"0x00d5a1267dfad9a8186634e384e5c8e30c62e3072c72bd6cdc8da1e9f6c32c2a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750868412,"version":3959990455},"lastArchive":"0x21b84ca28ac5b7f3e8eddf81eaad7468959195e3a0fba9e29086d7a776b54568","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x133bc83518a1cbf8da5d71a67031b789d268fc4a67dd459c46ed77285fd673e0","publicDataTree":"0x0c6afdc45fba00d8f98c3bdf1aa02ee72e6cd6ef0841a0508400b81ac0e3c167"},"totalFees":1173542320,"totalManaUsed":3532}} 16:15:11 [16:15:11.689] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:11 [16:15:11.722] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:11 [16:15:11.722] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:11 [16:15:11.753] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:11 [16:15:11.755] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:11 [16:15:11.762] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:11 [16:15:11.766] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d3a9f86332a05a16793326dd66ebb5f44aed9d525bf2ec0d55fa62b0f4cfc58 16:15:11 [16:15:11.776] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:15:11 [16:15:11.777] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:15:11 [16:15:11.782] VERBOSE: simulator:client_execution_context:debug_log Found valid nonces for a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:15:11 [16:15:11.783] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:15:11 [16:15:11.785] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:11 [16:15:11.792] VERBOSE: pxe:service Added note {"index":0,"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x176630fe53893fe38bdb7c87eb0736744a3417299a502e91d9cd9ee1c352d1dc","nullifier":"0x16ff704cefe1619105c3d0b4d3f35912dada77bae225f461e9f98ac9ae31956b"} 16:15:11 [16:15:11.804] VERBOSE: simulator:client_execution_context:debug_log Setting 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 as fee payer 16:15:11 [16:15:11.843] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:15:12 [16:15:12.408] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x1b65c8b0134ffdde2e5bda426e3f768c735fdc51aed59a8b93d4855a312a69c2,0x1433d6f7db93cc6989c06c3b719999509a273a95a9683a810954c2443a15f510,0x041c4d4abb1bdd2629a5e1a478e2c7b20466e714f64cc4957911563d0199aabf,0x28700b4d2106bcf639e64f9115497c86d1cc6bf34fb0488f7cf583dda08608a4 16:15:12 [16:15:12.479] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:15:12 [16:15:12.641] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:15:12 [16:15:12.648] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:12 [16:15:12.651] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:12 [16:15:12.683] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:15:12 [16:15:12.695] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801,0x0000000000000000000000000000000000000000000000000000000000000001,0x0a5c04a49adfb2294cfd040f6dcd39202c599c6388a8fd5186b2c54a96cf1fd7,0x1b65c8b0134ffdde2e5bda426e3f768c735fdc51aed59a8b93d4855a312a69c2,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 16:15:13 [16:15:13.289] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:13 [16:15:13.664] INFO: pxe:service Proving completed in 2029.8607439999978ms {"timings":{"total":2029.8607439999978,"sync":18.837454999997135,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":175.63596399999733,"oracles":{"debugLog":{"times":[0.4769989999986137,0.39996099999916623,0.4147369999991497,0.5716690000008384,0.44348899999749847,0.37900399999853107,0.33264499999859254,0.46284400000149617]},"fetchTaggedLogs":{"times":[42.42977500000052]},"loadCapsule":{"times":[0.21779400000013993,0.16109399999913876,0.39225900000019465,0.21331199999985984,0.1813030000012077,0.15178300000115996,0.18606899999940651,0.14271799999914947,0.17027600000074017,0.17333199999848148]},"getSharedSecret":{"times":[2.707361000000674]},"aes128Decrypt":{"times":[0.23198899999988498,0.9642160000003059]},"getPublicKeysAndPartialAddress":{"times":[1.3139499999997497]},"getKeyValidationRequest":{"times":[1.547030999998242]},"storeCapsule":{"times":[0.2802460000020801,0.2369909999979427,0.18055100000128732]},"deleteCapsule":{"times":[0.1876700000029814]},"bulkRetrieveLogs":{"times":[0.8972079999984999]},"validateEnqueuedNotesAndEvents":{"times":[6.285508999997546]},"getNotes":{"times":[1.159977000002982]},"getAuthWitness":{"times":[0.23391199999969103]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06457000000227708]},"callPrivateFunction":{"times":[779.103275999998,114.03689200000008]}}},{"functionName":"private_kernel_init","time":60.28508299999885},{"functionName":"ContractClassRegisterer:register","time":765.9065520000004,"oracles":{"loadCapsule":{"times":[4.358405999999377]},"notifyCreatedNullifier":{"times":[0.28006100000129663]},"debugLog":{"times":[0.4556349999984377]},"notifyCreatedContractClassLog":{"times":[7.3557029999974475]}}},{"functionName":"private_kernel_inner","time":110.81854899999962},{"functionName":"ContractInstanceDeployer:deploy","time":74.35913200000505,"oracles":{"storeInExecutionCache":{"times":[0.07038900000043213]},"callPrivateFunction":{"times":[45.064525999998295]},"notifyCreatedNullifier":{"times":[0.34262200000011944]},"debugLog":{"times":[0.4497139999984938]}}},{"functionName":"private_kernel_inner","time":109.72043800000029},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":27.470078999998805,"oracles":{}},{"functionName":"private_kernel_inner","time":111.41353900000104},{"functionName":"private_kernel_reset","time":190.49918100000286},{"functionName":"private_kernel_tail","time":69.177423000001}],"unaccounted":315.73734899999545}} 16:15:13 [16:15:13.677] VERBOSE: sequencer Not enough txs to build block 3 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:13 [16:15:13.751] VERBOSE: p2p:tx_pool Adding tx 0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025 to pool {"eventName":"tx-added-to-pool","txHash":"0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":260,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 16:15:13 [16:15:13.769] INFO: node Received tx 0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025 {"txHash":"0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025"} 16:15:13 [16:15:13.770] INFO: pxe:service Sent transaction 0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025 16:15:14 [16:15:14.194] VERBOSE: sequencer Preparing proposal for block 3 at slot 3 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"chainTipArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","blockNumber":3,"slot":3} 16:15:14 [16:15:14.211] VERBOSE: block-builder Building block 3 for slot 3 {"slot":3,"slotStart":"2025-06-25T16:20:48.000Z","now":"2025-06-25T16:20:51.536Z","blockNumber":3,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x133bc83518a1cbf8da5d71a67031b789d268fc4a67dd459c46ed77285fd673e0","publicDataTree":"0x0c6afdc45fba00d8f98c3bdf1aa02ee72e6cd6ef0841a0508400b81ac0e3c167"},"initialArchiveRoot":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 16:15:14 [16:15:14.259] VERBOSE: simulator:public-processor Processed tx 0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025 with no public calls in 23.179800999998406ms {"txHash":"0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025","txFee":1675254920,"revertCode":0,"gasUsed":{"totalGas":{"daGas":144384,"l2Gas":5042},"billedGas":{"daGas":144384,"l2Gas":5042},"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":23.179800999998406} 16:15:14 [16:15:14.260] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04810609499999919s {"duration":0.04810609499999919,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":144384,"l2Gas":5042},"totalSizeInBytes":9280} 16:15:14 [16:15:14.299] INFO: sequencer Built block 3 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0951fe45940aacc17479d7d89f816caa540ffe284784ca1d8ca8fc4392eb7562","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"txHashes":["0x11c867562d4fc891f6ff71ecf827bbff861c66be03e4c6c29a731a1dc8962025"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":93.14675899999929,"publicProcessDuration":48.42092699999921,"rollupCircuitsDuration":88.48887800000011,"txCount":1,"blockNumber":3,"blockTimestamp":1750868448,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":260} 16:15:14 [16:15:14.301] VERBOSE: sequencer Attesting committee is empty 16:15:14 [16:15:14.501] VERBOSE: node Sent L1 transaction 0xa91e296f317ad81775cabace5e6cd6dc0f76daf6179898e9dffc4d2d43ec4987 {"gasLimit":386120,"maxFeePerGas":"1.24461069","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:15:14 [16:15:14.514] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:15:14 [16:15:14.514] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xa91e296f317ad81775cabace5e6cd6dc0f76daf6179898e9dffc4d2d43ec4987","calldataSize":1252,"calldataGas":9952,"txCount":1,"blockNumber":3,"blockTimestamp":1750868448,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":260} 16:15:14 [16:15:14.515] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:15:14 [16:15:14.519] INFO: blob-sink:server Received blob sidecar for block 0x36e1bcef53e5555d0bb30d6b436b75d08e5533e5f485120c4333fe207be2b4d7 16:15:14 [16:15:14.522] INFO: blob-sink:server Blob sidecar stored successfully for block 0x36e1bcef53e5555d0bb30d6b436b75d08e5533e5f485120c4333fe207be2b4d7 16:15:14 [16:15:14.601] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750868484 16:15:14 [16:15:14.601] WARN: foundation:test-date-provider Time set to 2025-06-25T16:21:24.000Z {"offset":369399,"timeMs":1750868484000} 16:15:14 [16:15:14.601] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 16:15:14 [16:15:14.703] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 16:15:14 [16:15:14.705] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 16:15:14 [16:15:14.773] VERBOSE: archiver:block-helper Store contract instance at 0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801 16:15:14 [16:15:14.777] VERBOSE: archiver:block-helper Store contract class 0x1b65c8b0134ffdde2e5bda426e3f768c735fdc51aed59a8b93d4855a312a69c2 16:15:14 [16:15:14.790] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x0951fe45940aacc17479d7d89f816caa540ffe284784ca1d8ca8fc4392eb7562","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"archiveRoot":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","archiveNextLeafIndex":4} 16:15:14 [16:15:14.794] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 16:15:14 [16:15:14.821] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":5.811363000000711,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750868448,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":260} 16:15:14 [16:15:14.838] VERBOSE: p2p Synched to latest block 3 16:15:15 [16:15:15.033] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:15 [16:15:15.034] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:15 [16:15:15.550] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:15 [16:15:15.551] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:15 [16:15:15.865] INFO: aztecjs:deploy_sent_tx Contract 0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801 successfully deployed. 16:15:15 [16:15:15.930] WARN: pxe:service No artifact found for contract class 0x006db20afd408347c66f8996e8290e82ada91e1cc835a79a256a006538914703 when looking for its metadata 16:15:15 [16:15:15.934] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x006db20afd408347c66f8996e8290e82ada91e1cc835a79a256a006538914703 as part of deployment for 0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614 16:15:16 [16:15:16.125] INFO: pxe:service Added contract Child at 0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614 with class 0x006db20afd408347c66f8996e8290e82ada91e1cc835a79a256a006538914703 16:15:16 [16:15:16.138] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:16 [16:15:16.142] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:16 [16:15:16.155] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","header":{"contentCommitment":{"blobsHash":"0x0022c731e18ed6b6a5d12003f0006d5ddebec2c9535be37b0e706968dd2eba5d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750868448,"version":3959990455},"lastArchive":"0x2c97cbc0ade2d1fae3c102663b631b14d1128f83b9dcac161fc55861417282b3","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x166a410506a69cb71b4b0cb83c858190e6934c272777b486c87530298519349f","publicDataTree":"0x2cdb4e288334672123501b07e772eef94d8dcbbb93279a3ec0eca1fa491154eb"},"totalFees":1675254920,"totalManaUsed":5042}} 16:15:16 [16:15:16.196] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:16 [16:15:16.229] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:16 [16:15:16.230] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:16 [16:15:16.262] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:16 [16:15:16.266] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d3a9f86332a05a16793326dd66ebb5f44aed9d525bf2ec0d55fa62b0f4cfc58 16:15:16 [16:15:16.276] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:15:16 [16:15:16.277] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:15:16 [16:15:16.281] VERBOSE: simulator:client_execution_context:debug_log Found valid nonces for a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:15:16 [16:15:16.282] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:15:16 [16:15:16.284] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:16 [16:15:16.289] VERBOSE: pxe:service Added note {"index":0,"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x176630fe53893fe38bdb7c87eb0736744a3417299a502e91d9cd9ee1c352d1dc","nullifier":"0x16ff704cefe1619105c3d0b4d3f35912dada77bae225f461e9f98ac9ae31956b"} 16:15:16 [16:15:16.301] VERBOSE: simulator:client_execution_context:debug_log Setting 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 as fee payer 16:15:16 [16:15:16.347] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:15:16 [16:15:16.971] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x006db20afd408347c66f8996e8290e82ada91e1cc835a79a256a006538914703,0x22f067327bfd522b1ae38a5e1152f2186efb51715e675c65367c60d8f235c975,0x041a2db24e7e11c282d9a838afbcc26fb39aa6aabcba07ad288df9f384c39168,0x0aadc79b51eb877ecdac1244d8c443b6a25d7295ab801c4eb4da5e1b6230e719 16:15:17 [16:15:17.042] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:15:17 [16:15:17.217] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:15:17 [16:15:17.227] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:17 [16:15:17.229] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:17 [16:15:17.259] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:15:17 [16:15:17.269] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614,0x0000000000000000000000000000000000000000000000000000000000000001,0x2f3add9e05a956ec609c7e66ae9004f1741c87511211ea068a200b6b5880c005,0x006db20afd408347c66f8996e8290e82ada91e1cc835a79a256a006538914703,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 16:15:17 [16:15:17.874] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:18 [16:15:18.249] INFO: pxe:service Proving completed in 2102.2655769999983ms {"timings":{"total":2102.2655769999983,"sync":9.247469000001729,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":169.76950700000089,"oracles":{"debugLog":{"times":[0.4537139999993087,0.3864740000026359,0.41463500000099884,0.5071289999978035,0.4279949999981909,0.3746869999995397,0.32714599999962957,0.44801400000142166]},"fetchTaggedLogs":{"times":[35.033321000002616]},"loadCapsule":{"times":[0.1739080000006652,0.15683399999761605,0.37403400000039255,0.19870000000082655,0.17562700000053155,0.17950800000107847,0.19646199999988312,0.15144000000145752,0.15229900000122143,0.14593999999851803]},"getSharedSecret":{"times":[2.6012550000014016]},"aes128Decrypt":{"times":[0.25340000000142027,0.9484569999985979]},"getPublicKeysAndPartialAddress":{"times":[1.2092010000014852]},"getKeyValidationRequest":{"times":[1.1992519999985234]},"storeCapsule":{"times":[0.27385100000174134,0.2251959999994142,0.3331510000025446]},"deleteCapsule":{"times":[0.2038990000000922]},"bulkRetrieveLogs":{"times":[0.817375999999058]},"validateEnqueuedNotesAndEvents":{"times":[3.734057000001485]},"getNotes":{"times":[1.1433249999972759]},"getAuthWitness":{"times":[0.220737999999983]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05011199999717064]},"callPrivateFunction":{"times":[847.5667509999985,126.9288779999988]}}},{"functionName":"private_kernel_init","time":54.598000000001775},{"functionName":"ContractClassRegisterer:register","time":831.2357480000028,"oracles":{"loadCapsule":{"times":[4.01742600000216]},"notifyCreatedNullifier":{"times":[0.28071499999714433]},"debugLog":{"times":[0.49793900000076974]},"notifyCreatedContractClassLog":{"times":[7.375272000001132]}}},{"functionName":"private_kernel_inner","time":111.92314700000134},{"functionName":"ContractInstanceDeployer:deploy","time":79.3057849999932,"oracles":{"storeInExecutionCache":{"times":[0.0914020000018354]},"callPrivateFunction":{"times":[44.02969000000303]},"notifyCreatedNullifier":{"times":[0.24367000000347616]},"debugLog":{"times":[0.48160900000220863]}}},{"functionName":"private_kernel_inner","time":110.54090499999802},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":32.715439000003244,"oracles":{}},{"functionName":"private_kernel_inner","time":110.7178070000009},{"functionName":"private_kernel_reset","time":190.26953299999877},{"functionName":"private_kernel_tail","time":69.83153799999855}],"unaccounted":332.1106989999971}} 16:15:18 [16:15:18.265] VERBOSE: sequencer Not enough txs to build block 4 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:18 [16:15:18.347] VERBOSE: p2p:tx_pool Adding tx 0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4 to pool {"eventName":"tx-added-to-pool","txHash":"0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":145,"proofSize":172052,"size":292848,"feePaymentMethod":"fee_juice"} 16:15:18 [16:15:18.367] INFO: node Received tx 0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4 {"txHash":"0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4"} 16:15:18 [16:15:18.367] INFO: pxe:service Sent transaction 0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4 16:15:18 [16:15:18.782] VERBOSE: sequencer Preparing proposal for block 4 at slot 4 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"chainTipArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","blockNumber":4,"slot":4} 16:15:18 [16:15:18.795] VERBOSE: block-builder Building block 4 for slot 4 {"slot":4,"slotStart":"2025-06-25T16:21:24.000Z","now":"2025-06-25T16:21:28.194Z","blockNumber":4,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x166a410506a69cb71b4b0cb83c858190e6934c272777b486c87530298519349f","publicDataTree":"0x2cdb4e288334672123501b07e772eef94d8dcbbb93279a3ec0eca1fa491154eb"},"initialArchiveRoot":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 16:15:18 [16:15:18.837] VERBOSE: simulator:public-processor Processed tx 0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4 with no public calls in 20.396731000000727ms {"txHash":"0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4","txFee":1675254920,"revertCode":0,"gasUsed":{"totalGas":{"daGas":85504,"l2Gas":5042},"billedGas":{"daGas":85504,"l2Gas":5042},"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":20.396731000000727} 16:15:18 [16:15:18.839] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04147139199999947s {"duration":0.04147139199999947,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":85504,"l2Gas":5042},"totalSizeInBytes":5600} 16:15:18 [16:15:18.879] INFO: sequencer Built block 4 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2879bd41b1370d5c103a0d6cd13e35abc9d913080d46fde3775b42b7847166ae","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"txHashes":["0x0d712ae5b95c1fe5ae411c7b4d1bbb6db53dab0778be731a65f7d961fea51ce4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":88.27986199999941,"publicProcessDuration":41.828459000000294,"rollupCircuitsDuration":83.58729599999788,"txCount":1,"blockNumber":4,"blockTimestamp":1750868484,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":145} 16:15:18 [16:15:18.882] VERBOSE: sequencer Attesting committee is empty 16:15:19 [16:15:19.077] VERBOSE: node Sent L1 transaction 0xeef8be445f833d7bd3062b62f442d5f9272f4b9acb693ecec36417b9a7af7847 {"gasLimit":386134,"maxFeePerGas":"1.234239916","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:15:19 [16:15:19.085] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:15:19 [16:15:19.085] WARN: foundation:test-date-provider Time set to 2025-06-25T16:21:36.000Z {"offset":376915,"timeMs":1750868496000} 16:15:19 [16:15:19.087] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:15:19 [16:15:19.087] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xeef8be445f833d7bd3062b62f442d5f9272f4b9acb693ecec36417b9a7af7847","calldataSize":1252,"calldataGas":9964,"txCount":1,"blockNumber":4,"blockTimestamp":1750868484,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":145} 16:15:19 [16:15:19.088] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:15:19 [16:15:19.092] INFO: blob-sink:server Received blob sidecar for block 0xa6f84e27ca41ccbd9c57d475d4254b340424751dcbec959921334de17089217c 16:15:19 [16:15:19.095] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa6f84e27ca41ccbd9c57d475d4254b340424751dcbec959921334de17089217c 16:15:19 [16:15:19.114] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 16:15:19 [16:15:19.116] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 16:15:19 [16:15:19.178] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750868520 16:15:19 [16:15:19.178] WARN: foundation:test-date-provider Time set to 2025-06-25T16:22:00.000Z {"offset":400822,"timeMs":1750868520000} 16:15:19 [16:15:19.178] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 16:15:19 [16:15:19.505] VERBOSE: archiver:block-helper Store contract instance at 0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614 16:15:19 [16:15:19.508] VERBOSE: archiver:block-helper Store contract class 0x006db20afd408347c66f8996e8290e82ada91e1cc835a79a256a006538914703 16:15:19 [16:15:19.515] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x2879bd41b1370d5c103a0d6cd13e35abc9d913080d46fde3775b42b7847166ae","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"archiveRoot":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","archiveNextLeafIndex":5} 16:15:19 [16:15:19.521] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 16:15:19 [16:15:19.608] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":5.827836000000389,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750868484,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":145} 16:15:19 [16:15:19.635] VERBOSE: p2p Synched to latest block 4 16:15:20 [16:15:20.110] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750868520,"version":3959990455},"chainTipArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","blockNumber":5,"slot":5} 16:15:20 [16:15:20.111] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","blockNumber":5,"slot":5} 16:15:20 [16:15:20.404] INFO: aztecjs:deploy_sent_tx Contract 0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614 successfully deployed. 16:15:20 [16:15:20.404] VERBOSE: e2e:snapshot_manager:e2e_nested_contract/manual-1 State transition for manual complete. 16:15:20 [16:15:20.518] INFO: e2e:manual_private_call Running test: e2e_nested_contract manual performs nested calls 16:15:20 [16:15:20.543] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","header":{"contentCommitment":{"blobsHash":"0x009556f989260285ecf4365a5bc817b11629cf4d8f4937032e38f332533c531f","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750868484,"version":3959990455},"lastArchive":"0x2a251154fe1290ae52da8c25a2a2c2cf1cdc238ee33e8d554f7a5b74973d5cbf","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x17b0da7f1a174c5fdc535b4bfb0abc7c3433cbc6825b8a318dcf203a9e8e5d92","publicDataTree":"0x053836bddbfb6d1f0e0761649ff5d5512bacf5bd057481bde16d22ce51fa1ff3"},"totalFees":1675254920,"totalManaUsed":5042}} 16:15:20 [16:15:20.589] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:20 [16:15:20.622] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:20 [16:15:20.623] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:20 [16:15:20.660] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750868520,"version":3959990455},"chainTipArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","blockNumber":5,"slot":5} 16:15:20 [16:15:20.661] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","blockNumber":5,"slot":5} 16:15:20 [16:15:20.669] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:20 [16:15:20.676] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d3a9f86332a05a16793326dd66ebb5f44aed9d525bf2ec0d55fa62b0f4cfc58 16:15:20 [16:15:20.686] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:15:20 [16:15:20.686] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:15:20 [16:15:20.691] VERBOSE: simulator:client_execution_context:debug_log Found valid nonces for a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:15:20 [16:15:20.692] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:15:20 [16:15:20.695] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:20 [16:15:20.699] VERBOSE: pxe:service Added note {"index":0,"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x176630fe53893fe38bdb7c87eb0736744a3417299a502e91d9cd9ee1c352d1dc","nullifier":"0x16ff704cefe1619105c3d0b4d3f35912dada77bae225f461e9f98ac9ae31956b"} 16:15:20 [16:15:20.711] VERBOSE: simulator:client_execution_context:debug_log Setting 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 as fee payer 16:15:20 [16:15:20.777] VERBOSE: simulator:private_execution Executing private function Parent:entry_point {"contract":"0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801"} 16:15:20 [16:15:20.787] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:20 [16:15:20.788] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801"} 16:15:20 [16:15:20.823] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801"} 16:15:20 [16:15:20.826] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:20 [16:15:20.865] VERBOSE: simulator:private_execution Executing private function Child:value {"contract":"0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614"} 16:15:20 [16:15:20.875] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:20 [16:15:20.875] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614"} 16:15:20 [16:15:20.894] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614"} 16:15:20 [16:15:20.898] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:21 [16:15:21.371] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750868520,"version":3959990455},"chainTipArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","blockNumber":5,"slot":5} 16:15:21 [16:15:21.396] VERBOSE: sequencer Not enough txs to build block 5 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","blockNumber":5,"slot":5} 16:15:21 [16:15:21.825] INFO: pxe:service Proving completed in 1291.7062129999977ms {"timings":{"total":1291.7062129999977,"sync":11.478339999997843,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":191.28029400000014,"oracles":{"debugLog":{"times":[0.42772400000103517,0.397423999998864,0.4213469999995141,0.5329060000003665,0.44711699999970733,0.41846000000077765,0.3658550000000105,0.48094700000001467]},"fetchTaggedLogs":{"times":[49.16487699999925]},"loadCapsule":{"times":[0.18428600000333972,0.14872500000274158,2.3174509999989823,0.39884100000199396,0.16815199999837205,0.1420399999988149,0.1931490000024496,0.13805900000079419,0.13591299999825424,0.12186100000326405]},"getSharedSecret":{"times":[2.880565999999817]},"aes128Decrypt":{"times":[0.2351380000000063,0.9690580000024056]},"getPublicKeysAndPartialAddress":{"times":[1.188758999996935]},"getKeyValidationRequest":{"times":[1.4669800000010582]},"storeCapsule":{"times":[0.3480500000005122,0.19845400000122027,0.22390900000027614]},"deleteCapsule":{"times":[0.41661300000123447]},"bulkRetrieveLogs":{"times":[0.8001850000000559]},"validateEnqueuedNotesAndEvents":{"times":[3.434936999998172]},"getNotes":{"times":[1.2454209999996237]},"getAuthWitness":{"times":[0.21922100000301725]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.056338999998843065]},"callPrivateFunction":{"times":[201.74116200000208]}}},{"functionName":"private_kernel_init","time":54.21267799999987},{"functionName":"Parent:entry_point","time":112.3482839999997,"oracles":{"debugLog":{"times":[0.43977199999790173,0.37931399999797577]},"fetchTaggedLogs":{"times":[36.66820700000244]},"loadCapsule":{"times":[0.17103900000074646,0.16556100000161678,0.20706299999801558,0.14498699999967357,0.14505500000086613,0.12927400000262423]},"bulkRetrieveLogs":{"times":[0.8948760000021139]},"validateEnqueuedNotesAndEvents":{"times":[0.8978239999996731]},"storeInExecutionCache":{"times":[0.04343399999925168,0.04707299999790848]},"callPrivateFunction":{"times":[78.65665799999988]},"loadFromExecutionCache":{"times":[0.14382900000055088]}}},{"functionName":"private_kernel_inner","time":106.34939899999881},{"functionName":"Child:value","time":63.172826000001805,"oracles":{"debugLog":{"times":[0.47551300000122865,0.3928990000022168]},"fetchTaggedLogs":{"times":[21.516497000000527]},"loadCapsule":{"times":[0.19871700000294368,0.17354300000079093,0.21071799999845098,0.20797299999685492,0.22508300000117742,0.24181099999987055]},"bulkRetrieveLogs":{"times":[2.543647000002238]},"validateEnqueuedNotesAndEvents":{"times":[0.9767250000004424]},"storeInExecutionCache":{"times":[0.048666999999113614]}}},{"functionName":"private_kernel_inner","time":109.09763100000055},{"functionName":"private_kernel_reset","time":188.93278799999825},{"functionName":"private_kernel_tail","time":69.19536400000288}],"unaccounted":385.6386089999978}} 16:15:21 [16:15:21.856] VERBOSE: p2p:tx_pool Adding tx 0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38 to pool {"eventName":"tx-added-to-pool","txHash":"0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196240,"feePaymentMethod":"fee_juice"} 16:15:21 [16:15:21.860] INFO: node Received tx 0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38 {"txHash":"0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38"} 16:15:21 [16:15:21.860] INFO: pxe:service Sent transaction 0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38 16:15:21 [16:15:21.912] VERBOSE: sequencer Preparing proposal for block 5 at slot 5 {"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750868520,"version":3959990455},"chainTipArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","blockNumber":5,"slot":5} 16:15:21 [16:15:21.925] VERBOSE: block-builder Building block 5 for slot 5 {"slot":5,"slotStart":"2025-06-25T16:22:00.000Z","now":"2025-06-25T16:22:02.747Z","blockNumber":5,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x17b0da7f1a174c5fdc535b4bfb0abc7c3433cbc6825b8a318dcf203a9e8e5d92","publicDataTree":"0x053836bddbfb6d1f0e0761649ff5d5512bacf5bd057481bde16d22ce51fa1ff3"},"initialArchiveRoot":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 16:15:21 [16:15:21.946] VERBOSE: simulator:public-processor Processed tx 0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38 with no public calls in 13.477374999998574ms {"txHash":"0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38","txFee":50974620,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1024,"l2Gas":2022},"billedGas":{"daGas":1024,"l2Gas":2022},"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":13.477374999998574} 16:15:21 [16:15:21.948] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.021203397000001133s {"duration":0.021203397000001133,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1024,"l2Gas":2022},"totalSizeInBytes":256} 16:15:21 [16:15:21.975] INFO: sequencer Built block 5 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0e3810df5ee9f1a2d246190956935ec0c76d49c9ffb52403fc894e9173b42161","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750868520,"version":3959990455},"txHashes":["0x2b4eb5c21576c7068226ab48ebe928af105faa9f07b535f2573ba176d3f7ee38"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":55.17872900000293,"publicProcessDuration":21.91265900000144,"rollupCircuitsDuration":50.545523000000685,"txCount":1,"blockNumber":5,"blockTimestamp":1750868520,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:15:21 [16:15:21.977] VERBOSE: sequencer Attesting committee is empty 16:15:22 [16:15:22.146] VERBOSE: node Sent L1 transaction 0xc4d605da2c573e462773d386872ebe193a0d2b8b2a96910294d1203131054a77 {"gasLimit":386118,"maxFeePerGas":"1.226280067","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:15:22 [16:15:22.157] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:15:22 [16:15:22.157] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xc4d605da2c573e462773d386872ebe193a0d2b8b2a96910294d1203131054a77","calldataSize":1252,"calldataGas":9940,"txCount":1,"blockNumber":5,"blockTimestamp":1750868520,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:15:22 [16:15:22.157] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:15:22 [16:15:22.159] INFO: blob-sink:server Received blob sidecar for block 0x5114347dec6010021a742abbce09d756a56fef37753e32ab10b58aadb96021aa 16:15:22 [16:15:22.163] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5114347dec6010021a742abbce09d756a56fef37753e32ab10b58aadb96021aa 16:15:22 [16:15:22.254] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 16:15:22 [16:15:22.254] WARN: foundation:test-date-provider Time set to 2025-06-25T16:22:12.000Z {"offset":409746,"timeMs":1750868532000} 16:15:22 [16:15:22.255] WARN: ethereum:cheat_codes Set L1 storage for contract 0xc6e7df5e7b4f2a278906862b61205850344d4e7d at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 16:15:22 [16:15:22.257] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 16:15:22 [16:15:22.364] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750868556 16:15:22 [16:15:22.365] WARN: foundation:test-date-provider Time set to 2025-06-25T16:22:36.000Z {"offset":433635,"timeMs":1750868556000} 16:15:22 [16:15:22.365] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 16:15:22 [16:15:22.587] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x0e3810df5ee9f1a2d246190956935ec0c76d49c9ffb52403fc894e9173b42161","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750868520,"version":3959990455},"archiveRoot":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","archiveNextLeafIndex":6} 16:15:22 [16:15:22.590] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 16:15:22 [16:15:22.690] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":5.822406000002957,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750868520,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:15:22 [16:15:22.697] VERBOSE: p2p Synched to latest block 5 16:15:22 [16:15:22.864] INFO: e2e:manual_private_call Running test: e2e_nested_contract manual fails simulation if calling a function not allowed to be called externally 16:15:22 [16:15:22.881] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 {"origin":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000ec08a8b7","authWitnesses":["0x17e8960f9c90249d45c69378d604fb2f5b6b8b87309c0fb02fd450cc4d2ecb17"]} 16:15:22 [16:15:22.886] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","header":{"contentCommitment":{"blobsHash":"0x00d3ebf449d200ee8f5276011a667de521425ed2e947513d972e95d12f70d820","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750868520,"version":3959990455},"lastArchive":"0x0d832f5b739ac6638e271e5f9ebb90b3fbde4bfae4bbdc8970d118c0ea29bcbe","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2d4bbcb6cb7f8303c50120817e9c4b3ba5bc4c8a4d5c3f706478b98095ea9aee","nullifierTree":"0x2346c4098be47693d85127bb5ffcd2b37ba83c5fb7734a7de79b70db82e01e69","publicDataTree":"0x169f1efac772bfd149a0a6b77a6a6e44592c6bdaeb76bd9cc1f0a965cea47d82"},"totalFees":50974620,"totalManaUsed":2022}} 16:15:22 [16:15:22.922] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:22 [16:15:22.955] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:22 [16:15:22.956] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:22 [16:15:22.979] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459"} 16:15:22 [16:15:22.983] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2d3a9f86332a05a16793326dd66ebb5f44aed9d525bf2ec0d55fa62b0f4cfc58 16:15:22 [16:15:22.993] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:15:22 [16:15:22.994] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:15:23 [16:15:23.004] VERBOSE: simulator:client_execution_context:debug_log Found valid nonces for a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:15:23 [16:15:23.005] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:15:23 [16:15:23.008] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:23 [16:15:23.013] VERBOSE: pxe:service Added note {"index":0,"contract":"0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x176630fe53893fe38bdb7c87eb0736744a3417299a502e91d9cd9ee1c352d1dc","nullifier":"0x16ff704cefe1619105c3d0b4d3f35912dada77bae225f461e9f98ac9ae31956b"} 16:15:23 [16:15:23.026] VERBOSE: simulator:client_execution_context:debug_log Setting 0x291d7e7b2d6c63082f62083a3fcf59422d14c2d7ac50e4ce79875745b1273459 as fee payer 16:15:23 [16:15:23.091] VERBOSE: simulator:private_execution Executing private function Parent:entry_point {"contract":"0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801"} 16:15:23 [16:15:23.101] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:15:23 [16:15:23.102] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801"} 16:15:23 [16:15:23.138] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1935ff6eb9da6826ab28b1d68e285bc992954d85be0b007276816698499df801"} 16:15:23 [16:15:23.142] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:15:23 [16:15:23.181] VERBOSE: simulator:private_execution Executing private function Child:value_internal {"contract":"0x0943a3d1becd7013f5bb0d0200978af01e7f45d002b29df91d8dddb8553df614"} 16:15:23 [16:15:23.244] INFO: e2e:e2e_nested_contract Tearing down subsystems 16:15:23 [16:15:23.245] INFO: node Stopping Aztec Node 16:15:23 [16:15:23.264] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750868556,"version":3959990455},"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:23 [16:15:23.265] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:23 [16:15:23.777] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750868556,"version":3959990455},"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:23 [16:15:23.777] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:24 [16:15:24.287] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750868556,"version":3959990455},"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:24 [16:15:24.287] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:24 [16:15:24.797] VERBOSE: sequencer Preparing proposal for block 6 at slot 6 {"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":25210,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750868556,"version":3959990455},"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:24 [16:15:24.798] VERBOSE: sequencer Not enough txs to build block 6 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x00e532762c54fc8ae4e554fce62824431bf67f1fad37e6c52b34a3b68bde8ef2","blockNumber":6,"slot":6} 16:15:25 [16:15:25.246] INFO: slasher Slasher client stopped. 16:15:25 [16:15:25.246] INFO: sequencer Stopped sequencer 16:15:25 [16:15:25.247] INFO: p2p P2P client stopped 16:15:25 [16:15:25.248] INFO: world_state Stopped world state synchronizer 16:15:25 [16:15:25.248] INFO: archiver Stopped. 16:15:25 [16:15:25.248] INFO: node Stopped Aztec Node 16:15:25 [16:15:25.256] INFO: blob-sink:server Stopping blob sink 16:15:25 [16:15:25.257] INFO: blob-sink:server Blob sink stopped 16:15:25 PASS src/e2e_nested_contract/manual_private_call.test.ts 16:15:25 e2e_nested_contract manual 16:15:25 ✓ performs nested calls (2347 ms) 16:15:25 ✓ fails simulation if calling a function not allowed to be called externally (380 ms) 16:15:25 16:15:25 Test Suites: 1 passed, 1 total 16:15:25 Tests: 2 passed, 2 total 16:15:25 Snapshots: 0 total 16:15:25 Time: 30.374 s 16:15:25 Ran all test suites matching src/e2e_nested_contract/manual_private_call.test.ts. 16:15:25 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?