Parent Log: http://ci.aztec-labs.com/b77d7025149214cb Command: a173e32263f6bc73:ISOLATE=1:NAME=e2e_partial_notes yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_partial_notes.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/71fe6b444df8fafa5531226cf458dbd22d2f3ab7 Env: REF_NAME=gh-readonly-queue/master/pr-15117-c06f30929f18b85bcea93c0926a8d640a3819f00 CURRENT_VERSION=0.87.8 CI_FULL=0 Date: Tue Jun 17 19:31:50 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15117_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_6b4a73ce992ff502_master 19:31:50 +++ id -u 19:31:50 +++ id -g 19:31:50 ++ docker run -d --name e2e_partial_notes --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_partial_notes.test.ts'\''' 19:31:51 + cid=59217c13106a59aa64469b782bff72aec20aa55d99dbebc35523963737714e24 19:31:51 + set +x 19:31:51 {"level":25,"time":1750188711555,"pid":12,"hostname":"59217c13106a","module":"logger","msg":"Logger initialized with level verbose"} 19:31:55 [19:31:55.608] INFO: e2e:e2e_partial_notes Logging metrics to log/unknown.jsonl 19:31:55 [19:31:55.837] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-RXBwEi/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:31:55 [19:31:55.867] INFO: e2e:e2e_partial_notes Calling anvil_setBlockTimestampInterval with params: [12] 19:31:55 [19:31:55.889] WARN: e2e:e2e_partial_notes Set block interval to 12 19:31:55 [19:31:55.889] VERBOSE: e2e:e2e_partial_notes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:31:55 [19:31:55.934] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:31:55 [19:31:55.941] VERBOSE: e2e:e2e_partial_notes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:31:55 [19:31:55.957] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:31:55 [19:31:55.962] VERBOSE: e2e:e2e_partial_notes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:31:55 [19:31:55.981] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:31:55 [19:31:55.993] VERBOSE: e2e:e2e_partial_notes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:31:56 [19:31:56.007] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:31:56 [19:31:56.011] VERBOSE: e2e:e2e_partial_notes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:31:56 [19:31:56.027] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 19:31:56 [19:31:56.031] VERBOSE: e2e:e2e_partial_notes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:31:56 [19:31:56.043] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 19:31:56 [19:31:56.047] VERBOSE: e2e:e2e_partial_notes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:31:56 [19:31:56.048] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 19:31:56 [19:31:56.048] INFO: e2e:e2e_partial_notes Waiting for 6 transactions to be mined... 19:31:56 [19:31:56.067] INFO: e2e:e2e_partial_notes All transactions mined successfully 19:31:56 [19:31:56.081] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 19:31:56 [19:31:56.081] VERBOSE: e2e:e2e_partial_notes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 19:31:56 [19:31:56.095] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 19:31:56 [19:31:56.107] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 19:31:56 [19:31:56.111] VERBOSE: e2e:e2e_partial_notes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 19:31:56 [19:31:56.122] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 19:31:56 [19:31:56.123] VERBOSE: e2e:e2e_partial_notes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 19:31:56 [19:31:56.137] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 19:31:56 [19:31:56.141] VERBOSE: e2e:e2e_partial_notes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:31:56 [19:31:56.151] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 19:31:56 [19:31:56.151] VERBOSE: e2e:e2e_partial_notes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 19:31:56 [19:31:56.152] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 19:31:56 [19:31:56.152] INFO: e2e:e2e_partial_notes Waiting for 8 transactions to be mined... 19:31:56 [19:31:56.168] INFO: e2e:e2e_partial_notes All transactions mined successfully 19:31:56 [19:31:56.177] VERBOSE: e2e:e2e_partial_notes Deployed shared contracts 19:31:56 [19:31:56.194] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 19:31:56 [19:31:56.194] VERBOSE: e2e:e2e_partial_notes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 19:31:56 [19:31:56.196] VERBOSE: e2e:e2e_partial_notes Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:31:56 [19:31:56.207] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 19:31:56 [19:31:56.228] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 19:31:56 [19:31:56.233] VERBOSE: e2e:e2e_partial_notes Awaiting for linked libraries to be deployed 19:31:56 [19:31:56.269] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xe67f6264769c51ab0acc8c251cdcea0dab288a685c896e64d3d8cf81e39419be {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 19:31:56 [19:31:56.275] VERBOSE: e2e:e2e_partial_notes Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 19:31:56 [19:31:56.275] INFO: e2e:e2e_partial_notes Waiting for 9 transactions to be mined... 19:31:56 [19:31:56.292] INFO: e2e:e2e_partial_notes All transactions mined successfully 19:31:56 [19:31:56.293] VERBOSE: e2e:e2e_partial_notes All core contracts have been deployed 19:31:56 [19:31:56.306] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 19:31:56 [19:31:56.306] VERBOSE: e2e:e2e_partial_notes Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 19:31:56 [19:31:56.317] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 19:31:56 [19:31:56.321] VERBOSE: e2e:e2e_partial_notes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 19:31:56 [19:31:56.338] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 19:31:56 [19:31:56.339] VERBOSE: e2e:e2e_partial_notes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 19:31:56 [19:31:56.339] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 19:31:56 [19:31:56.359] INFO: e2e:e2e_partial_notes All transactions mined successfully 19:31:56 [19:31:56.365] VERBOSE: e2e:e2e_partial_notes Rollup deployed 19:31:56 [19:31:56.365] VERBOSE: e2e:e2e_partial_notes Waiting for rollup and slash factory to be deployed 19:31:56 [19:31:56.365] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 19:31:56 [19:31:56.382] INFO: e2e:e2e_partial_notes All transactions mined successfully 19:31:56 [19:31:56.382] VERBOSE: e2e:e2e_partial_notes All transactions for L1 deployment have been mined 19:31:56 [19:31:56.398] INFO: e2e:e2e_partial_notes Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 19:31:56 [19:31:56.400] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:31:56 [19:31:56.402] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:56 [19:31:56.403] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 19:31:56 [19:31:56.404] INFO: telemetry:client Using NoopTelemetryClient 19:31:56 [19:31:56.409] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 19:31:56 [19:31:56.409] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 19:31:56 [19:31:56.410] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/06d59ab6e09bf0f7/blob-sink with map size 134217728 KB (LMDB v2) 19:31:56 [19:31:56.413] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:56 [19:31:56.415] INFO: aztecjs:utils:watcher New L1 time: 1750188955 19:31:56 [19:31:56.416] WARN: foundation:test-date-provider Time set to 2025-06-17T19:35:55.000Z {"offset":238585,"timeMs":1750188955000} 19:31:56 [19:31:56.417] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:31:56 [19:31:56.423] INFO: blob-sink:server Server is running on http://localhost:43651 19:31:56 [19:31:56.423] VERBOSE: e2e:e2e_partial_notes Creating and synching an aztec node... 19:31:56 [19:31:56.423] VERBOSE: e2e:e2e_partial_notes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/7ba24319/acvm 19:31:56 [19:31:56.424] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:43651"} 19:31:56 [19:31:56.438] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:31:56 [19:31:56.438] INFO: archiver:lmdb Creating archiver data store at directory /tmp/06d59ab6e09bf0f7/archiver with map size 134217728 KB (LMDB v2) 19:31:56 [19:31:56.442] INFO: archiver:lmdb Starting data store with maxReaders 16 19:31:56 [19:31:56.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:56 [19:31:56.692] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:43651"} 19:31:56 [19:31:56.706] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:43651"} 19:31:56 [19:31:56.707] WARN: node:blob-sink:client No L1 consensus host urls configured 19:31:56 [19:31:56.707] WARN: node:blob-sink:client No archive client configured 19:31:56 [19:31:56.709] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x5738799892326a76b53289f6628e98f7931f11da0174b55ab660ba9d010950d0 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x63c2742fdc66c249a6e73b763a6d766abfb372da120015ad0bbc46b37dfdc80e","l1BlockNumber":16}} 19:31:56 [19:31:56.721] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:31:56 [19:31:56.727] INFO: world-state:database Creating world state data store at directory /tmp/06d59ab6e09bf0f7/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:31:56 [19:31:56.749] INFO: world_state Created world state synchroniser with block history of 64 19:31:56 [19:31:56.749] WARN: node Aztec node is accepting fake proofs 19:31:56 [19:31:56.758] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/06d59ab6e09bf0f7/p2p with map size 134217728 KB (LMDB v2) 19:31:56 [19:31:56.759] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:31:56 [19:31:56.760] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/06d59ab6e09bf0f7/p2p-archive with map size 134217728 KB (LMDB v2) 19:31:56 [19:31:56.761] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:31:56 [19:31:56.762] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/06d59ab6e09bf0f7/p2p-peers with map size 134217728 KB (LMDB v2) 19:31:56 [19:31:56.763] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:31:56 [19:31:56.764] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:31:56 [19:31:56.764] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:31:56 [19:31:56.767] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 19:31:56 [19:31:56.767] INFO: world_state Started world state synchronizer from block 1 19:31:56 [19:31:56.769] VERBOSE: world-state:block_stream Starting sync from block number 0 19:31:56 [19:31:56.771] INFO: p2p Starting p2p client from block 0 with empty mempools 19:31:56 [19:31:56.771] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 19:31:56 [19:31:56.772] INFO: slasher Slasher client initialized 19:31:56 [19:31:56.772] INFO: slasher Starting Slasher client... 19:31:56 [19:31:56.800] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:31:56 [19:31:56.801] VERBOSE: node All Aztec Node subsystems synced 19:31:56 [19:31:56.807] INFO: sequencer-client Deploying forwarder contract 19:31:56 [19:31:56.812] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:31:56 [19:31:56.824] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:56 [19:31:56.826] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 19:31:56 [19:31:56.827] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 19:31:56 [19:31:56.831] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:31:56 [19:31:56.844] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:31:56 [19:31:56.844] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 19:31:56 [19:31:56.844] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/7ba24319/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:31:57 [19:31:57.025] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:31:57 [19:31:57.027] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:31:57 [19:31:57.028] INFO: node Aztec Node version: 0.87.8 19:31:57 [19:31:57.028] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 19:31:57 [19:31:57.029] VERBOSE: e2e:e2e_partial_notes Creating a pxe... 19:31:57 [19:31:57.032] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:57 [19:31:57.040] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/f4d0e9fabd065c16/pxe_data with map size 134217728 KB (LMDB v2) 19:31:57 [19:31:57.050] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03c29cde8a88d667a928df0acca3d8d04c8de78e4348d4287602130dadc6354a","blockNumber":1,"slot":2} 19:31:57 [19:31:57.050] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:31:57 [19:31:57.242] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:57 [19:31:57.269] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:31:57 [19:31:57.269] INFO: pxe:service Started PXE connected to chain 31337 version 4243557673 19:31:57 [19:31:57.318] INFO: pxe:service Registered account 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 19:31:57 [19:31:57.371] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 19:31:57 [19:31:57.372] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 19:31:57 [19:31:57.483] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:57 [19:31:57.486] INFO: pxe:service Added contract SchnorrAccount at 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:31:57 [19:31:57.522] VERBOSE: pxe:block_stream Starting sync from block number 0 19:31:57 [19:31:57.539] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:31:57 [19:31:57.615] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03c29cde8a88d667a928df0acca3d8d04c8de78e4348d4287602130dadc6354a","blockNumber":1,"slot":2} 19:31:57 [19:31:57.622] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:31:58 [19:31:58.049] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:31:58 [19:31:58.122] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:31:58 [19:31:58.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.225] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03c29cde8a88d667a928df0acca3d8d04c8de78e4348d4287602130dadc6354a","blockNumber":1,"slot":2} 19:31:58 [19:31:58.271] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:31:58 [19:31:58.305] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:31:58 [19:31:58.306] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:31:58 [19:31:58.341] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:31:58 [19:31:58.345] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:31:58 [19:31:58.393] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.498] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:31:58 [19:31:58.531] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:31:58 [19:31:58.531] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:31:58 [19:31:58.559] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:31:58 [19:31:58.561] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:31:58 [19:31:58.575] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 as fee payer 19:31:58 [19:31:58.596] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.805] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:58 [19:31:58.808] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03c29cde8a88d667a928df0acca3d8d04c8de78e4348d4287602130dadc6354a","blockNumber":1,"slot":2} 19:31:59 [19:31:59.031] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:59 [19:31:59.622] INFO: pxe:service Proving completed in 2106.8310460000002ms {"timings":{"total":2106.8310460000002,"sync":7.991053999999167,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":117.10205799999949,"oracles":{"callPrivateFunction":{"times":[596.7639680000002,254.3976389999998,155.40757800000029]}}},{"functionName":"private_kernel_init","time":92.79583100000036},{"functionName":"ContractClassRegisterer:register","time":583.4599240000007,"oracles":{"loadCapsule":{"times":[16.364754000000175]},"notifyCreatedNullifier":{"times":[0.5752049999991868]},"debugLog":{"times":[0.7235949999994773]},"notifyCreatedContractClassLog":{"times":[7.785828999999467]}}},{"functionName":"private_kernel_inner","time":116.64355200000045},{"functionName":"SchnorrAccount:constructor","time":229.8076799999999,"oracles":{"getContractInstance":{"times":[1.1783479999994597]},"debugLog":{"times":[0.4596380000002682,0.4029609999997774]},"fetchTaggedLogs":{"times":[37.31165400000009]},"loadCapsule":{"times":[0.3198099999999613,0.23179099999924802,0.2357189999993352]},"notifyCreatedNullifier":{"times":[0.19089999999960128,0.21119900000030611]},"notifyCreatedNote":{"times":[0.34844800000064424]},"getRandomField":{"times":[0.35761299999921903,0.14627899999959482,0.09719399999994494,0.07115299999986746,0.07164800000009564,0.060279000000264205,0.08201199999984965,0.0639790000004723,0.06738399999994726,0.09241899999960879,0.06233100000008562]},"getIndexedTaggingSecretAsSender":{"times":[30.84947800000009]},"incrementAppTaggingSecretIndexAsSender":{"times":[23.06697499999973]}}},{"functionName":"private_kernel_inner","time":107.79928000000018},{"functionName":"SchnorrAccount:entrypoint","time":133.12960199999998,"oracles":{"debugLog":{"times":[0.458557999999357,0.39192300000013347,0.5375549999998839]},"fetchTaggedLogs":{"times":[28.941960999999537]},"loadCapsule":{"times":[0.19693499999993946,0.17540500000086467,0.2122769999996308]},"getNotes":{"times":[1.4217349999998987]},"getAuthWitness":{"times":[0.3456270000006043]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7717099999999846]}}},{"functionName":"private_kernel_inner","time":106.3252279999997},{"functionName":"private_kernel_reset","time":164.40131099999962},{"functionName":"private_kernel_tail","time":70.2540480000007}],"unaccounted":377.121478}} 19:31:59 [19:31:59.636] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:31:59 [19:31:59.704] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x03c29cde8a88d667a928df0acca3d8d04c8de78e4348d4287602130dadc6354a","blockNumber":1,"slot":2} 19:31:59 [19:31:59.767] VERBOSE: p2p:tx_pool Adding tx 0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539 to pool {"eventName":"tx-added-to-pool","txHash":"0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:31:59 [19:31:59.784] INFO: node Received tx 0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539 {"txHash":"0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539"} 19:31:59 [19:31:59.784] INFO: pxe:service Sent transaction 0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539 19:31:59 [19:31:59.844] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.047] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.217] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 19:32:00 [19:32:00.229] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-17T19:36:19.000Z","now":"2025-06-17T19:35:58.814Z"} 19:32:00 [19:32:00.292] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.459] VERBOSE: simulator:public-processor Processed tx 0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539 with no public calls in 157.03115400000024ms {"txHash":"0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539","txFee":6794052480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":20448},"billedGas":{"daGas":16896,"l2Gas":20448},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":157.03115400000024} 19:32:00 [19:32:00.462] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23154626300000017s {"duration":0.23154626300000017,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 19:32:00 [19:32:00.573] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.586] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x225be9096b0dcc94ee03e2c925040fb83f8b13773d6f09f00ec173c0f5a44aa6","globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":1,"slotNumber":2,"timestamp":1750188979,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1615f141d9afcf9e3b0cf69594687668b0edab7807e9c7c2e2781e3fb0eee539"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":369.2289720000008,"publicProcessDuration":232.26381700000093,"rollupCircuitsDuration":357.84082899999885,"txCount":1,"blockNumber":1,"blockTimestamp":1750188979,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:32:00 [19:32:00.588] VERBOSE: sequencer Attesting committee is empty 19:32:00 [19:32:00.778] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.944] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x7902998a092053839c5d9231a829966ccc2bd1186f25c05e651dd66a92edb067 19:32:00 [19:32:00.944] VERBOSE: sequencer-client Sent L1 transaction 0x7902998a092053839c5d9231a829966ccc2bd1186f25c05e651dd66a92edb067 {"gasLimit":514552,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 19:32:00 [19:32:00.954] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:32:00 [19:32:00.955] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x7902998a092053839c5d9231a829966ccc2bd1186f25c05e651dd66a92edb067","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1750188979,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:32:00 [19:32:00.955] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:32:00 [19:32:00.969] INFO: blob-sink:server Received blob sidecar for block 0x3b468c44c2106e5476fbaa5ba175fce2a002a6f158a33cbee47c457d831a4f87 19:32:00 [19:32:00.973] INFO: blob-sink:server Blob sidecar stored successfully for block 0x3b468c44c2106e5476fbaa5ba175fce2a002a6f158a33cbee47c457d831a4f87 19:32:00 [19:32:00.981] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:00 [19:32:00.985] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:32:00 [19:32:00.986] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:32:00 [19:32:00.988] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:32:01 [19:32:01.002] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750189015] on http://127.0.0.1:8545 19:32:01 [19:32:01.003] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:32:01 [19:32:01.004] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750189015 19:32:01 [19:32:01.004] WARN: foundation:test-date-provider Time set to 2025-06-17T19:36:55.000Z {"offset":293996,"timeMs":1750189015000} 19:32:01 [19:32:01.005] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 19:32:01 [19:32:01.185] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:01 [19:32:01.338] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:32:01 [19:32:01.344] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x225be9096b0dcc94ee03e2c925040fb83f8b13773d6f09f00ec173c0f5a44aa6","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":1,"slotNumber":2,"timestamp":1750188979,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x24e00971517d298b35ac520b31ffffb25854725017b0dbf214c5dedf0d117af6","archiveNextLeafIndex":2} 19:32:01 [19:32:01.349] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:32:01 [19:32:01.387] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:01 [19:32:01.480] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":39.808256000000256,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750188979,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:32:01 [19:32:01.504] VERBOSE: p2p Synched to latest block 1 19:32:01 [19:32:01.505] INFO: pxe:service Registered account 0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225 19:32:01 [19:32:01.590] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:01 [19:32:01.595] INFO: pxe:service Added contract SchnorrAccount at 0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:32:01 [19:32:01.619] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x24e00971517d298b35ac520b31ffffb25854725017b0dbf214c5dedf0d117af6","header":{"contentCommitment":{"blobsHash":"0x00734d74c8e49c27d0911b80e28cb7fbf1bd2e88c2ccb201988c5fc224c66250","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750188979,"version":4243557673},"lastArchive":"0x03c29cde8a88d667a928df0acca3d8d04c8de78e4348d4287602130dadc6354a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2cd4e078166b8b063077b2f857eb251f97c72e1ff7dffb97ad1e9c2091c0b4d1","nullifierTree":"0x1926f5336bef2e3299a32df7b38bbcb75a39f8e3c300afbc397b1cf1f9113ac7","publicDataTree":"0x045b69e763356a9c3c2777e32536f2eb411a5d69128813b54d3e9d19af4d52bf"},"totalFees":6794052480,"totalManaUsed":20448}} 19:32:01 [19:32:01.633] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:32:01 [19:32:01.712] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225"} 19:32:01 [19:32:01.743] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:01 [19:32:01.743] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225"} 19:32:01 [19:32:01.796] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:01 [19:32:01.797] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225"} 19:32:01 [19:32:01.806] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:01 [19:32:01.962] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225"} 19:32:01 [19:32:01.994] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:01 [19:32:01.994] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225"} 19:32:01 [19:32:02.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.043] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24e00971517d298b35ac520b31ffffb25854725017b0dbf214c5dedf0d117af6","blockNumber":2,"slot":3} 19:32:02 [19:32:02.061] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225"} 19:32:02 [19:32:02.065] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:02 [19:32:02.076] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a6af735f23cc8d6a19a553d646dc0c3bc528ae0846e4af21037a9dfe8853225 as fee payer 19:32:02 [19:32:02.231] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.761] INFO: pxe:service Proving completed in 1150.8862339999996ms {"timings":{"total":1150.8862339999996,"sync":11.020818999999392,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":69.2285240000001,"oracles":{"callPrivateFunction":{"times":[245.05594199999905,197.25960400000076]}}},{"functionName":"private_kernel_init","time":56.386200999999346},{"functionName":"SchnorrAccount:constructor","time":222.30545300000085,"oracles":{"getContractInstance":{"times":[0.9857630000005884]},"debugLog":{"times":[0.4862169999996695,0.39711999999963155]},"fetchTaggedLogs":{"times":[61.67515099999946]},"loadCapsule":{"times":[0.2653780000000552,0.3385499999985768,0.2544849999994767]},"notifyCreatedNullifier":{"times":[0.2225109999999404,0.20367700000133482]},"notifyCreatedNote":{"times":[0.10658800000055635]},"getRandomField":{"times":[0.12806599999930768,0.12583900000026915,0.07743399999890244,0.06345999999939522,0.06577900000047521,0.055194000000483356,0.07180100000005041,0.05867899999975634,0.0630700000001525,0.053075000001626904,0.05178199999863864]},"getIndexedTaggingSecretAsSender":{"times":[26.624486000000616]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.36124899999959]}}},{"functionName":"private_kernel_inner","time":104.9195380000001},{"functionName":"SchnorrAccount:entrypoint","time":176.12984900000083,"oracles":{"debugLog":{"times":[0.4783690000003844,0.4158289999995759,0.459619000001112]},"fetchTaggedLogs":{"times":[69.5645970000005]},"loadCapsule":{"times":[0.21197299999948882,0.17195600000013656,0.30101599999943573]},"getNotes":{"times":[0.9045659999992495]},"getAuthWitness":{"times":[0.19082700000035402]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4163200000002689]}}},{"functionName":"private_kernel_inner","time":105.11927600000126},{"functionName":"private_kernel_reset","time":159.51533000000018},{"functionName":"private_kernel_tail","time":69.33489399999962}],"unaccounted":176.9263499999979}} 19:32:02 [19:32:02.773] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:02 [19:32:02.815] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x24e00971517d298b35ac520b31ffffb25854725017b0dbf214c5dedf0d117af6","blockNumber":2,"slot":3} 19:32:02 [19:32:02.821] VERBOSE: p2p:tx_pool Adding tx 0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5 to pool {"eventName":"tx-added-to-pool","txHash":"0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:32:02 [19:32:02.826] INFO: node Received tx 0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5 {"txHash":"0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5"} 19:32:02 [19:32:02.826] INFO: pxe:service Sent transaction 0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5 19:32:02 [19:32:02.979] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.182] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.341] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 19:32:03 [19:32:03.358] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-17T19:36:55.000Z","now":"2025-06-17T19:36:57.354Z"} 19:32:03 [19:32:03.377] VERBOSE: simulator:public-processor Processed tx 0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5 with no public calls in 12.910507000000507ms {"txHash":"0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5","txFee":5018455040,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":15104},"billedGas":{"daGas":11776,"l2Gas":15104},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":12.910507000000507} 19:32:03 [19:32:03.378] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019777019999999538s {"duration":0.019777019999999538,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 19:32:03 [19:32:03.384] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.498] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x17d203d5e21b7f6f92faa4182b5bfde9d8f8e05ab8ad79cfc83a86f8be3c7d77","globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":2,"slotNumber":3,"timestamp":1750189015,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x052b0df1ed939fe6ac3466e993250c2e3de794549fd2ee073404fea45f4dbce5"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":156.99663200000032,"publicProcessDuration":20.132461999999578,"rollupCircuitsDuration":140.60138499999994,"txCount":1,"blockNumber":2,"blockTimestamp":1750189015,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:03 [19:32:03.501] VERBOSE: sequencer Attesting committee is empty 19:32:03 [19:32:03.589] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.762] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x04984cebdc42947b48ad5b9cec39b5cde386feac2e55eea4d24ab075664c7439 19:32:03 [19:32:03.762] VERBOSE: sequencer-client Sent L1 transaction 0x04984cebdc42947b48ad5b9cec39b5cde386feac2e55eea4d24ab075664c7439 {"gasLimit":470251,"maxFeePerGas":"1.303611197","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:32:03 [19:32:03.770] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:32:03 [19:32:03.771] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x04984cebdc42947b48ad5b9cec39b5cde386feac2e55eea4d24ab075664c7439","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1750189015,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:03 [19:32:03.771] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:32:03 [19:32:03.774] INFO: blob-sink:server Received blob sidecar for block 0x482a62007d105f84545a64c2a0c1ab3065f6c1a9b41fed05dbfc9870600ede08 19:32:03 [19:32:03.777] INFO: blob-sink:server Blob sidecar stored successfully for block 0x482a62007d105f84545a64c2a0c1ab3065f6c1a9b41fed05dbfc9870600ede08 19:32:03 [19:32:03.792] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:03 [19:32:03.799] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:32:03 [19:32:03.801] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:32:03 [19:32:03.803] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:32:03 [19:32:03.804] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750189051] on http://127.0.0.1:8545 19:32:03 [19:32:03.805] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:32:03 [19:32:03.807] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750189051 19:32:03 [19:32:03.807] WARN: foundation:test-date-provider Time set to 2025-06-17T19:37:31.000Z {"offset":327193,"timeMs":1750189051000} 19:32:03 [19:32:03.807] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 19:32:03 [19:32:03.980] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x17d203d5e21b7f6f92faa4182b5bfde9d8f8e05ab8ad79cfc83a86f8be3c7d77","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":2,"slotNumber":3,"timestamp":1750189015,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x078d69dd90f4ff4b1cd8016953ae37a97bacaecee4e03dd0f28684bad67f179b","archiveNextLeafIndex":3} 19:32:03 [19:32:03.982] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:32:03 [19:32:03.996] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:04 [19:32:04.086] INFO: e2e:e2e_partial_notes Deploying Token contract... 19:32:04 [19:32:04.400] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:04 [19:32:04.405] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 19:32:04 [19:32:04.409] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7 19:32:04 [19:32:04.566] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":162.87421900000118,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750189015,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:04 [19:32:04.621] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:04 [19:32:04.631] VERBOSE: p2p Synched to latest block 2 19:32:04 [19:32:04.862] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:04 [19:32:04.874] INFO: pxe:service Added contract Token at 0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7 with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 19:32:04 [19:32:04.904] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x078d69dd90f4ff4b1cd8016953ae37a97bacaecee4e03dd0f28684bad67f179b","header":{"contentCommitment":{"blobsHash":"0x0048e067b3fcfc616bc06ce3847247b62b41faa688689763ae07874f75ad6078","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750189015,"version":4243557673},"lastArchive":"0x24e00971517d298b35ac520b31ffffb25854725017b0dbf214c5dedf0d117af6","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x11ca6d144260b3336eafad1f0b3206d7cdcedd5d5f4888895827c8117eeb37d9","nullifierTree":"0x25bbf7111db25b25d089bcd4d799eb59336dcc73f71f734dbf48eedfb4bebd5d","publicDataTree":"0x04e5e119593fcf33aeec4a4887c88ec727b76f9ddc816b872ae4030e0830f0de"},"totalFees":5018455040,"totalManaUsed":15104}} 19:32:05 [19:32:05.009] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:32:05 [19:32:05.042] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:05 [19:32:05.042] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:32:05 [19:32:05.070] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:05 [19:32:05.093] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x078d69dd90f4ff4b1cd8016953ae37a97bacaecee4e03dd0f28684bad67f179b","blockNumber":3,"slot":4} 19:32:05 [19:32:05.116] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:32:05 [19:32:05.120] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1873b8c67e02c5839087cf222fa443dfdb06544d014c2684b0d2314cda06824e 19:32:05 [19:32:05.132] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:32:05 [19:32:05.132] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:32:05 [19:32:05.138] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:32:05 [19:32:05.139] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:32:05 [19:32:05.142] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1783623154867077507658adbaf3b54d82da88b99c3cc2059955bca03d3b6dd1","nullifier":"0x2a8ea969b69e0d4057abb47524ef9d03016f3aa8c3c3db58e4edc3c149e51318"} 19:32:05 [19:32:05.144] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:05 [19:32:05.157] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 as fee payer 19:32:05 [19:32:05.184] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:32:05 [19:32:05.496] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 19:32:05 [19:32:05.566] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:32:05 [19:32:05.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:05 [19:32:05.675] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 19:32:05 [19:32:05.683] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x078d69dd90f4ff4b1cd8016953ae37a97bacaecee4e03dd0f28684bad67f179b","blockNumber":3,"slot":4} 19:32:05 [19:32:05.705] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:32:05 [19:32:05.716] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7,0x0000000000000000000000000000000000000000000000000000000000000001,0x00d7861bfff3912fc0d22d4318fa9135c1ffe05175512665c1f5f4c932d78920,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x13600d4c1b147c0fb91268fea54399f2f0628d219021d9f303a21328baa24429,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 19:32:05 [19:32:05.860] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.088] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.278] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x078d69dd90f4ff4b1cd8016953ae37a97bacaecee4e03dd0f28684bad67f179b","blockNumber":3,"slot":4} 19:32:06 [19:32:06.388] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.634] INFO: pxe:service Proving completed in 1737.6763219999993ms {"timings":{"total":1737.6763219999993,"sync":9.007949999999255,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":272.661055999999,"oracles":{"debugLog":{"times":[0.47905200000059267,0.3809719999990193,0.40524400000140304,0.6014269999996031,0.421688999998878,0.35621399999945424,0.32190600000103586,0.4196909999991476]},"fetchTaggedLogs":{"times":[76.68939500000124]},"loadCapsule":{"times":[0.21107500000107393,0.1761690000003,0.3422100000007049,0.1912240000001475,0.19352099999923666,0.20650399999976798]},"getSharedSecret":{"times":[3.6006409999990865]},"aes128Decrypt":{"times":[0.9652200000000448,0.9667659999995522]},"getPublicKeysAndPartialAddress":{"times":[1.391077000000223]},"getKeyValidationRequest":{"times":[1.9349250000013853]},"deliverNote":{"times":[3.5617289999991044]},"deleteCapsule":{"times":[0.3309949999984383]},"storeCapsule":{"times":[0.31590999999934866]},"getNotes":{"times":[3.032299000000421]},"getAuthWitness":{"times":[0.20974800000112737]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05890899999940302]},"callPrivateFunction":{"times":[458.74181300000055,102.6457360000004]},"notifyEnqueuedPublicFunctionCall":{"times":[0.22219199999926786]}}},{"functionName":"private_kernel_init","time":54.67326399999911},{"functionName":"ContractClassRegisterer:register","time":448.6695520000012,"oracles":{"loadCapsule":{"times":[3.873537999999826]},"notifyCreatedNullifier":{"times":[0.31035700000029465]},"debugLog":{"times":[0.4345899999989342]},"notifyCreatedContractClassLog":{"times":[6.651750999999422]}}},{"functionName":"private_kernel_inner","time":104.68404600000031},{"functionName":"ContractInstanceDeployer:deploy","time":63.77026400000068,"oracles":{"storeInExecutionCache":{"times":[0.15542199999981676]},"callPrivateFunction":{"times":[32.15192999999999]},"notifyCreatedNullifier":{"times":[0.27108100000077684]},"debugLog":{"times":[0.4355809999997291]}}},{"functionName":"private_kernel_inner","time":106.7080760000008},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":22.694878999998764,"oracles":{}},{"functionName":"private_kernel_inner","time":103.87874899999952},{"functionName":"private_kernel_reset","time":165.54548000000068},{"functionName":"private_kernel_tail","time":83.30919100000028}],"unaccounted":302.07381499999974}} 19:32:06 [19:32:06.664] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.857] VERBOSE: p2p:tx_pool Adding tx 0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30 to pool {"eventName":"tx-added-to-pool","txHash":"0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 19:32:06 [19:32:06.877] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:06 [19:32:06.879] INFO: node Received tx 0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30 {"txHash":"0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30"} 19:32:06 [19:32:06.880] INFO: pxe:service Sent transaction 0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30 19:32:06 [19:32:06.891] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 19:32:06 [19:32:06.902] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-17T19:37:31.000Z","now":"2025-06-17T19:37:34.095Z"} 19:32:07 [19:32:07.086] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.317] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.369] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":194.45039800000086} 19:32:07 [19:32:07.519] VERBOSE: simulator:public-processor Processed tx 0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30 with 1 public calls in 480.69748399999844ms {"txHash":"0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30","txFee":139009277500,"revertCode":0,"gasUsed":{"totalGas":{"daGas":380416,"l2Gas":418375},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":6144,"l2Gas":381831},"billedGas":{"daGas":380416,"l2Gas":418375}},"publicDataWriteCount":12,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":480.69748399999844} 19:32:07 [19:32:07.521] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:07 [19:32:07.523] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.6206042290000005s {"duration":0.6206042290000005,"rate":615256.8451156972,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 19:32:07 [19:32:07.692] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 476398.44229907787 mana/s {"blockHash":"0x1de3bd78cc8a0d7620c2a1633593117f6dc0e17b0974acd0eeeb764bcd4fd51c","globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":3,"slotNumber":4,"timestamp":1750189051,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1034ddae9f4a381543a29698b5288baafdbdd79d79f4dc732606fb5a39078e30"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":800.9139429999977,"publicProcessDuration":620.9834250000004,"rollupCircuitsDuration":790.4692659999982,"txCount":1,"blockNumber":3,"blockTimestamp":1750189051,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 19:32:07 [19:32:07.694] VERBOSE: sequencer Attesting committee is empty 19:32:07 [19:32:07.805] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.008] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9ef58becf1240a351dc4c5b51cc6bb808261db808bc0d5c44d41669e91ac9309 19:32:08 [19:32:08.009] VERBOSE: sequencer-client Sent L1 transaction 0x9ef58becf1240a351dc4c5b51cc6bb808261db808bc0d5c44d41669e91ac9309 {"gasLimit":470294,"maxFeePerGas":"1.279583393","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:32:08 [19:32:08.010] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.019] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 19:32:08 [19:32:08.020] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 19:32:08 [19:32:08.022] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:32:08 [19:32:08.023] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9ef58becf1240a351dc4c5b51cc6bb808261db808bc0d5c44d41669e91ac9309","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":3,"blockTimestamp":1750189051,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 19:32:08 [19:32:08.023] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:32:08 [19:32:08.025] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 19:32:08 [19:32:08.030] INFO: blob-sink:server Received blob sidecar for block 0xa6160fa524c23ccccaefca787db9499a3e740ac95878d4f2e89f8c57b7f67e7b 19:32:08 [19:32:08.036] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa6160fa524c23ccccaefca787db9499a3e740ac95878d4f2e89f8c57b7f67e7b 19:32:08 [19:32:08.037] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750189087] on http://127.0.0.1:8545 19:32:08 [19:32:08.039] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:32:08 [19:32:08.040] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750189087 19:32:08 [19:32:08.040] WARN: foundation:test-date-provider Time set to 2025-06-17T19:38:07.000Z {"offset":358960,"timeMs":1750189087000} 19:32:08 [19:32:08.040] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 19:32:08 [19:32:08.215] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.502] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.525] VERBOSE: archiver:block-helper Store contract instance at 0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7 19:32:08 [19:32:08.550] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 19:32:08 [19:32:08.588] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1de3bd78cc8a0d7620c2a1633593117f6dc0e17b0974acd0eeeb764bcd4fd51c","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":3,"slotNumber":4,"timestamp":1750189051,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2fa772dd01bafcdb61c00350d10b0c5df0da71dbb28d86c8c67c487649516a4e","archiveNextLeafIndex":4} 19:32:08 [19:32:08.599] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 19:32:08 [19:32:08.626] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":6.448374999999942,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750189051,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 19:32:08 [19:32:08.709] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:08 [19:32:08.711] VERBOSE: p2p Synched to latest block 3 19:32:09 [19:32:09.040] INFO: aztecjs:deploy_sent_tx Contract 0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7 successfully deployed. 19:32:09 [19:32:09.040] INFO: e2e:e2e_partial_notes L2 contract deployed 19:32:09 [19:32:09.042] INFO: e2e:e2e_partial_notes Running test: partial notes mint to private 19:32:09 [19:32:09.043] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.243] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2fa772dd01bafcdb61c00350d10b0c5df0da71dbb28d86c8c67c487649516a4e","blockNumber":4,"slot":5} 19:32:09 [19:32:09.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.261] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x2fa772dd01bafcdb61c00350d10b0c5df0da71dbb28d86c8c67c487649516a4e","header":{"contentCommitment":{"blobsHash":"0x009128530add7f15e4f5f13cdc13240cdb5985a310927256fb713d38391a3f63","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750189051,"version":4243557673},"lastArchive":"0x078d69dd90f4ff4b1cd8016953ae37a97bacaecee4e03dd0f28684bad67f179b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x11ca6d144260b3336eafad1f0b3206d7cdcedd5d5f4888895827c8117eeb37d9","nullifierTree":"0x1df127ad9252abf42bfaadb791ea361930ba175b1f988bd7a222e9b39575ce94","publicDataTree":"0x10a9903508050de245ecd8717b2d4b3fda65e160643a7c3c55fa07cc2ba1174f"},"totalFees":139009277500,"totalManaUsed":418375}} 19:32:09 [19:32:09.322] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:32:09 [19:32:09.354] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:09 [19:32:09.355] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:32:09 [19:32:09.407] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723"} 19:32:09 [19:32:09.418] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1873b8c67e02c5839087cf222fa443dfdb06544d014c2684b0d2314cda06824e 19:32:09 [19:32:09.427] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:32:09 [19:32:09.428] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:32:09 [19:32:09.433] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:32:09 [19:32:09.433] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:32:09 [19:32:09.436] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1783623154867077507658adbaf3b54d82da88b99c3cc2059955bca03d3b6dd1","nullifier":"0x2a8ea969b69e0d4057abb47524ef9d03016f3aa8c3c3db58e4edc3c149e51318"} 19:32:09 [19:32:09.437] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:09 [19:32:09.448] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1b88eed9ddfb6a529b82c8160544588bc1b3d10250a819097ebdbf3f0697d723 as fee payer 19:32:09 [19:32:09.524] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.677] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7"} 19:32:09 [19:32:09.707] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:32:09 [19:32:09.707] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7"} 19:32:09 [19:32:09.788] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:09 [19:32:09.826] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2fa772dd01bafcdb61c00350d10b0c5df0da71dbb28d86c8c67c487649516a4e","blockNumber":4,"slot":5} 19:32:09 [19:32:09.841] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7"} 19:32:09 [19:32:09.844] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:32:10 [19:32:10.019] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:10 [19:32:10.322] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:10 [19:32:10.679] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:10 [19:32:10.821] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2fa772dd01bafcdb61c00350d10b0c5df0da71dbb28d86c8c67c487649516a4e","blockNumber":4,"slot":5} 19:32:11 [19:32:11.076] INFO: pxe:service Proving completed in 1841.1392720000003ms {"timings":{"total":1841.1392720000003,"sync":27.75170900000012,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":251.2064440000031,"oracles":{"debugLog":{"times":[0.4475170000005164,0.3708420000002661,0.385258000002068,0.5138310000002093,0.3844040000003588,0.34135799999785377,0.30888799999956973,0.45307100000354694]},"fetchTaggedLogs":{"times":[60.89201899999898]},"loadCapsule":{"times":[0.7213169999995444,0.17513999999937369,0.33813999999983935,0.17941000000064378,0.16523000000233878,0.17834299999958603]},"getSharedSecret":{"times":[2.7180219999972905]},"aes128Decrypt":{"times":[0.22674299999926006,0.8237220000009984]},"getPublicKeysAndPartialAddress":{"times":[1.1447599999992235]},"getKeyValidationRequest":{"times":[1.6844430000019202]},"deliverNote":{"times":[2.4137249999985215]},"deleteCapsule":{"times":[0.2110530000027211]},"storeCapsule":{"times":[0.1982979999993404]},"getNotes":{"times":[1.1930690000008326]},"getAuthWitness":{"times":[0.1815939999978582]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05639099999825703]},"callPrivateFunction":{"times":[583.5239509999992]}}},{"functionName":"private_kernel_init","time":55.78743899999972},{"functionName":"Token:mint_to_private","time":508.3963189999995,"oracles":{"debugLog":{"times":[0.4140750000005937,0.3513230000025942]},"fetchTaggedLogs":{"times":[135.6999219999998]},"loadCapsule":{"times":[0.17565299999841955,0.1424509999997099,0.1727339999997639]},"getRandomField":{"times":[0.0948149999967427,0.08538200000111829,0.11538300000029267,0.06565600000249106,0.06281599999783793,0.06214000000181841,0.05884900000091875,0.0502230000020063,0.06808900000032736,0.04918800000086776,0.044880000001285225,0.05723200000284123]},"getIndexedTaggingSecretAsSender":{"times":[80.35427899999922]},"incrementAppTaggingSecretIndexAsSender":{"times":[80.40320599999905]},"notifyCreatedNullifier":{"times":[0.23623700000098324]},"storeInExecutionCache":{"times":[0.07564199999978882]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05895800000143936]}}},{"functionName":"private_kernel_inner","time":104.20912900000258},{"functionName":"private_kernel_reset","time":172.35995699999694},{"functionName":"private_kernel_tail","time":82.72154600000067}],"unaccounted":638.7067289999977}} 19:32:11 [19:32:11.103] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:11 [19:32:11.123] VERBOSE: p2p:tx_pool Adding tx 0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b to pool {"eventName":"tx-added-to-pool","txHash":"0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 19:32:11 [19:32:11.130] INFO: node Received tx 0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b {"txHash":"0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b"} 19:32:11 [19:32:11.130] INFO: pxe:service Sent transaction 0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b 19:32:11 [19:32:11.306] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:11 [19:32:11.339] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 19:32:11 [19:32:11.353] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-17T19:38:07.000Z","now":"2025-06-17T19:38:10.313Z"} 19:32:11 [19:32:11.395] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":25.289945000000444} 19:32:11 [19:32:11.415] VERBOSE: simulator:public-processor Processed tx 0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b with 1 public calls in 51.77115799999956ms {"txHash":"0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b","txFee":3736336500,"revertCode":0,"gasUsed":{"totalGas":{"daGas":13312,"l2Gas":73695},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":2048,"l2Gas":42495},"billedGas":{"daGas":13312,"l2Gas":73695}},"publicDataWriteCount":2,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":1,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":51.77115799999956} 19:32:11 [19:32:11.416] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.062434684000003474s {"duration":0.062434684000003474,"rate":680631.2978215384,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 19:32:11 [19:32:11.527] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:11 [19:32:11.540] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 210886.42001327558 mana/s {"blockHash":"0x0d76fca5649098160a71c2f8e78860a7c5ef99d275f808c51aae6181ac4cfd22","globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":4,"slotNumber":5,"timestamp":1750189087,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x26d316dc9d9989445122192a0f21ead62ae676f5a691a3f2db49421f67e6c25b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":200.87774100000024,"publicProcessDuration":62.79330000000118,"rollupCircuitsDuration":187.96941199999856,"txCount":1,"blockNumber":4,"blockTimestamp":1750189087,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:11 [19:32:11.542] VERBOSE: sequencer Attesting committee is empty 19:32:11 [19:32:11.804] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:11 [19:32:11.812] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x850ccb7b0d4bfd482965d6f7339518bc4a5b0661585bb6e73f1cdc590d087ac1 19:32:11 [19:32:11.812] VERBOSE: sequencer-client Sent L1 transaction 0x850ccb7b0d4bfd482965d6f7339518bc4a5b0661585bb6e73f1cdc590d087ac1 {"gasLimit":470310,"maxFeePerGas":"1.26112774","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:32:11 [19:32:11.819] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750189123] on http://127.0.0.1:8545 19:32:11 [19:32:11.821] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:32:11 [19:32:11.823] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:32:11 [19:32:11.824] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x850ccb7b0d4bfd482965d6f7339518bc4a5b0661585bb6e73f1cdc590d087ac1","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":4,"blockTimestamp":1750189087,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:11 [19:32:11.824] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:32:11 [19:32:11.826] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750189123 19:32:11 [19:32:11.826] WARN: foundation:test-date-provider Time set to 2025-06-17T19:38:43.000Z {"offset":391174,"timeMs":1750189123000} 19:32:11 [19:32:11.826] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 19:32:11 [19:32:11.829] INFO: blob-sink:server Received blob sidecar for block 0x7fb8489a5760795f98f467e945c39eb3cc43dc38de410b067b172dd57c34fe11 19:32:11 [19:32:11.832] INFO: blob-sink:server Blob sidecar stored successfully for block 0x7fb8489a5760795f98f467e945c39eb3cc43dc38de410b067b172dd57c34fe11 19:32:12 [19:32:12.007] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:12 [19:32:12.011] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 19:32:12 [19:32:12.012] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 19:32:12 [19:32:12.014] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 19:32:12 [19:32:12.298] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:12 [19:32:12.314] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0d76fca5649098160a71c2f8e78860a7c5ef99d275f808c51aae6181ac4cfd22","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":4243557673,"blockNumber":4,"slotNumber":5,"timestamp":1750189087,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0a20be790f386c31ff1d534787eec628d79c41ca26bb38cdba269b6e83b324ba","archiveNextLeafIndex":5} 19:32:12 [19:32:12.316] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 19:32:12 [19:32:12.416] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":6.24970200000098,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750189087,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 19:32:12 [19:32:12.425] VERBOSE: p2p Synched to latest block 4 19:32:12 [19:32:12.502] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:12 [19:32:12.705] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:12 [19:32:12.846] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0a20be790f386c31ff1d534787eec628d79c41ca26bb38cdba269b6e83b324ba","blockNumber":5,"slot":6} 19:32:12 [19:32:12.907] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:13 [19:32:13.110] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:13 [19:32:13.145] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x0a20be790f386c31ff1d534787eec628d79c41ca26bb38cdba269b6e83b324ba","header":{"contentCommitment":{"blobsHash":"0x00e798533c320a22c921d9be4fc6591dc72442e71c44efb57cdd07fbc62694ba","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750189087,"version":4243557673},"lastArchive":"0x2fa772dd01bafcdb61c00350d10b0c5df0da71dbb28d86c8c67c487649516a4e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x3054af76b2d96971fc2a54b08cf1971a4e9e231fcba46a03fd3f7a02c375a753","nullifierTree":"0x1bc52663d54f6c137c804a64accaef1bd14e2853725d4feae7e6e8a41472007a","publicDataTree":"0x1fb842871c8cf86dbde8fd657aeaa41c931db9816b1ae8f97041a8ecc39f6537"},"totalFees":3736336500,"totalManaUsed":73695}} 19:32:13 [19:32:13.367] VERBOSE: simulator Executing utility function balance_of_private {"contract":"0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7","selector":"0x4375727c"} 19:32:13 [19:32:13.374] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:32:13 [19:32:13.378] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:32:13 [19:32:13.378] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7"} 19:32:13 [19:32:13.485] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0a20be790f386c31ff1d534787eec628d79c41ca26bb38cdba269b6e83b324ba","blockNumber":5,"slot":6} 19:32:13 [19:32:13.507] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7"} 19:32:13 [19:32:13.511] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x30237468562e0d7ec3745a0b951424e357cbe10a725d9c40b7f4756b066b9adc 19:32:13 [19:32:13.520] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 19:32:13 [19:32:13.522] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 19:32:13 [19:32:13.526] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x1281c302acec415e5ee14c213b17843bc7e7d6762fdbb31243afefc3a3427974 19:32:13 [19:32:13.526] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7 for storage slot 0x18bafb4c7dc3a55695be3b514138b555d5875f7b204bd7f7fe339d2d8090cabe 19:32:13 [19:32:13.531] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:32:13 [19:32:13.531] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x1281c302acec415e5ee14c213b17843bc7e7d6762fdbb31243afefc3a3427974 19:32:13 [19:32:13.534] VERBOSE: pxe:service Added note {"index":192,"contract":"0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7","slot":"0x18bafb4c7dc3a55695be3b514138b555d5875f7b204bd7f7fe339d2d8090cabe","noteHash":"0x20dbb4033258a43c71e2c733f83b116d2ccadabbb1af0fcc16eb841ecea8e1e8","nullifier":"0x0256decab9fd65d7f74d91de1b256617746a3cc32a64fbca0adfd906074beb70"} 19:32:13 [19:32:13.537] VERBOSE: simulator Utility simulation for 0x242fa514d6402f9737b7689aab62948c117dc4eb6e8768fe91bfa68cfe2f18a7.0x4375727c completed 19:32:13 [19:32:13.540] INFO: node Stopping 19:32:13 [19:32:13.541] INFO: slasher Slasher client stopped. 19:32:13 [19:32:13.541] INFO: sequencer Stopped sequencer 19:32:13 [19:32:13.541] INFO: p2p P2P client stopped. 19:32:13 [19:32:13.543] INFO: world_state Stopped world state synchronizer 19:32:13 [19:32:13.543] INFO: archiver Stopped. 19:32:13 [19:32:13.543] INFO: node Stopped 19:32:13 [19:32:13.543] VERBOSE: e2e:e2e_partial_notes Cleaning up ACVM state 19:32:13 [19:32:13.543] INFO: e2e:e2e_partial_notes Cleaning up ACVM temp directory /tmp/7ba24319 19:32:13 [19:32:13.544] VERBOSE: e2e:e2e_partial_notes Cleaning up BB state 19:32:13 [19:32:13.552] INFO: blob-sink:server Stopping blob sink 19:32:13 [19:32:13.553] INFO: blob-sink:server Blob sink stopped 19:32:13 [19:32:13.553] VERBOSE: e2e:e2e_partial_notes Cleaning up data directory at /tmp/06d59ab6e09bf0f7 19:32:13 PASS src/e2e_partial_notes.test.ts 19:32:13 partial notes 19:32:13 ✓ mint to private (4498 ms) 19:32:13 19:32:13 Test Suites: 1 passed, 1 total 19:32:13 Tests: 1 passed, 1 total 19:32:13 Snapshots: 0 total 19:32:13 Time: 22.149 s 19:32:13 Ran all test suites matching /src\/e2e_partial_notes.test.ts/i. 19:32:13 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?